builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1461120135.08 results: success (0) buildid: 20160419143022 builduid: f109929e594547bfb4b2a7352a7de0e2 revision: 59fe5c482a5535f44775070b7ee56d9d15561b6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.078047) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.078594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.078922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.105811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.106264) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 19:42:15-- 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% 226M=0s 2016-04-19 19:42:15 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.248989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.249479) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015325 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.304668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.308060) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 59fe5c482a5535f44775070b7ee56d9d15561b6b --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 59fe5c482a5535f44775070b7ee56d9d15561b6b --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=652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 19:42:15,357 truncating revision to first 12 chars 2016-04-19 19:42:15,357 Setting DEBUG logging. 2016-04-19 19:42:15,358 attempt 1/10 2016-04-19 19:42:15,358 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/59fe5c482a55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 19:42:15,633 unpacking tar archive at: fx-team-59fe5c482a55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.916239) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.916590) ========= script_repo_revision: 59fe5c482a5535f44775070b7ee56d9d15561b6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.918593) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.918910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 19:42:15.928301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-19 19:42:15.928626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:42:16 INFO - MultiFileLogger online at 20160419 19:42:16 in /builds/slave/test 19:42:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:42:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:42:16 INFO - {'append_to_log': False, 19:42:16 INFO - 'base_work_dir': '/builds/slave/test', 19:42:16 INFO - 'blob_upload_branch': 'Fx-Team', 19:42:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:42:16 INFO - 'branch': 'Fx-Team', 19:42:16 INFO - 'buildbot_json_path': 'buildprops.json', 19:42:16 INFO - 'config_files': ('talos/linux_config.py',), 19:42:16 INFO - 'default_actions': ('clobber', 19:42:16 INFO - 'read-buildbot-config', 19:42:16 INFO - 'download-and-extract', 19:42:16 INFO - 'populate-webroot', 19:42:16 INFO - 'create-virtualenv', 19:42:16 INFO - 'install', 19:42:16 INFO - 'run-tests'), 19:42:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:42:16 INFO - 'download_minidump_stackwalk': True, 19:42:16 INFO - 'download_symbols': 'ondemand', 19:42:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:42:16 INFO - 'tooltool.py': '/tools/tooltool.py', 19:42:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:42:16 INFO - '/tools/misc-python/virtualenv.py')}, 19:42:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:42:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:42:16 INFO - 'installer_path': 'installer.exe', 19:42:16 INFO - 'log_level': 'info', 19:42:16 INFO - 'log_name': 'talos', 19:42:16 INFO - 'log_to_console': True, 19:42:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:42:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:42:16 INFO - 'opt_config_files': (), 19:42:16 INFO - 'pip_index': False, 19:42:16 INFO - 'sps_profile': False, 19:42:16 INFO - 'sps_profile_interval': 0, 19:42:16 INFO - 'suite': 'dromaeojs-e10s', 19:42:16 INFO - 'system_bits': '32', 19:42:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:42:16 INFO - 'title': 'talos-linux64-ix-046', 19:42:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:42:16 INFO - 'use_talos_json': True, 19:42:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:42:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:42:16 INFO - 'work_dir': 'build'} 19:42:16 INFO - ##### 19:42:16 INFO - ##### Running clobber step. 19:42:16 INFO - ##### 19:42:16 INFO - Running pre-action listener: _resource_record_pre_action 19:42:16 INFO - Running main action method: clobber 19:42:16 INFO - rmtree: /builds/slave/test/build 19:42:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:42:16 INFO - Running post-action listener: _resource_record_post_action 19:42:16 INFO - ##### 19:42:16 INFO - ##### Running read-buildbot-config step. 19:42:16 INFO - ##### 19:42:16 INFO - Running pre-action listener: _resource_record_pre_action 19:42:16 INFO - Running main action method: read_buildbot_config 19:42:16 INFO - Using buildbot properties: 19:42:16 INFO - { 19:42:16 INFO - "project": "", 19:42:16 INFO - "product": "firefox", 19:42:16 INFO - "script_repo_revision": "production", 19:42:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:42:16 INFO - "repository": "", 19:42:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 19:42:16 INFO - "buildid": "20160419143022", 19:42:16 INFO - "pgo_build": "True", 19:42:16 INFO - "basedir": "/builds/slave/test", 19:42:16 INFO - "buildnumber": 661, 19:42:16 INFO - "slavename": "talos-linux64-ix-046", 19:42:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:42:16 INFO - "platform": "ubuntu64_hw", 19:42:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 19:42:16 INFO - "branch": "fx-team", 19:42:16 INFO - "repo_path": "integration/fx-team", 19:42:16 INFO - "revision": "59fe5c482a5535f44775070b7ee56d9d15561b6b", 19:42:16 INFO - "stage_platform": "linux64-pgo", 19:42:16 INFO - "builduid": "f109929e594547bfb4b2a7352a7de0e2", 19:42:16 INFO - "slavebuilddir": "test" 19:42:16 INFO - } 19:42:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 19:42:16 INFO - Running post-action listener: _resource_record_post_action 19:42:16 INFO - ##### 19:42:16 INFO - ##### Running download-and-extract step. 19:42:16 INFO - ##### 19:42:16 INFO - Running pre-action listener: _resource_record_pre_action 19:42:16 INFO - Running main action method: download_and_extract 19:42:16 INFO - mkdir: /builds/slave/test/build/tests 19:42:16 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')]} 19:42:16 INFO - https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:42:17 INFO - Downloaded 1361 bytes. 19:42:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 19:42:17 INFO - Using the following test package requirements: 19:42:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:42:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:42:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:42:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'jsshell-linux-x86_64.zip'], 19:42:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:42:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 19:42:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:42:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:42:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:42:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 19:42:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:42:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:42:17 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')]} 19:42:17 INFO - https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:42:18 INFO - Downloaded 23838444 bytes. 19:42:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:42:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:42:19 INFO - Return code: 0 19:42:19 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:42:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:19 INFO - https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:42:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:42:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:42:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 19:42:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:42:23 INFO - Downloaded 23838444 bytes. 19:42:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:42:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:42:25 INFO - Return code: 0 19:42:25 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')]} 19:42:25 INFO - https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:42:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:42:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:42:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 19:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:42:26 INFO - Downloaded 10845952 bytes. 19:42:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:42:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:42:26 INFO - Return code: 0 19:42:26 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')]} 19:42:26 INFO - https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:42:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:42:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:42:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:42:27 INFO - Downloaded 58272021 bytes. 19:42:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:42:27 INFO - mkdir: /builds/slave/test/properties 19:42:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:42:27 INFO - Writing to file /builds/slave/test/properties/build_url 19:42:27 INFO - Contents: 19:42:27 INFO - build_url:https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 19:42:28 INFO - Running post-action listener: _resource_record_post_action 19:42:28 INFO - Running post-action listener: set_extra_try_arguments 19:42:28 INFO - ##### 19:42:28 INFO - ##### Running populate-webroot step. 19:42:28 INFO - ##### 19:42:28 INFO - Running pre-action listener: _resource_record_pre_action 19:42:28 INFO - Running main action method: populate_webroot 19:42:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:42:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:42:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:42:28 INFO - '--tppagecycles', 19:42:28 INFO - '7'], 19:42:28 INFO - 'tests': ['tsvgm']}}, 19:42:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:42:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:42:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:42:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:42:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:42:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:42:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['damp', 'tps']}, 19:42:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'tests': ['damp', 'tps']}, 19:42:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['dromaeo_dom']}, 19:42:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:42:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['a11yr', 19:42:28 INFO - 'ts_paint', 19:42:28 INFO - 'tpaint', 19:42:28 INFO - 'sessionrestore', 19:42:28 INFO - 'sessionrestore_no_auto_restore', 19:42:28 INFO - 'tabpaint']}, 19:42:28 INFO - 'other-e10s': {'tests': ['a11yr', 19:42:28 INFO - 'ts_paint', 19:42:28 INFO - 'tpaint', 19:42:28 INFO - 'sessionrestore', 19:42:28 INFO - 'sessionrestore_no_auto_restore', 19:42:28 INFO - 'tabpaint']}, 19:42:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:42:28 INFO - 'ts_paint', 19:42:28 INFO - 'tpaint', 19:42:28 INFO - 'sessionrestore', 19:42:28 INFO - 'sessionrestore_no_auto_restore', 19:42:28 INFO - 'tabpaint']}, 19:42:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:42:28 INFO - 'ts_paint', 19:42:28 INFO - 'tpaint', 19:42:28 INFO - 'sessionrestore', 19:42:28 INFO - 'sessionrestore_no_auto_restore', 19:42:28 INFO - 'tabpaint']}, 19:42:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['a11yr', 19:42:28 INFO - 'ts_paint', 19:42:28 INFO - 'tpaint', 19:42:28 INFO - 'sessionrestore', 19:42:28 INFO - 'sessionrestore_no_auto_restore', 19:42:28 INFO - 'tabpaint']}, 19:42:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['a11yr', 19:42:28 INFO - 'ts_paint', 19:42:28 INFO - 'tpaint', 19:42:28 INFO - 'sessionrestore', 19:42:28 INFO - 'sessionrestore_no_auto_restore', 19:42:28 INFO - 'tabpaint']}, 19:42:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['tsvgx', 19:42:28 INFO - 'tsvgr_opacity', 19:42:28 INFO - 'tart', 19:42:28 INFO - 'tscrollx', 19:42:28 INFO - 'cart']}, 19:42:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:42:28 INFO - 'tsvgr_opacity', 19:42:28 INFO - 'tart', 19:42:28 INFO - 'tscrollx', 19:42:28 INFO - 'cart']}, 19:42:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'talos_options': ['--disable-e10s'], 19:42:28 INFO - 'tests': ['tp5o']}, 19:42:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'tests': ['tp5o']}, 19:42:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'talos_options': ['--disable-e10s', 19:42:28 INFO - '--xperf_path', 19:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:42:28 INFO - 'tests': ['tp5n']}, 19:42:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:42:28 INFO - 'talos_options': ['--xperf_path', 19:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:42:28 INFO - 'tests': ['tp5n']}}, 19:42:28 INFO - 'talos.zip': {'path': '', 19:42:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:42:28 INFO - Running post-action listener: _resource_record_post_action 19:42:28 INFO - ##### 19:42:28 INFO - ##### Running create-virtualenv step. 19:42:28 INFO - ##### 19:42:28 INFO - Running pre-action listener: _resource_record_pre_action 19:42:28 INFO - Running main action method: create_virtualenv 19:42:28 INFO - Creating virtualenv /builds/slave/test/build/venv 19:42:28 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 19:42:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:42:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:42:28 INFO - Using real prefix '/usr' 19:42:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:42:29 INFO - Installing distribute.............................................................................................................................................................................................done. 19:42:31 INFO - Installing pip.................done. 19:42:31 INFO - Return code: 0 19:42:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:42:31 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')]} 19:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:31 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')]} 19:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:31 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:31 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 19:42:31 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 19:42:31 INFO - Using env: {'DISPLAY': ':0', 19:42:31 INFO - 'HOME': '/home/cltbld', 19:42:31 INFO - 'LANG': 'en_US.UTF-8', 19:42:31 INFO - 'LANGUAGE': 'en_US:en', 19:42:31 INFO - 'LOGNAME': 'cltbld', 19:42:31 INFO - 'MAIL': '/var/mail/cltbld', 19:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:31 INFO - 'MOZ_NO_REMOTE': '1', 19:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:31 INFO - 'NO_EM_RESTART': '1', 19:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:31 INFO - 'PWD': '/builds/slave/test', 19:42:31 INFO - 'SHELL': '/bin/bash', 19:42:31 INFO - 'SHLVL': '1', 19:42:31 INFO - 'TERM': 'linux', 19:42:31 INFO - 'TMOUT': '86400', 19:42:31 INFO - 'USER': 'cltbld', 19:42:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:31 INFO - '_': '/tools/buildbot/bin/python'} 19:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:31 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 19:42:31 INFO - Cleaning up... 19:42:31 INFO - Return code: 0 19:42:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:42:31 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')]} 19:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:31 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')]} 19:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:31 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:31 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 19:42:31 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 19:42:31 INFO - Using env: {'DISPLAY': ':0', 19:42:31 INFO - 'HOME': '/home/cltbld', 19:42:31 INFO - 'LANG': 'en_US.UTF-8', 19:42:31 INFO - 'LANGUAGE': 'en_US:en', 19:42:31 INFO - 'LOGNAME': 'cltbld', 19:42:31 INFO - 'MAIL': '/var/mail/cltbld', 19:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:31 INFO - 'MOZ_NO_REMOTE': '1', 19:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:31 INFO - 'NO_EM_RESTART': '1', 19:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:31 INFO - 'PWD': '/builds/slave/test', 19:42:31 INFO - 'SHELL': '/bin/bash', 19:42:31 INFO - 'SHLVL': '1', 19:42:31 INFO - 'TERM': 'linux', 19:42:31 INFO - 'TMOUT': '86400', 19:42:31 INFO - 'USER': 'cltbld', 19:42:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:31 INFO - '_': '/tools/buildbot/bin/python'} 19:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:31 INFO - Downloading/unpacking psutil>=0.7.1 19:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:31 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 19:42:31 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 19:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:42:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:42:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:42:33 INFO - Installing collected packages: psutil 19:42:33 INFO - Running setup.py install for psutil 19:42:33 INFO - building 'psutil._psutil_linux' extension 19:42:33 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 19:42:33 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 19:42:33 INFO - building 'psutil._psutil_posix' extension 19:42:33 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 19:42:33 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 19:42:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:42:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:42:34 INFO - Successfully installed psutil 19:42:34 INFO - Cleaning up... 19:42:34 INFO - Return code: 0 19:42:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:42: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')]} 19:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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')]} 19:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:34 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:34 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 19:42:34 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 19:42:34 INFO - Using env: {'DISPLAY': ':0', 19:42:34 INFO - 'HOME': '/home/cltbld', 19:42:34 INFO - 'LANG': 'en_US.UTF-8', 19:42:34 INFO - 'LANGUAGE': 'en_US:en', 19:42:34 INFO - 'LOGNAME': 'cltbld', 19:42:34 INFO - 'MAIL': '/var/mail/cltbld', 19:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:34 INFO - 'MOZ_NO_REMOTE': '1', 19:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:34 INFO - 'NO_EM_RESTART': '1', 19:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:34 INFO - 'PWD': '/builds/slave/test', 19:42:34 INFO - 'SHELL': '/bin/bash', 19:42:34 INFO - 'SHLVL': '1', 19:42:34 INFO - 'TERM': 'linux', 19:42:34 INFO - 'TMOUT': '86400', 19:42:34 INFO - 'USER': 'cltbld', 19:42:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:34 INFO - '_': '/tools/buildbot/bin/python'} 19:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:34 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 19:42:34 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 19:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:42:36 INFO - Installing collected packages: mozsystemmonitor 19:42:36 INFO - Running setup.py install for mozsystemmonitor 19:42:36 INFO - Successfully installed mozsystemmonitor 19:42:36 INFO - Cleaning up... 19:42:37 INFO - Return code: 0 19:42:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:42:37 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')]} 19:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:37 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')]} 19:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:37 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:37 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 19:42:37 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 19:42:37 INFO - Using env: {'DISPLAY': ':0', 19:42:37 INFO - 'HOME': '/home/cltbld', 19:42:37 INFO - 'LANG': 'en_US.UTF-8', 19:42:37 INFO - 'LANGUAGE': 'en_US:en', 19:42:37 INFO - 'LOGNAME': 'cltbld', 19:42:37 INFO - 'MAIL': '/var/mail/cltbld', 19:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:37 INFO - 'MOZ_NO_REMOTE': '1', 19:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:37 INFO - 'NO_EM_RESTART': '1', 19:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:37 INFO - 'PWD': '/builds/slave/test', 19:42:37 INFO - 'SHELL': '/bin/bash', 19:42:37 INFO - 'SHLVL': '1', 19:42:37 INFO - 'TERM': 'linux', 19:42:37 INFO - 'TMOUT': '86400', 19:42:37 INFO - 'USER': 'cltbld', 19:42:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:37 INFO - '_': '/tools/buildbot/bin/python'} 19:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:42:37 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 19:42:37 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 19:42:37 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 19:42:37 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 19:42:37 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 19:42:37 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 19:42:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:42:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:39 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 19:42:39 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 19:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:42:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:39 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 19:42:39 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 19:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:40 INFO - Downloading docopt-0.6.1.tar.gz 19:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:42:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:42:40 INFO - Running setup.py install for blobuploader 19:42:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:42:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:42:40 INFO - Running setup.py install for requests 19:42:40 INFO - Running setup.py install for docopt 19:42:40 INFO - Successfully installed blobuploader requests docopt 19:42:40 INFO - Cleaning up... 19:42:40 INFO - Return code: 0 19:42:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:42: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')]} 19:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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')]} 19:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:40 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:40 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 19:42:40 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 19:42:40 INFO - Using env: {'DISPLAY': ':0', 19:42:40 INFO - 'HOME': '/home/cltbld', 19:42:40 INFO - 'LANG': 'en_US.UTF-8', 19:42:40 INFO - 'LANGUAGE': 'en_US:en', 19:42:40 INFO - 'LOGNAME': 'cltbld', 19:42:40 INFO - 'MAIL': '/var/mail/cltbld', 19:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:40 INFO - 'MOZ_NO_REMOTE': '1', 19:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:40 INFO - 'NO_EM_RESTART': '1', 19:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:40 INFO - 'PWD': '/builds/slave/test', 19:42:40 INFO - 'SHELL': '/bin/bash', 19:42:40 INFO - 'SHLVL': '1', 19:42:40 INFO - 'TERM': 'linux', 19:42:40 INFO - 'TMOUT': '86400', 19:42:40 INFO - 'USER': 'cltbld', 19:42:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:40 INFO - '_': '/tools/buildbot/bin/python'} 19:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:42:40 INFO - Running setup.py (path:/tmp/pip-KEDPHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:42:41 INFO - Running setup.py (path:/tmp/pip-pKQ4qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:42:41 INFO - Running setup.py (path:/tmp/pip-okNY0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:42:41 INFO - Running setup.py (path:/tmp/pip-tF8XQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:42:41 INFO - Running setup.py (path:/tmp/pip-aXlJle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:42:41 INFO - Running setup.py (path:/tmp/pip-ujPluQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:42:41 INFO - Running setup.py (path:/tmp/pip-V9tDch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:42:41 INFO - Running setup.py (path:/tmp/pip-9YYkCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:42:41 INFO - Running setup.py (path:/tmp/pip-BEduRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:42:41 INFO - Running setup.py (path:/tmp/pip-LwUAKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:42:41 INFO - Running setup.py (path:/tmp/pip-eN6Y0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:42:41 INFO - Running setup.py (path:/tmp/pip-fvMs6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:42:41 INFO - Running setup.py (path:/tmp/pip-EQhcJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:42:41 INFO - Running setup.py (path:/tmp/pip-sK8yqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:41 INFO - Running setup.py (path:/tmp/pip-NzodXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:42:42 INFO - Running setup.py (path:/tmp/pip-_1BE4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:42:42 INFO - Running setup.py (path:/tmp/pip-GCjNof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:42:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:42:42 INFO - Running setup.py install for manifestparser 19:42:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:42:42 INFO - Running setup.py install for mozcrash 19:42:42 INFO - Running setup.py install for mozdebug 19:42:42 INFO - Running setup.py install for mozdevice 19:42:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:42:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:42:42 INFO - Running setup.py install for mozfile 19:42:42 INFO - Running setup.py install for mozhttpd 19:42:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:42:42 INFO - Running setup.py install for mozinfo 19:42:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:42:42 INFO - Running setup.py install for mozInstall 19:42:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Running setup.py install for mozleak 19:42:43 INFO - Running setup.py install for mozlog 19:42:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Running setup.py install for moznetwork 19:42:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Running setup.py install for mozprocess 19:42:43 INFO - Running setup.py install for mozprofile 19:42:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Running setup.py install for mozrunner 19:42:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Running setup.py install for mozscreenshot 19:42:43 INFO - Running setup.py install for moztest 19:42:43 INFO - Running setup.py install for mozversion 19:42:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:42:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:42:43 INFO - Cleaning up... 19:42:44 INFO - Return code: 0 19:42:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:44 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:44 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 19:42:44 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 19:42:44 INFO - Using env: {'DISPLAY': ':0', 19:42:44 INFO - 'HOME': '/home/cltbld', 19:42:44 INFO - 'LANG': 'en_US.UTF-8', 19:42:44 INFO - 'LANGUAGE': 'en_US:en', 19:42:44 INFO - 'LOGNAME': 'cltbld', 19:42:44 INFO - 'MAIL': '/var/mail/cltbld', 19:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:44 INFO - 'MOZ_NO_REMOTE': '1', 19:42:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:44 INFO - 'NO_EM_RESTART': '1', 19:42:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:44 INFO - 'PWD': '/builds/slave/test', 19:42:44 INFO - 'SHELL': '/bin/bash', 19:42:44 INFO - 'SHLVL': '1', 19:42:44 INFO - 'TERM': 'linux', 19:42:44 INFO - 'TMOUT': '86400', 19:42:44 INFO - 'USER': 'cltbld', 19:42:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:44 INFO - '_': '/tools/buildbot/bin/python'} 19:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:42:44 INFO - Running setup.py (path:/tmp/pip-fa3T59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:42:44 INFO - Running setup.py (path:/tmp/pip-LdxTEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:42:44 INFO - Running setup.py (path:/tmp/pip-CoiwIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:42:44 INFO - Running setup.py (path:/tmp/pip-63YRUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:42:44 INFO - Running setup.py (path:/tmp/pip-abHzIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:42:44 INFO - Running setup.py (path:/tmp/pip-I58M9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:42:44 INFO - Running setup.py (path:/tmp/pip-QFIsiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:42:44 INFO - Running setup.py (path:/tmp/pip-wOiHax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:42:44 INFO - Running setup.py (path:/tmp/pip-wU_Nyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:42:44 INFO - Running setup.py (path:/tmp/pip-dluOZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:42:44 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)) 19:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:42:44 INFO - Running setup.py (path:/tmp/pip-Q6Hg80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:42:45 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)) 19:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:42:45 INFO - Running setup.py (path:/tmp/pip-B20vjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:42:45 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)) 19:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:42:45 INFO - Running setup.py (path:/tmp/pip-ibMhsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:42:45 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)) 19:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:42:45 INFO - Running setup.py (path:/tmp/pip-l8miHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:42:45 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)) 19:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:45 INFO - Running setup.py (path:/tmp/pip-GhvVRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:45 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)) 19:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:42:45 INFO - Running setup.py (path:/tmp/pip-RJf2Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:42:45 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)) 19:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:42:45 INFO - Running setup.py (path:/tmp/pip-mW70jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:42:45 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)) 19:42:45 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)) 19:42:45 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)) 19:42:45 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)) 19:42:45 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)) 19:42:45 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)) 19:42:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:42:47 INFO - Downloading blessings-1.6.tar.gz 19:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:42:47 INFO - Installing collected packages: blessings 19:42:47 INFO - Running setup.py install for blessings 19:42:47 INFO - Successfully installed blessings 19:42:47 INFO - Cleaning up... 19:42:47 INFO - Return code: 0 19:42:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:42:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:42:47 INFO - Reading from file tmpfile_stdout 19:42:47 INFO - Current package versions: 19:42:47 INFO - argparse == 1.2.1 19:42:47 INFO - blessings == 1.6 19:42:47 INFO - blobuploader == 1.2.4 19:42:47 INFO - docopt == 0.6.1 19:42:47 INFO - manifestparser == 1.1 19:42:47 INFO - mozInstall == 1.12 19:42:47 INFO - mozcrash == 0.17 19:42:47 INFO - mozdebug == 0.1 19:42:47 INFO - mozdevice == 0.48 19:42:47 INFO - mozfile == 1.2 19:42:47 INFO - mozhttpd == 0.7 19:42:47 INFO - mozinfo == 0.9 19:42:47 INFO - mozleak == 0.1 19:42:47 INFO - mozlog == 3.1 19:42:47 INFO - moznetwork == 0.27 19:42:47 INFO - mozprocess == 0.22 19:42:47 INFO - mozprofile == 0.28 19:42:47 INFO - mozrunner == 6.11 19:42:47 INFO - mozscreenshot == 0.1 19:42:47 INFO - mozsystemmonitor == 0.0 19:42:47 INFO - moztest == 0.7 19:42:47 INFO - mozversion == 1.4 19:42:47 INFO - psutil == 3.1.1 19:42:47 INFO - requests == 1.2.3 19:42:47 INFO - wsgiref == 0.1.2 19:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:47 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:47 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 19:42:47 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 19:42:47 INFO - Using env: {'DISPLAY': ':0', 19:42:47 INFO - 'HOME': '/home/cltbld', 19:42:47 INFO - 'LANG': 'en_US.UTF-8', 19:42:47 INFO - 'LANGUAGE': 'en_US:en', 19:42:47 INFO - 'LOGNAME': 'cltbld', 19:42:47 INFO - 'MAIL': '/var/mail/cltbld', 19:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:47 INFO - 'MOZ_NO_REMOTE': '1', 19:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:47 INFO - 'NO_EM_RESTART': '1', 19:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:47 INFO - 'PWD': '/builds/slave/test', 19:42:47 INFO - 'SHELL': '/bin/bash', 19:42:47 INFO - 'SHLVL': '1', 19:42:47 INFO - 'TERM': 'linux', 19:42:47 INFO - 'TMOUT': '86400', 19:42:47 INFO - 'USER': 'cltbld', 19:42:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:47 INFO - '_': '/tools/buildbot/bin/python'} 19:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 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)) 19:42:47 INFO - Cleaning up... 19:42:47 INFO - Return code: 0 19:42:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:42:47 INFO - Using env: {'DISPLAY': ':0', 19:42:47 INFO - 'HOME': '/home/cltbld', 19:42:47 INFO - 'LANG': 'en_US.UTF-8', 19:42:47 INFO - 'LANGUAGE': 'en_US:en', 19:42:47 INFO - 'LOGNAME': 'cltbld', 19:42:47 INFO - 'MAIL': '/var/mail/cltbld', 19:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:47 INFO - 'MOZ_NO_REMOTE': '1', 19:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:47 INFO - 'NO_EM_RESTART': '1', 19:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:47 INFO - 'PWD': '/builds/slave/test', 19:42:47 INFO - 'SHELL': '/bin/bash', 19:42:47 INFO - 'SHLVL': '1', 19:42:47 INFO - 'TERM': 'linux', 19:42:47 INFO - 'TMOUT': '86400', 19:42:47 INFO - 'USER': 'cltbld', 19:42:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:47 INFO - '_': '/tools/buildbot/bin/python'} 19:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:48 INFO - Downloading/unpacking jsonschema 19:42:48 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 19:42:48 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 19:42:48 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 19:42:48 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 19:42:48 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 19:42:48 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 19:42:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:42:50 INFO - Downloading/unpacking functools32 (from jsonschema) 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42:50 INFO - Downloading functools32-3.2.3-2.tar.gz 19:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:42:50 INFO - warning: no files found matching '*.txt' 19:42:50 INFO - no previously-included directories found matching 'build' 19:42:50 INFO - no previously-included directories found matching 'dist' 19:42:50 INFO - no previously-included directories found matching '.git*' 19:42:50 INFO - Installing collected packages: jsonschema, functools32 19:42:50 INFO - Running setup.py install for functools32 19:42:50 INFO - warning: no files found matching '*.txt' 19:42:50 INFO - no previously-included directories found matching 'build' 19:42:50 INFO - no previously-included directories found matching 'dist' 19:42:50 INFO - no previously-included directories found matching '.git*' 19:42:50 INFO - Successfully installed jsonschema functools32 19:42:50 INFO - Cleaning up... 19:42:50 INFO - Return code: 0 19:42:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:50 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 0x7f133204cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14da8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15a55a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', '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 19:42:50 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 19:42:50 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 19:42:50 INFO - Using env: {'DISPLAY': ':0', 19:42:50 INFO - 'HOME': '/home/cltbld', 19:42:50 INFO - 'LANG': 'en_US.UTF-8', 19:42:50 INFO - 'LANGUAGE': 'en_US:en', 19:42:50 INFO - 'LOGNAME': 'cltbld', 19:42:50 INFO - 'MAIL': '/var/mail/cltbld', 19:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:50 INFO - 'MOZ_NO_REMOTE': '1', 19:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:42:50 INFO - 'NO_EM_RESTART': '1', 19:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:50 INFO - 'PWD': '/builds/slave/test', 19:42:50 INFO - 'SHELL': '/bin/bash', 19:42:50 INFO - 'SHLVL': '1', 19:42:50 INFO - 'TERM': 'linux', 19:42:50 INFO - 'TMOUT': '86400', 19:42:50 INFO - 'USER': 'cltbld', 19:42:50 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:50 INFO - '_': '/tools/buildbot/bin/python'} 19:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:50 INFO - Downloading/unpacking flake8 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:42:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:42:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42: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 19:42:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:42:53 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 19:42:53 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 19:42:53 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 19:42:53 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 19:42:53 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 19:42:53 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 19:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:42:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:42:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:42:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:42:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:42:53 INFO - no previously-included directories found matching 'docs/_build' 19:42:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:42:53 INFO - Running setup.py install for pep8 19:42:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:42:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:42:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:42:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:42:53 INFO - no previously-included directories found matching 'docs/_build' 19:42:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:42:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:42:53 INFO - Cleaning up... 19:42:53 INFO - Return code: 0 19:42:53 INFO - Running post-action listener: _resource_record_post_action 19:42:53 INFO - Running post-action listener: _start_resource_monitoring 19:42:53 INFO - Starting resource monitoring. 19:42:53 INFO - ##### 19:42:53 INFO - ##### Running install step. 19:42:53 INFO - ##### 19:42:53 INFO - Running pre-action listener: _resource_record_pre_action 19:42:53 INFO - Running main action method: install 19:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:42:53 INFO - Reading from file tmpfile_stdout 19:42:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:42:53 INFO - Reading from file tmpfile_stdout 19:42:53 INFO - Output received: 19:42:53 INFO - Usage: mozinstall [options] installer 19:42:53 INFO - Options: 19:42:53 INFO - -h, --help show this help message and exit 19:42:53 INFO - -d DEST, --destination=DEST 19:42:53 INFO - Directory to install application into. [default: 19:42:53 INFO - "/builds/slave/test"] 19:42:53 INFO - --app=APP Application being installed. [default: firefox] 19:42:53 INFO - mkdir: /builds/slave/test/build/application 19:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:43:10 INFO - Reading from file tmpfile_stdout 19:43:10 INFO - Output received: 19:43:10 INFO - /builds/slave/test/build/application/firefox/firefox 19:43:10 INFO - Running post-action listener: _resource_record_post_action 19:43:10 INFO - ##### 19:43:10 INFO - ##### Running run-tests step. 19:43:10 INFO - ##### 19:43:10 INFO - Running pre-action listener: _resource_record_pre_action 19:43:10 INFO - Running main action method: run_tests 19:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:43:10 INFO - Python 2.7.3 19:43:10 INFO - Return code: 0 19:43:10 INFO - grabbing minidump binary from tooltool 19:43:10 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')]} 19:43:10 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 0x1634410>, '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 0x1635310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16357a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:43:10 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 19:43:10 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 19:43:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:43:10 INFO - Return code: 0 19:43:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:43:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:43:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:43:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:43:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:43:11 INFO - Return code: 0 19:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 19:43:11 INFO - Using env: {'DISPLAY': ':0', 19:43:11 INFO - 'HOME': '/home/cltbld', 19:43:11 INFO - 'LANG': 'en_US.UTF-8', 19:43:11 INFO - 'LANGUAGE': 'en_US:en', 19:43:11 INFO - 'LOGNAME': 'cltbld', 19:43:11 INFO - 'MAIL': '/var/mail/cltbld', 19:43:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:43:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:11 INFO - 'MOZ_NO_REMOTE': '1', 19:43:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:43:11 INFO - 'NO_EM_RESTART': '1', 19:43:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:11 INFO - 'PWD': '/builds/slave/test', 19:43:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:43:11 INFO - 'SHELL': '/bin/bash', 19:43:11 INFO - 'SHLVL': '1', 19:43:11 INFO - 'TERM': 'linux', 19:43:11 INFO - 'TMOUT': '86400', 19:43:11 INFO - 'USER': 'cltbld', 19:43:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029', 19:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:11 INFO - '_': '/tools/buildbot/bin/python'} 19:43:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 19:43:11 INFO - mozversion application_buildid: 20160419143022 19:43:11 INFO - mozversion application_changeset: 59fe5c482a5535f44775070b7ee56d9d15561b6b 19:43:11 INFO - mozversion application_display_name: Nightly 19:43:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:43:11 INFO - mozversion application_name: Firefox 19:43:11 INFO - mozversion application_remotingname: firefox 19:43:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:43:11 INFO - mozversion application_vendor: Mozilla 19:43:11 INFO - mozversion application_version: 48.0a1 19:43:11 INFO - mozversion platform_buildid: 20160419143022 19:43:11 INFO - mozversion platform_changeset: 59fe5c482a5535f44775070b7ee56d9d15561b6b 19:43:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:43:11 INFO - mozversion platform_version: 48.0a1 19:43:11 INFO - using testdate: 1461120191 19:43:11 INFO - actual date: 1461120191 19:43:11 INFO - starting webserver on 'localhost:42732' 19:43:11 INFO - SUITE-START | Running 2 tests 19:43:11 INFO - TEST-START | dromaeo_css 19:43:11 INFO - operating with platform_type : linux_ 19:43:11 INFO - Initialising browser for dromaeo_css test... 19:43:11 INFO - TEST-INFO | started process 6818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_tDXo5/profile http://localhost:42732/getInfo.html) 19:43:15 INFO - PROCESS | 6818 | 19:43:15 INFO - PROCESS | 6818 | (process:6884): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:43:16 INFO - PROCESS | 6818 | __metrics Screen width/height:1600/1200 19:43:16 INFO - PROCESS | 6818 | colorDepth:24 19:43:16 INFO - PROCESS | 6818 | Browser inner width/height: 1024/697 19:43:16 INFO - PROCESS | 6818 | __metrics 19:43:16 ERROR - PROCESS | 6818 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 19:43:17 INFO - TEST-INFO | 6818: exit 0 19:43:17 INFO - Browser initialized. 19:43:17 INFO - Running cycle 1/1 for dromaeo_css test... 19:43:17 INFO - TEST-INFO | started process 6935 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_tDXo5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:19 INFO - PROCESS | 6935 | 19:43:19 INFO - PROCESS | 6935 | (process:6997): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 19:43:29 INFO - PROCESS | 6935 | RSS: Main: 163692544 19:43:29 INFO - PROCESS | 6935 | 19:44:19 INFO - PROCESS | 6935 | 1461120259048 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] 19:46:27 INFO - PROCESS | 6935 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42732/tests/dromaeo/cssquery-ext.html) 19:46:28 INFO - PROCESS | 6935 | RSS: Main: 168148992 19:46:28 INFO - PROCESS | 6935 | 19:49:30 INFO - PROCESS | 6935 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-ext.html (next: http://localhost:42732/tests/dromaeo/cssquery-jquery.html) 19:49:30 INFO - PROCESS | 6935 | RSS: Main: 165109760 19:49:30 INFO - PROCESS | 6935 | 19:52:32 INFO - PROCESS | 6935 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42732/tests/dromaeo/cssquery-mootools.html) 19:52:33 INFO - PROCESS | 6935 | RSS: Main: 166539264 19:52:33 INFO - PROCESS | 6935 | 19:55:34 INFO - PROCESS | 6935 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42732/tests/dromaeo/cssquery-prototype.html) 19:55:35 INFO - PROCESS | 6935 | RSS: Main: 164376576 19:55:35 INFO - PROCESS | 6935 | 19:58:37 INFO - PROCESS | 6935 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42732/tests/dromaeo/cssquery-yui.html) 19:58:38 INFO - PROCESS | 6935 | RSS: Main: 165609472 19:58:38 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | Cycle 1(1): loaded http://localhost:42732/tests/dromaeo/cssquery-yui.html (next: http://localhost:42732/tests/dromaeo/cssquery-dojo.html) 20:01:40 INFO - PROCESS | 6935 | RSS: Main: 167583744 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | __start_tp_report 20:01:40 INFO - PROCESS | 6935 | _x_x_mozilla_page_load 20:01:40 INFO - PROCESS | 6935 | _x_x_mozilla_page_load_details 20:01:40 INFO - PROCESS | 6935 | |i|pagename|runs| 20:01:40 INFO - PROCESS | 6935 | |0;dojo.html;3201.3117179806345;3218.2115381731464;3237.546743455915;3264.2655402534433;3275.3613045456136;5427.99582077316;5441.347038355398;5460.426655201206;5500.724963751816;5511.834644960648;5383.4616538346145;5441.319835020622;5459.454054594538;5586.050371436855;5587.580931430139;4992.475790042057;5020.899582008357;5066.113430149728;5081.695098294095;5087.633038822747;4962.206047032476;5121.308623335839;5134.820281290155;5151.5878729701535;5152.562032227265;4871.098846713352;4934.728589927553;4956.677815941952;5054.9241761373605;5061.240813877929;4994.126027945095;5004.074246264417;5006.299118123466;5027.698338099725;5029.19532874742;4960.355153830015;4967.180415231483;4978.477259887732;4996.525330093636;5006.4492905780335;5378;5410.810621628263;5451.427600101972;5469.617126801126;5484.314460692413;5815.127730840365;5840.7079646017955;5843.941560584382;5866.677332746697;5898.14476900847;5921.111833225008;5934.7922822701;5937.703114844284;5940.584159108864;5947.37552556984;5351.117065684158;5445.782168713286;5459.181122831567;5512.145617429264;5523.7790488380815;5965.791197308074;6030.065339872327;6030.939690603038;6034.849128771816;6037.1246169305205;5767.596268261182;5814.447627475383;5818.389069147678;5823.097419899922;5825.7378417971295;5711.200431939532;5791.797287095016;5830.067189249785;5866.941330586725;5892.234009578728;5702.0591602385975;5799.2460980073165;5801.970990145022;5813.82558523245;5819.854503637358;5741.569382296345;5778.422157784188;5795.420457954171;5842.737076831553;5859;4381;4384.561543845653;4424.33634954753;4428.6678499112695;4451.6661250405705;3946.5461471931094;3976.423418604344;3981.980090099589;3995.6603688686787;4005.1589166275407;5562.972185139049;5573.721313934287;5573.972130139324;5574.693391863405;5602.915956260659;5730.455606717355;5786.88426231473;5873.030949893306;5885.382034886361;5899.144624029492;5611.494965453129;5630.18362337467;5647.068233741386;5649.293838270216;5705.515031222392;5056.6713163644245;5078.238264260391;5085.2372144177925;5085.771140298695;5134.973005398935;5878.647281163144;5999.1901093351835;6037.637741735422;6042.667653279024;6087.147799308101;5854.2096816930025;5893.351731309467;5897.7935772247765;5899.203607513103;5946.881062378815;6003.099535069775;6016.037434010537;6023.5783495156675;6036.6679832609625;6054.606450580698;5595.524380427709;5761.625494342854;5766.538676905753;5776.884462310646;5841.415858414124;5948.196993406008;5966.880662386641;5967.76128954837;5975.850603734942;5984.910226346521;5713.857153571194;5748.6838223898085;5758.107493338539;5798.652080875161;5815.069588865761;5591.692456914909;5624.128260119688;5674.659520428788;5723.742431590672;5776.7400466979925;5546.502444339925;5571.470710282517;5600.551955843604;5603.579731520071;5662.886742265049;5721.084626459747;5786.710664466676;5797.246357973437;5818.0981947798155;5825.621334613236;5596.776128954796;5607.355154157324;5688.715564221855;5691.943080569141;5722.542196624343 20:01:40 INFO - PROCESS | 6935 | |1;ext.html;590.6574186971557;627.5701144715869;644.3620815392762;649.5420728386488;652.2564276724535;30473.69526304739;37461.81269093654;37951.62048379515;38316.61683383166;38419.61580384195;40125.398119028236;40853;40996;41042.179156416925;41164.58835411645;8569.228769410736;8769.824603507926;8772.166644168825;8818.823623527525;8829.205371516562;8514.403991720583;8659.134086591353;8670.566471676391;8682.348823838205;8879.112088791133;8831.11688831115;8945.73162805117;8952.149545793172;8999.460032398078;9003.549822508881;8782.868256976119;8851.867221991675;8890.4665720057;8917.375783695144;8945.15021072997;8886.777830554223;8929.241014513775;8975.237104846095;9000.414973026733;9022.278217742565;41323.58676413228;41327.380089298684;41685;41764.582354176375;41838.1632367351;3520.700740437066;3577.284543091392;3607.098225443639;3662.8351724172207;3689.7232707546773;28540.286492837637;28992.388311084746;29017.419651607062;31027;31291.53062704061;4295.312749960022;4346.413234213373;4350.825966961318;4379.562043795627;4501.819927202908;274591;274742;277024.99999999796;277333;278152;35730.821345893106;36678.8166059168;54002;54129;54162.72918635382;34922.650773492445;35023.4746478803;35107;35149.64850351464;35276.29447411037;14622.26888655563;14747.705045899022;14766.114033158045;14832.332545035284;14862.92568537172;12308.753824923451;12394.690132746753;12399.442025108712;12399.814002789966;12407.751844963232;8545.230929216275;8567.828643427096;8592.398532102692;8662.696805611773;8670.089640587774;3312;3369.786876724377;3375.4599264118115;3380.7295416366633;3399.6260411354733;1096.9341839489657;1147.4320211495196;1179.6696924861053;1206.1556910162922;1261.9053570982212;30859.691403085682;34809.82595087009;36109.45835812465;36242.456363154575;36476.45285320669;1123.6179698902413;1145.8968692817687;1174.4010554617207;1176.7705297467082;1202.6271855724754;16513.422030228885;16688.332466701195;16755.581110472092;16875.831241687672;16995.660086798194;475354;482516;482818;483833;484242;57367;58426.123608145914;58498;58534.12198817021;58549.70725146347;1375.2711063136553;1390.450771945076;1395.7696979998389;1398.6573289543924;1402.0396028720359;31479.370412592078;31574.368512630077;32197;32548.83725581357;32563.674363256065;51810.74094629503;52344.21483677824;52647.21029184642;52681.47318526919;52967.47032529626;454391;458589;459455;460371;460638;28045.579316309864;28283.858580706965;28470.57294140548;28500;28520.14439566816;48428.7578562119;48705;49190.50809492003;49970.25044624406;50432.74783626058;40228.396574052;40536.79731601323;41259.1748165041;41268.587314126475;42293;40714.410611246436;41260.79369603133;41443.85026737939;41793.79103104465;41880.79059604683;41894.16211675688;42541;43076.35385469158;43724.78137609291;43931.12137757163;31646.683533164374;33749;34585.48121778125;35614.287714246086;35948.82025589855;27375.86312068427;27791.917437693908;28054.36637427786;28077.438451230453;28259.717402825707 20:01:40 INFO - PROCESS | 6935 | |2;jquery.html;387.3898609689738;397.7017237072194;402.37229921322756;404.5913627236492;404.7065877239001;13696.794548081762;15334.693306133871;17807.910960445195;18375.356862509816;18465.630687386245;15726;15920.601984950354;18217.908910455462;18832.905835470803;19307.806921930776;5580.693061881595;5749.942500575004;5768.567357448208;5801.042827933407;5816.999999999979;5562.805301814437;5652.802151924683;5748.712564371785;5767.509761670263;5788.855278618026;5387.811426600069;5710.685912274823;5713.057345538002;5732.971335143318;5739.196512488255;5558.499735023867;5604.943950560483;5615.185798059259;5617.297837770278;5646.20953066571;5318.016167009116;5618.550515958714;5646.068398714207;5647.689377084259;5650.773969041234;12732.745345093046;12909.741805163938;12957.416916238792;12986.675333116653;13653;2272.9545409091893;2284.846152692896;2426.5146970605774;2542.9491410171695;2885.040183069998;9805.950970245103;10014.949925250326;10335.741606459824;12506.18709783861;13665;1899.629572233415;1931.3529967460918;1945.9124339404761;1981.5937732764892;1995.281698588507;78291.6085419575;78922.60538697327;80616.19383806146;80706;81237.59381203115;10826.40454774995;10907.127429805596;10925.781484370267;10934.945325273482;11127.610533631285;15204.847951520343;15254.694906101815;15255.313510891814;15325.386984520717;15346.769798453031;7039.92960070403;7114;7195.96402017997;7245.529040612343;7291.380232680282;6441.25925518562;6510.056041873901;6520.380563846427;6596.769113081019;6621.106150669694;4618.861434156981;4682.578567928903;4756.405449318835;4797.7601119943865;4832.540908613676;1944.8055194480721;1979.6244506592147;1991.8904460254535;1995.6906679464705;2018.6770116781245;1002.368507840056;1067.0023528001343;1088.7278180454887;1090.1278976818514;1093.4532733633184;18964.24143034263;19273.903630482037;19392;19482;19620.3132890351;1010.9789112995927;1015.7359086637528;1074.3285446595878;1086.684861390188;1101.2236373356764;10218.284720069672;10818.513166907507;10820.458977051274;10868.945655271673;10983.61557345505;445723;446450;505925;506119;508275;76625.6168719164;83357.58321208355;88997;89498.10501895029;90635;1055.8363453664695;1057.539970112988;1058.1270451877233;1060.7825395793843;1071.5713714514102;16708.08105554206;16935.391137841885;17032.318707251572;17351.7397239039;17546.38587649426;34871;36273;37092;38661.420078699404;38735.6126438732;54046.459535404145;54309;55156.44843551513;55179;55863.44136558745;8259.174082591693;8384.832303353776;8486.321094312563;8520.105388934073;8784.91215087841;10812.945935270272;11852.407379630811;13057.673558161123;13234.272115033766;13235.801462978256;10713.214564213205;10763.461826908466;11167.329960202089;11551.884481155417;11773.352465614473;10917.727056823644;10927.289726167774;11061.612843550438;11144.164187685794;11508.309501429942;11376.601818936297;11511.136664750009;11620.825687614524;11627;11647.417629118341;7582.128055273714;7812.804679883048;7924.326432253323;8103.635336409758;8677.913220867711;11437.370944598128;11578.305301681927;11620.418979051183;11648.708782280512;11774.3524106175 20:01:40 INFO - PROCESS | 6935 | |3;mootools.html;1524.1464779723356;1530.4184409924228;1713.4003098915382;1776.3960253513803;1851.5559461510802;7348.530293941207;8011.799705007378;8029.35765138789;8191.590420478975;8261.628226729797;8051.275385215329;8095.109537950835;8095.838083238332;8160.836783264331;8163.91836081639;2289.221664634024;2303.2284184798027;2304.0207911637485;2309.8960546775434;2318.1770471482632;2251.909923603054;2255.6954811100454;2270.6821045053625;2282.7374851891996;2283.817294616435;2299.298713892262;2314.2247347138727;2327.860328380294;2335.369450248432;2346.941326466835;2202.768709285534;2213.7564867864603;2215.291106845802;2216.656418255173;2223.0552015393473;2256.187772401934;2264.479169790941;2272.7954484096513;2273.0339605667527;2278.908843646252;8181.059178194524;8196.67213311467;8270.875936860952;8284.83430331396;8325.292350150185;5012.774425150877;5106.897862042775;5145;5152.072626927152;5187.948120518822;3171.14596862823;3315.1877789941377;3362.4788157835574;3389.2035371687634;3399.184195792992;1035.5184839049878;1048.3028785857396;1062.4634559547455;1068.1294744783054;1069.3744159666605;11302.321860688386;11307.095432365391;11310.37792921389;11353.772924541463;11369.48837302315;4403.119376124788;4511.751853648016;4584.97707511467;4629.560191781776;4672.462666793294;9646.517674116407;9658.613655453844;9661.420314781135;9690.46702431373;9701.660441884642;5030.798768049237;5053.140966035783;5064.873378165576;5071.746412679351;5093.643444958817;4265.210935976854;4665.206914824488;4678.087772884255;4689.155951928686;4819.036192761461;3767.2653832502947;3814.923701525954;3838.596947320491;3859.7684138951754;3880.1075752576503;1271.2309053022789;1271.3452571925466;1276.44474653526;1278.6995056161795;1284.319310765296;951.857221416793;979.8971108033696;990.7622170678985;999.9500024998721;1004.0662184168793;5558.944410555842;5634.474874496761;5725.914111288334;5762.625429347079;5843.766249349978;418.1741061403703;420.7223232666487;422.6618705035959;425.97552885310876;429.289525834744;3961.7028722845903;3975.423563583322;3995.220931918306;4015.4177644242004;4060.898477538085;9854;10294;10294.536745846455;10296.536655850505;10307.690769276935;10123.848142277871;10136.239782016379;10145.644902428527;10177.33847299938;10189.133923616428;7709.884351734729;7843.764687059397;7852.960735196288;7869.527828330319;7898.368130549542;5473.17902314656;5577.330720313588;5621.751299480077;5677.914831277617;5757.309122905111;9067.773305667148;9251.814963700823;9273.53632318395;9279.536023198678;9367.765805854908;9469.242460602998;9485.66800161991;9686.806263874541;9694.903050969682;9732.221422286058;6677.131972843694;7059.399951004222;7186.46101542376;7256.2018177999325;7271.41828653717;7769.766906992573;7810.609469526615;7814.53112813233;7817.374610031297;7884.960575197088;7045.436365090883;7209.279072092749;7260.96369518149;7264.34620884123;7274.854502910018;7068.293170683096;7183.497155199086;7188.460865435218;7220.638968051681;7223.422126229784;6593.076969224217;6796.388325050769;6854.7600833972565;6861.622610756456;6870.828229294108;4785.258284965836;4854.927176092291;4866.756662166948;4877.975610121926;4936.284238785428;4915.827946021872;4930.161872481758;4953.380827396575;4984.576311013459;5021.924671130009 20:01:40 INFO - PROCESS | 6935 | |4;prototype.html;333.6796675191816;336.2400973799214;340.6236109099445;342.51192051326854;344.44716230450126;5945.940540594593;6030.608010479315;6037.516998640109;6038.456538911502;6068.453839154476;5925.762969481227;5930.347661757203;5960.463558279765;5964.970175149129;5976.2230909981645;4114.670826333886;4243.490781106264;4498.572635599629;4502.639788816887;4530.161920044786;4524.9095018099615;4533.705309154894;4561.7262964222255;4562.315652652095;4590.839320623779;4507.323901414781;4548.295014272793;4552.408186935694;4553.134904368176;4561.270196768518;4474.351219073233;4522.479914809806;4549.363089167519;4549.840755573572;4568.406107206075;3995.220931918277;4009.639132478091;4012.0371110933165;4012.217617564576;4016.297147999118;5668.149777533362;5672.262605861211;5715.170835540198;5717.199592057115;5776.8844623107725;5164.14791559396;5236.664650514094;5261.921071183935;5279.815206467755;5286.207068939651;6135.294441139237;6161.229846269216;6207.410296021871;6212.751489940397;6218.440340369389;4392.428984232061;4414.381986521889;4433.512313645497;4436.911261774746;4450.866474005785;6273.772810652198;6372.107904893319;6498.317676643932;6503.447206987412;6548.869022619569;4416.867493975186;4424.7123936944;4432.335149727567;4438.312061630452;4444.333349997526;4470.597646211857;4490.236659767847;4519.638428925678;4521.276595744665;4522.163399771053;4956.702597844141;5242.842714718565;5249.973750131301;5265.52610265078;5268.894622107613;6275;6297.244330680348;6313.305536390993;6327.968360158262;6379.106925030499;1544.2201688147413;1560.0795530636979;1568.576484349242;1571.591386239563;1574.039835700222;999.4752754803786;1033.8087453821067;1037.387941114746;1039.1946241662772;1054.7574057966558;5984.251968503937;5992.460678538865;5992.760289588455;6008.978473659488;6049.18336024631;6368.267649220306;6372.107904893319;6383.808485745435;6404.647744374104;6423.743050277936;5822.388649191858;6082.695865206722;6085.482733967662;6089.725962331706;6097.298810636745;3431.725461963037;3468.9653103469145;3472.548568686105;3477.1828620274214;3477.2523907360037;6430.143096263445;6522.739090436425;6574.309697481791;6623.668816559153;6657.633830139292;6471.482281417475;6491.156149700603;6495.7401703932255;6502.479801615859;6537.869242615121;6317.6209427434505;6569.83575410609;6580.670966451658;6589.637569933604;6765.154355705438;6523.217213934358;6546.24718157418;6549.198970283211;6554.934450655433;6573.835654108686;6319.526035547445;6506.186726659168;6519.5436319457185;6523.021546768023;6535.673216339259;6664.866702665822;6732.360425759741;6749.42629876466;6749.628770417674;6762.932370676231;4356.564343565745;4377.868663940087;4398.670099742596;4401.36180253855;4416.094700586308;6262.311145774052;6499.512536559682;6522.28254891971;6546.116274303098;6597.472202223907;6335.429811317003;6339.714712838026;6372.55392122547;6375.776847810304;6385.393387628168;5962.642241465526;6308.549033722178;6324.2410910691015;6356.237251529846;6365.299817020032;6199.56603037783;6225.533085018732;6242.906356404748;6256.906146407899;6263.530235232467;6116.877662446637;6371.649559274284;6391.201099862517;6442.420182183626;6461.2892581816905;6197.411245931629;6204.525465739201;6211.937880621136;6244.687765611792;6250.093736408105 20:01:40 INFO - PROCESS | 6935 | |5;yui.html;712.1881055596617;729.7299999000368;806.3508875355338;829.2909562324209;877.9034306226314;12747.872521274785;12865.228086314828;12886.291253981039;12998.41507132179;13021.479140834366;13477.123986940842;13499.325033748299;13537.255450950193;13552.457901683922;13568.321583920813;683.0812557110678;789.4749991255808;821.6590115102225;822.8313195794877;824.0729179672868;818.9099199088125;819.7950512371907;819.889314942484;820.7086484298078;826.8387664405443;852.0499642898186;859.1108203009886;862.3101518784947;863.2101627011277;866.6013633728493;851.3061854588491;851.6763629820659;858.274757829633;859.7721603775004;867.6616119713317;620.1008537620469;623.3984205241918;626.7211091064478;627.4353082225988;627.7896904536985;12883.098183127186;12996.935015324863;13059.542915997894;13062.673433164247;13134.211947283098;13923.094998825145;13969.58091257264;14022.859771402258;14090.436382544685;14092.802111820405;11399.430028498626;11436.829679929178;11512.424378781112;11602.187846850724;11816.409179541075;3564;3565.073080998933;3632.54593175853;3658.5609726832686;3725.9068523286865;54655.18017229745;55059.44940550583;55107;55534.16698749522;56789.71605141948;10737.570497180026;10775.568977240979;11010.614628488125;11040.558377664964;11074.501647425885;20107.19571217164;20217.696734548994;20337.694934575993;20416.0812763426;21051.68422473664;8262.917370826215;8288.668453261802;8297.95851020753;8340.41617086798;8345.41582089248;4365.476142862877;4518.118966801442;4553.5218802025975;4661.836835710734;4749.928751068736;3212.486002239677;3305.1241421023446;3308.4706446968853;3310.66893310667;3315.8839440619945;556.4602335734331;557.6737608498993;561.9915701264484;621.3879328861068;661.9205695316593;728.9575906453716;784.8194915169543;798.5887268056955;808.2846680687634;813.1543195077054;9074;9414.529273536296;9477.526123693926;9481.2271702029;9588.856167157499;735.4116706634671;775.4068137874418;779.0729032451478;795.5783434779576;822.9341652667772;4484.977575112103;4622.907541849144;4785.3300537924715;4812.735299558488;4821.95178048215;61206.693966529885;61583.38416615866;61637.38362616406;62281.37718622846;62362;55574.444255556926;56748.432515674314;57160;57590;58209.70895145497;50725.23912141321;50811.23783143256;51173.488265116874;52195;53806.19290710642;8733.606987685442;8804.823903522021;8872.600732966903;9008.86486702713;9108.134727200906;33380.83309583534;33664.49503257404;34228.48657270093;34366.48450273198;34394.484082739276;42433.57566424296;43955.78022109869;45938;47131;47707.28439073486;11701.2979221247;11850.703732406759;11883.287002779862;12039.425157051957;12107.515699371927;12871.806922895978;13043.478260869459;13201.669958251121;13450.798238026633;13498.86501134976;12593.622191334274;12689.746205076031;12841;12932.612021639367;13344.933275333562;12475.563355282522;12631.242125472501;12819.615411537668;12840.678983025498;12903.41934612926;12797.936010319889;12818.807717884052;12854.293013884326;12909.35453227316;13341.066125371519;9705.805883882142;9875.456849873326;10013.24900632441;10087.646932357333;10196.898031019891;10911.454427278446;10943.616973405893;10991.120710342993;11024.779504410028;11135.88864111381 20:01:40 INFO - PROCESS | 6935 | __end_tp_report 20:01:40 INFO - PROCESS | 6935 | __start_cc_report 20:01:40 INFO - PROCESS | 6935 | _x_x_mozilla_cycle_collect,352 20:01:40 INFO - PROCESS | 6935 | __end_cc_report 20:01:40 INFO - PROCESS | 6935 | __startTimestamp1461121300914__endTimestamp 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | ------- Summary: start ------- 20:01:40 INFO - PROCESS | 6935 | Number of tests: 6 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | [#0] dojo.html Cycles:165 Average:5452.67 Median:5649.29 stddev:609.96 (10.8%) stddev-sans-first:585.71 20:01:40 INFO - PROCESS | 6935 | Values: 3201.3 3218.2 3237.5 3264.3 3275.4 5428.0 5441.3 5460.4 5500.7 5511.8 5383.5 5441.3 5459.5 5586.1 5587.6 4992.5 5020.9 5066.1 5081.7 5087.6 4962.2 5121.3 5134.8 5151.6 5152.6 4871.1 4934.7 4956.7 5054.9 5061.2 4994.1 5004.1 5006.3 5027.7 5029.2 4960.4 4967.2 4978.5 4996.5 5006.4 5378.0 5410.8 5451.4 5469.6 5484.3 5815.1 5840.7 5843.9 5866.7 5898.1 5921.1 5934.8 5937.7 5940.6 5947.4 5351.1 5445.8 5459.2 5512.1 5523.8 5965.8 6030.1 6030.9 6034.8 6037.1 5767.6 5814.4 5818.4 5823.1 5825.7 5711.2 5791.8 5830.1 5866.9 5892.2 5702.1 5799.2 5802.0 5813.8 5819.9 5741.6 5778.4 5795.4 5842.7 5859.0 4381.0 4384.6 4424.3 4428.7 4451.7 3946.5 3976.4 3982.0 3995.7 4005.2 5563.0 5573.7 5574.0 5574.7 5602.9 5730.5 5786.9 5873.0 5885.4 5899.1 5611.5 5630.2 5647.1 5649.3 5705.5 5056.7 5078.2 5085.2 5085.8 5135.0 5878.6 5999.2 6037.6 6042.7 6087.1 5854.2 5893.4 5897.8 5899.2 5946.9 6003.1 6016.0 6023.6 6036.7 6054.6 5595.5 5761.6 5766.5 5776.9 5841.4 5948.2 5966.9 5967.8 5975.9 5984.9 5713.9 5748.7 5758.1 5798.7 5815.1 5591.7 5624.1 5674.7 5723.7 5776.7 5546.5 5571.5 5600.6 5603.6 5662.9 5721.1 5786.7 5797.2 5818.1 5825.6 5596.8 5607.4 5688.7 5691.9 5722.5 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | [#1] ext.html Cycles:180 Average:55646.38 Median:40783.71 stddev:110429.77 (270.8%) stddev-sans-first:110662.18 20:01:40 INFO - PROCESS | 6935 | Values: 590.7 627.6 644.4 649.5 652.3 30473.7 37461.8 37951.6 38316.6 38419.6 40125.4 40853.0 40996.0 41042.2 41164.6 8569.2 8769.8 8772.2 8818.8 8829.2 8514.4 8659.1 8670.6 8682.3 8879.1 8831.1 8945.7 8952.1 8999.5 9003.5 8782.9 8851.9 8890.5 8917.4 8945.2 8886.8 8929.2 8975.2 9000.4 9022.3 41323.6 41327.4 41685.0 41764.6 41838.2 3520.7 3577.3 3607.1 3662.8 3689.7 28540.3 28992.4 29017.4 31027.0 31291.5 4295.3 4346.4 4350.8 4379.6 4501.8 274591.0 274742.0 277025.0 277333.0 278152.0 35730.8 36678.8 54002.0 54129.0 54162.7 34922.7 35023.5 35107.0 35149.6 35276.3 14622.3 14747.7 14766.1 14832.3 14862.9 12308.8 12394.7 12399.4 12399.8 12407.8 8545.2 8567.8 8592.4 8662.7 8670.1 3312.0 3369.8 3375.5 3380.7 3399.6 1096.9 1147.4 1179.7 1206.2 1261.9 30859.7 34809.8 36109.5 36242.5 36476.5 1123.6 1145.9 1174.4 1176.8 1202.6 16513.4 16688.3 16755.6 16875.8 16995.7 475354.0 482516.0 482818.0 483833.0 484242.0 57367.0 58426.1 58498.0 58534.1 58549.7 1375.3 1390.5 1395.8 1398.7 1402.0 31479.4 31574.4 32197.0 32548.8 32563.7 51810.7 52344.2 52647.2 52681.5 52967.5 454391.0 458589.0 459455.0 460371.0 460638.0 28045.6 28283.9 28470.6 28500.0 28520.1 48428.8 48705.0 49190.5 49970.3 50432.7 40228.4 40536.8 41259.2 41268.6 42293.0 40714.4 41260.8 41443.9 41793.8 41880.8 41894.2 42541.0 43076.4 43724.8 43931.1 31646.7 33749.0 34585.5 35614.3 35948.8 27375.9 27791.9 28054.4 28077.4 28259.7 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | [#2] jquery.html Cycles:180 Average:27876.57 Median:1993.59 stddev:79634.67 (3994.5%) stddev-sans-first:79831.31 20:01:40 INFO - PROCESS | 6935 | Values: 387.4 397.7 402.4 404.6 404.7 13696.8 15334.7 17807.9 18375.4 18465.6 15726.0 15920.6 18217.9 18832.9 19307.8 5580.7 5749.9 5768.6 5801.0 5817.0 5562.8 5652.8 5748.7 5767.5 5788.9 5387.8 5710.7 5713.1 5733.0 5739.2 5558.5 5604.9 5615.2 5617.3 5646.2 5318.0 5618.6 5646.1 5647.7 5650.8 12732.7 12909.7 12957.4 12986.7 13653.0 2273.0 2284.8 2426.5 2542.9 2885.0 9806.0 10014.9 10335.7 12506.2 13665.0 1899.6 1931.4 1945.9 1981.6 1995.3 78291.6 78922.6 80616.2 80706.0 81237.6 10826.4 10907.1 10925.8 10934.9 11127.6 15204.8 15254.7 15255.3 15325.4 15346.8 7039.9 7114.0 7196.0 7245.5 7291.4 6441.3 6510.1 6520.4 6596.8 6621.1 4618.9 4682.6 4756.4 4797.8 4832.5 1944.8 1979.6 1991.9 1995.7 2018.7 1002.4 1067.0 1088.7 1090.1 1093.5 18964.2 19273.9 19392.0 19482.0 19620.3 1011.0 1015.7 1074.3 1086.7 1101.2 10218.3 10818.5 10820.5 10868.9 10983.6 445723.0 446450.0 505925.0 506119.0 508275.0 76625.6 83357.6 88997.0 89498.1 90635.0 1055.8 1057.5 1058.1 1060.8 1071.6 16708.1 16935.4 17032.3 17351.7 17546.4 34871.0 36273.0 37092.0 38661.4 38735.6 54046.5 54309.0 55156.4 55179.0 55863.4 8259.2 8384.8 8486.3 8520.1 8784.9 10812.9 11852.4 13057.7 13234.3 13235.8 10713.2 10763.5 11167.3 11551.9 11773.4 10917.7 10927.3 11061.6 11144.2 11508.3 11376.6 11511.1 11620.8 11627.0 11647.4 7582.1 7812.8 7924.3 8103.6 8677.9 11437.4 11578.3 11620.4 11648.7 11774.4 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | [#3] mootools.html Cycles:180 Average:5471.42 Median:4933.22 stddev:3038.66 (61.6%) stddev-sans-first:3032.70 20:01:40 INFO - PROCESS | 6935 | Values: 1524.1 1530.4 1713.4 1776.4 1851.6 7348.5 8011.8 8029.4 8191.6 8261.6 8051.3 8095.1 8095.8 8160.8 8163.9 2289.2 2303.2 2304.0 2309.9 2318.2 2251.9 2255.7 2270.7 2282.7 2283.8 2299.3 2314.2 2327.9 2335.4 2346.9 2202.8 2213.8 2215.3 2216.7 2223.1 2256.2 2264.5 2272.8 2273.0 2278.9 8181.1 8196.7 8270.9 8284.8 8325.3 5012.8 5106.9 5145.0 5152.1 5187.9 3171.1 3315.2 3362.5 3389.2 3399.2 1035.5 1048.3 1062.5 1068.1 1069.4 11302.3 11307.1 11310.4 11353.8 11369.5 4403.1 4511.8 4585.0 4629.6 4672.5 9646.5 9658.6 9661.4 9690.5 9701.7 5030.8 5053.1 5064.9 5071.7 5093.6 4265.2 4665.2 4678.1 4689.2 4819.0 3767.3 3814.9 3838.6 3859.8 3880.1 1271.2 1271.3 1276.4 1278.7 1284.3 951.9 979.9 990.8 1000.0 1004.1 5558.9 5634.5 5725.9 5762.6 5843.8 418.2 420.7 422.7 426.0 429.3 3961.7 3975.4 3995.2 4015.4 4060.9 9854.0 10294.0 10294.5 10296.5 10307.7 10123.8 10136.2 10145.6 10177.3 10189.1 7709.9 7843.8 7853.0 7869.5 7898.4 5473.2 5577.3 5621.8 5677.9 5757.3 9067.8 9251.8 9273.5 9279.5 9367.8 9469.2 9485.7 9686.8 9694.9 9732.2 6677.1 7059.4 7186.5 7256.2 7271.4 7769.8 7810.6 7814.5 7817.4 7885.0 7045.4 7209.3 7261.0 7264.3 7274.9 7068.3 7183.5 7188.5 7220.6 7223.4 6593.1 6796.4 6854.8 6861.6 6870.8 4785.3 4854.9 4866.8 4878.0 4936.3 4915.8 4930.2 4953.4 4984.6 5021.9 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | [#4] prototype.html Cycles:180 Average:5249.78 Median:6019.79 stddev:1584.22 (26.3%) stddev-sans-first:1545.10 20:01:40 INFO - PROCESS | 6935 | Values: 333.7 336.2 340.6 342.5 344.4 5945.9 6030.6 6037.5 6038.5 6068.5 5925.8 5930.3 5960.5 5965.0 5976.2 4114.7 4243.5 4498.6 4502.6 4530.2 4524.9 4533.7 4561.7 4562.3 4590.8 4507.3 4548.3 4552.4 4553.1 4561.3 4474.4 4522.5 4549.4 4549.8 4568.4 3995.2 4009.6 4012.0 4012.2 4016.3 5668.1 5672.3 5715.2 5717.2 5776.9 5164.1 5236.7 5261.9 5279.8 5286.2 6135.3 6161.2 6207.4 6212.8 6218.4 4392.4 4414.4 4433.5 4436.9 4450.9 6273.8 6372.1 6498.3 6503.4 6548.9 4416.9 4424.7 4432.3 4438.3 4444.3 4470.6 4490.2 4519.6 4521.3 4522.2 4956.7 5242.8 5250.0 5265.5 5268.9 6275.0 6297.2 6313.3 6328.0 6379.1 1544.2 1560.1 1568.6 1571.6 1574.0 999.5 1033.8 1037.4 1039.2 1054.8 5984.3 5992.5 5992.8 6009.0 6049.2 6368.3 6372.1 6383.8 6404.6 6423.7 5822.4 6082.7 6085.5 6089.7 6097.3 3431.7 3469.0 3472.5 3477.2 3477.3 6430.1 6522.7 6574.3 6623.7 6657.6 6471.5 6491.2 6495.7 6502.5 6537.9 6317.6 6569.8 6580.7 6589.6 6765.2 6523.2 6546.2 6549.2 6554.9 6573.8 6319.5 6506.2 6519.5 6523.0 6535.7 6664.9 6732.4 6749.4 6749.6 6762.9 4356.6 4377.9 4398.7 4401.4 4416.1 6262.3 6499.5 6522.3 6546.1 6597.5 6335.4 6339.7 6372.6 6375.8 6385.4 5962.6 6308.5 6324.2 6356.2 6365.3 6199.6 6225.5 6242.9 6256.9 6263.5 6116.9 6371.6 6391.2 6442.4 6461.3 6197.4 6204.5 6211.9 6244.7 6250.1 20:01:40 INFO - PROCESS | 6935 | 20:01:40 INFO - PROCESS | 6935 | [#5] yui.html Cycles:180 Average:14895.90 Median:4642.37 stddev:17364.03 (374.0%) stddev-sans-first:17380.07 20:01:40 INFO - PROCESS | 6935 | Values: 712.2 729.7 806.4 829.3 877.9 12747.9 12865.2 12886.3 12998.4 13021.5 13477.1 13499.3 13537.3 13552.5 13568.3 683.1 789.5 821.7 822.8 824.1 818.9 819.8 819.9 820.7 826.8 852.0 859.1 862.3 863.2 866.6 851.3 851.7 858.3 859.8 867.7 620.1 623.4 626.7 627.4 627.8 12883.1 12996.9 13059.5 13062.7 13134.2 13923.1 13969.6 14022.9 14090.4 14092.8 11399.4 11436.8 11512.4 11602.2 11816.4 3564.0 3565.1 3632.5 3658.6 3725.9 54655.2 55059.4 55107.0 55534.2 56789.7 10737.6 10775.6 11010.6 11040.6 11074.5 20107.2 20217.7 20337.7 20416.1 21051.7 8262.9 8288.7 8298.0 8340.4 8345.4 4365.5 4518.1 4553.5 4661.8 4749.9 3212.5 3305.1 3308.5 3310.7 3315.9 556.5 557.7 562.0 621.4 661.9 729.0 784.8 798.6 808.3 813.2 9074.0 9414.5 9477.5 9481.2 9588.9 735.4 775.4 779.1 795.6 822.9 4485.0 4622.9 4785.3 4812.7 4822.0 61206.7 61583.4 61637.4 62281.4 62362.0 55574.4 56748.4 57160.0 57590.0 58209.7 50725.2 50811.2 51173.5 52195.0 53806.2 8733.6 8804.8 8872.6 9008.9 9108.1 33380.8 33664.5 34228.5 34366.5 34394.5 42433.6 43955.8 45938.0 47131.0 47707.3 11701.3 11850.7 11883.3 12039.4 12107.5 12871.8 13043.5 13201.7 13450.8 13498.9 12593.6 12689.7 12841.0 12932.6 13344.9 12475.6 12631.2 12819.6 12840.7 12903.4 12797.9 12818.8 12854.3 12909.4 13341.1 9705.8 9875.5 10013.2 10087.6 10196.9 10911.5 10943.6 10991.1 11024.8 11135.9 20:01:40 INFO - PROCESS | 6935 | -------- Summary: end -------- 20:01:40 INFO - PROCESS | 6935 | 20:01:41 INFO - TEST-INFO | 6935: exit 0 20:01:41 INFO - TEST-OK | dromaeo_css | took 1110005ms 20:01:41 INFO - TEST-START | kraken 20:01:41 INFO - operating with platform_type : linux_ 20:01:41 INFO - Initialising browser for kraken test... 20:01:41 INFO - TEST-INFO | started process 7164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJ15WB/profile http://localhost:42732/getInfo.html) 20:01:45 INFO - PROCESS | 7164 | 20:01:45 INFO - PROCESS | 7164 | (process:7232): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:01:46 INFO - PROCESS | 7164 | __metrics Screen width/height:1600/1200 20:01:46 INFO - PROCESS | 7164 | colorDepth:24 20:01:46 INFO - PROCESS | 7164 | Browser inner width/height: 1024/697 20:01:46 INFO - PROCESS | 7164 | __metrics 20:01:46 ERROR - PROCESS | 7164 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 20:01:47 INFO - TEST-INFO | 7164: exit 0 20:01:47 INFO - Browser initialized. 20:01:47 INFO - Running cycle 1/1 for kraken test... 20:01:47 INFO - TEST-INFO | started process 7283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEJ15WB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:01:49 INFO - PROCESS | 7283 | 20:01:49 INFO - PROCESS | 7283 | (process:7342): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:01:59 INFO - PROCESS | 7283 | RSS: Main: 163577856 20:01:59 INFO - PROCESS | 7283 | 20:02:01 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-beat-detection) 20:02:02 INFO - PROCESS | 7283 | RSS: Main: 167907328 20:02:02 INFO - PROCESS | 7283 | 20:02:05 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-dft) 20:02:06 INFO - PROCESS | 7283 | RSS: Main: 171761664 20:02:06 INFO - PROCESS | 7283 | 20:02:08 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-fft) 20:02:09 INFO - PROCESS | 7283 | RSS: Main: 162488320 20:02:09 INFO - PROCESS | 7283 | 20:02:11 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42732/tests/kraken/driver.html?testName=audio-oscillator) 20:02:12 INFO - PROCESS | 7283 | RSS: Main: 163115008 20:02:12 INFO - PROCESS | 7283 | 20:02:14 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:02:15 INFO - PROCESS | 7283 | RSS: Main: 164225024 20:02:15 INFO - PROCESS | 7283 | 20:02:18 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42732/tests/kraken/driver.html?testName=imaging-darkroom) 20:02:18 INFO - PROCESS | 7283 | RSS: Main: 163659776 20:02:18 INFO - PROCESS | 7283 | 20:02:22 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42732/tests/kraken/driver.html?testName=imaging-desaturate) 20:02:22 INFO - PROCESS | 7283 | RSS: Main: 163975168 20:02:22 INFO - PROCESS | 7283 | 20:02:25 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42732/tests/kraken/driver.html?testName=json-parse-financial) 20:02:26 INFO - PROCESS | 7283 | RSS: Main: 166535168 20:02:26 INFO - PROCESS | 7283 | 20:02:27 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:02:28 INFO - PROCESS | 7283 | RSS: Main: 166514688 20:02:28 INFO - PROCESS | 7283 | 20:02:30 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:02:30 INFO - PROCESS | 7283 | RSS: Main: 166674432 20:02:30 INFO - PROCESS | 7283 | 20:02:32 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:02:33 INFO - PROCESS | 7283 | RSS: Main: 167170048 20:02:33 INFO - PROCESS | 7283 | 20:02:36 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:02:36 INFO - PROCESS | 7283 | RSS: Main: 167415808 20:02:36 INFO - PROCESS | 7283 | 20:02:39 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:02:40 INFO - PROCESS | 7283 | RSS: Main: 167964672 20:02:40 INFO - PROCESS | 7283 | 20:02:41 INFO - PROCESS | 7283 | Cycle 1(1): loaded http://localhost:42732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42732/tests/kraken/driver.html?testName=ai-astar) 20:02:42 INFO - PROCESS | 7283 | RSS: Main: 169033728 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | __start_tp_report 20:02:42 INFO - PROCESS | 7283 | _x_x_mozilla_page_load 20:02:42 INFO - PROCESS | 7283 | _x_x_mozilla_page_load_details 20:02:42 INFO - PROCESS | 7283 | |i|pagename|runs| 20:02:42 INFO - PROCESS | 7283 | |0;ai-astar;115;104;110;111;112;123;111;111;111;110 20:02:42 INFO - PROCESS | 7283 | |1;audio-beat-detection;154;126;155;191;132;155;156;127;187;129 20:02:42 INFO - PROCESS | 7283 | |2;audio-dft;163;161;163;161;161;165;174;162;165;162 20:02:42 INFO - PROCESS | 7283 | |3;audio-fft;73;79;77;155;78;73;72;74;165;79 20:02:42 INFO - PROCESS | 7283 | |4;audio-oscillator;93;92;149;92;94;92;157;105;93;140 20:02:42 INFO - PROCESS | 7283 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;117;118;117 20:02:42 INFO - PROCESS | 7283 | |6;imaging-darkroom;148;147;146;146;147;146;147;146;146;148 20:02:42 INFO - PROCESS | 7283 | |7;imaging-desaturate;95;96;96;96;94;101;94;95;95;95 20:02:42 INFO - PROCESS | 7283 | |8;json-parse-financial;57;57;58;56;58;57;59;80;57;56 20:02:42 INFO - PROCESS | 7283 | |9;json-stringify-tinderbox;62;62;62;62;62;62;61;62;63;63 20:02:42 INFO - PROCESS | 7283 | |10;stanford-crypto-aes;76;83;75;76;78;84;77;77;78;77 20:02:42 INFO - PROCESS | 7283 | |11;stanford-crypto-ccm;126;123;126;124;132;126;142;138;163;128 20:02:42 INFO - PROCESS | 7283 | |12;stanford-crypto-pbkdf2;167;166;162;164;167;170;163;167;164;161 20:02:42 INFO - PROCESS | 7283 | |13;stanford-crypto-sha256-iterative;66;67;69;66;68;66;68;64;66;67 20:02:42 INFO - PROCESS | 7283 | __end_tp_report 20:02:42 INFO - PROCESS | 7283 | __start_cc_report 20:02:42 INFO - PROCESS | 7283 | _x_x_mozilla_cycle_collect,834 20:02:42 INFO - PROCESS | 7283 | __end_cc_report 20:02:42 INFO - PROCESS | 7283 | __startTimestamp1461121362143__endTimestamp 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | ------- Summary: start ------- 20:02:42 INFO - PROCESS | 7283 | Number of tests: 14 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:4.78 (4.3%) stddev-sans-first:4.93 20:02:42 INFO - PROCESS | 7283 | Values: 115.0 104.0 110.0 111.0 112.0 123.0 111.0 111.0 111.0 110.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#1] audio-beat-detection Cycles:10 Average:151.20 Median:155.00 stddev:23.59 (15.2%) stddev-sans-first:25.00 20:02:42 INFO - PROCESS | 7283 | Values: 154.0 126.0 155.0 191.0 132.0 155.0 156.0 127.0 187.0 129.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.92 (2.4%) stddev-sans-first:4.15 20:02:42 INFO - PROCESS | 7283 | Values: 163.0 161.0 163.0 161.0 161.0 165.0 174.0 162.0 165.0 162.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.50 stddev:35.75 (47.3%) stddev-sans-first:37.21 20:02:42 INFO - PROCESS | 7283 | Values: 73.0 79.0 77.0 155.0 78.0 73.0 72.0 74.0 165.0 79.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:92.00 stddev:26.78 (29.1%) stddev-sans-first:27.63 20:02:42 INFO - PROCESS | 7283 | Values: 93.0 92.0 149.0 92.0 94.0 92.0 157.0 105.0 93.0 140.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:02:42 INFO - PROCESS | 7283 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 117.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 20:02:42 INFO - PROCESS | 7283 | Values: 148.0 147.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 148.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.00 (2.1%) stddev-sans-first:2.11 20:02:42 INFO - PROCESS | 7283 | Values: 95.0 96.0 96.0 96.0 94.0 101.0 94.0 95.0 95.0 95.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:57.50 stddev:7.26 (12.6%) stddev-sans-first:7.64 20:02:42 INFO - PROCESS | 7283 | Values: 57.0 57.0 58.0 56.0 58.0 57.0 59.0 80.0 57.0 56.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 20:02:42 INFO - PROCESS | 7283 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 61.0 62.0 63.0 63.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:3.00 (3.9%) stddev-sans-first:3.08 20:02:42 INFO - PROCESS | 7283 | Values: 76.0 83.0 75.0 76.0 78.0 84.0 77.0 77.0 78.0 77.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:130.00 stddev:12.29 (9.5%) stddev-sans-first:12.79 20:02:42 INFO - PROCESS | 7283 | Values: 126.0 123.0 126.0 124.0 132.0 126.0 142.0 138.0 163.0 128.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.50 stddev:2.77 (1.7%) stddev-sans-first:2.85 20:02:42 INFO - PROCESS | 7283 | Values: 167.0 166.0 162.0 164.0 167.0 170.0 163.0 167.0 164.0 161.0 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - PROCESS | 7283 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 20:02:42 INFO - PROCESS | 7283 | Values: 66.0 67.0 69.0 66.0 68.0 66.0 68.0 64.0 66.0 67.0 20:02:42 INFO - PROCESS | 7283 | -------- Summary: end -------- 20:02:42 INFO - PROCESS | 7283 | 20:02:42 INFO - TEST-INFO | 7283: exit 0 20:02:43 INFO - TEST-OK | kraken | took 61402ms 20:02:43 INFO - SUITE-END | took 1171s 20:02:43 INFO - Completed test suite (00:19:31) 20:02:43 INFO - javascript benchmark 20:02:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3201.3117179806345, 3218.2115381731464, 3237.546743455915, 3264.2655402534433, 3275.3613045456136, 5427.99582077316, 5441.347038355398, 5460.426655201206, 5500.724963751816, 5511.834644960648, 5383.4616538346145, 5441.319835020622, 5459.454054594538, 5586.050371436855, 5587.580931430139, 4992.475790042057, 5020.899582008357, 5066.113430149728, 5081.695098294095, 5087.633038822747, 4962.206047032476, 5121.308623335839, 5134.820281290155, 5151.5878729701535, 5152.562032227265, 4871.098846713352, 4934.728589927553, 4956.677815941952, 5054.9241761373605, 5061.240813877929, 4994.126027945095, 5004.074246264417, 5006.299118123466, 5027.698338099725, 5029.19532874742, 4960.355153830015, 4967.180415231483, 4978.477259887732, 4996.525330093636, 5006.4492905780335, 5378.0, 5410.810621628263, 5451.427600101972, 5469.617126801126, 5484.314460692413, 5815.127730840365, 5840.7079646017955, 5843.941560584382, 5866.677332746697, 5898.14476900847, 5921.111833225008, 5934.7922822701, 5937.703114844284, 5940.584159108864, 5947.37552556984, 5351.117065684158, 5445.782168713286, 5459.181122831567, 5512.145617429264, 5523.7790488380815, 5965.791197308074, 6030.065339872327, 6030.939690603038, 6034.849128771816, 6037.1246169305205, 5767.596268261182, 5814.447627475383, 5818.389069147678, 5823.097419899922, 5825.7378417971295, 5711.200431939532, 5791.797287095016, 5830.067189249785, 5866.941330586725, 5892.234009578728, 5702.0591602385975, 5799.2460980073165, 5801.970990145022, 5813.82558523245, 5819.854503637358, 5741.569382296345, 5778.422157784188, 5795.420457954171, 5842.737076831553, 5859.0, 4381.0, 4384.561543845653, 4424.33634954753, 4428.6678499112695, 4451.6661250405705, 3946.5461471931094, 3976.423418604344, 3981.980090099589, 3995.6603688686787, 4005.1589166275407, 5562.972185139049, 5573.721313934287, 5573.972130139324, 5574.693391863405, 5602.915956260659, 5730.455606717355, 5786.88426231473, 5873.030949893306, 5885.382034886361, 5899.144624029492, 5611.494965453129, 5630.18362337467, 5647.068233741386, 5649.293838270216, 5705.515031222392, 5056.6713163644245, 5078.238264260391, 5085.2372144177925, 5085.771140298695, 5134.973005398935, 5878.647281163144, 5999.1901093351835, 6037.637741735422, 6042.667653279024, 6087.147799308101, 5854.2096816930025, 5893.351731309467, 5897.7935772247765, 5899.203607513103, 5946.881062378815, 6003.099535069775, 6016.037434010537, 6023.5783495156675, 6036.6679832609625, 6054.606450580698, 5595.524380427709, 5761.625494342854, 5766.538676905753, 5776.884462310646, 5841.415858414124, 5948.196993406008, 5966.880662386641, 5967.76128954837, 5975.850603734942, 5984.910226346521, 5713.857153571194, 5748.6838223898085, 5758.107493338539, 5798.652080875161, 5815.069588865761, 5591.692456914909, 5624.128260119688, 5674.659520428788, 5723.742431590672, 5776.7400466979925, 5546.502444339925, 5571.470710282517, 5600.551955843604, 5603.579731520071, 5662.886742265049, 5721.084626459747, 5786.710664466676, 5797.246357973437, 5818.0981947798155, 5825.621334613236, 5596.776128954796, 5607.355154157324, 5688.715564221855, 5691.943080569141, 5722.542196624343], "value": 5412.191818475193, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6574186971557, 627.5701144715869, 644.3620815392762, 649.5420728386488, 652.2564276724535, 30473.69526304739, 37461.81269093654, 37951.62048379515, 38316.61683383166, 38419.61580384195, 40125.398119028236, 40853.0, 40996.0, 41042.179156416925, 41164.58835411645, 8569.228769410736, 8769.824603507926, 8772.166644168825, 8818.823623527525, 8829.205371516562, 8514.403991720583, 8659.134086591353, 8670.566471676391, 8682.348823838205, 8879.112088791133, 8831.11688831115, 8945.73162805117, 8952.149545793172, 8999.460032398078, 9003.549822508881, 8782.868256976119, 8851.867221991675, 8890.4665720057, 8917.375783695144, 8945.15021072997, 8886.777830554223, 8929.241014513775, 8975.237104846095, 9000.414973026733, 9022.278217742565, 41323.58676413228, 41327.380089298684, 41685.0, 41764.582354176375, 41838.1632367351, 3520.700740437066, 3577.284543091392, 3607.098225443639, 3662.8351724172207, 3689.7232707546773, 28540.286492837637, 28992.388311084746, 29017.419651607062, 31027.0, 31291.53062704061, 4295.312749960022, 4346.413234213373, 4350.825966961318, 4379.562043795627, 4501.819927202908, 274591.0, 274742.0, 277024.99999999796, 277333.0, 278152.0, 35730.821345893106, 36678.8166059168, 54002.0, 54129.0, 54162.72918635382, 34922.650773492445, 35023.4746478803, 35107.0, 35149.64850351464, 35276.29447411037, 14622.26888655563, 14747.705045899022, 14766.114033158045, 14832.332545035284, 14862.92568537172, 12308.753824923451, 12394.690132746753, 12399.442025108712, 12399.814002789966, 12407.751844963232, 8545.230929216275, 8567.828643427096, 8592.398532102692, 8662.696805611773, 8670.089640587774, 3312.0, 3369.786876724377, 3375.4599264118115, 3380.7295416366633, 3399.6260411354733, 1096.9341839489657, 1147.4320211495196, 1179.6696924861053, 1206.1556910162922, 1261.9053570982212, 30859.691403085682, 34809.82595087009, 36109.45835812465, 36242.456363154575, 36476.45285320669, 1123.6179698902413, 1145.8968692817687, 1174.4010554617207, 1176.7705297467082, 1202.6271855724754, 16513.422030228885, 16688.332466701195, 16755.581110472092, 16875.831241687672, 16995.660086798194, 475354.0, 482516.0, 482818.0, 483833.0, 484242.0, 57367.0, 58426.123608145914, 58498.0, 58534.12198817021, 58549.70725146347, 1375.2711063136553, 1390.450771945076, 1395.7696979998389, 1398.6573289543924, 1402.0396028720359, 31479.370412592078, 31574.368512630077, 32197.0, 32548.83725581357, 32563.674363256065, 51810.74094629503, 52344.21483677824, 52647.21029184642, 52681.47318526919, 52967.47032529626, 454391.0, 458589.0, 459455.0, 460371.0, 460638.0, 28045.579316309864, 28283.858580706965, 28470.57294140548, 28500.0, 28520.14439566816, 48428.7578562119, 48705.0, 49190.50809492003, 49970.25044624406, 50432.74783626058, 40228.396574052, 40536.79731601323, 41259.1748165041, 41268.587314126475, 42293.0, 40714.410611246436, 41260.79369603133, 41443.85026737939, 41793.79103104465, 41880.79059604683, 41894.16211675688, 42541.0, 43076.35385469158, 43724.78137609291, 43931.12137757163, 31646.683533164374, 33749.0, 34585.48121778125, 35614.287714246086, 35948.82025589855, 27375.86312068427, 27791.917437693908, 28054.36637427786, 28077.438451230453, 28259.717402825707], "value": 18669.334876482735, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.3898609689738, 397.7017237072194, 402.37229921322756, 404.5913627236492, 404.7065877239001, 13696.794548081762, 15334.693306133871, 17807.910960445195, 18375.356862509816, 18465.630687386245, 15726.0, 15920.601984950354, 18217.908910455462, 18832.905835470803, 19307.806921930776, 5580.693061881595, 5749.942500575004, 5768.567357448208, 5801.042827933407, 5816.999999999979, 5562.805301814437, 5652.802151924683, 5748.712564371785, 5767.509761670263, 5788.855278618026, 5387.811426600069, 5710.685912274823, 5713.057345538002, 5732.971335143318, 5739.196512488255, 5558.499735023867, 5604.943950560483, 5615.185798059259, 5617.297837770278, 5646.20953066571, 5318.016167009116, 5618.550515958714, 5646.068398714207, 5647.689377084259, 5650.773969041234, 12732.745345093046, 12909.741805163938, 12957.416916238792, 12986.675333116653, 13653.0, 2272.9545409091893, 2284.846152692896, 2426.5146970605774, 2542.9491410171695, 2885.040183069998, 9805.950970245103, 10014.949925250326, 10335.741606459824, 12506.18709783861, 13665.0, 1899.629572233415, 1931.3529967460918, 1945.9124339404761, 1981.5937732764892, 1995.281698588507, 78291.6085419575, 78922.60538697327, 80616.19383806146, 80706.0, 81237.59381203115, 10826.40454774995, 10907.127429805596, 10925.781484370267, 10934.945325273482, 11127.610533631285, 15204.847951520343, 15254.694906101815, 15255.313510891814, 15325.386984520717, 15346.769798453031, 7039.92960070403, 7114.0, 7195.96402017997, 7245.529040612343, 7291.380232680282, 6441.25925518562, 6510.056041873901, 6520.380563846427, 6596.769113081019, 6621.106150669694, 4618.861434156981, 4682.578567928903, 4756.405449318835, 4797.7601119943865, 4832.540908613676, 1944.8055194480721, 1979.6244506592147, 1991.8904460254535, 1995.6906679464705, 2018.6770116781245, 1002.368507840056, 1067.0023528001343, 1088.7278180454887, 1090.1278976818514, 1093.4532733633184, 18964.24143034263, 19273.903630482037, 19392.0, 19482.0, 19620.3132890351, 1010.9789112995927, 1015.7359086637528, 1074.3285446595878, 1086.684861390188, 1101.2236373356764, 10218.284720069672, 10818.513166907507, 10820.458977051274, 10868.945655271673, 10983.61557345505, 445723.0, 446450.0, 505925.0, 506119.0, 508275.0, 76625.6168719164, 83357.58321208355, 88997.0, 89498.10501895029, 90635.0, 1055.8363453664695, 1057.539970112988, 1058.1270451877233, 1060.7825395793843, 1071.5713714514102, 16708.08105554206, 16935.391137841885, 17032.318707251572, 17351.7397239039, 17546.38587649426, 34871.0, 36273.0, 37092.0, 38661.420078699404, 38735.6126438732, 54046.459535404145, 54309.0, 55156.44843551513, 55179.0, 55863.44136558745, 8259.174082591693, 8384.832303353776, 8486.321094312563, 8520.105388934073, 8784.91215087841, 10812.945935270272, 11852.407379630811, 13057.673558161123, 13234.272115033766, 13235.801462978256, 10713.214564213205, 10763.461826908466, 11167.329960202089, 11551.884481155417, 11773.352465614473, 10917.727056823644, 10927.289726167774, 11061.612843550438, 11144.164187685794, 11508.309501429942, 11376.601818936297, 11511.136664750009, 11620.825687614524, 11627.0, 11647.417629118341, 7582.128055273714, 7812.804679883048, 7924.326432253323, 8103.635336409758, 8677.913220867711, 11437.370944598128, 11578.305301681927, 11620.418979051183, 11648.708782280512, 11774.3524106175], "value": 8893.096976611216, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.1464779723356, 1530.4184409924228, 1713.4003098915382, 1776.3960253513803, 1851.5559461510802, 7348.530293941207, 8011.799705007378, 8029.35765138789, 8191.590420478975, 8261.628226729797, 8051.275385215329, 8095.109537950835, 8095.838083238332, 8160.836783264331, 8163.91836081639, 2289.221664634024, 2303.2284184798027, 2304.0207911637485, 2309.8960546775434, 2318.1770471482632, 2251.909923603054, 2255.6954811100454, 2270.6821045053625, 2282.7374851891996, 2283.817294616435, 2299.298713892262, 2314.2247347138727, 2327.860328380294, 2335.369450248432, 2346.941326466835, 2202.768709285534, 2213.7564867864603, 2215.291106845802, 2216.656418255173, 2223.0552015393473, 2256.187772401934, 2264.479169790941, 2272.7954484096513, 2273.0339605667527, 2278.908843646252, 8181.059178194524, 8196.67213311467, 8270.875936860952, 8284.83430331396, 8325.292350150185, 5012.774425150877, 5106.897862042775, 5145.0, 5152.072626927152, 5187.948120518822, 3171.14596862823, 3315.1877789941377, 3362.4788157835574, 3389.2035371687634, 3399.184195792992, 1035.5184839049878, 1048.3028785857396, 1062.4634559547455, 1068.1294744783054, 1069.3744159666605, 11302.321860688386, 11307.095432365391, 11310.37792921389, 11353.772924541463, 11369.48837302315, 4403.119376124788, 4511.751853648016, 4584.97707511467, 4629.560191781776, 4672.462666793294, 9646.517674116407, 9658.613655453844, 9661.420314781135, 9690.46702431373, 9701.660441884642, 5030.798768049237, 5053.140966035783, 5064.873378165576, 5071.746412679351, 5093.643444958817, 4265.210935976854, 4665.206914824488, 4678.087772884255, 4689.155951928686, 4819.036192761461, 3767.2653832502947, 3814.923701525954, 3838.596947320491, 3859.7684138951754, 3880.1075752576503, 1271.2309053022789, 1271.3452571925466, 1276.44474653526, 1278.6995056161795, 1284.319310765296, 951.857221416793, 979.8971108033696, 990.7622170678985, 999.9500024998721, 1004.0662184168793, 5558.944410555842, 5634.474874496761, 5725.914111288334, 5762.625429347079, 5843.766249349978, 418.1741061403703, 420.7223232666487, 422.6618705035959, 425.97552885310876, 429.289525834744, 3961.7028722845903, 3975.423563583322, 3995.220931918306, 4015.4177644242004, 4060.898477538085, 9854.0, 10294.0, 10294.536745846455, 10296.536655850505, 10307.690769276935, 10123.848142277871, 10136.239782016379, 10145.644902428527, 10177.33847299938, 10189.133923616428, 7709.884351734729, 7843.764687059397, 7852.960735196288, 7869.527828330319, 7898.368130549542, 5473.17902314656, 5577.330720313588, 5621.751299480077, 5677.914831277617, 5757.309122905111, 9067.773305667148, 9251.814963700823, 9273.53632318395, 9279.536023198678, 9367.765805854908, 9469.242460602998, 9485.66800161991, 9686.806263874541, 9694.903050969682, 9732.221422286058, 6677.131972843694, 7059.399951004222, 7186.46101542376, 7256.2018177999325, 7271.41828653717, 7769.766906992573, 7810.609469526615, 7814.53112813233, 7817.374610031297, 7884.960575197088, 7045.436365090883, 7209.279072092749, 7260.96369518149, 7264.34620884123, 7274.854502910018, 7068.293170683096, 7183.497155199086, 7188.460865435218, 7220.638968051681, 7223.422126229784, 6593.076969224217, 6796.388325050769, 6854.7600833972565, 6861.622610756456, 6870.828229294108, 4785.258284965836, 4854.927176092291, 4866.756662166948, 4877.975610121926, 4936.284238785428, 4915.827946021872, 4930.161872481758, 4953.380827396575, 4984.576311013459, 5021.924671130009], "value": 4357.510753641783, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.6796675191816, 336.2400973799214, 340.6236109099445, 342.51192051326854, 344.44716230450126, 5945.940540594593, 6030.608010479315, 6037.516998640109, 6038.456538911502, 6068.453839154476, 5925.762969481227, 5930.347661757203, 5960.463558279765, 5964.970175149129, 5976.2230909981645, 4114.670826333886, 4243.490781106264, 4498.572635599629, 4502.639788816887, 4530.161920044786, 4524.9095018099615, 4533.705309154894, 4561.7262964222255, 4562.315652652095, 4590.839320623779, 4507.323901414781, 4548.295014272793, 4552.408186935694, 4553.134904368176, 4561.270196768518, 4474.351219073233, 4522.479914809806, 4549.363089167519, 4549.840755573572, 4568.406107206075, 3995.220931918277, 4009.639132478091, 4012.0371110933165, 4012.217617564576, 4016.297147999118, 5668.149777533362, 5672.262605861211, 5715.170835540198, 5717.199592057115, 5776.8844623107725, 5164.14791559396, 5236.664650514094, 5261.921071183935, 5279.815206467755, 5286.207068939651, 6135.294441139237, 6161.229846269216, 6207.410296021871, 6212.751489940397, 6218.440340369389, 4392.428984232061, 4414.381986521889, 4433.512313645497, 4436.911261774746, 4450.866474005785, 6273.772810652198, 6372.107904893319, 6498.317676643932, 6503.447206987412, 6548.869022619569, 4416.867493975186, 4424.7123936944, 4432.335149727567, 4438.312061630452, 4444.333349997526, 4470.597646211857, 4490.236659767847, 4519.638428925678, 4521.276595744665, 4522.163399771053, 4956.702597844141, 5242.842714718565, 5249.973750131301, 5265.52610265078, 5268.894622107613, 6275.0, 6297.244330680348, 6313.305536390993, 6327.968360158262, 6379.106925030499, 1544.2201688147413, 1560.0795530636979, 1568.576484349242, 1571.591386239563, 1574.039835700222, 999.4752754803786, 1033.8087453821067, 1037.387941114746, 1039.1946241662772, 1054.7574057966558, 5984.251968503937, 5992.460678538865, 5992.760289588455, 6008.978473659488, 6049.18336024631, 6368.267649220306, 6372.107904893319, 6383.808485745435, 6404.647744374104, 6423.743050277936, 5822.388649191858, 6082.695865206722, 6085.482733967662, 6089.725962331706, 6097.298810636745, 3431.725461963037, 3468.9653103469145, 3472.548568686105, 3477.1828620274214, 3477.2523907360037, 6430.143096263445, 6522.739090436425, 6574.309697481791, 6623.668816559153, 6657.633830139292, 6471.482281417475, 6491.156149700603, 6495.7401703932255, 6502.479801615859, 6537.869242615121, 6317.6209427434505, 6569.83575410609, 6580.670966451658, 6589.637569933604, 6765.154355705438, 6523.217213934358, 6546.24718157418, 6549.198970283211, 6554.934450655433, 6573.835654108686, 6319.526035547445, 6506.186726659168, 6519.5436319457185, 6523.021546768023, 6535.673216339259, 6664.866702665822, 6732.360425759741, 6749.42629876466, 6749.628770417674, 6762.932370676231, 4356.564343565745, 4377.868663940087, 4398.670099742596, 4401.36180253855, 4416.094700586308, 6262.311145774052, 6499.512536559682, 6522.28254891971, 6546.116274303098, 6597.472202223907, 6335.429811317003, 6339.714712838026, 6372.55392122547, 6375.776847810304, 6385.393387628168, 5962.642241465526, 6308.549033722178, 6324.2410910691015, 6356.237251529846, 6365.299817020032, 6199.56603037783, 6225.533085018732, 6242.906356404748, 6256.906146407899, 6263.530235232467, 6116.877662446637, 6371.649559274284, 6391.201099862517, 6442.420182183626, 6461.2892581816905, 6197.411245931629, 6204.525465739201, 6211.937880621136, 6244.687765611792, 6250.093736408105], "value": 4733.161834222217, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.1881055596617, 729.7299999000368, 806.3508875355338, 829.2909562324209, 877.9034306226314, 12747.872521274785, 12865.228086314828, 12886.291253981039, 12998.41507132179, 13021.479140834366, 13477.123986940842, 13499.325033748299, 13537.255450950193, 13552.457901683922, 13568.321583920813, 683.0812557110678, 789.4749991255808, 821.6590115102225, 822.8313195794877, 824.0729179672868, 818.9099199088125, 819.7950512371907, 819.889314942484, 820.7086484298078, 826.8387664405443, 852.0499642898186, 859.1108203009886, 862.3101518784947, 863.2101627011277, 866.6013633728493, 851.3061854588491, 851.6763629820659, 858.274757829633, 859.7721603775004, 867.6616119713317, 620.1008537620469, 623.3984205241918, 626.7211091064478, 627.4353082225988, 627.7896904536985, 12883.098183127186, 12996.935015324863, 13059.542915997894, 13062.673433164247, 13134.211947283098, 13923.094998825145, 13969.58091257264, 14022.859771402258, 14090.436382544685, 14092.802111820405, 11399.430028498626, 11436.829679929178, 11512.424378781112, 11602.187846850724, 11816.409179541075, 3564.0, 3565.073080998933, 3632.54593175853, 3658.5609726832686, 3725.9068523286865, 54655.18017229745, 55059.44940550583, 55107.0, 55534.16698749522, 56789.71605141948, 10737.570497180026, 10775.568977240979, 11010.614628488125, 11040.558377664964, 11074.501647425885, 20107.19571217164, 20217.696734548994, 20337.694934575993, 20416.0812763426, 21051.68422473664, 8262.917370826215, 8288.668453261802, 8297.95851020753, 8340.41617086798, 8345.41582089248, 4365.476142862877, 4518.118966801442, 4553.5218802025975, 4661.836835710734, 4749.928751068736, 3212.486002239677, 3305.1241421023446, 3308.4706446968853, 3310.66893310667, 3315.8839440619945, 556.4602335734331, 557.6737608498993, 561.9915701264484, 621.3879328861068, 661.9205695316593, 728.9575906453716, 784.8194915169543, 798.5887268056955, 808.2846680687634, 813.1543195077054, 9074.0, 9414.529273536296, 9477.526123693926, 9481.2271702029, 9588.856167157499, 735.4116706634671, 775.4068137874418, 779.0729032451478, 795.5783434779576, 822.9341652667772, 4484.977575112103, 4622.907541849144, 4785.3300537924715, 4812.735299558488, 4821.95178048215, 61206.693966529885, 61583.38416615866, 61637.38362616406, 62281.37718622846, 62362.0, 55574.444255556926, 56748.432515674314, 57160.0, 57590.0, 58209.70895145497, 50725.23912141321, 50811.23783143256, 51173.488265116874, 52195.0, 53806.19290710642, 8733.606987685442, 8804.823903522021, 8872.600732966903, 9008.86486702713, 9108.134727200906, 33380.83309583534, 33664.49503257404, 34228.48657270093, 34366.48450273198, 34394.484082739276, 42433.57566424296, 43955.78022109869, 45938.0, 47131.0, 47707.28439073486, 11701.2979221247, 11850.703732406759, 11883.287002779862, 12039.425157051957, 12107.515699371927, 12871.806922895978, 13043.478260869459, 13201.669958251121, 13450.798238026633, 13498.86501134976, 12593.622191334274, 12689.746205076031, 12841.0, 12932.612021639367, 13344.933275333562, 12475.563355282522, 12631.242125472501, 12819.615411537668, 12840.678983025498, 12903.41934612926, 12797.936010319889, 12818.807717884052, 12854.293013884326, 12909.35453227316, 13341.066125371519, 9705.805883882142, 9875.456849873326, 10013.24900632441, 10087.646932357333, 10196.898031019891, 10911.454427278446, 10943.616973405893, 10991.120710342993, 11024.779504410028, 11135.88864111381], "value": 6753.95930939979, "unit": "score"}], "name": "dromaeo_css", "value": 7072.785568066432, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 104.0, 110.0, 111.0, 112.0, 123.0, 111.0, 111.0, 111.0, 110.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 126.0, 155.0, 191.0, 132.0, 155.0, 156.0, 127.0, 187.0, 129.0], "value": 151.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 161.0, 165.0, 174.0, 162.0, 165.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 79.0, 77.0, 155.0, 78.0, 73.0, 72.0, 74.0, 165.0, 79.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 149.0, 92.0, 94.0, 92.0, 157.0, 105.0, 93.0, 140.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 94.0, 101.0, 94.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 58.0, 56.0, 58.0, 57.0, 59.0, 80.0, 57.0, 56.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 75.0, 76.0, 78.0, 84.0, 77.0, 77.0, 78.0, 77.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 126.0, 124.0, 132.0, 126.0, 142.0, 138.0, 163.0, 128.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 162.0, 164.0, 167.0, 170.0, 163.0, 167.0, 164.0, 161.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 66.0, 68.0, 66.0, 68.0, 64.0, 66.0, 67.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1553.9999999999998, "alertThreshold": 2.0}]} 20:02:43 INFO - Return code: 0 20:02:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:02:43 ERROR - # TBPL SUCCESS # 20:02:43 INFO - Running post-action listener: _resource_record_post_action 20:02:43 INFO - Running post-run listener: _resource_record_post_run 20:02:44 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 425984; Write bytes: 293920768; Read time: 68; Write time: 247504 20:02:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5242880; Read time: 0; Write time: 392 20:02:44 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 425984; Write bytes: 288677888; Read time: 68; Write time: 247112 20:02:44 INFO - Running post-run listener: _upload_blobber_files 20:02:44 INFO - Blob upload gear active. 20:02:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:02:44 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 20:02:44 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:02:44 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:02:44 INFO - (blobuploader) - INFO - Open directory for files ... 20:02:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:02:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:02:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:02:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:02:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:02:45 INFO - (blobuploader) - INFO - Done attempting. 20:02:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:02:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:02:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:02:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:02:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:02:46 INFO - (blobuploader) - INFO - Done attempting. 20:02:46 INFO - (blobuploader) - INFO - Iteration through files over. 20:02:46 INFO - Return code: 0 20:02:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:02:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:02:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e13198cc333583177e6f884b386673c91f21bc5653f0e552576181cad7d23a865f91dcd04648f25ebffabe701bef36fcbeab4429f4a332a9d6500bb42eb54ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90caac7b77d281026e47b45a2912b5a2168767269ba522cfbc3ddb070da9a67be06144e9b7c7d21411ff6b4c39177871412d6473a4812b673e5b4e140540d031"} 20:02:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:02:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:02:46 INFO - Contents: 20:02:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e13198cc333583177e6f884b386673c91f21bc5653f0e552576181cad7d23a865f91dcd04648f25ebffabe701bef36fcbeab4429f4a332a9d6500bb42eb54ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90caac7b77d281026e47b45a2912b5a2168767269ba522cfbc3ddb070da9a67be06144e9b7c7d21411ff6b4c39177871412d6473a4812b673e5b4e140540d031"} 20:02:46 INFO - Running post-run listener: copy_logs_to_upload_dir 20:02:46 INFO - Copying logs to upload dir... 20:02:46 INFO - mkdir: /builds/slave/test/build/upload/logs 20:02:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.761170 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-19 20:02:46.710438) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 20:02:46.714462) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029 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/sha512/e13198cc333583177e6f884b386673c91f21bc5653f0e552576181cad7d23a865f91dcd04648f25ebffabe701bef36fcbeab4429f4a332a9d6500bb42eb54ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90caac7b77d281026e47b45a2912b5a2168767269ba522cfbc3ddb070da9a67be06144e9b7c7d21411ff6b4c39177871412d6473a4812b673e5b4e140540d031"} build_url:https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/KRIcV3SKSvCNL76kQmtRQA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e13198cc333583177e6f884b386673c91f21bc5653f0e552576181cad7d23a865f91dcd04648f25ebffabe701bef36fcbeab4429f4a332a9d6500bb42eb54ed3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/90caac7b77d281026e47b45a2912b5a2168767269ba522cfbc3ddb070da9a67be06144e9b7c7d21411ff6b4c39177871412d6473a4812b673e5b4e140540d031"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 20:02:46.739458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 20:02:46.739791) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461118625.175443-463757029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 20:02:46.825378) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 20:02:46.825703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 20:02:46.826107) ========= ========= Total master_lag: 0.19 =========