builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1461978156.16 results: success (0) buildid: 20160429172135 builduid: fafd1f9ae6544e29a465af53fdf4d328 revision: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.164089) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.164509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.164834) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.200374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.200687) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 18:02:37-- 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% 84.6K=0.1s 2016-04-29 18:02:37 (84.6 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220903 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.448189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.448540) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013853 ========= master_lag: 0.10 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.566294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:36.566655) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b7b5c87cf2b319aa751a5903f42ee2e5883749a --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 3b7b5c87cf2b319aa751a5903f42ee2e5883749a --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=6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 18:02:37,672 truncating revision to first 12 chars 2016-04-29 18:02:37,672 Setting DEBUG logging. 2016-04-29 18:02:37,672 attempt 1/10 2016-04-29 18:02:37,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b7b5c87cf2b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 18:02:37,939 unpacking tar archive at: fx-team-3b7b5c87cf2b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571515 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.157002) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.157316) ========= script_repo_revision: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.157761) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.158068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 18:02:37.166051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-29 18:02:37.166363) ========= /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=6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:02:38 INFO - MultiFileLogger online at 20160429 18:02:38 in /builds/slave/test 18:02:38 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 18:02:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:02:38 INFO - {'append_to_log': False, 18:02:38 INFO - 'base_work_dir': '/builds/slave/test', 18:02:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:02:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:02:38 INFO - 'branch': 'Fx-Team-Non-PGO', 18:02:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:02:38 INFO - 'config_files': ('talos/linux_config.py',), 18:02:38 INFO - 'default_actions': ('clobber', 18:02:38 INFO - 'read-buildbot-config', 18:02:38 INFO - 'download-and-extract', 18:02:38 INFO - 'populate-webroot', 18:02:38 INFO - 'create-virtualenv', 18:02:38 INFO - 'install', 18:02:38 INFO - 'run-tests'), 18:02:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:02:38 INFO - 'download_minidump_stackwalk': True, 18:02:38 INFO - 'download_symbols': 'ondemand', 18:02:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:02:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:02:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:02:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:02:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:02:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:02:38 INFO - 'installer_path': 'installer.exe', 18:02:38 INFO - 'log_level': 'info', 18:02:38 INFO - 'log_name': 'talos', 18:02:38 INFO - 'log_to_console': True, 18:02:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:02:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:02:38 INFO - 'opt_config_files': (), 18:02:38 INFO - 'pip_index': False, 18:02:38 INFO - 'sps_profile': False, 18:02:38 INFO - 'sps_profile_interval': 0, 18:02:38 INFO - 'suite': 'dromaeojs-e10s', 18:02:38 INFO - 'system_bits': '32', 18:02:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:02:38 INFO - 'title': 'talos-linux64-ix-023', 18:02:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:02:38 INFO - 'use_talos_json': True, 18:02:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:02:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:02:38 INFO - 'work_dir': 'build'} 18:02:38 INFO - ##### 18:02:38 INFO - ##### Running clobber step. 18:02:38 INFO - ##### 18:02:38 INFO - Running pre-action listener: _resource_record_pre_action 18:02:38 INFO - Running main action method: clobber 18:02:38 INFO - rmtree: /builds/slave/test/build 18:02:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:02:39 INFO - Running post-action listener: _resource_record_post_action 18:02:39 INFO - ##### 18:02:39 INFO - ##### Running read-buildbot-config step. 18:02:39 INFO - ##### 18:02:39 INFO - Running pre-action listener: _resource_record_pre_action 18:02:39 INFO - Running main action method: read_buildbot_config 18:02:39 INFO - Using buildbot properties: 18:02:39 INFO - { 18:02:39 INFO - "project": "", 18:02:39 INFO - "product": "firefox", 18:02:39 INFO - "script_repo_revision": "production", 18:02:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:02:39 INFO - "repository": "", 18:02:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:02:39 INFO - "buildid": "20160429172135", 18:02:39 INFO - "pgo_build": "False", 18:02:39 INFO - "basedir": "/builds/slave/test", 18:02:39 INFO - "buildnumber": 1223, 18:02:39 INFO - "slavename": "talos-linux64-ix-023", 18:02:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:02:39 INFO - "platform": "ubuntu64_hw", 18:02:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:02:39 INFO - "branch": "fx-team", 18:02:39 INFO - "repo_path": "integration/fx-team", 18:02:39 INFO - "revision": "3b7b5c87cf2b319aa751a5903f42ee2e5883749a", 18:02:39 INFO - "stage_platform": "linux64", 18:02:39 INFO - "builduid": "fafd1f9ae6544e29a465af53fdf4d328", 18:02:39 INFO - "slavebuilddir": "test" 18:02:39 INFO - } 18:02:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:02:39 INFO - Running post-action listener: _resource_record_post_action 18:02:39 INFO - ##### 18:02:39 INFO - ##### Running download-and-extract step. 18:02:39 INFO - ##### 18:02:39 INFO - Running pre-action listener: _resource_record_pre_action 18:02:39 INFO - Running main action method: download_and_extract 18:02:39 INFO - mkdir: /builds/slave/test/build/tests 18:02:39 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')]} 18:02:39 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:02:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:02:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:02:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:44 INFO - Downloaded 1361 bytes. 18:02:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:02:44 INFO - Using the following test package requirements: 18:02:44 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:02:44 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:02:44 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:02:44 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'jsshell-linux-x86_64.zip'], 18:02:44 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:02:44 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:02:44 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:02:44 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:02:44 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:02:44 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:02:44 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:02:44 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:02: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')]} 18:02:44 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:48 INFO - Downloaded 22304506 bytes. 18:02:48 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'] 18:02:48 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 18:02:50 INFO - Return code: 0 18:02:50 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 18:02: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')]} 18:02:50 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:02:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:02:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:02:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:03:02 INFO - Downloaded 22304506 bytes. 18:03:02 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'] 18:03:02 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 18:03:04 INFO - Return code: 0 18:03:04 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')]} 18:03:04 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:03:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:03:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:03:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:03:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:03:07 INFO - Downloaded 10840152 bytes. 18:03:07 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'] 18:03:07 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 18:03:08 INFO - Return code: 0 18:03:08 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')]} 18:03:08 INFO - https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:03:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:03:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:03:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:03:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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 18:03:51 INFO - Downloaded 54918257 bytes. 18:03:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:03:51 INFO - mkdir: /builds/slave/test/properties 18:03:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:03:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:03:51 INFO - Contents: 18:03:51 INFO - build_url:https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:03:52 INFO - Running post-action listener: _resource_record_post_action 18:03:52 INFO - Running post-action listener: set_extra_try_arguments 18:03:52 INFO - ##### 18:03:52 INFO - ##### Running populate-webroot step. 18:03:52 INFO - ##### 18:03:52 INFO - Running pre-action listener: _resource_record_pre_action 18:03:52 INFO - Running main action method: populate_webroot 18:03:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:03:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:03:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:03:52 INFO - '--tppagecycles', 18:03:52 INFO - '7'], 18:03:52 INFO - 'tests': ['tsvgm']}}, 18:03:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:03:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:03:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:03:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:03:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:03:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:03:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['damp', 'tps']}, 18:03:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'tests': ['damp', 'tps']}, 18:03:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['dromaeo_dom']}, 18:03:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:03:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['a11yr', 18:03:52 INFO - 'ts_paint', 18:03:52 INFO - 'tpaint', 18:03:52 INFO - 'sessionrestore', 18:03:52 INFO - 'sessionrestore_no_auto_restore', 18:03:52 INFO - 'tabpaint']}, 18:03:52 INFO - 'other-e10s': {'tests': ['a11yr', 18:03:52 INFO - 'ts_paint', 18:03:52 INFO - 'tpaint', 18:03:52 INFO - 'sessionrestore', 18:03:52 INFO - 'sessionrestore_no_auto_restore', 18:03:52 INFO - 'tabpaint']}, 18:03:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:03:52 INFO - 'ts_paint', 18:03:52 INFO - 'tpaint', 18:03:52 INFO - 'sessionrestore', 18:03:52 INFO - 'sessionrestore_no_auto_restore', 18:03:52 INFO - 'tabpaint']}, 18:03:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:03:52 INFO - 'ts_paint', 18:03:52 INFO - 'tpaint', 18:03:52 INFO - 'sessionrestore', 18:03:52 INFO - 'sessionrestore_no_auto_restore', 18:03:52 INFO - 'tabpaint']}, 18:03:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['a11yr', 18:03:52 INFO - 'ts_paint', 18:03:52 INFO - 'tpaint', 18:03:52 INFO - 'sessionrestore', 18:03:52 INFO - 'sessionrestore_no_auto_restore', 18:03:52 INFO - 'tabpaint']}, 18:03:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['a11yr', 18:03:52 INFO - 'ts_paint', 18:03:52 INFO - 'tpaint', 18:03:52 INFO - 'sessionrestore', 18:03:52 INFO - 'sessionrestore_no_auto_restore', 18:03:52 INFO - 'tabpaint']}, 18:03:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['tsvgx', 18:03:52 INFO - 'tsvgr_opacity', 18:03:52 INFO - 'tart', 18:03:52 INFO - 'tscrollx', 18:03:52 INFO - 'cart']}, 18:03:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:03:52 INFO - 'tsvgr_opacity', 18:03:52 INFO - 'tart', 18:03:52 INFO - 'tscrollx', 18:03:52 INFO - 'cart']}, 18:03:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'talos_options': ['--disable-e10s'], 18:03:52 INFO - 'tests': ['tp5o']}, 18:03:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'tests': ['tp5o']}, 18:03:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'talos_options': ['--disable-e10s', 18:03:52 INFO - '--xperf_path', 18:03:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:03:52 INFO - 'tests': ['tp5n']}, 18:03:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:03:52 INFO - 'talos_options': ['--xperf_path', 18:03:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:03:52 INFO - 'tests': ['tp5n']}}, 18:03:52 INFO - 'talos.zip': {'path': '', 18:03:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:03:52 INFO - Running post-action listener: _resource_record_post_action 18:03:52 INFO - ##### 18:03:52 INFO - ##### Running create-virtualenv step. 18:03:52 INFO - ##### 18:03:52 INFO - Running pre-action listener: _resource_record_pre_action 18:03:52 INFO - Running main action method: create_virtualenv 18:03:52 INFO - Creating virtualenv /builds/slave/test/build/venv 18:03:52 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 18:03:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:03:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:03:53 INFO - Using real prefix '/usr' 18:03:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:03:53 INFO - Installing distribute.............................................................................................................................................................................................done. 18:03:55 INFO - Installing pip.................done. 18:03:55 INFO - Return code: 0 18:03:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:03:55 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')]} 18:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:55 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')]} 18:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:55 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:03:55 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 18:03:55 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 18:03:55 INFO - Using env: {'DISPLAY': ':0', 18:03:55 INFO - 'HOME': '/home/cltbld', 18:03:55 INFO - 'LANG': 'en_US.UTF-8', 18:03:55 INFO - 'LANGUAGE': 'en_US:en', 18:03:55 INFO - 'LOGNAME': 'cltbld', 18:03:55 INFO - 'MAIL': '/var/mail/cltbld', 18:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:55 INFO - 'MOZ_NO_REMOTE': '1', 18:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:55 INFO - 'NO_EM_RESTART': '1', 18:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:55 INFO - 'PWD': '/builds/slave/test', 18:03:55 INFO - 'SHELL': '/bin/bash', 18:03:55 INFO - 'SHLVL': '1', 18:03:55 INFO - 'TERM': 'linux', 18:03:55 INFO - 'TMOUT': '86400', 18:03:55 INFO - 'USER': 'cltbld', 18:03:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:55 INFO - '_': '/tools/buildbot/bin/python'} 18:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:55 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 18:03:55 INFO - Cleaning up... 18:03:55 INFO - Return code: 0 18:03:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:03:55 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')]} 18:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:55 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')]} 18:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:55 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:03:55 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 18:03:55 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 18:03:55 INFO - Using env: {'DISPLAY': ':0', 18:03:55 INFO - 'HOME': '/home/cltbld', 18:03:55 INFO - 'LANG': 'en_US.UTF-8', 18:03:55 INFO - 'LANGUAGE': 'en_US:en', 18:03:55 INFO - 'LOGNAME': 'cltbld', 18:03:55 INFO - 'MAIL': '/var/mail/cltbld', 18:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:55 INFO - 'MOZ_NO_REMOTE': '1', 18:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:55 INFO - 'NO_EM_RESTART': '1', 18:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:55 INFO - 'PWD': '/builds/slave/test', 18:03:55 INFO - 'SHELL': '/bin/bash', 18:03:55 INFO - 'SHLVL': '1', 18:03:55 INFO - 'TERM': 'linux', 18:03:55 INFO - 'TMOUT': '86400', 18:03:55 INFO - 'USER': 'cltbld', 18:03:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:55 INFO - '_': '/tools/buildbot/bin/python'} 18:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:55 INFO - Downloading/unpacking psutil>=0.7.1 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:03:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:03:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:03:57 INFO - Installing collected packages: psutil 18:03:57 INFO - Running setup.py install for psutil 18:03:57 INFO - building 'psutil._psutil_linux' extension 18:03:57 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 18:03:58 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 18:03:58 INFO - building 'psutil._psutil_posix' extension 18:03:58 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 18:03:58 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 18:03:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:03:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:03:58 INFO - Successfully installed psutil 18:03:58 INFO - Cleaning up... 18:03:58 INFO - Return code: 0 18:03:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:03:58 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')]} 18:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:58 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')]} 18:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:03:58 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:03:58 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 18:03:58 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 18:03:58 INFO - Using env: {'DISPLAY': ':0', 18:03:58 INFO - 'HOME': '/home/cltbld', 18:03:58 INFO - 'LANG': 'en_US.UTF-8', 18:03:58 INFO - 'LANGUAGE': 'en_US:en', 18:03:58 INFO - 'LOGNAME': 'cltbld', 18:03:58 INFO - 'MAIL': '/var/mail/cltbld', 18:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:03:58 INFO - 'MOZ_NO_REMOTE': '1', 18:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:03:58 INFO - 'NO_EM_RESTART': '1', 18:03:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:03:58 INFO - 'PWD': '/builds/slave/test', 18:03:58 INFO - 'SHELL': '/bin/bash', 18:03:58 INFO - 'SHLVL': '1', 18:03:58 INFO - 'TERM': 'linux', 18:03:58 INFO - 'TMOUT': '86400', 18:03:58 INFO - 'USER': 'cltbld', 18:03:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:03:58 INFO - '_': '/tools/buildbot/bin/python'} 18:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:03:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:03: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 18:04:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:04:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:04:00 INFO - Installing collected packages: mozsystemmonitor 18:04:00 INFO - Running setup.py install for mozsystemmonitor 18:04:00 INFO - Successfully installed mozsystemmonitor 18:04:00 INFO - Cleaning up... 18:04:00 INFO - Return code: 0 18:04:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:04: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')]} 18:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04: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')]} 18:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04: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', '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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:04: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:04: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 blobuploader==1.2.4 18:04:00 INFO - Using env: {'DISPLAY': ':0', 18:04:00 INFO - 'HOME': '/home/cltbld', 18:04:00 INFO - 'LANG': 'en_US.UTF-8', 18:04:00 INFO - 'LANGUAGE': 'en_US:en', 18:04:00 INFO - 'LOGNAME': 'cltbld', 18:04:00 INFO - 'MAIL': '/var/mail/cltbld', 18:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:00 INFO - 'MOZ_NO_REMOTE': '1', 18:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:00 INFO - 'NO_EM_RESTART': '1', 18:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:00 INFO - 'PWD': '/builds/slave/test', 18:04:00 INFO - 'SHELL': '/bin/bash', 18:04:00 INFO - 'SHLVL': '1', 18:04:00 INFO - 'TERM': 'linux', 18:04:00 INFO - 'TMOUT': '86400', 18:04:00 INFO - 'USER': 'cltbld', 18:04:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:00 INFO - '_': '/tools/buildbot/bin/python'} 18:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:00 INFO - Downloading/unpacking blobuploader==1.2.4 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04:02 INFO - Downloading blobuploader-1.2.4.tar.gz 18:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:04:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:04:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04: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 18:04:03 INFO - Downloading docopt-0.6.1.tar.gz 18:04:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:04:03 INFO - Installing collected packages: blobuploader, requests, docopt 18:04:03 INFO - Running setup.py install for blobuploader 18:04:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:04:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:04:03 INFO - Running setup.py install for requests 18:04:03 INFO - Running setup.py install for docopt 18:04:04 INFO - Successfully installed blobuploader requests docopt 18:04:04 INFO - Cleaning up... 18:04:04 INFO - Return code: 0 18:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:04 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')]} 18:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:04 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')]} 18:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:04 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:04:04 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 18:04:04 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 18:04:04 INFO - Using env: {'DISPLAY': ':0', 18:04:04 INFO - 'HOME': '/home/cltbld', 18:04:04 INFO - 'LANG': 'en_US.UTF-8', 18:04:04 INFO - 'LANGUAGE': 'en_US:en', 18:04:04 INFO - 'LOGNAME': 'cltbld', 18:04:04 INFO - 'MAIL': '/var/mail/cltbld', 18:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:04 INFO - 'MOZ_NO_REMOTE': '1', 18:04:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:04 INFO - 'NO_EM_RESTART': '1', 18:04:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:04 INFO - 'PWD': '/builds/slave/test', 18:04:04 INFO - 'SHELL': '/bin/bash', 18:04:04 INFO - 'SHLVL': '1', 18:04:04 INFO - 'TERM': 'linux', 18:04:04 INFO - 'TMOUT': '86400', 18:04:04 INFO - 'USER': 'cltbld', 18:04:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:04 INFO - '_': '/tools/buildbot/bin/python'} 18:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:04 INFO - Running setup.py (path:/tmp/pip-Pan_Mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:04 INFO - Running setup.py (path:/tmp/pip-0EISlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:04 INFO - Running setup.py (path:/tmp/pip-r6qr6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:04 INFO - Running setup.py (path:/tmp/pip-l3snFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:04 INFO - Running setup.py (path:/tmp/pip-WkWFsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:04 INFO - Running setup.py (path:/tmp/pip-yWEx0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:04 INFO - Running setup.py (path:/tmp/pip-VK25ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:04 INFO - Running setup.py (path:/tmp/pip-4AJx0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:04 INFO - Running setup.py (path:/tmp/pip-SbTvbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:04 INFO - Running setup.py (path:/tmp/pip-lnTRSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:05 INFO - Running setup.py (path:/tmp/pip-fy7FR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:05 INFO - Running setup.py (path:/tmp/pip-I1Eomo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:05 INFO - Running setup.py (path:/tmp/pip-4lmfWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:05 INFO - Running setup.py (path:/tmp/pip-RdlFTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:05 INFO - Running setup.py (path:/tmp/pip-KJYTrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:05 INFO - Running setup.py (path:/tmp/pip-oN7uJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:05 INFO - Running setup.py (path:/tmp/pip-gUFJHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:04:05 INFO - Running setup.py install for manifestparser 18:04:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:04:05 INFO - Running setup.py install for mozcrash 18:04:05 INFO - Running setup.py install for mozdebug 18:04:05 INFO - Running setup.py install for mozdevice 18:04:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:04:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:04:05 INFO - Running setup.py install for mozfile 18:04:06 INFO - Running setup.py install for mozhttpd 18:04:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Running setup.py install for mozinfo 18:04:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Running setup.py install for mozInstall 18:04:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Running setup.py install for mozleak 18:04:06 INFO - Running setup.py install for mozlog 18:04:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Running setup.py install for moznetwork 18:04:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Running setup.py install for mozprocess 18:04:06 INFO - Running setup.py install for mozprofile 18:04:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Running setup.py install for mozrunner 18:04:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:04:06 INFO - Running setup.py install for mozscreenshot 18:04:07 INFO - Running setup.py install for moztest 18:04:07 INFO - Running setup.py install for mozversion 18:04:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:04:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:04:07 INFO - Cleaning up... 18:04:07 INFO - Return code: 0 18:04:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:07 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')]} 18:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:07 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')]} 18:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:07 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:04:07 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 18:04:07 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 18:04:07 INFO - Using env: {'DISPLAY': ':0', 18:04:07 INFO - 'HOME': '/home/cltbld', 18:04:07 INFO - 'LANG': 'en_US.UTF-8', 18:04:07 INFO - 'LANGUAGE': 'en_US:en', 18:04:07 INFO - 'LOGNAME': 'cltbld', 18:04:07 INFO - 'MAIL': '/var/mail/cltbld', 18:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:07 INFO - 'MOZ_NO_REMOTE': '1', 18:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:07 INFO - 'NO_EM_RESTART': '1', 18:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:07 INFO - 'PWD': '/builds/slave/test', 18:04:07 INFO - 'SHELL': '/bin/bash', 18:04:07 INFO - 'SHLVL': '1', 18:04:07 INFO - 'TERM': 'linux', 18:04:07 INFO - 'TMOUT': '86400', 18:04:07 INFO - 'USER': 'cltbld', 18:04:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:07 INFO - '_': '/tools/buildbot/bin/python'} 18:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:04:07 INFO - Running setup.py (path:/tmp/pip-Us38CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:04:07 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)) 18:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:04:07 INFO - Running setup.py (path:/tmp/pip-lvgEbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:04:07 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)) 18:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:04:07 INFO - Running setup.py (path:/tmp/pip-5mTy9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:04:07 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)) 18:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:04:07 INFO - Running setup.py (path:/tmp/pip-qcJDkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:04:07 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)) 18:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:04:07 INFO - Running setup.py (path:/tmp/pip-uIiCHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:04:07 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)) 18:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:04:07 INFO - Running setup.py (path:/tmp/pip-UfQh7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:04:07 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)) 18:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:04:07 INFO - Running setup.py (path:/tmp/pip-enFEh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:04:08 INFO - Running setup.py (path:/tmp/pip-CmIsTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:04:08 INFO - Running setup.py (path:/tmp/pip-YLuLud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:04:08 INFO - Running setup.py (path:/tmp/pip-BpJl6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:04:08 INFO - Running setup.py (path:/tmp/pip-EgQgWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:04:08 INFO - Running setup.py (path:/tmp/pip-dk1JuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:04:08 INFO - Running setup.py (path:/tmp/pip-9yR6GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:04:08 INFO - Running setup.py (path:/tmp/pip-gdKpwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:08 INFO - Running setup.py (path:/tmp/pip-949Nzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:04:08 INFO - Running setup.py (path:/tmp/pip-5NXPOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:04:08 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)) 18:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:04:08 INFO - Running setup.py (path:/tmp/pip-kXyGMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:04:08 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)) 18:04:08 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)) 18:04:08 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)) 18:04:08 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)) 18:04:08 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)) 18:04:08 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)) 18:04:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:04:08 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 18:04:08 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 18:04:08 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 18:04:08 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 18:04:08 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 18:04:08 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 18:04:10 INFO - Downloading blessings-1.6.tar.gz 18:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:04:10 INFO - Installing collected packages: blessings 18:04:10 INFO - Running setup.py install for blessings 18:04:10 INFO - Successfully installed blessings 18:04:10 INFO - Cleaning up... 18:04:10 INFO - Return code: 0 18:04:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:04:11 INFO - Reading from file tmpfile_stdout 18:04:11 INFO - Current package versions: 18:04:11 INFO - argparse == 1.2.1 18:04:11 INFO - blessings == 1.6 18:04:11 INFO - blobuploader == 1.2.4 18:04:11 INFO - docopt == 0.6.1 18:04:11 INFO - manifestparser == 1.1 18:04:11 INFO - mozInstall == 1.12 18:04:11 INFO - mozcrash == 0.17 18:04:11 INFO - mozdebug == 0.1 18:04:11 INFO - mozdevice == 0.48 18:04:11 INFO - mozfile == 1.2 18:04:11 INFO - mozhttpd == 0.7 18:04:11 INFO - mozinfo == 0.9 18:04:11 INFO - mozleak == 0.1 18:04:11 INFO - mozlog == 3.1 18:04:11 INFO - moznetwork == 0.27 18:04:11 INFO - mozprocess == 0.22 18:04:11 INFO - mozprofile == 0.28 18:04:11 INFO - mozrunner == 6.11 18:04:11 INFO - mozscreenshot == 0.1 18:04:11 INFO - mozsystemmonitor == 0.0 18:04:11 INFO - moztest == 0.7 18:04:11 INFO - mozversion == 1.4 18:04:11 INFO - psutil == 3.1.1 18:04:11 INFO - requests == 1.2.3 18:04:11 INFO - wsgiref == 0.1.2 18:04:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:04:11 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')]} 18:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 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')]} 18:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:04:11 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 18:04:11 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 18:04:11 INFO - Using env: {'DISPLAY': ':0', 18:04:11 INFO - 'HOME': '/home/cltbld', 18:04:11 INFO - 'LANG': 'en_US.UTF-8', 18:04:11 INFO - 'LANGUAGE': 'en_US:en', 18:04:11 INFO - 'LOGNAME': 'cltbld', 18:04:11 INFO - 'MAIL': '/var/mail/cltbld', 18:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:11 INFO - 'MOZ_NO_REMOTE': '1', 18:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:11 INFO - 'NO_EM_RESTART': '1', 18:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:11 INFO - 'PWD': '/builds/slave/test', 18:04:11 INFO - 'SHELL': '/bin/bash', 18:04:11 INFO - 'SHLVL': '1', 18:04:11 INFO - 'TERM': 'linux', 18:04:11 INFO - 'TMOUT': '86400', 18:04:11 INFO - 'USER': 'cltbld', 18:04:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:11 INFO - '_': '/tools/buildbot/bin/python'} 18:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 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)) 18:04:11 INFO - Cleaning up... 18:04:11 INFO - Return code: 0 18:04:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:04:11 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')]} 18:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 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')]} 18:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:11 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:04:11 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 18:04:11 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 18:04:11 INFO - Using env: {'DISPLAY': ':0', 18:04:11 INFO - 'HOME': '/home/cltbld', 18:04:11 INFO - 'LANG': 'en_US.UTF-8', 18:04:11 INFO - 'LANGUAGE': 'en_US:en', 18:04:11 INFO - 'LOGNAME': 'cltbld', 18:04:11 INFO - 'MAIL': '/var/mail/cltbld', 18:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:11 INFO - 'MOZ_NO_REMOTE': '1', 18:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:11 INFO - 'NO_EM_RESTART': '1', 18:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:11 INFO - 'PWD': '/builds/slave/test', 18:04:11 INFO - 'SHELL': '/bin/bash', 18:04:11 INFO - 'SHLVL': '1', 18:04:11 INFO - 'TERM': 'linux', 18:04:11 INFO - 'TMOUT': '86400', 18:04:11 INFO - 'USER': 'cltbld', 18:04:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:11 INFO - '_': '/tools/buildbot/bin/python'} 18:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:11 INFO - Downloading/unpacking jsonschema 18:04:11 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 18:04:11 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 18:04:11 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 18:04:11 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 18:04:11 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 18:04:11 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 18:04:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:04:13 INFO - Downloading/unpacking functools32 (from jsonschema) 18:04:13 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 18:04:13 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 18:04:13 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 18:04:13 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 18:04:13 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 18:04:13 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 18:04:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:04:13 INFO - warning: no files found matching '*.txt' 18:04:13 INFO - no previously-included directories found matching 'build' 18:04:13 INFO - no previously-included directories found matching 'dist' 18:04:13 INFO - no previously-included directories found matching '.git*' 18:04:13 INFO - Installing collected packages: jsonschema, functools32 18:04:13 INFO - Running setup.py install for functools32 18:04:13 INFO - warning: no files found matching '*.txt' 18:04:13 INFO - no previously-included directories found matching 'build' 18:04:13 INFO - no previously-included directories found matching 'dist' 18:04:13 INFO - no previously-included directories found matching '.git*' 18:04:13 INFO - Successfully installed jsonschema functools32 18:04:13 INFO - Cleaning up... 18:04:13 INFO - Return code: 0 18:04:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:04:13 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')]} 18:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:13 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')]} 18:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:04:13 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 0x7fd60fc13f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b4e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c195a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, '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': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', '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 18:04:13 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 18:04:13 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 18:04:13 INFO - Using env: {'DISPLAY': ':0', 18:04:13 INFO - 'HOME': '/home/cltbld', 18:04:13 INFO - 'LANG': 'en_US.UTF-8', 18:04:13 INFO - 'LANGUAGE': 'en_US:en', 18:04:13 INFO - 'LOGNAME': 'cltbld', 18:04:13 INFO - 'MAIL': '/var/mail/cltbld', 18:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:13 INFO - 'MOZ_NO_REMOTE': '1', 18:04:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:13 INFO - 'NO_EM_RESTART': '1', 18:04:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:13 INFO - 'PWD': '/builds/slave/test', 18:04:13 INFO - 'SHELL': '/bin/bash', 18:04:13 INFO - 'SHLVL': '1', 18:04:13 INFO - 'TERM': 'linux', 18:04:13 INFO - 'TMOUT': '86400', 18:04:13 INFO - 'USER': 'cltbld', 18:04:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:13 INFO - '_': '/tools/buildbot/bin/python'} 18:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:04:14 INFO - Downloading/unpacking flake8 18:04:14 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 18:04:14 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 18:04:14 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 18:04:14 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 18:04:14 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 18:04:14 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 18:04:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:04:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:04:15 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 18:04:15 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 18:04:15 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 18:04:15 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 18:04:15 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 18:04:15 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 18:04:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:04:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 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 18:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:04:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:04:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:04:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:04:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:04:16 INFO - no previously-included directories found matching 'docs/_build' 18:04:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:04:16 INFO - Running setup.py install for pep8 18:04:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:04:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:04:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:04:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:04:16 INFO - no previously-included directories found matching 'docs/_build' 18:04:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:04:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:04:16 INFO - Cleaning up... 18:04:16 INFO - Return code: 0 18:04:16 INFO - Running post-action listener: _resource_record_post_action 18:04:16 INFO - Running post-action listener: _start_resource_monitoring 18:04:16 INFO - Starting resource monitoring. 18:04:16 INFO - ##### 18:04:16 INFO - ##### Running install step. 18:04:16 INFO - ##### 18:04:16 INFO - Running pre-action listener: _resource_record_pre_action 18:04:16 INFO - Running main action method: install 18:04:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:04:17 INFO - Reading from file tmpfile_stdout 18:04:17 INFO - Detecting whether we're running mozinstall >=1.0... 18:04:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:04:17 INFO - Reading from file tmpfile_stdout 18:04:17 INFO - Output received: 18:04:17 INFO - Usage: mozinstall [options] installer 18:04:17 INFO - Options: 18:04:17 INFO - -h, --help show this help message and exit 18:04:17 INFO - -d DEST, --destination=DEST 18:04:17 INFO - Directory to install application into. [default: 18:04:17 INFO - "/builds/slave/test"] 18:04:17 INFO - --app=APP Application being installed. [default: firefox] 18:04:17 INFO - mkdir: /builds/slave/test/build/application 18:04:17 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'] 18:04:17 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 18:04:33 INFO - Reading from file tmpfile_stdout 18:04:33 INFO - Output received: 18:04:33 INFO - /builds/slave/test/build/application/firefox/firefox 18:04:33 INFO - Running post-action listener: _resource_record_post_action 18:04:33 INFO - ##### 18:04:33 INFO - ##### Running run-tests step. 18:04:33 INFO - ##### 18:04:33 INFO - Running pre-action listener: _resource_record_pre_action 18:04:33 INFO - Running main action method: run_tests 18:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:04:33 INFO - Python 2.7.3 18:04:33 INFO - Return code: 0 18:04:33 INFO - grabbing minidump binary from tooltool 18:04: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')]} 18:04:33 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 0x2ca8410>, '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 0x2ca9310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ca97a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:04:33 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 18:04:33 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 18:04:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:04:33 INFO - Return code: 0 18:04:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:04:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:04:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:04:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:04:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:04:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:04:34 INFO - Return code: 0 18:04:34 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/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:04:34 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/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:04:34 INFO - Using env: {'DISPLAY': ':0', 18:04:34 INFO - 'HOME': '/home/cltbld', 18:04:34 INFO - 'LANG': 'en_US.UTF-8', 18:04:34 INFO - 'LANGUAGE': 'en_US:en', 18:04:34 INFO - 'LOGNAME': 'cltbld', 18:04:34 INFO - 'MAIL': '/var/mail/cltbld', 18:04:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:04:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:04:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:04:34 INFO - 'MOZ_NO_REMOTE': '1', 18:04:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:04:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:04:34 INFO - 'NO_EM_RESTART': '1', 18:04:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:04:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:04:34 INFO - 'PWD': '/builds/slave/test', 18:04:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:04:34 INFO - 'SHELL': '/bin/bash', 18:04:34 INFO - 'SHLVL': '1', 18:04:34 INFO - 'TERM': 'linux', 18:04:34 INFO - 'TMOUT': '86400', 18:04:34 INFO - 'USER': 'cltbld', 18:04:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591', 18:04:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:04:34 INFO - '_': '/tools/buildbot/bin/python'} 18:04:34 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/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:04:34 INFO - mozversion application_buildid: 20160429172135 18:04:34 INFO - mozversion application_changeset: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a 18:04:34 INFO - mozversion application_display_name: Nightly 18:04:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:04:34 INFO - mozversion application_name: Firefox 18:04:34 INFO - mozversion application_remotingname: firefox 18:04:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:04:34 INFO - mozversion application_vendor: Mozilla 18:04:34 INFO - mozversion application_version: 49.0a1 18:04:34 INFO - mozversion platform_buildid: 20160429172135 18:04:34 INFO - mozversion platform_changeset: 3b7b5c87cf2b319aa751a5903f42ee2e5883749a 18:04:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:04:34 INFO - mozversion platform_version: 49.0a1 18:04:34 INFO - using testdate: 1461978274 18:04:34 INFO - actual date: 1461978274 18:04:34 INFO - starting webserver on 'localhost:56020' 18:04:34 INFO - SUITE-START | Running 2 tests 18:04:34 INFO - TEST-START | dromaeo_css 18:04:34 INFO - operating with platform_type : linux_ 18:04:34 INFO - Initialising browser for dromaeo_css test... 18:04:34 INFO - TEST-INFO | started process 9036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__R3xg/profile http://localhost:56020/getInfo.html) 18:04:38 INFO - PROCESS | 9036 | 18:04:38 INFO - PROCESS | 9036 | (process:9105): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:04:39 INFO - PROCESS | 9036 | __metrics Screen width/height:1600/1200 18:04:39 INFO - PROCESS | 9036 | colorDepth:24 18:04:39 INFO - PROCESS | 9036 | Browser inner width/height: 1024/697 18:04:39 INFO - PROCESS | 9036 | __metrics 18:04:39 ERROR - PROCESS | 9036 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:04:40 INFO - TEST-INFO | 9036: exit 0 18:04:40 INFO - Browser initialized. 18:04:40 INFO - Running cycle 1/1 for dromaeo_css test... 18:04:40 INFO - TEST-INFO | started process 9156 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp__R3xg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:04:42 INFO - PROCESS | 9156 | 18:04:42 INFO - PROCESS | 9156 | (process:9217): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:04:52 INFO - PROCESS | 9156 | RSS: Main: 166154240 18:04:52 INFO - PROCESS | 9156 | 18:05:42 INFO - PROCESS | 9156 | 1461978342101 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] 18:07:53 INFO - PROCESS | 9156 | Cycle 1(1): loaded http://localhost:56020/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56020/tests/dromaeo/cssquery-ext.html) 18:07:54 INFO - PROCESS | 9156 | RSS: Main: 168845312 18:07:54 INFO - PROCESS | 9156 | 18:10:56 INFO - PROCESS | 9156 | Cycle 1(1): loaded http://localhost:56020/tests/dromaeo/cssquery-ext.html (next: http://localhost:56020/tests/dromaeo/cssquery-jquery.html) 18:10:57 INFO - PROCESS | 9156 | RSS: Main: 167350272 18:10:57 INFO - PROCESS | 9156 | 18:13:59 INFO - PROCESS | 9156 | Cycle 1(1): loaded http://localhost:56020/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56020/tests/dromaeo/cssquery-mootools.html) 18:13:59 INFO - PROCESS | 9156 | RSS: Main: 168714240 18:13:59 INFO - PROCESS | 9156 | 18:17:01 INFO - PROCESS | 9156 | Cycle 1(1): loaded http://localhost:56020/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56020/tests/dromaeo/cssquery-prototype.html) 18:17:02 INFO - PROCESS | 9156 | RSS: Main: 165138432 18:17:02 INFO - PROCESS | 9156 | 18:20:05 INFO - PROCESS | 9156 | Cycle 1(1): loaded http://localhost:56020/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56020/tests/dromaeo/cssquery-yui.html) 18:20:05 INFO - PROCESS | 9156 | RSS: Main: 166412288 18:20:05 INFO - PROCESS | 9156 | 18:23:07 INFO - PROCESS | 9156 | Cycle 1(1): loaded http://localhost:56020/tests/dromaeo/cssquery-yui.html (next: http://localhost:56020/tests/dromaeo/cssquery-dojo.html) 18:23:08 INFO - PROCESS | 9156 | RSS: Main: 168148992 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | __start_tp_report 18:23:08 INFO - PROCESS | 9156 | _x_x_mozilla_page_load 18:23:08 INFO - PROCESS | 9156 | _x_x_mozilla_page_load_details 18:23:08 INFO - PROCESS | 9156 | |i|pagename|runs| 18:23:08 INFO - PROCESS | 9156 | |0;dojo.html;2553.8340007899487;2637.696664883538;2681.6781986161664;2681.7184195659456;2682.3160094175996;4656.394668693069;4703.5061318561575;4721.763911804409;4734.218853889104;4746.976265118678;4653.3252678361705;4723.267893476508;4757.1437141314545;4787.473377928433;4829.806807727687;4263.5523270056665;4321.611055005049;4361.193179261831;4369.235383807837;4401.757903315316;4342.196693611692;4371.4098596689355;4409.272470042455;4423.601875831175;4426.845060422886;4255.5318914919335;4272.316429371317;4308.676849236288;4332.415123958257;4411.316245981878;4335.56644335567;4339.804708788112;4341.956580434186;4349.739015659039;4372.628326592212;4249.086446414005;4278.101598664284;4291.313389857608;4291.935620965688;4328;4513.074819661994;4522.6155776759015;4553.043860789238;4587.7017993830295;4603.5166307537565;4992.550670439641;4995.175795993657;5019.19692849146;5020.0963826511215;5068.113080210948;4946.109700253953;5032.295478632957;5051.797928082872;5073.644844860824;5103.56619687327;4757.714537127748;4772.188727916263;4785.449673287617;4830.275458681226;4834.20235661112;5097.847064587994;5126.846194614168;5143.7428128594165;5169.017886601609;5206.8958620828125;4855.441624213261;4933.87665308363;4935.136351138536;4943.209086546135;5006.774695138727;4948.851534453972;4983.750812459362;4984.950150498521;5032.094223039888;5051.318072060299;4816.133096042676;4973.602111831045;5019.196928491424;5019.447860735316;5061.544460998528;4920.975395123073;4924.409070911442;4936.3829521309835;4951.10880041596;4982.626303027215;4287.892802679958;4323.632491238217;4327.112941846914;4352.173087113439;4378.036831897041;3720.051386896324;3743.831527581265;3754.887353379403;3755.7746535207975;3786.3373909565717;4341;4350.412694286294;4362.607365337071;4382.53983331752;4426.601605855424;5058.747062646853;5060.2156665716875;5069.188929771219;5088.389393272831;5106.872328191751;4449.332600109945;4450.731541510719;4456.22016147173;4478.261086920622;4492.415985921809;4490.9670775721115;4510.120526497367;4620.8151673933335;4624.398828152386;4639.698419602715;4786.569208771228;4797.4482934462285;4827.034593081397;4831.0820944021225;4866.270059491105;5114.948850511447;5118.129917913889;5120.4111527174855;5154.226865969985;5160.741962901765;4658.394408726844;4667.533246675441;4726.3146843708155;4736.644751643572;4837.201861692782;4961.231009193581;4963.131451995959;4991.176455884738;4992.2761199626575;5018.473060328759;5053.343065401475;5053.823116190915;5062.670926389773;5069.569086627678;5116.820911268088;4790.185668436305;4874.2444921037295;4881.780319885543;4933.432655244693;4958.45456999737;4864.829730959541;4918.2376731606655;4919.385076865392;4921.581665558468;4940.2342636891335;4744.78648460827;4797.040591881568;4808.543188397097;4815.446223684321;4818.084563932842;4871.19625261842;4877.585405240594;4950.504949505164;4970.453250142409;4981.825636102719;4704.153252414599;4718.740469274223;4719.3628860103445;4753.358296630049;4758.8096476141955 18:23:08 INFO - PROCESS | 9156 | |1;ext.html;584.4739734239187;589.3546566509671;599.8380437281934;622.1290193728778;631.453792469514;33350.49974250388;34434;34547.82726086366;34764.47853282203;34841.47737783929;38275.425868611994;39174.608253917526;39256;39309;39623.603763962354;7538.020057392545;7662.578558179298;7733.9226607734045;7735.419843511731;7738.535687858746;7662.387009039291;7777.300042996129;7795.493292935941;7797.844043119134;7813.609319534001;7738.380929525652;7782.37740980723;7811;7811.414143939199;7845.058592968851;7727.188645192258;7765;7823.843523129534;7832.412569057286;7839.294463498256;7597.810054748676;7749.961250193769;7753.108392534874;7755.650995705207;7758.14660387357;25107.748922510906;34844.12889677753;35384.29231415357;35509.82245088784;35594.82202588997;3012.0813151988636;3093.597832281789;3194.552762613236;3221.2430078931666;3487.19794447276;26729.599056014176;27271;27292.727072729216;27453.17640470789;27901;3393.2025973896116;3477.0611934777467;3483.2685136121445;3618.5657721073376;3627;181544;186573;186679.99999999863;187038;187231;31016.53475197874;58565.414345856;58628;58987.41012589905;59150.40849591449;33455.665443345744;33674.32651346959;33812.323753525285;33850.15374615605;33857.15357116092;14004;14176.787348189786;14231.85768142326;14247.715045699028;14272.643183920485;11552.76894462106;11707.765844683228;11723.589674361527;11778;11888.702782430508;8219.1369906159;8234.135415781377;8243.2581067703;8254.133316001853;8318.292945099734;3262.200760813616;3308.6525914778604;3342.8161451119936;3367.983160084184;3368.9663103368653;853.81216132452;883.8541640629353;899.7165892743765;932.2588542109039;937.5921474158763;27328.56751438456;27538.862305688745;27836.721632783818;28380;28948.710512894602;909.0909090909091;948.5304774136708;1104.6023431564631;1109.611635927419;1123.617969890225;14695.706085878222;15104.773428398583;15372.400189758147;15438.84561154374;15498.147601882005;348432;354631;355978;357417;359700;47771.522284777406;48409.515904840504;48727.756361217966;48736;48773.26840097401;1063.9255252132432;1148.8506494155874;1185.51986445488;1202.2485946283573;1209.4980583057932;26556.8672156638;27561.724382755914;27887;27964.44071118607;28239.29401764972;43247;43301.35047974346;43328.350074748276;43620.34569481524;43631;302111;302380;302429;302499;303883;23758.88120559386;23989.640155398032;24000;24109.15617953363;34585.65414345825;36803;37077;37398.439023414125;37512;37967.8235394112;32455.675443245265;32510.024699259062;32593.511097333085;32611.34777304488;32817.179570510925;31353.686463135076;31851.68148318487;32153.517697234092;32677.836610816794;32913.83543082365;27548.862255688593;31400.214994625316;32288.83855580707;32620.347593048482;32766.180845479055;27670.446591067663;31367.84316078405;31830.363392732477;32299.67700323061;32380.35239295248;24070;24557.263282101565;24627.63058554159;24843.627345590194;24911 18:23:08 INFO - PROCESS | 9156 | |2;jquery.html;377.1871616666084;381.9465274861519;382.1363717997326;385.0642937661481;390.2955165925503;15378.92310538447;16013.199340032996;16758.748618770696;16941.322347106117;16949.745753813673;12250.326232057234;15410.691786164298;17242.13789310536;17259;17302.30790768371;4724.90550188996;4801.399825021872;4875.561199492045;4877.244027175793;4892.290617860408;3504.123969007748;6525.3800888915475;7131.0729605151255;7134.8573028539395;7140.464465165108;6937.375636192742;6976.755803555814;7061.435085193172;7100.6449677516175;7108.6445677716165;6754.5947243165565;7066.116735408074;7067.222605513415;7084.645767711594;7113.537620054706;6948.5483443576;6967.581945083311;6989.860202795916;6994.545354551989;7021.052157958712;20786.272480463263;21989.340319790434;22129.66805497903;22178.667319990214;22655.886720566457;1945.620603982224;1975.1309423853459;2069.5757369739167;2133.893305334727;2149.3874245840016;13700.520481783089;13892.374843132084;13986.30068496571;14178.716425671531;14886.627834304121;1830.1398342779005;1884.9528761780928;1947.6494231038407;1987.3739771971782;2061.938141855732;79356.60321698355;80631;82202;85381.57309213476;85847.99999999937;16529.504114876574;16760.916195419188;16853.325866965428;16855.483006529226;17478.475645730647;29830;29968.40063198724;30216;30294.697053029628;30299.545506816976;8936.285097192209;9259.953700231456;9273.119053689888;9390.34267601275;9436.207120647055;7399.334059934632;7458.888116678254;7566.659500322498;7660.1573826879;7685.616589013919;3539.0798392418155;8298.668053277801;8352.958235208785;8481.194286542892;8549.786255343666;1813.4740925131828;1825.0965771942974;1874.5313671582105;1886.6132442849182;1910.169076451748;807.6284908941835;851.3231980575457;882.8984666763276;904.1500989070253;918.3250311021394;16504.33982640705;16651.084190369405;16887.493375198763;17114;17504.737428938577;835.8286551257099;839.8656215005692;847.4449235750593;861.5132450165762;888.3470649072926;9329.34694571387;9604.423734575948;9608.471534065553;9623.470709111067;9810;392225;399028;402635;404002;406875;79996;80275.19724802794;81049.59475202704;81081;82073;879.6921077622909;892.7143314139413;899.5547204133995;900.0774206438452;906.4380084347615;15038.54884353471;15115.244237788287;15162.104736907886;15236;15696.136712480924;35540.289194216486;36076.63923360838;36120;36831.44752828656;36972;49787.50212497829;50320.49679503305;50680.746596266785;50684.493155067976;50686.746566266935;7107.360337569644;7456.888146677913;7503.212162722835;7700.229977002479;7756.728514501965;8959.507227102571;11386.544538218379;11401.885981140415;11526.654200374001;11563.190576659554;8976.28189744832;9271.30465215125;9300.348975571645;9329.11373419524;9422.481763503074;9776.87241935425;10077.294589378966;10212.131968782736;10230.6419275325;10294.073533382032;9261.981182070102;9351.849074712718;9519.857202142111;9540.141387275178;9631.951840240754;7734.7679569613;7873.921260787319;7911.84176316459;7989.760307190793;7994.600269986594;9382.812343753223;9465.858012129962;9545.140937315397;9620.71137865865;9639.855402168832 18:23:08 INFO - PROCESS | 9156 | |3;mootools.html;1412.6579749238224;1454.1565891782768;1573.984260157398;1735.3058776489395;1758.0682238413644;6836.4530837533;7366.968624392589;7524.285192906672;7822.452428330026;7833.255840695139;7387.889181662266;7509.699612015513;7561.886571701429;7562.962185189066;7587.962060189705;2177.1944380579207;2222.866628002317;2226.9888650556804;2228.543148654522;2229.2086309360106;2143.174877672092;2186.835987300951;2201.5376770878056;2202.031106313225;2210.7126073610407;2217.756046834847;2224.7552769195377;2247.1236217875044;2249.0666373454997;2263.76230495798;2156.3962090614496;2171.4245724882917;2171.522265101675;2175.0755928730305;2182.181681869299;2129.6486079796814;2142.5607750411127;2157.56848630273;2162.740471143457;2174.4563859035243;7626.466147369686;7812.804679882992;7817.609119544;7819.413543984224;7847.372210223226;4595.333676616872;4804.5916097131785;4809.927851082237;4815.470298267188;4820.951790482085;2772.750452459268;2834.5464725643797;2871.6984716604666;2900.129961011688;2927.5315949447986;911.7766147293889;914.826183025223;933.0110083311712;960.7886265021684;962.4033099478369;9953.104220620178;10124.746881327952;10175.389476631351;10198.490075496196;10252.641157559525;4248.681348898845;4258.68059895509;4352.7823608819435;4379.824807007748;4390.1878152541885;8932.821343573092;8980;8992.685256016008;9009.819803604023;9024.36829421934;4628.675992680547;4697.389339385858;4722.150012997625;4748.311494833299;4773.164696178224;3812.4662547243406;4228.682848786353;4315.913681726411;4356.128774245164;4402.7358358498595;3640.9635903640624;3653.8903832885057;3715.6098609645596;3747.681447077029;3773.1510410158044;1191.5531675621642;1214.690253985228;1221.0353820481898;1240.7084335181225;1241.4785789968234;712.8004158835431;760.6082867323333;764.6215123513786;810.3071873548149;819.5082950229814;5290.391604965478;5497.697626630494;5575.944240557624;5626.324841019104;5734.598578099493;842;960.2201626291846;982.40564458503;1002.9448380339152;1012.7822518158484;3769.3968964965475;3887.086534664352;3905.4922860028014;3907.081835768592;3917.5690674025836;9095.226905713089;9425.25632757942;9432.292578056673;9490.383125096847;9531.761705957268;9247.583858726373;9336.253099752004;9424.764380890532;9434.433933963985;9455.952720236355;6904.344087311697;7278.963605182046;7478.85042299151;7481.8877716834295;7490.101187857383;5199.194124910645;5250.238715386324;5636.436356364495;5645.1532270159805;5754.108113242454;8582;8743.213110820057;8756.649734010569;8865.379423440298;8878.200961913459;9026.097390260922;9027.052159523419;9181.173694367271;9323.02108278621;9379.953100234456;6371;6372.267189273293;6378.170837791057;6474.417302442803;6501.2198536175965;7274.781756547312;7323.414126869944;7337.229590893093;7348.816279593053;7385.48301618903;6585.3085426029575;6711.295313992156;6770.424513916372;6774.627395493098;6820.795376138723;6547.607143571401;6552.180977377828;6618.305077966937;6636;6716.361945615159;5821.854453638693;6032.607880487754;6182.536309776695;6258.342873998165;6262.906056409249;4632.490426053064;4685.180093483695;4725.787339569796;4758.1435341638835;4778.928316075192;4736.407949006374;4754;4805.399325084364;4808.374911261513;4818.204996175732 18:23:08 INFO - PROCESS | 9156 | |4;prototype.html;296.27856170225505;299.2862024072586;302.9424409362221;304.57815924943947;307.2441793188756;4862.927056094157;4936.3829521309835;4969.552740253376;4970.975145124278;4976.178930476467;4795.280707893818;4825.107355139302;4835.05716385305;4878.463369029404;4885.462599114104;3601.171730501986;3718.5909549949483;3821.4840996465537;3823.3941744467393;3867.207222519391;3829.636184562462;3842.6349496797898;3846.384578467446;3846.4807251021175;3846.903827404309;3783.451399547078;3790.6777923876502;3797.613870937102;3809.3714537101346;3824.541055073395;3532.2229109595846;3789.7347185697013;3811.6188381161937;3831.885043448701;3836.865709700147;3265.755068369882;3292.3415316936707;3300.1914530940076;3304.240024794287;3316.6899074865532;4658.18481765693;4672.579467847876;4687.601553867926;4693.55411235932;4694.647901407374;4299.398084268205;4300.677449191292;4302.806373713191;4307.117041006586;4321.956780432187;4972.87567810804;5075.162598171298;5113.51421614946;5117.822900732852;5118.872028199287;3607.971728057491;3622.293652737691;3623.963760362389;3634.945475817865;3646.8541258349633;5330.466953304677;5384.865378365533;5398.570643210571;5413.485718856702;5450.291462109901;3457.4468085106764;3680.3375392429084;3680.3743363628246;3684.705223582107;3696.5933747287777;3732.197577520846;3734.402495600691;3738.2336620992633;3753.3619284721663;3754.605766394544;4251.192273468031;4291.871243862689;4300.075483771005;4300.354946757949;4322.3516472528745;5044.974775126101;5191.2472691459525;5208.166693329049;5212.296339994128;5213.713245771443;1375.6835927736677;1376.8691974262429;1381.2265131526378;1383.8616138386283;1387.549046559872;846.1115828380176;901.7610333261691;903.5437104262305;931.1061381074245;933.0902370189146;4422.5356337584735;4561.954380456219;4571.885702857455;4574.748388838646;4585.174668559691;5309.681419114865;5313.734313284398;5324.946750532523;5339.652922560022;5351.3578370595;4446.420631391696;4562.406887104655;4573.885652858705;4588.2888152336445;4603.631709463235;3023.380207057548;3048.9176342398573;3075.9231019224253;3077.584526088994;3087.274490494732;5364.249005139283;5366.597505187048;5370.140777475585;5373.032854086224;5375.919361209585;5666.546676265889;5858.2677165354335;5874;5898.970505147447;5904.228731380568;5319.867003324948;5330.840074797762;5343.812966546152;5346.732663366816;5385.515303622693;5765.7693692253515;5767.8464307139575;5774.595778295647;5775.451332123442;5779.36426993022;5446.128619421032;5614.747336369955;5616.742289472178;5646.06839871433;5653;5340.5994550408095;5358.35699716021;5363.812266570807;5365.114756065205;5372.865678358073;3872.1287710266092;3877.340852055214;3881.3789793634014;3882.80585970706;3887.3002859485564;5081.644284900021;5313.442088580643;5316.989771943318;5317.7341132943975;5318.175682769177;5153.788859618062;5165.405978312542;5177.508136727005;5184.377874655065;5201.713905735221;4894.608431325414;5169.53474187325;5171.224316352577;5173.1722924331925;5191.377034755854;5049.823256186163;5067.417247016493;5087.618428617794;5111.87220319495;5135.281060651587;4929.457759646508;5053.418856831365;5149.176131818891;5192.428832828461;5217.34783152106;5076.162433198481;5107.131787596192;5126.743947732829;5128.58971282304;5151.845444636667 18:23:08 INFO - PROCESS | 9156 | |5;yui.html;685.5989246290919;689.5621280486889;696.1263614164225;760.5474742528197;795.4392153531761;11370;12103.939480302608;12264.81602775958;12268.263904165757;12317.199382040173;12071.818922716166;12077.818832717494;12083.456244468998;12115.151939364227;12170.269783812977;625.0967352176108;765.5904091311149;783.2832957843581;801.1707882341777;812.252727490707;801.887735717;802.3420794948115;803.1005274092995;803.7307501986842;804.0632662947659;850.9914900851005;851.4252879306474;852.3564708644965;852.4757274276307;855.0850589868812;833.0544831616098;840.0675250471971;841.9326453883674;843.8607629741085;844.273924424994;619.2228752915108;619.3465893482374;619.3496828330235;620.9937900620981;622.1476577089417;11926.284422934652;11940.044796416265;11994.940025299906;12004.579839705655;12073.27560346382;11864.338992541052;12115.394230288539;12135.878641213563;12140;12257.168825720888;10925.617603383924;10935.671929842118;10959.56161753529;11039.83440248397;11118;3391.8473668684724;3400.1499625093725;3455.481677748358;3480.3561341151967;3486.6687664671817;44059.55940440619;44171.337429938576;44298.33552496715;44755.3286700703;44777.32834007493;9710.320277580502;9754.561044753003;9873.308868379145;10175;10375.740606484747;17576.209070591853;17599.82400175982;17614.471565853044;17614.91192544029;17671.204795784222;6365.458935990493;6506.4469520091325;6602.042703807921;6681.064650948871;6735.528513004043;3554;3644.580873199563;3661.1579336752698;3687.1888184599347;3698.519192504957;2778.152663437671;2890.913272601825;2891.2193707699225;2894.233028247516;2894.3921776426764;499.61280007994094;504.7097918696764;514.7452011254453;518.1217835768412;522.1879976636291;551.2805788446117;562.6399104573077;569.4135040907789;589.6108568344957;593.6705128653552;7215.530990485601;7422.628868556659;7457.7016919323705;7465.664045117983;7547.28300811422;513.1712284660247;532.281420082885;534.3507638219581;546.3171036204744;551.4623242338688;3468.4797280408143;3509.8596056157467;3526.947095793565;3546;3552.946705799415;49182.75408622934;51163.74418127885;51984.48015519796;52047.12272824088;53149.46850531445;45510.772446137555;45554.5444545557;45943.77028114838;46278.53721462809;46488.767556162005;41302;41360.58639413628;41388;41598;41658.37512437316;6421.229452465734;6477.4494167996245;6576.901346479711;6606.570572912745;6622.503312251504;28438.146855594365;28825.711742882304;28984.275393115342;29200.26999325034;29243.85378073096;34176.48735268923;37863.81068094642;38339.61660383472;38561;39390.212195756496;8423.410361274897;8679.609417576097;8709.042005379277;8737.606807693543;8818.779530511789;9057.728268151966;9066.410683305565;9211.355205135576;9291.67479138227;9338.859917101114;8108.270255677017;8395.829065636874;8746.081661425713;8800.60397282111;8811.867821982547;8596.269317108116;8743.868841967504;8798.604062817316;8882.555872206234;8884.689035883972;8238.50568965864;8644.394892357475;8834.249088827522;9140.771480713036;9251;8067.515949043076;8399.580020999048;8446.66213351459;8463.915360846559;8689.522076285864;8200.138985406445;8238.423310368216;8323.916760832315;8385.706500272461;8392.244697977212 18:23:08 INFO - PROCESS | 9156 | __end_tp_report 18:23:08 INFO - PROCESS | 9156 | __start_cc_report 18:23:08 INFO - PROCESS | 9156 | _x_x_mozilla_cycle_collect,358 18:23:08 INFO - PROCESS | 9156 | __end_cc_report 18:23:08 INFO - PROCESS | 9156 | __startTimestamp1461979388081__endTimestamp 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | ------- Summary: start ------- 18:23:08 INFO - PROCESS | 9156 | Number of tests: 6 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | [#0] dojo.html Cycles:165 Average:4660.33 Median:4787.47 stddev:479.09 (10.0%) stddev-sans-first:451.16 18:23:08 INFO - PROCESS | 9156 | Values: 2553.8 2637.7 2681.7 2681.7 2682.3 4656.4 4703.5 4721.8 4734.2 4747.0 4653.3 4723.3 4757.1 4787.5 4829.8 4263.6 4321.6 4361.2 4369.2 4401.8 4342.2 4371.4 4409.3 4423.6 4426.8 4255.5 4272.3 4308.7 4332.4 4411.3 4335.6 4339.8 4342.0 4349.7 4372.6 4249.1 4278.1 4291.3 4291.9 4328.0 4513.1 4522.6 4553.0 4587.7 4603.5 4992.6 4995.2 5019.2 5020.1 5068.1 4946.1 5032.3 5051.8 5073.6 5103.6 4757.7 4772.2 4785.4 4830.3 4834.2 5097.8 5126.8 5143.7 5169.0 5206.9 4855.4 4933.9 4935.1 4943.2 5006.8 4948.9 4983.8 4985.0 5032.1 5051.3 4816.1 4973.6 5019.2 5019.4 5061.5 4921.0 4924.4 4936.4 4951.1 4982.6 4287.9 4323.6 4327.1 4352.2 4378.0 3720.1 3743.8 3754.9 3755.8 3786.3 4341.0 4350.4 4362.6 4382.5 4426.6 5058.7 5060.2 5069.2 5088.4 5106.9 4449.3 4450.7 4456.2 4478.3 4492.4 4491.0 4510.1 4620.8 4624.4 4639.7 4786.6 4797.4 4827.0 4831.1 4866.3 5114.9 5118.1 5120.4 5154.2 5160.7 4658.4 4667.5 4726.3 4736.6 4837.2 4961.2 4963.1 4991.2 4992.3 5018.5 5053.3 5053.8 5062.7 5069.6 5116.8 4790.2 4874.2 4881.8 4933.4 4958.5 4864.8 4918.2 4919.4 4921.6 4940.2 4744.8 4797.0 4808.5 4815.4 4818.1 4871.2 4877.6 4950.5 4970.5 4981.8 4704.2 4718.7 4719.4 4753.4 4758.8 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | [#1] ext.html Cycles:180 Average:42488.37 Median:18590.65 stddev:76507.47 (411.5%) stddev-sans-first:76657.40 18:23:08 INFO - PROCESS | 9156 | Values: 584.5 589.4 599.8 622.1 631.5 33350.5 34434.0 34547.8 34764.5 34841.5 38275.4 39174.6 39256.0 39309.0 39623.6 7538.0 7662.6 7733.9 7735.4 7738.5 7662.4 7777.3 7795.5 7797.8 7813.6 7738.4 7782.4 7811.0 7811.4 7845.1 7727.2 7765.0 7823.8 7832.4 7839.3 7597.8 7750.0 7753.1 7755.7 7758.1 25107.7 34844.1 35384.3 35509.8 35594.8 3012.1 3093.6 3194.6 3221.2 3487.2 26729.6 27271.0 27292.7 27453.2 27901.0 3393.2 3477.1 3483.3 3618.6 3627.0 181544.0 186573.0 186680.0 187038.0 187231.0 31016.5 58565.4 58628.0 58987.4 59150.4 33455.7 33674.3 33812.3 33850.2 33857.2 14004.0 14176.8 14231.9 14247.7 14272.6 11552.8 11707.8 11723.6 11778.0 11888.7 8219.1 8234.1 8243.3 8254.1 8318.3 3262.2 3308.7 3342.8 3368.0 3369.0 853.8 883.9 899.7 932.3 937.6 27328.6 27538.9 27836.7 28380.0 28948.7 909.1 948.5 1104.6 1109.6 1123.6 14695.7 15104.8 15372.4 15438.8 15498.1 348432.0 354631.0 355978.0 357417.0 359700.0 47771.5 48409.5 48727.8 48736.0 48773.3 1063.9 1148.9 1185.5 1202.2 1209.5 26556.9 27561.7 27887.0 27964.4 28239.3 43247.0 43301.4 43328.4 43620.3 43631.0 302111.0 302380.0 302429.0 302499.0 303883.0 23758.9 23989.6 24000.0 24109.2 34585.7 36803.0 37077.0 37398.4 37512.0 37967.8 32455.7 32510.0 32593.5 32611.3 32817.2 31353.7 31851.7 32153.5 32677.8 32913.8 27548.9 31400.2 32288.8 32620.3 32766.2 27670.4 31367.8 31830.4 32299.7 32380.4 24070.0 24557.3 24627.6 24843.6 24911.0 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | [#2] jquery.html Cycles:180 Average:26068.64 Median:6639.99 stddev:66354.25 (999.3%) stddev-sans-first:66512.35 18:23:08 INFO - PROCESS | 9156 | Values: 377.2 381.9 382.1 385.1 390.3 15378.9 16013.2 16758.7 16941.3 16949.7 12250.3 15410.7 17242.1 17259.0 17302.3 4724.9 4801.4 4875.6 4877.2 4892.3 3504.1 6525.4 7131.1 7134.9 7140.5 6937.4 6976.8 7061.4 7100.6 7108.6 6754.6 7066.1 7067.2 7084.6 7113.5 6948.5 6967.6 6989.9 6994.5 7021.1 20786.3 21989.3 22129.7 22178.7 22655.9 1945.6 1975.1 2069.6 2133.9 2149.4 13700.5 13892.4 13986.3 14178.7 14886.6 1830.1 1885.0 1947.6 1987.4 2061.9 79356.6 80631.0 82202.0 85381.6 85848.0 16529.5 16760.9 16853.3 16855.5 17478.5 29830.0 29968.4 30216.0 30294.7 30299.5 8936.3 9260.0 9273.1 9390.3 9436.2 7399.3 7458.9 7566.7 7660.2 7685.6 3539.1 8298.7 8353.0 8481.2 8549.8 1813.5 1825.1 1874.5 1886.6 1910.2 807.6 851.3 882.9 904.2 918.3 16504.3 16651.1 16887.5 17114.0 17504.7 835.8 839.9 847.4 861.5 888.3 9329.3 9604.4 9608.5 9623.5 9810.0 392225.0 399028.0 402635.0 404002.0 406875.0 79996.0 80275.2 81049.6 81081.0 82073.0 879.7 892.7 899.6 900.1 906.4 15038.5 15115.2 15162.1 15236.0 15696.1 35540.3 36076.6 36120.0 36831.4 36972.0 49787.5 50320.5 50680.7 50684.5 50686.7 7107.4 7456.9 7503.2 7700.2 7756.7 8959.5 11386.5 11401.9 11526.7 11563.2 8976.3 9271.3 9300.3 9329.1 9422.5 9776.9 10077.3 10212.1 10230.6 10294.1 9262.0 9351.8 9519.9 9540.1 9632.0 7734.8 7873.9 7911.8 7989.8 7994.6 9382.8 9465.9 9545.1 9620.7 9639.9 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | [#3] mootools.html Cycles:180 Average:5129.11 Median:5601.13 stddev:2785.41 (49.7%) stddev-sans-first:2779.22 18:23:08 INFO - PROCESS | 9156 | Values: 1412.7 1454.2 1574.0 1735.3 1758.1 6836.5 7367.0 7524.3 7822.5 7833.3 7387.9 7509.7 7561.9 7563.0 7588.0 2177.2 2222.9 2227.0 2228.5 2229.2 2143.2 2186.8 2201.5 2202.0 2210.7 2217.8 2224.8 2247.1 2249.1 2263.8 2156.4 2171.4 2171.5 2175.1 2182.2 2129.6 2142.6 2157.6 2162.7 2174.5 7626.5 7812.8 7817.6 7819.4 7847.4 4595.3 4804.6 4809.9 4815.5 4821.0 2772.8 2834.5 2871.7 2900.1 2927.5 911.8 914.8 933.0 960.8 962.4 9953.1 10124.7 10175.4 10198.5 10252.6 4248.7 4258.7 4352.8 4379.8 4390.2 8932.8 8980.0 8992.7 9009.8 9024.4 4628.7 4697.4 4722.2 4748.3 4773.2 3812.5 4228.7 4315.9 4356.1 4402.7 3641.0 3653.9 3715.6 3747.7 3773.2 1191.6 1214.7 1221.0 1240.7 1241.5 712.8 760.6 764.6 810.3 819.5 5290.4 5497.7 5575.9 5626.3 5734.6 842.0 960.2 982.4 1002.9 1012.8 3769.4 3887.1 3905.5 3907.1 3917.6 9095.2 9425.3 9432.3 9490.4 9531.8 9247.6 9336.3 9424.8 9434.4 9456.0 6904.3 7279.0 7478.9 7481.9 7490.1 5199.2 5250.2 5636.4 5645.2 5754.1 8582.0 8743.2 8756.6 8865.4 8878.2 9026.1 9027.1 9181.2 9323.0 9380.0 6371.0 6372.3 6378.2 6474.4 6501.2 7274.8 7323.4 7337.2 7348.8 7385.5 6585.3 6711.3 6770.4 6774.6 6820.8 6547.6 6552.2 6618.3 6636.0 6716.4 5821.9 6032.6 6182.5 6258.3 6262.9 4632.5 4685.2 4725.8 4758.1 4778.9 4736.4 4754.0 4805.4 4808.4 4818.2 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | [#4] prototype.html Cycles:180 Average:4342.08 Median:4890.04 stddev:1289.69 (26.4%) stddev-sans-first:1257.05 18:23:08 INFO - PROCESS | 9156 | Values: 296.3 299.3 302.9 304.6 307.2 4862.9 4936.4 4969.6 4971.0 4976.2 4795.3 4825.1 4835.1 4878.5 4885.5 3601.2 3718.6 3821.5 3823.4 3867.2 3829.6 3842.6 3846.4 3846.5 3846.9 3783.5 3790.7 3797.6 3809.4 3824.5 3532.2 3789.7 3811.6 3831.9 3836.9 3265.8 3292.3 3300.2 3304.2 3316.7 4658.2 4672.6 4687.6 4693.6 4694.6 4299.4 4300.7 4302.8 4307.1 4322.0 4972.9 5075.2 5113.5 5117.8 5118.9 3608.0 3622.3 3624.0 3634.9 3646.9 5330.5 5384.9 5398.6 5413.5 5450.3 3457.4 3680.3 3680.4 3684.7 3696.6 3732.2 3734.4 3738.2 3753.4 3754.6 4251.2 4291.9 4300.1 4300.4 4322.4 5045.0 5191.2 5208.2 5212.3 5213.7 1375.7 1376.9 1381.2 1383.9 1387.5 846.1 901.8 903.5 931.1 933.1 4422.5 4562.0 4571.9 4574.7 4585.2 5309.7 5313.7 5324.9 5339.7 5351.4 4446.4 4562.4 4573.9 4588.3 4603.6 3023.4 3048.9 3075.9 3077.6 3087.3 5364.2 5366.6 5370.1 5373.0 5375.9 5666.5 5858.3 5874.0 5899.0 5904.2 5319.9 5330.8 5343.8 5346.7 5385.5 5765.8 5767.8 5774.6 5775.5 5779.4 5446.1 5614.7 5616.7 5646.1 5653.0 5340.6 5358.4 5363.8 5365.1 5372.9 3872.1 3877.3 3881.4 3882.8 3887.3 5081.6 5313.4 5317.0 5317.7 5318.2 5153.8 5165.4 5177.5 5184.4 5201.7 4894.6 5169.5 5171.2 5173.2 5191.4 5049.8 5067.4 5087.6 5111.9 5135.3 4929.5 5053.4 5149.2 5192.4 5217.3 5076.2 5107.1 5126.7 5128.6 5151.8 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - PROCESS | 9156 | [#5] yui.html Cycles:180 Average:12160.95 Median:548.80 stddev:14207.86 (2588.9%) stddev-sans-first:14221.58 18:23:08 INFO - PROCESS | 9156 | Values: 685.6 689.6 696.1 760.5 795.4 11370.0 12103.9 12264.8 12268.3 12317.2 12071.8 12077.8 12083.5 12115.2 12170.3 625.1 765.6 783.3 801.2 812.3 801.9 802.3 803.1 803.7 804.1 851.0 851.4 852.4 852.5 855.1 833.1 840.1 841.9 843.9 844.3 619.2 619.3 619.3 621.0 622.1 11926.3 11940.0 11994.9 12004.6 12073.3 11864.3 12115.4 12135.9 12140.0 12257.2 10925.6 10935.7 10959.6 11039.8 11118.0 3391.8 3400.1 3455.5 3480.4 3486.7 44059.6 44171.3 44298.3 44755.3 44777.3 9710.3 9754.6 9873.3 10175.0 10375.7 17576.2 17599.8 17614.5 17614.9 17671.2 6365.5 6506.4 6602.0 6681.1 6735.5 3554.0 3644.6 3661.2 3687.2 3698.5 2778.2 2890.9 2891.2 2894.2 2894.4 499.6 504.7 514.7 518.1 522.2 551.3 562.6 569.4 589.6 593.7 7215.5 7422.6 7457.7 7465.7 7547.3 513.2 532.3 534.4 546.3 551.5 3468.5 3509.9 3526.9 3546.0 3552.9 49182.8 51163.7 51984.5 52047.1 53149.5 45510.8 45554.5 45943.8 46278.5 46488.8 41302.0 41360.6 41388.0 41598.0 41658.4 6421.2 6477.4 6576.9 6606.6 6622.5 28438.1 28825.7 28984.3 29200.3 29243.9 34176.5 37863.8 38339.6 38561.0 39390.2 8423.4 8679.6 8709.0 8737.6 8818.8 9057.7 9066.4 9211.4 9291.7 9338.9 8108.3 8395.8 8746.1 8800.6 8811.9 8596.3 8743.9 8798.6 8882.6 8884.7 8238.5 8644.4 8834.2 9140.8 9251.0 8067.5 8399.6 8446.7 8463.9 8689.5 8200.1 8238.4 8323.9 8385.7 8392.2 18:23:08 INFO - PROCESS | 9156 | -------- Summary: end -------- 18:23:08 INFO - PROCESS | 9156 | 18:23:08 INFO - TEST-INFO | 9156: exit 0 18:23:08 INFO - TEST-OK | dromaeo_css | took 1114602ms 18:23:08 INFO - TEST-START | kraken 18:23:08 INFO - operating with platform_type : linux_ 18:23:08 INFO - Initialising browser for kraken test... 18:23:08 INFO - TEST-INFO | started process 9393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUj96hd/profile http://localhost:56020/getInfo.html) 18:23:12 INFO - PROCESS | 9393 | 18:23:12 INFO - PROCESS | 9393 | (process:9461): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:23:13 INFO - PROCESS | 9393 | __metrics Screen width/height:1600/1200 18:23:13 INFO - PROCESS | 9393 | colorDepth:24 18:23:13 INFO - PROCESS | 9393 | Browser inner width/height: 1024/697 18:23:13 INFO - PROCESS | 9393 | __metrics 18:23:14 ERROR - PROCESS | 9393 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:23:15 INFO - TEST-INFO | 9393: exit 0 18:23:15 INFO - Browser initialized. 18:23:15 INFO - Running cycle 1/1 for kraken test... 18:23:15 INFO - TEST-INFO | started process 9512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUj96hd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:23:17 INFO - PROCESS | 9512 | 18:23:17 INFO - PROCESS | 9512 | (process:9572): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:23:27 INFO - PROCESS | 9512 | RSS: Main: 166322176 18:23:27 INFO - PROCESS | 9512 | 18:23:29 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56020/tests/kraken/driver.html?testName=audio-beat-detection) 18:23:30 INFO - PROCESS | 9512 | RSS: Main: 170823680 18:23:30 INFO - PROCESS | 9512 | 18:23:33 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56020/tests/kraken/driver.html?testName=audio-dft) 18:23:34 INFO - PROCESS | 9512 | RSS: Main: 174366720 18:23:34 INFO - PROCESS | 9512 | 18:23:37 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56020/tests/kraken/driver.html?testName=audio-fft) 18:23:37 INFO - PROCESS | 9512 | RSS: Main: 164339712 18:23:37 INFO - PROCESS | 9512 | 18:23:39 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56020/tests/kraken/driver.html?testName=audio-oscillator) 18:23:40 INFO - PROCESS | 9512 | RSS: Main: 164704256 18:23:40 INFO - PROCESS | 9512 | 18:23:42 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56020/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:23:43 INFO - PROCESS | 9512 | RSS: Main: 166989824 18:23:43 INFO - PROCESS | 9512 | 18:23:46 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56020/tests/kraken/driver.html?testName=imaging-darkroom) 18:23:47 INFO - PROCESS | 9512 | RSS: Main: 166760448 18:23:47 INFO - PROCESS | 9512 | 18:23:50 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56020/tests/kraken/driver.html?testName=imaging-desaturate) 18:23:51 INFO - PROCESS | 9512 | RSS: Main: 166006784 18:23:51 INFO - PROCESS | 9512 | 18:23:54 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56020/tests/kraken/driver.html?testName=json-parse-financial) 18:23:54 INFO - PROCESS | 9512 | RSS: Main: 166649856 18:23:54 INFO - PROCESS | 9512 | 18:23:56 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56020/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:23:57 INFO - PROCESS | 9512 | RSS: Main: 166895616 18:23:57 INFO - PROCESS | 9512 | 18:23:59 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:23:59 INFO - PROCESS | 9512 | RSS: Main: 167022592 18:23:59 INFO - PROCESS | 9512 | 18:24:01 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:24:02 INFO - PROCESS | 9512 | RSS: Main: 167170048 18:24:02 INFO - PROCESS | 9512 | 18:24:05 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:24:06 INFO - PROCESS | 9512 | RSS: Main: 167088128 18:24:06 INFO - PROCESS | 9512 | 18:24:09 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:24:09 INFO - PROCESS | 9512 | RSS: Main: 167084032 18:24:09 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | Cycle 1(1): loaded http://localhost:56020/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56020/tests/kraken/driver.html?testName=ai-astar) 18:24:11 INFO - PROCESS | 9512 | RSS: Main: 168812544 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | __start_tp_report 18:24:11 INFO - PROCESS | 9512 | _x_x_mozilla_page_load 18:24:11 INFO - PROCESS | 9512 | _x_x_mozilla_page_load_details 18:24:11 INFO - PROCESS | 9512 | |i|pagename|runs| 18:24:11 INFO - PROCESS | 9512 | |0;ai-astar;113;107;114;114;115;127;116;113;117;113 18:24:11 INFO - PROCESS | 9512 | |1;audio-beat-detection;165;136;168;184;138;163;165;138;198;140 18:24:11 INFO - PROCESS | 9512 | |2;audio-dft;162;164;167;168;167;162;163;162;166;163 18:24:11 INFO - PROCESS | 9512 | |3;audio-fft;76;77;76;159;82;81;75;76;162;77 18:24:11 INFO - PROCESS | 9512 | |4;audio-oscillator;94;94;146;95;94;94;152;95;93;145 18:24:11 INFO - PROCESS | 9512 | |5;imaging-gaussian-blur;117;118;118;120;117;118;126;119;119;117 18:24:11 INFO - PROCESS | 9512 | |6;imaging-darkroom;147;147;149;148;147;148;149;147;149;148 18:24:11 INFO - PROCESS | 9512 | |7;imaging-desaturate;96;96;96;97;95;96;95;95;97;95 18:24:11 INFO - PROCESS | 9512 | |8;json-parse-financial;68;68;69;70;69;69;69;86;69;67 18:24:11 INFO - PROCESS | 9512 | |9;json-stringify-tinderbox;66;66;66;67;66;65;66;66;66;66 18:24:11 INFO - PROCESS | 9512 | |10;stanford-crypto-aes;82;82;82;84;84;85;83;83;83;83 18:24:11 INFO - PROCESS | 9512 | |11;stanford-crypto-ccm;135;135;134;142;137;135;134;147;178;134 18:24:11 INFO - PROCESS | 9512 | |12;stanford-crypto-pbkdf2;183;180;180;178;191;178;185;179;184;181 18:24:11 INFO - PROCESS | 9512 | |13;stanford-crypto-sha256-iterative;77;76;76;80;77;75;74;74;77;74 18:24:11 INFO - PROCESS | 9512 | __end_tp_report 18:24:11 INFO - PROCESS | 9512 | __start_cc_report 18:24:11 INFO - PROCESS | 9512 | _x_x_mozilla_cycle_collect,969 18:24:11 INFO - PROCESS | 9512 | __end_cc_report 18:24:11 INFO - PROCESS | 9512 | __startTimestamp1461979451917__endTimestamp 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | ------- Summary: start ------- 18:24:11 INFO - PROCESS | 9512 | Number of tests: 14 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:5.02 (4.4%) stddev-sans-first:5.28 18:24:11 INFO - PROCESS | 9512 | Values: 113.0 107.0 114.0 114.0 115.0 127.0 116.0 113.0 117.0 113.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#1] audio-beat-detection Cycles:10 Average:159.50 Median:165.00 stddev:21.30 (12.9%) stddev-sans-first:22.50 18:24:11 INFO - PROCESS | 9512 | Values: 165.0 136.0 168.0 184.0 138.0 163.0 165.0 138.0 198.0 140.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.37 (1.4%) stddev-sans-first:2.35 18:24:11 INFO - PROCESS | 9512 | Values: 162.0 164.0 167.0 168.0 167.0 162.0 163.0 162.0 166.0 163.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#3] audio-fft Cycles:10 Average:94.10 Median:76.50 stddev:35.08 (45.9%) stddev-sans-first:36.59 18:24:11 INFO - PROCESS | 9512 | Values: 76.0 77.0 76.0 159.0 82.0 81.0 75.0 76.0 162.0 77.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:94.00 stddev:25.92 (27.6%) stddev-sans-first:26.82 18:24:11 INFO - PROCESS | 9512 | Values: 94.0 94.0 146.0 95.0 94.0 94.0 152.0 95.0 93.0 145.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:118.50 stddev:2.69 (2.3%) stddev-sans-first:2.76 18:24:11 INFO - PROCESS | 9512 | Values: 117.0 118.0 118.0 120.0 117.0 118.0 126.0 119.0 119.0 117.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 18:24:11 INFO - PROCESS | 9512 | Values: 147.0 147.0 149.0 148.0 147.0 148.0 149.0 147.0 149.0 148.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 18:24:11 INFO - PROCESS | 9512 | Values: 96.0 96.0 96.0 97.0 95.0 96.0 95.0 95.0 97.0 95.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#8] json-parse-financial Cycles:10 Average:70.40 Median:69.00 stddev:5.54 (8.0%) stddev-sans-first:5.81 18:24:11 INFO - PROCESS | 9512 | Values: 68.0 68.0 69.0 70.0 69.0 69.0 69.0 86.0 69.0 67.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 18:24:11 INFO - PROCESS | 9512 | Values: 66.0 66.0 66.0 67.0 66.0 65.0 66.0 66.0 66.0 66.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:0.97 18:24:11 INFO - PROCESS | 9512 | Values: 82.0 82.0 82.0 84.0 84.0 85.0 83.0 83.0 83.0 83.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:136.00 stddev:13.65 (10.0%) stddev-sans-first:14.30 18:24:11 INFO - PROCESS | 9512 | Values: 135.0 135.0 134.0 142.0 137.0 135.0 134.0 147.0 178.0 134.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:182.00 stddev:4.01 (2.2%) stddev-sans-first:4.24 18:24:11 INFO - PROCESS | 9512 | Values: 183.0 180.0 180.0 178.0 191.0 178.0 185.0 179.0 184.0 181.0 18:24:11 INFO - PROCESS | 9512 | 18:24:11 INFO - PROCESS | 9512 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:76.50 stddev:1.89 (2.5%) stddev-sans-first:1.96 18:24:11 INFO - PROCESS | 9512 | Values: 77.0 76.0 76.0 80.0 77.0 75.0 74.0 74.0 77.0 74.0 18:24:11 INFO - PROCESS | 9512 | -------- Summary: end -------- 18:24:11 INFO - PROCESS | 9512 | 18:24:12 INFO - TEST-INFO | 9512: exit 0 18:24:13 INFO - TEST-OK | kraken | took 64156ms 18:24:13 INFO - SUITE-END | took 1178s 18:24:13 INFO - Completed test suite (00:19:38) 18:24:13 INFO - javascript benchmark 18:24:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.8340007899487, 2637.696664883538, 2681.6781986161664, 2681.7184195659456, 2682.3160094175996, 4656.394668693069, 4703.5061318561575, 4721.763911804409, 4734.218853889104, 4746.976265118678, 4653.3252678361705, 4723.267893476508, 4757.1437141314545, 4787.473377928433, 4829.806807727687, 4263.5523270056665, 4321.611055005049, 4361.193179261831, 4369.235383807837, 4401.757903315316, 4342.196693611692, 4371.4098596689355, 4409.272470042455, 4423.601875831175, 4426.845060422886, 4255.5318914919335, 4272.316429371317, 4308.676849236288, 4332.415123958257, 4411.316245981878, 4335.56644335567, 4339.804708788112, 4341.956580434186, 4349.739015659039, 4372.628326592212, 4249.086446414005, 4278.101598664284, 4291.313389857608, 4291.935620965688, 4328.0, 4513.074819661994, 4522.6155776759015, 4553.043860789238, 4587.7017993830295, 4603.5166307537565, 4992.550670439641, 4995.175795993657, 5019.19692849146, 5020.0963826511215, 5068.113080210948, 4946.109700253953, 5032.295478632957, 5051.797928082872, 5073.644844860824, 5103.56619687327, 4757.714537127748, 4772.188727916263, 4785.449673287617, 4830.275458681226, 4834.20235661112, 5097.847064587994, 5126.846194614168, 5143.7428128594165, 5169.017886601609, 5206.8958620828125, 4855.441624213261, 4933.87665308363, 4935.136351138536, 4943.209086546135, 5006.774695138727, 4948.851534453972, 4983.750812459362, 4984.950150498521, 5032.094223039888, 5051.318072060299, 4816.133096042676, 4973.602111831045, 5019.196928491424, 5019.447860735316, 5061.544460998528, 4920.975395123073, 4924.409070911442, 4936.3829521309835, 4951.10880041596, 4982.626303027215, 4287.892802679958, 4323.632491238217, 4327.112941846914, 4352.173087113439, 4378.036831897041, 3720.051386896324, 3743.831527581265, 3754.887353379403, 3755.7746535207975, 3786.3373909565717, 4341.0, 4350.412694286294, 4362.607365337071, 4382.53983331752, 4426.601605855424, 5058.747062646853, 5060.2156665716875, 5069.188929771219, 5088.389393272831, 5106.872328191751, 4449.332600109945, 4450.731541510719, 4456.22016147173, 4478.261086920622, 4492.415985921809, 4490.9670775721115, 4510.120526497367, 4620.8151673933335, 4624.398828152386, 4639.698419602715, 4786.569208771228, 4797.4482934462285, 4827.034593081397, 4831.0820944021225, 4866.270059491105, 5114.948850511447, 5118.129917913889, 5120.4111527174855, 5154.226865969985, 5160.741962901765, 4658.394408726844, 4667.533246675441, 4726.3146843708155, 4736.644751643572, 4837.201861692782, 4961.231009193581, 4963.131451995959, 4991.176455884738, 4992.2761199626575, 5018.473060328759, 5053.343065401475, 5053.823116190915, 5062.670926389773, 5069.569086627678, 5116.820911268088, 4790.185668436305, 4874.2444921037295, 4881.780319885543, 4933.432655244693, 4958.45456999737, 4864.829730959541, 4918.2376731606655, 4919.385076865392, 4921.581665558468, 4940.2342636891335, 4744.78648460827, 4797.040591881568, 4808.543188397097, 4815.446223684321, 4818.084563932842, 4871.19625261842, 4877.585405240594, 4950.504949505164, 4970.453250142409, 4981.825636102719, 4704.153252414599, 4718.740469274223, 4719.3628860103445, 4753.358296630049, 4758.8096476141955], "value": 4630.211319192837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4739734239187, 589.3546566509671, 599.8380437281934, 622.1290193728778, 631.453792469514, 33350.49974250388, 34434.0, 34547.82726086366, 34764.47853282203, 34841.47737783929, 38275.425868611994, 39174.608253917526, 39256.0, 39309.0, 39623.603763962354, 7538.020057392545, 7662.578558179298, 7733.9226607734045, 7735.419843511731, 7738.535687858746, 7662.387009039291, 7777.300042996129, 7795.493292935941, 7797.844043119134, 7813.609319534001, 7738.380929525652, 7782.37740980723, 7811.0, 7811.414143939199, 7845.058592968851, 7727.188645192258, 7765.0, 7823.843523129534, 7832.412569057286, 7839.294463498256, 7597.810054748676, 7749.961250193769, 7753.108392534874, 7755.650995705207, 7758.14660387357, 25107.748922510906, 34844.12889677753, 35384.29231415357, 35509.82245088784, 35594.82202588997, 3012.0813151988636, 3093.597832281789, 3194.552762613236, 3221.2430078931666, 3487.19794447276, 26729.599056014176, 27271.0, 27292.727072729216, 27453.17640470789, 27901.0, 3393.2025973896116, 3477.0611934777467, 3483.2685136121445, 3618.5657721073376, 3627.0, 181544.0, 186573.0, 186679.99999999863, 187038.0, 187231.0, 31016.53475197874, 58565.414345856, 58628.0, 58987.41012589905, 59150.40849591449, 33455.665443345744, 33674.32651346959, 33812.323753525285, 33850.15374615605, 33857.15357116092, 14004.0, 14176.787348189786, 14231.85768142326, 14247.715045699028, 14272.643183920485, 11552.76894462106, 11707.765844683228, 11723.589674361527, 11778.0, 11888.702782430508, 8219.1369906159, 8234.135415781377, 8243.2581067703, 8254.133316001853, 8318.292945099734, 3262.200760813616, 3308.6525914778604, 3342.8161451119936, 3367.983160084184, 3368.9663103368653, 853.81216132452, 883.8541640629353, 899.7165892743765, 932.2588542109039, 937.5921474158763, 27328.56751438456, 27538.862305688745, 27836.721632783818, 28380.0, 28948.710512894602, 909.0909090909091, 948.5304774136708, 1104.6023431564631, 1109.611635927419, 1123.617969890225, 14695.706085878222, 15104.773428398583, 15372.400189758147, 15438.84561154374, 15498.147601882005, 348432.0, 354631.0, 355978.0, 357417.0, 359700.0, 47771.522284777406, 48409.515904840504, 48727.756361217966, 48736.0, 48773.26840097401, 1063.9255252132432, 1148.8506494155874, 1185.51986445488, 1202.2485946283573, 1209.4980583057932, 26556.8672156638, 27561.724382755914, 27887.0, 27964.44071118607, 28239.29401764972, 43247.0, 43301.35047974346, 43328.350074748276, 43620.34569481524, 43631.0, 302111.0, 302380.0, 302429.0, 302499.0, 303883.0, 23758.88120559386, 23989.640155398032, 24000.0, 24109.15617953363, 34585.65414345825, 36803.0, 37077.0, 37398.439023414125, 37512.0, 37967.8235394112, 32455.675443245265, 32510.024699259062, 32593.511097333085, 32611.34777304488, 32817.179570510925, 31353.686463135076, 31851.68148318487, 32153.517697234092, 32677.836610816794, 32913.83543082365, 27548.862255688593, 31400.214994625316, 32288.83855580707, 32620.347593048482, 32766.180845479055, 27670.446591067663, 31367.84316078405, 31830.363392732477, 32299.67700323061, 32380.35239295248, 24070.0, 24557.263282101565, 24627.63058554159, 24843.627345590194, 24911.0], "value": 16060.782436026133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1871616666084, 381.9465274861519, 382.1363717997326, 385.0642937661481, 390.2955165925503, 15378.92310538447, 16013.199340032996, 16758.748618770696, 16941.322347106117, 16949.745753813673, 12250.326232057234, 15410.691786164298, 17242.13789310536, 17259.0, 17302.30790768371, 4724.90550188996, 4801.399825021872, 4875.561199492045, 4877.244027175793, 4892.290617860408, 3504.123969007748, 6525.3800888915475, 7131.0729605151255, 7134.8573028539395, 7140.464465165108, 6937.375636192742, 6976.755803555814, 7061.435085193172, 7100.6449677516175, 7108.6445677716165, 6754.5947243165565, 7066.116735408074, 7067.222605513415, 7084.645767711594, 7113.537620054706, 6948.5483443576, 6967.581945083311, 6989.860202795916, 6994.545354551989, 7021.052157958712, 20786.272480463263, 21989.340319790434, 22129.66805497903, 22178.667319990214, 22655.886720566457, 1945.620603982224, 1975.1309423853459, 2069.5757369739167, 2133.893305334727, 2149.3874245840016, 13700.520481783089, 13892.374843132084, 13986.30068496571, 14178.716425671531, 14886.627834304121, 1830.1398342779005, 1884.9528761780928, 1947.6494231038407, 1987.3739771971782, 2061.938141855732, 79356.60321698355, 80631.0, 82202.0, 85381.57309213476, 85847.99999999937, 16529.504114876574, 16760.916195419188, 16853.325866965428, 16855.483006529226, 17478.475645730647, 29830.0, 29968.40063198724, 30216.0, 30294.697053029628, 30299.545506816976, 8936.285097192209, 9259.953700231456, 9273.119053689888, 9390.34267601275, 9436.207120647055, 7399.334059934632, 7458.888116678254, 7566.659500322498, 7660.1573826879, 7685.616589013919, 3539.0798392418155, 8298.668053277801, 8352.958235208785, 8481.194286542892, 8549.786255343666, 1813.4740925131828, 1825.0965771942974, 1874.5313671582105, 1886.6132442849182, 1910.169076451748, 807.6284908941835, 851.3231980575457, 882.8984666763276, 904.1500989070253, 918.3250311021394, 16504.33982640705, 16651.084190369405, 16887.493375198763, 17114.0, 17504.737428938577, 835.8286551257099, 839.8656215005692, 847.4449235750593, 861.5132450165762, 888.3470649072926, 9329.34694571387, 9604.423734575948, 9608.471534065553, 9623.470709111067, 9810.0, 392225.0, 399028.0, 402635.0, 404002.0, 406875.0, 79996.0, 80275.19724802794, 81049.59475202704, 81081.0, 82073.0, 879.6921077622909, 892.7143314139413, 899.5547204133995, 900.0774206438452, 906.4380084347615, 15038.54884353471, 15115.244237788287, 15162.104736907886, 15236.0, 15696.136712480924, 35540.289194216486, 36076.63923360838, 36120.0, 36831.44752828656, 36972.0, 49787.50212497829, 50320.49679503305, 50680.746596266785, 50684.493155067976, 50686.746566266935, 7107.360337569644, 7456.888146677913, 7503.212162722835, 7700.229977002479, 7756.728514501965, 8959.507227102571, 11386.544538218379, 11401.885981140415, 11526.654200374001, 11563.190576659554, 8976.28189744832, 9271.30465215125, 9300.348975571645, 9329.11373419524, 9422.481763503074, 9776.87241935425, 10077.294589378966, 10212.131968782736, 10230.6419275325, 10294.073533382032, 9261.981182070102, 9351.849074712718, 9519.857202142111, 9540.141387275178, 9631.951840240754, 7734.7679569613, 7873.921260787319, 7911.84176316459, 7989.760307190793, 7994.600269986594, 9382.812343753223, 9465.858012129962, 9545.140937315397, 9620.71137865865, 9639.855402168832], "value": 9061.23787184382, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.6579749238224, 1454.1565891782768, 1573.984260157398, 1735.3058776489395, 1758.0682238413644, 6836.4530837533, 7366.968624392589, 7524.285192906672, 7822.452428330026, 7833.255840695139, 7387.889181662266, 7509.699612015513, 7561.886571701429, 7562.962185189066, 7587.962060189705, 2177.1944380579207, 2222.866628002317, 2226.9888650556804, 2228.543148654522, 2229.2086309360106, 2143.174877672092, 2186.835987300951, 2201.5376770878056, 2202.031106313225, 2210.7126073610407, 2217.756046834847, 2224.7552769195377, 2247.1236217875044, 2249.0666373454997, 2263.76230495798, 2156.3962090614496, 2171.4245724882917, 2171.522265101675, 2175.0755928730305, 2182.181681869299, 2129.6486079796814, 2142.5607750411127, 2157.56848630273, 2162.740471143457, 2174.4563859035243, 7626.466147369686, 7812.804679882992, 7817.609119544, 7819.413543984224, 7847.372210223226, 4595.333676616872, 4804.5916097131785, 4809.927851082237, 4815.470298267188, 4820.951790482085, 2772.750452459268, 2834.5464725643797, 2871.6984716604666, 2900.129961011688, 2927.5315949447986, 911.7766147293889, 914.826183025223, 933.0110083311712, 960.7886265021684, 962.4033099478369, 9953.104220620178, 10124.746881327952, 10175.389476631351, 10198.490075496196, 10252.641157559525, 4248.681348898845, 4258.68059895509, 4352.7823608819435, 4379.824807007748, 4390.1878152541885, 8932.821343573092, 8980.0, 8992.685256016008, 9009.819803604023, 9024.36829421934, 4628.675992680547, 4697.389339385858, 4722.150012997625, 4748.311494833299, 4773.164696178224, 3812.4662547243406, 4228.682848786353, 4315.913681726411, 4356.128774245164, 4402.7358358498595, 3640.9635903640624, 3653.8903832885057, 3715.6098609645596, 3747.681447077029, 3773.1510410158044, 1191.5531675621642, 1214.690253985228, 1221.0353820481898, 1240.7084335181225, 1241.4785789968234, 712.8004158835431, 760.6082867323333, 764.6215123513786, 810.3071873548149, 819.5082950229814, 5290.391604965478, 5497.697626630494, 5575.944240557624, 5626.324841019104, 5734.598578099493, 842.0, 960.2201626291846, 982.40564458503, 1002.9448380339152, 1012.7822518158484, 3769.3968964965475, 3887.086534664352, 3905.4922860028014, 3907.081835768592, 3917.5690674025836, 9095.226905713089, 9425.25632757942, 9432.292578056673, 9490.383125096847, 9531.761705957268, 9247.583858726373, 9336.253099752004, 9424.764380890532, 9434.433933963985, 9455.952720236355, 6904.344087311697, 7278.963605182046, 7478.85042299151, 7481.8877716834295, 7490.101187857383, 5199.194124910645, 5250.238715386324, 5636.436356364495, 5645.1532270159805, 5754.108113242454, 8582.0, 8743.213110820057, 8756.649734010569, 8865.379423440298, 8878.200961913459, 9026.097390260922, 9027.052159523419, 9181.173694367271, 9323.02108278621, 9379.953100234456, 6371.0, 6372.267189273293, 6378.170837791057, 6474.417302442803, 6501.2198536175965, 7274.781756547312, 7323.414126869944, 7337.229590893093, 7348.816279593053, 7385.48301618903, 6585.3085426029575, 6711.295313992156, 6770.424513916372, 6774.627395493098, 6820.795376138723, 6547.607143571401, 6552.180977377828, 6618.305077966937, 6636.0, 6716.361945615159, 5821.854453638693, 6032.607880487754, 6182.536309776695, 6258.342873998165, 6262.906056409249, 4632.490426053064, 4685.180093483695, 4725.787339569796, 4758.1435341638835, 4778.928316075192, 4736.407949006374, 4754.0, 4805.399325084364, 4808.374911261513, 4818.204996175732], "value": 4170.5691661751625, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.27856170225505, 299.2862024072586, 302.9424409362221, 304.57815924943947, 307.2441793188756, 4862.927056094157, 4936.3829521309835, 4969.552740253376, 4970.975145124278, 4976.178930476467, 4795.280707893818, 4825.107355139302, 4835.05716385305, 4878.463369029404, 4885.462599114104, 3601.171730501986, 3718.5909549949483, 3821.4840996465537, 3823.3941744467393, 3867.207222519391, 3829.636184562462, 3842.6349496797898, 3846.384578467446, 3846.4807251021175, 3846.903827404309, 3783.451399547078, 3790.6777923876502, 3797.613870937102, 3809.3714537101346, 3824.541055073395, 3532.2229109595846, 3789.7347185697013, 3811.6188381161937, 3831.885043448701, 3836.865709700147, 3265.755068369882, 3292.3415316936707, 3300.1914530940076, 3304.240024794287, 3316.6899074865532, 4658.18481765693, 4672.579467847876, 4687.601553867926, 4693.55411235932, 4694.647901407374, 4299.398084268205, 4300.677449191292, 4302.806373713191, 4307.117041006586, 4321.956780432187, 4972.87567810804, 5075.162598171298, 5113.51421614946, 5117.822900732852, 5118.872028199287, 3607.971728057491, 3622.293652737691, 3623.963760362389, 3634.945475817865, 3646.8541258349633, 5330.466953304677, 5384.865378365533, 5398.570643210571, 5413.485718856702, 5450.291462109901, 3457.4468085106764, 3680.3375392429084, 3680.3743363628246, 3684.705223582107, 3696.5933747287777, 3732.197577520846, 3734.402495600691, 3738.2336620992633, 3753.3619284721663, 3754.605766394544, 4251.192273468031, 4291.871243862689, 4300.075483771005, 4300.354946757949, 4322.3516472528745, 5044.974775126101, 5191.2472691459525, 5208.166693329049, 5212.296339994128, 5213.713245771443, 1375.6835927736677, 1376.8691974262429, 1381.2265131526378, 1383.8616138386283, 1387.549046559872, 846.1115828380176, 901.7610333261691, 903.5437104262305, 931.1061381074245, 933.0902370189146, 4422.5356337584735, 4561.954380456219, 4571.885702857455, 4574.748388838646, 4585.174668559691, 5309.681419114865, 5313.734313284398, 5324.946750532523, 5339.652922560022, 5351.3578370595, 4446.420631391696, 4562.406887104655, 4573.885652858705, 4588.2888152336445, 4603.631709463235, 3023.380207057548, 3048.9176342398573, 3075.9231019224253, 3077.584526088994, 3087.274490494732, 5364.249005139283, 5366.597505187048, 5370.140777475585, 5373.032854086224, 5375.919361209585, 5666.546676265889, 5858.2677165354335, 5874.0, 5898.970505147447, 5904.228731380568, 5319.867003324948, 5330.840074797762, 5343.812966546152, 5346.732663366816, 5385.515303622693, 5765.7693692253515, 5767.8464307139575, 5774.595778295647, 5775.451332123442, 5779.36426993022, 5446.128619421032, 5614.747336369955, 5616.742289472178, 5646.06839871433, 5653.0, 5340.5994550408095, 5358.35699716021, 5363.812266570807, 5365.114756065205, 5372.865678358073, 3872.1287710266092, 3877.340852055214, 3881.3789793634014, 3882.80585970706, 3887.3002859485564, 5081.644284900021, 5313.442088580643, 5316.989771943318, 5317.7341132943975, 5318.175682769177, 5153.788859618062, 5165.405978312542, 5177.508136727005, 5184.377874655065, 5201.713905735221, 4894.608431325414, 5169.53474187325, 5171.224316352577, 5173.1722924331925, 5191.377034755854, 5049.823256186163, 5067.417247016493, 5087.618428617794, 5111.87220319495, 5135.281060651587, 4929.457759646508, 5053.418856831365, 5149.176131818891, 5192.428832828461, 5217.34783152106, 5076.162433198481, 5107.131787596192, 5126.743947732829, 5128.58971282304, 5151.845444636667], "value": 3936.121821550814, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.5989246290919, 689.5621280486889, 696.1263614164225, 760.5474742528197, 795.4392153531761, 11370.0, 12103.939480302608, 12264.81602775958, 12268.263904165757, 12317.199382040173, 12071.818922716166, 12077.818832717494, 12083.456244468998, 12115.151939364227, 12170.269783812977, 625.0967352176108, 765.5904091311149, 783.2832957843581, 801.1707882341777, 812.252727490707, 801.887735717, 802.3420794948115, 803.1005274092995, 803.7307501986842, 804.0632662947659, 850.9914900851005, 851.4252879306474, 852.3564708644965, 852.4757274276307, 855.0850589868812, 833.0544831616098, 840.0675250471971, 841.9326453883674, 843.8607629741085, 844.273924424994, 619.2228752915108, 619.3465893482374, 619.3496828330235, 620.9937900620981, 622.1476577089417, 11926.284422934652, 11940.044796416265, 11994.940025299906, 12004.579839705655, 12073.27560346382, 11864.338992541052, 12115.394230288539, 12135.878641213563, 12140.0, 12257.168825720888, 10925.617603383924, 10935.671929842118, 10959.56161753529, 11039.83440248397, 11118.0, 3391.8473668684724, 3400.1499625093725, 3455.481677748358, 3480.3561341151967, 3486.6687664671817, 44059.55940440619, 44171.337429938576, 44298.33552496715, 44755.3286700703, 44777.32834007493, 9710.320277580502, 9754.561044753003, 9873.308868379145, 10175.0, 10375.740606484747, 17576.209070591853, 17599.82400175982, 17614.471565853044, 17614.91192544029, 17671.204795784222, 6365.458935990493, 6506.4469520091325, 6602.042703807921, 6681.064650948871, 6735.528513004043, 3554.0, 3644.580873199563, 3661.1579336752698, 3687.1888184599347, 3698.519192504957, 2778.152663437671, 2890.913272601825, 2891.2193707699225, 2894.233028247516, 2894.3921776426764, 499.61280007994094, 504.7097918696764, 514.7452011254453, 518.1217835768412, 522.1879976636291, 551.2805788446117, 562.6399104573077, 569.4135040907789, 589.6108568344957, 593.6705128653552, 7215.530990485601, 7422.628868556659, 7457.7016919323705, 7465.664045117983, 7547.28300811422, 513.1712284660247, 532.281420082885, 534.3507638219581, 546.3171036204744, 551.4623242338688, 3468.4797280408143, 3509.8596056157467, 3526.947095793565, 3546.0, 3552.946705799415, 49182.75408622934, 51163.74418127885, 51984.48015519796, 52047.12272824088, 53149.46850531445, 45510.772446137555, 45554.5444545557, 45943.77028114838, 46278.53721462809, 46488.767556162005, 41302.0, 41360.58639413628, 41388.0, 41598.0, 41658.37512437316, 6421.229452465734, 6477.4494167996245, 6576.901346479711, 6606.570572912745, 6622.503312251504, 28438.146855594365, 28825.711742882304, 28984.275393115342, 29200.26999325034, 29243.85378073096, 34176.48735268923, 37863.81068094642, 38339.61660383472, 38561.0, 39390.212195756496, 8423.410361274897, 8679.609417576097, 8709.042005379277, 8737.606807693543, 8818.779530511789, 9057.728268151966, 9066.410683305565, 9211.355205135576, 9291.67479138227, 9338.859917101114, 8108.270255677017, 8395.829065636874, 8746.081661425713, 8800.60397282111, 8811.867821982547, 8596.269317108116, 8743.868841967504, 8798.604062817316, 8882.555872206234, 8884.689035883972, 8238.50568965864, 8644.394892357475, 8834.249088827522, 9140.771480713036, 9251.0, 8067.515949043076, 8399.580020999048, 8446.66213351459, 8463.915360846559, 8689.522076285864, 8200.138985406445, 8238.423310368216, 8323.916760832315, 8385.706500272461, 8392.244697977212], "value": 5608.507566680115, "unit": "score"}], "name": "dromaeo_css", "value": 6291.952771541617, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 114.0, 115.0, 127.0, 116.0, 113.0, 117.0, 113.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 136.0, 168.0, 184.0, 138.0, 163.0, 165.0, 138.0, 198.0, 140.0], "value": 159.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 167.0, 168.0, 167.0, 162.0, 163.0, 162.0, 166.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 159.0, 82.0, 81.0, 75.0, 76.0, 162.0, 77.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 146.0, 95.0, 94.0, 94.0, 152.0, 95.0, 93.0, 145.0], "value": 110.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 120.0, 117.0, 118.0, 126.0, 119.0, 119.0, 117.0], "value": 118.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 148.0, 147.0, 148.0, 149.0, 147.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 70.0, 69.0, 69.0, 69.0, 86.0, 69.0, 67.0], "value": 70.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 84.0, 84.0, 85.0, 83.0, 83.0, 83.0, 83.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 134.0, 142.0, 137.0, 135.0, 134.0, 147.0, 178.0, 134.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 180.0, 178.0, 191.0, 178.0, 185.0, 179.0, 184.0, 181.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 80.0, 77.0, 75.0, 74.0, 74.0, 77.0, 74.0], "value": 76.0, "unit": "score"}], "name": "kraken", "value": 1624.1999999999998, "alertThreshold": 2.0}]} 18:24:13 INFO - Return code: 0 18:24:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:24:13 ERROR - # TBPL SUCCESS # 18:24:13 INFO - Running post-action listener: _resource_record_post_action 18:24:13 INFO - Running post-run listener: _resource_record_post_run 18:24:14 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 322023424; Read time: 0; Write time: 332160 18:24:14 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 19042304; Read time: 0; Write time: 15208 18:24:14 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 292495360; Read time: 0; Write time: 315324 18:24:14 INFO - Running post-run listener: _upload_blobber_files 18:24:14 INFO - Blob upload gear active. 18:24:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:24:14 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 18:24:14 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'] 18:24:14 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 18:24:14 INFO - (blobuploader) - INFO - Open directory for files ... 18:24:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:24:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:15 INFO - (blobuploader) - INFO - Done attempting. 18:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:24:16 INFO - (blobuploader) - INFO - Done attempting. 18:24:16 INFO - (blobuploader) - INFO - Iteration through files over. 18:24:16 INFO - Return code: 0 18:24:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:24:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:24:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/785f9ff0313bc0d9c1b9ffebec228878f3d2fa7df6381b163fe5e8ea7a30872fe816f99ce5ed8de1dabe5d8fdc9a0e060d2392b80e15cbb991beb33e2bbd7a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/845fe229382349ffe939a0ff2158fca2eac3b0af7b82a78494e76969256e6055958b0d442b6f041e50d78a2071dee979f23dfc11fa3bec137f48314147c7ee9f"} 18:24:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:24:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:24:16 INFO - Contents: 18:24:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/785f9ff0313bc0d9c1b9ffebec228878f3d2fa7df6381b163fe5e8ea7a30872fe816f99ce5ed8de1dabe5d8fdc9a0e060d2392b80e15cbb991beb33e2bbd7a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/845fe229382349ffe939a0ff2158fca2eac3b0af7b82a78494e76969256e6055958b0d442b6f041e50d78a2071dee979f23dfc11fa3bec137f48314147c7ee9f"} 18:24:16 INFO - Running post-run listener: copy_logs_to_upload_dir 18:24:16 INFO - Copying logs to upload dir... 18:24:16 INFO - mkdir: /builds/slave/test/build/upload/logs 18:24:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1297.955558 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-04-29 18:24:15.136887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:15.140142) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591 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/785f9ff0313bc0d9c1b9ffebec228878f3d2fa7df6381b163fe5e8ea7a30872fe816f99ce5ed8de1dabe5d8fdc9a0e060d2392b80e15cbb991beb33e2bbd7a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/845fe229382349ffe939a0ff2158fca2eac3b0af7b82a78494e76969256e6055958b0d442b6f041e50d78a2071dee979f23dfc11fa3bec137f48314147c7ee9f"} build_url:https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011327 build_url: 'https://queue.taskcluster.net/v1/task/T_aO63P6R7W6pA4HMTnpDQ/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/785f9ff0313bc0d9c1b9ffebec228878f3d2fa7df6381b163fe5e8ea7a30872fe816f99ce5ed8de1dabe5d8fdc9a0e060d2392b80e15cbb991beb33e2bbd7a99", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/845fe229382349ffe939a0ff2158fca2eac3b0af7b82a78494e76969256e6055958b0d442b6f041e50d78a2071dee979f23dfc11fa3bec137f48314147c7ee9f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:15.168871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:15.169297) ========= 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=6d15e502d8e29d5d2676d664000001c3-1461975110.402081-1998285591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:15.253677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:24:15.254012) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:24:15.254340) ========= ========= Total master_lag: 0.26 =========