builder: mozilla-beta_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1496412950.8 results: success (0) revision: a6a79438608114ac87218bcb467b1f8aa5d603f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:50.803831) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:50.804293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:50.804587) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:50.823775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:50.824107) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-02 07:15:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-06-02 07:15:52 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136435 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:50.973808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:50.974131) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019902 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:51.026917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 07:15:51.030296) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6a79438608114ac87218bcb467b1f8aa5d603f3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6a79438608114ac87218bcb467b1f8aa5d603f3 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-02 07:15:53,106 truncating revision to first 12 chars 2017-06-02 07:15:53,106 Setting DEBUG logging. 2017-06-02 07:15:53,106 attempt 1/10 2017-06-02 07:15:53,106 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a6a794386081?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 07:15:54,471 unpacking tar archive at: mozilla-beta-a6a794386081/testing/mozharness/ program finished with exit code 0 elapsedTime=1.712465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 07:15:52.758311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:52.758633) ========= script_repo_revision: a6a79438608114ac87218bcb467b1f8aa5d603f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:52.759027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:52.759307) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 07:15:52.769225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-06-02 07:15:52.769515) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:54 INFO - MultiFileLogger online at 20170602 07:15:54 in /builds/slave/test 07:15:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 07:15:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:54 INFO - {'append_to_log': False, 07:15:54 INFO - 'base_work_dir': '/builds/slave/test', 07:15:54 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:15:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:54 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:15:54 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:54 INFO - 'config_files': ('talos/linux_config.py',), 07:15:54 INFO - 'default_actions': ('clobber', 07:15:54 INFO - 'read-buildbot-config', 07:15:54 INFO - 'download-and-extract', 07:15:54 INFO - 'populate-webroot', 07:15:54 INFO - 'create-virtualenv', 07:15:54 INFO - 'install', 07:15:54 INFO - 'run-tests'), 07:15:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:54 INFO - 'download_minidump_stackwalk': True, 07:15:54 INFO - 'download_symbols': 'ondemand', 07:15:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:54 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:54 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:54 INFO - 'gecko_profile': False, 07:15:54 INFO - 'gecko_profile_interval': 0, 07:15:54 INFO - 'installer_path': 'installer.exe', 07:15:54 INFO - 'log_level': 'info', 07:15:54 INFO - 'log_name': 'talos', 07:15:54 INFO - 'log_to_console': True, 07:15:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:54 INFO - 'opt_config_files': (), 07:15:54 INFO - 'pip_index': False, 07:15:54 INFO - 'suite': 'dromaeojs', 07:15:54 INFO - 'system_bits': '32', 07:15:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:54 INFO - 'title': 'talos-linux64-ix-069', 07:15:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:54 INFO - 'use_talos_json': True, 07:15:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:54 INFO - 'work_dir': 'build'} 07:15:54 INFO - [mozharness: 2017-06-02 14:15:54.938674Z] Running clobber step. 07:15:54 INFO - Running pre-action listener: _resource_record_pre_action 07:15:54 INFO - Running main action method: clobber 07:15:54 INFO - rmtree: /builds/slave/test/build 07:15:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:56 INFO - Running post-action listener: _resource_record_post_action 07:15:56 INFO - [mozharness: 2017-06-02 14:15:56.471193Z] Finished clobber step (success) 07:15:56 INFO - [mozharness: 2017-06-02 14:15:56.471290Z] Running read-buildbot-config step. 07:15:56 INFO - Running pre-action listener: _resource_record_pre_action 07:15:56 INFO - Running main action method: read_buildbot_config 07:15:56 INFO - Using buildbot properties: 07:15:56 INFO - { 07:15:56 INFO - "project": "", 07:15:56 INFO - "product": "firefox", 07:15:56 INFO - "who": "cbook@mozilla.com", 07:15:56 INFO - "installer_path": "public/build/target.tar.bz2", 07:15:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 07:15:56 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 07:15:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs", 07:15:56 INFO - "stage_platform": "linux64", 07:15:56 INFO - "basedir": "/builds/slave/test", 07:15:56 INFO - "buildnumber": 69, 07:15:56 INFO - "platform": "ubuntu64_hw", 07:15:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:15:56 INFO - "slavebuilddir": "test", 07:15:56 INFO - "taskId": "X90hwuq_Qf2gLtyMAT_2Vg", 07:15:56 INFO - "branch": "mozilla-beta", 07:15:56 INFO - "script_repo_revision": "production", 07:15:56 INFO - "revision": "a6a79438608114ac87218bcb467b1f8aa5d603f3", 07:15:56 INFO - "slavename": "talos-linux64-ix-069", 07:15:56 INFO - "repo_path": "releases/mozilla-beta" 07:15:56 INFO - } 07:15:56 INFO - Finding installer, test and symbols from parent task. 07:15:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X90hwuq_Qf2gLtyMAT_2Vg'}, attempt #1 07:15:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X90hwuq_Qf2gLtyMAT_2Vg'}, attempt #1 07:15:57 INFO - Task dependencies: QhQeSGOLQzmFu-quKo1Ehw 07:15:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw'}, attempt #1 07:15:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2 07:15:57 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/test_packages.json 07:15:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.crashreporter-symbols.zip 07:15:57 INFO - Running post-action listener: _resource_record_post_action 07:15:57 INFO - [mozharness: 2017-06-02 14:15:57.823206Z] Finished read-buildbot-config step (success) 07:15:57 INFO - [mozharness: 2017-06-02 14:15:57.823512Z] Running download-and-extract step. 07:15:57 INFO - Running pre-action listener: _resource_record_pre_action 07:15:57 INFO - Running main action method: download_and_extract 07:15:57 INFO - mkdir: /builds/slave/test/build/tests 07:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:58 INFO - trying https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.test_packages.json 07:15:58 INFO - Downloading https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:15:58 INFO - Downloaded 986 bytes. 07:15:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:15:58 INFO - Using the following test package requirements: 07:15:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:15:58 INFO - u'common': [u'target.common.tests.zip'], 07:15:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:15:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:15:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:15:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:15:58 INFO - u'mozbase': [u'target.common.tests.zip'], 07:15:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:15:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:15:58 INFO - u'web-platform': [u'target.common.tests.zip', 07:15:58 INFO - u'target.web-platform.tests.zip'], 07:15:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:15:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:15:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.common.tests.zip 07:15:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:15:58 INFO - Fetch https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.common.tests.zip into memory 07:16:00 INFO - Expected file size: 59715473 07:16:00 INFO - Obtained file size: 59715473 07:16:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:16:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.common.tests.zip 07:16:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:16:09 INFO - Fetch https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.common.tests.zip into memory 07:16:11 INFO - Expected file size: 59715473 07:16:11 INFO - Obtained file size: 59715473 07:16:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.talos.tests.zip 07:16:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:16:21 INFO - Fetch https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.talos.tests.zip into memory 07:16:22 INFO - Expected file size: 14404461 07:16:22 INFO - Obtained file size: 14404461 07:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:22 INFO - trying https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2 07:16:22 INFO - Downloading https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:16:24 INFO - Downloaded 59719913 bytes. 07:16:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2 07:16:24 INFO - mkdir: /builds/slave/test/properties 07:16:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:16:24 INFO - Writing to file /builds/slave/test/properties/build_url 07:16:24 INFO - Contents: 07:16:24 INFO - build_url:https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2 07:16:24 INFO - Running post-action listener: _resource_record_post_action 07:16:24 INFO - Running post-action listener: set_extra_try_arguments 07:16:24 INFO - [mozharness: 2017-06-02 14:16:24.042485Z] Finished download-and-extract step (success) 07:16:24 INFO - [mozharness: 2017-06-02 14:16:24.042582Z] Running populate-webroot step. 07:16:24 INFO - Running pre-action listener: _resource_record_pre_action 07:16:24 INFO - Running main action method: populate_webroot 07:16:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:16:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:16:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:16:24 INFO - '--tppagecycles', 07:16:24 INFO - '7'], 07:16:24 INFO - 'tests': ['tsvgm']}}, 07:16:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:16:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:16:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:16:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:16:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:16:24 INFO - 'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:16:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:16:24 INFO - 'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['damp', 'tps']}, 07:16:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:16:24 INFO - 'tests': ['damp', 'tps']}, 07:16:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['dromaeo_dom']}, 07:16:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:16:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['basic_compositor_video']}, 07:16:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:16:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['a11yr', 07:16:24 INFO - 'ts_paint', 07:16:24 INFO - 'tpaint', 07:16:24 INFO - 'sessionrestore', 07:16:24 INFO - 'sessionrestore_no_auto_restore', 07:16:24 INFO - 'tabpaint']}, 07:16:24 INFO - 'other-e10s': {'tests': ['a11yr', 07:16:24 INFO - 'ts_paint', 07:16:24 INFO - 'tpaint', 07:16:24 INFO - 'sessionrestore', 07:16:24 INFO - 'sessionrestore_no_auto_restore', 07:16:24 INFO - 'tabpaint']}, 07:16:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:16:24 INFO - 'ts_paint', 07:16:24 INFO - 'tpaint', 07:16:24 INFO - 'sessionrestore', 07:16:24 INFO - 'sessionrestore_no_auto_restore', 07:16:24 INFO - 'tabpaint']}, 07:16:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:16:24 INFO - 'ts_paint', 07:16:24 INFO - 'tpaint', 07:16:24 INFO - 'sessionrestore', 07:16:24 INFO - 'sessionrestore_no_auto_restore', 07:16:24 INFO - 'tabpaint']}, 07:16:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['a11yr', 07:16:24 INFO - 'ts_paint', 07:16:24 INFO - 'tpaint', 07:16:24 INFO - 'sessionrestore', 07:16:24 INFO - 'sessionrestore_no_auto_restore', 07:16:24 INFO - 'tabpaint']}, 07:16:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['a11yr', 07:16:24 INFO - 'ts_paint', 07:16:24 INFO - 'tpaint', 07:16:24 INFO - 'sessionrestore', 07:16:24 INFO - 'sessionrestore_no_auto_restore', 07:16:24 INFO - 'tabpaint']}, 07:16:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['tsvgx', 07:16:24 INFO - 'tsvgr_opacity', 07:16:24 INFO - 'tart', 07:16:24 INFO - 'tscrollx', 07:16:24 INFO - 'cart', 07:16:24 INFO - 'tsvg_static']}, 07:16:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:16:24 INFO - 'tsvgr_opacity', 07:16:24 INFO - 'tart', 07:16:24 INFO - 'tscrollx', 07:16:24 INFO - 'cart', 07:16:24 INFO - 'tsvg_static']}, 07:16:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:16:24 INFO - 'talos_options': ['--disable-e10s'], 07:16:24 INFO - 'tests': ['tp5o']}, 07:16:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:16:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:16:24 INFO - 'talos_options': ['--disable-e10s', 07:16:24 INFO - '--xperf_path', 07:16:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:24 INFO - 'tests': ['tp5n']}, 07:16:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:16:24 INFO - 'talos_options': ['--xperf_path', 07:16:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:24 INFO - 'tests': ['tp5n']}}, 07:16:24 INFO - 'talos.zip': {'path': '', 07:16:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:16:24 INFO - Running post-action listener: _resource_record_post_action 07:16:24 INFO - [mozharness: 2017-06-02 14:16:24.055589Z] Finished populate-webroot step (success) 07:16:24 INFO - [mozharness: 2017-06-02 14:16:24.055679Z] Running create-virtualenv step. 07:16:24 INFO - Running pre-action listener: _resource_record_pre_action 07:16:24 INFO - Running main action method: create_virtualenv 07:16:24 INFO - Creating virtualenv /builds/slave/test/build/venv 07:16:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:16:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:16:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:16:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:16:24 INFO - Using real prefix '/usr' 07:16:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:16:24 INFO - Installing distribute.............................................................................................................................................................................................done. 07:16:26 INFO - Installing pip.................done. 07:16:26 INFO - Return code: 0 07:16:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:16:26 INFO - Reading from file tmpfile_stdout 07:16:26 INFO - Output received: 07:16:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:16:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:16:26 INFO - Using env: {'DISPLAY': ':0', 07:16:26 INFO - 'HOME': '/home/cltbld', 07:16:26 INFO - 'LANG': 'en_US.UTF-8', 07:16:26 INFO - 'LANGUAGE': 'en_US:en', 07:16:26 INFO - 'LOGNAME': 'cltbld', 07:16:26 INFO - 'MAIL': '/var/mail/cltbld', 07:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:26 INFO - 'MOZ_NO_REMOTE': '1', 07:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:26 INFO - 'NO_EM_RESTART': '1', 07:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:26 INFO - 'PWD': '/builds/slave/test', 07:16:26 INFO - 'SHELL': '/bin/bash', 07:16:26 INFO - 'SHLVL': '1', 07:16:26 INFO - 'TERM': 'linux', 07:16:26 INFO - 'TMOUT': '86400', 07:16:26 INFO - 'USER': 'cltbld', 07:16:26 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:26 INFO - '_': '/tools/buildbot/bin/python'} 07:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:16:27 INFO - Cleaning up... 07:16:27 INFO - Return code: 0 07:16:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:16:27 INFO - Using env: {'DISPLAY': ':0', 07:16:27 INFO - 'HOME': '/home/cltbld', 07:16:27 INFO - 'LANG': 'en_US.UTF-8', 07:16:27 INFO - 'LANGUAGE': 'en_US:en', 07:16:27 INFO - 'LOGNAME': 'cltbld', 07:16:27 INFO - 'MAIL': '/var/mail/cltbld', 07:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:27 INFO - 'MOZ_NO_REMOTE': '1', 07:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:27 INFO - 'NO_EM_RESTART': '1', 07:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:27 INFO - 'PWD': '/builds/slave/test', 07:16:27 INFO - 'SHELL': '/bin/bash', 07:16:27 INFO - 'SHLVL': '1', 07:16:27 INFO - 'TERM': 'linux', 07:16:27 INFO - 'TMOUT': '86400', 07:16:27 INFO - 'USER': 'cltbld', 07:16:27 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:27 INFO - '_': '/tools/buildbot/bin/python'} 07:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:27 INFO - Downloading/unpacking psutil>=3.1.1 07:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:16:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:28 INFO - Installing collected packages: psutil 07:16:28 INFO - Running setup.py install for psutil 07:16:28 INFO - building 'psutil._psutil_linux' extension 07:16:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:16:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:16:28 INFO - building 'psutil._psutil_posix' extension 07:16:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:16:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:16:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:28 INFO - Successfully installed psutil 07:16:28 INFO - Cleaning up... 07:16:29 INFO - Return code: 0 07:16:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:16:29 INFO - Using env: {'DISPLAY': ':0', 07:16:29 INFO - 'HOME': '/home/cltbld', 07:16:29 INFO - 'LANG': 'en_US.UTF-8', 07:16:29 INFO - 'LANGUAGE': 'en_US:en', 07:16:29 INFO - 'LOGNAME': 'cltbld', 07:16:29 INFO - 'MAIL': '/var/mail/cltbld', 07:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:29 INFO - 'MOZ_NO_REMOTE': '1', 07:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:29 INFO - 'NO_EM_RESTART': '1', 07:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:29 INFO - 'PWD': '/builds/slave/test', 07:16:29 INFO - 'SHELL': '/bin/bash', 07:16:29 INFO - 'SHLVL': '1', 07:16:29 INFO - 'TERM': 'linux', 07:16:29 INFO - 'TMOUT': '86400', 07:16:29 INFO - 'USER': 'cltbld', 07:16:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:29 INFO - '_': '/tools/buildbot/bin/python'} 07:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:16:30 INFO - Installing collected packages: mozsystemmonitor 07:16:30 INFO - Running setup.py install for mozsystemmonitor 07:16:30 INFO - Successfully installed mozsystemmonitor 07:16:30 INFO - Cleaning up... 07:16:30 INFO - Return code: 0 07:16:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:16:30 INFO - Using env: {'DISPLAY': ':0', 07:16:30 INFO - 'HOME': '/home/cltbld', 07:16:30 INFO - 'LANG': 'en_US.UTF-8', 07:16:30 INFO - 'LANGUAGE': 'en_US:en', 07:16:30 INFO - 'LOGNAME': 'cltbld', 07:16:30 INFO - 'MAIL': '/var/mail/cltbld', 07:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:30 INFO - 'MOZ_NO_REMOTE': '1', 07:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:30 INFO - 'NO_EM_RESTART': '1', 07:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:30 INFO - 'PWD': '/builds/slave/test', 07:16:30 INFO - 'SHELL': '/bin/bash', 07:16:30 INFO - 'SHLVL': '1', 07:16:30 INFO - 'TERM': 'linux', 07:16:30 INFO - 'TMOUT': '86400', 07:16:30 INFO - 'USER': 'cltbld', 07:16:30 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:30 INFO - '_': '/tools/buildbot/bin/python'} 07:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:30 INFO - Downloading/unpacking jsonschema==2.5.1 07:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:31 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:31 INFO - warning: no files found matching '*.txt' 07:16:31 INFO - no previously-included directories found matching 'build' 07:16:31 INFO - no previously-included directories found matching 'dist' 07:16:31 INFO - no previously-included directories found matching '.git*' 07:16:31 INFO - Installing collected packages: jsonschema, functools32 07:16:32 INFO - Running setup.py install for functools32 07:16:32 INFO - warning: no files found matching '*.txt' 07:16:32 INFO - no previously-included directories found matching 'build' 07:16:32 INFO - no previously-included directories found matching 'dist' 07:16:32 INFO - no previously-included directories found matching '.git*' 07:16:32 INFO - Successfully installed jsonschema functools32 07:16:32 INFO - Cleaning up... 07:16:32 INFO - Return code: 0 07:16:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:16:32 INFO - Using env: {'DISPLAY': ':0', 07:16:32 INFO - 'HOME': '/home/cltbld', 07:16:32 INFO - 'LANG': 'en_US.UTF-8', 07:16:32 INFO - 'LANGUAGE': 'en_US:en', 07:16:32 INFO - 'LOGNAME': 'cltbld', 07:16:32 INFO - 'MAIL': '/var/mail/cltbld', 07:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:32 INFO - 'MOZ_NO_REMOTE': '1', 07:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:32 INFO - 'NO_EM_RESTART': '1', 07:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:32 INFO - 'PWD': '/builds/slave/test', 07:16:32 INFO - 'SHELL': '/bin/bash', 07:16:32 INFO - 'SHLVL': '1', 07:16:32 INFO - 'TERM': 'linux', 07:16:32 INFO - 'TMOUT': '86400', 07:16:32 INFO - 'USER': 'cltbld', 07:16:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:32 INFO - '_': '/tools/buildbot/bin/python'} 07:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:16:32 INFO - Cleaning up... 07:16:32 INFO - Return code: 0 07:16:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:16:32 INFO - Using env: {'DISPLAY': ':0', 07:16:32 INFO - 'HOME': '/home/cltbld', 07:16:32 INFO - 'LANG': 'en_US.UTF-8', 07:16:32 INFO - 'LANGUAGE': 'en_US:en', 07:16:32 INFO - 'LOGNAME': 'cltbld', 07:16:32 INFO - 'MAIL': '/var/mail/cltbld', 07:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:32 INFO - 'MOZ_NO_REMOTE': '1', 07:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:32 INFO - 'NO_EM_RESTART': '1', 07:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:32 INFO - 'PWD': '/builds/slave/test', 07:16:32 INFO - 'SHELL': '/bin/bash', 07:16:32 INFO - 'SHLVL': '1', 07:16:32 INFO - 'TERM': 'linux', 07:16:32 INFO - 'TMOUT': '86400', 07:16:32 INFO - 'USER': 'cltbld', 07:16:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:32 INFO - '_': '/tools/buildbot/bin/python'} 07:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:33 INFO - Downloading blobuploader-1.2.4.tar.gz 07:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:16:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:16:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:34 INFO - Downloading docopt-0.6.1.tar.gz 07:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:16:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:16:34 INFO - Running setup.py install for blobuploader 07:16:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:16:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:16:34 INFO - Running setup.py install for requests 07:16:34 INFO - Running setup.py install for docopt 07:16:34 INFO - Successfully installed blobuploader requests docopt 07:16:34 INFO - Cleaning up... 07:16:34 INFO - Return code: 0 07:16:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:34 INFO - Using env: {'DISPLAY': ':0', 07:16:34 INFO - 'HOME': '/home/cltbld', 07:16:34 INFO - 'LANG': 'en_US.UTF-8', 07:16:34 INFO - 'LANGUAGE': 'en_US:en', 07:16:34 INFO - 'LOGNAME': 'cltbld', 07:16:34 INFO - 'MAIL': '/var/mail/cltbld', 07:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:34 INFO - 'MOZ_NO_REMOTE': '1', 07:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:34 INFO - 'NO_EM_RESTART': '1', 07:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:34 INFO - 'PWD': '/builds/slave/test', 07:16:34 INFO - 'SHELL': '/bin/bash', 07:16:34 INFO - 'SHLVL': '1', 07:16:34 INFO - 'TERM': 'linux', 07:16:34 INFO - 'TMOUT': '86400', 07:16:34 INFO - 'USER': 'cltbld', 07:16:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:34 INFO - '_': '/tools/buildbot/bin/python'} 07:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:35 INFO - Running setup.py (path:/tmp/pip-LjKPDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:35 INFO - Running setup.py (path:/tmp/pip-2RANSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:35 INFO - Running setup.py (path:/tmp/pip-PfNnVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:35 INFO - Running setup.py (path:/tmp/pip-lyWHSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:35 INFO - Running setup.py (path:/tmp/pip-7rUcjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:35 INFO - Running setup.py (path:/tmp/pip-jOxnXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:35 INFO - Running setup.py (path:/tmp/pip-2AbtI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:35 INFO - Running setup.py (path:/tmp/pip-lfOBMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:35 INFO - Running setup.py (path:/tmp/pip-tm_rrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:35 INFO - Running setup.py (path:/tmp/pip-FKyEoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:35 INFO - Running setup.py (path:/tmp/pip-y8yHi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:35 INFO - Running setup.py (path:/tmp/pip-_fcz2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:35 INFO - Running setup.py (path:/tmp/pip-reSqNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:36 INFO - Running setup.py (path:/tmp/pip-m5Tmy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:36 INFO - Running setup.py (path:/tmp/pip-uDZL4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:36 INFO - Running setup.py (path:/tmp/pip-CE2ESA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:36 INFO - Running setup.py (path:/tmp/pip-nsV9ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:16:36 INFO - Running setup.py install for manifestparser 07:16:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:16:36 INFO - Running setup.py install for mozcrash 07:16:36 INFO - Running setup.py install for mozdebug 07:16:36 INFO - Running setup.py install for mozdevice 07:16:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:16:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:16:36 INFO - Running setup.py install for mozfile 07:16:36 INFO - Running setup.py install for mozhttpd 07:16:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:16:36 INFO - Running setup.py install for mozinfo 07:16:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Running setup.py install for mozInstall 07:16:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Running setup.py install for mozleak 07:16:37 INFO - Running setup.py install for mozlog 07:16:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Running setup.py install for moznetwork 07:16:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Running setup.py install for mozprocess 07:16:37 INFO - Running setup.py install for mozprofile 07:16:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Running setup.py install for mozrunner 07:16:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:16:37 INFO - Running setup.py install for mozscreenshot 07:16:37 INFO - Running setup.py install for moztest 07:16:37 INFO - Running setup.py install for mozversion 07:16:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:16:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:16:38 INFO - Cleaning up... 07:16:38 INFO - Return code: 0 07:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:38 INFO - Using env: {'DISPLAY': ':0', 07:16:38 INFO - 'HOME': '/home/cltbld', 07:16:38 INFO - 'LANG': 'en_US.UTF-8', 07:16:38 INFO - 'LANGUAGE': 'en_US:en', 07:16:38 INFO - 'LOGNAME': 'cltbld', 07:16:38 INFO - 'MAIL': '/var/mail/cltbld', 07:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:38 INFO - 'MOZ_NO_REMOTE': '1', 07:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:38 INFO - 'NO_EM_RESTART': '1', 07:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:38 INFO - 'PWD': '/builds/slave/test', 07:16:38 INFO - 'SHELL': '/bin/bash', 07:16:38 INFO - 'SHLVL': '1', 07:16:38 INFO - 'TERM': 'linux', 07:16:38 INFO - 'TMOUT': '86400', 07:16:38 INFO - 'USER': 'cltbld', 07:16:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:38 INFO - '_': '/tools/buildbot/bin/python'} 07:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:38 INFO - Running setup.py (path:/tmp/pip-suUBXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:38 INFO - Running setup.py (path:/tmp/pip-SwRFRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:38 INFO - Running setup.py (path:/tmp/pip-gOHsFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:38 INFO - Running setup.py (path:/tmp/pip-LY8ivf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:38 INFO - Running setup.py (path:/tmp/pip-HNj3UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:38 INFO - Running setup.py (path:/tmp/pip-AeIJga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:38 INFO - Running setup.py (path:/tmp/pip-FHuJSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:38 INFO - Running setup.py (path:/tmp/pip-gLCdJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:38 INFO - Running setup.py (path:/tmp/pip-ykqETU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:38 INFO - Running setup.py (path:/tmp/pip-wks7Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:39 INFO - Running setup.py (path:/tmp/pip-qCZ76n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:39 INFO - Running setup.py (path:/tmp/pip-B6InU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:39 INFO - Running setup.py (path:/tmp/pip-qe7R82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:39 INFO - Running setup.py (path:/tmp/pip-O3y88f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:39 INFO - Running setup.py (path:/tmp/pip-1xoVcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:39 INFO - Running setup.py (path:/tmp/pip-GFVUYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:39 INFO - Running setup.py (path:/tmp/pip-ifGyy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:16:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:40 INFO - Downloading blessings-1.6.tar.gz 07:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:40 INFO - Installing collected packages: blessings 07:16:40 INFO - Running setup.py install for blessings 07:16:40 INFO - Successfully installed blessings 07:16:40 INFO - Cleaning up... 07:16:40 INFO - Return code: 0 07:16:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:41 INFO - Reading from file tmpfile_stdout 07:16:41 INFO - Current package versions: 07:16:41 INFO - argparse == 1.2.1 07:16:41 INFO - blessings == 1.6 07:16:41 INFO - blobuploader == 1.2.4 07:16:41 INFO - docopt == 0.6.1 07:16:41 INFO - functools32 == 3.2.3-2 07:16:41 INFO - jsonschema == 2.5.1 07:16:41 INFO - manifestparser == 1.1 07:16:41 INFO - mozInstall == 1.12 07:16:41 INFO - mozcrash == 1.0 07:16:41 INFO - mozdebug == 0.1 07:16:41 INFO - mozdevice == 0.49 07:16:41 INFO - mozfile == 1.2 07:16:41 INFO - mozhttpd == 0.7 07:16:41 INFO - mozinfo == 0.9 07:16:41 INFO - mozleak == 0.1 07:16:41 INFO - mozlog == 3.4 07:16:41 INFO - moznetwork == 0.27 07:16:41 INFO - mozprocess == 0.25 07:16:41 INFO - mozprofile == 0.28 07:16:41 INFO - mozrunner == 6.13 07:16:41 INFO - mozscreenshot == 0.1 07:16:41 INFO - mozsystemmonitor == 0.3 07:16:41 INFO - moztest == 0.8 07:16:41 INFO - mozversion == 1.4 07:16:41 INFO - psutil == 3.1.1 07:16:41 INFO - requests == 1.2.3 07:16:41 INFO - wsgiref == 0.1.2 07:16:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:16:41 INFO - Using env: {'DISPLAY': ':0', 07:16:41 INFO - 'HOME': '/home/cltbld', 07:16:41 INFO - 'LANG': 'en_US.UTF-8', 07:16:41 INFO - 'LANGUAGE': 'en_US:en', 07:16:41 INFO - 'LOGNAME': 'cltbld', 07:16:41 INFO - 'MAIL': '/var/mail/cltbld', 07:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:41 INFO - 'MOZ_NO_REMOTE': '1', 07:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:41 INFO - 'NO_EM_RESTART': '1', 07:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:41 INFO - 'PWD': '/builds/slave/test', 07:16:41 INFO - 'SHELL': '/bin/bash', 07:16:41 INFO - 'SHLVL': '1', 07:16:41 INFO - 'TERM': 'linux', 07:16:41 INFO - 'TMOUT': '86400', 07:16:41 INFO - 'USER': 'cltbld', 07:16:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:41 INFO - '_': '/tools/buildbot/bin/python'} 07:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:16:41 INFO - Cleaning up... 07:16:41 INFO - Return code: 0 07:16:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b06310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:16:41 INFO - Using env: {'DISPLAY': ':0', 07:16:41 INFO - 'HOME': '/home/cltbld', 07:16:41 INFO - 'LANG': 'en_US.UTF-8', 07:16:41 INFO - 'LANGUAGE': 'en_US:en', 07:16:41 INFO - 'LOGNAME': 'cltbld', 07:16:41 INFO - 'MAIL': '/var/mail/cltbld', 07:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:41 INFO - 'MOZ_NO_REMOTE': '1', 07:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:41 INFO - 'NO_EM_RESTART': '1', 07:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:41 INFO - 'PWD': '/builds/slave/test', 07:16:41 INFO - 'SHELL': '/bin/bash', 07:16:41 INFO - 'SHLVL': '1', 07:16:41 INFO - 'TERM': 'linux', 07:16:41 INFO - 'TMOUT': '86400', 07:16:41 INFO - 'USER': 'cltbld', 07:16:41 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:41 INFO - '_': '/tools/buildbot/bin/python'} 07:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:16:41 INFO - Cleaning up... 07:16:41 INFO - Return code: 0 07:16:41 INFO - Running post-action listener: _resource_record_post_action 07:16:41 INFO - Running post-action listener: _start_resource_monitoring 07:16:41 INFO - Starting resource monitoring. 07:16:41 INFO - [mozharness: 2017-06-02 14:16:41.606570Z] Finished create-virtualenv step (success) 07:16:41 INFO - [mozharness: 2017-06-02 14:16:41.607045Z] Running install step. 07:16:41 INFO - Running pre-action listener: _resource_record_pre_action 07:16:41 INFO - Running main action method: install 07:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:41 INFO - Reading from file tmpfile_stdout 07:16:41 INFO - Detecting whether we're running mozinstall >=1.0... 07:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:16:41 INFO - Reading from file tmpfile_stdout 07:16:41 INFO - Output received: 07:16:41 INFO - Usage: mozinstall [options] installer 07:16:41 INFO - Options: 07:16:41 INFO - -h, --help show this help message and exit 07:16:41 INFO - -d DEST, --destination=DEST 07:16:41 INFO - Directory to install application into. [default: 07:16:41 INFO - "/builds/slave/test"] 07:16:41 INFO - --app=APP Application being installed. [default: firefox] 07:16:41 INFO - mkdir: /builds/slave/test/build/application 07:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:16:55 INFO - Reading from file tmpfile_stdout 07:16:55 INFO - Output received: 07:16:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:55 INFO - Running post-action listener: _resource_record_post_action 07:16:55 INFO - [mozharness: 2017-06-02 14:16:55.968744Z] Finished install step (success) 07:16:55 INFO - [mozharness: 2017-06-02 14:16:55.968984Z] Running run-tests step. 07:16:55 INFO - Running pre-action listener: _resource_record_pre_action 07:16:55 INFO - Running main action method: run_tests 07:16:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:55 INFO - Python 2.7.3 07:16:55 INFO - Return code: 0 07:16:55 INFO - grabbing minidump binary from tooltool 07:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:16:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b03400>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b043b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:16:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:16:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:16:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:56 INFO - Return code: 0 07:16:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:56 INFO - ENV: RUST_BACKTRACE is now 1 07:16:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:16:56 INFO - Using env: {'DISPLAY': ':0', 07:16:56 INFO - 'HOME': '/home/cltbld', 07:16:56 INFO - 'LANG': 'en_US.UTF-8', 07:16:56 INFO - 'LANGUAGE': 'en_US:en', 07:16:56 INFO - 'LOGNAME': 'cltbld', 07:16:56 INFO - 'MAIL': '/var/mail/cltbld', 07:16:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:56 INFO - 'MOZ_NO_REMOTE': '1', 07:16:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:56 INFO - 'NO_EM_RESTART': '1', 07:16:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:56 INFO - 'PWD': '/builds/slave/test', 07:16:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:56 INFO - 'RUST_BACKTRACE': '1', 07:16:56 INFO - 'SHELL': '/bin/bash', 07:16:56 INFO - 'SHLVL': '1', 07:16:56 INFO - 'TERM': 'linux', 07:16:56 INFO - 'TMOUT': '86400', 07:16:56 INFO - 'USER': 'cltbld', 07:16:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837', 07:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:56 INFO - '_': '/tools/buildbot/bin/python'} 07:16:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:16:56 INFO - mozversion application_buildid: 20170602132652 07:16:56 INFO - mozversion application_changeset: a6a79438608114ac87218bcb467b1f8aa5d603f3 07:16:56 INFO - mozversion application_display_name: Firefox 07:16:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:56 INFO - mozversion application_name: Firefox 07:16:56 INFO - mozversion application_remotingname: firefox 07:16:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:16:56 INFO - mozversion application_vendor: Mozilla 07:16:56 INFO - mozversion application_version: 54.0 07:16:56 INFO - mozversion platform_buildid: 20170602132652 07:16:56 INFO - mozversion platform_changeset: a6a79438608114ac87218bcb467b1f8aa5d603f3 07:16:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:16:56 INFO - mozversion platform_version: 54.0 07:16:56 INFO - using testdate: 1496413016 07:16:56 INFO - actual date: 1496413016 07:16:56 INFO - starting webserver on 'localhost:47512' 07:16:56 INFO - SUITE-START | Running 2 tests 07:16:56 INFO - TEST-START | dromaeo_css 07:16:56 INFO - operating with platform_type : linux_ 07:16:56 INFO - Initialising browser for dromaeo_css test... 07:16:56 INFO - TEST-INFO | started process 31075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkHlkK/profile http://localhost:47512/getInfo.html) 07:17:01 INFO - PROCESS | 31075 | __metrics Screen width/height:1600/1200 07:17:01 INFO - PROCESS | 31075 | colorDepth:24 07:17:01 INFO - PROCESS | 31075 | Browser inner width/height: 1024/697 07:17:01 INFO - PROCESS | 31075 | __metrics 07:17:02 INFO - PROCESS | 31075 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:17:02 INFO - PROCESS | 31075 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:17:03 INFO - TEST-INFO | 31075: exit 0 07:17:03 INFO - Browser initialized. 07:17:03 INFO - Running cycle 1/1 for dromaeo_css test... 07:17:03 INFO - TEST-INFO | started process 31172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBkHlkK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:14 INFO - PROCESS | 31172 | RSS: Main: 141959168 07:17:14 INFO - PROCESS | 31172 | 07:20:16 INFO - PROCESS | 31172 | Cycle 1(1): loaded http://localhost:47512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47512/tests/dromaeo/cssquery-ext.html) 07:20:18 INFO - PROCESS | 31172 | RSS: Main: 256155648 07:20:18 INFO - PROCESS | 31172 | 07:23:20 INFO - PROCESS | 31172 | Cycle 1(1): loaded http://localhost:47512/tests/dromaeo/cssquery-ext.html (next: http://localhost:47512/tests/dromaeo/cssquery-jquery.html) 07:23:20 INFO - PROCESS | 31172 | RSS: Main: 226619392 07:23:20 INFO - PROCESS | 31172 | 07:26:22 INFO - PROCESS | 31172 | Cycle 1(1): loaded http://localhost:47512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47512/tests/dromaeo/cssquery-mootools.html) 07:26:23 INFO - PROCESS | 31172 | RSS: Main: 171483136 07:26:23 INFO - PROCESS | 31172 | 07:29:25 INFO - PROCESS | 31172 | Cycle 1(1): loaded http://localhost:47512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47512/tests/dromaeo/cssquery-prototype.html) 07:29:25 INFO - PROCESS | 31172 | RSS: Main: 215265280 07:29:25 INFO - PROCESS | 31172 | 07:32:28 INFO - PROCESS | 31172 | Cycle 1(1): loaded http://localhost:47512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47512/tests/dromaeo/cssquery-yui.html) 07:32:29 INFO - PROCESS | 31172 | RSS: Main: 173281280 07:32:29 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | Cycle 1(1): loaded http://localhost:47512/tests/dromaeo/cssquery-yui.html (next: http://localhost:47512/tests/dromaeo/cssquery-dojo.html) 07:35:31 INFO - PROCESS | 31172 | RSS: Main: 257826816 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | __start_tp_report 07:35:31 INFO - PROCESS | 31172 | _x_x_mozilla_page_load 07:35:31 INFO - PROCESS | 31172 | _x_x_mozilla_page_load_details 07:35:31 INFO - PROCESS | 31172 | |i|pagename|runs| 07:35:31 INFO - PROCESS | 31172 | |0;dojo.html;3420.2817408344245;3450.6549345065487;3475.4786781982684;3490.057684425207;3515.6660117288848;5850.561207909408;5871.559633027518;5900.43945825147;5904.46859782619;5909.645421274727;5905.173275741399;5945.88108237835;5946.048632218846;5951.970240148793;5964.135200395951;5306.177542480922;5333;5360.490753378443;5400.891982160354;5419.3225846769155;5234.816781412651;5268.157094864822;5454.809081682142;5464.6994415307145;5466.508014278714;5336.252924590561;5356.892862142755;5369.087255166631;5381.031414345416;5399.865003374908;5436.293281873351;5448.046591846451;5448.8365349039395;5453.645513041679;5456;5204.635675502716;5305.602079844027;5354.598405119632;5382.058139825514;5443.2107344434835;5746.79886203985;5786.334571524287;5826.883462330772;5891.410858914117;5896.705164741746;6279.37206279373;6290.087937249119;6317.431431171217;6317.715702793385;6323.33604971476;6357.364263573651;6367.6497792621385;6370.235571731376;6372.490200783926;6374.521910856704;5766.942330576682;5798.246227990334;5851.912221316641;5882.499987501024;5977.133315669291;6466.482681385478;6472.0291956206;6472.35276472349;6474.964005759056;6475.579087359307;6118.235220597426;6242.188515493048;6245.781397651152;6248.562600617913;6251.937480625226;6083.8174854754425;6117.204763380732;6209.9379006210265;6325.240971083499;6337.619742815354;6300.810975670737;6306.085617585424;6312.210973628296;6315.210598675166;6316.115743795872;6100.755969761249;6112.26032301701;6171.814845554641;6177.351378105234;6325.082862984841;4712.811487540528;4722.598579120745;4749.073930583503;4762.690425122356;4763.428388593322;4258.361245813153;4265.125649241898;4303.591158839905;4308.310670292801;4357.411749413852;6028.788992385245;6035.426634469718;6035.758569657252;6046.909296360558;6071.119687645267;6118.357572454917;6130.245269657028;6249.343818899041;6252.781152659726;6356.968215158895;6045.576809623284;6050.273967123973;6050.394960503914;6053.152558641794;6087.817365479043;5373.677579345252;5385.3268341457315;5386.084365657847;5389.541888939406;5390;6235.688215589203;6360.236771587439;6488.221413430229;6545.476361891133;6602.207735071822;6328.240611126695;6355.396237357444;6367.363263673596;6370.649614271074;6374.904376434264;6651.401373876374;6656.167979002625;6656.267810540933;6656.73373065072;6661;6073.848153796191;6104.267487901303;6147.323794382525;6212.254529456494;6277.905831412624;6261.154744109487;6340.4927605792345;6367.9044814328745;6370.458511026429;6372.74509019634;6169.6915154241215;6179.474744646755;6180.752769889334;6184.103305020657;6190.2571691397325;5968.403159683997;6010.068439391901;6118.051701986199;6179.660118693515;6185.659788711484;6104.17593624855;6122.418370254819;6139.798803208702;6153.046277826944;6167.599106058092;6225.937740622717;6233.719482623203;6241.78153764616;6245.906311405423;6248.4064013918605;5876.500497457764;5890.2342695449315;5932.79235226765;6083.452489275986;6098.0852872069545 07:35:31 INFO - PROCESS | 31172 | |1;ext.html;775.1666958020127;834.7036801935313;852.9189726975939;902.823949329881;910.0399078971682;30247.24381890454;42431.363529547045;42908.570914290845;43165;43308.566914330884;39046.219075618545;39081.60918390815;39328.80335598318;44153.77923110388;44197.337039944345;7708.653110610008;7879.881801772978;9201.125893040167;9342.766430839216;9343.299252556051;10704.78590428191;10952.123830093613;10952.671419857417;10954.287971281841;10958.123350131971;11076.889231107707;11116.22186446945;11121.888781112206;11124.38815865127;11136.888631113707;10989.890101099007;11021.944890275538;11047.944760276147;11049.337039777598;11056.613018544313;10593.099586535154;10637.627683031134;10657.200709946708;10668.093212076983;10672.679819605424;40727.18545629071;40734.185316293806;40891.7955410224;40906.79546602278;40980.385294220614;4309.267424537805;4354.194474022316;4374.912501749947;4469.664775141878;4490.685652004361;29526.114216573536;29928.70071299281;30078.54882176769;30604.693953060407;31379.686203137906;4333.826646934119;4434.06884554244;4440.267355886275;4442.600165985044;4483.103379324149;226906;227081;228063;228454;228701.99999999834;52258.738706306984;52543.474565254626;52777.736111319195;52903.470965290624;52987.470125298256;54758.17862732062;54809.72595136999;54842.17736733952;54894.451055488935;54940.72529637326;16368.590785230226;16828.495145145665;16845.831541684427;16846.157692115346;16880.493585192464;11927.821082683766;12098.516059357527;14543.41826326935;14950.102993820406;15007.024543404645;12921.870781292067;13087.672808179872;13150.07949443549;13217.273049982343;13289.601311960656;5360.8123715670545;5380.139177731544;5394.406615272317;5426.593005524523;5524;1015;1018.1701912941078;1027.825269704137;1029.3206483720708;1029.5264178477985;26747;27602.723972760417;28018.43963120726;28243.435131297258;28540.71459285422;1093.2511229807608;1094.2777766673958;1104.0560320925492;1104.7956128116164;1135.1089394825024;14416.13503189812;14489.275536223147;14783.926080369529;14791.482298119514;14830.480933167288;291743;292359;293044;293090;294660;52963;53172;53243.201351979755;53246.467535324926;53276.467235327924;1479.3490864019798;1480.9333579988927;1502.504173622702;1517.1883042572392;1563.1715190948814;27064;28136;28284.43431131407;28311;28638.14085577436;44888;45143.77428112838;45207;45211.99999999868;45226.77386613046;320833;321134;321536;322895;325281;29610;29853.55219671663;29964.101076967727;30082.24794380158;30089.699103009567;37936;38087.23825523419;38535.80732096321;38640;39040.41439378468;29604.555931660612;30025.5496167562;30087;30149.547756784104;30591.847040764653;29347.559786603644;29622.851885740434;29780.404391912474;30206;30298.69701302959;33975.3204935895;34347.141321466166;34356;34372.65627343795;34509.30981380409;29155.85422072876;29405.85297073501;29450.852745736134;29550.852245738635;29707.851460742557;22943.311700649007;24239.272821815375;24479;24606.753932460448;24736.876315618305 07:35:31 INFO - PROCESS | 31172 | |2;jquery.html;466.4286249344551;469.3101141322255;478.76301230890704;479.9976000120001;488.60259657379885;20201.39395818126;21570.460738481546;21699.783002169974;21724;21870.78129218707;22190.112395504202;22483.66274505884;22528.77471225287;22597.77402225977;22732.772672273273;6846.383825455708;6903;6912.758053468129;6978.232394436608;7018.719251229944;6883.724651013953;7032.437405007587;7038.049863268445;7326.3040011198855;7601.239876012382;7767.6892924282965;7783.377329813601;7789.143194248628;7795.844083118334;7797.610119494031;7545.7358992435275;7666.693332266703;7671.616419179075;7685.923140768605;7717.151113377552;7396.186419493852;7452.701891924371;7567.886481702779;7610.429217808686;7621.23787621239;25083.87458062698;25450.10924617648;26050.34874128162;26173.73826261732;26217.868910655325;2949.27742703037;3102.37952409519;3161.0516844946424;3219.6941290577356;3257.478803391446;15427.691446171126;15923.044617322881;16049;16193.352265909349;16261.83738162615;2336.4859730859353;2408.8313818032743;2441.218809980807;2473.134402958968;2639.749223823753;113239;115130.99999999916;115513.4224328873;119068.84645618389;119390;18247.72628410575;18350.81649183518;18543.72184417235;18579.907100464683;18996.050197490345;32350.676493234765;32370.676293237237;32443.837780810944;32761.34477310488;32845.67154328426;10666.413347265974;10754.784904302027;10893.400862952456;10928.125749939985;11272.605458808903;9108.407953483002;9121.954390228006;9230.723078307661;9382.718518444457;9384.343095983351;9137.451752894847;9338.517511594473;9435.292353073546;9484.573194206278;9568.808623827485;3457.0960393269775;3539.823008849547;3571.9818302658914;3677.5219221501034;3804.353259945816;957.9952100239593;959.947202903833;960.8078384323163;966.2173639352147;979.5689896445541;19282.22871085141;20619.8969005157;20735.377938661863;20822.687659685118;21004.264850730153;973.026973026973;979.2264111352094;986.649739342523;993.2054356514759;1002.4987506246877;10484.63303784379;11386.94306528462;11421.657350279505;11529.538818447169;11626.883731162749;478409;617677;629425;630995;634266;68633.31366686369;110177.44911275392;113231;117089;119713;1188.8632807227107;1335.8998075144402;1372.053283234545;1383.5780087073338;1392.78411846164;18334.174962127003;18690.719639205694;18891.68136463762;18892.905535472233;19231.615367692848;48750.51249487601;49086.26370604373;49286.75356623194;49616.75191624019;50299.74850125726;64449;65211.347886522424;65758.34241657522;66007.33992660012;66839.3316066833;11620.88379116198;12054.216475929388;12102.75794484123;12132.757344852876;12264.877351226374;12726.554570589984;13136;13162.60512184636;13287.13633613812;13525.864741352461;10598.735031624272;10630.468476576294;11155.665330040112;11264.887351126712;11888.46501907399;10044.849327260243;10193.541290642088;10344.27590068688;10626.84059739089;10675.412852292888;11217.326960382403;11270.605528806453;11421.1434142438;11515.481803319039;11627.883721163018;11677.299362037966;11960.58137965167;12101.636950891487;12146;12212.145149839425;11120.666380008613;11248.212625116163;11315.377654229096;11459.484323205643;11740.647780566596 07:35:31 INFO - PROCESS | 31172 | |3;mootools.html;1550.8061492313461;1566.9921650391746;1591.9363225470988;1606.6385063360744;1616.0626836434865;10812.189085818565;11492.023178029856;11495.425228738572;11501.769964600713;11507.48216330264;11182.888171118286;11191.440427978609;11423.885761142406;11433.028192603619;11445.484953177107;2494.214322488415;2560.3087166465043;2561.180422264876;2574.806889483287;2588.352911772057;2433.5741245282006;2462.224399314219;2509.5482813093636;2511.3721569607596;2513.158092039169;2433.4646377796857;2475.232677869866;2509;2512.9748702513016;2529.304441278654;2404.278716385086;2430.6961629796274;2441.4994926040117;2452.301094188148;2465.5315490056832;2511.3344963584664;2528.203615860998;2550.681164854393;2550.9362265943314;2552.8851201695784;11602.6519204424;11860.28838269698;11879.881201187964;11881.702957426134;11895.643130706092;5967.254093238345;6109.633421994695;6118.755249790003;6120.14317995481;6124.479419249369;3673.779573225615;3706.0734816295926;3711.164987877733;3760.793156376398;3767.7770115631633;1466.7359875222455;1481.4666719980798;1498.9175595342251;1533.9539813805604;1548.040215066666;14262.64343391413;14538.273086345745;16514.42199523011;17741.645167096714;17996.820031799645;4978.5768209701855;5137.17805151174;5167.199084141964;5206.088934436459;5208.817691380859;14764.114153150846;14778.926105369404;14781.408743650349;14783.926080369529;14784.778228326584;6255.593386429868;6269.435750782452;6270.749170033238;6276.748930042747;6278.937210627927;5538.529225015919;5656.773729050792;5707.0583353747;5747.39652336507;5747.482726554546;4451.909282225875;4526.140033393644;4541.296099104644;4569.309355538472;4591.885202869955;1203.5546847666244;1240.6960294727849;1242.571312897049;1260.0927332320714;1262.4950019992077;1057.3444464431948;1091.0943916549404;1094.5129417409335;1102.8180350242121;1108.711734948919;7189.89215161773;7319.8715006883085;7351.41188704913;7412.481126321213;7444.255574442513;1077.4828082520435;1091.8471414002047;1096.923215374932;1116.6984914073155;1118.3681220110611;4748.430188377417;4764.2615394613895;4924.8276310328965;4961.330220420269;4978.253262010728;14732.926335368255;15438.382464701286;15450.38198472071;15451.690966180613;15473.148976806384;13974.860251397558;15147.469838555819;15252.237388130548;15253.6186595336;15358.692826143639;9215.95392023049;10310.175185985103;10535;10538.156947444186;10539.262251642465;6121.4490695837585;7252.38354739853;7393.334599886036;7415.8887616684715;7502.849943001219;12560.120791544505;12857.485700572246;12947.482100715866;12983.415746291628;13126.868731312565;13049.151805132637;13171.868281317064;13359.465621375037;13389.732205356033;13570.728585428433;9928.205743540644;10117.19062475015;10133.18934485254;10174;10225.642102526375;10913;10953.507092181031;10956.452177391258;11080.722981925517;11108.666739997812;9388.765280868032;9400.95299523498;9539.809203816023;9707.466089365153;9748.268879834182;9208.12522810332;9246.537673116452;9265.72202833916;9280.58237379306;9367.437953722798;8452.239298462922;8654.134586541295;8656.697015604424;8662.307015438624;8667.349948753996;6344.968275158594;6390.648514331757;6420.839479013062;6469.159009328945;6528.869422611616;6244.656543889948;6348.111264422892;6420.390062944013;6460.837049331166;6561.311062338576 07:35:31 INFO - PROCESS | 31172 | |4;prototype.html;416.2486711485767;423.54468945883184;430.47697048086576;441.7901496789025;441.8776308177228;5058.317127187828;5137.666051706637;5175.353080864892;5216.84349469516;5258.605604579658;5073.644844860862;5162.819301324445;5171.534561889429;5183.196604526295;5187.325647665808;4516.412866327373;4517.909641807179;4539.501964351773;4543.318502224676;4552.430946131733;4426.690131690767;4475.28395456727;4544.386507821451;4544.500104988449;4552.635789136878;4489.416375871132;4499.762565294537;4507.504174540814;4511.436070491189;4529.893599476243;4492.977535112336;4494.235979883428;4512.300593408027;4551.4083169188125;4572.177008138534;4241.4698162729655;4331.610155086058;4379.824807007716;4394.6923715339935;4401.691881568291;5064.290999260106;5068.771905264272;5088.516590923857;5102.540771330561;5113.437521872591;5191.974040129775;5217.852072544034;5217.869553261161;5220.269162317279;5264.341957255343;5340.477963780304;5477.589180811455;5494.148406996922;5501.377093757351;5507.228987941691;4776.211925032366;4784.234522476422;4788.904221915577;4805.327254184417;4836.322914791932;5719.369090218463;5744.8851022979725;5770;5772.365039845614;5839.678817665027;4871.34236878017;4913.164761990471;4950.331705219821;4969.304297398367;5049.545540901337;5026.472220416877;5033.993201359743;5037.571806396424;5060.822871199564;5073.644844860824;5204.9219261711105;5237.685738855681;5242.292290540804;5270.841874743764;5323.547498462674;5203.245529398216;5331.947200327824;5374.838754837361;5417.4582541746295;5560.193771903051;1556.8209655889718;1584.9366025359086;1585.810642018486;1594.6970075685583;1596.3295415925338;1262.8926541243914;1279.5137847617846;1291.5285920638898;1296.1963582578862;1303.9869601303865;5129.64092513528;5336.466353364633;5371.543418809367;5421.783128674888;5445.754941027663;5534.177569439615;5580.218769372291;5589.664620122806;5601.971990140023;5605.691686957175;5278.445763194886;5304.363476382859;5326.041312563776;5327.121025030904;5370.516653501204;2781.1934538983874;2913.4704280252613;2920.1677521906154;2932.5601159826197;2947.852607369623;5728.742206600713;5797.912751409489;5801.664043175191;5819.526701151994;5830.504407125357;5569.944300557024;5729.828105156852;5734.942650573441;5739.794643124907;5758.539316854642;5705.343885453226;5737.426257374229;5784.739686714024;5785.537157027512;5800.709964501758;5564.77740890376;5623.522000629992;5624.778212606079;5635.830925072254;5642.830715078554;5245.239440281061;5442.4557544246845;5464.426235245242;5566.77732890696;5596.6921819298705;5779.826605201851;5789.421057894177;5802.622829516068;5820.883582328414;5829.3296270927685;4638.466576343763;4646.442426908658;4654.953450465452;4694.34279200919;4703.3885594872445;5389.299391079135;5604.299462567179;5616.887662246814;5644.717764111861;5661.971690141523;5257.579393648422;5490.862728431821;5517.124177779574;5530.308711411074;5542.584306176972;5307.920381194363;5365.302510673743;5461.945380546303;5488.506034456758;5507.366652834815;5428.67427954324;5483.451654834645;5484.424135465719;5513.972430137824;5526.861828454321;5249.238860365149;5458.4541545845095;5468.863278418072;5492.231087647812;5494;5398.811041613525;5418.266154830574;5427.185922111715;5444.346678398618;5450.5367043801725 07:35:31 INFO - PROCESS | 31172 | |5;yui.html;827.8385714785616;843.4306842881053;923.1691477670096;946.4321407155705;951.8239125761739;17362.479125626236;18740.625187496276;18813.905930470362;18822.341218057372;18841.246350145993;15438.382464701399;16961.406350777725;17223.483295501155;17366.13169341531;17371.478855634352;877.714742708619;885.1812073831712;891.6879092317702;894.3515950935553;896.44420459315;907.6505545365015;909.0364213933219;910.9544522773868;911.0661571888801;911.1799380557485;963.0610155098793;963.1716723617683;964;965.1217392173124;965.9565319560602;951.8001219743862;956.9808603827885;957.5547370472764;961.0773657289011;961.1445813226235;699.4264702943589;706.251373544045;707.8902770070647;709.1277728394105;709.5813470052693;16118.194090295556;16363.263653135638;16390.590235244093;16468;16504.092274924875;14629.341679624442;14638.194899280536;15040.247987600576;15076.849231507655;15145.848541514553;12688;12859.678508037281;12931.935340323333;12984.87015129846;12998.935005325007;4036.576159503239;4095.651869591088;4107.732997355192;4168.895777605584;4171.395147703596;80309.19690803134;81357;81377.59311203405;82987.17012829916;83313.58343208245;10879.619213327655;11097;11142.331460112418;11323.603673871376;11327.773444531063;23296.417589560057;23485.06059757625;23500.882495587754;23754.16860409912;23904;9379;9450.243980481682;9537.856932146024;9589.136977672042;9599.904000959901;4385.350365942698;4520.932186017212;4534.977325113353;4543.182227199136;4652.32541281519;3956.9010774730864;4045.7774822384463;4052.3111071117983;4072.6131017553284;4077.510698716114;648.060312546809;654.9803505894831;662.8806814773387;666.6566718140161;671.8757029949475;812.4353574265829;835.2733122183739;848.1984524624171;851.1743608699552;874.6107981947972;10875.347479151276;11250.212485126127;11648.184627076023;11965.923066924019;12378.257304561756;849.6431498770531;849.8512760266929;859.6905114158898;863.330918538138;873.5370253765515;4763.737994410271;4804.543568361;4817.662763606514;4856.854294371175;4857.878553036132;78046.21953780502;79410.20589794144;79711;81367.18632813715;82150;66964.66517667478;68131;68318.65840670864;71298.64350678213;71312.64343678248;52219.73890130525;60761.392386075575;61765.38234617686;62525.77036545281;63415;8900.910990890008;9016.909830901606;9051.728448146567;9307.488088154945;10168.830584482583;41086.794566026976;41470.37794433146;41780;42007.57992420036;42058.579414205466;54439.455605443436;54724.452755473525;55939.72030139986;57337;57510.13734793898;12616.684582885135;12627.621171364874;12712.809307860574;12797.936010319889;12838.935805321287;14502.927485362507;14561.563153105424;14573.198474084027;14710.117392956457;14731.410743570137;13735.381907813973;13772.380242888894;14173.574792756233;14324.427022918966;14801.481948131765;13613.727725445238;13851.30743462843;13866.584002479942;13876.306184690928;14048.297585120907;13073.31888068572;13140.737185256432;13312.667183320495;13325.067245292736;13434.328283585586;9833.360831545926;9939.353941994037;10446.268761186644;10732.678019659423;10762.19283553721;9746.463944482837;10907.672769816918;10999.780004400027;11129.165312601426;11140.554377824796 07:35:31 INFO - PROCESS | 31172 | __end_tp_report 07:35:31 INFO - PROCESS | 31172 | __start_cc_report 07:35:31 INFO - PROCESS | 31172 | _x_x_mozilla_cycle_collect,1200 07:35:31 INFO - PROCESS | 31172 | __end_cc_report 07:35:31 INFO - PROCESS | 31172 | __startTimestamp1496414131521__endTimestamp 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | ------- Summary: start ------- 07:35:31 INFO - PROCESS | 31172 | Number of tests: 6 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | [#0] dojo.html Cycles:165 Average:5857.40 Median:6087.82 stddev:663.39 (10.9%) stddev-sans-first:637.28 07:35:31 INFO - PROCESS | 31172 | Values: 3420.3 3450.7 3475.5 3490.1 3515.7 5850.6 5871.6 5900.4 5904.5 5909.6 5905.2 5945.9 5946.0 5952.0 5964.1 5306.2 5333.0 5360.5 5400.9 5419.3 5234.8 5268.2 5454.8 5464.7 5466.5 5336.3 5356.9 5369.1 5381.0 5399.9 5436.3 5448.0 5448.8 5453.6 5456.0 5204.6 5305.6 5354.6 5382.1 5443.2 5746.8 5786.3 5826.9 5891.4 5896.7 6279.4 6290.1 6317.4 6317.7 6323.3 6357.4 6367.6 6370.2 6372.5 6374.5 5766.9 5798.2 5851.9 5882.5 5977.1 6466.5 6472.0 6472.4 6475.0 6475.6 6118.2 6242.2 6245.8 6248.6 6251.9 6083.8 6117.2 6209.9 6325.2 6337.6 6300.8 6306.1 6312.2 6315.2 6316.1 6100.8 6112.3 6171.8 6177.4 6325.1 4712.8 4722.6 4749.1 4762.7 4763.4 4258.4 4265.1 4303.6 4308.3 4357.4 6028.8 6035.4 6035.8 6046.9 6071.1 6118.4 6130.2 6249.3 6252.8 6357.0 6045.6 6050.3 6050.4 6053.2 6087.8 5373.7 5385.3 5386.1 5389.5 5390.0 6235.7 6360.2 6488.2 6545.5 6602.2 6328.2 6355.4 6367.4 6370.6 6374.9 6651.4 6656.2 6656.3 6656.7 6661.0 6073.8 6104.3 6147.3 6212.3 6277.9 6261.2 6340.5 6367.9 6370.5 6372.7 6169.7 6179.5 6180.8 6184.1 6190.3 5968.4 6010.1 6118.1 6179.7 6185.7 6104.2 6122.4 6139.8 6153.0 6167.6 6225.9 6233.7 6241.8 6245.9 6248.4 5876.5 5890.2 5932.8 6083.5 6098.1 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | [#1] ext.html Cycles:180 Average:44536.72 Median:29816.98 stddev:74123.24 (248.6%) stddev-sans-first:74258.35 07:35:31 INFO - PROCESS | 31172 | Values: 775.2 834.7 852.9 902.8 910.0 30247.2 42431.4 42908.6 43165.0 43308.6 39046.2 39081.6 39328.8 44153.8 44197.3 7708.7 7879.9 9201.1 9342.8 9343.3 10704.8 10952.1 10952.7 10954.3 10958.1 11076.9 11116.2 11121.9 11124.4 11136.9 10989.9 11021.9 11047.9 11049.3 11056.6 10593.1 10637.6 10657.2 10668.1 10672.7 40727.2 40734.2 40891.8 40906.8 40980.4 4309.3 4354.2 4374.9 4469.7 4490.7 29526.1 29928.7 30078.5 30604.7 31379.7 4333.8 4434.1 4440.3 4442.6 4483.1 226906.0 227081.0 228063.0 228454.0 228702.0 52258.7 52543.5 52777.7 52903.5 52987.5 54758.2 54809.7 54842.2 54894.5 54940.7 16368.6 16828.5 16845.8 16846.2 16880.5 11927.8 12098.5 14543.4 14950.1 15007.0 12921.9 13087.7 13150.1 13217.3 13289.6 5360.8 5380.1 5394.4 5426.6 5524.0 1015.0 1018.2 1027.8 1029.3 1029.5 26747.0 27602.7 28018.4 28243.4 28540.7 1093.3 1094.3 1104.1 1104.8 1135.1 14416.1 14489.3 14783.9 14791.5 14830.5 291743.0 292359.0 293044.0 293090.0 294660.0 52963.0 53172.0 53243.2 53246.5 53276.5 1479.3 1480.9 1502.5 1517.2 1563.2 27064.0 28136.0 28284.4 28311.0 28638.1 44888.0 45143.8 45207.0 45212.0 45226.8 320833.0 321134.0 321536.0 322895.0 325281.0 29610.0 29853.6 29964.1 30082.2 30089.7 37936.0 38087.2 38535.8 38640.0 39040.4 29604.6 30025.5 30087.0 30149.5 30591.8 29347.6 29622.9 29780.4 30206.0 30298.7 33975.3 34347.1 34356.0 34372.7 34509.3 29155.9 29405.9 29450.9 29550.9 29707.9 22943.3 24239.3 24479.0 24606.8 24736.9 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | [#2] jquery.html Cycles:180 Average:35664.36 Median:2372.66 stddev:99331.13 (4186.5%) stddev-sans-first:99574.62 07:35:31 INFO - PROCESS | 31172 | Values: 466.4 469.3 478.8 480.0 488.6 20201.4 21570.5 21699.8 21724.0 21870.8 22190.1 22483.7 22528.8 22597.8 22732.8 6846.4 6903.0 6912.8 6978.2 7018.7 6883.7 7032.4 7038.0 7326.3 7601.2 7767.7 7783.4 7789.1 7795.8 7797.6 7545.7 7666.7 7671.6 7685.9 7717.2 7396.2 7452.7 7567.9 7610.4 7621.2 25083.9 25450.1 26050.3 26173.7 26217.9 2949.3 3102.4 3161.1 3219.7 3257.5 15427.7 15923.0 16049.0 16193.4 16261.8 2336.5 2408.8 2441.2 2473.1 2639.7 113239.0 115131.0 115513.4 119068.8 119390.0 18247.7 18350.8 18543.7 18579.9 18996.1 32350.7 32370.7 32443.8 32761.3 32845.7 10666.4 10754.8 10893.4 10928.1 11272.6 9108.4 9122.0 9230.7 9382.7 9384.3 9137.5 9338.5 9435.3 9484.6 9568.8 3457.1 3539.8 3572.0 3677.5 3804.4 958.0 959.9 960.8 966.2 979.6 19282.2 20619.9 20735.4 20822.7 21004.3 973.0 979.2 986.6 993.2 1002.5 10484.6 11386.9 11421.7 11529.5 11626.9 478409.0 617677.0 629425.0 630995.0 634266.0 68633.3 110177.4 113231.0 117089.0 119713.0 1188.9 1335.9 1372.1 1383.6 1392.8 18334.2 18690.7 18891.7 18892.9 19231.6 48750.5 49086.3 49286.8 49616.8 50299.7 64449.0 65211.3 65758.3 66007.3 66839.3 11620.9 12054.2 12102.8 12132.8 12264.9 12726.6 13136.0 13162.6 13287.1 13525.9 10598.7 10630.5 11155.7 11264.9 11888.5 10044.8 10193.5 10344.3 10626.8 10675.4 11217.3 11270.6 11421.1 11515.5 11627.9 11677.3 11960.6 12101.6 12146.0 12212.1 11120.7 11248.2 11315.4 11459.5 11740.6 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | [#3] mootools.html Cycles:180 Average:7319.00 Median:2470.38 stddev:4597.25 (186.1%) stddev-sans-first:4589.71 07:35:31 INFO - PROCESS | 31172 | Values: 1550.8 1567.0 1591.9 1606.6 1616.1 10812.2 11492.0 11495.4 11501.8 11507.5 11182.9 11191.4 11423.9 11433.0 11445.5 2494.2 2560.3 2561.2 2574.8 2588.4 2433.6 2462.2 2509.5 2511.4 2513.2 2433.5 2475.2 2509.0 2513.0 2529.3 2404.3 2430.7 2441.5 2452.3 2465.5 2511.3 2528.2 2550.7 2550.9 2552.9 11602.7 11860.3 11879.9 11881.7 11895.6 5967.3 6109.6 6118.8 6120.1 6124.5 3673.8 3706.1 3711.2 3760.8 3767.8 1466.7 1481.5 1498.9 1534.0 1548.0 14262.6 14538.3 16514.4 17741.6 17996.8 4978.6 5137.2 5167.2 5206.1 5208.8 14764.1 14778.9 14781.4 14783.9 14784.8 6255.6 6269.4 6270.7 6276.7 6278.9 5538.5 5656.8 5707.1 5747.4 5747.5 4451.9 4526.1 4541.3 4569.3 4591.9 1203.6 1240.7 1242.6 1260.1 1262.5 1057.3 1091.1 1094.5 1102.8 1108.7 7189.9 7319.9 7351.4 7412.5 7444.3 1077.5 1091.8 1096.9 1116.7 1118.4 4748.4 4764.3 4924.8 4961.3 4978.3 14732.9 15438.4 15450.4 15451.7 15473.1 13974.9 15147.5 15252.2 15253.6 15358.7 9216.0 10310.2 10535.0 10538.2 10539.3 6121.4 7252.4 7393.3 7415.9 7502.8 12560.1 12857.5 12947.5 12983.4 13126.9 13049.2 13171.9 13359.5 13389.7 13570.7 9928.2 10117.2 10133.2 10174.0 10225.6 10913.0 10953.5 10956.5 11080.7 11108.7 9388.8 9401.0 9539.8 9707.5 9748.3 9208.1 9246.5 9265.7 9280.6 9367.4 8452.2 8654.1 8656.7 8662.3 8667.3 6345.0 6390.6 6420.8 6469.2 6528.9 6244.7 6348.1 6420.4 6460.8 6561.3 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | [#4] prototype.html Cycles:180 Average:4828.07 Median:5258.09 stddev:1265.15 (24.1%) stddev-sans-first:1224.60 07:35:31 INFO - PROCESS | 31172 | Values: 416.2 423.5 430.5 441.8 441.9 5058.3 5137.7 5175.4 5216.8 5258.6 5073.6 5162.8 5171.5 5183.2 5187.3 4516.4 4517.9 4539.5 4543.3 4552.4 4426.7 4475.3 4544.4 4544.5 4552.6 4489.4 4499.8 4507.5 4511.4 4529.9 4493.0 4494.2 4512.3 4551.4 4572.2 4241.5 4331.6 4379.8 4394.7 4401.7 5064.3 5068.8 5088.5 5102.5 5113.4 5192.0 5217.9 5217.9 5220.3 5264.3 5340.5 5477.6 5494.1 5501.4 5507.2 4776.2 4784.2 4788.9 4805.3 4836.3 5719.4 5744.9 5770.0 5772.4 5839.7 4871.3 4913.2 4950.3 4969.3 5049.5 5026.5 5034.0 5037.6 5060.8 5073.6 5204.9 5237.7 5242.3 5270.8 5323.5 5203.2 5331.9 5374.8 5417.5 5560.2 1556.8 1584.9 1585.8 1594.7 1596.3 1262.9 1279.5 1291.5 1296.2 1304.0 5129.6 5336.5 5371.5 5421.8 5445.8 5534.2 5580.2 5589.7 5602.0 5605.7 5278.4 5304.4 5326.0 5327.1 5370.5 2781.2 2913.5 2920.2 2932.6 2947.9 5728.7 5797.9 5801.7 5819.5 5830.5 5569.9 5729.8 5734.9 5739.8 5758.5 5705.3 5737.4 5784.7 5785.5 5800.7 5564.8 5623.5 5624.8 5635.8 5642.8 5245.2 5442.5 5464.4 5566.8 5596.7 5779.8 5789.4 5802.6 5820.9 5829.3 4638.5 4646.4 4655.0 4694.3 4703.4 5389.3 5604.3 5616.9 5644.7 5662.0 5257.6 5490.9 5517.1 5530.3 5542.6 5307.9 5365.3 5461.9 5488.5 5507.4 5428.7 5483.5 5484.4 5514.0 5526.9 5249.2 5458.5 5468.9 5492.2 5494.0 5398.8 5418.3 5427.2 5444.3 5450.5 07:35:31 INFO - PROCESS | 31172 | 07:35:31 INFO - PROCESS | 31172 | [#5] yui.html Cycles:180 Average:18018.57 Median:4539.08 stddev:22589.58 (497.7%) stddev-sans-first:22616.06 07:35:31 INFO - PROCESS | 31172 | Values: 827.8 843.4 923.2 946.4 951.8 17362.5 18740.6 18813.9 18822.3 18841.2 15438.4 16961.4 17223.5 17366.1 17371.5 877.7 885.2 891.7 894.4 896.4 907.7 909.0 911.0 911.1 911.2 963.1 963.2 964.0 965.1 966.0 951.8 957.0 957.6 961.1 961.1 699.4 706.3 707.9 709.1 709.6 16118.2 16363.3 16390.6 16468.0 16504.1 14629.3 14638.2 15040.2 15076.8 15145.8 12688.0 12859.7 12931.9 12984.9 12998.9 4036.6 4095.7 4107.7 4168.9 4171.4 80309.2 81357.0 81377.6 82987.2 83313.6 10879.6 11097.0 11142.3 11323.6 11327.8 23296.4 23485.1 23500.9 23754.2 23904.0 9379.0 9450.2 9537.9 9589.1 9599.9 4385.4 4520.9 4535.0 4543.2 4652.3 3956.9 4045.8 4052.3 4072.6 4077.5 648.1 655.0 662.9 666.7 671.9 812.4 835.3 848.2 851.2 874.6 10875.3 11250.2 11648.2 11965.9 12378.3 849.6 849.9 859.7 863.3 873.5 4763.7 4804.5 4817.7 4856.9 4857.9 78046.2 79410.2 79711.0 81367.2 82150.0 66964.7 68131.0 68318.7 71298.6 71312.6 52219.7 60761.4 61765.4 62525.8 63415.0 8900.9 9016.9 9051.7 9307.5 10168.8 41086.8 41470.4 41780.0 42007.6 42058.6 54439.5 54724.5 55939.7 57337.0 57510.1 12616.7 12627.6 12712.8 12797.9 12838.9 14502.9 14561.6 14573.2 14710.1 14731.4 13735.4 13772.4 14173.6 14324.4 14801.5 13613.7 13851.3 13866.6 13876.3 14048.3 13073.3 13140.7 13312.7 13325.1 13434.3 9833.4 9939.4 10446.3 10732.7 10762.2 9746.5 10907.7 10999.8 11129.2 11140.6 07:35:31 INFO - PROCESS | 31172 | -------- Summary: end -------- 07:35:31 INFO - PROCESS | 31172 | 07:35:32 INFO - TEST-INFO | 31172: exit 0 07:35:32 INFO - TEST-OK | dromaeo_css | took 1116028ms 07:35:32 INFO - TEST-START | kraken 07:35:32 INFO - operating with platform_type : linux_ 07:35:32 INFO - Initialising browser for kraken test... 07:35:32 INFO - TEST-INFO | started process 31515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYh9guv/profile http://localhost:47512/getInfo.html) 07:35:36 INFO - PROCESS | 31515 | __metrics Screen width/height:1600/1200 07:35:36 INFO - PROCESS | 31515 | colorDepth:24 07:35:36 INFO - PROCESS | 31515 | Browser inner width/height: 1024/697 07:35:36 INFO - PROCESS | 31515 | __metrics 07:35:37 INFO - PROCESS | 31515 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:35:37 INFO - PROCESS | 31515 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:37 INFO - TEST-INFO | 31515: exit 0 07:35:37 INFO - Browser initialized. 07:35:37 INFO - Running cycle 1/1 for kraken test... 07:35:38 INFO - TEST-INFO | started process 31609 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYh9guv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:49 INFO - PROCESS | 31609 | RSS: Main: 141111296 07:35:49 INFO - PROCESS | 31609 | 07:35:52 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47512/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:53 INFO - PROCESS | 31609 | RSS: Main: 184233984 07:35:53 INFO - PROCESS | 31609 | 07:35:55 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47512/tests/kraken/driver.html?testName=audio-dft) 07:35:56 INFO - PROCESS | 31609 | RSS: Main: 173318144 07:35:56 INFO - PROCESS | 31609 | 07:35:58 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47512/tests/kraken/driver.html?testName=audio-fft) 07:35:59 INFO - PROCESS | 31609 | RSS: Main: 265453568 07:35:59 INFO - PROCESS | 31609 | 07:36:01 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47512/tests/kraken/driver.html?testName=audio-oscillator) 07:36:02 INFO - PROCESS | 31609 | RSS: Main: 171954176 07:36:02 INFO - PROCESS | 31609 | 07:36:04 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:36:04 INFO - PROCESS | 31609 | RSS: Main: 174325760 07:36:04 INFO - PROCESS | 31609 | 07:36:07 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47512/tests/kraken/driver.html?testName=imaging-darkroom) 07:36:08 INFO - PROCESS | 31609 | RSS: Main: 211386368 07:36:08 INFO - PROCESS | 31609 | 07:36:11 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47512/tests/kraken/driver.html?testName=imaging-desaturate) 07:36:12 INFO - PROCESS | 31609 | RSS: Main: 212537344 07:36:12 INFO - PROCESS | 31609 | 07:36:15 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47512/tests/kraken/driver.html?testName=json-parse-financial) 07:36:15 INFO - PROCESS | 31609 | RSS: Main: 211640320 07:36:15 INFO - PROCESS | 31609 | 07:36:17 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:36:17 INFO - PROCESS | 31609 | RSS: Main: 173883392 07:36:17 INFO - PROCESS | 31609 | 07:36:19 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:36:20 INFO - PROCESS | 31609 | RSS: Main: 180375552 07:36:20 INFO - PROCESS | 31609 | 07:36:22 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:36:22 INFO - PROCESS | 31609 | RSS: Main: 185319424 07:36:22 INFO - PROCESS | 31609 | 07:36:25 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:36:26 INFO - PROCESS | 31609 | RSS: Main: 181354496 07:36:26 INFO - PROCESS | 31609 | 07:36:28 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:36:29 INFO - PROCESS | 31609 | RSS: Main: 185679872 07:36:29 INFO - PROCESS | 31609 | 07:36:30 INFO - PROCESS | 31609 | Cycle 1(1): loaded http://localhost:47512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47512/tests/kraken/driver.html?testName=ai-astar) 07:36:31 INFO - PROCESS | 31609 | RSS: Main: 238034944 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | __start_tp_report 07:36:31 INFO - PROCESS | 31609 | _x_x_mozilla_page_load 07:36:31 INFO - PROCESS | 31609 | _x_x_mozilla_page_load_details 07:36:31 INFO - PROCESS | 31609 | |i|pagename|runs| 07:36:31 INFO - PROCESS | 31609 | |0;ai-astar;101;111;112;111;111;110;109;110;111;111 07:36:31 INFO - PROCESS | 31609 | |1;audio-beat-detection;139;115;115;151;122;116;115;114;135;115 07:36:31 INFO - PROCESS | 31609 | |2;audio-dft;159;162;160;160;161;159;160;160;163;160 07:36:31 INFO - PROCESS | 31609 | |3;audio-fft;74;75;77;106;75;74;76;77;103;76 07:36:31 INFO - PROCESS | 31609 | |4;audio-oscillator;82;82;104;82;82;82;107;81;82;103 07:36:31 INFO - PROCESS | 31609 | |5;imaging-gaussian-blur;113;114;113;113;113;112;113;113;114;114 07:36:31 INFO - PROCESS | 31609 | |6;imaging-darkroom;146;147;147;147;146;146;147;147;145;146 07:36:31 INFO - PROCESS | 31609 | |7;imaging-desaturate;94;94;94;94;95;93;97;94;94;93 07:36:31 INFO - PROCESS | 31609 | |8;json-parse-financial;54;54;54;53;56;57;56;55;54;53 07:36:31 INFO - PROCESS | 31609 | |9;json-stringify-tinderbox;53;53;54;53;53;53;53;52;53;52 07:36:31 INFO - PROCESS | 31609 | |10;stanford-crypto-aes;79;76;81;81;75;91;79;79;81;95 07:36:31 INFO - PROCESS | 31609 | |11;stanford-crypto-ccm;133;125;122;126;117;117;125;118;143;117 07:36:31 INFO - PROCESS | 31609 | |12;stanford-crypto-pbkdf2;158;160;161;162;158;164;155;160;159;160 07:36:31 INFO - PROCESS | 31609 | |13;stanford-crypto-sha256-iterative;59;59;59;63;58;59;58;68;58;65 07:36:31 INFO - PROCESS | 31609 | __end_tp_report 07:36:31 INFO - PROCESS | 31609 | __start_cc_report 07:36:31 INFO - PROCESS | 31609 | _x_x_mozilla_cycle_collect,1628 07:36:31 INFO - PROCESS | 31609 | __end_cc_report 07:36:31 INFO - PROCESS | 31609 | __startTimestamp1496414191196__endTimestamp 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | ------- Summary: start ------- 07:36:31 INFO - PROCESS | 31609 | Number of tests: 14 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.16 (2.9%) stddev-sans-first:0.87 07:36:31 INFO - PROCESS | 31609 | Values: 101.0 111.0 112.0 111.0 111.0 110.0 109.0 110.0 111.0 111.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:119.00 stddev:13.19 (11.1%) stddev-sans-first:12.78 07:36:31 INFO - PROCESS | 31609 | Values: 139.0 115.0 115.0 151.0 122.0 116.0 115.0 114.0 135.0 115.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 07:36:31 INFO - PROCESS | 31609 | Values: 159.0 162.0 160.0 160.0 161.0 159.0 160.0 160.0 163.0 160.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:12.29 (16.3%) stddev-sans-first:12.75 07:36:31 INFO - PROCESS | 31609 | Values: 74.0 75.0 77.0 106.0 75.0 74.0 76.0 77.0 103.0 76.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:82.00 stddev:11.07 (13.5%) stddev-sans-first:11.47 07:36:31 INFO - PROCESS | 31609 | Values: 82.0 82.0 104.0 82.0 82.0 82.0 107.0 81.0 82.0 103.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 07:36:31 INFO - PROCESS | 31609 | Values: 113.0 114.0 113.0 113.0 113.0 112.0 113.0 113.0 114.0 114.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 07:36:31 INFO - PROCESS | 31609 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 145.0 146.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 07:36:31 INFO - PROCESS | 31609 | Values: 94.0 94.0 94.0 94.0 95.0 93.0 97.0 94.0 94.0 93.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.35 (2.5%) stddev-sans-first:1.41 07:36:31 INFO - PROCESS | 31609 | Values: 54.0 54.0 54.0 53.0 56.0 57.0 56.0 55.0 54.0 53.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#9] json-stringify-tinderbox Cycles:10 Average:52.90 Median:53.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 07:36:31 INFO - PROCESS | 31609 | Values: 53.0 53.0 54.0 53.0 53.0 53.0 53.0 52.0 53.0 52.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:6.36 (7.9%) stddev-sans-first:6.67 07:36:31 INFO - PROCESS | 31609 | Values: 79.0 76.0 81.0 81.0 75.0 91.0 79.0 79.0 81.0 95.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.00 stddev:8.39 (6.7%) stddev-sans-first:8.29 07:36:31 INFO - PROCESS | 31609 | Values: 133.0 125.0 122.0 126.0 117.0 117.0 125.0 118.0 143.0 117.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:2.45 (1.5%) stddev-sans-first:2.52 07:36:31 INFO - PROCESS | 31609 | Values: 158.0 160.0 161.0 162.0 158.0 164.0 155.0 160.0 159.0 160.0 07:36:31 INFO - PROCESS | 31609 | 07:36:31 INFO - PROCESS | 31609 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:59.00 stddev:3.50 (5.9%) stddev-sans-first:3.67 07:36:31 INFO - PROCESS | 31609 | Values: 59.0 59.0 59.0 63.0 58.0 59.0 58.0 68.0 58.0 65.0 07:36:31 INFO - PROCESS | 31609 | -------- Summary: end -------- 07:36:31 INFO - PROCESS | 31609 | 07:36:32 INFO - TEST-INFO | 31609: exit 0 07:36:32 INFO - TEST-OK | kraken | took 59938ms 07:36:32 INFO - SUITE-END | took 1175s 07:36:32 INFO - Completed test suite (00:19:36) 07:36:32 INFO - javascript benchmark 07:36:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7869.757936726273, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3420.2817408344245, 3450.6549345065487, 3475.4786781982684, 3490.057684425207, 3515.6660117288848, 5850.561207909408, 5871.559633027518, 5900.43945825147, 5904.46859782619, 5909.645421274727, 5905.173275741399, 5945.88108237835, 5946.048632218846, 5951.970240148793, 5964.135200395951, 5306.177542480922, 5333.0, 5360.490753378443, 5400.891982160354, 5419.3225846769155, 5234.816781412651, 5268.157094864822, 5454.809081682142, 5464.6994415307145, 5466.508014278714, 5336.252924590561, 5356.892862142755, 5369.087255166631, 5381.031414345416, 5399.865003374908, 5436.293281873351, 5448.046591846451, 5448.8365349039395, 5453.645513041679, 5456.0, 5204.635675502716, 5305.602079844027, 5354.598405119632, 5382.058139825514, 5443.2107344434835, 5746.79886203985, 5786.334571524287, 5826.883462330772, 5891.410858914117, 5896.705164741746, 6279.37206279373, 6290.087937249119, 6317.431431171217, 6317.715702793385, 6323.33604971476, 6357.364263573651, 6367.6497792621385, 6370.235571731376, 6372.490200783926, 6374.521910856704, 5766.942330576682, 5798.246227990334, 5851.912221316641, 5882.499987501024, 5977.133315669291, 6466.482681385478, 6472.0291956206, 6472.35276472349, 6474.964005759056, 6475.579087359307, 6118.235220597426, 6242.188515493048, 6245.781397651152, 6248.562600617913, 6251.937480625226, 6083.8174854754425, 6117.204763380732, 6209.9379006210265, 6325.240971083499, 6337.619742815354, 6300.810975670737, 6306.085617585424, 6312.210973628296, 6315.210598675166, 6316.115743795872, 6100.755969761249, 6112.26032301701, 6171.814845554641, 6177.351378105234, 6325.082862984841, 4712.811487540528, 4722.598579120745, 4749.073930583503, 4762.690425122356, 4763.428388593322, 4258.361245813153, 4265.125649241898, 4303.591158839905, 4308.310670292801, 4357.411749413852, 6028.788992385245, 6035.426634469718, 6035.758569657252, 6046.909296360558, 6071.119687645267, 6118.357572454917, 6130.245269657028, 6249.343818899041, 6252.781152659726, 6356.968215158895, 6045.576809623284, 6050.273967123973, 6050.394960503914, 6053.152558641794, 6087.817365479043, 5373.677579345252, 5385.3268341457315, 5386.084365657847, 5389.541888939406, 5390.0, 6235.688215589203, 6360.236771587439, 6488.221413430229, 6545.476361891133, 6602.207735071822, 6328.240611126695, 6355.396237357444, 6367.363263673596, 6370.649614271074, 6374.904376434264, 6651.401373876374, 6656.167979002625, 6656.267810540933, 6656.73373065072, 6661.0, 6073.848153796191, 6104.267487901303, 6147.323794382525, 6212.254529456494, 6277.905831412624, 6261.154744109487, 6340.4927605792345, 6367.9044814328745, 6370.458511026429, 6372.74509019634, 6169.6915154241215, 6179.474744646755, 6180.752769889334, 6184.103305020657, 6190.2571691397325, 5968.403159683997, 6010.068439391901, 6118.051701986199, 6179.660118693515, 6185.659788711484, 6104.17593624855, 6122.418370254819, 6139.798803208702, 6153.046277826944, 6167.599106058092, 6225.937740622717, 6233.719482623203, 6241.78153764616, 6245.906311405423, 6248.4064013918605, 5876.500497457764, 5890.2342695449315, 5932.79235226765, 6083.452489275986, 6098.0852872069545], "value": 5813.092163994957, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.1666958020127, 834.7036801935313, 852.9189726975939, 902.823949329881, 910.0399078971682, 30247.24381890454, 42431.363529547045, 42908.570914290845, 43165.0, 43308.566914330884, 39046.219075618545, 39081.60918390815, 39328.80335598318, 44153.77923110388, 44197.337039944345, 7708.653110610008, 7879.881801772978, 9201.125893040167, 9342.766430839216, 9343.299252556051, 10704.78590428191, 10952.123830093613, 10952.671419857417, 10954.287971281841, 10958.123350131971, 11076.889231107707, 11116.22186446945, 11121.888781112206, 11124.38815865127, 11136.888631113707, 10989.890101099007, 11021.944890275538, 11047.944760276147, 11049.337039777598, 11056.613018544313, 10593.099586535154, 10637.627683031134, 10657.200709946708, 10668.093212076983, 10672.679819605424, 40727.18545629071, 40734.185316293806, 40891.7955410224, 40906.79546602278, 40980.385294220614, 4309.267424537805, 4354.194474022316, 4374.912501749947, 4469.664775141878, 4490.685652004361, 29526.114216573536, 29928.70071299281, 30078.54882176769, 30604.693953060407, 31379.686203137906, 4333.826646934119, 4434.06884554244, 4440.267355886275, 4442.600165985044, 4483.103379324149, 226906.0, 227081.0, 228063.0, 228454.0, 228701.99999999834, 52258.738706306984, 52543.474565254626, 52777.736111319195, 52903.470965290624, 52987.470125298256, 54758.17862732062, 54809.72595136999, 54842.17736733952, 54894.451055488935, 54940.72529637326, 16368.590785230226, 16828.495145145665, 16845.831541684427, 16846.157692115346, 16880.493585192464, 11927.821082683766, 12098.516059357527, 14543.41826326935, 14950.102993820406, 15007.024543404645, 12921.870781292067, 13087.672808179872, 13150.07949443549, 13217.273049982343, 13289.601311960656, 5360.8123715670545, 5380.139177731544, 5394.406615272317, 5426.593005524523, 5524.0, 1015.0, 1018.1701912941078, 1027.825269704137, 1029.3206483720708, 1029.5264178477985, 26747.0, 27602.723972760417, 28018.43963120726, 28243.435131297258, 28540.71459285422, 1093.2511229807608, 1094.2777766673958, 1104.0560320925492, 1104.7956128116164, 1135.1089394825024, 14416.13503189812, 14489.275536223147, 14783.926080369529, 14791.482298119514, 14830.480933167288, 291743.0, 292359.0, 293044.0, 293090.0, 294660.0, 52963.0, 53172.0, 53243.201351979755, 53246.467535324926, 53276.467235327924, 1479.3490864019798, 1480.9333579988927, 1502.504173622702, 1517.1883042572392, 1563.1715190948814, 27064.0, 28136.0, 28284.43431131407, 28311.0, 28638.14085577436, 44888.0, 45143.77428112838, 45207.0, 45211.99999999868, 45226.77386613046, 320833.0, 321134.0, 321536.0, 322895.0, 325281.0, 29610.0, 29853.55219671663, 29964.101076967727, 30082.24794380158, 30089.699103009567, 37936.0, 38087.23825523419, 38535.80732096321, 38640.0, 39040.41439378468, 29604.555931660612, 30025.5496167562, 30087.0, 30149.547756784104, 30591.847040764653, 29347.559786603644, 29622.851885740434, 29780.404391912474, 30206.0, 30298.69701302959, 33975.3204935895, 34347.141321466166, 34356.0, 34372.65627343795, 34509.30981380409, 29155.85422072876, 29405.85297073501, 29450.852745736134, 29550.852245738635, 29707.851460742557, 22943.311700649007, 24239.272821815375, 24479.0, 24606.753932460448, 24736.876315618305], "value": 18610.451806160563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.4286249344551, 469.3101141322255, 478.76301230890704, 479.9976000120001, 488.60259657379885, 20201.39395818126, 21570.460738481546, 21699.783002169974, 21724.0, 21870.78129218707, 22190.112395504202, 22483.66274505884, 22528.77471225287, 22597.77402225977, 22732.772672273273, 6846.383825455708, 6903.0, 6912.758053468129, 6978.232394436608, 7018.719251229944, 6883.724651013953, 7032.437405007587, 7038.049863268445, 7326.3040011198855, 7601.239876012382, 7767.6892924282965, 7783.377329813601, 7789.143194248628, 7795.844083118334, 7797.610119494031, 7545.7358992435275, 7666.693332266703, 7671.616419179075, 7685.923140768605, 7717.151113377552, 7396.186419493852, 7452.701891924371, 7567.886481702779, 7610.429217808686, 7621.23787621239, 25083.87458062698, 25450.10924617648, 26050.34874128162, 26173.73826261732, 26217.868910655325, 2949.27742703037, 3102.37952409519, 3161.0516844946424, 3219.6941290577356, 3257.478803391446, 15427.691446171126, 15923.044617322881, 16049.0, 16193.352265909349, 16261.83738162615, 2336.4859730859353, 2408.8313818032743, 2441.218809980807, 2473.134402958968, 2639.749223823753, 113239.0, 115130.99999999916, 115513.4224328873, 119068.84645618389, 119390.0, 18247.72628410575, 18350.81649183518, 18543.72184417235, 18579.907100464683, 18996.050197490345, 32350.676493234765, 32370.676293237237, 32443.837780810944, 32761.34477310488, 32845.67154328426, 10666.413347265974, 10754.784904302027, 10893.400862952456, 10928.125749939985, 11272.605458808903, 9108.407953483002, 9121.954390228006, 9230.723078307661, 9382.718518444457, 9384.343095983351, 9137.451752894847, 9338.517511594473, 9435.292353073546, 9484.573194206278, 9568.808623827485, 3457.0960393269775, 3539.823008849547, 3571.9818302658914, 3677.5219221501034, 3804.353259945816, 957.9952100239593, 959.947202903833, 960.8078384323163, 966.2173639352147, 979.5689896445541, 19282.22871085141, 20619.8969005157, 20735.377938661863, 20822.687659685118, 21004.264850730153, 973.026973026973, 979.2264111352094, 986.649739342523, 993.2054356514759, 1002.4987506246877, 10484.63303784379, 11386.94306528462, 11421.657350279505, 11529.538818447169, 11626.883731162749, 478409.0, 617677.0, 629425.0, 630995.0, 634266.0, 68633.31366686369, 110177.44911275392, 113231.0, 117089.0, 119713.0, 1188.8632807227107, 1335.8998075144402, 1372.053283234545, 1383.5780087073338, 1392.78411846164, 18334.174962127003, 18690.719639205694, 18891.68136463762, 18892.905535472233, 19231.615367692848, 48750.51249487601, 49086.26370604373, 49286.75356623194, 49616.75191624019, 50299.74850125726, 64449.0, 65211.347886522424, 65758.34241657522, 66007.33992660012, 66839.3316066833, 11620.88379116198, 12054.216475929388, 12102.75794484123, 12132.757344852876, 12264.877351226374, 12726.554570589984, 13136.0, 13162.60512184636, 13287.13633613812, 13525.864741352461, 10598.735031624272, 10630.468476576294, 11155.665330040112, 11264.887351126712, 11888.46501907399, 10044.849327260243, 10193.541290642088, 10344.27590068688, 10626.84059739089, 10675.412852292888, 11217.326960382403, 11270.605528806453, 11421.1434142438, 11515.481803319039, 11627.883721163018, 11677.299362037966, 11960.58137965167, 12101.636950891487, 12146.0, 12212.145149839425, 11120.666380008613, 11248.212625116163, 11315.377654229096, 11459.484323205643, 11740.647780566596], "value": 11441.483120132567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1550.8061492313461, 1566.9921650391746, 1591.9363225470988, 1606.6385063360744, 1616.0626836434865, 10812.189085818565, 11492.023178029856, 11495.425228738572, 11501.769964600713, 11507.48216330264, 11182.888171118286, 11191.440427978609, 11423.885761142406, 11433.028192603619, 11445.484953177107, 2494.214322488415, 2560.3087166465043, 2561.180422264876, 2574.806889483287, 2588.352911772057, 2433.5741245282006, 2462.224399314219, 2509.5482813093636, 2511.3721569607596, 2513.158092039169, 2433.4646377796857, 2475.232677869866, 2509.0, 2512.9748702513016, 2529.304441278654, 2404.278716385086, 2430.6961629796274, 2441.4994926040117, 2452.301094188148, 2465.5315490056832, 2511.3344963584664, 2528.203615860998, 2550.681164854393, 2550.9362265943314, 2552.8851201695784, 11602.6519204424, 11860.28838269698, 11879.881201187964, 11881.702957426134, 11895.643130706092, 5967.254093238345, 6109.633421994695, 6118.755249790003, 6120.14317995481, 6124.479419249369, 3673.779573225615, 3706.0734816295926, 3711.164987877733, 3760.793156376398, 3767.7770115631633, 1466.7359875222455, 1481.4666719980798, 1498.9175595342251, 1533.9539813805604, 1548.040215066666, 14262.64343391413, 14538.273086345745, 16514.42199523011, 17741.645167096714, 17996.820031799645, 4978.5768209701855, 5137.17805151174, 5167.199084141964, 5206.088934436459, 5208.817691380859, 14764.114153150846, 14778.926105369404, 14781.408743650349, 14783.926080369529, 14784.778228326584, 6255.593386429868, 6269.435750782452, 6270.749170033238, 6276.748930042747, 6278.937210627927, 5538.529225015919, 5656.773729050792, 5707.0583353747, 5747.39652336507, 5747.482726554546, 4451.909282225875, 4526.140033393644, 4541.296099104644, 4569.309355538472, 4591.885202869955, 1203.5546847666244, 1240.6960294727849, 1242.571312897049, 1260.0927332320714, 1262.4950019992077, 1057.3444464431948, 1091.0943916549404, 1094.5129417409335, 1102.8180350242121, 1108.711734948919, 7189.89215161773, 7319.8715006883085, 7351.41188704913, 7412.481126321213, 7444.255574442513, 1077.4828082520435, 1091.8471414002047, 1096.923215374932, 1116.6984914073155, 1118.3681220110611, 4748.430188377417, 4764.2615394613895, 4924.8276310328965, 4961.330220420269, 4978.253262010728, 14732.926335368255, 15438.382464701286, 15450.38198472071, 15451.690966180613, 15473.148976806384, 13974.860251397558, 15147.469838555819, 15252.237388130548, 15253.6186595336, 15358.692826143639, 9215.95392023049, 10310.175185985103, 10535.0, 10538.156947444186, 10539.262251642465, 6121.4490695837585, 7252.38354739853, 7393.334599886036, 7415.8887616684715, 7502.849943001219, 12560.120791544505, 12857.485700572246, 12947.482100715866, 12983.415746291628, 13126.868731312565, 13049.151805132637, 13171.868281317064, 13359.465621375037, 13389.732205356033, 13570.728585428433, 9928.205743540644, 10117.19062475015, 10133.18934485254, 10174.0, 10225.642102526375, 10913.0, 10953.507092181031, 10956.452177391258, 11080.722981925517, 11108.666739997812, 9388.765280868032, 9400.95299523498, 9539.809203816023, 9707.466089365153, 9748.268879834182, 9208.12522810332, 9246.537673116452, 9265.72202833916, 9280.58237379306, 9367.437953722798, 8452.239298462922, 8654.134586541295, 8656.697015604424, 8662.307015438624, 8667.349948753996, 6344.968275158594, 6390.648514331757, 6420.839479013062, 6469.159009328945, 6528.869422611616, 6244.656543889948, 6348.111264422892, 6420.390062944013, 6460.837049331166, 6561.311062338576], "value": 5601.187593785331, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.2486711485767, 423.54468945883184, 430.47697048086576, 441.7901496789025, 441.8776308177228, 5058.317127187828, 5137.666051706637, 5175.353080864892, 5216.84349469516, 5258.605604579658, 5073.644844860862, 5162.819301324445, 5171.534561889429, 5183.196604526295, 5187.325647665808, 4516.412866327373, 4517.909641807179, 4539.501964351773, 4543.318502224676, 4552.430946131733, 4426.690131690767, 4475.28395456727, 4544.386507821451, 4544.500104988449, 4552.635789136878, 4489.416375871132, 4499.762565294537, 4507.504174540814, 4511.436070491189, 4529.893599476243, 4492.977535112336, 4494.235979883428, 4512.300593408027, 4551.4083169188125, 4572.177008138534, 4241.4698162729655, 4331.610155086058, 4379.824807007716, 4394.6923715339935, 4401.691881568291, 5064.290999260106, 5068.771905264272, 5088.516590923857, 5102.540771330561, 5113.437521872591, 5191.974040129775, 5217.852072544034, 5217.869553261161, 5220.269162317279, 5264.341957255343, 5340.477963780304, 5477.589180811455, 5494.148406996922, 5501.377093757351, 5507.228987941691, 4776.211925032366, 4784.234522476422, 4788.904221915577, 4805.327254184417, 4836.322914791932, 5719.369090218463, 5744.8851022979725, 5770.0, 5772.365039845614, 5839.678817665027, 4871.34236878017, 4913.164761990471, 4950.331705219821, 4969.304297398367, 5049.545540901337, 5026.472220416877, 5033.993201359743, 5037.571806396424, 5060.822871199564, 5073.644844860824, 5204.9219261711105, 5237.685738855681, 5242.292290540804, 5270.841874743764, 5323.547498462674, 5203.245529398216, 5331.947200327824, 5374.838754837361, 5417.4582541746295, 5560.193771903051, 1556.8209655889718, 1584.9366025359086, 1585.810642018486, 1594.6970075685583, 1596.3295415925338, 1262.8926541243914, 1279.5137847617846, 1291.5285920638898, 1296.1963582578862, 1303.9869601303865, 5129.64092513528, 5336.466353364633, 5371.543418809367, 5421.783128674888, 5445.754941027663, 5534.177569439615, 5580.218769372291, 5589.664620122806, 5601.971990140023, 5605.691686957175, 5278.445763194886, 5304.363476382859, 5326.041312563776, 5327.121025030904, 5370.516653501204, 2781.1934538983874, 2913.4704280252613, 2920.1677521906154, 2932.5601159826197, 2947.852607369623, 5728.742206600713, 5797.912751409489, 5801.664043175191, 5819.526701151994, 5830.504407125357, 5569.944300557024, 5729.828105156852, 5734.942650573441, 5739.794643124907, 5758.539316854642, 5705.343885453226, 5737.426257374229, 5784.739686714024, 5785.537157027512, 5800.709964501758, 5564.77740890376, 5623.522000629992, 5624.778212606079, 5635.830925072254, 5642.830715078554, 5245.239440281061, 5442.4557544246845, 5464.426235245242, 5566.77732890696, 5596.6921819298705, 5779.826605201851, 5789.421057894177, 5802.622829516068, 5820.883582328414, 5829.3296270927685, 4638.466576343763, 4646.442426908658, 4654.953450465452, 4694.34279200919, 4703.3885594872445, 5389.299391079135, 5604.299462567179, 5616.887662246814, 5644.717764111861, 5661.971690141523, 5257.579393648422, 5490.862728431821, 5517.124177779574, 5530.308711411074, 5542.584306176972, 5307.920381194363, 5365.302510673743, 5461.945380546303, 5488.506034456758, 5507.366652834815, 5428.67427954324, 5483.451654834645, 5484.424135465719, 5513.972430137824, 5526.861828454321, 5249.238860365149, 5458.4541545845095, 5468.863278418072, 5492.231087647812, 5494.0, 5398.811041613525, 5418.266154830574, 5427.185922111715, 5444.346678398618, 5450.5367043801725], "value": 4459.0037945848835, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.8385714785616, 843.4306842881053, 923.1691477670096, 946.4321407155705, 951.8239125761739, 17362.479125626236, 18740.625187496276, 18813.905930470362, 18822.341218057372, 18841.246350145993, 15438.382464701399, 16961.406350777725, 17223.483295501155, 17366.13169341531, 17371.478855634352, 877.714742708619, 885.1812073831712, 891.6879092317702, 894.3515950935553, 896.44420459315, 907.6505545365015, 909.0364213933219, 910.9544522773868, 911.0661571888801, 911.1799380557485, 963.0610155098793, 963.1716723617683, 964.0, 965.1217392173124, 965.9565319560602, 951.8001219743862, 956.9808603827885, 957.5547370472764, 961.0773657289011, 961.1445813226235, 699.4264702943589, 706.251373544045, 707.8902770070647, 709.1277728394105, 709.5813470052693, 16118.194090295556, 16363.263653135638, 16390.590235244093, 16468.0, 16504.092274924875, 14629.341679624442, 14638.194899280536, 15040.247987600576, 15076.849231507655, 15145.848541514553, 12688.0, 12859.678508037281, 12931.935340323333, 12984.87015129846, 12998.935005325007, 4036.576159503239, 4095.651869591088, 4107.732997355192, 4168.895777605584, 4171.395147703596, 80309.19690803134, 81357.0, 81377.59311203405, 82987.17012829916, 83313.58343208245, 10879.619213327655, 11097.0, 11142.331460112418, 11323.603673871376, 11327.773444531063, 23296.417589560057, 23485.06059757625, 23500.882495587754, 23754.16860409912, 23904.0, 9379.0, 9450.243980481682, 9537.856932146024, 9589.136977672042, 9599.904000959901, 4385.350365942698, 4520.932186017212, 4534.977325113353, 4543.182227199136, 4652.32541281519, 3956.9010774730864, 4045.7774822384463, 4052.3111071117983, 4072.6131017553284, 4077.510698716114, 648.060312546809, 654.9803505894831, 662.8806814773387, 666.6566718140161, 671.8757029949475, 812.4353574265829, 835.2733122183739, 848.1984524624171, 851.1743608699552, 874.6107981947972, 10875.347479151276, 11250.212485126127, 11648.184627076023, 11965.923066924019, 12378.257304561756, 849.6431498770531, 849.8512760266929, 859.6905114158898, 863.330918538138, 873.5370253765515, 4763.737994410271, 4804.543568361, 4817.662763606514, 4856.854294371175, 4857.878553036132, 78046.21953780502, 79410.20589794144, 79711.0, 81367.18632813715, 82150.0, 66964.66517667478, 68131.0, 68318.65840670864, 71298.64350678213, 71312.64343678248, 52219.73890130525, 60761.392386075575, 61765.38234617686, 62525.77036545281, 63415.0, 8900.910990890008, 9016.909830901606, 9051.728448146567, 9307.488088154945, 10168.830584482583, 41086.794566026976, 41470.37794433146, 41780.0, 42007.57992420036, 42058.579414205466, 54439.455605443436, 54724.452755473525, 55939.72030139986, 57337.0, 57510.13734793898, 12616.684582885135, 12627.621171364874, 12712.809307860574, 12797.936010319889, 12838.935805321287, 14502.927485362507, 14561.563153105424, 14573.198474084027, 14710.117392956457, 14731.410743570137, 13735.381907813973, 13772.380242888894, 14173.574792756233, 14324.427022918966, 14801.481948131765, 13613.727725445238, 13851.30743462843, 13866.584002479942, 13876.306184690928, 14048.297585120907, 13073.31888068572, 13140.737185256432, 13312.667183320495, 13325.067245292736, 13434.328283585586, 9833.360831545926, 9939.353941994037, 10446.268761186644, 10732.678019659423, 10762.19283553721, 9746.463944482837, 10907.672769816918, 10999.780004400027, 11129.165312601426, 11140.554377824796], "value": 7683.648649788443, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1451.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 112.0, 111.0, 111.0, 110.0, 109.0, 110.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 115.0, 115.0, 151.0, 122.0, 116.0, 115.0, 114.0, 135.0, 115.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 160.0, 160.0, 161.0, 159.0, 160.0, 160.0, 163.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 106.0, 75.0, 74.0, 76.0, 77.0, 103.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 104.0, 82.0, 82.0, 82.0, 107.0, 81.0, 82.0, 103.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 97.0, 94.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 56.0, 57.0, 56.0, 55.0, 54.0, 53.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 52.0, 53.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 81.0, 81.0, 75.0, 91.0, 79.0, 79.0, 81.0, 95.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 125.0, 122.0, 126.0, 117.0, 117.0, 125.0, 118.0, 143.0, 117.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 161.0, 162.0, 158.0, 164.0, 155.0, 160.0, 159.0, 160.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 63.0, 58.0, 59.0, 58.0, 68.0, 58.0, 65.0], "value": 60.6, "unit": "score"}]}]} 07:36:32 INFO - Return code: 0 07:36:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:36:32 INFO - # TBPL SUCCESS # 07:36:32 INFO - Running post-action listener: _resource_record_post_action 07:36:32 INFO - [mozharness: 2017-06-02 14:36:32.515508Z] Finished run-tests step (success) 07:36:32 INFO - Running post-run listener: _resource_record_post_run 07:36:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 2134016; Write bytes: 317620224; Read time: 776; Write time: 204884 07:36:32 INFO - TinderboxPrint: CPU usage
13.1% 07:36:32 INFO - TinderboxPrint: I/O read bytes / time
2,134,016 / 776 07:36:32 INFO - TinderboxPrint: I/O write bytes / time
317,620,224 / 204,884 07:36:32 INFO - TinderboxPrint: CPU idle
8,252.4 (86.9%) 07:36:32 INFO - TinderboxPrint: CPU user
1,199.0 (12.6%) 07:36:32 INFO - TinderboxPrint: Swap in / out
0 / 0 07:36:32 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 30773248; Read time: 0; Write time: 8844 07:36:32 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 2129920; Write bytes: 286846976; Read time: 764; Write time: 196040 07:36:33 INFO - Running post-run listener: _upload_blobber_files 07:36:33 INFO - Blob upload gear active. 07:36:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:36:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:36:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:36:33 INFO - (blobuploader) - INFO - Open directory for files ... 07:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:34 INFO - (blobuploader) - INFO - Done attempting. 07:36:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:36:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:40 INFO - (blobuploader) - INFO - Done attempting. 07:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:41 INFO - (blobuploader) - INFO - Done attempting. 07:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:36:42 INFO - (blobuploader) - INFO - Done attempting. 07:36:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:36:42 INFO - Return code: 0 07:36:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:36:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:36:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d873aa0d69a7b929f8ac42f96451f36f06110ff9f83ee2fd9a4806e1aa95079b396a29303d3e4d16eb04ed7819a9068a2ecba699dd6d0dcca439aea2dd5de3b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0d4a837e28f8990c74af57c38ca60e9472f57657227b8f53a5dca3cfa4e5924e3a55a2f27ea136b5bada66025d2f49d2325928b5a5e4c46d05c87da9bb508206", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a7caf2ceb0936be1622f6adb7297a4ceae4c0e7474067198dc319e5ec477f135f249d7cae7151d97bf8cbe31e27737c991bd8c83d0000c79808726ed83c2ad3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5f3e317322b2bebe0bba482f7cd4d88d5872463269e6cf15b08bdd4318e2861a78886220387bd84e20dba56e5b61b60212c65550d09f81f993c547b82e86303b"} 07:36:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:36:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:36:42 INFO - Contents: 07:36:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d873aa0d69a7b929f8ac42f96451f36f06110ff9f83ee2fd9a4806e1aa95079b396a29303d3e4d16eb04ed7819a9068a2ecba699dd6d0dcca439aea2dd5de3b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0d4a837e28f8990c74af57c38ca60e9472f57657227b8f53a5dca3cfa4e5924e3a55a2f27ea136b5bada66025d2f49d2325928b5a5e4c46d05c87da9bb508206", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a7caf2ceb0936be1622f6adb7297a4ceae4c0e7474067198dc319e5ec477f135f249d7cae7151d97bf8cbe31e27737c991bd8c83d0000c79808726ed83c2ad3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5f3e317322b2bebe0bba482f7cd4d88d5872463269e6cf15b08bdd4318e2861a78886220387bd84e20dba56e5b61b60212c65550d09f81f993c547b82e86303b"} 07:36:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:36:42 INFO - Copying logs to upload dir... 07:36:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:36:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.559189 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-06-02 07:36:40.342880) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 07:36:40.350606) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d873aa0d69a7b929f8ac42f96451f36f06110ff9f83ee2fd9a4806e1aa95079b396a29303d3e4d16eb04ed7819a9068a2ecba699dd6d0dcca439aea2dd5de3b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0d4a837e28f8990c74af57c38ca60e9472f57657227b8f53a5dca3cfa4e5924e3a55a2f27ea136b5bada66025d2f49d2325928b5a5e4c46d05c87da9bb508206", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a7caf2ceb0936be1622f6adb7297a4ceae4c0e7474067198dc319e5ec477f135f249d7cae7151d97bf8cbe31e27737c991bd8c83d0000c79808726ed83c2ad3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5f3e317322b2bebe0bba482f7cd4d88d5872463269e6cf15b08bdd4318e2861a78886220387bd84e20dba56e5b61b60212c65550d09f81f993c547b82e86303b"} build_url:https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/QhQeSGOLQzmFu-quKo1Ehw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/d873aa0d69a7b929f8ac42f96451f36f06110ff9f83ee2fd9a4806e1aa95079b396a29303d3e4d16eb04ed7819a9068a2ecba699dd6d0dcca439aea2dd5de3b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0d4a837e28f8990c74af57c38ca60e9472f57657227b8f53a5dca3cfa4e5924e3a55a2f27ea136b5bada66025d2f49d2325928b5a5e4c46d05c87da9bb508206", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a7caf2ceb0936be1622f6adb7297a4ceae4c0e7474067198dc319e5ec477f135f249d7cae7151d97bf8cbe31e27737c991bd8c83d0000c79808726ed83c2ad3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5f3e317322b2bebe0bba482f7cd4d88d5872463269e6cf15b08bdd4318e2861a78886220387bd84e20dba56e5b61b60212c65550d09f81f993c547b82e86303b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 07:36:40.374740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 07:36:40.375057) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1496409871.724389-266828837 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 07:36:40.462361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 07:36:40.462704) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 07:36:40.463043) ========= ========= Total master_lag: 0.17 =========