builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1461979472.94 results: success (0) buildid: 20160429175034 builduid: 079c86fad6e54276990d8252d8cd2b1c revision: f58bd13402ee8c40e6f2e48bdecc28b372a9c9db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:32.939870) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:32.940698) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:32.941306) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:32.975895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:32.976204) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 18:24:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-04-29 18:24:33 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163485 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.154697) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.155259) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017845 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.207759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.208168) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f58bd13402ee8c40e6f2e48bdecc28b372a9c9db --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 f58bd13402ee8c40e6f2e48bdecc28b372a9c9db --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=5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 18:24:33,290 truncating revision to first 12 chars 2016-04-29 18:24:33,290 Setting DEBUG logging. 2016-04-29 18:24:33,290 attempt 1/10 2016-04-29 18:24:33,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f58bd13402ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 18:24:33,568 unpacking tar archive at: fx-team-f58bd13402ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.799926) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.800512) ========= script_repo_revision: f58bd13402ee8c40e6f2e48bdecc28b372a9c9db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.801229) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.801694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 18:24:33.819279) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-29 18:24:33.819918) ========= /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=5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:24:33 INFO - MultiFileLogger online at 20160429 18:24:33 in /builds/slave/test 18:24:33 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:24:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:24:33 INFO - {'append_to_log': False, 18:24:33 INFO - 'base_work_dir': '/builds/slave/test', 18:24:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:24:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:24:33 INFO - 'branch': 'Fx-Team-Non-PGO', 18:24:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:24:33 INFO - 'config_files': ('talos/linux_config.py',), 18:24:33 INFO - 'default_actions': ('clobber', 18:24:33 INFO - 'read-buildbot-config', 18:24:33 INFO - 'download-and-extract', 18:24:33 INFO - 'populate-webroot', 18:24:33 INFO - 'create-virtualenv', 18:24:33 INFO - 'install', 18:24:33 INFO - 'run-tests'), 18:24:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:24:33 INFO - 'download_minidump_stackwalk': True, 18:24:33 INFO - 'download_symbols': 'ondemand', 18:24:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:24:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:24:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:24:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:24:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:24:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:24:33 INFO - 'installer_path': 'installer.exe', 18:24:33 INFO - 'log_level': 'info', 18:24:33 INFO - 'log_name': 'talos', 18:24:33 INFO - 'log_to_console': True, 18:24:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:24:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:24:33 INFO - 'opt_config_files': (), 18:24:33 INFO - 'pip_index': False, 18:24:33 INFO - 'sps_profile': False, 18:24:33 INFO - 'sps_profile_interval': 0, 18:24:33 INFO - 'suite': 'dromaeojs-e10s', 18:24:33 INFO - 'system_bits': '32', 18:24:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:24:33 INFO - 'title': 'talos-linux64-ix-039', 18:24:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:24:33 INFO - 'use_talos_json': True, 18:24:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:24:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:24:33 INFO - 'work_dir': 'build'} 18:24:33 INFO - ##### 18:24:33 INFO - ##### Running clobber step. 18:24:33 INFO - ##### 18:24:33 INFO - Running pre-action listener: _resource_record_pre_action 18:24:33 INFO - Running main action method: clobber 18:24:33 INFO - rmtree: /builds/slave/test/build 18:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:24:34 INFO - Running post-action listener: _resource_record_post_action 18:24:34 INFO - ##### 18:24:34 INFO - ##### Running read-buildbot-config step. 18:24:34 INFO - ##### 18:24:34 INFO - Running pre-action listener: _resource_record_pre_action 18:24:34 INFO - Running main action method: read_buildbot_config 18:24:34 INFO - Using buildbot properties: 18:24:34 INFO - { 18:24:34 INFO - "project": "", 18:24:34 INFO - "product": "firefox", 18:24:34 INFO - "script_repo_revision": "production", 18:24:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:24:34 INFO - "repository": "", 18:24:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:24:34 INFO - "buildid": "20160429175034", 18:24:34 INFO - "pgo_build": "False", 18:24:34 INFO - "basedir": "/builds/slave/test", 18:24:34 INFO - "buildnumber": 1238, 18:24:34 INFO - "slavename": "talos-linux64-ix-039", 18:24:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:24:34 INFO - "platform": "ubuntu64_hw", 18:24:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:24:34 INFO - "branch": "fx-team", 18:24:34 INFO - "repo_path": "integration/fx-team", 18:24:34 INFO - "revision": "f58bd13402ee8c40e6f2e48bdecc28b372a9c9db", 18:24:34 INFO - "stage_platform": "linux64", 18:24:34 INFO - "builduid": "079c86fad6e54276990d8252d8cd2b1c", 18:24:34 INFO - "slavebuilddir": "test" 18:24:34 INFO - } 18:24:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 18:24:34 INFO - Running post-action listener: _resource_record_post_action 18:24:34 INFO - ##### 18:24:34 INFO - ##### Running download-and-extract step. 18:24:34 INFO - ##### 18:24:34 INFO - Running pre-action listener: _resource_record_pre_action 18:24:34 INFO - Running main action method: download_and_extract 18:24:34 INFO - mkdir: /builds/slave/test/build/tests 18:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:34 INFO - https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:35 INFO - Downloaded 1361 bytes. 18:24:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 18:24:35 INFO - Using the following test package requirements: 18:24:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:24:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:24:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:24:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'jsshell-linux-x86_64.zip'], 18:24:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:24:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 18:24:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:24:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:24:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:24:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 18:24:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:24:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:24:35 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:24:35 INFO - https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:36 INFO - Downloaded 22304506 bytes. 18:24:36 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:24:36 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:24:38 INFO - Return code: 0 18:24:38 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:24:38 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:24:38 INFO - https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:24:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 18:24:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:39 INFO - Downloaded 22304506 bytes. 18:24:39 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:24:39 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:24:40 INFO - Return code: 0 18:24:40 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:24:40 INFO - https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:24:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 18:24:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:42 INFO - Downloaded 10840152 bytes. 18:24:42 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:24:42 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:24:42 INFO - Return code: 0 18:24:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:24:42 INFO - https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HYrVyTYbSQODRnnNwp2DDw/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:24:46 INFO - Downloaded 54912749 bytes. 18:24:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:46 INFO - mkdir: /builds/slave/test/properties 18:24:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:24:46 INFO - Writing to file /builds/slave/test/properties/build_url 18:24:46 INFO - Contents: 18:24:46 INFO - build_url:https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 18:24:47 INFO - Running post-action listener: _resource_record_post_action 18:24:47 INFO - Running post-action listener: set_extra_try_arguments 18:24:47 INFO - ##### 18:24:47 INFO - ##### Running populate-webroot step. 18:24:47 INFO - ##### 18:24:47 INFO - Running pre-action listener: _resource_record_pre_action 18:24:47 INFO - Running main action method: populate_webroot 18:24:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:24:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:24:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:24:47 INFO - '--tppagecycles', 18:24:47 INFO - '7'], 18:24:47 INFO - 'tests': ['tsvgm']}}, 18:24:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:24:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:24:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:24:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:24:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:24:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['damp', 'tps']}, 18:24:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'tests': ['damp', 'tps']}, 18:24:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['dromaeo_dom']}, 18:24:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:24:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['a11yr', 18:24:47 INFO - 'ts_paint', 18:24:47 INFO - 'tpaint', 18:24:47 INFO - 'sessionrestore', 18:24:47 INFO - 'sessionrestore_no_auto_restore', 18:24:47 INFO - 'tabpaint']}, 18:24:47 INFO - 'other-e10s': {'tests': ['a11yr', 18:24:47 INFO - 'ts_paint', 18:24:47 INFO - 'tpaint', 18:24:47 INFO - 'sessionrestore', 18:24:47 INFO - 'sessionrestore_no_auto_restore', 18:24:47 INFO - 'tabpaint']}, 18:24:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:24:47 INFO - 'ts_paint', 18:24:47 INFO - 'tpaint', 18:24:47 INFO - 'sessionrestore', 18:24:47 INFO - 'sessionrestore_no_auto_restore', 18:24:47 INFO - 'tabpaint']}, 18:24:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:24:47 INFO - 'ts_paint', 18:24:47 INFO - 'tpaint', 18:24:47 INFO - 'sessionrestore', 18:24:47 INFO - 'sessionrestore_no_auto_restore', 18:24:47 INFO - 'tabpaint']}, 18:24:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['a11yr', 18:24:47 INFO - 'ts_paint', 18:24:47 INFO - 'tpaint', 18:24:47 INFO - 'sessionrestore', 18:24:47 INFO - 'sessionrestore_no_auto_restore', 18:24:47 INFO - 'tabpaint']}, 18:24:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['a11yr', 18:24:47 INFO - 'ts_paint', 18:24:47 INFO - 'tpaint', 18:24:47 INFO - 'sessionrestore', 18:24:47 INFO - 'sessionrestore_no_auto_restore', 18:24:47 INFO - 'tabpaint']}, 18:24:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['tsvgx', 18:24:47 INFO - 'tsvgr_opacity', 18:24:47 INFO - 'tart', 18:24:47 INFO - 'tscrollx', 18:24:47 INFO - 'cart']}, 18:24:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:24:47 INFO - 'tsvgr_opacity', 18:24:47 INFO - 'tart', 18:24:47 INFO - 'tscrollx', 18:24:47 INFO - 'cart']}, 18:24:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'talos_options': ['--disable-e10s'], 18:24:47 INFO - 'tests': ['tp5o']}, 18:24:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'tests': ['tp5o']}, 18:24:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'talos_options': ['--disable-e10s', 18:24:47 INFO - '--xperf_path', 18:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:47 INFO - 'tests': ['tp5n']}, 18:24:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:24:47 INFO - 'talos_options': ['--xperf_path', 18:24:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:24:47 INFO - 'tests': ['tp5n']}}, 18:24:47 INFO - 'talos.zip': {'path': '', 18:24:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:24:47 INFO - Running post-action listener: _resource_record_post_action 18:24:47 INFO - ##### 18:24:47 INFO - ##### Running create-virtualenv step. 18:24:47 INFO - ##### 18:24:47 INFO - Running pre-action listener: _resource_record_pre_action 18:24:47 INFO - Running main action method: create_virtualenv 18:24:47 INFO - Creating virtualenv /builds/slave/test/build/venv 18:24:47 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:24:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:24:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:24:47 INFO - Using real prefix '/usr' 18:24:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:24:47 INFO - Installing distribute.............................................................................................................................................................................................done. 18:24:49 INFO - Installing pip.................done. 18:24:49 INFO - Return code: 0 18:24:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:24:49 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:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:49 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:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:49 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:24:49 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:24:49 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:24:49 INFO - Using env: {'DISPLAY': ':0', 18:24:49 INFO - 'HOME': '/home/cltbld', 18:24:49 INFO - 'LANG': 'en_US.UTF-8', 18:24:49 INFO - 'LANGUAGE': 'en_US:en', 18:24:49 INFO - 'LOGNAME': 'cltbld', 18:24:49 INFO - 'MAIL': '/var/mail/cltbld', 18:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:49 INFO - 'MOZ_NO_REMOTE': '1', 18:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:49 INFO - 'NO_EM_RESTART': '1', 18:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:49 INFO - 'PWD': '/builds/slave/test', 18:24:49 INFO - 'SHELL': '/bin/bash', 18:24:49 INFO - 'SHLVL': '1', 18:24:49 INFO - 'TERM': 'linux', 18:24:49 INFO - 'TMOUT': '86400', 18:24:49 INFO - 'USER': 'cltbld', 18:24:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:49 INFO - '_': '/tools/buildbot/bin/python'} 18:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:49 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:24:49 INFO - Cleaning up... 18:24:49 INFO - Return code: 0 18:24:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:24:49 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:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:49 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:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:49 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:24:49 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:24:49 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:24:50 INFO - Using env: {'DISPLAY': ':0', 18:24:50 INFO - 'HOME': '/home/cltbld', 18:24:50 INFO - 'LANG': 'en_US.UTF-8', 18:24:50 INFO - 'LANGUAGE': 'en_US:en', 18:24:50 INFO - 'LOGNAME': 'cltbld', 18:24:50 INFO - 'MAIL': '/var/mail/cltbld', 18:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:50 INFO - 'MOZ_NO_REMOTE': '1', 18:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:50 INFO - 'NO_EM_RESTART': '1', 18:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:50 INFO - 'PWD': '/builds/slave/test', 18:24:50 INFO - 'SHELL': '/bin/bash', 18:24:50 INFO - 'SHLVL': '1', 18:24:50 INFO - 'TERM': 'linux', 18:24:50 INFO - 'TMOUT': '86400', 18:24:50 INFO - 'USER': 'cltbld', 18:24:50 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:50 INFO - '_': '/tools/buildbot/bin/python'} 18:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:50 INFO - Downloading/unpacking psutil>=0.7.1 18:24:50 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:24:50 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:24:50 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:24:50 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:24:50 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:24:50 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:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:52 INFO - Installing collected packages: psutil 18:24:52 INFO - Running setup.py install for psutil 18:24:52 INFO - building 'psutil._psutil_linux' extension 18:24:52 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:24:52 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:24:52 INFO - building 'psutil._psutil_posix' extension 18:24:52 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:24:52 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:24:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:24:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:24:52 INFO - Successfully installed psutil 18:24:52 INFO - Cleaning up... 18:24:52 INFO - Return code: 0 18:24:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:24:52 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:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:52 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:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:52 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:24:52 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:24:52 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:24:52 INFO - Using env: {'DISPLAY': ':0', 18:24:52 INFO - 'HOME': '/home/cltbld', 18:24:52 INFO - 'LANG': 'en_US.UTF-8', 18:24:52 INFO - 'LANGUAGE': 'en_US:en', 18:24:52 INFO - 'LOGNAME': 'cltbld', 18:24:52 INFO - 'MAIL': '/var/mail/cltbld', 18:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:52 INFO - 'MOZ_NO_REMOTE': '1', 18:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:52 INFO - 'NO_EM_RESTART': '1', 18:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:52 INFO - 'PWD': '/builds/slave/test', 18:24:52 INFO - 'SHELL': '/bin/bash', 18:24:52 INFO - 'SHLVL': '1', 18:24:52 INFO - 'TERM': 'linux', 18:24:52 INFO - 'TMOUT': '86400', 18:24:52 INFO - 'USER': 'cltbld', 18:24:52 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:52 INFO - '_': '/tools/buildbot/bin/python'} 18:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:24:54 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:24:54 INFO - Installing collected packages: mozsystemmonitor 18:24:54 INFO - Running setup.py install for mozsystemmonitor 18:24:54 INFO - Successfully installed mozsystemmonitor 18:24:54 INFO - Cleaning up... 18:24:54 INFO - Return code: 0 18:24:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:24:54 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:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:54 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:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:54 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:24:54 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:24:54 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:24:54 INFO - Using env: {'DISPLAY': ':0', 18:24:54 INFO - 'HOME': '/home/cltbld', 18:24:54 INFO - 'LANG': 'en_US.UTF-8', 18:24:54 INFO - 'LANGUAGE': 'en_US:en', 18:24:54 INFO - 'LOGNAME': 'cltbld', 18:24:54 INFO - 'MAIL': '/var/mail/cltbld', 18:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:54 INFO - 'MOZ_NO_REMOTE': '1', 18:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:54 INFO - 'NO_EM_RESTART': '1', 18:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:54 INFO - 'PWD': '/builds/slave/test', 18:24:54 INFO - 'SHELL': '/bin/bash', 18:24:54 INFO - 'SHLVL': '1', 18:24:55 INFO - 'TERM': 'linux', 18:24:55 INFO - 'TMOUT': '86400', 18:24:55 INFO - 'USER': 'cltbld', 18:24:55 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:55 INFO - '_': '/tools/buildbot/bin/python'} 18:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:55 INFO - Downloading/unpacking blobuploader==1.2.4 18:24: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:24: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:24: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:24: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:24: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:24: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:24:57 INFO - Downloading blobuploader-1.2.4.tar.gz 18:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:24:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:24:57 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:24:57 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:24:57 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:24:57 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:24:57 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:24:57 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:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:24:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:24:57 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:24:57 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:24:57 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:24:57 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:24:57 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:24:57 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:24:57 INFO - Downloading docopt-0.6.1.tar.gz 18:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:24:57 INFO - Installing collected packages: blobuploader, requests, docopt 18:24:57 INFO - Running setup.py install for blobuploader 18:24:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:24:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:24:57 INFO - Running setup.py install for requests 18:24:58 INFO - Running setup.py install for docopt 18:24:58 INFO - Successfully installed blobuploader requests docopt 18:24:58 INFO - Cleaning up... 18:24:58 INFO - Return code: 0 18:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:24: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:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24: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:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:24:58 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:24:58 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:24:58 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:24:58 INFO - Using env: {'DISPLAY': ':0', 18:24:58 INFO - 'HOME': '/home/cltbld', 18:24:58 INFO - 'LANG': 'en_US.UTF-8', 18:24:58 INFO - 'LANGUAGE': 'en_US:en', 18:24:58 INFO - 'LOGNAME': 'cltbld', 18:24:58 INFO - 'MAIL': '/var/mail/cltbld', 18:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:24:58 INFO - 'MOZ_NO_REMOTE': '1', 18:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:24:58 INFO - 'NO_EM_RESTART': '1', 18:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:24:58 INFO - 'PWD': '/builds/slave/test', 18:24:58 INFO - 'SHELL': '/bin/bash', 18:24:58 INFO - 'SHLVL': '1', 18:24:58 INFO - 'TERM': 'linux', 18:24:58 INFO - 'TMOUT': '86400', 18:24:58 INFO - 'USER': 'cltbld', 18:24:58 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:24:58 INFO - '_': '/tools/buildbot/bin/python'} 18:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:24:58 INFO - Running setup.py (path:/tmp/pip-QO_JaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:24:58 INFO - Running setup.py (path:/tmp/pip-UynnBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:24:58 INFO - Running setup.py (path:/tmp/pip-moMygO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:24:58 INFO - Running setup.py (path:/tmp/pip-TRduF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:24:58 INFO - Running setup.py (path:/tmp/pip-4tC9Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:24:58 INFO - Running setup.py (path:/tmp/pip-LYNj_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:24:59 INFO - Running setup.py (path:/tmp/pip-YBGpgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:24:59 INFO - Running setup.py (path:/tmp/pip-mQGllc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:24:59 INFO - Running setup.py (path:/tmp/pip-IvUOYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:24:59 INFO - Running setup.py (path:/tmp/pip-Lhzi2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:24:59 INFO - Running setup.py (path:/tmp/pip-Vp2zPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:24:59 INFO - Running setup.py (path:/tmp/pip-9IHwEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:24:59 INFO - Running setup.py (path:/tmp/pip-1GfslC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:24:59 INFO - Running setup.py (path:/tmp/pip-7d6j8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:59 INFO - Running setup.py (path:/tmp/pip-UaNRek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:24:59 INFO - Running setup.py (path:/tmp/pip-wSvV7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:24:59 INFO - Running setup.py (path:/tmp/pip-juOXtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:24:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:24:59 INFO - Running setup.py install for manifestparser 18:24:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:24:59 INFO - Running setup.py install for mozcrash 18:25:00 INFO - Running setup.py install for mozdebug 18:25:00 INFO - Running setup.py install for mozdevice 18:25:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Running setup.py install for mozfile 18:25:00 INFO - Running setup.py install for mozhttpd 18:25:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Running setup.py install for mozinfo 18:25:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Running setup.py install for mozInstall 18:25:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Running setup.py install for mozleak 18:25:00 INFO - Running setup.py install for mozlog 18:25:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Running setup.py install for moznetwork 18:25:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:25:00 INFO - Running setup.py install for mozprocess 18:25:01 INFO - Running setup.py install for mozprofile 18:25:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for mozrunner 18:25:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Running setup.py install for mozscreenshot 18:25:01 INFO - Running setup.py install for moztest 18:25:01 INFO - Running setup.py install for mozversion 18:25:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:25:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:25:01 INFO - Cleaning up... 18:25:01 INFO - Return code: 0 18:25:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:01 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:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:01 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:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:01 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:25:01 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:25:01 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:25:01 INFO - Using env: {'DISPLAY': ':0', 18:25:01 INFO - 'HOME': '/home/cltbld', 18:25:01 INFO - 'LANG': 'en_US.UTF-8', 18:25:01 INFO - 'LANGUAGE': 'en_US:en', 18:25:01 INFO - 'LOGNAME': 'cltbld', 18:25:01 INFO - 'MAIL': '/var/mail/cltbld', 18:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:01 INFO - 'MOZ_NO_REMOTE': '1', 18:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:01 INFO - 'NO_EM_RESTART': '1', 18:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:01 INFO - 'PWD': '/builds/slave/test', 18:25:01 INFO - 'SHELL': '/bin/bash', 18:25:01 INFO - 'SHLVL': '1', 18:25:01 INFO - 'TERM': 'linux', 18:25:01 INFO - 'TMOUT': '86400', 18:25:01 INFO - 'USER': 'cltbld', 18:25:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:01 INFO - '_': '/tools/buildbot/bin/python'} 18:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:25:01 INFO - Running setup.py (path:/tmp/pip-6zhZPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:25:01 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:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:25:01 INFO - Running setup.py (path:/tmp/pip-xCcZnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:25:01 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:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:25:01 INFO - Running setup.py (path:/tmp/pip-X8X3I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:25:02 INFO - Running setup.py (path:/tmp/pip-QM5ljw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:25:02 INFO - Running setup.py (path:/tmp/pip-T0Qi0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:25:02 INFO - Running setup.py (path:/tmp/pip-6wz2Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:25:02 INFO - Running setup.py (path:/tmp/pip-S9Cnkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:25:02 INFO - Running setup.py (path:/tmp/pip-PGsCQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:25:02 INFO - Running setup.py (path:/tmp/pip-TEAPCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:25:02 INFO - Running setup.py (path:/tmp/pip-XOHaU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:25:02 INFO - Running setup.py (path:/tmp/pip-ILpPMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:25:02 INFO - Running setup.py (path:/tmp/pip-5YGcXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:25:02 INFO - Running setup.py (path:/tmp/pip-_1N3CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:25:02 INFO - Running setup.py (path:/tmp/pip-uOKzKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:02 INFO - Running setup.py (path:/tmp/pip-xgV6lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:25:02 INFO - Running setup.py (path:/tmp/pip-XhPwRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:25:02 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:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:25:02 INFO - Running setup.py (path:/tmp/pip-0UhCX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:25:03 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:25:03 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:25:03 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:25:03 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:25:03 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:25:03 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:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:25: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:25: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:25: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:25: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:25: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:25: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:25:04 INFO - Downloading blessings-1.6.tar.gz 18:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:25:05 INFO - Installing collected packages: blessings 18:25:05 INFO - Running setup.py install for blessings 18:25:05 INFO - Successfully installed blessings 18:25:05 INFO - Cleaning up... 18:25:05 INFO - Return code: 0 18:25:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:05 INFO - Reading from file tmpfile_stdout 18:25:05 INFO - Current package versions: 18:25:05 INFO - argparse == 1.2.1 18:25:05 INFO - blessings == 1.6 18:25:05 INFO - blobuploader == 1.2.4 18:25:05 INFO - docopt == 0.6.1 18:25:05 INFO - manifestparser == 1.1 18:25:05 INFO - mozInstall == 1.12 18:25:05 INFO - mozcrash == 0.17 18:25:05 INFO - mozdebug == 0.1 18:25:05 INFO - mozdevice == 0.48 18:25:05 INFO - mozfile == 1.2 18:25:05 INFO - mozhttpd == 0.7 18:25:05 INFO - mozinfo == 0.9 18:25:05 INFO - mozleak == 0.1 18:25:05 INFO - mozlog == 3.1 18:25:05 INFO - moznetwork == 0.27 18:25:05 INFO - mozprocess == 0.22 18:25:05 INFO - mozprofile == 0.28 18:25:05 INFO - mozrunner == 6.11 18:25:05 INFO - mozscreenshot == 0.1 18:25:05 INFO - mozsystemmonitor == 0.0 18:25:05 INFO - moztest == 0.7 18:25:05 INFO - mozversion == 1.4 18:25:05 INFO - psutil == 3.1.1 18:25:05 INFO - requests == 1.2.3 18:25:05 INFO - wsgiref == 0.1.2 18:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:25:05 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:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:05 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:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:05 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:25:05 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:25:05 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:25:05 INFO - Using env: {'DISPLAY': ':0', 18:25:05 INFO - 'HOME': '/home/cltbld', 18:25:05 INFO - 'LANG': 'en_US.UTF-8', 18:25:05 INFO - 'LANGUAGE': 'en_US:en', 18:25:05 INFO - 'LOGNAME': 'cltbld', 18:25:05 INFO - 'MAIL': '/var/mail/cltbld', 18:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:05 INFO - 'MOZ_NO_REMOTE': '1', 18:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:05 INFO - 'NO_EM_RESTART': '1', 18:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:05 INFO - 'PWD': '/builds/slave/test', 18:25:05 INFO - 'SHELL': '/bin/bash', 18:25:05 INFO - 'SHLVL': '1', 18:25:05 INFO - 'TERM': 'linux', 18:25:05 INFO - 'TMOUT': '86400', 18:25:05 INFO - 'USER': 'cltbld', 18:25:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:05 INFO - '_': '/tools/buildbot/bin/python'} 18:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 INFO - Cleaning up... 18:25:05 INFO - Return code: 0 18:25:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:25:05 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:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:05 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:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:05 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:25:05 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:25:05 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:25:05 INFO - Using env: {'DISPLAY': ':0', 18:25:05 INFO - 'HOME': '/home/cltbld', 18:25:05 INFO - 'LANG': 'en_US.UTF-8', 18:25:05 INFO - 'LANGUAGE': 'en_US:en', 18:25:05 INFO - 'LOGNAME': 'cltbld', 18:25:05 INFO - 'MAIL': '/var/mail/cltbld', 18:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:05 INFO - 'MOZ_NO_REMOTE': '1', 18:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:05 INFO - 'NO_EM_RESTART': '1', 18:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:05 INFO - 'PWD': '/builds/slave/test', 18:25:05 INFO - 'SHELL': '/bin/bash', 18:25:05 INFO - 'SHLVL': '1', 18:25:05 INFO - 'TERM': 'linux', 18:25:05 INFO - 'TMOUT': '86400', 18:25:05 INFO - 'USER': 'cltbld', 18:25:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:05 INFO - '_': '/tools/buildbot/bin/python'} 18:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:05 INFO - Downloading/unpacking jsonschema 18:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:25:07 INFO - Downloading/unpacking functools32 (from jsonschema) 18:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 INFO - Downloading functools32-3.2.3-2.tar.gz 18:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:25:07 INFO - warning: no files found matching '*.txt' 18:25:07 INFO - no previously-included directories found matching 'build' 18:25:07 INFO - no previously-included directories found matching 'dist' 18:25:07 INFO - no previously-included directories found matching '.git*' 18:25:07 INFO - Installing collected packages: jsonschema, functools32 18:25:08 INFO - Running setup.py install for functools32 18:25:08 INFO - warning: no files found matching '*.txt' 18:25:08 INFO - no previously-included directories found matching 'build' 18:25:08 INFO - no previously-included directories found matching 'dist' 18:25:08 INFO - no previously-included directories found matching '.git*' 18:25:08 INFO - Successfully installed jsonschema functools32 18:25:08 INFO - Cleaning up... 18:25:08 INFO - Return code: 0 18:25:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:25: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:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25: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:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:25:08 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 0x7f22cf07bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x217a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', '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:25:08 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:25:08 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:25:08 INFO - Using env: {'DISPLAY': ':0', 18:25:08 INFO - 'HOME': '/home/cltbld', 18:25:08 INFO - 'LANG': 'en_US.UTF-8', 18:25:08 INFO - 'LANGUAGE': 'en_US:en', 18:25:08 INFO - 'LOGNAME': 'cltbld', 18:25:08 INFO - 'MAIL': '/var/mail/cltbld', 18:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:08 INFO - 'MOZ_NO_REMOTE': '1', 18:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:08 INFO - 'NO_EM_RESTART': '1', 18:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:08 INFO - 'PWD': '/builds/slave/test', 18:25:08 INFO - 'SHELL': '/bin/bash', 18:25:08 INFO - 'SHLVL': '1', 18:25:08 INFO - 'TERM': 'linux', 18:25:08 INFO - 'TMOUT': '86400', 18:25:08 INFO - 'USER': 'cltbld', 18:25:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:08 INFO - '_': '/tools/buildbot/bin/python'} 18:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:25:08 INFO - Downloading/unpacking flake8 18:25: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:25: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:25: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:25: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:25: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:25: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:25:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:25:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:25:10 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:25:10 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:25:10 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:25:10 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:25:10 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:25:10 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:25:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:25:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:25:10 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:25:10 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:25:10 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:25:10 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:25:10 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:25:10 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:25:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:25:10 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:25:10 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:25:10 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:25:10 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:25:10 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:25:10 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:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:25:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:25:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:25:10 INFO - no previously-included directories found matching 'docs/_build' 18:25:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:25:11 INFO - Running setup.py install for pep8 18:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:25:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:25:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:25:11 INFO - no previously-included directories found matching 'docs/_build' 18:25:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:25:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:25:11 INFO - Cleaning up... 18:25:11 INFO - Return code: 0 18:25:11 INFO - Running post-action listener: _resource_record_post_action 18:25:11 INFO - Running post-action listener: _start_resource_monitoring 18:25:11 INFO - Starting resource monitoring. 18:25:11 INFO - ##### 18:25:11 INFO - ##### Running install step. 18:25:11 INFO - ##### 18:25:11 INFO - Running pre-action listener: _resource_record_pre_action 18:25:11 INFO - Running main action method: install 18:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:25:11 INFO - Reading from file tmpfile_stdout 18:25:11 INFO - Detecting whether we're running mozinstall >=1.0... 18:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:25:11 INFO - Reading from file tmpfile_stdout 18:25:11 INFO - Output received: 18:25:11 INFO - Usage: mozinstall [options] installer 18:25:11 INFO - Options: 18:25:11 INFO - -h, --help show this help message and exit 18:25:11 INFO - -d DEST, --destination=DEST 18:25:11 INFO - Directory to install application into. [default: 18:25:11 INFO - "/builds/slave/test"] 18:25:11 INFO - --app=APP Application being installed. [default: firefox] 18:25:11 INFO - mkdir: /builds/slave/test/build/application 18:25:11 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:25:11 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:25:27 INFO - Reading from file tmpfile_stdout 18:25:27 INFO - Output received: 18:25:27 INFO - /builds/slave/test/build/application/firefox/firefox 18:25:27 INFO - Running post-action listener: _resource_record_post_action 18:25:27 INFO - ##### 18:25:27 INFO - ##### Running run-tests step. 18:25:27 INFO - ##### 18:25:27 INFO - Running pre-action listener: _resource_record_pre_action 18:25:27 INFO - Running main action method: run_tests 18:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:25:27 INFO - Python 2.7.3 18:25:27 INFO - Return code: 0 18:25:27 INFO - grabbing minidump binary from tooltool 18:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:25:27 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 0x2209410>, '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 0x220a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x220a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:25:27 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:25:27 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:25:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:25:27 INFO - Return code: 0 18:25:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:25:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:25:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:25:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:25:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:25:28 INFO - Return code: 0 18:25:28 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/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:25:28 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/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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:25:28 INFO - Using env: {'DISPLAY': ':0', 18:25:28 INFO - 'HOME': '/home/cltbld', 18:25:28 INFO - 'LANG': 'en_US.UTF-8', 18:25:28 INFO - 'LANGUAGE': 'en_US:en', 18:25:28 INFO - 'LOGNAME': 'cltbld', 18:25:28 INFO - 'MAIL': '/var/mail/cltbld', 18:25:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:25:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:25:28 INFO - 'MOZ_NO_REMOTE': '1', 18:25:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:25:28 INFO - 'NO_EM_RESTART': '1', 18:25:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:25:28 INFO - 'PWD': '/builds/slave/test', 18:25:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:25:28 INFO - 'SHELL': '/bin/bash', 18:25:28 INFO - 'SHLVL': '1', 18:25:28 INFO - 'TERM': 'linux', 18:25:28 INFO - 'TMOUT': '86400', 18:25:28 INFO - 'USER': 'cltbld', 18:25:28 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103', 18:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:25:28 INFO - '_': '/tools/buildbot/bin/python'} 18:25:28 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/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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:25:28 INFO - mozversion application_buildid: 20160429175034 18:25:28 INFO - mozversion application_changeset: f58bd13402ee8c40e6f2e48bdecc28b372a9c9db 18:25:28 INFO - mozversion application_display_name: Nightly 18:25:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:25:28 INFO - mozversion application_name: Firefox 18:25:28 INFO - mozversion application_remotingname: firefox 18:25:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:25:28 INFO - mozversion application_vendor: Mozilla 18:25:28 INFO - mozversion application_version: 49.0a1 18:25:28 INFO - mozversion platform_buildid: 20160429175034 18:25:28 INFO - mozversion platform_changeset: f58bd13402ee8c40e6f2e48bdecc28b372a9c9db 18:25:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:25:28 INFO - mozversion platform_version: 49.0a1 18:25:28 INFO - using testdate: 1461979528 18:25:28 INFO - actual date: 1461979528 18:25:28 INFO - starting webserver on 'localhost:50681' 18:25:28 INFO - SUITE-START | Running 2 tests 18:25:28 INFO - TEST-START | dromaeo_css 18:25:28 INFO - operating with platform_type : linux_ 18:25:28 INFO - Initialising browser for dromaeo_css test... 18:25:28 INFO - TEST-INFO | started process 6271 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNze_dN/profile http://localhost:50681/getInfo.html) 18:25:32 INFO - PROCESS | 6271 | 18:25:32 INFO - PROCESS | 6271 | (process:6342): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:25:33 INFO - PROCESS | 6271 | __metrics Screen width/height:1600/1200 18:25:33 INFO - PROCESS | 6271 | colorDepth:24 18:25:33 INFO - PROCESS | 6271 | Browser inner width/height: 1024/697 18:25:33 INFO - PROCESS | 6271 | __metrics 18:25:34 ERROR - PROCESS | 6271 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:25:35 INFO - TEST-INFO | 6271: exit 0 18:25:35 INFO - Browser initialized. 18:25:35 INFO - Running cycle 1/1 for dromaeo_css test... 18:25:35 INFO - TEST-INFO | started process 6393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNze_dN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:25:37 INFO - PROCESS | 6393 | 18:25:37 INFO - PROCESS | 6393 | (process:6453): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:25:47 INFO - PROCESS | 6393 | RSS: Main: 166096896 18:25:47 INFO - PROCESS | 6393 | 18:26:36 INFO - PROCESS | 6393 | 1461979596800 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:28:48 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50681/tests/dromaeo/cssquery-ext.html) 18:28:49 INFO - PROCESS | 6393 | RSS: Main: 170463232 18:28:49 INFO - PROCESS | 6393 | 18:31:51 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-ext.html (next: http://localhost:50681/tests/dromaeo/cssquery-jquery.html) 18:31:51 INFO - PROCESS | 6393 | RSS: Main: 166309888 18:31:51 INFO - PROCESS | 6393 | 18:34:53 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50681/tests/dromaeo/cssquery-mootools.html) 18:34:54 INFO - PROCESS | 6393 | RSS: Main: 167383040 18:34:54 INFO - PROCESS | 6393 | 18:37:56 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50681/tests/dromaeo/cssquery-prototype.html) 18:37:56 INFO - PROCESS | 6393 | RSS: Main: 165613568 18:37:56 INFO - PROCESS | 6393 | 18:40:59 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50681/tests/dromaeo/cssquery-yui.html) 18:41:00 INFO - PROCESS | 6393 | RSS: Main: 166768640 18:41:00 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | Cycle 1(1): loaded http://localhost:50681/tests/dromaeo/cssquery-yui.html (next: http://localhost:50681/tests/dromaeo/cssquery-dojo.html) 18:44:02 INFO - PROCESS | 6393 | RSS: Main: 168939520 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | __start_tp_report 18:44:02 INFO - PROCESS | 6393 | _x_x_mozilla_page_load 18:44:02 INFO - PROCESS | 6393 | _x_x_mozilla_page_load_details 18:44:02 INFO - PROCESS | 6393 | |i|pagename|runs| 18:44:02 INFO - PROCESS | 6393 | |0;dojo.html;2592.1445922845464;2645.6428382168406;2678.9196324110285;2685.43605842773;2696.4876673432045;4692.5542073503;4710.340552322673;4718.764061796909;4732;4773.522647735224;4604.907901841962;4699.788509517071;4718.4809670936165;4738.597219236369;4780.689255198418;4315.180115778;4383.991681913162;4425.623821975136;4432.3573081903105;4450.310201918692;4350.847720329789;4408.97795511022;4431.933520997188;4434.423524941769;4461.286194208928;4288.828446862121;4362.36745671879;4364.67264955128;4380.9780951095045;4389.275769498029;4267.850625228133;4273.55127711592;4279.400883876228;4294.4202532658;4302.032042790347;4238.300680387732;4251.086016506435;4255.319148936155;4293.677974151919;4329.675274354436;4495.707778994355;4624.768761561909;4677.087967846272;4699.036697477009;4736.218523943545;5006;5021.84934451967;5028.4971502849785;5054.848354549369;5066.518680725325;4957.975210123926;5074.771635276422;5077.390713114413;5087.186050231945;5136.4606716295;4738.336632871401;4755.429348478205;4775.450823155382;4816.349792778;4817.51824817519;5148.794048238104;5162.6128040397125;5190.922136167885;5192.45479224676;5228.843134705965;4845.733484658307;4955.1576232039915;4957.256411538298;4982.950170498321;4984.750762461862;5124.30821839047;5125.103106956342;5141.126008578551;5152.046871328741;5195.532402083755;4880.975595122001;4923.089228492669;4940.2342636891335;4945;4985.302057711923;4850.345203397566;4958.330625365602;4998.150314446553;5008.69947803133;5060.1903695408555;4271.829126834954;4276.2089013532595;4285.528591854893;4316.330968699856;4316.870493885189;3675.889723308305;3715.479832823407;3723.3298006358573;3755.962440375616;3760.6803421708914;4304.870853874389;4315.029118448387;4360.454943132108;4372.213001659732;4392.692511524163;5059.797608095709;5077;5078.289039534468;5079.619028572872;5106.489351064938;4375.956240437555;4396.890077748082;4404.801783919731;4411.874672848251;4424.933625995613;4507.932381014288;4516.209663308908;4545.36364908913;4564.041551274203;4586.472555656075;4751.928721069186;4766.213574760126;4767.976160119178;4773.832915847928;4796.56830885222;5090.898182036264;5112.36095488064;5112.795488180431;5117.1300878851425;5172.1465958118;4639.675222734376;4703.270992996091;4739.526047395233;4765.666403351732;4791.736454495036;4972.2790195422185;4980.551750342486;4982.526659967298;4984.75076246179;5032.798688052437;4928.359313289249;5058.974705126598;5059.316992206005;5060.266261392004;5122.743862806919;4822.927656085091;4878.048780487913;4896.436909755281;4958.677685950402;4979.975100124476;4824.0834241494;4856.271559266138;4867;4918.852434426973;4962.3052772611145;4666.230072038212;4766.475687674284;4779.426468823764;4779.641526885567;4811.735354555533;4946.109700253989;4995.525425084611;5000.449950505515;5040.193569028937;5054.848354549369;4822.565969062801;4843.927341089816;4852.975735121302;4854.75726213695;4880 18:44:02 INFO - PROCESS | 6393 | |1;ext.html;571.3201290464347;589.9351071382149;605.7274226598032;610.282917571853;643.7360682120332;32729.345413091753;34015.14962125948;34075.31849363011;34085.31829363414;34107;35715.82142089286;36481.452778208346;36606.81696591513;36631.63368366315;36645.450318245246;7428.517146385481;7617.961910190441;7647.885281720779;7655.081390233152;7669.539827610333;7368.263173682642;7551.24487551246;7554.735584254552;7708.961455192716;7716.112647045606;7661.387089032892;7734.651940662656;7737.806554836118;7740.225977402243;7744.535327880345;7619.238076192391;7627.313541781238;7650;7677.270659287359;7683.615819209017;7647.082350117966;7724.073111226632;7765.922340776577;7771.300582947561;7775.261350171724;37327.25345493102;38050.61949380498;38078.42882356767;38082.809585951894;38085.04787380338;2769.376890199709;3119.4385010698065;3125.7811953163286;3206.214477453039;3425.828708564562;29133.12600621985;29366.70633293661;29684.406311873856;29779.10662680123;30385.69614303851;3124.4532206863937;3179.1416317594353;3207.406629773476;3213.9517907231175;3262.4616938205168;230418;230453;230921;232541.9999999983;233139;30180.396392072034;30664;52769.472305277224;52807.735961319944;52970.20544691833;31143.065708028797;31180;31237.219069523442;31261.687383125878;31494.527582086288;13549.187048777105;13560;13717.45130194781;13744.381502832397;13774;10665.89334106649;10732.463376831127;10738.73153171177;10794.568217271379;10813.134949204203;7872.01599800025;7961.522308661383;8014.879776803353;8036.718714844952;8063.637136328879;3089.0423968569817;3118.8908388206305;3169.572107765422;3172.698593633601;3180.8727650894166;881.850085485469;927.3601215161517;989.5200827598609;1006.3006210683504;1042.4110377636612;27776.444471110466;28326.575101373084;28399.858000709864;28544.28639283993;28577.57133642997;933.1927882381691;945.5461378538203;970.257752819094;994.8656931314325;1109.5561775289787;15077.698446031018;15144;15208.46770363032;15486.612834679223;15496.535103946899;276430;286371;287157;287317;356751;49219.26171107436;49648;49728.50271497311;50137.74931125321;50154;1204.5181927229003;1208.915375923677;1211.7576484702918;1221.3770976801895;1289.5744404346542;27283.454330913668;27638.86180569084;28167.57748633731;28209.71790282071;28904.85547572249;42105.36841947435;42823.3576496359;42835.357469638606;42886.14227715366;42947;296224;301979;302810;303485;303578;25445.618315724907;25729.099481518057;25883.352916177246;25898;25936;40570.79714601408;41420.378694319006;41975.370369445096;42051.369229462194;42234.78882605567;35321.29357412889;36111.45832812563;36237.0940726484;36404.63595364012;36657;34928.65071349355;35291.823540882135;35615.46576801298;35869.461958070126;35902.64097359098;32645.836770815993;32699.67300326966;32938.341233175684;33448.1637959053;33449.66550334466;30092.24769380783;31595.526067109473;32244.19389515281;32267.193320167185;32583;24567.14015009466;24748.628770568816;24811.25566233016;25078.24765257045;25144.37139071538 18:44:02 INFO - PROCESS | 6393 | |2;jquery.html;379.7398781834444;379.8233821273108;380.45214890557594;380.93904975203975;381.43547549626567;15267.465638702648;15574.610634734137;16239.91880040601;16271.105089220087;16296.266667999953;15963.281652325644;16609.83390166098;17203.311867525284;17320.82679173211;17345.566360840985;4966.304717339566;5186.170212765958;5196.896062078757;5201.583873290147;5221.79112835488;4989.725565093919;5057.645964782467;5120.411152717429;5168.250603662466;5174.223866420049;5247.737613119348;5260.631755777097;5261.894762104775;5268.525832675058;5277.023750606131;5049.469805670388;5252.159654455288;5445.646033007842;5455.890882182373;5457;5295.152775555893;5300.469953004707;5315.840524784263;5353.892922141575;5357.1696387060065;11676;12400.81398779019;12416.937915310456;12428.813567796491;12478.875211247952;1825.3155066849931;1847.178005787425;1869.2242719271485;1895.6113996630659;1923.6537423263808;9429.481378524179;9461.52692365379;9685.564149613285;10939;11927;1586.191042568287;1591.2362066208168;1608.300389330645;1609.8229194788564;1660.5931546770998;70018;72328.27671723321;72350;73504.63247683781;73733;9739.659111931049;9806.705798826046;10264.024917632813;10561.155107591529;10873.07578855806;13793.586192414243;13834.515791947233;13941.65145871341;13961.162330260217;13969.79045314321;7280.890786638205;7328.120625524971;7414.035280650632;7516.361109305771;7577.128630207487;7037.507374483737;7104.609246491389;7162.534435261691;7170.6056166910275;7193.568385896863;4235.237657221668;4251.681123915719;4350.8042138103865;4357.629601483846;4392.736435813861;1828.2047309420445;1880.3324819689087;1885.86798924074;1892.1617573639542;1893.6591413545693;755.928186822251;774.3302043732131;801.2988634944423;813.3574476163883;840.6133178737726;15567.922160389126;16075.678486430439;16385.262663180187;16507.174641267888;16752.748708769377;824.9216324449168;836.2933321343455;859.9226069653761;878.7539488943106;901.2789768185556;9081.59132839024;9083.727488175366;9262.814743705088;9283.25733941283;9347.953260233655;413588;414832;416282;440564;453602;58804.41195588075;69999;71095.2890471099;79896.60051699704;83817;875.8905136857893;951.3198063384575;957.0764212534938;957.9089986451276;961.4135377419768;15240.618984525476;15500.457483988006;15608.921955390604;15714.13572253537;15829.604259893134;35764.46353304754;36473.45289820708;36834.8158259207;37071.629283707895;37103.6289637111;48747.51252487572;52185;52846.47153528415;52980;53620.73189634027;7109.466789990668;7484.251574842472;7537.510061845963;7621;7642.426817988784;10830.40432776205;11061.225714199929;11248.662540123809;11295.209335346446;11324;9083.137101975302;9247.213986810928;9367.625294988396;9388.530573471162;9452.43285402878;9440.527973601154;9893.901060989298;9901.207903367856;10132.037456441627;10146.847797282899;8437.198466145706;8982.685606004019;9278.072192780668;9286.72139835806;9554.426734395958;7478.850422991619;7683.615819209129;7732.806679832825;7768.88346674789;7855.646495907584;4789.425268967746;6290.528210384148;6959.304069593203;7506.699732010877;9326 18:44:02 INFO - PROCESS | 6393 | |3;mootools.html;1405.1077565745752;1447.1895738386504;1538.6076550479627;1748.2133040131944;1777.2890843662533;6816.863662726742;7547.018887544626;7563.962180189098;7763.650635721399;7796.06447226333;7590.5066170698865;7627.0847498300145;7648.655810488527;7657.655405506752;7729.072511298638;2141.7429908411013;2193.8573992690426;2202.7797220278003;2206.580749657568;2207.845450818443;2092.89535523224;2099.9475013124716;2149.48412381029;2158.363282831561;2162.275637661385;2167.0681606909025;2169.6203164446238;2181.5091604388963;2182.9126834926665;2201.0755482697227;2162.1243396424475;2171.0447403142566;2171.457135716071;2176.923807666724;2179.967300490494;2098.685197220429;2137.78622137785;2156.320758960938;2158.136745301876;2165.805077543013;7755.418343624195;7836.490628109154;7849.646765895548;7856;7867.6852925882895;4459.175052615276;4584.426946631671;4604;4626.097910907374;4641.466231383401;2749.5188342040065;2806.989483785856;2897.1887871396043;2905.4334404791075;2917.810342327763;878.1218781218781;887.760304717729;888.8666699995052;902.6795487601938;916;10554.366737995744;10607.84088238677;10610.628627997983;10634.946825265824;10638.361698298128;4248.725382385333;4294.76378799169;4375.453068366454;4392.824287028547;4396.054848207651;9053.139951704577;9055.81888362229;9069.229115525122;9081.091890810865;9118.179363857153;4767.118083154627;4775.570198682066;4779.617630589544;4780.091782561302;4781.13939490895;3766.114962983697;4161.625453709181;4225.598568136023;4251.192273468031;4298.376735373354;3573.4639804029084;3573.5890372607482;3652.579953305351;3686.9815650921573;3710.035390798358;1172.8533933258343;1205.2949024820402;1212.8483939507562;1220.7192345760525;1223.7980733178927;781.2929298984428;892.7455675132557;898.0839543665555;908.2280061947292;919.5034681272172;5620.718964051781;5642.407547207484;5698.914516282259;5712.000399930079;5827.3298570664065;841.0454134557199;889.1508609278123;889.5463313710054;929.9023602521638;986.7335819328885;3626.1659818241424;3785;3841.193349396602;3848.7690738555775;3866.5940076292145;8943.284537237136;9275;9351.90648093524;9353.766155846022;9390.295727820305;9118.544072796334;9175.908240917639;9238.722838314861;9266.536673166314;9301.581428835718;6957.339052789976;7283.745068922668;7314.232005639437;7333.413326933833;7364.705411783576;5117.078925793393;5340.252364669027;5383.434739352311;5410.269613602113;5612.719364031864;8503.574821258788;8672.306215502618;8681.739547813575;8751.387402881992;8819.60311785984;8710.91289087101;8906.465612063297;8907.821843563223;8944.731658050268;9214.262858971133;6066.332703402534;6224.87952168614;6415.775447859302;6641.970494573349;6789.864202715819;7393.186749457448;7402.703891844481;7416.44376671741;7420.257974202753;7436.144843342869;6425.389587989321;6522.967385163044;6577.210734711865;6661.267260601427;6696.698648560729;6335.429811317003;6447.548671592944;6511.283758786624;6568.47452203813;6600.702968366339;6033.78881739137;6103.816885493442;6113.57204995646;6136.171616831671;6142.938570614416;4658.510856360169;4668.463126740468;4732.384789977281;4866.099771542276;4903;4641.489436162087;4693.6949098308505;4746.169420351355;4799.3041009052795;4860.052289803454 18:44:02 INFO - PROCESS | 6393 | |4;prototype.html;286.9684334723181;301.58080268426886;304.21057356160753;305.68819803800125;309.01424455985403;4775.737334446604;4840.17716988112;4851.345068415762;4951.628627852912;4968.900621987563;4928.926066109002;4935.703857768536;4939.950600493994;4965.801367945278;4980.60155187585;3881.10734531058;3909.9413508797393;3912.041549820298;3915.099527108767;3932.292187406266;3610.277944411115;3880.1269714314194;3894.2990261752875;3904.7852368119884;3906.941395879064;3754.192848537564;3792.2415516896594;3818.8472461101524;3828.1386687995255;3833.7508061976023;3790.0903783092;3802.9429558556644;3807.409851473012;3807.6573108420375;3822.2164456286396;3342.983285083559;3348.4475061614803;3350.078728349699;3351.765376423651;3358.714509266715;4654.953450465486;4705.153072446992;4732.408448943882;4759.833405830814;4764;4311.8706438806885;4336.460556502459;4346.913061738779;4352.151330490556;4382.517923028464;5133.563647090002;5146.511081447256;5159.845204643867;5195.974020129913;5207.6615020023955;3425.760196786226;3644.0343309022865;3660.267946410702;3660.8535658573624;3663.688586470153;5407.134858422633;5415.918761218585;5431.728413579305;5446.264754258164;5483.945160548423;3729.216864458494;3730.3658378075793;3741.4387841823946;3749.9250015000093;3752.962470375316;3781.640744129303;3784.0729021389934;3793.696504279651;3801.1067399161175;3817.408301713239;4092.5907409258834;4306.569343065668;4314.676399270067;4340.305551111807;4343.19650864591;5204.167333226741;5214.270002199695;5227.843164705065;5228.895422091613;5241.846793705378;1300.7203451257835;1331.7269959658247;1358.9864101359058;1372.9038967272195;1373.9725205496034;889.5329951775369;904.5974541329177;920.4569304110607;921.5438358012826;921.7972046149837;4668.4631267404;4698.412698412699;4766.571008609172;4773.11697335994;4792.784324705397;5637.746301416446;5639.379668236491;5654.85862853432;5655.123455864347;5682.192930736416;4686.554777296152;4728.881777955578;4778.259369797687;4809;4810.2100781546615;3016.245938515371;3021.6374035115928;3033.8634761435787;3042.710942460463;3043.1022848259818;5254.579633629301;5267.657602255841;5298.470152984671;5304.973475132677;5317.601179911522;5237.3453318335205;5542.168674698827;5555.972220138954;5775.249217601685;5782.3639399666;5071.18860982241;5074.467180945948;5077.136886729265;5107.182850743863;5111.744412779271;5443.673379597237;5444.782208711607;5455.672659640434;5458.317710286215;5486.478784515464;5204.802895334019;5304.28392167068;5325.281087053353;5346.465353464622;5353.323338330834;5028.64799464034;5072.9746351268;5115.9232611510115;5119.462456442169;5144.170706111699;3696.4824924511126;3706.5181526401393;3718.442233664972;3729.5710993236125;3734.402495600691;5056.6207534434325;5334.973325133349;5351.170568561879;5368.141097424549;5369.48989845964;5074.517920797518;5197.856471576247;5228.790848366023;5247.763850626655;5280.867978300574;5203.427622961547;5213.661112027706;5224.52979231871;5246.632735708464;5255.947440525699;4861.270809378621;5126.4617215191865;5145.151050076845;5154.381474223117;5170.741462926763;5236.476352364733;5245.790168393221;5289.127293996601;5315.813946511854;5323.813666521653;5131.332926719502;5139.331886854685;5168;5191.428942816212;5194.68831870089 18:44:02 INFO - PROCESS | 6393 | |5;yui.html;649.8050584824553;746.3842330077687;767.2634271099747;771.5100910921564;779.7270955165693;12107.394630268484;12331.5067397304;12353.629391118258;12415;12485.875141248596;10133.391996480217;10216.131628811541;10267.691969240916;11963.820542691845;12330.506779728823;630.0926665601542;792.453207286973;804.4047404920346;809.6842231529708;809.7773112394079;776.7126163319551;795.3954994204388;797.7726347990824;798.1101072304368;798.7723498802842;821.6877586517115;831.3266254334009;832.3923535818856;836.3643630840575;836.5440834745048;825.8761185822115;829.0341751859077;829.6308142876422;833.7748807821915;835.8495470815251;610.2432983100967;615.2616859768295;615.326217791522;619.3991827926903;621.5307442880642;12526.997840172764;12539.31033793141;12542.874571254262;12624.55814046504;12629.052821038367;12515.374231288399;12835.550755723505;12837.486500539968;12894.742105157844;12966.546170883974;9519.936923847445;9621.951890240574;9639.662611808553;9726.97866723991;9863.260255480867;3285.4414749492644;3327.6505966873615;3365.562476878015;3381.408253555618;3434.3818112739696;42417.57582424167;43199.35200971988;43453;44749.32876006862;45263.86840328985;9502.334836561375;9548.761280967892;9565.665201717906;9631.614735410645;9693.6122555097;17584.64830703379;17693.115344232738;17704.822951770577;17722.645547088985;17727;6577.80266592003;6587.077809106729;6685.39831415175;6688.3646053624825;6754.392104710501;3538.380783362901;3549;3624.909377265537;3636.7999760013454;3647.161152934787;2873.454043731684;2939.955900661492;2940.529515277545;2942.3526824098662;2950.8229506229695;493.7457209537091;501.53607912680627;512.9153689641242;513.1609817947682;514.2337916504382;534.6551474299056;553.0239127939191;558.4722437296797;562.072580242603;581.758570193365;6556.901646475307;6837.62393068386;7095.325944035309;7191.748288809971;7229.530080544748;428.29545397820414;454.5227511113318;456.33375272103103;503.75819606589044;512.9757055896486;3359.6976272135626;3409.4715319125576;3439.724822014233;3482.1120614243205;3490.1798077451776;48999;49385.75307123513;49849;57005;57359.426405736245;47445;47886.28170577444;48477.75761121172;48596.27105593419;49303.753481233085;44100;45125.77437112859;45718.542814572094;45749.31376029296;45820.54179458163;6729.394354508117;6831.9658401707675;6840.452763778985;6867.244603093755;6909.827254318682;28261.30432174076;28806;29167.270818229714;29407.85296073506;29691.257718557208;36851;38857.639982601606;38868.222635547696;38971.6102838968;39310;8507.617157227816;8559.914400856162;8656;8739.126087391463;8759.386842920934;8943.597538110931;9056.184943355129;9136.6802161924;9144.405613635092;9297.628094876129;8499;8580.326836267117;8609.870851937101;8639.740807775777;8739.650413983623;8728.781780455285;8856.822863542822;8869.467831930106;8914.643414263617;8985.640574376952;8248.958755206186;8303.95848020756;8414.074451810418;8488.490690558587;8501.277391421798;7212.134543854561;7248.238934911969;7278.890816637861;7475.953366528799;7615.428842836699;7255.056842610426;7330.874046526447;7409.259074092548;7552.244775522404;7589.924100759143 18:44:02 INFO - PROCESS | 6393 | __end_tp_report 18:44:02 INFO - PROCESS | 6393 | __start_cc_report 18:44:02 INFO - PROCESS | 6393 | _x_x_mozilla_cycle_collect,363 18:44:02 INFO - PROCESS | 6393 | __end_cc_report 18:44:02 INFO - PROCESS | 6393 | __startTimestamp1461980642678__endTimestamp 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | ------- Summary: start ------- 18:44:02 INFO - PROCESS | 6393 | Number of tests: 6 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | [#0] dojo.html Cycles:165 Average:4666.93 Median:4779.43 stddev:487.25 (10.2%) stddev-sans-first:460.76 18:44:02 INFO - PROCESS | 6393 | Values: 2592.1 2645.6 2678.9 2685.4 2696.5 4692.6 4710.3 4718.8 4732.0 4773.5 4604.9 4699.8 4718.5 4738.6 4780.7 4315.2 4384.0 4425.6 4432.4 4450.3 4350.8 4409.0 4431.9 4434.4 4461.3 4288.8 4362.4 4364.7 4381.0 4389.3 4267.9 4273.6 4279.4 4294.4 4302.0 4238.3 4251.1 4255.3 4293.7 4329.7 4495.7 4624.8 4677.1 4699.0 4736.2 5006.0 5021.8 5028.5 5054.8 5066.5 4958.0 5074.8 5077.4 5087.2 5136.5 4738.3 4755.4 4775.5 4816.3 4817.5 5148.8 5162.6 5190.9 5192.5 5228.8 4845.7 4955.2 4957.3 4983.0 4984.8 5124.3 5125.1 5141.1 5152.0 5195.5 4881.0 4923.1 4940.2 4945.0 4985.3 4850.3 4958.3 4998.2 5008.7 5060.2 4271.8 4276.2 4285.5 4316.3 4316.9 3675.9 3715.5 3723.3 3756.0 3760.7 4304.9 4315.0 4360.5 4372.2 4392.7 5059.8 5077.0 5078.3 5079.6 5106.5 4376.0 4396.9 4404.8 4411.9 4424.9 4507.9 4516.2 4545.4 4564.0 4586.5 4751.9 4766.2 4768.0 4773.8 4796.6 5090.9 5112.4 5112.8 5117.1 5172.1 4639.7 4703.3 4739.5 4765.7 4791.7 4972.3 4980.6 4982.5 4984.8 5032.8 4928.4 5059.0 5059.3 5060.3 5122.7 4822.9 4878.0 4896.4 4958.7 4980.0 4824.1 4856.3 4867.0 4918.9 4962.3 4666.2 4766.5 4779.4 4779.6 4811.7 4946.1 4995.5 5000.4 5040.2 5054.8 4822.6 4843.9 4853.0 4854.8 4880.0 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | [#1] ext.html Cycles:180 Average:42270.64 Median:32833.84 stddev:73367.54 (223.5%) stddev-sans-first:73506.55 18:44:02 INFO - PROCESS | 6393 | Values: 571.3 589.9 605.7 610.3 643.7 32729.3 34015.1 34075.3 34085.3 34107.0 35715.8 36481.5 36606.8 36631.6 36645.5 7428.5 7618.0 7647.9 7655.1 7669.5 7368.3 7551.2 7554.7 7709.0 7716.1 7661.4 7734.7 7737.8 7740.2 7744.5 7619.2 7627.3 7650.0 7677.3 7683.6 7647.1 7724.1 7765.9 7771.3 7775.3 37327.3 38050.6 38078.4 38082.8 38085.0 2769.4 3119.4 3125.8 3206.2 3425.8 29133.1 29366.7 29684.4 29779.1 30385.7 3124.5 3179.1 3207.4 3214.0 3262.5 230418.0 230453.0 230921.0 232542.0 233139.0 30180.4 30664.0 52769.5 52807.7 52970.2 31143.1 31180.0 31237.2 31261.7 31494.5 13549.2 13560.0 13717.5 13744.4 13774.0 10665.9 10732.5 10738.7 10794.6 10813.1 7872.0 7961.5 8014.9 8036.7 8063.6 3089.0 3118.9 3169.6 3172.7 3180.9 881.9 927.4 989.5 1006.3 1042.4 27776.4 28326.6 28399.9 28544.3 28577.6 933.2 945.5 970.3 994.9 1109.6 15077.7 15144.0 15208.5 15486.6 15496.5 276430.0 286371.0 287157.0 287317.0 356751.0 49219.3 49648.0 49728.5 50137.7 50154.0 1204.5 1208.9 1211.8 1221.4 1289.6 27283.5 27638.9 28167.6 28209.7 28904.9 42105.4 42823.4 42835.4 42886.1 42947.0 296224.0 301979.0 302810.0 303485.0 303578.0 25445.6 25729.1 25883.4 25898.0 25936.0 40570.8 41420.4 41975.4 42051.4 42234.8 35321.3 36111.5 36237.1 36404.6 36657.0 34928.7 35291.8 35615.5 35869.5 35902.6 32645.8 32699.7 32938.3 33448.2 33449.7 30092.2 31595.5 32244.2 32267.2 32583.0 24567.1 24748.6 24811.3 25078.2 25144.4 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | [#2] jquery.html Cycles:180 Average:24922.49 Median:5234.76 stddev:70528.72 (1347.3%) stddev-sans-first:70702.50 18:44:02 INFO - PROCESS | 6393 | Values: 379.7 379.8 380.5 380.9 381.4 15267.5 15574.6 16239.9 16271.1 16296.3 15963.3 16609.8 17203.3 17320.8 17345.6 4966.3 5186.2 5196.9 5201.6 5221.8 4989.7 5057.6 5120.4 5168.3 5174.2 5247.7 5260.6 5261.9 5268.5 5277.0 5049.5 5252.2 5445.6 5455.9 5457.0 5295.2 5300.5 5315.8 5353.9 5357.2 11676.0 12400.8 12416.9 12428.8 12478.9 1825.3 1847.2 1869.2 1895.6 1923.7 9429.5 9461.5 9685.6 10939.0 11927.0 1586.2 1591.2 1608.3 1609.8 1660.6 70018.0 72328.3 72350.0 73504.6 73733.0 9739.7 9806.7 10264.0 10561.2 10873.1 13793.6 13834.5 13941.7 13961.2 13969.8 7280.9 7328.1 7414.0 7516.4 7577.1 7037.5 7104.6 7162.5 7170.6 7193.6 4235.2 4251.7 4350.8 4357.6 4392.7 1828.2 1880.3 1885.9 1892.2 1893.7 755.9 774.3 801.3 813.4 840.6 15567.9 16075.7 16385.3 16507.2 16752.7 824.9 836.3 859.9 878.8 901.3 9081.6 9083.7 9262.8 9283.3 9348.0 413588.0 414832.0 416282.0 440564.0 453602.0 58804.4 69999.0 71095.3 79896.6 83817.0 875.9 951.3 957.1 957.9 961.4 15240.6 15500.5 15608.9 15714.1 15829.6 35764.5 36473.5 36834.8 37071.6 37103.6 48747.5 52185.0 52846.5 52980.0 53620.7 7109.5 7484.3 7537.5 7621.0 7642.4 10830.4 11061.2 11248.7 11295.2 11324.0 9083.1 9247.2 9367.6 9388.5 9452.4 9440.5 9893.9 9901.2 10132.0 10146.8 8437.2 8982.7 9278.1 9286.7 9554.4 7478.9 7683.6 7732.8 7768.9 7855.6 4789.4 6290.5 6959.3 7506.7 9326.0 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | [#3] mootools.html Cycles:180 Average:5112.44 Median:5631.56 stddev:2797.64 (49.7%) stddev-sans-first:2791.62 18:44:02 INFO - PROCESS | 6393 | Values: 1405.1 1447.2 1538.6 1748.2 1777.3 6816.9 7547.0 7564.0 7763.7 7796.1 7590.5 7627.1 7648.7 7657.7 7729.1 2141.7 2193.9 2202.8 2206.6 2207.8 2092.9 2099.9 2149.5 2158.4 2162.3 2167.1 2169.6 2181.5 2182.9 2201.1 2162.1 2171.0 2171.5 2176.9 2180.0 2098.7 2137.8 2156.3 2158.1 2165.8 7755.4 7836.5 7849.6 7856.0 7867.7 4459.2 4584.4 4604.0 4626.1 4641.5 2749.5 2807.0 2897.2 2905.4 2917.8 878.1 887.8 888.9 902.7 916.0 10554.4 10607.8 10610.6 10634.9 10638.4 4248.7 4294.8 4375.5 4392.8 4396.1 9053.1 9055.8 9069.2 9081.1 9118.2 4767.1 4775.6 4779.6 4780.1 4781.1 3766.1 4161.6 4225.6 4251.2 4298.4 3573.5 3573.6 3652.6 3687.0 3710.0 1172.9 1205.3 1212.8 1220.7 1223.8 781.3 892.7 898.1 908.2 919.5 5620.7 5642.4 5698.9 5712.0 5827.3 841.0 889.2 889.5 929.9 986.7 3626.2 3785.0 3841.2 3848.8 3866.6 8943.3 9275.0 9351.9 9353.8 9390.3 9118.5 9175.9 9238.7 9266.5 9301.6 6957.3 7283.7 7314.2 7333.4 7364.7 5117.1 5340.3 5383.4 5410.3 5612.7 8503.6 8672.3 8681.7 8751.4 8819.6 8710.9 8906.5 8907.8 8944.7 9214.3 6066.3 6224.9 6415.8 6642.0 6789.9 7393.2 7402.7 7416.4 7420.3 7436.1 6425.4 6523.0 6577.2 6661.3 6696.7 6335.4 6447.5 6511.3 6568.5 6600.7 6033.8 6103.8 6113.6 6136.2 6142.9 4658.5 4668.5 4732.4 4866.1 4903.0 4641.5 4693.7 4746.2 4799.3 4860.1 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | [#4] prototype.html Cycles:180 Average:4344.89 Median:4937.83 stddev:1276.16 (25.8%) stddev-sans-first:1242.86 18:44:02 INFO - PROCESS | 6393 | Values: 287.0 301.6 304.2 305.7 309.0 4775.7 4840.2 4851.3 4951.6 4968.9 4928.9 4935.7 4940.0 4965.8 4980.6 3881.1 3909.9 3912.0 3915.1 3932.3 3610.3 3880.1 3894.3 3904.8 3906.9 3754.2 3792.2 3818.8 3828.1 3833.8 3790.1 3802.9 3807.4 3807.7 3822.2 3343.0 3348.4 3350.1 3351.8 3358.7 4655.0 4705.2 4732.4 4759.8 4764.0 4311.9 4336.5 4346.9 4352.2 4382.5 5133.6 5146.5 5159.8 5196.0 5207.7 3425.8 3644.0 3660.3 3660.9 3663.7 5407.1 5415.9 5431.7 5446.3 5483.9 3729.2 3730.4 3741.4 3749.9 3753.0 3781.6 3784.1 3793.7 3801.1 3817.4 4092.6 4306.6 4314.7 4340.3 4343.2 5204.2 5214.3 5227.8 5228.9 5241.8 1300.7 1331.7 1359.0 1372.9 1374.0 889.5 904.6 920.5 921.5 921.8 4668.5 4698.4 4766.6 4773.1 4792.8 5637.7 5639.4 5654.9 5655.1 5682.2 4686.6 4728.9 4778.3 4809.0 4810.2 3016.2 3021.6 3033.9 3042.7 3043.1 5254.6 5267.7 5298.5 5305.0 5317.6 5237.3 5542.2 5556.0 5775.2 5782.4 5071.2 5074.5 5077.1 5107.2 5111.7 5443.7 5444.8 5455.7 5458.3 5486.5 5204.8 5304.3 5325.3 5346.5 5353.3 5028.6 5073.0 5115.9 5119.5 5144.2 3696.5 3706.5 3718.4 3729.6 3734.4 5056.6 5335.0 5351.2 5368.1 5369.5 5074.5 5197.9 5228.8 5247.8 5280.9 5203.4 5213.7 5224.5 5246.6 5255.9 4861.3 5126.5 5145.2 5154.4 5170.7 5236.5 5245.8 5289.1 5315.8 5323.8 5131.3 5139.3 5168.0 5191.4 5194.7 18:44:02 INFO - PROCESS | 6393 | 18:44:02 INFO - PROCESS | 6393 | [#5] yui.html Cycles:180 Average:12267.31 Median:612.75 stddev:14736.00 (2404.9%) stddev-sans-first:14751.51 18:44:02 INFO - PROCESS | 6393 | Values: 649.8 746.4 767.3 771.5 779.7 12107.4 12331.5 12353.6 12415.0 12485.9 10133.4 10216.1 10267.7 11963.8 12330.5 630.1 792.5 804.4 809.7 809.8 776.7 795.4 797.8 798.1 798.8 821.7 831.3 832.4 836.4 836.5 825.9 829.0 829.6 833.8 835.8 610.2 615.3 615.3 619.4 621.5 12527.0 12539.3 12542.9 12624.6 12629.1 12515.4 12835.6 12837.5 12894.7 12966.5 9519.9 9622.0 9639.7 9727.0 9863.3 3285.4 3327.7 3365.6 3381.4 3434.4 42417.6 43199.4 43453.0 44749.3 45263.9 9502.3 9548.8 9565.7 9631.6 9693.6 17584.6 17693.1 17704.8 17722.6 17727.0 6577.8 6587.1 6685.4 6688.4 6754.4 3538.4 3549.0 3624.9 3636.8 3647.2 2873.5 2940.0 2940.5 2942.4 2950.8 493.7 501.5 512.9 513.2 514.2 534.7 553.0 558.5 562.1 581.8 6556.9 6837.6 7095.3 7191.7 7229.5 428.3 454.5 456.3 503.8 513.0 3359.7 3409.5 3439.7 3482.1 3490.2 48999.0 49385.8 49849.0 57005.0 57359.4 47445.0 47886.3 48477.8 48596.3 49303.8 44100.0 45125.8 45718.5 45749.3 45820.5 6729.4 6832.0 6840.5 6867.2 6909.8 28261.3 28806.0 29167.3 29407.9 29691.3 36851.0 38857.6 38868.2 38971.6 39310.0 8507.6 8559.9 8656.0 8739.1 8759.4 8943.6 9056.2 9136.7 9144.4 9297.6 8499.0 8580.3 8609.9 8639.7 8739.7 8728.8 8856.8 8869.5 8914.6 8985.6 8249.0 8304.0 8414.1 8488.5 8501.3 7212.1 7248.2 7278.9 7476.0 7615.4 7255.1 7330.9 7409.3 7552.2 7589.9 18:44:02 INFO - PROCESS | 6393 | -------- Summary: end -------- 18:44:02 INFO - PROCESS | 6393 | 18:44:03 INFO - TEST-INFO | 6393: exit 0 18:44:03 INFO - TEST-OK | dromaeo_css | took 1114943ms 18:44:03 INFO - TEST-START | kraken 18:44:03 INFO - operating with platform_type : linux_ 18:44:03 INFO - Initialising browser for kraken test... 18:44:03 INFO - TEST-INFO | started process 6626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppI2pna/profile http://localhost:50681/getInfo.html) 18:44:07 INFO - PROCESS | 6626 | 18:44:07 INFO - PROCESS | 6626 | (process:6695): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:44:08 INFO - PROCESS | 6626 | __metrics Screen width/height:1600/1200 18:44:08 INFO - PROCESS | 6626 | colorDepth:24 18:44:08 INFO - PROCESS | 6626 | Browser inner width/height: 1024/697 18:44:08 INFO - PROCESS | 6626 | __metrics 18:44:09 ERROR - PROCESS | 6626 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 18:44:10 INFO - TEST-INFO | 6626: exit 0 18:44:10 INFO - Browser initialized. 18:44:10 INFO - Running cycle 1/1 for kraken test... 18:44:10 INFO - TEST-INFO | started process 6746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppI2pna/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:12 INFO - PROCESS | 6746 | 18:44:12 INFO - PROCESS | 6746 | (process:6805): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 18:44:22 INFO - PROCESS | 6746 | RSS: Main: 166285312 18:44:22 INFO - PROCESS | 6746 | 18:44:24 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-beat-detection) 18:44:25 INFO - PROCESS | 6746 | RSS: Main: 169840640 18:44:25 INFO - PROCESS | 6746 | 18:44:28 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-dft) 18:44:29 INFO - PROCESS | 6746 | RSS: Main: 173297664 18:44:29 INFO - PROCESS | 6746 | 18:44:32 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-fft) 18:44:32 INFO - PROCESS | 6746 | RSS: Main: 164442112 18:44:32 INFO - PROCESS | 6746 | 18:44:35 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50681/tests/kraken/driver.html?testName=audio-oscillator) 18:44:35 INFO - PROCESS | 6746 | RSS: Main: 165199872 18:44:35 INFO - PROCESS | 6746 | 18:44:37 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:44:38 INFO - PROCESS | 6746 | RSS: Main: 165953536 18:44:38 INFO - PROCESS | 6746 | 18:44:41 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50681/tests/kraken/driver.html?testName=imaging-darkroom) 18:44:42 INFO - PROCESS | 6746 | RSS: Main: 166526976 18:44:42 INFO - PROCESS | 6746 | 18:44:45 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50681/tests/kraken/driver.html?testName=imaging-desaturate) 18:44:46 INFO - PROCESS | 6746 | RSS: Main: 164622336 18:44:46 INFO - PROCESS | 6746 | 18:44:49 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50681/tests/kraken/driver.html?testName=json-parse-financial) 18:44:50 INFO - PROCESS | 6746 | RSS: Main: 165302272 18:44:50 INFO - PROCESS | 6746 | 18:44:51 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:44:52 INFO - PROCESS | 6746 | RSS: Main: 165666816 18:44:52 INFO - PROCESS | 6746 | 18:44:54 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:44:55 INFO - PROCESS | 6746 | RSS: Main: 165470208 18:44:55 INFO - PROCESS | 6746 | 18:44:57 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:44:57 INFO - PROCESS | 6746 | RSS: Main: 165855232 18:44:57 INFO - PROCESS | 6746 | 18:45:00 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:45:01 INFO - PROCESS | 6746 | RSS: Main: 165904384 18:45:01 INFO - PROCESS | 6746 | 18:45:04 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:45:04 INFO - PROCESS | 6746 | RSS: Main: 165994496 18:45:04 INFO - PROCESS | 6746 | 18:45:06 INFO - PROCESS | 6746 | Cycle 1(1): loaded http://localhost:50681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50681/tests/kraken/driver.html?testName=ai-astar) 18:45:07 INFO - PROCESS | 6746 | RSS: Main: 167493632 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | __start_tp_report 18:45:07 INFO - PROCESS | 6746 | _x_x_mozilla_page_load 18:45:07 INFO - PROCESS | 6746 | _x_x_mozilla_page_load_details 18:45:07 INFO - PROCESS | 6746 | |i|pagename|runs| 18:45:07 INFO - PROCESS | 6746 | |0;ai-astar;115;110;115;114;115;128;119;114;113;113 18:45:07 INFO - PROCESS | 6746 | |1;audio-beat-detection;160;135;174;190;139;176;159;137;196;136 18:45:07 INFO - PROCESS | 6746 | |2;audio-dft;161;163;164;173;163;162;161;164;166;163 18:45:07 INFO - PROCESS | 6746 | |3;audio-fft;77;77;84;174;77;87;77;76;157;79 18:45:07 INFO - PROCESS | 6746 | |4;audio-oscillator;94;96;145;95;94;95;145;95;94;138 18:45:07 INFO - PROCESS | 6746 | |5;imaging-gaussian-blur;118;118;117;119;117;117;118;119;118;118 18:45:07 INFO - PROCESS | 6746 | |6;imaging-darkroom;147;148;148;149;147;148;147;147;147;147 18:45:07 INFO - PROCESS | 6746 | |7;imaging-desaturate;95;96;96;95;95;95;94;94;96;96 18:45:07 INFO - PROCESS | 6746 | |8;json-parse-financial;68;68;68;70;68;74;68;69;67;68 18:45:07 INFO - PROCESS | 6746 | |9;json-stringify-tinderbox;66;65;65;65;65;66;66;65;65;66 18:45:07 INFO - PROCESS | 6746 | |10;stanford-crypto-aes;84;82;82;83;82;84;86;88;123;82 18:45:07 INFO - PROCESS | 6746 | |11;stanford-crypto-ccm;133;139;147;140;137;141;131;131;153;135 18:45:07 INFO - PROCESS | 6746 | |12;stanford-crypto-pbkdf2;181;176;180;189;177;175;178;180;175;178 18:45:07 INFO - PROCESS | 6746 | |13;stanford-crypto-sha256-iterative;75;76;73;76;76;74;75;75;74;73 18:45:07 INFO - PROCESS | 6746 | __end_tp_report 18:45:07 INFO - PROCESS | 6746 | __start_cc_report 18:45:07 INFO - PROCESS | 6746 | _x_x_mozilla_cycle_collect,949 18:45:07 INFO - PROCESS | 6746 | __end_cc_report 18:45:07 INFO - PROCESS | 6746 | __startTimestamp1461980707009__endTimestamp 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | ------- Summary: start ------- 18:45:07 INFO - PROCESS | 6746 | Number of tests: 14 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#0] ai-astar Cycles:10 Average:115.60 Median:115.00 stddev:4.90 (4.3%) stddev-sans-first:5.20 18:45:07 INFO - PROCESS | 6746 | Values: 115.0 110.0 115.0 114.0 115.0 128.0 119.0 114.0 113.0 113.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#1] audio-beat-detection Cycles:10 Average:160.20 Median:167.00 stddev:23.14 (13.9%) stddev-sans-first:24.54 18:45:07 INFO - PROCESS | 6746 | Values: 160.0 135.0 174.0 190.0 139.0 176.0 159.0 137.0 196.0 136.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.50 (2.1%) stddev-sans-first:3.54 18:45:07 INFO - PROCESS | 6746 | Values: 161.0 163.0 164.0 173.0 163.0 162.0 161.0 164.0 166.0 163.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#3] audio-fft Cycles:10 Average:96.50 Median:77.00 stddev:36.76 (47.7%) stddev-sans-first:38.30 18:45:07 INFO - PROCESS | 6746 | Values: 77.0 77.0 84.0 174.0 77.0 87.0 77.0 76.0 157.0 79.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.50 stddev:23.25 (24.6%) stddev-sans-first:24.01 18:45:07 INFO - PROCESS | 6746 | Values: 94.0 96.0 145.0 95.0 94.0 95.0 145.0 95.0 94.0 138.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 18:45:07 INFO - PROCESS | 6746 | Values: 118.0 118.0 117.0 119.0 117.0 117.0 118.0 119.0 118.0 118.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 18:45:07 INFO - PROCESS | 6746 | Values: 147.0 148.0 148.0 149.0 147.0 148.0 147.0 147.0 147.0 147.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.83 18:45:07 INFO - PROCESS | 6746 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 94.0 94.0 96.0 96.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:68.00 stddev:1.99 (2.9%) stddev-sans-first:2.09 18:45:07 INFO - PROCESS | 6746 | Values: 68.0 68.0 68.0 70.0 68.0 74.0 68.0 69.0 67.0 68.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 18:45:07 INFO - PROCESS | 6746 | Values: 66.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 65.0 66.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:83.50 stddev:12.60 (15.1%) stddev-sans-first:13.29 18:45:07 INFO - PROCESS | 6746 | Values: 84.0 82.0 82.0 83.0 82.0 84.0 86.0 88.0 123.0 82.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:139.50 stddev:7.06 (5.1%) stddev-sans-first:7.18 18:45:07 INFO - PROCESS | 6746 | Values: 133.0 139.0 147.0 140.0 137.0 141.0 131.0 131.0 153.0 135.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:179.00 stddev:4.12 (2.3%) stddev-sans-first:4.30 18:45:07 INFO - PROCESS | 6746 | Values: 181.0 176.0 180.0 189.0 177.0 175.0 178.0 180.0 175.0 178.0 18:45:07 INFO - PROCESS | 6746 | 18:45:07 INFO - PROCESS | 6746 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.70 Median:75.00 stddev:1.16 (1.5%) stddev-sans-first:1.22 18:45:07 INFO - PROCESS | 6746 | Values: 75.0 76.0 73.0 76.0 76.0 74.0 75.0 75.0 74.0 73.0 18:45:07 INFO - PROCESS | 6746 | -------- Summary: end -------- 18:45:07 INFO - PROCESS | 6746 | 18:45:08 INFO - TEST-INFO | 6746: exit 0 18:45:08 INFO - TEST-OK | kraken | took 64628ms 18:45:08 INFO - SUITE-END | took 1179s 18:45:08 INFO - Completed test suite (00:19:39) 18:45:08 INFO - javascript benchmark 18:45:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.1445922845464, 2645.6428382168406, 2678.9196324110285, 2685.43605842773, 2696.4876673432045, 4692.5542073503, 4710.340552322673, 4718.764061796909, 4732.0, 4773.522647735224, 4604.907901841962, 4699.788509517071, 4718.4809670936165, 4738.597219236369, 4780.689255198418, 4315.180115778, 4383.991681913162, 4425.623821975136, 4432.3573081903105, 4450.310201918692, 4350.847720329789, 4408.97795511022, 4431.933520997188, 4434.423524941769, 4461.286194208928, 4288.828446862121, 4362.36745671879, 4364.67264955128, 4380.9780951095045, 4389.275769498029, 4267.850625228133, 4273.55127711592, 4279.400883876228, 4294.4202532658, 4302.032042790347, 4238.300680387732, 4251.086016506435, 4255.319148936155, 4293.677974151919, 4329.675274354436, 4495.707778994355, 4624.768761561909, 4677.087967846272, 4699.036697477009, 4736.218523943545, 5006.0, 5021.84934451967, 5028.4971502849785, 5054.848354549369, 5066.518680725325, 4957.975210123926, 5074.771635276422, 5077.390713114413, 5087.186050231945, 5136.4606716295, 4738.336632871401, 4755.429348478205, 4775.450823155382, 4816.349792778, 4817.51824817519, 5148.794048238104, 5162.6128040397125, 5190.922136167885, 5192.45479224676, 5228.843134705965, 4845.733484658307, 4955.1576232039915, 4957.256411538298, 4982.950170498321, 4984.750762461862, 5124.30821839047, 5125.103106956342, 5141.126008578551, 5152.046871328741, 5195.532402083755, 4880.975595122001, 4923.089228492669, 4940.2342636891335, 4945.0, 4985.302057711923, 4850.345203397566, 4958.330625365602, 4998.150314446553, 5008.69947803133, 5060.1903695408555, 4271.829126834954, 4276.2089013532595, 4285.528591854893, 4316.330968699856, 4316.870493885189, 3675.889723308305, 3715.479832823407, 3723.3298006358573, 3755.962440375616, 3760.6803421708914, 4304.870853874389, 4315.029118448387, 4360.454943132108, 4372.213001659732, 4392.692511524163, 5059.797608095709, 5077.0, 5078.289039534468, 5079.619028572872, 5106.489351064938, 4375.956240437555, 4396.890077748082, 4404.801783919731, 4411.874672848251, 4424.933625995613, 4507.932381014288, 4516.209663308908, 4545.36364908913, 4564.041551274203, 4586.472555656075, 4751.928721069186, 4766.213574760126, 4767.976160119178, 4773.832915847928, 4796.56830885222, 5090.898182036264, 5112.36095488064, 5112.795488180431, 5117.1300878851425, 5172.1465958118, 4639.675222734376, 4703.270992996091, 4739.526047395233, 4765.666403351732, 4791.736454495036, 4972.2790195422185, 4980.551750342486, 4982.526659967298, 4984.75076246179, 5032.798688052437, 4928.359313289249, 5058.974705126598, 5059.316992206005, 5060.266261392004, 5122.743862806919, 4822.927656085091, 4878.048780487913, 4896.436909755281, 4958.677685950402, 4979.975100124476, 4824.0834241494, 4856.271559266138, 4867.0, 4918.852434426973, 4962.3052772611145, 4666.230072038212, 4766.475687674284, 4779.426468823764, 4779.641526885567, 4811.735354555533, 4946.109700253989, 4995.525425084611, 5000.449950505515, 5040.193569028937, 5054.848354549369, 4822.565969062801, 4843.927341089816, 4852.975735121302, 4854.75726213695, 4880.0], "value": 4636.057079937914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.3201290464347, 589.9351071382149, 605.7274226598032, 610.282917571853, 643.7360682120332, 32729.345413091753, 34015.14962125948, 34075.31849363011, 34085.31829363414, 34107.0, 35715.82142089286, 36481.452778208346, 36606.81696591513, 36631.63368366315, 36645.450318245246, 7428.517146385481, 7617.961910190441, 7647.885281720779, 7655.081390233152, 7669.539827610333, 7368.263173682642, 7551.24487551246, 7554.735584254552, 7708.961455192716, 7716.112647045606, 7661.387089032892, 7734.651940662656, 7737.806554836118, 7740.225977402243, 7744.535327880345, 7619.238076192391, 7627.313541781238, 7650.0, 7677.270659287359, 7683.615819209017, 7647.082350117966, 7724.073111226632, 7765.922340776577, 7771.300582947561, 7775.261350171724, 37327.25345493102, 38050.61949380498, 38078.42882356767, 38082.809585951894, 38085.04787380338, 2769.376890199709, 3119.4385010698065, 3125.7811953163286, 3206.214477453039, 3425.828708564562, 29133.12600621985, 29366.70633293661, 29684.406311873856, 29779.10662680123, 30385.69614303851, 3124.4532206863937, 3179.1416317594353, 3207.406629773476, 3213.9517907231175, 3262.4616938205168, 230418.0, 230453.0, 230921.0, 232541.9999999983, 233139.0, 30180.396392072034, 30664.0, 52769.472305277224, 52807.735961319944, 52970.20544691833, 31143.065708028797, 31180.0, 31237.219069523442, 31261.687383125878, 31494.527582086288, 13549.187048777105, 13560.0, 13717.45130194781, 13744.381502832397, 13774.0, 10665.89334106649, 10732.463376831127, 10738.73153171177, 10794.568217271379, 10813.134949204203, 7872.01599800025, 7961.522308661383, 8014.879776803353, 8036.718714844952, 8063.637136328879, 3089.0423968569817, 3118.8908388206305, 3169.572107765422, 3172.698593633601, 3180.8727650894166, 881.850085485469, 927.3601215161517, 989.5200827598609, 1006.3006210683504, 1042.4110377636612, 27776.444471110466, 28326.575101373084, 28399.858000709864, 28544.28639283993, 28577.57133642997, 933.1927882381691, 945.5461378538203, 970.257752819094, 994.8656931314325, 1109.5561775289787, 15077.698446031018, 15144.0, 15208.46770363032, 15486.612834679223, 15496.535103946899, 276430.0, 286371.0, 287157.0, 287317.0, 356751.0, 49219.26171107436, 49648.0, 49728.50271497311, 50137.74931125321, 50154.0, 1204.5181927229003, 1208.915375923677, 1211.7576484702918, 1221.3770976801895, 1289.5744404346542, 27283.454330913668, 27638.86180569084, 28167.57748633731, 28209.71790282071, 28904.85547572249, 42105.36841947435, 42823.3576496359, 42835.357469638606, 42886.14227715366, 42947.0, 296224.0, 301979.0, 302810.0, 303485.0, 303578.0, 25445.618315724907, 25729.099481518057, 25883.352916177246, 25898.0, 25936.0, 40570.79714601408, 41420.378694319006, 41975.370369445096, 42051.369229462194, 42234.78882605567, 35321.29357412889, 36111.45832812563, 36237.0940726484, 36404.63595364012, 36657.0, 34928.65071349355, 35291.823540882135, 35615.46576801298, 35869.461958070126, 35902.64097359098, 32645.836770815993, 32699.67300326966, 32938.341233175684, 33448.1637959053, 33449.66550334466, 30092.24769380783, 31595.526067109473, 32244.19389515281, 32267.193320167185, 32583.0, 24567.14015009466, 24748.628770568816, 24811.25566233016, 25078.24765257045, 25144.37139071538], "value": 16062.270356105353, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.7398781834444, 379.8233821273108, 380.45214890557594, 380.93904975203975, 381.43547549626567, 15267.465638702648, 15574.610634734137, 16239.91880040601, 16271.105089220087, 16296.266667999953, 15963.281652325644, 16609.83390166098, 17203.311867525284, 17320.82679173211, 17345.566360840985, 4966.304717339566, 5186.170212765958, 5196.896062078757, 5201.583873290147, 5221.79112835488, 4989.725565093919, 5057.645964782467, 5120.411152717429, 5168.250603662466, 5174.223866420049, 5247.737613119348, 5260.631755777097, 5261.894762104775, 5268.525832675058, 5277.023750606131, 5049.469805670388, 5252.159654455288, 5445.646033007842, 5455.890882182373, 5457.0, 5295.152775555893, 5300.469953004707, 5315.840524784263, 5353.892922141575, 5357.1696387060065, 11676.0, 12400.81398779019, 12416.937915310456, 12428.813567796491, 12478.875211247952, 1825.3155066849931, 1847.178005787425, 1869.2242719271485, 1895.6113996630659, 1923.6537423263808, 9429.481378524179, 9461.52692365379, 9685.564149613285, 10939.0, 11927.0, 1586.191042568287, 1591.2362066208168, 1608.300389330645, 1609.8229194788564, 1660.5931546770998, 70018.0, 72328.27671723321, 72350.0, 73504.63247683781, 73733.0, 9739.659111931049, 9806.705798826046, 10264.024917632813, 10561.155107591529, 10873.07578855806, 13793.586192414243, 13834.515791947233, 13941.65145871341, 13961.162330260217, 13969.79045314321, 7280.890786638205, 7328.120625524971, 7414.035280650632, 7516.361109305771, 7577.128630207487, 7037.507374483737, 7104.609246491389, 7162.534435261691, 7170.6056166910275, 7193.568385896863, 4235.237657221668, 4251.681123915719, 4350.8042138103865, 4357.629601483846, 4392.736435813861, 1828.2047309420445, 1880.3324819689087, 1885.86798924074, 1892.1617573639542, 1893.6591413545693, 755.928186822251, 774.3302043732131, 801.2988634944423, 813.3574476163883, 840.6133178737726, 15567.922160389126, 16075.678486430439, 16385.262663180187, 16507.174641267888, 16752.748708769377, 824.9216324449168, 836.2933321343455, 859.9226069653761, 878.7539488943106, 901.2789768185556, 9081.59132839024, 9083.727488175366, 9262.814743705088, 9283.25733941283, 9347.953260233655, 413588.0, 414832.0, 416282.0, 440564.0, 453602.0, 58804.41195588075, 69999.0, 71095.2890471099, 79896.60051699704, 83817.0, 875.8905136857893, 951.3198063384575, 957.0764212534938, 957.9089986451276, 961.4135377419768, 15240.618984525476, 15500.457483988006, 15608.921955390604, 15714.13572253537, 15829.604259893134, 35764.46353304754, 36473.45289820708, 36834.8158259207, 37071.629283707895, 37103.6289637111, 48747.51252487572, 52185.0, 52846.47153528415, 52980.0, 53620.73189634027, 7109.466789990668, 7484.251574842472, 7537.510061845963, 7621.0, 7642.426817988784, 10830.40432776205, 11061.225714199929, 11248.662540123809, 11295.209335346446, 11324.0, 9083.137101975302, 9247.213986810928, 9367.625294988396, 9388.530573471162, 9452.43285402878, 9440.527973601154, 9893.901060989298, 9901.207903367856, 10132.037456441627, 10146.847797282899, 8437.198466145706, 8982.685606004019, 9278.072192780668, 9286.72139835806, 9554.426734395958, 7478.850422991619, 7683.615819209129, 7732.806679832825, 7768.88346674789, 7855.646495907584, 4789.425268967746, 6290.528210384148, 6959.304069593203, 7506.699732010877, 9326.0], "value": 7923.296719633548, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.1077565745752, 1447.1895738386504, 1538.6076550479627, 1748.2133040131944, 1777.2890843662533, 6816.863662726742, 7547.018887544626, 7563.962180189098, 7763.650635721399, 7796.06447226333, 7590.5066170698865, 7627.0847498300145, 7648.655810488527, 7657.655405506752, 7729.072511298638, 2141.7429908411013, 2193.8573992690426, 2202.7797220278003, 2206.580749657568, 2207.845450818443, 2092.89535523224, 2099.9475013124716, 2149.48412381029, 2158.363282831561, 2162.275637661385, 2167.0681606909025, 2169.6203164446238, 2181.5091604388963, 2182.9126834926665, 2201.0755482697227, 2162.1243396424475, 2171.0447403142566, 2171.457135716071, 2176.923807666724, 2179.967300490494, 2098.685197220429, 2137.78622137785, 2156.320758960938, 2158.136745301876, 2165.805077543013, 7755.418343624195, 7836.490628109154, 7849.646765895548, 7856.0, 7867.6852925882895, 4459.175052615276, 4584.426946631671, 4604.0, 4626.097910907374, 4641.466231383401, 2749.5188342040065, 2806.989483785856, 2897.1887871396043, 2905.4334404791075, 2917.810342327763, 878.1218781218781, 887.760304717729, 888.8666699995052, 902.6795487601938, 916.0, 10554.366737995744, 10607.84088238677, 10610.628627997983, 10634.946825265824, 10638.361698298128, 4248.725382385333, 4294.76378799169, 4375.453068366454, 4392.824287028547, 4396.054848207651, 9053.139951704577, 9055.81888362229, 9069.229115525122, 9081.091890810865, 9118.179363857153, 4767.118083154627, 4775.570198682066, 4779.617630589544, 4780.091782561302, 4781.13939490895, 3766.114962983697, 4161.625453709181, 4225.598568136023, 4251.192273468031, 4298.376735373354, 3573.4639804029084, 3573.5890372607482, 3652.579953305351, 3686.9815650921573, 3710.035390798358, 1172.8533933258343, 1205.2949024820402, 1212.8483939507562, 1220.7192345760525, 1223.7980733178927, 781.2929298984428, 892.7455675132557, 898.0839543665555, 908.2280061947292, 919.5034681272172, 5620.718964051781, 5642.407547207484, 5698.914516282259, 5712.000399930079, 5827.3298570664065, 841.0454134557199, 889.1508609278123, 889.5463313710054, 929.9023602521638, 986.7335819328885, 3626.1659818241424, 3785.0, 3841.193349396602, 3848.7690738555775, 3866.5940076292145, 8943.284537237136, 9275.0, 9351.90648093524, 9353.766155846022, 9390.295727820305, 9118.544072796334, 9175.908240917639, 9238.722838314861, 9266.536673166314, 9301.581428835718, 6957.339052789976, 7283.745068922668, 7314.232005639437, 7333.413326933833, 7364.705411783576, 5117.078925793393, 5340.252364669027, 5383.434739352311, 5410.269613602113, 5612.719364031864, 8503.574821258788, 8672.306215502618, 8681.739547813575, 8751.387402881992, 8819.60311785984, 8710.91289087101, 8906.465612063297, 8907.821843563223, 8944.731658050268, 9214.262858971133, 6066.332703402534, 6224.87952168614, 6415.775447859302, 6641.970494573349, 6789.864202715819, 7393.186749457448, 7402.703891844481, 7416.44376671741, 7420.257974202753, 7436.144843342869, 6425.389587989321, 6522.967385163044, 6577.210734711865, 6661.267260601427, 6696.698648560729, 6335.429811317003, 6447.548671592944, 6511.283758786624, 6568.47452203813, 6600.702968366339, 6033.78881739137, 6103.816885493442, 6113.57204995646, 6136.171616831671, 6142.938570614416, 4658.510856360169, 4668.463126740468, 4732.384789977281, 4866.099771542276, 4903.0, 4641.489436162087, 4693.6949098308505, 4746.169420351355, 4799.3041009052795, 4860.052289803454], "value": 4151.7160913886255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.9684334723181, 301.58080268426886, 304.21057356160753, 305.68819803800125, 309.01424455985403, 4775.737334446604, 4840.17716988112, 4851.345068415762, 4951.628627852912, 4968.900621987563, 4928.926066109002, 4935.703857768536, 4939.950600493994, 4965.801367945278, 4980.60155187585, 3881.10734531058, 3909.9413508797393, 3912.041549820298, 3915.099527108767, 3932.292187406266, 3610.277944411115, 3880.1269714314194, 3894.2990261752875, 3904.7852368119884, 3906.941395879064, 3754.192848537564, 3792.2415516896594, 3818.8472461101524, 3828.1386687995255, 3833.7508061976023, 3790.0903783092, 3802.9429558556644, 3807.409851473012, 3807.6573108420375, 3822.2164456286396, 3342.983285083559, 3348.4475061614803, 3350.078728349699, 3351.765376423651, 3358.714509266715, 4654.953450465486, 4705.153072446992, 4732.408448943882, 4759.833405830814, 4764.0, 4311.8706438806885, 4336.460556502459, 4346.913061738779, 4352.151330490556, 4382.517923028464, 5133.563647090002, 5146.511081447256, 5159.845204643867, 5195.974020129913, 5207.6615020023955, 3425.760196786226, 3644.0343309022865, 3660.267946410702, 3660.8535658573624, 3663.688586470153, 5407.134858422633, 5415.918761218585, 5431.728413579305, 5446.264754258164, 5483.945160548423, 3729.216864458494, 3730.3658378075793, 3741.4387841823946, 3749.9250015000093, 3752.962470375316, 3781.640744129303, 3784.0729021389934, 3793.696504279651, 3801.1067399161175, 3817.408301713239, 4092.5907409258834, 4306.569343065668, 4314.676399270067, 4340.305551111807, 4343.19650864591, 5204.167333226741, 5214.270002199695, 5227.843164705065, 5228.895422091613, 5241.846793705378, 1300.7203451257835, 1331.7269959658247, 1358.9864101359058, 1372.9038967272195, 1373.9725205496034, 889.5329951775369, 904.5974541329177, 920.4569304110607, 921.5438358012826, 921.7972046149837, 4668.4631267404, 4698.412698412699, 4766.571008609172, 4773.11697335994, 4792.784324705397, 5637.746301416446, 5639.379668236491, 5654.85862853432, 5655.123455864347, 5682.192930736416, 4686.554777296152, 4728.881777955578, 4778.259369797687, 4809.0, 4810.2100781546615, 3016.245938515371, 3021.6374035115928, 3033.8634761435787, 3042.710942460463, 3043.1022848259818, 5254.579633629301, 5267.657602255841, 5298.470152984671, 5304.973475132677, 5317.601179911522, 5237.3453318335205, 5542.168674698827, 5555.972220138954, 5775.249217601685, 5782.3639399666, 5071.18860982241, 5074.467180945948, 5077.136886729265, 5107.182850743863, 5111.744412779271, 5443.673379597237, 5444.782208711607, 5455.672659640434, 5458.317710286215, 5486.478784515464, 5204.802895334019, 5304.28392167068, 5325.281087053353, 5346.465353464622, 5353.323338330834, 5028.64799464034, 5072.9746351268, 5115.9232611510115, 5119.462456442169, 5144.170706111699, 3696.4824924511126, 3706.5181526401393, 3718.442233664972, 3729.5710993236125, 3734.402495600691, 5056.6207534434325, 5334.973325133349, 5351.170568561879, 5368.141097424549, 5369.48989845964, 5074.517920797518, 5197.856471576247, 5228.790848366023, 5247.763850626655, 5280.867978300574, 5203.427622961547, 5213.661112027706, 5224.52979231871, 5246.632735708464, 5255.947440525699, 4861.270809378621, 5126.4617215191865, 5145.151050076845, 5154.381474223117, 5170.741462926763, 5236.476352364733, 5245.790168393221, 5289.127293996601, 5315.813946511854, 5323.813666521653, 5131.332926719502, 5139.331886854685, 5168.0, 5191.428942816212, 5194.68831870089], "value": 3940.6799585995395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.8050584824553, 746.3842330077687, 767.2634271099747, 771.5100910921564, 779.7270955165693, 12107.394630268484, 12331.5067397304, 12353.629391118258, 12415.0, 12485.875141248596, 10133.391996480217, 10216.131628811541, 10267.691969240916, 11963.820542691845, 12330.506779728823, 630.0926665601542, 792.453207286973, 804.4047404920346, 809.6842231529708, 809.7773112394079, 776.7126163319551, 795.3954994204388, 797.7726347990824, 798.1101072304368, 798.7723498802842, 821.6877586517115, 831.3266254334009, 832.3923535818856, 836.3643630840575, 836.5440834745048, 825.8761185822115, 829.0341751859077, 829.6308142876422, 833.7748807821915, 835.8495470815251, 610.2432983100967, 615.2616859768295, 615.326217791522, 619.3991827926903, 621.5307442880642, 12526.997840172764, 12539.31033793141, 12542.874571254262, 12624.55814046504, 12629.052821038367, 12515.374231288399, 12835.550755723505, 12837.486500539968, 12894.742105157844, 12966.546170883974, 9519.936923847445, 9621.951890240574, 9639.662611808553, 9726.97866723991, 9863.260255480867, 3285.4414749492644, 3327.6505966873615, 3365.562476878015, 3381.408253555618, 3434.3818112739696, 42417.57582424167, 43199.35200971988, 43453.0, 44749.32876006862, 45263.86840328985, 9502.334836561375, 9548.761280967892, 9565.665201717906, 9631.614735410645, 9693.6122555097, 17584.64830703379, 17693.115344232738, 17704.822951770577, 17722.645547088985, 17727.0, 6577.80266592003, 6587.077809106729, 6685.39831415175, 6688.3646053624825, 6754.392104710501, 3538.380783362901, 3549.0, 3624.909377265537, 3636.7999760013454, 3647.161152934787, 2873.454043731684, 2939.955900661492, 2940.529515277545, 2942.3526824098662, 2950.8229506229695, 493.7457209537091, 501.53607912680627, 512.9153689641242, 513.1609817947682, 514.2337916504382, 534.6551474299056, 553.0239127939191, 558.4722437296797, 562.072580242603, 581.758570193365, 6556.901646475307, 6837.62393068386, 7095.325944035309, 7191.748288809971, 7229.530080544748, 428.29545397820414, 454.5227511113318, 456.33375272103103, 503.75819606589044, 512.9757055896486, 3359.6976272135626, 3409.4715319125576, 3439.724822014233, 3482.1120614243205, 3490.1798077451776, 48999.0, 49385.75307123513, 49849.0, 57005.0, 57359.426405736245, 47445.0, 47886.28170577444, 48477.75761121172, 48596.27105593419, 49303.753481233085, 44100.0, 45125.77437112859, 45718.542814572094, 45749.31376029296, 45820.54179458163, 6729.394354508117, 6831.9658401707675, 6840.452763778985, 6867.244603093755, 6909.827254318682, 28261.30432174076, 28806.0, 29167.270818229714, 29407.85296073506, 29691.257718557208, 36851.0, 38857.639982601606, 38868.222635547696, 38971.6102838968, 39310.0, 8507.617157227816, 8559.914400856162, 8656.0, 8739.126087391463, 8759.386842920934, 8943.597538110931, 9056.184943355129, 9136.6802161924, 9144.405613635092, 9297.628094876129, 8499.0, 8580.326836267117, 8609.870851937101, 8639.740807775777, 8739.650413983623, 8728.781780455285, 8856.822863542822, 8869.467831930106, 8914.643414263617, 8985.640574376952, 8248.958755206186, 8303.95848020756, 8414.074451810418, 8488.490690558587, 8501.277391421798, 7212.134543854561, 7248.238934911969, 7278.890816637861, 7475.953366528799, 7615.428842836699, 7255.056842610426, 7330.874046526447, 7409.259074092548, 7552.244775522404, 7589.924100759143], "value": 5534.334218563582, "unit": "score"}], "name": "dromaeo_css", "value": 6137.0784012122695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 115.0, 114.0, 115.0, 128.0, 119.0, 114.0, 113.0, 113.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 135.0, 174.0, 190.0, 139.0, 176.0, 159.0, 137.0, 196.0, 136.0], "value": 160.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 173.0, 163.0, 162.0, 161.0, 164.0, 166.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 84.0, 174.0, 77.0, 87.0, 77.0, 76.0, 157.0, 79.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 145.0, 95.0, 94.0, 95.0, 145.0, 95.0, 94.0, 138.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 119.0, 117.0, 117.0, 118.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 70.0, 68.0, 74.0, 68.0, 69.0, 67.0, 68.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 82.0, 83.0, 82.0, 84.0, 86.0, 88.0, 123.0, 82.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 139.0, 147.0, 140.0, 137.0, 141.0, 131.0, 131.0, 153.0, 135.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 180.0, 189.0, 177.0, 175.0, 178.0, 180.0, 175.0, 178.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 76.0, 76.0, 74.0, 75.0, 75.0, 74.0, 73.0], "value": 74.7, "unit": "score"}], "name": "kraken", "value": 1620.1000000000001, "alertThreshold": 2.0}]} 18:45:08 INFO - Return code: 0 18:45:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:45:08 ERROR - # TBPL SUCCESS # 18:45:08 INFO - Running post-action listener: _resource_record_post_action 18:45:08 INFO - Running post-run listener: _resource_record_post_run 18:45:09 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536879104; Read time: 8; Write time: 525112 18:45:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 241844224; Read time: 0; Write time: 283188 18:45:09 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284143616; Read time: 8; Write time: 239092 18:45:09 INFO - Running post-run listener: _upload_blobber_files 18:45:09 INFO - Blob upload gear active. 18:45:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:45:09 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:45:09 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:45:09 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:45:09 INFO - (blobuploader) - INFO - Open directory for files ... 18:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:10 INFO - (blobuploader) - INFO - Done attempting. 18:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:45:11 INFO - (blobuploader) - INFO - Done attempting. 18:45:11 INFO - (blobuploader) - INFO - Iteration through files over. 18:45:11 INFO - Return code: 0 18:45:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:45:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:45:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4690f5e3dc044e3117ec78b0b04bbac29c250d00298014c1f879af40a607ce1deea8ff1bcde0953c1005b9a7497c3b9d196de1c99f8740158b4b6b0b70050139", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43c879c339d3eded470d3ec97ef07a679579acf2bd065e8b8dfead443525524389634150a9cd87a2a8472c8b1034b8d0a79c44341843006bb886becffd49bb99"} 18:45:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:45:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:45:11 INFO - Contents: 18:45:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4690f5e3dc044e3117ec78b0b04bbac29c250d00298014c1f879af40a607ce1deea8ff1bcde0953c1005b9a7497c3b9d196de1c99f8740158b4b6b0b70050139", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43c879c339d3eded470d3ec97ef07a679579acf2bd065e8b8dfead443525524389634150a9cd87a2a8472c8b1034b8d0a79c44341843006bb886becffd49bb99"} 18:45:11 INFO - Running post-run listener: copy_logs_to_upload_dir 18:45:11 INFO - Copying logs to upload dir... 18:45:11 INFO - mkdir: /builds/slave/test/build/upload/logs 18:45:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.063951 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-29 18:45:11.904294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:45:11.907643) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103 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/4690f5e3dc044e3117ec78b0b04bbac29c250d00298014c1f879af40a607ce1deea8ff1bcde0953c1005b9a7497c3b9d196de1c99f8740158b4b6b0b70050139", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43c879c339d3eded470d3ec97ef07a679579acf2bd065e8b8dfead443525524389634150a9cd87a2a8472c8b1034b8d0a79c44341843006bb886becffd49bb99"} build_url:https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/HYrVyTYbSQODRnnNwp2DDw/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/4690f5e3dc044e3117ec78b0b04bbac29c250d00298014c1f879af40a607ce1deea8ff1bcde0953c1005b9a7497c3b9d196de1c99f8740158b4b6b0b70050139", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/43c879c339d3eded470d3ec97ef07a679579acf2bd065e8b8dfead443525524389634150a9cd87a2a8472c8b1034b8d0a79c44341843006bb886becffd49bb99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 18:45:11.934361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:45:11.934857) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461978446.917261-237682103 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 18:45:12.019488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:45:12.020138) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 18:45:12.020721) ========= ========= Total master_lag: 0.18 =========