builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1462882826.52 results: success (0) buildid: 20160510043819 builduid: ba4ea0efd99643e28823962e68c5850f revision: 1ded8982a100a4b703be202f8d4d303fcf34b316 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.517977) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.518423) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.518717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.534679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.534936) ========= 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=00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 05:20:26-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-05-10 05:20:26 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.645251) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.645566) ========= 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=00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013555 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.694805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:26.695109) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1ded8982a100a4b703be202f8d4d303fcf34b316 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1ded8982a100a4b703be202f8d4d303fcf34b316 --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=00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 05:20:26,760 truncating revision to first 12 chars 2016-05-10 05:20:26,760 Setting DEBUG logging. 2016-05-10 05:20:26,760 attempt 1/10 2016-05-10 05:20:26,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1ded8982a100?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 05:20:27,038 unpacking tar archive at: fx-team-1ded8982a100/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602270 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:27.311307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:27.311991) ========= script_repo_revision: 1ded8982a100a4b703be202f8d4d303fcf34b316 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:27.312408) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:27.312715) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:20:27.322644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-10 05:20:27.322937) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:27 INFO - MultiFileLogger online at 20160510 05:20:27 in /builds/slave/test 05:20:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:20:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:27 INFO - {'append_to_log': False, 05:20:27 INFO - 'base_work_dir': '/builds/slave/test', 05:20:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:20:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:27 INFO - 'branch': 'Fx-Team-Non-PGO', 05:20:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:27 INFO - 'config_files': ('talos/linux_config.py',), 05:20:27 INFO - 'default_actions': ('clobber', 05:20:27 INFO - 'read-buildbot-config', 05:20:27 INFO - 'download-and-extract', 05:20:27 INFO - 'populate-webroot', 05:20:27 INFO - 'create-virtualenv', 05:20:27 INFO - 'install', 05:20:27 INFO - 'run-tests'), 05:20:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:27 INFO - 'download_minidump_stackwalk': True, 05:20:27 INFO - 'download_symbols': 'ondemand', 05:20:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:27 INFO - 'installer_path': 'installer.exe', 05:20:27 INFO - 'log_level': 'info', 05:20:27 INFO - 'log_name': 'talos', 05:20:27 INFO - 'log_to_console': True, 05:20:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:27 INFO - 'opt_config_files': (), 05:20:27 INFO - 'pip_index': False, 05:20:27 INFO - 'sps_profile': False, 05:20:27 INFO - 'sps_profile_interval': 0, 05:20:27 INFO - 'suite': 'dromaeojs-e10s', 05:20:27 INFO - 'system_bits': '32', 05:20:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:27 INFO - 'title': 'talos-linux64-ix-016', 05:20:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:27 INFO - 'use_talos_json': True, 05:20:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:27 INFO - 'work_dir': 'build'} 05:20:27 INFO - ##### 05:20:27 INFO - ##### Running clobber step. 05:20:27 INFO - ##### 05:20:27 INFO - Running pre-action listener: _resource_record_pre_action 05:20:27 INFO - Running main action method: clobber 05:20:27 INFO - rmtree: /builds/slave/test/build 05:20:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:27 INFO - Running post-action listener: _resource_record_post_action 05:20:27 INFO - ##### 05:20:27 INFO - ##### Finished clobber step (success) 05:20:27 INFO - ##### 05:20:27 INFO - ##### 05:20:27 INFO - ##### Running read-buildbot-config step. 05:20:27 INFO - ##### 05:20:27 INFO - Running pre-action listener: _resource_record_pre_action 05:20:27 INFO - Running main action method: read_buildbot_config 05:20:27 INFO - Using buildbot properties: 05:20:27 INFO - { 05:20:27 INFO - "project": "", 05:20:27 INFO - "product": "firefox", 05:20:27 INFO - "script_repo_revision": "production", 05:20:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:20:27 INFO - "repository": "", 05:20:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:20:27 INFO - "buildid": "20160510043819", 05:20:27 INFO - "pgo_build": "False", 05:20:27 INFO - "basedir": "/builds/slave/test", 05:20:27 INFO - "buildnumber": 1276, 05:20:27 INFO - "slavename": "talos-linux64-ix-016", 05:20:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:20:27 INFO - "platform": "ubuntu64_hw", 05:20:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:20:27 INFO - "branch": "fx-team", 05:20:27 INFO - "repo_path": "integration/fx-team", 05:20:27 INFO - "revision": "1ded8982a100a4b703be202f8d4d303fcf34b316", 05:20:27 INFO - "stage_platform": "linux64", 05:20:27 INFO - "builduid": "ba4ea0efd99643e28823962e68c5850f", 05:20:27 INFO - "slavebuilddir": "test" 05:20:27 INFO - } 05:20:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:20:27 INFO - Running post-action listener: _resource_record_post_action 05:20:27 INFO - ##### 05:20:27 INFO - ##### Finished read-buildbot-config step (success) 05:20:27 INFO - ##### 05:20:27 INFO - ##### 05:20:27 INFO - ##### Running download-and-extract step. 05:20:27 INFO - ##### 05:20:27 INFO - Running pre-action listener: _resource_record_pre_action 05:20:27 INFO - Running main action method: download_and_extract 05:20:27 INFO - mkdir: /builds/slave/test/build/tests 05:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:27 INFO - https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:20:28 INFO - Downloaded 1361 bytes. 05:20:28 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:28 INFO - Using the following test package requirements: 05:20:28 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:28 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:28 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:28 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'jsshell-linux-x86_64.zip'], 05:20:28 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:28 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:28 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:28 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:28 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:28 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:28 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:28 INFO - https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:29 INFO - Downloaded 22325903 bytes. 05:20:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:30 INFO - Return code: 0 05:20:30 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:30 INFO - https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:32 INFO - Downloaded 22325903 bytes. 05:20:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:33 INFO - Return code: 0 05:20:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:33 INFO - https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:20:34 INFO - Downloaded 10840152 bytes. 05:20:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:20:34 INFO - Return code: 0 05:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:34 INFO - https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:20:38 INFO - Downloaded 54674684 bytes. 05:20:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:38 INFO - mkdir: /builds/slave/test/properties 05:20:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:38 INFO - Contents: 05:20:38 INFO - build_url:https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:39 INFO - Running post-action listener: _resource_record_post_action 05:20:39 INFO - Running post-action listener: set_extra_try_arguments 05:20:39 INFO - ##### 05:20:39 INFO - ##### Finished download-and-extract step (success) 05:20:39 INFO - ##### 05:20:39 INFO - ##### 05:20:39 INFO - ##### Running populate-webroot step. 05:20:39 INFO - ##### 05:20:39 INFO - Running pre-action listener: _resource_record_pre_action 05:20:39 INFO - Running main action method: populate_webroot 05:20:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:39 INFO - '--tppagecycles', 05:20:39 INFO - '7'], 05:20:39 INFO - 'tests': ['tsvgm']}}, 05:20:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['damp', 'tps']}, 05:20:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'tests': ['damp', 'tps']}, 05:20:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['dromaeo_dom']}, 05:20:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['a11yr', 05:20:39 INFO - 'ts_paint', 05:20:39 INFO - 'tpaint', 05:20:39 INFO - 'sessionrestore', 05:20:39 INFO - 'sessionrestore_no_auto_restore', 05:20:39 INFO - 'tabpaint']}, 05:20:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:39 INFO - 'ts_paint', 05:20:39 INFO - 'tpaint', 05:20:39 INFO - 'sessionrestore', 05:20:39 INFO - 'sessionrestore_no_auto_restore', 05:20:39 INFO - 'tabpaint']}, 05:20:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:39 INFO - 'ts_paint', 05:20:39 INFO - 'tpaint', 05:20:39 INFO - 'sessionrestore', 05:20:39 INFO - 'sessionrestore_no_auto_restore', 05:20:39 INFO - 'tabpaint']}, 05:20:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:39 INFO - 'ts_paint', 05:20:39 INFO - 'tpaint', 05:20:39 INFO - 'sessionrestore', 05:20:39 INFO - 'sessionrestore_no_auto_restore', 05:20:39 INFO - 'tabpaint']}, 05:20:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['a11yr', 05:20:39 INFO - 'ts_paint', 05:20:39 INFO - 'tpaint', 05:20:39 INFO - 'sessionrestore', 05:20:39 INFO - 'sessionrestore_no_auto_restore', 05:20:39 INFO - 'tabpaint']}, 05:20:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['a11yr', 05:20:39 INFO - 'ts_paint', 05:20:39 INFO - 'tpaint', 05:20:39 INFO - 'sessionrestore', 05:20:39 INFO - 'sessionrestore_no_auto_restore', 05:20:39 INFO - 'tabpaint']}, 05:20:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['tsvgx', 05:20:39 INFO - 'tsvgr_opacity', 05:20:39 INFO - 'tart', 05:20:39 INFO - 'tscrollx', 05:20:39 INFO - 'cart']}, 05:20:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:39 INFO - 'tsvgr_opacity', 05:20:39 INFO - 'tart', 05:20:39 INFO - 'tscrollx', 05:20:39 INFO - 'cart']}, 05:20:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'talos_options': ['--disable-e10s'], 05:20:39 INFO - 'tests': ['tp5o']}, 05:20:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'tests': ['tp5o']}, 05:20:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'talos_options': ['--disable-e10s', 05:20:39 INFO - '--xperf_path', 05:20:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:39 INFO - 'tests': ['tp5n']}, 05:20:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:39 INFO - 'talos_options': ['--xperf_path', 05:20:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:39 INFO - 'tests': ['tp5n']}}, 05:20:39 INFO - 'talos.zip': {'path': '', 05:20:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:39 INFO - Running post-action listener: _resource_record_post_action 05:20:39 INFO - ##### 05:20:39 INFO - ##### Finished populate-webroot step (success) 05:20:39 INFO - ##### 05:20:39 INFO - ##### 05:20:39 INFO - ##### Running create-virtualenv step. 05:20:39 INFO - ##### 05:20:39 INFO - Running pre-action listener: _resource_record_pre_action 05:20:39 INFO - Running main action method: create_virtualenv 05:20:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:39 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 05:20:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:39 INFO - Using real prefix '/usr' 05:20:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:39 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:41 INFO - Installing pip.................done. 05:20:41 INFO - Return code: 0 05:20:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:41 INFO - Using env: {'DISPLAY': ':0', 05:20:41 INFO - 'HOME': '/home/cltbld', 05:20:41 INFO - 'LANG': 'en_US.UTF-8', 05:20:41 INFO - 'LANGUAGE': 'en_US:en', 05:20:41 INFO - 'LOGNAME': 'cltbld', 05:20:41 INFO - 'MAIL': '/var/mail/cltbld', 05:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:41 INFO - 'MOZ_NO_REMOTE': '1', 05:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:41 INFO - 'NO_EM_RESTART': '1', 05:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:41 INFO - 'PWD': '/builds/slave/test', 05:20:41 INFO - 'SHELL': '/bin/bash', 05:20:41 INFO - 'SHLVL': '1', 05:20:41 INFO - 'TERM': 'linux', 05:20:41 INFO - 'TMOUT': '86400', 05:20:41 INFO - 'USER': 'cltbld', 05:20:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:41 INFO - '_': '/tools/buildbot/bin/python'} 05:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:42 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 05:20:42 INFO - Cleaning up... 05:20:42 INFO - Return code: 0 05:20:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:42 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:20:42 INFO - Using env: {'DISPLAY': ':0', 05:20:42 INFO - 'HOME': '/home/cltbld', 05:20:42 INFO - 'LANG': 'en_US.UTF-8', 05:20:42 INFO - 'LANGUAGE': 'en_US:en', 05:20:42 INFO - 'LOGNAME': 'cltbld', 05:20:42 INFO - 'MAIL': '/var/mail/cltbld', 05:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:42 INFO - 'MOZ_NO_REMOTE': '1', 05:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:42 INFO - 'NO_EM_RESTART': '1', 05:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:42 INFO - 'PWD': '/builds/slave/test', 05:20:42 INFO - 'SHELL': '/bin/bash', 05:20:42 INFO - 'SHLVL': '1', 05:20:42 INFO - 'TERM': 'linux', 05:20:42 INFO - 'TMOUT': '86400', 05:20:42 INFO - 'USER': 'cltbld', 05:20:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:42 INFO - '_': '/tools/buildbot/bin/python'} 05:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:42 INFO - Downloading/unpacking psutil>=0.7.1 05:20:42 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 05:20:42 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 05:20:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:42 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 05:20:42 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 05:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:44 INFO - Installing collected packages: psutil 05:20:44 INFO - Running setup.py install for psutil 05:20:44 INFO - building 'psutil._psutil_linux' extension 05:20:44 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 05:20:44 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 05:20:44 INFO - building 'psutil._psutil_posix' extension 05:20:44 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 05:20:44 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 05:20:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:44 INFO - Successfully installed psutil 05:20:44 INFO - Cleaning up... 05:20:44 INFO - Return code: 0 05:20:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:44 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:20:44 INFO - Using env: {'DISPLAY': ':0', 05:20:44 INFO - 'HOME': '/home/cltbld', 05:20:44 INFO - 'LANG': 'en_US.UTF-8', 05:20:44 INFO - 'LANGUAGE': 'en_US:en', 05:20:44 INFO - 'LOGNAME': 'cltbld', 05:20:44 INFO - 'MAIL': '/var/mail/cltbld', 05:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:44 INFO - 'MOZ_NO_REMOTE': '1', 05:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:44 INFO - 'NO_EM_RESTART': '1', 05:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:44 INFO - 'PWD': '/builds/slave/test', 05:20:44 INFO - 'SHELL': '/bin/bash', 05:20:44 INFO - 'SHLVL': '1', 05:20:44 INFO - 'TERM': 'linux', 05:20:44 INFO - 'TMOUT': '86400', 05:20:44 INFO - 'USER': 'cltbld', 05:20:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:44 INFO - '_': '/tools/buildbot/bin/python'} 05:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:20:45 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 05:20:45 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 05:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:45 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 05:20:45 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 05:20:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:20:47 INFO - Installing collected packages: mozsystemmonitor 05:20:47 INFO - Running setup.py install for mozsystemmonitor 05:20:47 INFO - Successfully installed mozsystemmonitor 05:20:47 INFO - Cleaning up... 05:20:47 INFO - Return code: 0 05:20:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:20:47 INFO - Using env: {'DISPLAY': ':0', 05:20:47 INFO - 'HOME': '/home/cltbld', 05:20:47 INFO - 'LANG': 'en_US.UTF-8', 05:20:47 INFO - 'LANGUAGE': 'en_US:en', 05:20:47 INFO - 'LOGNAME': 'cltbld', 05:20:47 INFO - 'MAIL': '/var/mail/cltbld', 05:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:47 INFO - 'MOZ_NO_REMOTE': '1', 05:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:47 INFO - 'NO_EM_RESTART': '1', 05:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:47 INFO - 'PWD': '/builds/slave/test', 05:20:47 INFO - 'SHELL': '/bin/bash', 05:20:47 INFO - 'SHLVL': '1', 05:20:47 INFO - 'TERM': 'linux', 05:20:47 INFO - 'TMOUT': '86400', 05:20:47 INFO - 'USER': 'cltbld', 05:20:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:47 INFO - '_': '/tools/buildbot/bin/python'} 05:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:47 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 05:20:47 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 05:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:47 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 05:20:47 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 05:20:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20:49 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 05:20:49 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 05:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:49 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 05:20:49 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 05:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:49 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 05:20:49 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 05:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:49 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 05:20:49 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 05:20:49 INFO - Downloading docopt-0.6.1.tar.gz 05:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:50 INFO - Running setup.py install for blobuploader 05:20:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:50 INFO - Running setup.py install for requests 05:20:50 INFO - Running setup.py install for docopt 05:20:50 INFO - Successfully installed blobuploader requests docopt 05:20:50 INFO - Cleaning up... 05:20:50 INFO - Return code: 0 05:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:20:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:50 INFO - Using env: {'DISPLAY': ':0', 05:20:50 INFO - 'HOME': '/home/cltbld', 05:20:50 INFO - 'LANG': 'en_US.UTF-8', 05:20:50 INFO - 'LANGUAGE': 'en_US:en', 05:20:50 INFO - 'LOGNAME': 'cltbld', 05:20:50 INFO - 'MAIL': '/var/mail/cltbld', 05:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:50 INFO - 'MOZ_NO_REMOTE': '1', 05:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:50 INFO - 'NO_EM_RESTART': '1', 05:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:50 INFO - 'PWD': '/builds/slave/test', 05:20:50 INFO - 'SHELL': '/bin/bash', 05:20:50 INFO - 'SHLVL': '1', 05:20:50 INFO - 'TERM': 'linux', 05:20:50 INFO - 'TMOUT': '86400', 05:20:50 INFO - 'USER': 'cltbld', 05:20:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:50 INFO - '_': '/tools/buildbot/bin/python'} 05:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:50 INFO - Running setup.py (path:/tmp/pip-KMFkOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:50 INFO - Running setup.py (path:/tmp/pip-978A8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:50 INFO - Running setup.py (path:/tmp/pip-HkT7U8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:51 INFO - Running setup.py (path:/tmp/pip-fTgjNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:51 INFO - Running setup.py (path:/tmp/pip-7Sp3lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:51 INFO - Running setup.py (path:/tmp/pip-WuSRyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:51 INFO - Running setup.py (path:/tmp/pip-bl3hM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:51 INFO - Running setup.py (path:/tmp/pip-z_Fq3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:51 INFO - Running setup.py (path:/tmp/pip-JTg1k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:51 INFO - Running setup.py (path:/tmp/pip-Im02iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:51 INFO - Running setup.py (path:/tmp/pip-VpHqwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:51 INFO - Running setup.py (path:/tmp/pip-fh7Mw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:51 INFO - Running setup.py (path:/tmp/pip-Kqwf63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:51 INFO - Running setup.py (path:/tmp/pip-Bu1nIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:51 INFO - Running setup.py (path:/tmp/pip-EBNAUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:51 INFO - Running setup.py (path:/tmp/pip-jIWYWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:51 INFO - Running setup.py (path:/tmp/pip-MdYA_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:52 INFO - Running setup.py install for manifestparser 05:20:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Running setup.py install for mozcrash 05:20:52 INFO - Running setup.py install for mozdebug 05:20:52 INFO - Running setup.py install for mozdevice 05:20:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Running setup.py install for mozfile 05:20:52 INFO - Running setup.py install for mozhttpd 05:20:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Running setup.py install for mozinfo 05:20:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Running setup.py install for mozInstall 05:20:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:52 INFO - Running setup.py install for mozleak 05:20:52 INFO - Running setup.py install for mozlog 05:20:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:53 INFO - Running setup.py install for moznetwork 05:20:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:53 INFO - Running setup.py install for mozprocess 05:20:53 INFO - Running setup.py install for mozprofile 05:20:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:53 INFO - Running setup.py install for mozrunner 05:20:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:53 INFO - Running setup.py install for mozscreenshot 05:20:53 INFO - Running setup.py install for moztest 05:20:53 INFO - Running setup.py install for mozversion 05:20:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:53 INFO - Cleaning up... 05:20:53 INFO - Return code: 0 05:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:20:53 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:53 INFO - Using env: {'DISPLAY': ':0', 05:20:53 INFO - 'HOME': '/home/cltbld', 05:20:53 INFO - 'LANG': 'en_US.UTF-8', 05:20:53 INFO - 'LANGUAGE': 'en_US:en', 05:20:53 INFO - 'LOGNAME': 'cltbld', 05:20:53 INFO - 'MAIL': '/var/mail/cltbld', 05:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:53 INFO - 'MOZ_NO_REMOTE': '1', 05:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:53 INFO - 'NO_EM_RESTART': '1', 05:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:53 INFO - 'PWD': '/builds/slave/test', 05:20:53 INFO - 'SHELL': '/bin/bash', 05:20:53 INFO - 'SHLVL': '1', 05:20:53 INFO - 'TERM': 'linux', 05:20:53 INFO - 'TMOUT': '86400', 05:20:53 INFO - 'USER': 'cltbld', 05:20:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:53 INFO - '_': '/tools/buildbot/bin/python'} 05:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:54 INFO - Running setup.py (path:/tmp/pip-ROJyK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:54 INFO - Running setup.py (path:/tmp/pip-tSgZQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:54 INFO - Running setup.py (path:/tmp/pip-LcVYvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:54 INFO - Running setup.py (path:/tmp/pip-KbPAPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:54 INFO - Running setup.py (path:/tmp/pip-usKyei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:54 INFO - Running setup.py (path:/tmp/pip-7olK6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:54 INFO - Running setup.py (path:/tmp/pip-oLHjIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:54 INFO - Running setup.py (path:/tmp/pip-9uLP5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:54 INFO - Running setup.py (path:/tmp/pip-9Wc0kF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:54 INFO - Running setup.py (path:/tmp/pip-Eubat7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:54 INFO - Running setup.py (path:/tmp/pip-TvM0Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:54 INFO - Running setup.py (path:/tmp/pip-tHTmHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:54 INFO - Running setup.py (path:/tmp/pip-pQ00bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:54 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)) 05:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:54 INFO - Running setup.py (path:/tmp/pip-TlTnkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:55 INFO - Running setup.py (path:/tmp/pip-YcX36A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:55 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)) 05:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:55 INFO - Running setup.py (path:/tmp/pip-MTu0Fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:55 INFO - Running setup.py (path:/tmp/pip-z0Ix0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:55 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)) 05:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:55 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)) 05:20:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:55 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:20:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:55 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 05:20:55 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 05:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:55 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 05:20:55 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 05:20:57 INFO - Downloading blessings-1.6.tar.gz 05:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:57 INFO - Installing collected packages: blessings 05:20:57 INFO - Running setup.py install for blessings 05:20:57 INFO - Successfully installed blessings 05:20:57 INFO - Cleaning up... 05:20:57 INFO - Return code: 0 05:20:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:57 INFO - Reading from file tmpfile_stdout 05:20:57 INFO - Current package versions: 05:20:57 INFO - argparse == 1.2.1 05:20:57 INFO - blessings == 1.6 05:20:57 INFO - blobuploader == 1.2.4 05:20:57 INFO - docopt == 0.6.1 05:20:57 INFO - manifestparser == 1.1 05:20:57 INFO - mozInstall == 1.12 05:20:57 INFO - mozcrash == 0.17 05:20:57 INFO - mozdebug == 0.1 05:20:57 INFO - mozdevice == 0.48 05:20:57 INFO - mozfile == 1.2 05:20:57 INFO - mozhttpd == 0.7 05:20:57 INFO - mozinfo == 0.9 05:20:57 INFO - mozleak == 0.1 05:20:57 INFO - mozlog == 3.1 05:20:57 INFO - moznetwork == 0.27 05:20:57 INFO - mozprocess == 0.22 05:20:57 INFO - mozprofile == 0.28 05:20:57 INFO - mozrunner == 6.11 05:20:57 INFO - mozscreenshot == 0.1 05:20:57 INFO - mozsystemmonitor == 0.0 05:20:57 INFO - moztest == 0.7 05:20:57 INFO - mozversion == 1.4 05:20:57 INFO - psutil == 3.1.1 05:20:57 INFO - requests == 1.2.3 05:20:57 INFO - wsgiref == 0.1.2 05:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 05:20:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:57 INFO - Using env: {'DISPLAY': ':0', 05:20:57 INFO - 'HOME': '/home/cltbld', 05:20:57 INFO - 'LANG': 'en_US.UTF-8', 05:20:57 INFO - 'LANGUAGE': 'en_US:en', 05:20:57 INFO - 'LOGNAME': 'cltbld', 05:20:57 INFO - 'MAIL': '/var/mail/cltbld', 05:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:57 INFO - 'MOZ_NO_REMOTE': '1', 05:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:57 INFO - 'NO_EM_RESTART': '1', 05:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:57 INFO - 'PWD': '/builds/slave/test', 05:20:57 INFO - 'SHELL': '/bin/bash', 05:20:57 INFO - 'SHLVL': '1', 05:20:57 INFO - 'TERM': 'linux', 05:20:57 INFO - 'TMOUT': '86400', 05:20:57 INFO - 'USER': 'cltbld', 05:20:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:57 INFO - '_': '/tools/buildbot/bin/python'} 05:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 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)) 05:20:57 INFO - Cleaning up... 05:20:57 INFO - Return code: 0 05:20:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:57 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:20:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:20:57 INFO - Using env: {'DISPLAY': ':0', 05:20:57 INFO - 'HOME': '/home/cltbld', 05:20:57 INFO - 'LANG': 'en_US.UTF-8', 05:20:57 INFO - 'LANGUAGE': 'en_US:en', 05:20:57 INFO - 'LOGNAME': 'cltbld', 05:20:57 INFO - 'MAIL': '/var/mail/cltbld', 05:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:57 INFO - 'MOZ_NO_REMOTE': '1', 05:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:57 INFO - 'NO_EM_RESTART': '1', 05:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:57 INFO - 'PWD': '/builds/slave/test', 05:20:57 INFO - 'SHELL': '/bin/bash', 05:20:57 INFO - 'SHLVL': '1', 05:20:57 INFO - 'TERM': 'linux', 05:20:57 INFO - 'TMOUT': '86400', 05:20:57 INFO - 'USER': 'cltbld', 05:20:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:57 INFO - '_': '/tools/buildbot/bin/python'} 05:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:58 INFO - Downloading/unpacking jsonschema 05:20:58 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 05:20:58 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 05:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:58 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 05:20:58 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 05:20:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:59 INFO - Downloading/unpacking functools32 (from jsonschema) 05:20:59 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 05:20:59 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 05:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:59 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 05:20:59 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 05:21:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:00 INFO - warning: no files found matching '*.txt' 05:21:00 INFO - no previously-included directories found matching 'build' 05:21:00 INFO - no previously-included directories found matching 'dist' 05:21:00 INFO - no previously-included directories found matching '.git*' 05:21:00 INFO - Installing collected packages: jsonschema, functools32 05:21:00 INFO - Running setup.py install for functools32 05:21:00 INFO - warning: no files found matching '*.txt' 05:21:00 INFO - no previously-included directories found matching 'build' 05:21:00 INFO - no previously-included directories found matching 'dist' 05:21:00 INFO - no previously-included directories found matching '.git*' 05:21:00 INFO - Successfully installed jsonschema functools32 05:21:00 INFO - Cleaning up... 05:21:00 INFO - Return code: 0 05:21:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:00 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5899d00f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, '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': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', '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 05:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:21:00 INFO - Using env: {'DISPLAY': ':0', 05:21:00 INFO - 'HOME': '/home/cltbld', 05:21:00 INFO - 'LANG': 'en_US.UTF-8', 05:21:00 INFO - 'LANGUAGE': 'en_US:en', 05:21:00 INFO - 'LOGNAME': 'cltbld', 05:21:00 INFO - 'MAIL': '/var/mail/cltbld', 05:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:00 INFO - 'MOZ_NO_REMOTE': '1', 05:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:00 INFO - 'NO_EM_RESTART': '1', 05:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:00 INFO - 'PWD': '/builds/slave/test', 05:21:00 INFO - 'SHELL': '/bin/bash', 05:21:00 INFO - 'SHLVL': '1', 05:21:00 INFO - 'TERM': 'linux', 05:21:00 INFO - 'TMOUT': '86400', 05:21:00 INFO - 'USER': 'cltbld', 05:21:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:00 INFO - '_': '/tools/buildbot/bin/python'} 05:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:00 INFO - Downloading/unpacking flake8 05:21:00 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 05:21:00 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 05:21:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:00 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 05:21:00 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 05:21:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:02 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 05:21:02 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 05:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:02 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 05:21:02 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 05:21:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:02 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 05:21:02 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 05:21:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:02 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 05:21:02 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 05:21:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:03 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 05:21:03 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 05:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:03 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 05:21:03 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 05:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:03 INFO - no previously-included directories found matching 'docs/_build' 05:21:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:03 INFO - Running setup.py install for pep8 05:21:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:03 INFO - no previously-included directories found matching 'docs/_build' 05:21:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:03 INFO - Cleaning up... 05:21:03 INFO - Return code: 0 05:21:03 INFO - Running post-action listener: _resource_record_post_action 05:21:03 INFO - Running post-action listener: _start_resource_monitoring 05:21:03 INFO - Starting resource monitoring. 05:21:03 INFO - ##### 05:21:03 INFO - ##### Finished create-virtualenv step (success) 05:21:03 INFO - ##### 05:21:03 INFO - ##### 05:21:03 INFO - ##### Running install step. 05:21:03 INFO - ##### 05:21:03 INFO - Running pre-action listener: _resource_record_pre_action 05:21:03 INFO - Running main action method: install 05:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:04 INFO - Reading from file tmpfile_stdout 05:21:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:04 INFO - Reading from file tmpfile_stdout 05:21:04 INFO - Output received: 05:21:04 INFO - Usage: mozinstall [options] installer 05:21:04 INFO - Options: 05:21:04 INFO - -h, --help show this help message and exit 05:21:04 INFO - -d DEST, --destination=DEST 05:21:04 INFO - Directory to install application into. [default: 05:21:04 INFO - "/builds/slave/test"] 05:21:04 INFO - --app=APP Application being installed. [default: firefox] 05:21:04 INFO - mkdir: /builds/slave/test/build/application 05:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:21:19 INFO - Reading from file tmpfile_stdout 05:21:19 INFO - Output received: 05:21:19 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:19 INFO - Running post-action listener: _resource_record_post_action 05:21:19 INFO - ##### 05:21:19 INFO - ##### Finished install step (success) 05:21:19 INFO - ##### 05:21:19 INFO - ##### 05:21:19 INFO - ##### Running run-tests step. 05:21:19 INFO - ##### 05:21:19 INFO - Running pre-action listener: _resource_record_pre_action 05:21:19 INFO - Running main action method: run_tests 05:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:19 INFO - Python 2.7.3 05:21:19 INFO - Return code: 0 05:21:19 INFO - grabbing minidump binary from tooltool 05:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:19 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27fe9c0>, '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 0x27ff8c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ffd50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:19 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 05:21:19 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 05:21:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:19 INFO - Return code: 0 05:21:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:20 INFO - Return code: 0 05:21:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:21:20 INFO - Using env: {'DISPLAY': ':0', 05:21:20 INFO - 'HOME': '/home/cltbld', 05:21:20 INFO - 'LANG': 'en_US.UTF-8', 05:21:20 INFO - 'LANGUAGE': 'en_US:en', 05:21:20 INFO - 'LOGNAME': 'cltbld', 05:21:20 INFO - 'MAIL': '/var/mail/cltbld', 05:21:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:20 INFO - 'MOZ_NO_REMOTE': '1', 05:21:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:20 INFO - 'NO_EM_RESTART': '1', 05:21:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:20 INFO - 'PWD': '/builds/slave/test', 05:21:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:20 INFO - 'SHELL': '/bin/bash', 05:21:20 INFO - 'SHLVL': '1', 05:21:20 INFO - 'TERM': 'linux', 05:21:20 INFO - 'TMOUT': '86400', 05:21:20 INFO - 'USER': 'cltbld', 05:21:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455', 05:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:20 INFO - '_': '/tools/buildbot/bin/python'} 05:21:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:21:21 INFO - mozversion application_buildid: 20160510043819 05:21:21 INFO - mozversion application_changeset: 1ded8982a100a4b703be202f8d4d303fcf34b316 05:21:21 INFO - mozversion application_display_name: Nightly 05:21:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:21 INFO - mozversion application_name: Firefox 05:21:21 INFO - mozversion application_remotingname: firefox 05:21:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:21:21 INFO - mozversion application_vendor: Mozilla 05:21:21 INFO - mozversion application_version: 49.0a1 05:21:21 INFO - mozversion platform_buildid: 20160510043819 05:21:21 INFO - mozversion platform_changeset: 1ded8982a100a4b703be202f8d4d303fcf34b316 05:21:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:21:21 INFO - mozversion platform_version: 49.0a1 05:21:21 INFO - using testdate: 1462882881 05:21:21 INFO - actual date: 1462882881 05:21:21 INFO - starting webserver on 'localhost:51160' 05:21:21 INFO - SUITE-START | Running 2 tests 05:21:21 INFO - TEST-START | dromaeo_css 05:21:21 INFO - operating with platform_type : linux_ 05:21:21 INFO - Initialising browser for dromaeo_css test... 05:21:21 INFO - TEST-INFO | started process 1023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkZ_jO/profile http://localhost:51160/getInfo.html) 05:21:25 INFO - PROCESS | 1023 | 05:21:25 INFO - PROCESS | 1023 | (process:1101): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:21:26 INFO - PROCESS | 1023 | __metrics Screen width/height:1600/1200 05:21:26 INFO - PROCESS | 1023 | colorDepth:24 05:21:26 INFO - PROCESS | 1023 | Browser inner width/height: 1024/697 05:21:26 INFO - PROCESS | 1023 | __metrics 05:21:26 ERROR - PROCESS | 1023 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:21:27 INFO - TEST-INFO | 1023: exit 0 05:21:27 INFO - Browser initialized. 05:21:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:27 INFO - TEST-INFO | started process 1208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjkZ_jO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:29 INFO - PROCESS | 1208 | 05:21:29 INFO - PROCESS | 1208 | (process:1282): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:21:39 INFO - PROCESS | 1208 | RSS: Main: 164548608 05:21:39 INFO - PROCESS | 1208 | 05:22:29 INFO - PROCESS | 1208 | 1462882949215 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:24:40 INFO - PROCESS | 1208 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51160/tests/dromaeo/cssquery-ext.html) 05:24:42 INFO - PROCESS | 1208 | RSS: Main: 167460864 05:24:42 INFO - PROCESS | 1208 | 05:27:44 INFO - PROCESS | 1208 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-ext.html (next: http://localhost:51160/tests/dromaeo/cssquery-jquery.html) 05:27:44 INFO - PROCESS | 1208 | RSS: Main: 167165952 05:27:44 INFO - PROCESS | 1208 | 05:30:46 INFO - PROCESS | 1208 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51160/tests/dromaeo/cssquery-mootools.html) 05:30:47 INFO - PROCESS | 1208 | RSS: Main: 167845888 05:30:47 INFO - PROCESS | 1208 | 05:33:49 INFO - PROCESS | 1208 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51160/tests/dromaeo/cssquery-prototype.html) 05:33:49 INFO - PROCESS | 1208 | RSS: Main: 165597184 05:33:49 INFO - PROCESS | 1208 | 05:36:52 INFO - PROCESS | 1208 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51160/tests/dromaeo/cssquery-yui.html) 05:36:53 INFO - PROCESS | 1208 | RSS: Main: 167018496 05:36:53 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | Cycle 1(1): loaded http://localhost:51160/tests/dromaeo/cssquery-yui.html (next: http://localhost:51160/tests/dromaeo/cssquery-dojo.html) 05:39:55 INFO - PROCESS | 1208 | RSS: Main: 168988672 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | __start_tp_report 05:39:55 INFO - PROCESS | 1208 | _x_x_mozilla_page_load 05:39:55 INFO - PROCESS | 1208 | _x_x_mozilla_page_load_details 05:39:55 INFO - PROCESS | 1208 | |i|pagename|runs| 05:39:55 INFO - PROCESS | 1208 | |0;dojo.html;2661.973380266197;2665.2670515608215;2693.3132051326907;2708.7697545708616;2717.1033558925556;4729.858104256873;4766.690165139268;4776.37907072081;4794.376731024962;4816.422029356473;4685.4143232095985;4766.78549465274;4812.759362031893;4840.878978025551;4863.027394521101;4378.737275763448;4399.956000440003;4517.954820451802;4549.749763763009;4555.04344087742;4437.068215674696;4473.373727678128;4489.910201795962;4505.684602077856;4524.117797029564;4335.0462898162195;4344;4381.342798580238;4437.356583295436;4437.42313499243;4434.911301773946;4492.3710680504755;4504.70719403241;4510.954890451119;4520.457545094577;4371.803268852909;4478.865634030984;4486.192485352635;4487.730736155841;4492.730436173807;4692.718436893797;4723.504032076651;4761.047790441926;4771.33201351811;4786.617070634341;5153.2270159476;5163.974180129076;5179.300794392747;5201;5227.163653815409;5154.433012368637;5194.3247377840635;5195.506426889439;5212.713300768456;5244.81643142492;4914.778834952364;4936.975315123437;4952.678075925053;4966.329545511346;4998.600111991032;5439.075357189287;5439.619226654176;5444.373897001817;5449.373322068013;5455.290812194389;5084.923726144111;5126.564242039469;5161;5163.896722065538;5169.25045868347;5021.071101846097;5045.646804723634;5216.817411390583;5255.264263003182;5269.868253293622;5144.922826157611;5179.948200518022;5217.58259339252;5237.973810130925;5244.606654500928;5082.974585127051;5085.669431486942;5108.055009823194;5169.379674439091;5193.792248310026;4450.955490445054;4462.642988560908;4471.7987690554;4472.619827314715;4529.048899731093;3868.7678739275734;3871.709621778378;3874.050857539921;3919.118198405393;3972.8410863565714;4434.55654434554;4443.600075993176;4467.821287148543;4479.977600111979;4491.258942274553;5227.294315267466;5244.895102098013;5260.316158899319;5261.710605916712;5318.760655770499;4333.349997500401;4493.5281795411665;4494.505604383515;4498.055408364215;4538.682292239578;4706.176419126639;4733.668643194943;4741.431028276629;4741.502142275081;4749.762511874462;4899.216125419915;4919.1883339248625;4921.458639549646;4933;4974.104661161025;5099.388073431063;5183.585313174862;5263.763130659206;5283.445238250082;5345.1714984177515;4839.975800120977;4846.224604063333;4861.756912154449;4887.193613053949;4925.901481970269;5143.074246635641;5149.897002059863;5162.303089082926;5171.793128274827;5209.296744939385;5054.064997975386;5137.717425541631;5153.330067091254;5235.083860324352;5251.553617942365;4968.130577148912;4997.5002499749735;5018.698878067327;5070.4676009019995;5083.72039537829;4981.452040275494;4982.950170498249;4998.1253280676465;5067.594592432671;5075.08648443269;4922.409310882717;4926.852194434173;4953.108440480748;4958.206686930074;4974.17926042199;4975.029869175476;5004.374453193351;5047.9747601263225;5054.16606259963;5057.69653820772;4913.729744864067;4940.283658869515;4964.180910149785;4976.5023497649945;4985.102681517362 05:39:55 INFO - PROCESS | 1208 | |1;ext.html;529.4159059441953;577.4918072096556;607.4290167242791;610.6916007416252;633.3223450907531;35544.111397215085;39946.20107597846;39984.60015399845;40012.19975600486;40093.59906400935;40100.59899401005;40354;40645.390319145234;40659.18681626366;40762.7961860191;7649.541027538337;7705.768826935201;7754.185810489902;7757.185495522974;7777;7677.385809135284;7745.496542724733;7786.3381612563;7801.141874393812;7801.5709135997495;7822.530648161129;7829.647665855022;7838.882416763753;7844.686212551491;7869.803254918645;7525.811854703621;7547.54714717116;7567.621618919032;7576.469647124703;7600;7765.339946104588;7850.057993040871;7870.488418252795;7874.094479134916;7880.133185349607;36679;36999.445008324896;37027.81486092552;37030.44454333187;37051;2982.7315541601142;3195.936081278385;3264.05342450689;3338.7329013678846;3377.3583019226267;28953.710462895313;29360.559591606143;29645.258868528243;29670.85164574185;29892;2850.686424493304;2869.237771664794;2888.523393640047;2907.4330505551425;2962.6296712910885;249573;250290;250445;250785;250830;55802;56099.71950140223;56420.71789641026;56499;56542.717286414125;37068.44397334042;37897.24205515874;37898.62101379006;38086.61913380886;38090.23819523594;15654.45209417665;15694.724264981514;15709.528714138594;15771.605709857346;15802.446914358172;11585.304881706956;11651.59219427316;11701.414929253504;11721.296722196696;11780.528778848922;15032.924835375754;15147.924260378628;15208.391664333303;15210;15219.162946038074;7156.177039640404;7179.820504487325;7201.819954501075;7327.2672732726305;7476.775696729107;851.4720873058619;963.9566219520138;1039.6621098143135;1070.7590792071721;1107.5182295701395;29148.125556233346;29226.707732922823;29249.853750731534;29414.558781618292;29678.851605741835;963.2294164668237;1044.6604853422668;1083.9349639021527;1167.854018247719;1186.8575770907546;15407.383704651913;15415.152166630718;15631.728746442272;15719.214039297989;15760.448384306494;379217;383592;385990;386119;388602;51392.74303628533;51963.74018129961;52831;52853;52905.7354713224;1231.7782799096249;1265.9873401266054;1269.1306455078302;1273.9681507962189;1291.263979531658;25110.246692599252;25225.74774252234;25632.487350253265;25812.756078928847;26174.86912565425;44940.55059449364;45312.773436133924;45358;45420.772896135306;45421.77289113533;313044;318510;319249;320136;320372;26150.34624134336;26507.469850603266;26535;26675.06637267764;26682.733172668024;42612.57387426086;43363.34954975741;43734.56265437432;44445.77777111094;44985.1002979932;37930.0517487065;38001;38200.36828746352;38387.42418863775;38500.80749596234;37239;37729;38022.61977380191;38093.80953095217;38574;33132;37048.44427333538;37354.8132259337;38045.04887377727;38048;32337.35325293434;33583;33968.490472642436;34038.829805850815;34127;25573;25978;26298.079567215056;26367.472650546497;26609.403435793913 05:39:55 INFO - PROCESS | 1208 | |2;jquery.html;381.0853950518755;383.63554623108047;384.29865495470773;395.9821808018639;398.8922990792484;15603.531894043183;17446.82553174468;17711.82288177118;18017.36939207128;18036.278548858045;17552.473425797216;17772.28910843565;18110;18118.456446306598;18355.26578936844;5034.82378116766;5144.536991670749;5194.35070616173;5208.374995000586;5230.084735171349;3704.9993003778063;4105.055837157455;6153.169322141521;6280.340564240758;6307.337729538402;6161.35305792892;6209.534284928626;6226.221722284715;6229.844253893666;6254.21822272216;6073.453389194971;6248.5313601480075;6253.812385628438;6256.03031530109;6265.874682506347;4575.633949284049;4919.72941488218;5432.728363581805;5470.261514695505;5471.452854714536;12607.747845043139;12620.242785432903;12842;12856.871431285661;18529.44411667652;1894.2233684189416;1896.345760712552;1906.5328994396323;1934.2069751401998;2263.1060731011157;9479;9743.025697430272;10754.300970436896;10863.782724345469;13682.04225704201;1703.3251133561366;1731.2469075952001;1765.2674140231788;1777.4845294864474;1852.435007322766;67599.3240067598;68092.6595367025;68522.65738671274;69378;69993;9809.117179453884;10063.849042264372;10259.384436933808;10328.122109620766;10452.372857628567;14480;14596.489122880648;14604.780928286084;14665.48670796517;14713.190774507504;7484.476086673881;7595.012648355679;7673.462857600026;7779.649915753805;7785.416093792875;7299.379552738077;7306.232845551141;7465;7487.363574096263;7501.362384197295;4334.154839806208;4393.692441529062;4436.423264975532;4511.639068874482;4590.977045114753;1887.9716804247948;1906.170815695177;1911.130435651775;1923.1442008306449;1965.88204707718;934.4206591912922;940.2947789158131;978.2467500024941;984.3306551544875;1013.8732658417698;15017.699646007237;17454.30182792674;17501.38745143914;17685.823141768677;17710.20304086319;421.55947035348134;437.6127127492192;445.3053236950368;460.9677322587387;464.1482878917157;5343.866403339947;5825.417458254141;5903;5950.821475355746;6072.635641861502;415772;418359;422609;428237;428520;80327.59836200782;83396;83516.58241708753;84032.15967840365;84079.5796021016;454.72943598558805;463.3767582601463;465.7694441251602;467.306050514985;469.01974872516604;10061.245406594388;10146.391216526737;10291.588336466757;10403.53184106732;10438.269321147447;33665;34588.48117278293;34705;35138.648613513535;35405.82297088498;49249.2612610804;50334.49665503445;51022.74488627533;51623;51626.74186629043;7198.5680859148615;7990.560519171501;8075.475094118863;8198.590070496331;8311.168883111883;7763;8656;9471.905280947103;12241.571544995883;12545.435455404346;10639;10705.9464702676;10745.140388768723;10767.138628909512;10843.45782710877;10033.49832508357;10453.111485523816;10479.161667066768;10822;10973.122150227802;10667.46662666848;10925.235233533576;10937.398443085707;10975.725606859893;10985.450727463754;8065.717699880476;8079.434439589172;8117.512949223065;8169.387295952709;8206.384521160817;8094.028716554051;10324.48377581133;10549.103326217051;10662.626808061681;10746.83879741789 05:39:55 INFO - PROCESS | 1208 | |3;mootools.html;1412.152708374975;1496.670732438863;1498.2808252039022;1501.1368463133697;1529.3729570875944;6415.422611964922;7156.8926466102985;7395.630218489081;7669.079710434748;7676.616169191546;7428.257174282582;7603.239676032394;7692.576908270057;7777.572233527168;7803.258690424401;2192.8574642648255;2259.6836442898007;2261.547690461906;2268.0134141648355;2270.489139943508;2163.0590693048493;2192.7807219278025;2228.487447886987;2229.108356657334;2236.0608544411384;2220.666899965002;2227.866328020316;2234.229190929127;2239.585676649817;2271.171022576756;2052.466358746729;2053.917843286267;2057.9812992568623;2058.6500294949897;2060.6084843879767;2161.0815403453626;2174.804267615922;2185.2024011235944;2186.6392045312505;2192.0574153114153;7433.628318584049;7609.201033891417;7658.042744656918;7680.38556915451;7709.691612335556;4678.157931572316;4816.8554943351755;4836.588889944359;4856.68431551948;4870.853874383774;2891.927701807451;2944.175630823373;2986.910392688223;2995.4608170529295;2996.101169649118;931.7204838548408;932.6922115701802;938.9718308450757;939.1078475448352;955.7323949294208;10240.795184096276;10450.947745261301;10473;10488.423136727477;10525.631602893938;4301.290287102655;4335.111302183045;4365.236083685342;4392.692511524227;4392.912141757147;9137.223336016381;9168.633254669872;9171.77070573241;9210.769730756785;9222.354435189472;4733.668643195012;4793.400824896888;4798;4798.47216806151;4826.0830442215865;3728.757630753992;4066.837326506966;4195.035141917315;4204.600562946515;4262.744235345827;3607.4408466687705;3619.113317237294;3717.182219911615;3717.7955212463035;3739.2521495700967;1149.977000460003;1226.2642414551199;1230.5077968812548;1238.1518659718122;1240.0699475393455;794.1780257433644;796.7729197178776;804.3123129724119;835.8035861572525;849.0957130655831;4954.380702412199;5051.823186188466;5147.433782283946;5167.431582525919;5188.8962220755375;838.2037064788475;910.8132832769267;914.1635403605626;939.0468674295596;958.5542722633869;3549.219171782204;3617.8552857885916;3626.3653860574295;3637.2361804020925;3694.630536946284;8691.304695624462;8996.550172491348;9005.549722513848;9037.954810226038;9056.184943355129;8869.822603547893;8906.109389061043;8985.955070224607;8996.82006359869;9027.277817774562;7166.355028047501;7395.112586489656;7407.481476296607;7410.925890741131;7442.813929651694;5069.771860266371;5109.156989096758;5165.405978312542;5166.3025491558155;5263.815766448156;8657.091005444337;8720.520371379635;8829.293656507336;8915.331350148635;8931.106889311277;8406.915930840612;8721.65113395457;8761.824763504821;8911.866322005304;9066.50134242623;5835.095560188178;6514.088027676224;6715.664216789239;6800.795976120724;6883.174019117738;7242.203357630551;7252.601106938958;7307.232740562377;7324.853502930018;7353.926460735324;6339.429451349401;6488.708008139551;6492.805215843532;6500.642464664489;6575.112359831362;6586.604803711793;6757.425618822455;6760.763373281911;6763;6765.42493888025;6056.36408177135;6110.938890611037;6120.479759220516;6122.663253521099;6133.080037994337;4239.851605193803;4352.368906508602;4448.377227188132;4523.11799199153;4529.501754807035;4378.781060947003;4382.693211475166;4454.910901782011;4468.874290566222;4505.954940450553 05:39:55 INFO - PROCESS | 1208 | |4;prototype.html;311.1691782939551;313.5672771575226;317.7632663665569;319.0253774718235;319.157424399585;4943.184374578194;4959.330490383797;4985.127602669528;4997.975010124945;5011.22326039464;4877.268729511476;4921.212605983043;4926.5812405945535;4932.260160975847;4944.876378090549;3661.8535258589623;3785.167263202091;3870.78710670913;3892.6885849132;3893.824777885002;3864.516935383077;3888.416737489371;3888.572257051722;3893.7274390792654;3906.7069969752242;3872.1800753645743;3890.8443662253476;3900.941485877714;3903.512060992376;3904.12157264616;3778.5654649715084;3857.1514266861245;3889.4943657324648;3896.454496370496;3898.434726964588;3408.84660190292;3428;3445.4831775233915;3451.8101504417245;3466.2374277658873;4709.788059537329;4711.623070154379;4722.787474563653;4740.478547359788;4741.5732584067255;4436.733795972252;4475.462944446655;4478.977605111953;4496.2581174106235;4499.572540608637;4935.185694360426;5137.330367630535;5192.247124167013;5196.973180459624;5210.687358758449;3652.9634703652887;3679.3193259247123;3682.355587772129;3683;3702.5189924030333;5414.972925135349;5438.803463238081;5448.564114870801;5470.890582188414;5473.562115030788;3655.908602284964;3801.6008319126645;3807.4669546263544;3808.1622043150464;3817.9529698519104;3834.8082595870096;3852.2488114817343;3859.228154369081;3862.942055869164;3862.980685096613;4392.670549708785;4405.140997505456;4410.955890441119;4421.9336709949375;4428.6678499112695;5094.643374963791;5132.562033034279;5163.122269214243;5239.711815850089;5275.393329767126;1295.3393769177599;1296.6628676544167;1303.12690497367;1304.4064950447714;1309.2668105860557;803.2008151888908;825.7481468152271;848.3933987199182;850.3239924260228;860.2816648098783;4401.779911004437;4483.489246022173;4489.281714925596;4542.0915816836105;4553.225951588238;5295.814646487354;5307.177387504943;5335.253064570963;5348.705821179795;5355.598330125256;4361.06237159006;4548.977255113769;4549.135664223787;4557.680962332605;4562.178807814559;2771.1686494051705;2847.2454799478155;2851.2871782054485;2851.2871782054485;2876.6548014238424;4942.159832828428;4966.975165124223;5053.494650534917;5054.393472783216;5059.595232381401;5222.634415590872;5466.234727138204;5525;5540.972295138498;5541.473560011793;4965.50344965515;4978.452370239271;4985.501449855058;4986.227134794112;5003.824101336183;5322.654027488201;5329.280547126244;5331.226972088948;5341.519263266325;5352.411234764095;5032.672876263031;5254.894902102013;5272.525472707474;5296.708681022581;5299.2316114164005;4996.825111121093;5001.299818025406;5004.874878128076;5005.674631148963;5041.462353981924;3758.361078616587;3771.41543060826;3771.9434208486346;3776.169242766587;3790.981045094757;5251.89496210066;5294.888073504607;5397.8920421590565;5398.4614384900115;5414.431484694051;5207.453217412117;5210;5228.37259528859;5233.293505376725;5237.397699264481;5139.871503212449;5152.346541531189;5166;5169.715665638426;5223.843284701465;4767;5078.162103253069;5102.872428189325;5104.438511763628;5128.076946149728;5023.648344615988;5096.311997880239;5199.596109050611;5220.190870415092;5253.658512196695;5072.28987941681;5118.795248190031;5121.667091639031;5122.820701275437;5133.22903598258 05:39:55 INFO - PROCESS | 1208 | |5;yui.html;742.6732237815364;757.6628400361838;758.821676905927;770.9151993280739;771.672039383262;11311.943440282797;11976.520939162445;12009.219400738946;12015.639530814067;12026.819597706031;11725.120615953794;11838.822417663741;11911.821322680167;12584.622461326151;12881.162724422906;684.9657517124149;870.0603348383746;882.9337799665051;883.244825674049;883.3816328569994;843.5908584336622;877.2017464107663;878.5607196401799;878.8857448531681;879.2174964281762;911.6717981526679;916.4638686368482;916.5829547555879;916.9174774270315;918.1323649151554;902.5487256371814;904.5025236120108;907.8138981508807;908.0148039377284;908.1191244492832;667.546068673302;667.8597494526156;670.8188789026935;672.0691841799095;673.952823302369;12402;12462.065345099154;12521.373931303398;12529.561465348668;12557.183783054072;11218.775624487465;11338.773224535546;11809.822852657217;12010.339431331273;12383.442745076492;9048.909510904938;9537.666181683608;9574.090461406226;9787.657431989846;10024.398536087785;4069.4302797608357;4077.673786097105;4106.7946602670045;4113.568075352075;4144.44050053245;43002;43273;43738;43987.34018989718;44032.77983610093;8651.52416617092;8766.868496972551;8865;9170.220531254918;9621.27840411972;15581.922090389475;15613.219339033003;16320.102394368423;16778.0772057538;16880.91559542219;6658.134442522538;6813.795586132324;6904.861902761917;6940.340667636668;7069.8939515907305;3543.7696549724187;3584.390653588896;3623.438367053111;3681.650243226889;3806.5812760596314;2825.0818483992784;2852.8288302701903;2915.344047589318;2915.9562606560917;2919.839408832492;535.2506490912675;537.0118981074841;541.6100407706446;542.956563474921;544.9100898351728;518.0183552168619;551.3686828581332;620.7330847735427;644.5069521815815;649.6102338596899;8045.764532487369;8188.836223275501;8295.12901145371;8351.540665263346;8472.237498625153;509.22851879402737;558.1432501110776;583.5302581421996;610.6397225636807;623.7816764132517;3362.613299470543;3379.1889946412684;3487.3199726053685;3489.5986961499752;3502.264524449894;48632.27051594229;50366.748166258934;50464.49535504598;51166.48833511692;51228.743856281224;44775;45038.54961450409;45609.315860262126;45936.3109553357;47647.52352476431;40007.19985600272;40618;41287.587124128375;41700;41895;6732.528722989344;6830.897536537055;7048.942658601046;7377.446691498052;7442.96278518604;27415.45169096567;28563.714362856936;28757.99347022844;28764.424711505235;28792.424151517273;34102.65897340995;35898;36267;36718.8164059178;36741.63258367489;10682.145428365557;10825.61601821356;10876.45617719095;11010.834837477605;11163;11975;12116.394180290774;12217.877821221675;12313;12656.557020504239;10726.141908647445;10735.194860385345;10998;11931.940340298243;11953.22304050234;10638.73403164896;10916.181286403711;10938.890611093788;11091.944540277247;11477.081833453136;11323.547058117912;11415.315081095161;11631.185816992729;11750.94124529372;12084.75830483403;9634.951825240829;9642.325037247325;9734.610615575297;9843.409395436296;9953.502324883872;9761.9023809761;9976.750581235527;10078.244131690299;10078.596856125672;10134.23993200498 05:39:55 INFO - PROCESS | 1208 | __end_tp_report 05:39:55 INFO - PROCESS | 1208 | __start_cc_report 05:39:55 INFO - PROCESS | 1208 | _x_x_mozilla_cycle_collect,378 05:39:55 INFO - PROCESS | 1208 | __end_cc_report 05:39:55 INFO - PROCESS | 1208 | __startTimestamp1462883995820__endTimestamp 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | ------- Summary: start ------- 05:39:55 INFO - PROCESS | 1208 | Number of tests: 6 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | [#0] dojo.html Cycles:165 Average:4799.93 Median:4933.00 stddev:506.09 (10.3%) stddev-sans-first:479.04 05:39:55 INFO - PROCESS | 1208 | Values: 2662.0 2665.3 2693.3 2708.8 2717.1 4729.9 4766.7 4776.4 4794.4 4816.4 4685.4 4766.8 4812.8 4840.9 4863.0 4378.7 4400.0 4518.0 4549.7 4555.0 4437.1 4473.4 4489.9 4505.7 4524.1 4335.0 4344.0 4381.3 4437.4 4437.4 4434.9 4492.4 4504.7 4511.0 4520.5 4371.8 4478.9 4486.2 4487.7 4492.7 4692.7 4723.5 4761.0 4771.3 4786.6 5153.2 5164.0 5179.3 5201.0 5227.2 5154.4 5194.3 5195.5 5212.7 5244.8 4914.8 4937.0 4952.7 4966.3 4998.6 5439.1 5439.6 5444.4 5449.4 5455.3 5084.9 5126.6 5161.0 5163.9 5169.3 5021.1 5045.6 5216.8 5255.3 5269.9 5144.9 5179.9 5217.6 5238.0 5244.6 5083.0 5085.7 5108.1 5169.4 5193.8 4451.0 4462.6 4471.8 4472.6 4529.0 3868.8 3871.7 3874.1 3919.1 3972.8 4434.6 4443.6 4467.8 4480.0 4491.3 5227.3 5244.9 5260.3 5261.7 5318.8 4333.3 4493.5 4494.5 4498.1 4538.7 4706.2 4733.7 4741.4 4741.5 4749.8 4899.2 4919.2 4921.5 4933.0 4974.1 5099.4 5183.6 5263.8 5283.4 5345.2 4840.0 4846.2 4861.8 4887.2 4925.9 5143.1 5149.9 5162.3 5171.8 5209.3 5054.1 5137.7 5153.3 5235.1 5251.6 4968.1 4997.5 5018.7 5070.5 5083.7 4981.5 4983.0 4998.1 5067.6 5075.1 4922.4 4926.9 4953.1 4958.2 4974.2 4975.0 5004.4 5048.0 5054.2 5057.7 4913.7 4940.3 4964.2 4976.5 4985.1 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | [#1] ext.html Cycles:180 Average:47315.66 Median:37153.72 stddev:84833.78 (228.3%) stddev-sans-first:84999.03 05:39:55 INFO - PROCESS | 1208 | Values: 529.4 577.5 607.4 610.7 633.3 35544.1 39946.2 39984.6 40012.2 40093.6 40100.6 40354.0 40645.4 40659.2 40762.8 7649.5 7705.8 7754.2 7757.2 7777.0 7677.4 7745.5 7786.3 7801.1 7801.6 7822.5 7829.6 7838.9 7844.7 7869.8 7525.8 7547.5 7567.6 7576.5 7600.0 7765.3 7850.1 7870.5 7874.1 7880.1 36679.0 36999.4 37027.8 37030.4 37051.0 2982.7 3195.9 3264.1 3338.7 3377.4 28953.7 29360.6 29645.3 29670.9 29892.0 2850.7 2869.2 2888.5 2907.4 2962.6 249573.0 250290.0 250445.0 250785.0 250830.0 55802.0 56099.7 56420.7 56499.0 56542.7 37068.4 37897.2 37898.6 38086.6 38090.2 15654.5 15694.7 15709.5 15771.6 15802.4 11585.3 11651.6 11701.4 11721.3 11780.5 15032.9 15147.9 15208.4 15210.0 15219.2 7156.2 7179.8 7201.8 7327.3 7476.8 851.5 964.0 1039.7 1070.8 1107.5 29148.1 29226.7 29249.9 29414.6 29678.9 963.2 1044.7 1083.9 1167.9 1186.9 15407.4 15415.2 15631.7 15719.2 15760.4 379217.0 383592.0 385990.0 386119.0 388602.0 51392.7 51963.7 52831.0 52853.0 52905.7 1231.8 1266.0 1269.1 1274.0 1291.3 25110.2 25225.7 25632.5 25812.8 26174.9 44940.6 45312.8 45358.0 45420.8 45421.8 313044.0 318510.0 319249.0 320136.0 320372.0 26150.3 26507.5 26535.0 26675.1 26682.7 42612.6 43363.3 43734.6 44445.8 44985.1 37930.1 38001.0 38200.4 38387.4 38500.8 37239.0 37729.0 38022.6 38093.8 38574.0 33132.0 37048.4 37354.8 38045.0 38048.0 32337.4 33583.0 33968.5 34038.8 34127.0 25573.0 25978.0 26298.1 26367.5 26609.4 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | [#2] jquery.html Cycles:180 Average:25057.86 Median:428378.50 stddev:69754.14 (16.3%) stddev-sans-first:69925.21 05:39:55 INFO - PROCESS | 1208 | Values: 381.1 383.6 384.3 396.0 398.9 15603.5 17446.8 17711.8 18017.4 18036.3 17552.5 17772.3 18110.0 18118.5 18355.3 5034.8 5144.5 5194.4 5208.4 5230.1 3705.0 4105.1 6153.2 6280.3 6307.3 6161.4 6209.5 6226.2 6229.8 6254.2 6073.5 6248.5 6253.8 6256.0 6265.9 4575.6 4919.7 5432.7 5470.3 5471.5 12607.7 12620.2 12842.0 12856.9 18529.4 1894.2 1896.3 1906.5 1934.2 2263.1 9479.0 9743.0 10754.3 10863.8 13682.0 1703.3 1731.2 1765.3 1777.5 1852.4 67599.3 68092.7 68522.7 69378.0 69993.0 9809.1 10063.8 10259.4 10328.1 10452.4 14480.0 14596.5 14604.8 14665.5 14713.2 7484.5 7595.0 7673.5 7779.6 7785.4 7299.4 7306.2 7465.0 7487.4 7501.4 4334.2 4393.7 4436.4 4511.6 4591.0 1888.0 1906.2 1911.1 1923.1 1965.9 934.4 940.3 978.2 984.3 1013.9 15017.7 17454.3 17501.4 17685.8 17710.2 421.6 437.6 445.3 461.0 464.1 5343.9 5825.4 5903.0 5950.8 6072.6 415772.0 418359.0 422609.0 428237.0 428520.0 80327.6 83396.0 83516.6 84032.2 84079.6 454.7 463.4 465.8 467.3 469.0 10061.2 10146.4 10291.6 10403.5 10438.3 33665.0 34588.5 34705.0 35138.6 35405.8 49249.3 50334.5 51022.7 51623.0 51626.7 7198.6 7990.6 8075.5 8198.6 8311.2 7763.0 8656.0 9471.9 12241.6 12545.4 10639.0 10705.9 10745.1 10767.1 10843.5 10033.5 10453.1 10479.2 10822.0 10973.1 10667.5 10925.2 10937.4 10975.7 10985.5 8065.7 8079.4 8117.5 8169.4 8206.4 8094.0 10324.5 10549.1 10662.6 10746.8 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | [#3] mootools.html Cycles:180 Average:5053.47 Median:5165.85 stddev:2761.72 (53.5%) stddev-sans-first:2755.91 05:39:55 INFO - PROCESS | 1208 | Values: 1412.2 1496.7 1498.3 1501.1 1529.4 6415.4 7156.9 7395.6 7669.1 7676.6 7428.3 7603.2 7692.6 7777.6 7803.3 2192.9 2259.7 2261.5 2268.0 2270.5 2163.1 2192.8 2228.5 2229.1 2236.1 2220.7 2227.9 2234.2 2239.6 2271.2 2052.5 2053.9 2058.0 2058.7 2060.6 2161.1 2174.8 2185.2 2186.6 2192.1 7433.6 7609.2 7658.0 7680.4 7709.7 4678.2 4816.9 4836.6 4856.7 4870.9 2891.9 2944.2 2986.9 2995.5 2996.1 931.7 932.7 939.0 939.1 955.7 10240.8 10450.9 10473.0 10488.4 10525.6 4301.3 4335.1 4365.2 4392.7 4392.9 9137.2 9168.6 9171.8 9210.8 9222.4 4733.7 4793.4 4798.0 4798.5 4826.1 3728.8 4066.8 4195.0 4204.6 4262.7 3607.4 3619.1 3717.2 3717.8 3739.3 1150.0 1226.3 1230.5 1238.2 1240.1 794.2 796.8 804.3 835.8 849.1 4954.4 5051.8 5147.4 5167.4 5188.9 838.2 910.8 914.2 939.0 958.6 3549.2 3617.9 3626.4 3637.2 3694.6 8691.3 8996.6 9005.5 9038.0 9056.2 8869.8 8906.1 8986.0 8996.8 9027.3 7166.4 7395.1 7407.5 7410.9 7442.8 5069.8 5109.2 5165.4 5166.3 5263.8 8657.1 8720.5 8829.3 8915.3 8931.1 8406.9 8721.7 8761.8 8911.9 9066.5 5835.1 6514.1 6715.7 6800.8 6883.2 7242.2 7252.6 7307.2 7324.9 7353.9 6339.4 6488.7 6492.8 6500.6 6575.1 6586.6 6757.4 6760.8 6763.0 6765.4 6056.4 6110.9 6120.5 6122.7 6133.1 4239.9 4352.4 4448.4 4523.1 4529.5 4378.8 4382.7 4454.9 4468.9 4506.0 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | [#4] prototype.html Cycles:180 Average:4305.43 Median:4938.67 stddev:1252.26 (25.4%) stddev-sans-first:1219.36 05:39:55 INFO - PROCESS | 1208 | Values: 311.2 313.6 317.8 319.0 319.2 4943.2 4959.3 4985.1 4998.0 5011.2 4877.3 4921.2 4926.6 4932.3 4944.9 3661.9 3785.2 3870.8 3892.7 3893.8 3864.5 3888.4 3888.6 3893.7 3906.7 3872.2 3890.8 3900.9 3903.5 3904.1 3778.6 3857.2 3889.5 3896.5 3898.4 3408.8 3428.0 3445.5 3451.8 3466.2 4709.8 4711.6 4722.8 4740.5 4741.6 4436.7 4475.5 4479.0 4496.3 4499.6 4935.2 5137.3 5192.2 5197.0 5210.7 3653.0 3679.3 3682.4 3683.0 3702.5 5415.0 5438.8 5448.6 5470.9 5473.6 3655.9 3801.6 3807.5 3808.2 3818.0 3834.8 3852.2 3859.2 3862.9 3863.0 4392.7 4405.1 4411.0 4421.9 4428.7 5094.6 5132.6 5163.1 5239.7 5275.4 1295.3 1296.7 1303.1 1304.4 1309.3 803.2 825.7 848.4 850.3 860.3 4401.8 4483.5 4489.3 4542.1 4553.2 5295.8 5307.2 5335.3 5348.7 5355.6 4361.1 4549.0 4549.1 4557.7 4562.2 2771.2 2847.2 2851.3 2851.3 2876.7 4942.2 4967.0 5053.5 5054.4 5059.6 5222.6 5466.2 5525.0 5541.0 5541.5 4965.5 4978.5 4985.5 4986.2 5003.8 5322.7 5329.3 5331.2 5341.5 5352.4 5032.7 5254.9 5272.5 5296.7 5299.2 4996.8 5001.3 5004.9 5005.7 5041.5 3758.4 3771.4 3771.9 3776.2 3791.0 5251.9 5294.9 5397.9 5398.5 5414.4 5207.5 5210.0 5228.4 5233.3 5237.4 5139.9 5152.3 5166.0 5169.7 5223.8 4767.0 5078.2 5102.9 5104.4 5128.1 5023.6 5096.3 5199.6 5220.2 5253.7 5072.3 5118.8 5121.7 5122.8 5133.2 05:39:55 INFO - PROCESS | 1208 | 05:39:55 INFO - PROCESS | 1208 | [#5] yui.html Cycles:180 Average:12452.37 Median:43505.50 stddev:13824.12 (31.8%) stddev-sans-first:13834.93 05:39:55 INFO - PROCESS | 1208 | Values: 742.7 757.7 758.8 770.9 771.7 11311.9 11976.5 12009.2 12015.6 12026.8 11725.1 11838.8 11911.8 12584.6 12881.2 685.0 870.1 882.9 883.2 883.4 843.6 877.2 878.6 878.9 879.2 911.7 916.5 916.6 916.9 918.1 902.5 904.5 907.8 908.0 908.1 667.5 667.9 670.8 672.1 674.0 12402.0 12462.1 12521.4 12529.6 12557.2 11218.8 11338.8 11809.8 12010.3 12383.4 9048.9 9537.7 9574.1 9787.7 10024.4 4069.4 4077.7 4106.8 4113.6 4144.4 43002.0 43273.0 43738.0 43987.3 44032.8 8651.5 8766.9 8865.0 9170.2 9621.3 15581.9 15613.2 16320.1 16778.1 16880.9 6658.1 6813.8 6904.9 6940.3 7069.9 3543.8 3584.4 3623.4 3681.7 3806.6 2825.1 2852.8 2915.3 2916.0 2919.8 535.3 537.0 541.6 543.0 544.9 518.0 551.4 620.7 644.5 649.6 8045.8 8188.8 8295.1 8351.5 8472.2 509.2 558.1 583.5 610.6 623.8 3362.6 3379.2 3487.3 3489.6 3502.3 48632.3 50366.7 50464.5 51166.5 51228.7 44775.0 45038.5 45609.3 45936.3 47647.5 40007.2 40618.0 41287.6 41700.0 41895.0 6732.5 6830.9 7048.9 7377.4 7443.0 27415.5 28563.7 28758.0 28764.4 28792.4 34102.7 35898.0 36267.0 36718.8 36741.6 10682.1 10825.6 10876.5 11010.8 11163.0 11975.0 12116.4 12217.9 12313.0 12656.6 10726.1 10735.2 10998.0 11931.9 11953.2 10638.7 10916.2 10938.9 11091.9 11477.1 11323.5 11415.3 11631.2 11750.9 12084.8 9635.0 9642.3 9734.6 9843.4 9953.5 9761.9 9976.8 10078.2 10078.6 10134.2 05:39:55 INFO - PROCESS | 1208 | -------- Summary: end -------- 05:39:55 INFO - PROCESS | 1208 | 05:39:56 INFO - TEST-INFO | 1208: exit 0 05:39:56 INFO - TEST-OK | dromaeo_css | took 1115495ms 05:39:56 INFO - TEST-START | kraken 05:39:56 INFO - operating with platform_type : linux_ 05:39:56 INFO - Initialising browser for kraken test... 05:39:56 INFO - TEST-INFO | started process 1457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYS1Z7D/profile http://localhost:51160/getInfo.html) 05:40:00 INFO - PROCESS | 1457 | 05:40:00 INFO - PROCESS | 1457 | (process:1527): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:01 INFO - PROCESS | 1457 | __metrics Screen width/height:1600/1200 05:40:01 INFO - PROCESS | 1457 | colorDepth:24 05:40:01 INFO - PROCESS | 1457 | Browser inner width/height: 1024/697 05:40:01 INFO - PROCESS | 1457 | __metrics 05:40:02 ERROR - PROCESS | 1457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:40:03 INFO - TEST-INFO | 1457: exit 0 05:40:03 INFO - Browser initialized. 05:40:03 INFO - Running cycle 1/1 for kraken test... 05:40:03 INFO - TEST-INFO | started process 1578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYS1Z7D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:05 INFO - PROCESS | 1578 | 05:40:05 INFO - PROCESS | 1578 | (process:1637): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:40:15 INFO - PROCESS | 1578 | RSS: Main: 164564992 05:40:15 INFO - PROCESS | 1578 | 05:40:17 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:18 INFO - PROCESS | 1578 | RSS: Main: 167464960 05:40:18 INFO - PROCESS | 1578 | 05:40:21 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-dft) 05:40:22 INFO - PROCESS | 1578 | RSS: Main: 168058880 05:40:22 INFO - PROCESS | 1578 | 05:40:25 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-fft) 05:40:25 INFO - PROCESS | 1578 | RSS: Main: 163766272 05:40:25 INFO - PROCESS | 1578 | 05:40:27 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51160/tests/kraken/driver.html?testName=audio-oscillator) 05:40:28 INFO - PROCESS | 1578 | RSS: Main: 164081664 05:40:28 INFO - PROCESS | 1578 | 05:40:30 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51160/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:31 INFO - PROCESS | 1578 | RSS: Main: 164458496 05:40:31 INFO - PROCESS | 1578 | 05:40:34 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51160/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:35 INFO - PROCESS | 1578 | RSS: Main: 164896768 05:40:35 INFO - PROCESS | 1578 | 05:40:39 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51160/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:39 INFO - PROCESS | 1578 | RSS: Main: 163205120 05:40:39 INFO - PROCESS | 1578 | 05:40:42 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51160/tests/kraken/driver.html?testName=json-parse-financial) 05:40:43 INFO - PROCESS | 1578 | RSS: Main: 164016128 05:40:43 INFO - PROCESS | 1578 | 05:40:45 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51160/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:45 INFO - PROCESS | 1578 | RSS: Main: 163917824 05:40:45 INFO - PROCESS | 1578 | 05:40:47 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:48 INFO - PROCESS | 1578 | RSS: Main: 164339712 05:40:48 INFO - PROCESS | 1578 | 05:40:50 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:51 INFO - PROCESS | 1578 | RSS: Main: 165244928 05:40:51 INFO - PROCESS | 1578 | 05:40:54 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:54 INFO - PROCESS | 1578 | RSS: Main: 164831232 05:40:54 INFO - PROCESS | 1578 | 05:40:57 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:58 INFO - PROCESS | 1578 | RSS: Main: 165064704 05:40:58 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | Cycle 1(1): loaded http://localhost:51160/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51160/tests/kraken/driver.html?testName=ai-astar) 05:41:00 INFO - PROCESS | 1578 | RSS: Main: 167727104 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | __start_tp_report 05:41:00 INFO - PROCESS | 1578 | _x_x_mozilla_page_load 05:41:00 INFO - PROCESS | 1578 | _x_x_mozilla_page_load_details 05:41:00 INFO - PROCESS | 1578 | |i|pagename|runs| 05:41:00 INFO - PROCESS | 1578 | |0;ai-astar;111;114;107;113;116;114;108;115;114;114 05:41:00 INFO - PROCESS | 1578 | |1;audio-beat-detection;154;134;157;211;132;163;162;133;184;139 05:41:00 INFO - PROCESS | 1578 | |2;audio-dft;163;165;165;169;162;163;164;166;162;164 05:41:00 INFO - PROCESS | 1578 | |3;audio-fft;76;75;76;165;84;77;78;77;164;77 05:41:00 INFO - PROCESS | 1578 | |4;audio-oscillator;95;93;168;93;92;92;138;100;94;148 05:41:00 INFO - PROCESS | 1578 | |5;imaging-gaussian-blur;118;118;117;117;118;118;117;120;118;118 05:41:00 INFO - PROCESS | 1578 | |6;imaging-darkroom;148;147;148;147;148;147;147;147;147;147 05:41:00 INFO - PROCESS | 1578 | |7;imaging-desaturate;95;95;96;96;95;96;95;95;95;96 05:41:00 INFO - PROCESS | 1578 | |8;json-parse-financial;68;68;69;74;70;70;67;68;68;67 05:41:00 INFO - PROCESS | 1578 | |9;json-stringify-tinderbox;65;66;66;67;66;66;66;66;66;67 05:41:00 INFO - PROCESS | 1578 | |10;stanford-crypto-aes;85;84;82;84;83;89;83;84;144;84 05:41:00 INFO - PROCESS | 1578 | |11;stanford-crypto-ccm;135;138;134;160;141;135;142;145;165;151 05:41:00 INFO - PROCESS | 1578 | |12;stanford-crypto-pbkdf2;176;177;178;177;180;176;178;181;175;181 05:41:00 INFO - PROCESS | 1578 | |13;stanford-crypto-sha256-iterative;68;71;69;72;72;72;71;69;70;68 05:41:00 INFO - PROCESS | 1578 | __end_tp_report 05:41:00 INFO - PROCESS | 1578 | __start_cc_report 05:41:00 INFO - PROCESS | 1578 | _x_x_mozilla_cycle_collect,946 05:41:00 INFO - PROCESS | 1578 | __end_cc_report 05:41:00 INFO - PROCESS | 1578 | __startTimestamp1462884060624__endTimestamp 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | ------- Summary: start ------- 05:41:00 INFO - PROCESS | 1578 | Number of tests: 14 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:2.99 (2.6%) stddev-sans-first:3.11 05:41:00 INFO - PROCESS | 1578 | Values: 111.0 114.0 107.0 113.0 116.0 114.0 108.0 115.0 114.0 114.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#1] audio-beat-detection Cycles:10 Average:156.90 Median:159.50 stddev:25.32 (15.9%) stddev-sans-first:26.83 05:41:00 INFO - PROCESS | 1578 | Values: 154.0 134.0 157.0 211.0 132.0 163.0 162.0 133.0 184.0 139.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.11 (1.3%) stddev-sans-first:2.19 05:41:00 INFO - PROCESS | 1578 | Values: 163.0 165.0 165.0 169.0 162.0 163.0 164.0 166.0 162.0 164.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#3] audio-fft Cycles:10 Average:94.90 Median:77.00 stddev:36.76 (47.7%) stddev-sans-first:38.35 05:41:00 INFO - PROCESS | 1578 | Values: 76.0 75.0 76.0 165.0 84.0 77.0 78.0 77.0 164.0 77.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#4] audio-oscillator Cycles:10 Average:111.30 Median:92.50 stddev:28.64 (31.0%) stddev-sans-first:29.76 05:41:00 INFO - PROCESS | 1578 | Values: 95.0 93.0 168.0 93.0 92.0 92.0 138.0 100.0 94.0 148.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 05:41:00 INFO - PROCESS | 1578 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 117.0 120.0 118.0 118.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 05:41:00 INFO - PROCESS | 1578 | Values: 148.0 147.0 148.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:41:00 INFO - PROCESS | 1578 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 95.0 96.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#8] json-parse-financial Cycles:10 Average:68.90 Median:68.50 stddev:2.08 (3.0%) stddev-sans-first:2.18 05:41:00 INFO - PROCESS | 1578 | Values: 68.0 68.0 69.0 74.0 70.0 70.0 67.0 68.0 68.0 67.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 05:41:00 INFO - PROCESS | 1578 | Values: 65.0 66.0 66.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:84.00 stddev:19.00 (22.6%) stddev-sans-first:20.05 05:41:00 INFO - PROCESS | 1578 | Values: 85.0 84.0 82.0 84.0 83.0 89.0 83.0 84.0 144.0 84.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:143.50 stddev:10.82 (7.5%) stddev-sans-first:10.91 05:41:00 INFO - PROCESS | 1578 | Values: 135.0 138.0 134.0 160.0 141.0 135.0 142.0 145.0 165.0 151.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.90 Median:178.00 stddev:2.13 (1.2%) stddev-sans-first:2.15 05:41:00 INFO - PROCESS | 1578 | Values: 176.0 177.0 178.0 177.0 180.0 176.0 178.0 181.0 175.0 181.0 05:41:00 INFO - PROCESS | 1578 | 05:41:00 INFO - PROCESS | 1578 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:71.00 stddev:1.62 (2.3%) stddev-sans-first:1.51 05:41:00 INFO - PROCESS | 1578 | Values: 68.0 71.0 69.0 72.0 72.0 72.0 71.0 69.0 70.0 68.0 05:41:00 INFO - PROCESS | 1578 | -------- Summary: end -------- 05:41:00 INFO - PROCESS | 1578 | 05:41:01 INFO - TEST-INFO | 1578: exit 0 05:41:01 INFO - TEST-OK | kraken | took 65144ms 05:41:01 INFO - SUITE-END | took 1180s 05:41:01 INFO - Completed test suite (00:19:40) 05:41:01 INFO - javascript benchmark 05:41:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2661.973380266197, 2665.2670515608215, 2693.3132051326907, 2708.7697545708616, 2717.1033558925556, 4729.858104256873, 4766.690165139268, 4776.37907072081, 4794.376731024962, 4816.422029356473, 4685.4143232095985, 4766.78549465274, 4812.759362031893, 4840.878978025551, 4863.027394521101, 4378.737275763448, 4399.956000440003, 4517.954820451802, 4549.749763763009, 4555.04344087742, 4437.068215674696, 4473.373727678128, 4489.910201795962, 4505.684602077856, 4524.117797029564, 4335.0462898162195, 4344.0, 4381.342798580238, 4437.356583295436, 4437.42313499243, 4434.911301773946, 4492.3710680504755, 4504.70719403241, 4510.954890451119, 4520.457545094577, 4371.803268852909, 4478.865634030984, 4486.192485352635, 4487.730736155841, 4492.730436173807, 4692.718436893797, 4723.504032076651, 4761.047790441926, 4771.33201351811, 4786.617070634341, 5153.2270159476, 5163.974180129076, 5179.300794392747, 5201.0, 5227.163653815409, 5154.433012368637, 5194.3247377840635, 5195.506426889439, 5212.713300768456, 5244.81643142492, 4914.778834952364, 4936.975315123437, 4952.678075925053, 4966.329545511346, 4998.600111991032, 5439.075357189287, 5439.619226654176, 5444.373897001817, 5449.373322068013, 5455.290812194389, 5084.923726144111, 5126.564242039469, 5161.0, 5163.896722065538, 5169.25045868347, 5021.071101846097, 5045.646804723634, 5216.817411390583, 5255.264263003182, 5269.868253293622, 5144.922826157611, 5179.948200518022, 5217.58259339252, 5237.973810130925, 5244.606654500928, 5082.974585127051, 5085.669431486942, 5108.055009823194, 5169.379674439091, 5193.792248310026, 4450.955490445054, 4462.642988560908, 4471.7987690554, 4472.619827314715, 4529.048899731093, 3868.7678739275734, 3871.709621778378, 3874.050857539921, 3919.118198405393, 3972.8410863565714, 4434.55654434554, 4443.600075993176, 4467.821287148543, 4479.977600111979, 4491.258942274553, 5227.294315267466, 5244.895102098013, 5260.316158899319, 5261.710605916712, 5318.760655770499, 4333.349997500401, 4493.5281795411665, 4494.505604383515, 4498.055408364215, 4538.682292239578, 4706.176419126639, 4733.668643194943, 4741.431028276629, 4741.502142275081, 4749.762511874462, 4899.216125419915, 4919.1883339248625, 4921.458639549646, 4933.0, 4974.104661161025, 5099.388073431063, 5183.585313174862, 5263.763130659206, 5283.445238250082, 5345.1714984177515, 4839.975800120977, 4846.224604063333, 4861.756912154449, 4887.193613053949, 4925.901481970269, 5143.074246635641, 5149.897002059863, 5162.303089082926, 5171.793128274827, 5209.296744939385, 5054.064997975386, 5137.717425541631, 5153.330067091254, 5235.083860324352, 5251.553617942365, 4968.130577148912, 4997.5002499749735, 5018.698878067327, 5070.4676009019995, 5083.72039537829, 4981.452040275494, 4982.950170498249, 4998.1253280676465, 5067.594592432671, 5075.08648443269, 4922.409310882717, 4926.852194434173, 4953.108440480748, 4958.206686930074, 4974.17926042199, 4975.029869175476, 5004.374453193351, 5047.9747601263225, 5054.16606259963, 5057.69653820772, 4913.729744864067, 4940.283658869515, 4964.180910149785, 4976.5023497649945, 4985.102681517362], "value": 4767.34973001232, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.4159059441953, 577.4918072096556, 607.4290167242791, 610.6916007416252, 633.3223450907531, 35544.111397215085, 39946.20107597846, 39984.60015399845, 40012.19975600486, 40093.59906400935, 40100.59899401005, 40354.0, 40645.390319145234, 40659.18681626366, 40762.7961860191, 7649.541027538337, 7705.768826935201, 7754.185810489902, 7757.185495522974, 7777.0, 7677.385809135284, 7745.496542724733, 7786.3381612563, 7801.141874393812, 7801.5709135997495, 7822.530648161129, 7829.647665855022, 7838.882416763753, 7844.686212551491, 7869.803254918645, 7525.811854703621, 7547.54714717116, 7567.621618919032, 7576.469647124703, 7600.0, 7765.339946104588, 7850.057993040871, 7870.488418252795, 7874.094479134916, 7880.133185349607, 36679.0, 36999.445008324896, 37027.81486092552, 37030.44454333187, 37051.0, 2982.7315541601142, 3195.936081278385, 3264.05342450689, 3338.7329013678846, 3377.3583019226267, 28953.710462895313, 29360.559591606143, 29645.258868528243, 29670.85164574185, 29892.0, 2850.686424493304, 2869.237771664794, 2888.523393640047, 2907.4330505551425, 2962.6296712910885, 249573.0, 250290.0, 250445.0, 250785.0, 250830.0, 55802.0, 56099.71950140223, 56420.71789641026, 56499.0, 56542.717286414125, 37068.44397334042, 37897.24205515874, 37898.62101379006, 38086.61913380886, 38090.23819523594, 15654.45209417665, 15694.724264981514, 15709.528714138594, 15771.605709857346, 15802.446914358172, 11585.304881706956, 11651.59219427316, 11701.414929253504, 11721.296722196696, 11780.528778848922, 15032.924835375754, 15147.924260378628, 15208.391664333303, 15210.0, 15219.162946038074, 7156.177039640404, 7179.820504487325, 7201.819954501075, 7327.2672732726305, 7476.775696729107, 851.4720873058619, 963.9566219520138, 1039.6621098143135, 1070.7590792071721, 1107.5182295701395, 29148.125556233346, 29226.707732922823, 29249.853750731534, 29414.558781618292, 29678.851605741835, 963.2294164668237, 1044.6604853422668, 1083.9349639021527, 1167.854018247719, 1186.8575770907546, 15407.383704651913, 15415.152166630718, 15631.728746442272, 15719.214039297989, 15760.448384306494, 379217.0, 383592.0, 385990.0, 386119.0, 388602.0, 51392.74303628533, 51963.74018129961, 52831.0, 52853.0, 52905.7354713224, 1231.7782799096249, 1265.9873401266054, 1269.1306455078302, 1273.9681507962189, 1291.263979531658, 25110.246692599252, 25225.74774252234, 25632.487350253265, 25812.756078928847, 26174.86912565425, 44940.55059449364, 45312.773436133924, 45358.0, 45420.772896135306, 45421.77289113533, 313044.0, 318510.0, 319249.0, 320136.0, 320372.0, 26150.34624134336, 26507.469850603266, 26535.0, 26675.06637267764, 26682.733172668024, 42612.57387426086, 43363.34954975741, 43734.56265437432, 44445.77777111094, 44985.1002979932, 37930.0517487065, 38001.0, 38200.36828746352, 38387.42418863775, 38500.80749596234, 37239.0, 37729.0, 38022.61977380191, 38093.80953095217, 38574.0, 33132.0, 37048.44427333538, 37354.8132259337, 38045.04887377727, 38048.0, 32337.35325293434, 33583.0, 33968.490472642436, 34038.829805850815, 34127.0, 25573.0, 25978.0, 26298.079567215056, 26367.472650546497, 26609.403435793913], "value": 17637.08621557147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.0853950518755, 383.63554623108047, 384.29865495470773, 395.9821808018639, 398.8922990792484, 15603.531894043183, 17446.82553174468, 17711.82288177118, 18017.36939207128, 18036.278548858045, 17552.473425797216, 17772.28910843565, 18110.0, 18118.456446306598, 18355.26578936844, 5034.82378116766, 5144.536991670749, 5194.35070616173, 5208.374995000586, 5230.084735171349, 3704.9993003778063, 4105.055837157455, 6153.169322141521, 6280.340564240758, 6307.337729538402, 6161.35305792892, 6209.534284928626, 6226.221722284715, 6229.844253893666, 6254.21822272216, 6073.453389194971, 6248.5313601480075, 6253.812385628438, 6256.03031530109, 6265.874682506347, 4575.633949284049, 4919.72941488218, 5432.728363581805, 5470.261514695505, 5471.452854714536, 12607.747845043139, 12620.242785432903, 12842.0, 12856.871431285661, 18529.44411667652, 1894.2233684189416, 1896.345760712552, 1906.5328994396323, 1934.2069751401998, 2263.1060731011157, 9479.0, 9743.025697430272, 10754.300970436896, 10863.782724345469, 13682.04225704201, 1703.3251133561366, 1731.2469075952001, 1765.2674140231788, 1777.4845294864474, 1852.435007322766, 67599.3240067598, 68092.6595367025, 68522.65738671274, 69378.0, 69993.0, 9809.117179453884, 10063.849042264372, 10259.384436933808, 10328.122109620766, 10452.372857628567, 14480.0, 14596.489122880648, 14604.780928286084, 14665.48670796517, 14713.190774507504, 7484.476086673881, 7595.012648355679, 7673.462857600026, 7779.649915753805, 7785.416093792875, 7299.379552738077, 7306.232845551141, 7465.0, 7487.363574096263, 7501.362384197295, 4334.154839806208, 4393.692441529062, 4436.423264975532, 4511.639068874482, 4590.977045114753, 1887.9716804247948, 1906.170815695177, 1911.130435651775, 1923.1442008306449, 1965.88204707718, 934.4206591912922, 940.2947789158131, 978.2467500024941, 984.3306551544875, 1013.8732658417698, 15017.699646007237, 17454.30182792674, 17501.38745143914, 17685.823141768677, 17710.20304086319, 421.55947035348134, 437.6127127492192, 445.3053236950368, 460.9677322587387, 464.1482878917157, 5343.866403339947, 5825.417458254141, 5903.0, 5950.821475355746, 6072.635641861502, 415772.0, 418359.0, 422609.0, 428237.0, 428520.0, 80327.59836200782, 83396.0, 83516.58241708753, 84032.15967840365, 84079.5796021016, 454.72943598558805, 463.3767582601463, 465.7694441251602, 467.306050514985, 469.01974872516604, 10061.245406594388, 10146.391216526737, 10291.588336466757, 10403.53184106732, 10438.269321147447, 33665.0, 34588.48117278293, 34705.0, 35138.648613513535, 35405.82297088498, 49249.2612610804, 50334.49665503445, 51022.74488627533, 51623.0, 51626.74186629043, 7198.5680859148615, 7990.560519171501, 8075.475094118863, 8198.590070496331, 8311.168883111883, 7763.0, 8656.0, 9471.905280947103, 12241.571544995883, 12545.435455404346, 10639.0, 10705.9464702676, 10745.140388768723, 10767.138628909512, 10843.45782710877, 10033.49832508357, 10453.111485523816, 10479.161667066768, 10822.0, 10973.122150227802, 10667.46662666848, 10925.235233533576, 10937.398443085707, 10975.725606859893, 10985.450727463754, 8065.717699880476, 8079.434439589172, 8117.512949223065, 8169.387295952709, 8206.384521160817, 8094.028716554051, 10324.48377581133, 10549.103326217051, 10662.626808061681, 10746.83879741789], "value": 7872.669942248671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.152708374975, 1496.670732438863, 1498.2808252039022, 1501.1368463133697, 1529.3729570875944, 6415.422611964922, 7156.8926466102985, 7395.630218489081, 7669.079710434748, 7676.616169191546, 7428.257174282582, 7603.239676032394, 7692.576908270057, 7777.572233527168, 7803.258690424401, 2192.8574642648255, 2259.6836442898007, 2261.547690461906, 2268.0134141648355, 2270.489139943508, 2163.0590693048493, 2192.7807219278025, 2228.487447886987, 2229.108356657334, 2236.0608544411384, 2220.666899965002, 2227.866328020316, 2234.229190929127, 2239.585676649817, 2271.171022576756, 2052.466358746729, 2053.917843286267, 2057.9812992568623, 2058.6500294949897, 2060.6084843879767, 2161.0815403453626, 2174.804267615922, 2185.2024011235944, 2186.6392045312505, 2192.0574153114153, 7433.628318584049, 7609.201033891417, 7658.042744656918, 7680.38556915451, 7709.691612335556, 4678.157931572316, 4816.8554943351755, 4836.588889944359, 4856.68431551948, 4870.853874383774, 2891.927701807451, 2944.175630823373, 2986.910392688223, 2995.4608170529295, 2996.101169649118, 931.7204838548408, 932.6922115701802, 938.9718308450757, 939.1078475448352, 955.7323949294208, 10240.795184096276, 10450.947745261301, 10473.0, 10488.423136727477, 10525.631602893938, 4301.290287102655, 4335.111302183045, 4365.236083685342, 4392.692511524227, 4392.912141757147, 9137.223336016381, 9168.633254669872, 9171.77070573241, 9210.769730756785, 9222.354435189472, 4733.668643195012, 4793.400824896888, 4798.0, 4798.47216806151, 4826.0830442215865, 3728.757630753992, 4066.837326506966, 4195.035141917315, 4204.600562946515, 4262.744235345827, 3607.4408466687705, 3619.113317237294, 3717.182219911615, 3717.7955212463035, 3739.2521495700967, 1149.977000460003, 1226.2642414551199, 1230.5077968812548, 1238.1518659718122, 1240.0699475393455, 794.1780257433644, 796.7729197178776, 804.3123129724119, 835.8035861572525, 849.0957130655831, 4954.380702412199, 5051.823186188466, 5147.433782283946, 5167.431582525919, 5188.8962220755375, 838.2037064788475, 910.8132832769267, 914.1635403605626, 939.0468674295596, 958.5542722633869, 3549.219171782204, 3617.8552857885916, 3626.3653860574295, 3637.2361804020925, 3694.630536946284, 8691.304695624462, 8996.550172491348, 9005.549722513848, 9037.954810226038, 9056.184943355129, 8869.822603547893, 8906.109389061043, 8985.955070224607, 8996.82006359869, 9027.277817774562, 7166.355028047501, 7395.112586489656, 7407.481476296607, 7410.925890741131, 7442.813929651694, 5069.771860266371, 5109.156989096758, 5165.405978312542, 5166.3025491558155, 5263.815766448156, 8657.091005444337, 8720.520371379635, 8829.293656507336, 8915.331350148635, 8931.106889311277, 8406.915930840612, 8721.65113395457, 8761.824763504821, 8911.866322005304, 9066.50134242623, 5835.095560188178, 6514.088027676224, 6715.664216789239, 6800.795976120724, 6883.174019117738, 7242.203357630551, 7252.601106938958, 7307.232740562377, 7324.853502930018, 7353.926460735324, 6339.429451349401, 6488.708008139551, 6492.805215843532, 6500.642464664489, 6575.112359831362, 6586.604803711793, 6757.425618822455, 6760.763373281911, 6763.0, 6765.42493888025, 6056.36408177135, 6110.938890611037, 6120.479759220516, 6122.663253521099, 6133.080037994337, 4239.851605193803, 4352.368906508602, 4448.377227188132, 4523.11799199153, 4529.501754807035, 4378.781060947003, 4382.693211475166, 4454.910901782011, 4468.874290566222, 4505.954940450553], "value": 4109.968244861316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.1691782939551, 313.5672771575226, 317.7632663665569, 319.0253774718235, 319.157424399585, 4943.184374578194, 4959.330490383797, 4985.127602669528, 4997.975010124945, 5011.22326039464, 4877.268729511476, 4921.212605983043, 4926.5812405945535, 4932.260160975847, 4944.876378090549, 3661.8535258589623, 3785.167263202091, 3870.78710670913, 3892.6885849132, 3893.824777885002, 3864.516935383077, 3888.416737489371, 3888.572257051722, 3893.7274390792654, 3906.7069969752242, 3872.1800753645743, 3890.8443662253476, 3900.941485877714, 3903.512060992376, 3904.12157264616, 3778.5654649715084, 3857.1514266861245, 3889.4943657324648, 3896.454496370496, 3898.434726964588, 3408.84660190292, 3428.0, 3445.4831775233915, 3451.8101504417245, 3466.2374277658873, 4709.788059537329, 4711.623070154379, 4722.787474563653, 4740.478547359788, 4741.5732584067255, 4436.733795972252, 4475.462944446655, 4478.977605111953, 4496.2581174106235, 4499.572540608637, 4935.185694360426, 5137.330367630535, 5192.247124167013, 5196.973180459624, 5210.687358758449, 3652.9634703652887, 3679.3193259247123, 3682.355587772129, 3683.0, 3702.5189924030333, 5414.972925135349, 5438.803463238081, 5448.564114870801, 5470.890582188414, 5473.562115030788, 3655.908602284964, 3801.6008319126645, 3807.4669546263544, 3808.1622043150464, 3817.9529698519104, 3834.8082595870096, 3852.2488114817343, 3859.228154369081, 3862.942055869164, 3862.980685096613, 4392.670549708785, 4405.140997505456, 4410.955890441119, 4421.9336709949375, 4428.6678499112695, 5094.643374963791, 5132.562033034279, 5163.122269214243, 5239.711815850089, 5275.393329767126, 1295.3393769177599, 1296.6628676544167, 1303.12690497367, 1304.4064950447714, 1309.2668105860557, 803.2008151888908, 825.7481468152271, 848.3933987199182, 850.3239924260228, 860.2816648098783, 4401.779911004437, 4483.489246022173, 4489.281714925596, 4542.0915816836105, 4553.225951588238, 5295.814646487354, 5307.177387504943, 5335.253064570963, 5348.705821179795, 5355.598330125256, 4361.06237159006, 4548.977255113769, 4549.135664223787, 4557.680962332605, 4562.178807814559, 2771.1686494051705, 2847.2454799478155, 2851.2871782054485, 2851.2871782054485, 2876.6548014238424, 4942.159832828428, 4966.975165124223, 5053.494650534917, 5054.393472783216, 5059.595232381401, 5222.634415590872, 5466.234727138204, 5525.0, 5540.972295138498, 5541.473560011793, 4965.50344965515, 4978.452370239271, 4985.501449855058, 4986.227134794112, 5003.824101336183, 5322.654027488201, 5329.280547126244, 5331.226972088948, 5341.519263266325, 5352.411234764095, 5032.672876263031, 5254.894902102013, 5272.525472707474, 5296.708681022581, 5299.2316114164005, 4996.825111121093, 5001.299818025406, 5004.874878128076, 5005.674631148963, 5041.462353981924, 3758.361078616587, 3771.41543060826, 3771.9434208486346, 3776.169242766587, 3790.981045094757, 5251.89496210066, 5294.888073504607, 5397.8920421590565, 5398.4614384900115, 5414.431484694051, 5207.453217412117, 5210.0, 5228.37259528859, 5233.293505376725, 5237.397699264481, 5139.871503212449, 5152.346541531189, 5166.0, 5169.715665638426, 5223.843284701465, 4767.0, 5078.162103253069, 5102.872428189325, 5104.438511763628, 5128.076946149728, 5023.648344615988, 5096.311997880239, 5199.596109050611, 5220.190870415092, 5253.658512196695, 5072.28987941681, 5118.795248190031, 5121.667091639031, 5122.820701275437, 5133.22903598258], "value": 3905.997060100313, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6732237815364, 757.6628400361838, 758.821676905927, 770.9151993280739, 771.672039383262, 11311.943440282797, 11976.520939162445, 12009.219400738946, 12015.639530814067, 12026.819597706031, 11725.120615953794, 11838.822417663741, 11911.821322680167, 12584.622461326151, 12881.162724422906, 684.9657517124149, 870.0603348383746, 882.9337799665051, 883.244825674049, 883.3816328569994, 843.5908584336622, 877.2017464107663, 878.5607196401799, 878.8857448531681, 879.2174964281762, 911.6717981526679, 916.4638686368482, 916.5829547555879, 916.9174774270315, 918.1323649151554, 902.5487256371814, 904.5025236120108, 907.8138981508807, 908.0148039377284, 908.1191244492832, 667.546068673302, 667.8597494526156, 670.8188789026935, 672.0691841799095, 673.952823302369, 12402.0, 12462.065345099154, 12521.373931303398, 12529.561465348668, 12557.183783054072, 11218.775624487465, 11338.773224535546, 11809.822852657217, 12010.339431331273, 12383.442745076492, 9048.909510904938, 9537.666181683608, 9574.090461406226, 9787.657431989846, 10024.398536087785, 4069.4302797608357, 4077.673786097105, 4106.7946602670045, 4113.568075352075, 4144.44050053245, 43002.0, 43273.0, 43738.0, 43987.34018989718, 44032.77983610093, 8651.52416617092, 8766.868496972551, 8865.0, 9170.220531254918, 9621.27840411972, 15581.922090389475, 15613.219339033003, 16320.102394368423, 16778.0772057538, 16880.91559542219, 6658.134442522538, 6813.795586132324, 6904.861902761917, 6940.340667636668, 7069.8939515907305, 3543.7696549724187, 3584.390653588896, 3623.438367053111, 3681.650243226889, 3806.5812760596314, 2825.0818483992784, 2852.8288302701903, 2915.344047589318, 2915.9562606560917, 2919.839408832492, 535.2506490912675, 537.0118981074841, 541.6100407706446, 542.956563474921, 544.9100898351728, 518.0183552168619, 551.3686828581332, 620.7330847735427, 644.5069521815815, 649.6102338596899, 8045.764532487369, 8188.836223275501, 8295.12901145371, 8351.540665263346, 8472.237498625153, 509.22851879402737, 558.1432501110776, 583.5302581421996, 610.6397225636807, 623.7816764132517, 3362.613299470543, 3379.1889946412684, 3487.3199726053685, 3489.5986961499752, 3502.264524449894, 48632.27051594229, 50366.748166258934, 50464.49535504598, 51166.48833511692, 51228.743856281224, 44775.0, 45038.54961450409, 45609.315860262126, 45936.3109553357, 47647.52352476431, 40007.19985600272, 40618.0, 41287.587124128375, 41700.0, 41895.0, 6732.528722989344, 6830.897536537055, 7048.942658601046, 7377.446691498052, 7442.96278518604, 27415.45169096567, 28563.714362856936, 28757.99347022844, 28764.424711505235, 28792.424151517273, 34102.65897340995, 35898.0, 36267.0, 36718.8164059178, 36741.63258367489, 10682.145428365557, 10825.61601821356, 10876.45617719095, 11010.834837477605, 11163.0, 11975.0, 12116.394180290774, 12217.877821221675, 12313.0, 12656.557020504239, 10726.141908647445, 10735.194860385345, 10998.0, 11931.940340298243, 11953.22304050234, 10638.73403164896, 10916.181286403711, 10938.890611093788, 11091.944540277247, 11477.081833453136, 11323.547058117912, 11415.315081095161, 11631.185816992729, 11750.94124529372, 12084.75830483403, 9634.951825240829, 9642.325037247325, 9734.610615575297, 9843.409395436296, 9953.502324883872, 9761.9023809761, 9976.750581235527, 10078.244131690299, 10078.596856125672, 10134.23993200498], "value": 5964.226273841096, "unit": "score"}], "name": "dromaeo_css", "value": 6314.413861701605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 107.0, 113.0, 116.0, 114.0, 108.0, 115.0, 114.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 134.0, 157.0, 211.0, 132.0, 163.0, 162.0, 133.0, 184.0, 139.0], "value": 156.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 169.0, 162.0, 163.0, 164.0, 166.0, 162.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 165.0, 84.0, 77.0, 78.0, 77.0, 164.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 168.0, 93.0, 92.0, 92.0, 138.0, 100.0, 94.0, 148.0], "value": 111.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 120.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 74.0, 70.0, 70.0, 67.0, 68.0, 68.0, 67.0], "value": 68.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 82.0, 84.0, 83.0, 89.0, 83.0, 84.0, 144.0, 84.0], "value": 90.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 134.0, 160.0, 141.0, 135.0, 142.0, 145.0, 165.0, 151.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 178.0, 177.0, 180.0, 176.0, 178.0, 181.0, 175.0, 181.0], "value": 177.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 69.0, 72.0, 72.0, 72.0, 71.0, 69.0, 70.0, 68.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1618.5, "alertThreshold": 2.0}]} 05:41:01 INFO - Return code: 0 05:41:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:41:01 ERROR - # TBPL SUCCESS # 05:41:01 INFO - Running post-action listener: _resource_record_post_action 05:41:01 INFO - ##### 05:41:01 INFO - ##### Finished run-tests step (success) 05:41:01 INFO - ##### 05:41:01 INFO - Running post-run listener: _resource_record_post_run 05:41:03 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 415330304; Read time: 16; Write time: 265980 05:41:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 120406016; Read time: 0; Write time: 81332 05:41:03 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294924288; Read time: 16; Write time: 184648 05:41:03 INFO - Running post-run listener: _upload_blobber_files 05:41:03 INFO - Blob upload gear active. 05:41:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:03 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 05:41:03 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:03 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:41:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:04 INFO - (blobuploader) - INFO - Done attempting. 05:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:04 INFO - (blobuploader) - INFO - Done attempting. 05:41:04 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:04 INFO - Return code: 0 05:41:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/916086b435086dfc91c0a12780d1e1ad373784f3b951b5593f8e667720cc1eb243e8c445887214b8f8355bbbb70fc6932ca988fd59d9864fe83a388ecff72441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c56fce26c1fb2b183592ab18a0fb16ebda179301c2a829bebb622e880c47b7085a975b8ec3a22af03009c331dd672131b57baf83cc0c3ada70cf8e25f5eb62c4"} 05:41:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:04 INFO - Contents: 05:41:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/916086b435086dfc91c0a12780d1e1ad373784f3b951b5593f8e667720cc1eb243e8c445887214b8f8355bbbb70fc6932ca988fd59d9864fe83a388ecff72441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c56fce26c1fb2b183592ab18a0fb16ebda179301c2a829bebb622e880c47b7085a975b8ec3a22af03009c331dd672131b57baf83cc0c3ada70cf8e25f5eb62c4"} 05:41:04 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:04 INFO - Copying logs to upload dir... 05:41:04 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.645874 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-05-10 05:41:04.997732) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:41:05.000887) ========= 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=00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/916086b435086dfc91c0a12780d1e1ad373784f3b951b5593f8e667720cc1eb243e8c445887214b8f8355bbbb70fc6932ca988fd59d9864fe83a388ecff72441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c56fce26c1fb2b183592ab18a0fb16ebda179301c2a829bebb622e880c47b7085a975b8ec3a22af03009c331dd672131b57baf83cc0c3ada70cf8e25f5eb62c4"} build_url:https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011200 build_url: 'https://queue.taskcluster.net/v1/task/Tz5jkv4sQ6ClzIH-EZSunw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/916086b435086dfc91c0a12780d1e1ad373784f3b951b5593f8e667720cc1eb243e8c445887214b8f8355bbbb70fc6932ca988fd59d9864fe83a388ecff72441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c56fce26c1fb2b183592ab18a0fb16ebda179301c2a829bebb622e880c47b7085a975b8ec3a22af03009c331dd672131b57baf83cc0c3ada70cf8e25f5eb62c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:41:05.025390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:41:05.025745) ========= 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=00204705a9daa57ed339a427000001b9-1462882825.763887-1558505455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:41:05.113830) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:41:05.114526) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:41:05.115144) ========= ========= Total master_lag: 0.19 =========