builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1460891293.39 results: success (0) buildid: 20160417032814 builduid: 6fadf322d07d4224be63ab6f3180c7ee revision: f8c0dd78206cac5a132b164ebacfa8ffbac9713c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.394982) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.395417) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.395697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.414459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.414753) ========= 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=df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-17 04:08:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-04-17 04:08:13 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165356 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.592898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.593194) ========= 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=df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019284 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.642715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:13.643030) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8c0dd78206cac5a132b164ebacfa8ffbac9713c --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 f8c0dd78206cac5a132b164ebacfa8ffbac9713c --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=df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-17 04:08:13,953 truncating revision to first 12 chars 2016-04-17 04:08:13,953 Setting DEBUG logging. 2016-04-17 04:08:13,953 attempt 1/10 2016-04-17 04:08:13,953 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8c0dd78206c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-17 04:08:14,289 unpacking tar archive at: fx-team-f8c0dd78206c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601677 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:14.257673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:14.257998) ========= script_repo_revision: f8c0dd78206cac5a132b164ebacfa8ffbac9713c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:14.258414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:14.258698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-17 04:08:14.268516) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-17 04:08:14.268798) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:14 INFO - MultiFileLogger online at 20160417 04:08:14 in /builds/slave/test 04:08:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:08:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:14 INFO - {'append_to_log': False, 04:08:14 INFO - 'base_work_dir': '/builds/slave/test', 04:08:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:08:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:14 INFO - 'branch': 'Fx-Team-Non-PGO', 04:08:14 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:14 INFO - 'config_files': ('talos/linux_config.py',), 04:08:14 INFO - 'default_actions': ('clobber', 04:08:14 INFO - 'read-buildbot-config', 04:08:14 INFO - 'download-and-extract', 04:08:14 INFO - 'populate-webroot', 04:08:14 INFO - 'create-virtualenv', 04:08:14 INFO - 'install', 04:08:14 INFO - 'run-tests'), 04:08:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:14 INFO - 'download_minidump_stackwalk': True, 04:08:14 INFO - 'download_symbols': 'ondemand', 04:08:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:14 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:14 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:14 INFO - 'installer_path': 'installer.exe', 04:08:14 INFO - 'log_level': 'info', 04:08:14 INFO - 'log_name': 'talos', 04:08:14 INFO - 'log_to_console': True, 04:08:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:14 INFO - 'opt_config_files': (), 04:08:14 INFO - 'pip_index': False, 04:08:14 INFO - 'sps_profile': False, 04:08:14 INFO - 'sps_profile_interval': 0, 04:08:14 INFO - 'suite': 'dromaeojs', 04:08:14 INFO - 'system_bits': '32', 04:08:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:14 INFO - 'title': 'talos-linux64-ix-021', 04:08:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:14 INFO - 'use_talos_json': True, 04:08:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:14 INFO - 'work_dir': 'build'} 04:08:14 INFO - ##### 04:08:14 INFO - ##### Running clobber step. 04:08:14 INFO - ##### 04:08:14 INFO - Running pre-action listener: _resource_record_pre_action 04:08:14 INFO - Running main action method: clobber 04:08:14 INFO - rmtree: /builds/slave/test/build 04:08:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:15 INFO - Running post-action listener: _resource_record_post_action 04:08:15 INFO - ##### 04:08:15 INFO - ##### Running read-buildbot-config step. 04:08:15 INFO - ##### 04:08:15 INFO - Running pre-action listener: _resource_record_pre_action 04:08:15 INFO - Running main action method: read_buildbot_config 04:08:15 INFO - Using buildbot properties: 04:08:15 INFO - { 04:08:15 INFO - "project": "", 04:08:15 INFO - "product": "firefox", 04:08:15 INFO - "script_repo_revision": "production", 04:08:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:08:15 INFO - "repository": "", 04:08:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:08:15 INFO - "buildid": "20160417032814", 04:08:15 INFO - "pgo_build": "False", 04:08:15 INFO - "basedir": "/builds/slave/test", 04:08:15 INFO - "buildnumber": 1651, 04:08:15 INFO - "slavename": "talos-linux64-ix-021", 04:08:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:08:15 INFO - "platform": "ubuntu64_hw", 04:08:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:08:15 INFO - "branch": "fx-team", 04:08:15 INFO - "repo_path": "integration/fx-team", 04:08:15 INFO - "revision": "f8c0dd78206cac5a132b164ebacfa8ffbac9713c", 04:08:15 INFO - "stage_platform": "linux64", 04:08:15 INFO - "builduid": "6fadf322d07d4224be63ab6f3180c7ee", 04:08:15 INFO - "slavebuilddir": "test" 04:08:15 INFO - } 04:08:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:08:15 INFO - Running post-action listener: _resource_record_post_action 04:08:15 INFO - ##### 04:08:15 INFO - ##### Running download-and-extract step. 04:08:15 INFO - ##### 04:08:15 INFO - Running pre-action listener: _resource_record_pre_action 04:08:15 INFO - Running main action method: download_and_extract 04:08:15 INFO - mkdir: /builds/slave/test/build/tests 04:08:15 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')]} 04:08:15 INFO - https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:08:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:08:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:08:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:18 INFO - Downloaded 1361 bytes. 04:08:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:08:18 INFO - Using the following test package requirements: 04:08:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:08:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'jsshell-linux-x86_64.zip'], 04:08:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:18 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')]} 04:08:18 INFO - https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:30 INFO - Downloaded 22203703 bytes. 04:08:30 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'] 04:08:30 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 04:08:31 INFO - Return code: 0 04:08:31 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 04:08: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')]} 04:08:31 INFO - https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:33 INFO - Downloaded 22203703 bytes. 04:08:33 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'] 04:08:33 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 04:08:34 INFO - Return code: 0 04:08: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')]} 04:08:34 INFO - https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:35 INFO - Downloaded 10841076 bytes. 04:08:35 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'] 04:08:35 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 04:08:35 INFO - Return code: 0 04:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:35 INFO - https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:08:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/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 04:08:37 INFO - Downloaded 54452442 bytes. 04:08:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:37 INFO - mkdir: /builds/slave/test/properties 04:08:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:37 INFO - Contents: 04:08:37 INFO - build_url:https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:08:37 INFO - Running post-action listener: _resource_record_post_action 04:08:37 INFO - Running post-action listener: set_extra_try_arguments 04:08:37 INFO - ##### 04:08:37 INFO - ##### Running populate-webroot step. 04:08:37 INFO - ##### 04:08:37 INFO - Running pre-action listener: _resource_record_pre_action 04:08:37 INFO - Running main action method: populate_webroot 04:08:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:37 INFO - '--tppagecycles', 04:08:37 INFO - '7'], 04:08:37 INFO - 'tests': ['tsvgm']}}, 04:08:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['damp', 'tps']}, 04:08:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'tests': ['damp', 'tps']}, 04:08:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['dromaeo_dom']}, 04:08:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore', 04:08:37 INFO - 'tabpaint']}, 04:08:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore', 04:08:37 INFO - 'tabpaint']}, 04:08:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore', 04:08:37 INFO - 'tabpaint']}, 04:08:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore', 04:08:37 INFO - 'tabpaint']}, 04:08:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore', 04:08:37 INFO - 'tabpaint']}, 04:08:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['a11yr', 04:08:37 INFO - 'ts_paint', 04:08:37 INFO - 'tpaint', 04:08:37 INFO - 'sessionrestore', 04:08:37 INFO - 'sessionrestore_no_auto_restore', 04:08:37 INFO - 'tabpaint']}, 04:08:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['tsvgx', 04:08:37 INFO - 'tsvgr_opacity', 04:08:37 INFO - 'tart', 04:08:37 INFO - 'tscrollx', 04:08:37 INFO - 'cart']}, 04:08:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:37 INFO - 'tsvgr_opacity', 04:08:37 INFO - 'tart', 04:08:37 INFO - 'tscrollx', 04:08:37 INFO - 'cart']}, 04:08:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--disable-e10s'], 04:08:37 INFO - 'tests': ['tp5o']}, 04:08:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'tests': ['tp5o']}, 04:08:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--disable-e10s', 04:08:37 INFO - '--xperf_path', 04:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:37 INFO - 'tests': ['tp5n']}, 04:08:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:37 INFO - 'talos_options': ['--xperf_path', 04:08:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:37 INFO - 'tests': ['tp5n']}}, 04:08:37 INFO - 'talos.zip': {'path': '', 04:08:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:37 INFO - Running post-action listener: _resource_record_post_action 04:08:37 INFO - ##### 04:08:37 INFO - ##### Running create-virtualenv step. 04:08:37 INFO - ##### 04:08:37 INFO - Running pre-action listener: _resource_record_pre_action 04:08:37 INFO - Running main action method: create_virtualenv 04:08:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:37 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 04:08:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:38 INFO - Using real prefix '/usr' 04:08:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:40 INFO - Installing pip.................done. 04:08:40 INFO - Return code: 0 04:08:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:40 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:40 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 04:08:40 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 04:08:40 INFO - Using env: {'DISPLAY': ':0', 04:08:40 INFO - 'HOME': '/home/cltbld', 04:08:40 INFO - 'LANG': 'en_US.UTF-8', 04:08:40 INFO - 'LANGUAGE': 'en_US:en', 04:08:40 INFO - 'LOGNAME': 'cltbld', 04:08:40 INFO - 'MAIL': '/var/mail/cltbld', 04:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:40 INFO - 'MOZ_NO_REMOTE': '1', 04:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:40 INFO - 'NO_EM_RESTART': '1', 04:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:40 INFO - 'PWD': '/builds/slave/test', 04:08:40 INFO - 'SHELL': '/bin/bash', 04:08:40 INFO - 'SHLVL': '1', 04:08:40 INFO - 'TERM': 'linux', 04:08:40 INFO - 'TMOUT': '86400', 04:08:40 INFO - 'USER': 'cltbld', 04:08:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:40 INFO - '_': '/tools/buildbot/bin/python'} 04:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:40 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 04:08:40 INFO - Cleaning up... 04:08:40 INFO - Return code: 0 04:08:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:40 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:40 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 04:08:40 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 04:08:40 INFO - Using env: {'DISPLAY': ':0', 04:08:40 INFO - 'HOME': '/home/cltbld', 04:08:40 INFO - 'LANG': 'en_US.UTF-8', 04:08:40 INFO - 'LANGUAGE': 'en_US:en', 04:08:40 INFO - 'LOGNAME': 'cltbld', 04:08:40 INFO - 'MAIL': '/var/mail/cltbld', 04:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:40 INFO - 'MOZ_NO_REMOTE': '1', 04:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:40 INFO - 'NO_EM_RESTART': '1', 04:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:40 INFO - 'PWD': '/builds/slave/test', 04:08:40 INFO - 'SHELL': '/bin/bash', 04:08:40 INFO - 'SHLVL': '1', 04:08:40 INFO - 'TERM': 'linux', 04:08:40 INFO - 'TMOUT': '86400', 04:08:40 INFO - 'USER': 'cltbld', 04:08:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:40 INFO - '_': '/tools/buildbot/bin/python'} 04:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:41 INFO - Downloading/unpacking psutil>=0.7.1 04:08:41 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 04:08:41 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 04:08:41 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 04:08:41 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 04:08:41 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 04:08:41 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 04:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:43 INFO - Installing collected packages: psutil 04:08:43 INFO - Running setup.py install for psutil 04:08:43 INFO - building 'psutil._psutil_linux' extension 04:08:43 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 04:08:43 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 04:08:43 INFO - building 'psutil._psutil_posix' extension 04:08:43 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 04:08:43 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 04:08:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:43 INFO - Successfully installed psutil 04:08:43 INFO - Cleaning up... 04:08:43 INFO - Return code: 0 04:08:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:08:43 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')]} 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:43 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')]} 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:43 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:43 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 04:08:43 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 04:08:43 INFO - Using env: {'DISPLAY': ':0', 04:08:43 INFO - 'HOME': '/home/cltbld', 04:08:43 INFO - 'LANG': 'en_US.UTF-8', 04:08:43 INFO - 'LANGUAGE': 'en_US:en', 04:08:43 INFO - 'LOGNAME': 'cltbld', 04:08:43 INFO - 'MAIL': '/var/mail/cltbld', 04:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:43 INFO - 'MOZ_NO_REMOTE': '1', 04:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:43 INFO - 'NO_EM_RESTART': '1', 04:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:43 INFO - 'PWD': '/builds/slave/test', 04:08:43 INFO - 'SHELL': '/bin/bash', 04:08:43 INFO - 'SHLVL': '1', 04:08:43 INFO - 'TERM': 'linux', 04:08:43 INFO - 'TMOUT': '86400', 04:08:43 INFO - 'USER': 'cltbld', 04:08:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:43 INFO - '_': '/tools/buildbot/bin/python'} 04:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:08:43 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 04:08:43 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 04:08:43 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 04:08:43 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 04:08:43 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 04:08:43 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 04:08:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:08:47 INFO - Installing collected packages: mozsystemmonitor 04:08:47 INFO - Running setup.py install for mozsystemmonitor 04:08:48 INFO - Successfully installed mozsystemmonitor 04:08:48 INFO - Cleaning up... 04:08:48 INFO - Return code: 0 04:08:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:48 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')]} 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:48 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')]} 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:48 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:48 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 04:08:48 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 04:08:48 INFO - Using env: {'DISPLAY': ':0', 04:08:48 INFO - 'HOME': '/home/cltbld', 04:08:48 INFO - 'LANG': 'en_US.UTF-8', 04:08:48 INFO - 'LANGUAGE': 'en_US:en', 04:08:48 INFO - 'LOGNAME': 'cltbld', 04:08:48 INFO - 'MAIL': '/var/mail/cltbld', 04:08:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:48 INFO - 'MOZ_NO_REMOTE': '1', 04:08:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:48 INFO - 'NO_EM_RESTART': '1', 04:08:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:48 INFO - 'PWD': '/builds/slave/test', 04:08:48 INFO - 'SHELL': '/bin/bash', 04:08:48 INFO - 'SHLVL': '1', 04:08:48 INFO - 'TERM': 'linux', 04:08:48 INFO - 'TMOUT': '86400', 04:08:48 INFO - 'USER': 'cltbld', 04:08:48 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:48 INFO - '_': '/tools/buildbot/bin/python'} 04:08:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:51 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 04:08:51 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 04:08:51 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 04:08:51 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 04:08:51 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 04:08:51 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 04:08:51 INFO - Downloading docopt-0.6.1.tar.gz 04:08:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:51 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:51 INFO - Running setup.py install for blobuploader 04:08:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:51 INFO - Running setup.py install for requests 04:08:51 INFO - Running setup.py install for docopt 04:08:51 INFO - Successfully installed blobuploader requests docopt 04:08:51 INFO - Cleaning up... 04:08:52 INFO - Return code: 0 04:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:52 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 04:08:52 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 04:08:52 INFO - Using env: {'DISPLAY': ':0', 04:08:52 INFO - 'HOME': '/home/cltbld', 04:08:52 INFO - 'LANG': 'en_US.UTF-8', 04:08:52 INFO - 'LANGUAGE': 'en_US:en', 04:08:52 INFO - 'LOGNAME': 'cltbld', 04:08:52 INFO - 'MAIL': '/var/mail/cltbld', 04:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:52 INFO - 'MOZ_NO_REMOTE': '1', 04:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:52 INFO - 'NO_EM_RESTART': '1', 04:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:52 INFO - 'PWD': '/builds/slave/test', 04:08:52 INFO - 'SHELL': '/bin/bash', 04:08:52 INFO - 'SHLVL': '1', 04:08:52 INFO - 'TERM': 'linux', 04:08:52 INFO - 'TMOUT': '86400', 04:08:52 INFO - 'USER': 'cltbld', 04:08:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:52 INFO - '_': '/tools/buildbot/bin/python'} 04:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:52 INFO - Running setup.py (path:/tmp/pip-KxAWwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:52 INFO - Running setup.py (path:/tmp/pip-RN0e1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:52 INFO - Running setup.py (path:/tmp/pip-o9iI9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:52 INFO - Running setup.py (path:/tmp/pip-zIoWa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:52 INFO - Running setup.py (path:/tmp/pip-nCyrjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:52 INFO - Running setup.py (path:/tmp/pip-BonXb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:52 INFO - Running setup.py (path:/tmp/pip-szDpjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:52 INFO - Running setup.py (path:/tmp/pip-37mQ1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:52 INFO - Running setup.py (path:/tmp/pip-vwXw6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:52 INFO - Running setup.py (path:/tmp/pip-fWI_Cc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:52 INFO - Running setup.py (path:/tmp/pip-S80csZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:53 INFO - Running setup.py (path:/tmp/pip-vNT3fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:53 INFO - Running setup.py (path:/tmp/pip-VQ7dBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:53 INFO - Running setup.py (path:/tmp/pip-DEg_6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:53 INFO - Running setup.py (path:/tmp/pip-QEy1Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:53 INFO - Running setup.py (path:/tmp/pip-WuWLsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:53 INFO - Running setup.py (path:/tmp/pip-3sqh7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:53 INFO - Running setup.py install for manifestparser 04:08:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:53 INFO - Running setup.py install for mozcrash 04:08:53 INFO - Running setup.py install for mozdebug 04:08:53 INFO - Running setup.py install for mozdevice 04:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:53 INFO - Running setup.py install for mozfile 04:08:53 INFO - Running setup.py install for mozhttpd 04:08:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozinfo 04:08:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozInstall 04:08:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozleak 04:08:54 INFO - Running setup.py install for mozlog 04:08:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for moznetwork 04:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozprocess 04:08:54 INFO - Running setup.py install for mozprofile 04:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozrunner 04:08:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:54 INFO - Running setup.py install for mozscreenshot 04:08:55 INFO - Running setup.py install for moztest 04:08:55 INFO - Running setup.py install for mozversion 04:08:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:55 INFO - Cleaning up... 04:08:55 INFO - Return code: 0 04:08:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:55 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:55 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 04:08:55 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 04:08:55 INFO - Using env: {'DISPLAY': ':0', 04:08:55 INFO - 'HOME': '/home/cltbld', 04:08:55 INFO - 'LANG': 'en_US.UTF-8', 04:08:55 INFO - 'LANGUAGE': 'en_US:en', 04:08:55 INFO - 'LOGNAME': 'cltbld', 04:08:55 INFO - 'MAIL': '/var/mail/cltbld', 04:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:55 INFO - 'MOZ_NO_REMOTE': '1', 04:08:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:55 INFO - 'NO_EM_RESTART': '1', 04:08:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:55 INFO - 'PWD': '/builds/slave/test', 04:08:55 INFO - 'SHELL': '/bin/bash', 04:08:55 INFO - 'SHLVL': '1', 04:08:55 INFO - 'TERM': 'linux', 04:08:55 INFO - 'TMOUT': '86400', 04:08:55 INFO - 'USER': 'cltbld', 04:08:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:55 INFO - '_': '/tools/buildbot/bin/python'} 04:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:55 INFO - Running setup.py (path:/tmp/pip-s_ZvsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:55 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)) 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:55 INFO - Running setup.py (path:/tmp/pip-_RJNbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:55 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)) 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:55 INFO - Running setup.py (path:/tmp/pip-SJJENt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:55 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)) 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:55 INFO - Running setup.py (path:/tmp/pip-GESjI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:55 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)) 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:55 INFO - Running setup.py (path:/tmp/pip-cDi0qc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:55 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)) 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:55 INFO - Running setup.py (path:/tmp/pip-97P9GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:55 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)) 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:55 INFO - Running setup.py (path:/tmp/pip-kSg7TR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:55 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)) 04:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:55 INFO - Running setup.py (path:/tmp/pip-L4t1LC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:56 INFO - Running setup.py (path:/tmp/pip-8LE5XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:56 INFO - Running setup.py (path:/tmp/pip-n4MP2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:56 INFO - Running setup.py (path:/tmp/pip-rWnlGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:56 INFO - Running setup.py (path:/tmp/pip-EU3fXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:56 INFO - Running setup.py (path:/tmp/pip-buI3iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:56 INFO - Running setup.py (path:/tmp/pip-xGYIDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:56 INFO - Running setup.py (path:/tmp/pip-mwcYsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:56 INFO - Running setup.py (path:/tmp/pip-eoG2u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:56 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)) 04:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:56 INFO - Running setup.py (path:/tmp/pip-t0uYIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:56 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)) 04:08:56 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)) 04:08:56 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)) 04:08:56 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)) 04:08:56 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)) 04:08:56 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)) 04:08:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:56 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 04:08:56 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 04:08:56 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 04:08:56 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 04:08:56 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 04:08:56 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 04:08:58 INFO - Downloading blessings-1.6.tar.gz 04:08:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:58 INFO - Installing collected packages: blessings 04:08:58 INFO - Running setup.py install for blessings 04:08:58 INFO - Successfully installed blessings 04:08:58 INFO - Cleaning up... 04:08:58 INFO - Return code: 0 04:08:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:58 INFO - Reading from file tmpfile_stdout 04:08:58 INFO - Current package versions: 04:08:58 INFO - argparse == 1.2.1 04:08:58 INFO - blessings == 1.6 04:08:58 INFO - blobuploader == 1.2.4 04:08:58 INFO - docopt == 0.6.1 04:08:58 INFO - manifestparser == 1.1 04:08:58 INFO - mozInstall == 1.12 04:08:58 INFO - mozcrash == 0.17 04:08:58 INFO - mozdebug == 0.1 04:08:58 INFO - mozdevice == 0.48 04:08:58 INFO - mozfile == 1.2 04:08:58 INFO - mozhttpd == 0.7 04:08:58 INFO - mozinfo == 0.9 04:08:58 INFO - mozleak == 0.1 04:08:58 INFO - mozlog == 3.1 04:08:58 INFO - moznetwork == 0.27 04:08:58 INFO - mozprocess == 0.22 04:08:58 INFO - mozprofile == 0.28 04:08:58 INFO - mozrunner == 6.11 04:08:58 INFO - mozscreenshot == 0.1 04:08:58 INFO - mozsystemmonitor == 0.0 04:08:58 INFO - moztest == 0.7 04:08:58 INFO - mozversion == 1.4 04:08:58 INFO - psutil == 3.1.1 04:08:58 INFO - requests == 1.2.3 04:08:58 INFO - wsgiref == 0.1.2 04:08:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:58 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:58 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 04:08:58 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 04:08:58 INFO - Using env: {'DISPLAY': ':0', 04:08:58 INFO - 'HOME': '/home/cltbld', 04:08:58 INFO - 'LANG': 'en_US.UTF-8', 04:08:58 INFO - 'LANGUAGE': 'en_US:en', 04:08:58 INFO - 'LOGNAME': 'cltbld', 04:08:58 INFO - 'MAIL': '/var/mail/cltbld', 04:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:58 INFO - 'MOZ_NO_REMOTE': '1', 04:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:58 INFO - 'NO_EM_RESTART': '1', 04:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:58 INFO - 'PWD': '/builds/slave/test', 04:08:58 INFO - 'SHELL': '/bin/bash', 04:08:58 INFO - 'SHLVL': '1', 04:08:58 INFO - 'TERM': 'linux', 04:08:58 INFO - 'TMOUT': '86400', 04:08:58 INFO - 'USER': 'cltbld', 04:08:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:58 INFO - '_': '/tools/buildbot/bin/python'} 04:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 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)) 04:08:59 INFO - Cleaning up... 04:08:59 INFO - Return code: 0 04:08:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08:59 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')]} 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:59 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')]} 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:59 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:08:59 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 04:08:59 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 04:08:59 INFO - Using env: {'DISPLAY': ':0', 04:08:59 INFO - 'HOME': '/home/cltbld', 04:08:59 INFO - 'LANG': 'en_US.UTF-8', 04:08:59 INFO - 'LANGUAGE': 'en_US:en', 04:08:59 INFO - 'LOGNAME': 'cltbld', 04:08:59 INFO - 'MAIL': '/var/mail/cltbld', 04:08:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:59 INFO - 'MOZ_NO_REMOTE': '1', 04:08:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:59 INFO - 'NO_EM_RESTART': '1', 04:08:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:59 INFO - 'PWD': '/builds/slave/test', 04:08:59 INFO - 'SHELL': '/bin/bash', 04:08:59 INFO - 'SHLVL': '1', 04:08:59 INFO - 'TERM': 'linux', 04:08:59 INFO - 'TMOUT': '86400', 04:08:59 INFO - 'USER': 'cltbld', 04:08:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:08:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:59 INFO - '_': '/tools/buildbot/bin/python'} 04:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:59 INFO - Downloading/unpacking jsonschema 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:01 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:01 INFO - warning: no files found matching '*.txt' 04:09:01 INFO - no previously-included directories found matching 'build' 04:09:01 INFO - no previously-included directories found matching 'dist' 04:09:01 INFO - no previously-included directories found matching '.git*' 04:09:01 INFO - Installing collected packages: jsonschema, functools32 04:09:01 INFO - Running setup.py install for functools32 04:09:01 INFO - warning: no files found matching '*.txt' 04:09:01 INFO - no previously-included directories found matching 'build' 04:09:01 INFO - no previously-included directories found matching 'dist' 04:09:01 INFO - no previously-included directories found matching '.git*' 04:09:01 INFO - Successfully installed jsonschema functools32 04:09:01 INFO - Cleaning up... 04:09:01 INFO - Return code: 0 04:09:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:01 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 0x7f3cfd230f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22945a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, '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': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', '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 04:09:01 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 04:09:01 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 04:09:01 INFO - Using env: {'DISPLAY': ':0', 04:09:01 INFO - 'HOME': '/home/cltbld', 04:09:01 INFO - 'LANG': 'en_US.UTF-8', 04:09:01 INFO - 'LANGUAGE': 'en_US:en', 04:09:01 INFO - 'LOGNAME': 'cltbld', 04:09:01 INFO - 'MAIL': '/var/mail/cltbld', 04:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:01 INFO - 'MOZ_NO_REMOTE': '1', 04:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:01 INFO - 'NO_EM_RESTART': '1', 04:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:01 INFO - 'PWD': '/builds/slave/test', 04:09:01 INFO - 'SHELL': '/bin/bash', 04:09:01 INFO - 'SHLVL': '1', 04:09:01 INFO - 'TERM': 'linux', 04:09:01 INFO - 'TMOUT': '86400', 04:09:01 INFO - 'USER': 'cltbld', 04:09:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:01 INFO - '_': '/tools/buildbot/bin/python'} 04:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:01 INFO - Downloading/unpacking flake8 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 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 04:09:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:04 INFO - no previously-included directories found matching 'docs/_build' 04:09:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:04 INFO - Running setup.py install for pep8 04:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:04 INFO - no previously-included directories found matching 'docs/_build' 04:09:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:04 INFO - Cleaning up... 04:09:04 INFO - Return code: 0 04:09:04 INFO - Running post-action listener: _resource_record_post_action 04:09:04 INFO - Running post-action listener: _start_resource_monitoring 04:09:04 INFO - Starting resource monitoring. 04:09:04 INFO - ##### 04:09:04 INFO - ##### Running install step. 04:09:04 INFO - ##### 04:09:04 INFO - Running pre-action listener: _resource_record_pre_action 04:09:04 INFO - Running main action method: install 04:09:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:05 INFO - Reading from file tmpfile_stdout 04:09:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:05 INFO - Reading from file tmpfile_stdout 04:09:05 INFO - Output received: 04:09:05 INFO - Usage: mozinstall [options] installer 04:09:05 INFO - Options: 04:09:05 INFO - -h, --help show this help message and exit 04:09:05 INFO - -d DEST, --destination=DEST 04:09:05 INFO - Directory to install application into. [default: 04:09:05 INFO - "/builds/slave/test"] 04:09:05 INFO - --app=APP Application being installed. [default: firefox] 04:09:05 INFO - mkdir: /builds/slave/test/build/application 04:09:05 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'] 04:09:05 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 04:09:20 INFO - Reading from file tmpfile_stdout 04:09:20 INFO - Output received: 04:09:20 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:20 INFO - Running post-action listener: _resource_record_post_action 04:09:20 INFO - ##### 04:09:20 INFO - ##### Running run-tests step. 04:09:20 INFO - ##### 04:09:20 INFO - Running pre-action listener: _resource_record_pre_action 04:09:20 INFO - Running main action method: run_tests 04:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:20 INFO - Python 2.7.3 04:09:20 INFO - Return code: 0 04:09:20 INFO - grabbing minidump binary from tooltool 04:09:20 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')]} 04:09:20 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 0x2323410>, '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 0x2324310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23247a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:20 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 04:09:20 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 04:09:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:20 INFO - Return code: 0 04:09:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:21 INFO - Return code: 0 04:09:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:09:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:09:21 INFO - Using env: {'DISPLAY': ':0', 04:09:21 INFO - 'HOME': '/home/cltbld', 04:09:21 INFO - 'LANG': 'en_US.UTF-8', 04:09:21 INFO - 'LANGUAGE': 'en_US:en', 04:09:21 INFO - 'LOGNAME': 'cltbld', 04:09:21 INFO - 'MAIL': '/var/mail/cltbld', 04:09:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:21 INFO - 'MOZ_NO_REMOTE': '1', 04:09:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:21 INFO - 'NO_EM_RESTART': '1', 04:09:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:21 INFO - 'PWD': '/builds/slave/test', 04:09:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:21 INFO - 'SHELL': '/bin/bash', 04:09:21 INFO - 'SHLVL': '1', 04:09:21 INFO - 'TERM': 'linux', 04:09:21 INFO - 'TMOUT': '86400', 04:09:21 INFO - 'USER': 'cltbld', 04:09:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341', 04:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:21 INFO - '_': '/tools/buildbot/bin/python'} 04:09:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:09:22 INFO - mozversion application_buildid: 20160417032814 04:09:22 INFO - mozversion application_changeset: f8c0dd78206cac5a132b164ebacfa8ffbac9713c 04:09:22 INFO - mozversion application_display_name: Nightly 04:09:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:22 INFO - mozversion application_name: Firefox 04:09:22 INFO - mozversion application_remotingname: firefox 04:09:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:09:22 INFO - mozversion application_vendor: Mozilla 04:09:22 INFO - mozversion application_version: 48.0a1 04:09:22 INFO - mozversion platform_buildid: 20160417032814 04:09:22 INFO - mozversion platform_changeset: f8c0dd78206cac5a132b164ebacfa8ffbac9713c 04:09:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:09:22 INFO - mozversion platform_version: 48.0a1 04:09:22 INFO - using testdate: 1460891362 04:09:22 INFO - actual date: 1460891362 04:09:22 INFO - starting webserver on 'localhost:58974' 04:09:22 INFO - SUITE-START | Running 2 tests 04:09:22 INFO - TEST-START | dromaeo_css 04:09:22 INFO - operating with platform_type : linux_ 04:09:22 INFO - Initialising browser for dromaeo_css test... 04:09:22 INFO - TEST-INFO | started process 10848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cAllP/profile http://localhost:58974/getInfo.html) 04:09:27 INFO - PROCESS | 10848 | __metrics Screen width/height:1600/1200 04:09:27 INFO - PROCESS | 10848 | colorDepth:24 04:09:27 INFO - PROCESS | 10848 | Browser inner width/height: 1024/697 04:09:27 INFO - PROCESS | 10848 | __metrics 04:09:28 ERROR - PROCESS | 10848 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:09:29 INFO - TEST-INFO | 10848: exit 0 04:09:29 INFO - Browser initialized. 04:09:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:29 INFO - TEST-INFO | started process 10931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cAllP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:41 INFO - PROCESS | 10931 | RSS: Main: 155209728 04:09:41 INFO - PROCESS | 10931 | 04:10:32 INFO - PROCESS | 10931 | 1460891432430 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] 04:12:44 INFO - PROCESS | 10931 | Cycle 1(1): loaded http://localhost:58974/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58974/tests/dromaeo/cssquery-ext.html) 04:12:45 INFO - PROCESS | 10931 | RSS: Main: 236564480 04:12:45 INFO - PROCESS | 10931 | 04:15:48 INFO - PROCESS | 10931 | Cycle 1(1): loaded http://localhost:58974/tests/dromaeo/cssquery-ext.html (next: http://localhost:58974/tests/dromaeo/cssquery-jquery.html) 04:15:49 INFO - PROCESS | 10931 | RSS: Main: 241606656 04:15:49 INFO - PROCESS | 10931 | 04:18:51 INFO - PROCESS | 10931 | Cycle 1(1): loaded http://localhost:58974/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58974/tests/dromaeo/cssquery-mootools.html) 04:18:51 INFO - PROCESS | 10931 | RSS: Main: 237985792 04:18:51 INFO - PROCESS | 10931 | 04:21:53 INFO - PROCESS | 10931 | Cycle 1(1): loaded http://localhost:58974/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58974/tests/dromaeo/cssquery-prototype.html) 04:21:54 INFO - PROCESS | 10931 | RSS: Main: 238858240 04:21:54 INFO - PROCESS | 10931 | 04:24:57 INFO - PROCESS | 10931 | Cycle 1(1): loaded http://localhost:58974/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58974/tests/dromaeo/cssquery-yui.html) 04:24:57 INFO - PROCESS | 10931 | RSS: Main: 220663808 04:24:57 INFO - PROCESS | 10931 | 04:28:00 INFO - PROCESS | 10931 | Cycle 1(1): loaded http://localhost:58974/tests/dromaeo/cssquery-yui.html (next: http://localhost:58974/tests/dromaeo/cssquery-dojo.html) 04:28:01 INFO - PROCESS | 10931 | RSS: Main: 268664832 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | __start_tp_report 04:28:01 INFO - PROCESS | 10931 | _x_x_mozilla_page_load 04:28:01 INFO - PROCESS | 10931 | _x_x_mozilla_page_load_details 04:28:01 INFO - PROCESS | 10931 | |i|pagename|runs| 04:28:01 INFO - PROCESS | 10931 | |0;dojo.html;2609.6085587161924;2648.059938721755;2682.396460796321;2693.7171596982316;2706.391062011048;4524.954750452503;4619.745913974734;4633.860984170472;4634.050019745952;4637.304404339351;4552.567506086916;4725.054989002205;4785.736784476852;4790.06593714225;4803.615710743141;4241.575842415757;4255.787100676308;4262.829486820523;4290.249206388885;4336.956630433702;4356.912861742763;4360.062586543892;4394.055278115205;4432.601065904068;4433.13553856998;4141.482314710661;4207.368894665794;4347.847825326098;4352.630026447756;4426.645868330542;4250.447441832573;4281.336392859112;4293.635041021517;4296.076343586144;4299.204647140289;4242.554531774181;4256.723312984646;4270.743755374688;4272.572742725733;4278.871633850989;4527.320901864714;4584.106099310636;4586.724796512187;4591.242444996572;4634.582887540104;5022.824201152942;5029.3964724232965;5032.370953630796;5034.395872495287;5075.8984820303385;4832;4989.226669866177;5047.697138171721;5061.519155680205;5061.569766569846;4704.670673052922;4712.929306060412;4719.433667959798;4725.385699859065;4774.236122220428;5142.665726727825;5146.202338637517;5165.431802501722;5170.3278573785165;5174.508421699932;4720.598749106364;4849.854504364875;4897.461279259279;4941.03649788295;5018.422881368616;4843.612510999182;4870.975645121752;4871.829485968045;4898.681585696918;4935.284383764334;4831.685940413862;4845;4863.683860549053;4877.6585639004925;4935.383077115361;4735.289706544046;4813.422389313235;4813.518648135158;4817.229243321122;4870.82952096682;4169.187008533307;4201.117765269267;4208.978955105266;4229.80965856531;4241.363795430649;3703.037210325335;3709.3694072007825;3712.88861334155;3727.3663477208397;3743.831527581211;4161.854335098257;4309.224339618836;4313.223619748475;4322.330038843984;4346.2828633275785;5009.724465154379;5036.32009678696;5055.646104772631;5059.747012649353;5108.131617625013;4311.479988827252;4325.480942286946;4327.0480494291205;4367.934480982788;4372.978135109304;4308.719933204332;4393.275109606879;4475.597196252353;4525.117602067631;4528.547145285445;4765.666403351732;4765.95234047669;4776.904461910812;4784.186688262934;4801.327814106098;5037.974810125926;5038.722870242172;5042.3949126103635;5042.495750424928;5091.847244582668;4556.066006468733;4726.550977657117;4770.117528257145;4792.137415265286;4812.25410061441;4913.828016019422;4927.901441971212;4939.60396039604;4939.703617782944;5003.374578177728;4985.8005679772405;5004.749762511933;5012.824551140692;5015.097282489041;5063.797448102035;4661.766911654471;4794.400699912511;4855.344528488608;4881.829135980223;4904.730239836843;4862.610991120631;4879.56083952446;4902.852914412573;4911.435184953633;4957.504249575014;4648.395708557866;4812.205986012269;4837.129316722883;4839;4892.608591312757;4819.180739274261;4862.902741945212;4864.975675121602;4915.361003069578;4917.483664215206;4716.905661886812;4724.574788269072;4760.666753327234;4764.285357196448;4812.25410061441 04:28:01 INFO - PROCESS | 10931 | |1;ext.html;600.9519238460923;618.0482057631247;624.2446639566125;629.6316654756966;629.9433051025406;36535.26929461409;37846.24307513852;37865.43201851974;38054.429183562235;38089.809550952275;41131.794341028326;41990;42017.15965680692;42026.57973420265;42037.57962420375;7191.101112360955;7727.8068048298965;7913.248241417056;7939.880901786478;9363.719088427359;9504.714858554255;9659.613615455373;9660.661876834312;9663.468509232025;9666.903330966707;9909.207263418944;10006.749831254205;10007.29948903577;10008.549615267331;10010.34932729374;7381.188069312371;9692.95153524235;9868.555914983806;10062.798744025078;10077.546510406975;9507.952460237724;9658.75853103678;9665.178459830922;9668.419894806264;9674.08096230857;36472.63527364719;37136.44295335572;37166.25667486635;37212.81393593042;37227.25545489075;3198;3213.293075523381;3231.5475833383343;3253.7071663550396;3261.8858339957987;28749;28910.855445722846;29413.411731765245;29424;29475.557866631803;3466.1717362206628;3511.5961664408665;3526.365254254233;3535.045537704805;3546.929061418783;165452.17273913554;166349.6730065404;166500.16749916173;167078;167554;47677.284840727414;47749;48181;48185.277220841715;48196.7590162047;48552.75723621359;63335.6833215831;65589.34410655928;65641.01538476927;65657.67171164113;14733.55799326022;15032.17323047221;15034;15035.849641503444;15047.473338433321;9734.269929755155;11280.435978201058;11546.422678866023;11550.59572914944;11570.479328430241;18043.909780451013;18296.54258643518;18329.90835045816;18341.3580524681;18379.72430413545;6647.437852104751;6949.791506254821;7036.401905837959;7045.859082818418;7194.568325900463;871.6208449324438;904.1591320072264;913.6117150211134;990.5681551790337;1019.607451131305;26952.326191844968;28235.294117647223;28607.57088643672;28857.85571072173;28888.566671499946;961.4375590279765;997.0229175407995;1021.5862575656871;1035.1977217656226;1108.645233525264;14400.855991439952;15036.849631503765;15072.321745521478;15299.15854627984;15314.310856011283;319151;324749;325200;325205;326164;45325;45918.540814591426;46062.539374606495;46082.53917460849;46125.53874461279;1121.377635412354;1148.6439203846835;1208.10600155884;1236.9010479161825;1276.234259444326;24400.6339904898;25558.361040974123;26145.73854261433;26320.605190922535;26425.471490570464;35725.64274357223;36207.456888146175;36285;36309.27381452409;36382.63617363898;222191;222515;222718;222787;223781;22122.889385552968;24657.260282191564;25575.547301114857;25634.615480768178;25843.224703258933;38785.4182187273;39133.804330978164;39265;39530.40704389379;40144;33359.49960750639;33465.16337091495;33726;34258.48612270768;34396;32674.83662581767;32864.50703239405;33322.500162498065;33431.66568334286;33739.83130084334;33559.32881342409;34006.65993340035;34022.31955360928;34133.65866341305;34552.82723586366;29555.556666649587;31468.37063258676;32533.34933301368;32573;33185.50221746627;22802.65796013028;23148.884255578614;23643.40891477727;23780.762192377853;24754.7453858456 04:28:01 INFO - PROCESS | 10931 | |2;jquery.html;377.3829142125991;380.72017067455414;388.44646378910045;389.6532086443065;399.81009020715146;15742.212889355544;16510.174491275448;16590;16609.667806643858;16610.916945415287;15422.305996230169;15812.683746325067;16027.759583606256;16113.194340282967;16123.83876161238;4649.232876575361;4774.665773395864;4810.4948980357085;4810.68730532516;4817.566419022287;3434.9484757728655;4450.109978004396;4620.491745907947;4621.8844528886875;4622.9768851155695;4566.40636717228;4596.49438561758;4599.310103484488;4603.493615702287;4604.033153037866;4601.562851529099;4637.721736695792;4652.930206046912;4708.364370809931;4773.976130119345;4866.537678920497;5172.379314482248;5182.585393168538;5182.611304152204;5243.4232234454175;12673.873261267454;16060.75908861368;19513.121909513964;20146.899265503725;20161.596768064555;1885.2364792259157;1918.827305542508;2020.9191632334837;2025.0381068992258;2440.707115146176;9006.819863602692;10405.47972601367;12966;13107.820296173295;13352.799708004388;1747.720364741648;1757.490327804935;1813.1115753280928;1853.3513270355268;1853.4532312967572;64320;64808;65314.67342663304;65526.1539692145;65717;9950.35322704022;10260.486975651187;10284.897151028394;10387.636432724817;10403.895961040444;14214.85785142156;14232.644183895485;14259.21574313402;14278.07192532482;14284.285785710674;7192.496525243288;7311.122665280094;7316;7425.62871856405;7431.405487560982;6756.560823546453;6796.150481189851;6911.17065952089;6948.270431604608;6949.617771022541;4351.760653164043;4410.845620403271;4450.287953927421;4458.130664520388;4538.9546104539195;1718.3642052440678;1754.8332908373684;1813.836754692084;1815.4372144635206;1910.6274276516224;824.3528829868525;869.9695510657097;885.7121435533348;924.5746956399997;993;15964.12197329158;16368.508944731677;16427.91786041086;16656.250468728937;16680.58298542522;893.5666201892077;897.3090720145451;918.2929144558652;945.9432434053979;964.7732782796037;8970.730878073668;9287.303452241109;9323.25413966881;9438.197753190918;9452.196563292197;377893;384299;391106;392784;393173;79006.20993790103;79296.60351698204;79794;80803.5959820209;81297.59351203206;840.7099550655014;910.2626872233379;923.3398120343852;947.8341290274175;950.3585080070925;12409.565665201675;14063.859361406256;14300;14397.208153551237;14614.269286535418;32694.67305326916;32733;33045.66954330426;34034.489482657285;34466.138346541535;38231.426528601536;39023.414648779726;39772.40341394823;40070.799646001586;41925.580744192164;7058;7070.7525236616475;7126.928730712834;7205.603691797001;7246.202917678946;8270.586470676562;10378.792424151323;10454.529546170288;10590.311629744043;10786.946065269623;6312.715927783169;8714.956425218086;9140.954295228481;9194.770130746785;9478.857817132886;9387.577559009724;9441.52792360393;9482.478463684563;9534.570944307385;9708.514574271117;9637.325387222827;9770.606201480683;9813.460259685786;9886.357386769838;9912.35569687968;6922.757703480354;7388.889166662612;7404.518706284074;7585.431092667962;7607.847843043219;8661.610227539903;8787.824243514966;9154.450732955778;9339.299552533452;9507.477088760184 04:28:01 INFO - PROCESS | 10931 | |3;mootools.html;1214.5445457953267;1448.630599197205;1478.50470092519;1626.8617167540765;1818.2545156485835;7503.924960750391;7549.35830454412;7551.395888328934;7560.96219518903;7566.621668916559;7303.379212766921;7444.739434119807;7463.813404664873;7465.440091993095;7470.2903224193615;1892.9716054259197;2173.1850556041486;2177.9019944102474;2195.3523710505438;2253.785890340415;2241.3724157236;2252.1441852096264;2269.5120549081944;2269.9886500567472;2270.5004898922293;2139.711138996239;2220.4670878989086;2224.410531209223;2224.788645078723;2227.5878962392007;1870.1677753399742;2177.107385971744;2232.0960011195493;2235.3182279404773;2235.3629215673454;2055.7533096028574;2071.0887209627867;2077.6052550015447;2080.698298746673;2083.3020937985643;7576.0908690956885;7601.125870524905;7614.162442131416;7669.118051424102;7670.386369090459;4561.931571026437;4728.054389122155;4739.976300118512;4741.786619602126;4781.043791241766;2988.6114805075417;2996.4306781711625;3042.8478576071107;3073.5082386818226;3074.7540196784203;1013.6806905824716;1037.3309215556;1054.3199636234663;1803.6573051120245;1892.81071892811;10379.688609341732;10409.219308551814;10437.32157409766;10476.68569942903;10504.737381565446;3971.0667993021616;4128.0711839836395;4226.429432026698;4273.9358909616385;4275.5296917339065;8242.876356854653;8296.792580185544;8317.708880189164;8328.167183281745;8343.582820858932;3999;4672.6962747421985;4684.578387945033;4687.765611719468;4696.9060618787435;3828.2152158807376;3832.2335532893535;3849.942250866239;4177.56135605757;4335.1329734053315;3419.9316013679586;3466.116140384236;3501;3524.9118772030392;3590.2460483298278;1078.7249251440833;1085.2837127495816;1085.3270971997254;1090.8472813806075;1104.3539529375246;797.7606717984581;832.9625166867505;844.2317491083085;858.5192292316323;876.3471213945651;5231.581473482112;5316.946830531645;5451.373092094381;5470.015397228537;5499.835004949858;852.1435956863313;860.7934095816959;865.8138500222483;906.0803284666069;928.5821380378857;3668.2296717689583;3724.7392682511963;3743.9251214975548;3753.174301653632;3771.4719939208535;9069.093090690878;9352.812943741086;9443.811123777487;9444.0555944405;9446.85829712555;9289.442633442015;9339.486328252011;9341.532923353805;9347.065293470598;9347.859782103274;7052.717891284291;7358.337749602561;7388.187299397062;7388.891666250105;7430.777076687708;5461.644993075437;5538.556915446835;5580.2466666999435;5640.915386269291;5696.11710184922;8690.391672583111;8696.521691306785;8795.780105497413;9028.458292502472;9044.683436079706;8872.73381798547;9046.095390461165;9072;9150.40522366044;9171.678991235274;6086.421789929949;6277.937220627918;6283.874322513433;6610.867782644416;6739.292374300628;6912.93087069143;7276.527025743309;7438.70245190208;7452.962735186289;7486.139094004041;6685;6799.354061364163;6865.313468653095;6934.791956241321;6958.860822783415;6781.525293229624;6808.183018037867;6877.552959057645;6900.551464154814;6974.302569742985;6152.846178845564;6157.1072194532435;6232.75068997235;6235.688215589294;6405.0392441132335;4730.621550276039;4754.690945088558;4771.5467030632035;4840.806367745392;4852.102361063215;4902.3872015998;4913.1893237615395;4956.231784073474;5009.423916249678;5037.244413337882 04:28:01 INFO - PROCESS | 10931 | |4;prototype.html;315.4400938334456;317.38269066665333;321.07850469153533;322.234692605063;322.5645378738702;5006.148954677705;5056.873578160543;5064.08846407646;5072.84781456556;5138.100832354332;5104.234364845275;5108.2848401223855;5108.923366149511;5113.769880355384;5121.462246464123;3810.5236845394256;3935.60643935607;3979.5025621797276;3981.880543583697;3983.382575700771;3681.7193542800974;3951.3677811550156;3998.600139985993;3999.3401088820456;4057.2696914555368;3972.6424621784035;3984;3992.201559688074;3995.920081598381;4024;3791.374423220165;3908.1988192420486;4016.7389119707127;4024.094578719794;4026.2350153470748;3578.8568457261676;3579.874704385334;3585.15748799032;3596.4425514045365;3602;4832.9758351208375;4854.805807767685;4875.8781030474165;4882.829100981448;4924.384451943507;4550.817967281305;4636.420447444069;4637.489876113625;4645.094206629708;4647.372604698357;5361.115415956401;5365.570754339644;5366.865828354284;5367.704776237305;5375.75809088592;3912.4913761211146;3919.608039196086;3926.509186351706;3930.960690393088;3932.9803350983348;5195.584353251768;5337.786488540453;5564.248826408423;5634.887302253973;5654.208410822488;3963.1083006323925;3980.601939805996;3982.356144128148;4005.2189822984237;4010.63904248619;4066.3900414938;4071.7353372030725;4080.1227736036303;4089.5297040840683;4092.3452247640234;4593.609543188866;4608.815647374135;4614.377059097046;4616.907661846812;4624.375709279271;5178.352705911761;5300;5344.278522399504;5351.973240133774;5368.3826359968325;1410.6825964157983;1422.665673566711;1429.7712366021387;1435.7056803355288;1436.0522055443357;952.937474715687;977.0424983516194;987.4618333008384;995.5470261031213;996.800639872014;4655.720656760605;4675.368825208553;4679.27471241958;4685.812567497262;4706.129366067288;5522.144067669517;5522.66863988162;5529.778808847682;5530.483629948364;5557.221988921554;4536.7996521686955;4612.3542704021465;4613.884652883705;4649.163150632919;4707.270373092176;2958.4970555005702;2971.3463038131576;2971.881124755029;2984.224101733565;2987.746041586446;5206.297149884793;5212.478752124833;5213.661112027782;5214.070793806316;5228.738563071831;5556.777728890799;5609.971950140223;5672.404397538282;5673.120666296731;5676.44559948025;4992.201247800334;5069.6451248413;5194.11700010999;5216.843494695166;5227.163653815372;5524.861878453071;5566.443355664401;5572.331320241597;5574.804881829116;5576.972115139399;5461.750258596129;5468.781248750005;5472.644278121909;5473.31583552056;5482;5068.366454193226;5235.110031294766;5236.842894713165;5242.213667949838;5256.684598924076;3993.201359728008;4013.7792421415934;4016.7991600420446;4020.83916643331;4025.3358195898522;5552.167174923794;5574.581906357121;5576.247206627054;5576.358718747396;5584.804531841366;5139.306193663808;5401.945980540301;5402.270693456333;5403.946230485018;5406.513413792777;5293.12663410533;5350.170723537858;5368.302120724437;5381.434949330264;5382.67703937765;5207.869803254949;5288.497592728685;5306.283651707125;5313.840584782462;5335.946640533545;5380.515753582196;5410.053240682786;5448.591355648263;5452.727363631882;5462.453754624506;5273.6572122811895;5281.8679533010445;5303.549198318032;5307.336582927134;5310.840674779763 04:28:01 INFO - PROCESS | 10931 | |5;yui.html;663.767681311541;728.8724473217189;730.9364874108173;733.3106879533238;763.8930549723036;11545.884541154586;11846.940765296173;11864.110191735612;11883.643490695282;11918;11132.721681957955;11137.72155696106;11157.66527004191;11244.044256238209;11248.043916267126;640.2509064394658;779.5322806316193;818.5293456262643;819.3690858039306;819.6024927909959;789.8578255913933;798.9800254993613;803.1045384396385;806.802333428308;807.0355924670022;674.5076094451053;848.4485084694936;866.1035827918106;866.1295398124876;866.3978534918234;835.3692961813822;860.6256278518833;860.7030574451804;860.8235311761074;861.9353548483826;621.934696856828;626.0546574672278;626.2047200055904;629.6883042893751;632.5508888689036;11034.558617655284;11087.33475991443;11098.167637427225;11125.666230013112;11170.329780213213;12298.815517767242;12607;12657.810132848015;13163.210207387492;13165.407556659973;9947.452890091043;10259.79480410395;10310.948445257725;10329;10470.319429237075;3348.7655864089525;3404.6254911959663;3451.861925522976;3511.122219445139;3515.753897227195;41425.79287103545;42139;42770.358444623045;42961.57038429607;43118.13763724739;9627.326087173831;9894.505274736235;9954.619967214403;9956.751081223027;10065.094141527297;17967.64064718698;17970.19134138967;18133.54666133331;18147.09264536768;18185;6910.654467276616;6972.1981972072845;7046;7088.326608972139;7118.679659415338;3544.113971507123;3590.982045089758;3624.619414961444;3727.347714150013;3739.794311312904;2929.868155932988;3200.3599280144063;3353.7652364334263;3361.680640339164;3363.899083027513;511.910415677255;566.4165909113619;576.8529025098572;597.7011494252873;600.6096037575611;517.1054076447691;545.4354742841141;549.2228496677156;591.4135876279425;604.1632339210138;7684.46208765381;7774.494657847222;7793.454458187985;8066.919330806734;8161.714339998071;615.6244690738646;618.2766163588612;622.3247776162824;640.2029473305764;657.1719633262124;3985.3000412752863;4084.244414783275;4155.085881106152;4205.074883525619;4239.215745087169;51894.48105518972;52935;52973.205401919;53549.73225133849;53596.464035359924;45137.32294015592;45384;45579.544204558195;45889.08221835545;45931.77034114808;41876.790616046725;42527.574724252365;42653.57346426496;42901.996860219486;44281.33577996268;8415.11641277657;8549.316054715733;8578.571071446278;8596.957015214884;8637.481751094954;29588.704112958596;29796.255093622833;29998.70001299959;30048.2956533913;30532.694673053873;37334.066648332926;38669.61330386773;40461.19077618372;40539;40973.1805363897;10817.945910270399;11008.889911100787;11061.11511079128;11169.944150279196;11173;9908.405495670282;11711.824322634997;11850.288982660722;12594.370281485706;12598.55905043319;8916.643334266817;11516.366599837089;11551;11598.130140239347;11739.941300293443;11149.331040137618;11322.547098115983;11597.884021160018;12050.698732531757;12121.878781212428;10630;11089.112870970464;11257.71855703614;11734.061275097802;11750.059995200534;9578.664746733832;9623.759406014626;9816.754581135243;10020.549075291483;10137.239707021856;9425.151736343762;9678.51607419612;9772.560234789593;9904.7562443353;10130.189584833342 04:28:01 INFO - PROCESS | 10931 | __end_tp_report 04:28:01 INFO - PROCESS | 10931 | __start_cc_report 04:28:01 INFO - PROCESS | 10931 | _x_x_mozilla_cycle_collect,912 04:28:01 INFO - PROCESS | 10931 | __end_cc_report 04:28:01 INFO - PROCESS | 10931 | __startTimestamp1460892481125__endTimestamp 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | ------- Summary: start ------- 04:28:01 INFO - PROCESS | 10931 | Number of tests: 6 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | [#0] dojo.html Cycles:165 Average:4613.00 Median:4765.95 stddev:474.86 (10.0%) stddev-sans-first:449.56 04:28:01 INFO - PROCESS | 10931 | Values: 2609.6 2648.1 2682.4 2693.7 2706.4 4525.0 4619.7 4633.9 4634.1 4637.3 4552.6 4725.1 4785.7 4790.1 4803.6 4241.6 4255.8 4262.8 4290.2 4337.0 4356.9 4360.1 4394.1 4432.6 4433.1 4141.5 4207.4 4347.8 4352.6 4426.6 4250.4 4281.3 4293.6 4296.1 4299.2 4242.6 4256.7 4270.7 4272.6 4278.9 4527.3 4584.1 4586.7 4591.2 4634.6 5022.8 5029.4 5032.4 5034.4 5075.9 4832.0 4989.2 5047.7 5061.5 5061.6 4704.7 4712.9 4719.4 4725.4 4774.2 5142.7 5146.2 5165.4 5170.3 5174.5 4720.6 4849.9 4897.5 4941.0 5018.4 4843.6 4871.0 4871.8 4898.7 4935.3 4831.7 4845.0 4863.7 4877.7 4935.4 4735.3 4813.4 4813.5 4817.2 4870.8 4169.2 4201.1 4209.0 4229.8 4241.4 3703.0 3709.4 3712.9 3727.4 3743.8 4161.9 4309.2 4313.2 4322.3 4346.3 5009.7 5036.3 5055.6 5059.7 5108.1 4311.5 4325.5 4327.0 4367.9 4373.0 4308.7 4393.3 4475.6 4525.1 4528.5 4765.7 4766.0 4776.9 4784.2 4801.3 5038.0 5038.7 5042.4 5042.5 5091.8 4556.1 4726.6 4770.1 4792.1 4812.3 4913.8 4927.9 4939.6 4939.7 5003.4 4985.8 5004.7 5012.8 5015.1 5063.8 4661.8 4794.4 4855.3 4881.8 4904.7 4862.6 4879.6 4902.9 4911.4 4957.5 4648.4 4812.2 4837.1 4839.0 4892.6 4819.2 4862.9 4865.0 4915.4 4917.5 4716.9 4724.6 4760.7 4764.3 4812.3 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | [#1] ext.html Cycles:180 Average:40263.99 Median:33642.66 stddev:64532.05 (191.8%) stddev-sans-first:64644.36 04:28:01 INFO - PROCESS | 10931 | Values: 601.0 618.0 624.2 629.6 629.9 36535.3 37846.2 37865.4 38054.4 38089.8 41131.8 41990.0 42017.2 42026.6 42037.6 7191.1 7727.8 7913.2 7939.9 9363.7 9504.7 9659.6 9660.7 9663.5 9666.9 9909.2 10006.7 10007.3 10008.5 10010.3 7381.2 9693.0 9868.6 10062.8 10077.5 9508.0 9658.8 9665.2 9668.4 9674.1 36472.6 37136.4 37166.3 37212.8 37227.3 3198.0 3213.3 3231.5 3253.7 3261.9 28749.0 28910.9 29413.4 29424.0 29475.6 3466.2 3511.6 3526.4 3535.0 3546.9 165452.2 166349.7 166500.2 167078.0 167554.0 47677.3 47749.0 48181.0 48185.3 48196.8 48552.8 63335.7 65589.3 65641.0 65657.7 14733.6 15032.2 15034.0 15035.8 15047.5 9734.3 11280.4 11546.4 11550.6 11570.5 18043.9 18296.5 18329.9 18341.4 18379.7 6647.4 6949.8 7036.4 7045.9 7194.6 871.6 904.2 913.6 990.6 1019.6 26952.3 28235.3 28607.6 28857.9 28888.6 961.4 997.0 1021.6 1035.2 1108.6 14400.9 15036.8 15072.3 15299.2 15314.3 319151.0 324749.0 325200.0 325205.0 326164.0 45325.0 45918.5 46062.5 46082.5 46125.5 1121.4 1148.6 1208.1 1236.9 1276.2 24400.6 25558.4 26145.7 26320.6 26425.5 35725.6 36207.5 36285.0 36309.3 36382.6 222191.0 222515.0 222718.0 222787.0 223781.0 22122.9 24657.3 25575.5 25634.6 25843.2 38785.4 39133.8 39265.0 39530.4 40144.0 33359.5 33465.2 33726.0 34258.5 34396.0 32674.8 32864.5 33322.5 33431.7 33739.8 33559.3 34006.7 34022.3 34133.7 34552.8 29555.6 31468.4 32533.3 32573.0 33185.5 22802.7 23148.9 23643.4 23780.8 24754.7 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | [#2] jquery.html Cycles:180 Average:23465.44 Median:4621.19 stddev:63999.99 (1384.9%) stddev-sans-first:64156.05 04:28:01 INFO - PROCESS | 10931 | Values: 377.4 380.7 388.4 389.7 399.8 15742.2 16510.2 16590.0 16609.7 16610.9 15422.3 15812.7 16027.8 16113.2 16123.8 4649.2 4774.7 4810.5 4810.7 4817.6 3434.9 4450.1 4620.5 4621.9 4623.0 4566.4 4596.5 4599.3 4603.5 4604.0 4601.6 4637.7 4652.9 4708.4 4774.0 4866.5 5172.4 5182.6 5182.6 5243.4 12673.9 16060.8 19513.1 20146.9 20161.6 1885.2 1918.8 2020.9 2025.0 2440.7 9006.8 10405.5 12966.0 13107.8 13352.8 1747.7 1757.5 1813.1 1853.4 1853.5 64320.0 64808.0 65314.7 65526.2 65717.0 9950.4 10260.5 10284.9 10387.6 10403.9 14214.9 14232.6 14259.2 14278.1 14284.3 7192.5 7311.1 7316.0 7425.6 7431.4 6756.6 6796.2 6911.2 6948.3 6949.6 4351.8 4410.8 4450.3 4458.1 4539.0 1718.4 1754.8 1813.8 1815.4 1910.6 824.4 870.0 885.7 924.6 993.0 15964.1 16368.5 16427.9 16656.3 16680.6 893.6 897.3 918.3 945.9 964.8 8970.7 9287.3 9323.3 9438.2 9452.2 377893.0 384299.0 391106.0 392784.0 393173.0 79006.2 79296.6 79794.0 80803.6 81297.6 840.7 910.3 923.3 947.8 950.4 12409.6 14063.9 14300.0 14397.2 14614.3 32694.7 32733.0 33045.7 34034.5 34466.1 38231.4 39023.4 39772.4 40070.8 41925.6 7058.0 7070.8 7126.9 7205.6 7246.2 8270.6 10378.8 10454.5 10590.3 10786.9 6312.7 8715.0 9141.0 9194.8 9478.9 9387.6 9441.5 9482.5 9534.6 9708.5 9637.3 9770.6 9813.5 9886.4 9912.4 6922.8 7388.9 7404.5 7585.4 7607.8 8661.6 8787.8 9154.5 9339.3 9507.5 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | [#3] mootools.html Cycles:180 Average:5108.26 Median:5274.26 stddev:2774.17 (52.6%) stddev-sans-first:2766.52 04:28:01 INFO - PROCESS | 10931 | Values: 1214.5 1448.6 1478.5 1626.9 1818.3 7503.9 7549.4 7551.4 7561.0 7566.6 7303.4 7444.7 7463.8 7465.4 7470.3 1893.0 2173.2 2177.9 2195.4 2253.8 2241.4 2252.1 2269.5 2270.0 2270.5 2139.7 2220.5 2224.4 2224.8 2227.6 1870.2 2177.1 2232.1 2235.3 2235.4 2055.8 2071.1 2077.6 2080.7 2083.3 7576.1 7601.1 7614.2 7669.1 7670.4 4561.9 4728.1 4740.0 4741.8 4781.0 2988.6 2996.4 3042.8 3073.5 3074.8 1013.7 1037.3 1054.3 1803.7 1892.8 10379.7 10409.2 10437.3 10476.7 10504.7 3971.1 4128.1 4226.4 4273.9 4275.5 8242.9 8296.8 8317.7 8328.2 8343.6 3999.0 4672.7 4684.6 4687.8 4696.9 3828.2 3832.2 3849.9 4177.6 4335.1 3419.9 3466.1 3501.0 3524.9 3590.2 1078.7 1085.3 1085.3 1090.8 1104.4 797.8 833.0 844.2 858.5 876.3 5231.6 5316.9 5451.4 5470.0 5499.8 852.1 860.8 865.8 906.1 928.6 3668.2 3724.7 3743.9 3753.2 3771.5 9069.1 9352.8 9443.8 9444.1 9446.9 9289.4 9339.5 9341.5 9347.1 9347.9 7052.7 7358.3 7388.2 7388.9 7430.8 5461.6 5538.6 5580.2 5640.9 5696.1 8690.4 8696.5 8795.8 9028.5 9044.7 8872.7 9046.1 9072.0 9150.4 9171.7 6086.4 6277.9 6283.9 6610.9 6739.3 6912.9 7276.5 7438.7 7453.0 7486.1 6685.0 6799.4 6865.3 6934.8 6958.9 6781.5 6808.2 6877.6 6900.6 6974.3 6152.8 6157.1 6232.8 6235.7 6405.0 4730.6 4754.7 4771.5 4840.8 4852.1 4902.4 4913.2 4956.2 5009.4 5037.2 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | [#4] prototype.html Cycles:180 Average:4470.31 Median:5071.25 stddev:1279.20 (25.2%) stddev-sans-first:1244.19 04:28:01 INFO - PROCESS | 10931 | Values: 315.4 317.4 321.1 322.2 322.6 5006.1 5056.9 5064.1 5072.8 5138.1 5104.2 5108.3 5108.9 5113.8 5121.5 3810.5 3935.6 3979.5 3981.9 3983.4 3681.7 3951.4 3998.6 3999.3 4057.3 3972.6 3984.0 3992.2 3995.9 4024.0 3791.4 3908.2 4016.7 4024.1 4026.2 3578.9 3579.9 3585.2 3596.4 3602.0 4833.0 4854.8 4875.9 4882.8 4924.4 4550.8 4636.4 4637.5 4645.1 4647.4 5361.1 5365.6 5366.9 5367.7 5375.8 3912.5 3919.6 3926.5 3931.0 3933.0 5195.6 5337.8 5564.2 5634.9 5654.2 3963.1 3980.6 3982.4 4005.2 4010.6 4066.4 4071.7 4080.1 4089.5 4092.3 4593.6 4608.8 4614.4 4616.9 4624.4 5178.4 5300.0 5344.3 5352.0 5368.4 1410.7 1422.7 1429.8 1435.7 1436.1 952.9 977.0 987.5 995.5 996.8 4655.7 4675.4 4679.3 4685.8 4706.1 5522.1 5522.7 5529.8 5530.5 5557.2 4536.8 4612.4 4613.9 4649.2 4707.3 2958.5 2971.3 2971.9 2984.2 2987.7 5206.3 5212.5 5213.7 5214.1 5228.7 5556.8 5610.0 5672.4 5673.1 5676.4 4992.2 5069.6 5194.1 5216.8 5227.2 5524.9 5566.4 5572.3 5574.8 5577.0 5461.8 5468.8 5472.6 5473.3 5482.0 5068.4 5235.1 5236.8 5242.2 5256.7 3993.2 4013.8 4016.8 4020.8 4025.3 5552.2 5574.6 5576.2 5576.4 5584.8 5139.3 5401.9 5402.3 5403.9 5406.5 5293.1 5350.2 5368.3 5381.4 5382.7 5207.9 5288.5 5306.3 5313.8 5335.9 5380.5 5410.1 5448.6 5452.7 5462.5 5273.7 5281.9 5303.5 5307.3 5310.8 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - PROCESS | 10931 | [#5] yui.html Cycles:180 Average:12759.28 Median:42711.97 stddev:14280.74 (33.4%) stddev-sans-first:14291.91 04:28:01 INFO - PROCESS | 10931 | Values: 663.8 728.9 730.9 733.3 763.9 11545.9 11846.9 11864.1 11883.6 11918.0 11132.7 11137.7 11157.7 11244.0 11248.0 640.3 779.5 818.5 819.4 819.6 789.9 799.0 803.1 806.8 807.0 674.5 848.4 866.1 866.1 866.4 835.4 860.6 860.7 860.8 861.9 621.9 626.1 626.2 629.7 632.6 11034.6 11087.3 11098.2 11125.7 11170.3 12298.8 12607.0 12657.8 13163.2 13165.4 9947.5 10259.8 10310.9 10329.0 10470.3 3348.8 3404.6 3451.9 3511.1 3515.8 41425.8 42139.0 42770.4 42961.6 43118.1 9627.3 9894.5 9954.6 9956.8 10065.1 17967.6 17970.2 18133.5 18147.1 18185.0 6910.7 6972.2 7046.0 7088.3 7118.7 3544.1 3591.0 3624.6 3727.3 3739.8 2929.9 3200.4 3353.8 3361.7 3363.9 511.9 566.4 576.9 597.7 600.6 517.1 545.4 549.2 591.4 604.2 7684.5 7774.5 7793.5 8066.9 8161.7 615.6 618.3 622.3 640.2 657.2 3985.3 4084.2 4155.1 4205.1 4239.2 51894.5 52935.0 52973.2 53549.7 53596.5 45137.3 45384.0 45579.5 45889.1 45931.8 41876.8 42527.6 42653.6 42902.0 44281.3 8415.1 8549.3 8578.6 8597.0 8637.5 29588.7 29796.3 29998.7 30048.3 30532.7 37334.1 38669.6 40461.2 40539.0 40973.2 10817.9 11008.9 11061.1 11169.9 11173.0 9908.4 11711.8 11850.3 12594.4 12598.6 8916.6 11516.4 11551.0 11598.1 11739.9 11149.3 11322.5 11597.9 12050.7 12121.9 10630.0 11089.1 11257.7 11734.1 11750.1 9578.7 9623.8 9816.8 10020.5 10137.2 9425.2 9678.5 9772.6 9904.8 10130.2 04:28:01 INFO - PROCESS | 10931 | -------- Summary: end -------- 04:28:01 INFO - PROCESS | 10931 | 04:28:01 INFO - TEST-INFO | 10931: exit 0 04:28:01 INFO - TEST-OK | dromaeo_css | took 1119929ms 04:28:01 INFO - TEST-START | kraken 04:28:01 INFO - operating with platform_type : linux_ 04:28:01 INFO - Initialising browser for kraken test... 04:28:01 INFO - TEST-INFO | started process 11108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYGaQWB/profile http://localhost:58974/getInfo.html) 04:28:06 INFO - PROCESS | 11108 | __metrics Screen width/height:1600/1200 04:28:06 INFO - PROCESS | 11108 | colorDepth:24 04:28:06 INFO - PROCESS | 11108 | Browser inner width/height: 1024/697 04:28:06 INFO - PROCESS | 11108 | __metrics 04:28:07 ERROR - PROCESS | 11108 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:28:08 INFO - TEST-INFO | 11108: exit 0 04:28:08 INFO - Browser initialized. 04:28:08 INFO - Running cycle 1/1 for kraken test... 04:28:08 INFO - TEST-INFO | started process 11187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYGaQWB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:20 INFO - PROCESS | 11187 | RSS: Main: 154800128 04:28:20 INFO - PROCESS | 11187 | 04:28:23 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58974/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:24 INFO - PROCESS | 11187 | RSS: Main: 210132992 04:28:24 INFO - PROCESS | 11187 | 04:28:27 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58974/tests/kraken/driver.html?testName=audio-dft) 04:28:27 INFO - PROCESS | 11187 | RSS: Main: 195362816 04:28:27 INFO - PROCESS | 11187 | 04:28:30 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58974/tests/kraken/driver.html?testName=audio-fft) 04:28:31 INFO - PROCESS | 11187 | RSS: Main: 266756096 04:28:31 INFO - PROCESS | 11187 | 04:28:33 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58974/tests/kraken/driver.html?testName=audio-oscillator) 04:28:34 INFO - PROCESS | 11187 | RSS: Main: 174587904 04:28:34 INFO - PROCESS | 11187 | 04:28:36 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58974/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:37 INFO - PROCESS | 11187 | RSS: Main: 178700288 04:28:37 INFO - PROCESS | 11187 | 04:28:40 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58974/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:40 INFO - PROCESS | 11187 | RSS: Main: 214507520 04:28:40 INFO - PROCESS | 11187 | 04:28:44 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58974/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:44 INFO - PROCESS | 11187 | RSS: Main: 215048192 04:28:44 INFO - PROCESS | 11187 | 04:28:47 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58974/tests/kraken/driver.html?testName=json-parse-financial) 04:28:48 INFO - PROCESS | 11187 | RSS: Main: 215552000 04:28:48 INFO - PROCESS | 11187 | 04:28:50 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58974/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:50 INFO - PROCESS | 11187 | RSS: Main: 201924608 04:28:50 INFO - PROCESS | 11187 | 04:28:52 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:53 INFO - PROCESS | 11187 | RSS: Main: 207372288 04:28:53 INFO - PROCESS | 11187 | 04:28:55 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:55 INFO - PROCESS | 11187 | RSS: Main: 220708864 04:28:55 INFO - PROCESS | 11187 | 04:28:58 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:59 INFO - PROCESS | 11187 | RSS: Main: 224088064 04:28:59 INFO - PROCESS | 11187 | 04:29:02 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:02 INFO - PROCESS | 11187 | RSS: Main: 221986816 04:29:02 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | Cycle 1(1): loaded http://localhost:58974/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58974/tests/kraken/driver.html?testName=ai-astar) 04:29:04 INFO - PROCESS | 11187 | RSS: Main: 284741632 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | __start_tp_report 04:29:04 INFO - PROCESS | 11187 | _x_x_mozilla_page_load 04:29:04 INFO - PROCESS | 11187 | _x_x_mozilla_page_load_details 04:29:04 INFO - PROCESS | 11187 | |i|pagename|runs| 04:29:04 INFO - PROCESS | 11187 | |0;ai-astar;111;113;108;114;113;115;102;115;112;113 04:29:04 INFO - PROCESS | 11187 | |1;audio-beat-detection;161;143;159;180;148;157;159;143;190;137 04:29:04 INFO - PROCESS | 11187 | |2;audio-dft;161;162;161;161;162;162;161;161;161;162 04:29:04 INFO - PROCESS | 11187 | |3;audio-fft;77;74;123;123;75;74;76;113;100;76 04:29:04 INFO - PROCESS | 11187 | |4;audio-oscillator;95;94;154;94;93;94;146;94;93;143 04:29:04 INFO - PROCESS | 11187 | |5;imaging-gaussian-blur;117;117;117;117;117;117;119;116;118;117 04:29:04 INFO - PROCESS | 11187 | |6;imaging-darkroom;147;146;147;148;146;147;147;146;147;146 04:29:04 INFO - PROCESS | 11187 | |7;imaging-desaturate;96;95;95;95;95;94;95;95;95;95 04:29:04 INFO - PROCESS | 11187 | |8;json-parse-financial;65;66;66;65;65;66;65;89;64;63 04:29:04 INFO - PROCESS | 11187 | |9;json-stringify-tinderbox;65;64;64;64;64;64;65;64;64;65 04:29:04 INFO - PROCESS | 11187 | |10;stanford-crypto-aes;78;81;78;86;79;80;81;80;79;80 04:29:04 INFO - PROCESS | 11187 | |11;stanford-crypto-ccm;136;138;135;132;132;129;132;132;170;144 04:29:04 INFO - PROCESS | 11187 | |12;stanford-crypto-pbkdf2;180;181;179;186;181;175;190;180;190;176 04:29:04 INFO - PROCESS | 11187 | |13;stanford-crypto-sha256-iterative;72;76;71;71;72;71;70;71;70;70 04:29:04 INFO - PROCESS | 11187 | __end_tp_report 04:29:04 INFO - PROCESS | 11187 | __start_cc_report 04:29:04 INFO - PROCESS | 11187 | _x_x_mozilla_cycle_collect,1865 04:29:04 INFO - PROCESS | 11187 | __end_cc_report 04:29:04 INFO - PROCESS | 11187 | __startTimestamp1460892544920__endTimestamp 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | ------- Summary: start ------- 04:29:04 INFO - PROCESS | 11187 | Number of tests: 14 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.95 (3.5%) stddev-sans-first:4.18 04:29:04 INFO - PROCESS | 11187 | Values: 111.0 113.0 108.0 114.0 113.0 115.0 102.0 115.0 112.0 113.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#1] audio-beat-detection Cycles:10 Average:157.70 Median:159.00 stddev:16.70 (10.5%) stddev-sans-first:17.67 04:29:04 INFO - PROCESS | 11187 | Values: 161.0 143.0 159.0 180.0 148.0 157.0 159.0 143.0 190.0 137.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 04:29:04 INFO - PROCESS | 11187 | Values: 161.0 162.0 161.0 161.0 162.0 162.0 161.0 161.0 161.0 162.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#3] audio-fft Cycles:10 Average:91.10 Median:74.50 stddev:21.33 (28.6%) stddev-sans-first:22.00 04:29:04 INFO - PROCESS | 11187 | Values: 77.0 74.0 123.0 123.0 75.0 74.0 76.0 113.0 100.0 76.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:94.00 stddev:26.14 (27.8%) stddev-sans-first:27.15 04:29:04 INFO - PROCESS | 11187 | Values: 95.0 94.0 154.0 94.0 93.0 94.0 146.0 94.0 93.0 143.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 04:29:04 INFO - PROCESS | 11187 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 119.0 116.0 118.0 117.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:29:04 INFO - PROCESS | 11187 | Values: 147.0 146.0 147.0 148.0 146.0 147.0 147.0 146.0 147.0 146.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 04:29:04 INFO - PROCESS | 11187 | Values: 96.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:65.50 stddev:7.65 (11.7%) stddev-sans-first:8.06 04:29:04 INFO - PROCESS | 11187 | Values: 65.0 66.0 66.0 65.0 65.0 66.0 65.0 89.0 64.0 63.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 04:29:04 INFO - PROCESS | 11187 | Values: 65.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:2.30 (2.9%) stddev-sans-first:2.30 04:29:04 INFO - PROCESS | 11187 | Values: 78.0 81.0 78.0 86.0 79.0 80.0 81.0 80.0 79.0 80.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:135.50 stddev:12.01 (8.9%) stddev-sans-first:12.72 04:29:04 INFO - PROCESS | 11187 | Values: 136.0 138.0 135.0 132.0 132.0 129.0 132.0 132.0 170.0 144.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.80 Median:181.00 stddev:5.25 (2.9%) stddev-sans-first:5.52 04:29:04 INFO - PROCESS | 11187 | Values: 180.0 181.0 179.0 186.0 181.0 175.0 190.0 180.0 190.0 176.0 04:29:04 INFO - PROCESS | 11187 | 04:29:04 INFO - PROCESS | 11187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:1.78 (2.5%) stddev-sans-first:1.87 04:29:04 INFO - PROCESS | 11187 | Values: 72.0 76.0 71.0 71.0 72.0 71.0 70.0 71.0 70.0 70.0 04:29:04 INFO - PROCESS | 11187 | -------- Summary: end -------- 04:29:04 INFO - PROCESS | 11187 | 04:29:05 INFO - TEST-INFO | 11187: exit 0 04:29:06 INFO - TEST-OK | kraken | took 64078ms 04:29:06 INFO - SUITE-END | took 1184s 04:29:06 INFO - Completed test suite (00:19:44) 04:29:06 INFO - javascript benchmark 04:29:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.6085587161924, 2648.059938721755, 2682.396460796321, 2693.7171596982316, 2706.391062011048, 4524.954750452503, 4619.745913974734, 4633.860984170472, 4634.050019745952, 4637.304404339351, 4552.567506086916, 4725.054989002205, 4785.736784476852, 4790.06593714225, 4803.615710743141, 4241.575842415757, 4255.787100676308, 4262.829486820523, 4290.249206388885, 4336.956630433702, 4356.912861742763, 4360.062586543892, 4394.055278115205, 4432.601065904068, 4433.13553856998, 4141.482314710661, 4207.368894665794, 4347.847825326098, 4352.630026447756, 4426.645868330542, 4250.447441832573, 4281.336392859112, 4293.635041021517, 4296.076343586144, 4299.204647140289, 4242.554531774181, 4256.723312984646, 4270.743755374688, 4272.572742725733, 4278.871633850989, 4527.320901864714, 4584.106099310636, 4586.724796512187, 4591.242444996572, 4634.582887540104, 5022.824201152942, 5029.3964724232965, 5032.370953630796, 5034.395872495287, 5075.8984820303385, 4832.0, 4989.226669866177, 5047.697138171721, 5061.519155680205, 5061.569766569846, 4704.670673052922, 4712.929306060412, 4719.433667959798, 4725.385699859065, 4774.236122220428, 5142.665726727825, 5146.202338637517, 5165.431802501722, 5170.3278573785165, 5174.508421699932, 4720.598749106364, 4849.854504364875, 4897.461279259279, 4941.03649788295, 5018.422881368616, 4843.612510999182, 4870.975645121752, 4871.829485968045, 4898.681585696918, 4935.284383764334, 4831.685940413862, 4845.0, 4863.683860549053, 4877.6585639004925, 4935.383077115361, 4735.289706544046, 4813.422389313235, 4813.518648135158, 4817.229243321122, 4870.82952096682, 4169.187008533307, 4201.117765269267, 4208.978955105266, 4229.80965856531, 4241.363795430649, 3703.037210325335, 3709.3694072007825, 3712.88861334155, 3727.3663477208397, 3743.831527581211, 4161.854335098257, 4309.224339618836, 4313.223619748475, 4322.330038843984, 4346.2828633275785, 5009.724465154379, 5036.32009678696, 5055.646104772631, 5059.747012649353, 5108.131617625013, 4311.479988827252, 4325.480942286946, 4327.0480494291205, 4367.934480982788, 4372.978135109304, 4308.719933204332, 4393.275109606879, 4475.597196252353, 4525.117602067631, 4528.547145285445, 4765.666403351732, 4765.95234047669, 4776.904461910812, 4784.186688262934, 4801.327814106098, 5037.974810125926, 5038.722870242172, 5042.3949126103635, 5042.495750424928, 5091.847244582668, 4556.066006468733, 4726.550977657117, 4770.117528257145, 4792.137415265286, 4812.25410061441, 4913.828016019422, 4927.901441971212, 4939.60396039604, 4939.703617782944, 5003.374578177728, 4985.8005679772405, 5004.749762511933, 5012.824551140692, 5015.097282489041, 5063.797448102035, 4661.766911654471, 4794.400699912511, 4855.344528488608, 4881.829135980223, 4904.730239836843, 4862.610991120631, 4879.56083952446, 4902.852914412573, 4911.435184953633, 4957.504249575014, 4648.395708557866, 4812.205986012269, 4837.129316722883, 4839.0, 4892.608591312757, 4819.180739274261, 4862.902741945212, 4864.975675121602, 4915.361003069578, 4917.483664215206, 4716.905661886812, 4724.574788269072, 4760.666753327234, 4764.285357196448, 4812.25410061441], "value": 4583.707348245194, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.9519238460923, 618.0482057631247, 624.2446639566125, 629.6316654756966, 629.9433051025406, 36535.26929461409, 37846.24307513852, 37865.43201851974, 38054.429183562235, 38089.809550952275, 41131.794341028326, 41990.0, 42017.15965680692, 42026.57973420265, 42037.57962420375, 7191.101112360955, 7727.8068048298965, 7913.248241417056, 7939.880901786478, 9363.719088427359, 9504.714858554255, 9659.613615455373, 9660.661876834312, 9663.468509232025, 9666.903330966707, 9909.207263418944, 10006.749831254205, 10007.29948903577, 10008.549615267331, 10010.34932729374, 7381.188069312371, 9692.95153524235, 9868.555914983806, 10062.798744025078, 10077.546510406975, 9507.952460237724, 9658.75853103678, 9665.178459830922, 9668.419894806264, 9674.08096230857, 36472.63527364719, 37136.44295335572, 37166.25667486635, 37212.81393593042, 37227.25545489075, 3198.0, 3213.293075523381, 3231.5475833383343, 3253.7071663550396, 3261.8858339957987, 28749.0, 28910.855445722846, 29413.411731765245, 29424.0, 29475.557866631803, 3466.1717362206628, 3511.5961664408665, 3526.365254254233, 3535.045537704805, 3546.929061418783, 165452.17273913554, 166349.6730065404, 166500.16749916173, 167078.0, 167554.0, 47677.284840727414, 47749.0, 48181.0, 48185.277220841715, 48196.7590162047, 48552.75723621359, 63335.6833215831, 65589.34410655928, 65641.01538476927, 65657.67171164113, 14733.55799326022, 15032.17323047221, 15034.0, 15035.849641503444, 15047.473338433321, 9734.269929755155, 11280.435978201058, 11546.422678866023, 11550.59572914944, 11570.479328430241, 18043.909780451013, 18296.54258643518, 18329.90835045816, 18341.3580524681, 18379.72430413545, 6647.437852104751, 6949.791506254821, 7036.401905837959, 7045.859082818418, 7194.568325900463, 871.6208449324438, 904.1591320072264, 913.6117150211134, 990.5681551790337, 1019.607451131305, 26952.326191844968, 28235.294117647223, 28607.57088643672, 28857.85571072173, 28888.566671499946, 961.4375590279765, 997.0229175407995, 1021.5862575656871, 1035.1977217656226, 1108.645233525264, 14400.855991439952, 15036.849631503765, 15072.321745521478, 15299.15854627984, 15314.310856011283, 319151.0, 324749.0, 325200.0, 325205.0, 326164.0, 45325.0, 45918.540814591426, 46062.539374606495, 46082.53917460849, 46125.53874461279, 1121.377635412354, 1148.6439203846835, 1208.10600155884, 1236.9010479161825, 1276.234259444326, 24400.6339904898, 25558.361040974123, 26145.73854261433, 26320.605190922535, 26425.471490570464, 35725.64274357223, 36207.456888146175, 36285.0, 36309.27381452409, 36382.63617363898, 222191.0, 222515.0, 222718.0, 222787.0, 223781.0, 22122.889385552968, 24657.260282191564, 25575.547301114857, 25634.615480768178, 25843.224703258933, 38785.4182187273, 39133.804330978164, 39265.0, 39530.40704389379, 40144.0, 33359.49960750639, 33465.16337091495, 33726.0, 34258.48612270768, 34396.0, 32674.83662581767, 32864.50703239405, 33322.500162498065, 33431.66568334286, 33739.83130084334, 33559.32881342409, 34006.65993340035, 34022.31955360928, 34133.65866341305, 34552.82723586366, 29555.556666649587, 31468.37063258676, 32533.34933301368, 32573.0, 33185.50221746627, 22802.65796013028, 23148.884255578614, 23643.40891477727, 23780.762192377853, 24754.7453858456], "value": 17309.557122495924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.3829142125991, 380.72017067455414, 388.44646378910045, 389.6532086443065, 399.81009020715146, 15742.212889355544, 16510.174491275448, 16590.0, 16609.667806643858, 16610.916945415287, 15422.305996230169, 15812.683746325067, 16027.759583606256, 16113.194340282967, 16123.83876161238, 4649.232876575361, 4774.665773395864, 4810.4948980357085, 4810.68730532516, 4817.566419022287, 3434.9484757728655, 4450.109978004396, 4620.491745907947, 4621.8844528886875, 4622.9768851155695, 4566.40636717228, 4596.49438561758, 4599.310103484488, 4603.493615702287, 4604.033153037866, 4601.562851529099, 4637.721736695792, 4652.930206046912, 4708.364370809931, 4773.976130119345, 4866.537678920497, 5172.379314482248, 5182.585393168538, 5182.611304152204, 5243.4232234454175, 12673.873261267454, 16060.75908861368, 19513.121909513964, 20146.899265503725, 20161.596768064555, 1885.2364792259157, 1918.827305542508, 2020.9191632334837, 2025.0381068992258, 2440.707115146176, 9006.819863602692, 10405.47972601367, 12966.0, 13107.820296173295, 13352.799708004388, 1747.720364741648, 1757.490327804935, 1813.1115753280928, 1853.3513270355268, 1853.4532312967572, 64320.0, 64808.0, 65314.67342663304, 65526.1539692145, 65717.0, 9950.35322704022, 10260.486975651187, 10284.897151028394, 10387.636432724817, 10403.895961040444, 14214.85785142156, 14232.644183895485, 14259.21574313402, 14278.07192532482, 14284.285785710674, 7192.496525243288, 7311.122665280094, 7316.0, 7425.62871856405, 7431.405487560982, 6756.560823546453, 6796.150481189851, 6911.17065952089, 6948.270431604608, 6949.617771022541, 4351.760653164043, 4410.845620403271, 4450.287953927421, 4458.130664520388, 4538.9546104539195, 1718.3642052440678, 1754.8332908373684, 1813.836754692084, 1815.4372144635206, 1910.6274276516224, 824.3528829868525, 869.9695510657097, 885.7121435533348, 924.5746956399997, 993.0, 15964.12197329158, 16368.508944731677, 16427.91786041086, 16656.250468728937, 16680.58298542522, 893.5666201892077, 897.3090720145451, 918.2929144558652, 945.9432434053979, 964.7732782796037, 8970.730878073668, 9287.303452241109, 9323.25413966881, 9438.197753190918, 9452.196563292197, 377893.0, 384299.0, 391106.0, 392784.0, 393173.0, 79006.20993790103, 79296.60351698204, 79794.0, 80803.5959820209, 81297.59351203206, 840.7099550655014, 910.2626872233379, 923.3398120343852, 947.8341290274175, 950.3585080070925, 12409.565665201675, 14063.859361406256, 14300.0, 14397.208153551237, 14614.269286535418, 32694.67305326916, 32733.0, 33045.66954330426, 34034.489482657285, 34466.138346541535, 38231.426528601536, 39023.414648779726, 39772.40341394823, 40070.799646001586, 41925.580744192164, 7058.0, 7070.7525236616475, 7126.928730712834, 7205.603691797001, 7246.202917678946, 8270.586470676562, 10378.792424151323, 10454.529546170288, 10590.311629744043, 10786.946065269623, 6312.715927783169, 8714.956425218086, 9140.954295228481, 9194.770130746785, 9478.857817132886, 9387.577559009724, 9441.52792360393, 9482.478463684563, 9534.570944307385, 9708.514574271117, 9637.325387222827, 9770.606201480683, 9813.460259685786, 9886.357386769838, 9912.35569687968, 6922.757703480354, 7388.889166662612, 7404.518706284074, 7585.431092667962, 7607.847843043219, 8661.610227539903, 8787.824243514966, 9154.450732955778, 9339.299552533452, 9507.477088760184], "value": 7868.517338761374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1214.5445457953267, 1448.630599197205, 1478.50470092519, 1626.8617167540765, 1818.2545156485835, 7503.924960750391, 7549.35830454412, 7551.395888328934, 7560.96219518903, 7566.621668916559, 7303.379212766921, 7444.739434119807, 7463.813404664873, 7465.440091993095, 7470.2903224193615, 1892.9716054259197, 2173.1850556041486, 2177.9019944102474, 2195.3523710505438, 2253.785890340415, 2241.3724157236, 2252.1441852096264, 2269.5120549081944, 2269.9886500567472, 2270.5004898922293, 2139.711138996239, 2220.4670878989086, 2224.410531209223, 2224.788645078723, 2227.5878962392007, 1870.1677753399742, 2177.107385971744, 2232.0960011195493, 2235.3182279404773, 2235.3629215673454, 2055.7533096028574, 2071.0887209627867, 2077.6052550015447, 2080.698298746673, 2083.3020937985643, 7576.0908690956885, 7601.125870524905, 7614.162442131416, 7669.118051424102, 7670.386369090459, 4561.931571026437, 4728.054389122155, 4739.976300118512, 4741.786619602126, 4781.043791241766, 2988.6114805075417, 2996.4306781711625, 3042.8478576071107, 3073.5082386818226, 3074.7540196784203, 1013.6806905824716, 1037.3309215556, 1054.3199636234663, 1803.6573051120245, 1892.81071892811, 10379.688609341732, 10409.219308551814, 10437.32157409766, 10476.68569942903, 10504.737381565446, 3971.0667993021616, 4128.0711839836395, 4226.429432026698, 4273.9358909616385, 4275.5296917339065, 8242.876356854653, 8296.792580185544, 8317.708880189164, 8328.167183281745, 8343.582820858932, 3999.0, 4672.6962747421985, 4684.578387945033, 4687.765611719468, 4696.9060618787435, 3828.2152158807376, 3832.2335532893535, 3849.942250866239, 4177.56135605757, 4335.1329734053315, 3419.9316013679586, 3466.116140384236, 3501.0, 3524.9118772030392, 3590.2460483298278, 1078.7249251440833, 1085.2837127495816, 1085.3270971997254, 1090.8472813806075, 1104.3539529375246, 797.7606717984581, 832.9625166867505, 844.2317491083085, 858.5192292316323, 876.3471213945651, 5231.581473482112, 5316.946830531645, 5451.373092094381, 5470.015397228537, 5499.835004949858, 852.1435956863313, 860.7934095816959, 865.8138500222483, 906.0803284666069, 928.5821380378857, 3668.2296717689583, 3724.7392682511963, 3743.9251214975548, 3753.174301653632, 3771.4719939208535, 9069.093090690878, 9352.812943741086, 9443.811123777487, 9444.0555944405, 9446.85829712555, 9289.442633442015, 9339.486328252011, 9341.532923353805, 9347.065293470598, 9347.859782103274, 7052.717891284291, 7358.337749602561, 7388.187299397062, 7388.891666250105, 7430.777076687708, 5461.644993075437, 5538.556915446835, 5580.2466666999435, 5640.915386269291, 5696.11710184922, 8690.391672583111, 8696.521691306785, 8795.780105497413, 9028.458292502472, 9044.683436079706, 8872.73381798547, 9046.095390461165, 9072.0, 9150.40522366044, 9171.678991235274, 6086.421789929949, 6277.937220627918, 6283.874322513433, 6610.867782644416, 6739.292374300628, 6912.93087069143, 7276.527025743309, 7438.70245190208, 7452.962735186289, 7486.139094004041, 6685.0, 6799.354061364163, 6865.313468653095, 6934.791956241321, 6958.860822783415, 6781.525293229624, 6808.183018037867, 6877.552959057645, 6900.551464154814, 6974.302569742985, 6152.846178845564, 6157.1072194532435, 6232.75068997235, 6235.688215589294, 6405.0392441132335, 4730.621550276039, 4754.690945088558, 4771.5467030632035, 4840.806367745392, 4852.102361063215, 4902.3872015998, 4913.1893237615395, 4956.231784073474, 5009.423916249678, 5037.244413337882], "value": 4170.1909676191, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.4400938334456, 317.38269066665333, 321.07850469153533, 322.234692605063, 322.5645378738702, 5006.148954677705, 5056.873578160543, 5064.08846407646, 5072.84781456556, 5138.100832354332, 5104.234364845275, 5108.2848401223855, 5108.923366149511, 5113.769880355384, 5121.462246464123, 3810.5236845394256, 3935.60643935607, 3979.5025621797276, 3981.880543583697, 3983.382575700771, 3681.7193542800974, 3951.3677811550156, 3998.600139985993, 3999.3401088820456, 4057.2696914555368, 3972.6424621784035, 3984.0, 3992.201559688074, 3995.920081598381, 4024.0, 3791.374423220165, 3908.1988192420486, 4016.7389119707127, 4024.094578719794, 4026.2350153470748, 3578.8568457261676, 3579.874704385334, 3585.15748799032, 3596.4425514045365, 3602.0, 4832.9758351208375, 4854.805807767685, 4875.8781030474165, 4882.829100981448, 4924.384451943507, 4550.817967281305, 4636.420447444069, 4637.489876113625, 4645.094206629708, 4647.372604698357, 5361.115415956401, 5365.570754339644, 5366.865828354284, 5367.704776237305, 5375.75809088592, 3912.4913761211146, 3919.608039196086, 3926.509186351706, 3930.960690393088, 3932.9803350983348, 5195.584353251768, 5337.786488540453, 5564.248826408423, 5634.887302253973, 5654.208410822488, 3963.1083006323925, 3980.601939805996, 3982.356144128148, 4005.2189822984237, 4010.63904248619, 4066.3900414938, 4071.7353372030725, 4080.1227736036303, 4089.5297040840683, 4092.3452247640234, 4593.609543188866, 4608.815647374135, 4614.377059097046, 4616.907661846812, 4624.375709279271, 5178.352705911761, 5300.0, 5344.278522399504, 5351.973240133774, 5368.3826359968325, 1410.6825964157983, 1422.665673566711, 1429.7712366021387, 1435.7056803355288, 1436.0522055443357, 952.937474715687, 977.0424983516194, 987.4618333008384, 995.5470261031213, 996.800639872014, 4655.720656760605, 4675.368825208553, 4679.27471241958, 4685.812567497262, 4706.129366067288, 5522.144067669517, 5522.66863988162, 5529.778808847682, 5530.483629948364, 5557.221988921554, 4536.7996521686955, 4612.3542704021465, 4613.884652883705, 4649.163150632919, 4707.270373092176, 2958.4970555005702, 2971.3463038131576, 2971.881124755029, 2984.224101733565, 2987.746041586446, 5206.297149884793, 5212.478752124833, 5213.661112027782, 5214.070793806316, 5228.738563071831, 5556.777728890799, 5609.971950140223, 5672.404397538282, 5673.120666296731, 5676.44559948025, 4992.201247800334, 5069.6451248413, 5194.11700010999, 5216.843494695166, 5227.163653815372, 5524.861878453071, 5566.443355664401, 5572.331320241597, 5574.804881829116, 5576.972115139399, 5461.750258596129, 5468.781248750005, 5472.644278121909, 5473.31583552056, 5482.0, 5068.366454193226, 5235.110031294766, 5236.842894713165, 5242.213667949838, 5256.684598924076, 3993.201359728008, 4013.7792421415934, 4016.7991600420446, 4020.83916643331, 4025.3358195898522, 5552.167174923794, 5574.581906357121, 5576.247206627054, 5576.358718747396, 5584.804531841366, 5139.306193663808, 5401.945980540301, 5402.270693456333, 5403.946230485018, 5406.513413792777, 5293.12663410533, 5350.170723537858, 5368.302120724437, 5381.434949330264, 5382.67703937765, 5207.869803254949, 5288.497592728685, 5306.283651707125, 5313.840584782462, 5335.946640533545, 5380.515753582196, 5410.053240682786, 5448.591355648263, 5452.727363631882, 5462.453754624506, 5273.6572122811895, 5281.8679533010445, 5303.549198318032, 5307.336582927134, 5310.840674779763], "value": 4069.9563890111026, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.767681311541, 728.8724473217189, 730.9364874108173, 733.3106879533238, 763.8930549723036, 11545.884541154586, 11846.940765296173, 11864.110191735612, 11883.643490695282, 11918.0, 11132.721681957955, 11137.72155696106, 11157.66527004191, 11244.044256238209, 11248.043916267126, 640.2509064394658, 779.5322806316193, 818.5293456262643, 819.3690858039306, 819.6024927909959, 789.8578255913933, 798.9800254993613, 803.1045384396385, 806.802333428308, 807.0355924670022, 674.5076094451053, 848.4485084694936, 866.1035827918106, 866.1295398124876, 866.3978534918234, 835.3692961813822, 860.6256278518833, 860.7030574451804, 860.8235311761074, 861.9353548483826, 621.934696856828, 626.0546574672278, 626.2047200055904, 629.6883042893751, 632.5508888689036, 11034.558617655284, 11087.33475991443, 11098.167637427225, 11125.666230013112, 11170.329780213213, 12298.815517767242, 12607.0, 12657.810132848015, 13163.210207387492, 13165.407556659973, 9947.452890091043, 10259.79480410395, 10310.948445257725, 10329.0, 10470.319429237075, 3348.7655864089525, 3404.6254911959663, 3451.861925522976, 3511.122219445139, 3515.753897227195, 41425.79287103545, 42139.0, 42770.358444623045, 42961.57038429607, 43118.13763724739, 9627.326087173831, 9894.505274736235, 9954.619967214403, 9956.751081223027, 10065.094141527297, 17967.64064718698, 17970.19134138967, 18133.54666133331, 18147.09264536768, 18185.0, 6910.654467276616, 6972.1981972072845, 7046.0, 7088.326608972139, 7118.679659415338, 3544.113971507123, 3590.982045089758, 3624.619414961444, 3727.347714150013, 3739.794311312904, 2929.868155932988, 3200.3599280144063, 3353.7652364334263, 3361.680640339164, 3363.899083027513, 511.910415677255, 566.4165909113619, 576.8529025098572, 597.7011494252873, 600.6096037575611, 517.1054076447691, 545.4354742841141, 549.2228496677156, 591.4135876279425, 604.1632339210138, 7684.46208765381, 7774.494657847222, 7793.454458187985, 8066.919330806734, 8161.714339998071, 615.6244690738646, 618.2766163588612, 622.3247776162824, 640.2029473305764, 657.1719633262124, 3985.3000412752863, 4084.244414783275, 4155.085881106152, 4205.074883525619, 4239.215745087169, 51894.48105518972, 52935.0, 52973.205401919, 53549.73225133849, 53596.464035359924, 45137.32294015592, 45384.0, 45579.544204558195, 45889.08221835545, 45931.77034114808, 41876.790616046725, 42527.574724252365, 42653.57346426496, 42901.996860219486, 44281.33577996268, 8415.11641277657, 8549.316054715733, 8578.571071446278, 8596.957015214884, 8637.481751094954, 29588.704112958596, 29796.255093622833, 29998.70001299959, 30048.2956533913, 30532.694673053873, 37334.066648332926, 38669.61330386773, 40461.19077618372, 40539.0, 40973.1805363897, 10817.945910270399, 11008.889911100787, 11061.11511079128, 11169.944150279196, 11173.0, 9908.405495670282, 11711.824322634997, 11850.288982660722, 12594.370281485706, 12598.55905043319, 8916.643334266817, 11516.366599837089, 11551.0, 11598.130140239347, 11739.941300293443, 11149.331040137618, 11322.547098115983, 11597.884021160018, 12050.698732531757, 12121.878781212428, 10630.0, 11089.112870970464, 11257.71855703614, 11734.061275097802, 11750.059995200534, 9578.664746733832, 9623.759406014626, 9816.754581135243, 10020.549075291483, 10137.239707021856, 9425.151736343762, 9678.51607419612, 9772.560234789593, 9904.7562443353, 10130.189584833342], "value": 6004.535925846893, "unit": "score"}], "name": "dromaeo_css", "value": 6318.458152122547, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 108.0, 114.0, 113.0, 115.0, 102.0, 115.0, 112.0, 113.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 143.0, 159.0, 180.0, 148.0, 157.0, 159.0, 143.0, 190.0, 137.0], "value": 157.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 123.0, 123.0, 75.0, 74.0, 76.0, 113.0, 100.0, 76.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 154.0, 94.0, 93.0, 94.0, 146.0, 94.0, 93.0, 143.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 116.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 89.0, 64.0, 63.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 78.0, 86.0, 79.0, 80.0, 81.0, 80.0, 79.0, 80.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 135.0, 132.0, 132.0, 129.0, 132.0, 132.0, 170.0, 144.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 181.0, 179.0, 186.0, 181.0, 175.0, 190.0, 180.0, 190.0, 176.0], "value": 181.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 71.0, 71.0, 72.0, 71.0, 70.0, 71.0, 70.0, 70.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1593.8000000000002, "alertThreshold": 2.0}]} 04:29:06 INFO - Return code: 0 04:29:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:06 ERROR - # TBPL SUCCESS # 04:29:06 INFO - Running post-action listener: _resource_record_post_action 04:29:06 INFO - Running post-run listener: _resource_record_post_run 04:29:07 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285069312; Read time: 392; Write time: 315128 04:29:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5234688; Read time: 0; Write time: 336 04:29:07 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 279834624; Read time: 392; Write time: 314792 04:29:07 INFO - Running post-run listener: _upload_blobber_files 04:29:07 INFO - Blob upload gear active. 04:29:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:07 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 04:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:29:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:29:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:29:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:08 INFO - (blobuploader) - INFO - Done attempting. 04:29:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:29:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:29:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:09 INFO - (blobuploader) - INFO - Done attempting. 04:29:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:09 INFO - Return code: 0 04:29:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f334c0e64add3ba7ba0f6dc6d6e01737ffa59ce0568c45ffad2b4a4c49e204f2cdc24d211cd8e7235d36cbaec07fa1fbcc0407bb38eb76b0f90cf6fe1216b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b23dd3170ba367a1b309534627a5810e4c9b2d0fe5956d24129ee2af849f8725fb1f244ceeb479bd707d8890369eaf39a822377adcb4d4d271e53cfb1436aae5"} 04:29:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:09 INFO - Contents: 04:29:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f334c0e64add3ba7ba0f6dc6d6e01737ffa59ce0568c45ffad2b4a4c49e204f2cdc24d211cd8e7235d36cbaec07fa1fbcc0407bb38eb76b0f90cf6fe1216b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b23dd3170ba367a1b309534627a5810e4c9b2d0fe5956d24129ee2af849f8725fb1f244ceeb479bd707d8890369eaf39a822377adcb4d4d271e53cfb1436aae5"} 04:29:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:09 INFO - Copying logs to upload dir... 04:29:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.867770 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-04-17 04:29:09.153044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 04:29:09.156532) ========= 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=df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f334c0e64add3ba7ba0f6dc6d6e01737ffa59ce0568c45ffad2b4a4c49e204f2cdc24d211cd8e7235d36cbaec07fa1fbcc0407bb38eb76b0f90cf6fe1216b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b23dd3170ba367a1b309534627a5810e4c9b2d0fe5956d24129ee2af849f8725fb1f244ceeb479bd707d8890369eaf39a822377adcb4d4d271e53cfb1436aae5"} build_url:https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/IshT8UGPRDy2Ev7lWtT9Yg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f334c0e64add3ba7ba0f6dc6d6e01737ffa59ce0568c45ffad2b4a4c49e204f2cdc24d211cd8e7235d36cbaec07fa1fbcc0407bb38eb76b0f90cf6fe1216b18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b23dd3170ba367a1b309534627a5810e4c9b2d0fe5956d24129ee2af849f8725fb1f244ceeb479bd707d8890369eaf39a822377adcb4d4d271e53cfb1436aae5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-17 04:29:09.181121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:29:09.181440) ========= 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=df17445c3590ff7897617a0e00000225-1460869673.178518-1958579341 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-17 04:29:09.264915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 04:29:09.265258) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-17 04:29:09.265553) ========= ========= Total master_lag: 0.16 =========