builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1461618021.19 results: success (0) buildid: 20160425132510 builduid: 79619767a570474291ecb94d92c92ef7 revision: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.193480) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.194232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.194736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.212132) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.212472) ========= 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=aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 14:00:21-- 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% 112M=0s 2016-04-25 14:00:21 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.085941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.311673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.312073) ========= 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=aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023154 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.363043) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.363612) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 86e0ea42f55c34fc90dd9e32439783a9929f28f4 --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 86e0ea42f55c34fc90dd9e32439783a9929f28f4 --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=aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 14:00:21,693 truncating revision to first 12 chars 2016-04-25 14:00:21,693 Setting DEBUG logging. 2016-04-25 14:00:21,693 attempt 1/10 2016-04-25 14:00:21,693 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/86e0ea42f55c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 14:00:22,016 unpacking tar archive at: fx-team-86e0ea42f55c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.981547) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.982102) ========= script_repo_revision: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.982786) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.983242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 14:00:21.993502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-25 14:00:21.994030) ========= /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=aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:00:22 INFO - MultiFileLogger online at 20160425 14:00:22 in /builds/slave/test 14:00:22 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 14:00:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:00:22 INFO - {'append_to_log': False, 14:00:22 INFO - 'base_work_dir': '/builds/slave/test', 14:00:22 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:00:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:00:22 INFO - 'branch': 'Fx-Team-Non-PGO', 14:00:22 INFO - 'buildbot_json_path': 'buildprops.json', 14:00:22 INFO - 'config_files': ('talos/linux_config.py',), 14:00:22 INFO - 'default_actions': ('clobber', 14:00:22 INFO - 'read-buildbot-config', 14:00:22 INFO - 'download-and-extract', 14:00:22 INFO - 'populate-webroot', 14:00:22 INFO - 'create-virtualenv', 14:00:22 INFO - 'install', 14:00:22 INFO - 'run-tests'), 14:00:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:00:22 INFO - 'download_minidump_stackwalk': True, 14:00:22 INFO - 'download_symbols': 'ondemand', 14:00:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:00:22 INFO - 'tooltool.py': '/tools/tooltool.py', 14:00:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:00:22 INFO - '/tools/misc-python/virtualenv.py')}, 14:00:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:00:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:00:22 INFO - 'installer_path': 'installer.exe', 14:00:22 INFO - 'log_level': 'info', 14:00:22 INFO - 'log_name': 'talos', 14:00:22 INFO - 'log_to_console': True, 14:00:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:00:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:00:22 INFO - 'opt_config_files': (), 14:00:22 INFO - 'pip_index': False, 14:00:22 INFO - 'sps_profile': False, 14:00:22 INFO - 'sps_profile_interval': 0, 14:00:22 INFO - 'suite': 'dromaeojs', 14:00:22 INFO - 'system_bits': '32', 14:00:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:00:22 INFO - 'title': 'talos-linux64-ix-009', 14:00:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:00:22 INFO - 'use_talos_json': True, 14:00:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:00:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:00:22 INFO - 'work_dir': 'build'} 14:00:22 INFO - ##### 14:00:22 INFO - ##### Running clobber step. 14:00:22 INFO - ##### 14:00:22 INFO - Running pre-action listener: _resource_record_pre_action 14:00:22 INFO - Running main action method: clobber 14:00:22 INFO - rmtree: /builds/slave/test/build 14:00:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:00:22 INFO - Running post-action listener: _resource_record_post_action 14:00:22 INFO - ##### 14:00:22 INFO - ##### Running read-buildbot-config step. 14:00:22 INFO - ##### 14:00:22 INFO - Running pre-action listener: _resource_record_pre_action 14:00:22 INFO - Running main action method: read_buildbot_config 14:00:22 INFO - Using buildbot properties: 14:00:22 INFO - { 14:00:22 INFO - "project": "", 14:00:22 INFO - "product": "firefox", 14:00:22 INFO - "script_repo_revision": "production", 14:00:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:00:22 INFO - "repository": "", 14:00:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:00:22 INFO - "buildid": "20160425132510", 14:00:22 INFO - "pgo_build": "False", 14:00:22 INFO - "basedir": "/builds/slave/test", 14:00:22 INFO - "buildnumber": 2885, 14:00:22 INFO - "slavename": "talos-linux64-ix-009", 14:00:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:00:22 INFO - "platform": "ubuntu64_hw", 14:00:22 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:00:22 INFO - "branch": "fx-team", 14:00:22 INFO - "repo_path": "integration/fx-team", 14:00:22 INFO - "revision": "86e0ea42f55c34fc90dd9e32439783a9929f28f4", 14:00:22 INFO - "stage_platform": "linux64", 14:00:22 INFO - "builduid": "79619767a570474291ecb94d92c92ef7", 14:00:22 INFO - "slavebuilddir": "test" 14:00:22 INFO - } 14:00:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:00:22 INFO - Running post-action listener: _resource_record_post_action 14:00:22 INFO - ##### 14:00:22 INFO - ##### Running download-and-extract step. 14:00:22 INFO - ##### 14:00:22 INFO - Running pre-action listener: _resource_record_pre_action 14:00:22 INFO - Running main action method: download_and_extract 14:00:22 INFO - mkdir: /builds/slave/test/build/tests 14:00:22 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')]} 14:00:22 INFO - https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:24 INFO - Downloaded 1361 bytes. 14:00:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:00:24 INFO - Using the following test package requirements: 14:00:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:00:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:00:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'jsshell-linux-x86_64.zip'], 14:00:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:00:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:00:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:00:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:00:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:00:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:00:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:00:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:00:24 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')]} 14:00:24 INFO - https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:26 INFO - Downloaded 22288221 bytes. 14:00:26 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'] 14:00:26 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 14:00:27 INFO - Return code: 0 14:00:27 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 14:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:27 INFO - https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:00:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:00:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:29 INFO - Downloaded 22288221 bytes. 14:00:29 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'] 14:00:29 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 14:00:30 INFO - Return code: 0 14:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:30 INFO - https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:32 INFO - Downloaded 10840145 bytes. 14:00:32 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'] 14:00:32 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 14:00:32 INFO - Return code: 0 14:00:32 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')]} 14:00:32 INFO - https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W3RvCyqQReGRhEvd5lLXTg/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 14:00:33 INFO - Downloaded 54818190 bytes. 14:00:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:33 INFO - mkdir: /builds/slave/test/properties 14:00:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:00:33 INFO - Writing to file /builds/slave/test/properties/build_url 14:00:33 INFO - Contents: 14:00:33 INFO - build_url:https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:00:34 INFO - Running post-action listener: _resource_record_post_action 14:00:34 INFO - Running post-action listener: set_extra_try_arguments 14:00:34 INFO - ##### 14:00:34 INFO - ##### Running populate-webroot step. 14:00:34 INFO - ##### 14:00:34 INFO - Running pre-action listener: _resource_record_pre_action 14:00:34 INFO - Running main action method: populate_webroot 14:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:00:34 INFO - '--tppagecycles', 14:00:34 INFO - '7'], 14:00:34 INFO - 'tests': ['tsvgm']}}, 14:00:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:00:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:00:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:00:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['damp', 'tps']}, 14:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'tests': ['damp', 'tps']}, 14:00:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['dromaeo_dom']}, 14:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:00:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['a11yr', 14:00:34 INFO - 'ts_paint', 14:00:34 INFO - 'tpaint', 14:00:34 INFO - 'sessionrestore', 14:00:34 INFO - 'sessionrestore_no_auto_restore', 14:00:34 INFO - 'tabpaint']}, 14:00:34 INFO - 'other-e10s': {'tests': ['a11yr', 14:00:34 INFO - 'ts_paint', 14:00:34 INFO - 'tpaint', 14:00:34 INFO - 'sessionrestore', 14:00:34 INFO - 'sessionrestore_no_auto_restore', 14:00:34 INFO - 'tabpaint']}, 14:00:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:00:34 INFO - 'ts_paint', 14:00:34 INFO - 'tpaint', 14:00:34 INFO - 'sessionrestore', 14:00:34 INFO - 'sessionrestore_no_auto_restore', 14:00:34 INFO - 'tabpaint']}, 14:00:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:00:34 INFO - 'ts_paint', 14:00:34 INFO - 'tpaint', 14:00:34 INFO - 'sessionrestore', 14:00:34 INFO - 'sessionrestore_no_auto_restore', 14:00:34 INFO - 'tabpaint']}, 14:00:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['a11yr', 14:00:34 INFO - 'ts_paint', 14:00:34 INFO - 'tpaint', 14:00:34 INFO - 'sessionrestore', 14:00:34 INFO - 'sessionrestore_no_auto_restore', 14:00:34 INFO - 'tabpaint']}, 14:00:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['a11yr', 14:00:34 INFO - 'ts_paint', 14:00:34 INFO - 'tpaint', 14:00:34 INFO - 'sessionrestore', 14:00:34 INFO - 'sessionrestore_no_auto_restore', 14:00:34 INFO - 'tabpaint']}, 14:00:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['tsvgx', 14:00:34 INFO - 'tsvgr_opacity', 14:00:34 INFO - 'tart', 14:00:34 INFO - 'tscrollx', 14:00:34 INFO - 'cart']}, 14:00:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:00:34 INFO - 'tsvgr_opacity', 14:00:34 INFO - 'tart', 14:00:34 INFO - 'tscrollx', 14:00:34 INFO - 'cart']}, 14:00:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'talos_options': ['--disable-e10s'], 14:00:34 INFO - 'tests': ['tp5o']}, 14:00:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'tests': ['tp5o']}, 14:00:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'talos_options': ['--disable-e10s', 14:00:34 INFO - '--xperf_path', 14:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:34 INFO - 'tests': ['tp5n']}, 14:00:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:00:34 INFO - 'talos_options': ['--xperf_path', 14:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:00:34 INFO - 'tests': ['tp5n']}}, 14:00:34 INFO - 'talos.zip': {'path': '', 14:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:00:34 INFO - Running post-action listener: _resource_record_post_action 14:00:34 INFO - ##### 14:00:34 INFO - ##### Running create-virtualenv step. 14:00:34 INFO - ##### 14:00:34 INFO - Running pre-action listener: _resource_record_pre_action 14:00:34 INFO - Running main action method: create_virtualenv 14:00:34 INFO - Creating virtualenv /builds/slave/test/build/venv 14:00:34 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 14:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:00:34 INFO - Using real prefix '/usr' 14:00:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 14:00:37 INFO - Installing pip.................done. 14:00:37 INFO - Return code: 0 14:00:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:00:37 INFO - Using env: {'DISPLAY': ':0', 14:00:37 INFO - 'HOME': '/home/cltbld', 14:00:37 INFO - 'LANG': 'en_US.UTF-8', 14:00:37 INFO - 'LANGUAGE': 'en_US:en', 14:00:37 INFO - 'LOGNAME': 'cltbld', 14:00:37 INFO - 'MAIL': '/var/mail/cltbld', 14:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:37 INFO - 'MOZ_NO_REMOTE': '1', 14:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:37 INFO - 'NO_EM_RESTART': '1', 14:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:37 INFO - 'PWD': '/builds/slave/test', 14:00:37 INFO - 'SHELL': '/bin/bash', 14:00:37 INFO - 'SHLVL': '1', 14:00:37 INFO - 'TERM': 'linux', 14:00:37 INFO - 'TMOUT': '86400', 14:00:37 INFO - 'USER': 'cltbld', 14:00:37 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:37 INFO - '_': '/tools/buildbot/bin/python'} 14:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:37 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 14:00:37 INFO - Cleaning up... 14:00:37 INFO - Return code: 0 14:00:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:00:37 INFO - Using env: {'DISPLAY': ':0', 14:00:37 INFO - 'HOME': '/home/cltbld', 14:00:37 INFO - 'LANG': 'en_US.UTF-8', 14:00:37 INFO - 'LANGUAGE': 'en_US:en', 14:00:37 INFO - 'LOGNAME': 'cltbld', 14:00:37 INFO - 'MAIL': '/var/mail/cltbld', 14:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:37 INFO - 'MOZ_NO_REMOTE': '1', 14:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:37 INFO - 'NO_EM_RESTART': '1', 14:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:37 INFO - 'PWD': '/builds/slave/test', 14:00:37 INFO - 'SHELL': '/bin/bash', 14:00:37 INFO - 'SHLVL': '1', 14:00:37 INFO - 'TERM': 'linux', 14:00:37 INFO - 'TMOUT': '86400', 14:00:37 INFO - 'USER': 'cltbld', 14:00:37 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:37 INFO - '_': '/tools/buildbot/bin/python'} 14:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:37 INFO - Downloading/unpacking psutil>=0.7.1 14:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:39 INFO - Installing collected packages: psutil 14:00:39 INFO - Running setup.py install for psutil 14:00:39 INFO - building 'psutil._psutil_linux' extension 14:00:39 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 14:00:39 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 14:00:39 INFO - building 'psutil._psutil_posix' extension 14:00:39 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 14:00:39 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 14:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:00:39 INFO - Successfully installed psutil 14:00:39 INFO - Cleaning up... 14:00:40 INFO - Return code: 0 14:00:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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', '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 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:00: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 mozsystemmonitor==0.0.0 14:00:40 INFO - Using env: {'DISPLAY': ':0', 14:00:40 INFO - 'HOME': '/home/cltbld', 14:00:40 INFO - 'LANG': 'en_US.UTF-8', 14:00:40 INFO - 'LANGUAGE': 'en_US:en', 14:00:40 INFO - 'LOGNAME': 'cltbld', 14:00:40 INFO - 'MAIL': '/var/mail/cltbld', 14:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:40 INFO - 'MOZ_NO_REMOTE': '1', 14:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:40 INFO - 'NO_EM_RESTART': '1', 14:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:40 INFO - 'PWD': '/builds/slave/test', 14:00:40 INFO - 'SHELL': '/bin/bash', 14:00:40 INFO - 'SHLVL': '1', 14:00:40 INFO - 'TERM': 'linux', 14:00:40 INFO - 'TMOUT': '86400', 14:00:40 INFO - 'USER': 'cltbld', 14:00:40 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:40 INFO - '_': '/tools/buildbot/bin/python'} 14:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:00:40 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 14:00:40 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 14:00:40 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 14:00:40 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 14:00:40 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 14:00:40 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 14:00:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:00:42 INFO - Installing collected packages: mozsystemmonitor 14:00:42 INFO - Running setup.py install for mozsystemmonitor 14:00:42 INFO - Successfully installed mozsystemmonitor 14:00:42 INFO - Cleaning up... 14:00:42 INFO - Return code: 0 14:00:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:00:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:00:42 INFO - Using env: {'DISPLAY': ':0', 14:00:42 INFO - 'HOME': '/home/cltbld', 14:00:42 INFO - 'LANG': 'en_US.UTF-8', 14:00:42 INFO - 'LANGUAGE': 'en_US:en', 14:00:42 INFO - 'LOGNAME': 'cltbld', 14:00:42 INFO - 'MAIL': '/var/mail/cltbld', 14:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:42 INFO - 'MOZ_NO_REMOTE': '1', 14:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:42 INFO - 'NO_EM_RESTART': '1', 14:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:42 INFO - 'PWD': '/builds/slave/test', 14:00:42 INFO - 'SHELL': '/bin/bash', 14:00:42 INFO - 'SHLVL': '1', 14:00:42 INFO - 'TERM': 'linux', 14:00:42 INFO - 'TMOUT': '86400', 14:00:42 INFO - 'USER': 'cltbld', 14:00:42 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:42 INFO - '_': '/tools/buildbot/bin/python'} 14:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:00:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:00:44 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 14:00:44 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 14:00:44 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 14:00:44 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 14:00:44 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 14:00:44 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 14:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:00:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:00:44 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 14:00:44 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 14:00:44 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 14:00:44 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 14:00:44 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 14:00:44 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 14:00:45 INFO - Downloading docopt-0.6.1.tar.gz 14:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:00:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:00:45 INFO - Running setup.py install for blobuploader 14:00:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:00:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:00:45 INFO - Running setup.py install for requests 14:00:45 INFO - Running setup.py install for docopt 14:00:45 INFO - Successfully installed blobuploader requests docopt 14:00:45 INFO - Cleaning up... 14:00:45 INFO - Return code: 0 14:00:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00:45 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')]} 14:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:45 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')]} 14:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:45 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 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:45 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 14:00:45 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 14:00:45 INFO - Using env: {'DISPLAY': ':0', 14:00:45 INFO - 'HOME': '/home/cltbld', 14:00:45 INFO - 'LANG': 'en_US.UTF-8', 14:00:45 INFO - 'LANGUAGE': 'en_US:en', 14:00:45 INFO - 'LOGNAME': 'cltbld', 14:00:45 INFO - 'MAIL': '/var/mail/cltbld', 14:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:45 INFO - 'MOZ_NO_REMOTE': '1', 14:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:45 INFO - 'NO_EM_RESTART': '1', 14:00:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:45 INFO - 'PWD': '/builds/slave/test', 14:00:45 INFO - 'SHELL': '/bin/bash', 14:00:45 INFO - 'SHLVL': '1', 14:00:45 INFO - 'TERM': 'linux', 14:00:45 INFO - 'TMOUT': '86400', 14:00:45 INFO - 'USER': 'cltbld', 14:00:45 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:45 INFO - '_': '/tools/buildbot/bin/python'} 14:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:45 INFO - Running setup.py (path:/tmp/pip-ZMMeLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:46 INFO - Running setup.py (path:/tmp/pip-f8oRET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:46 INFO - Running setup.py (path:/tmp/pip-cu5tG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:46 INFO - Running setup.py (path:/tmp/pip-5TjmkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:46 INFO - Running setup.py (path:/tmp/pip-AoaLog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:46 INFO - Running setup.py (path:/tmp/pip-tqsCWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:46 INFO - Running setup.py (path:/tmp/pip-6gf9Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:46 INFO - Running setup.py (path:/tmp/pip-pNGFGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:46 INFO - Running setup.py (path:/tmp/pip-Kxdcpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:46 INFO - Running setup.py (path:/tmp/pip-vEqH7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:46 INFO - Running setup.py (path:/tmp/pip-ECKu48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:46 INFO - Running setup.py (path:/tmp/pip-5P2Lt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:46 INFO - Running setup.py (path:/tmp/pip-omGP4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:46 INFO - Running setup.py (path:/tmp/pip-49Cmd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:46 INFO - Running setup.py (path:/tmp/pip-cU2wUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:47 INFO - Running setup.py (path:/tmp/pip-O0Y0iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:47 INFO - Running setup.py (path:/tmp/pip-3b5XI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:00:47 INFO - Running setup.py install for manifestparser 14:00:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Running setup.py install for mozcrash 14:00:47 INFO - Running setup.py install for mozdebug 14:00:47 INFO - Running setup.py install for mozdevice 14:00:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Running setup.py install for mozfile 14:00:47 INFO - Running setup.py install for mozhttpd 14:00:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Running setup.py install for mozinfo 14:00:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Running setup.py install for mozInstall 14:00:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:00:47 INFO - Running setup.py install for mozleak 14:00:48 INFO - Running setup.py install for mozlog 14:00:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:00:48 INFO - Running setup.py install for moznetwork 14:00:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:00:48 INFO - Running setup.py install for mozprocess 14:00:48 INFO - Running setup.py install for mozprofile 14:00:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:00:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:00:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:00:48 INFO - Running setup.py install for mozrunner 14:00:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:00:48 INFO - Running setup.py install for mozscreenshot 14:00:48 INFO - Running setup.py install for moztest 14:00:48 INFO - Running setup.py install for mozversion 14:00:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:00:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:00:48 INFO - Cleaning up... 14:00:48 INFO - Return code: 0 14:00:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:48 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 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:48 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 14:00:48 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 14:00:48 INFO - Using env: {'DISPLAY': ':0', 14:00:48 INFO - 'HOME': '/home/cltbld', 14:00:48 INFO - 'LANG': 'en_US.UTF-8', 14:00:48 INFO - 'LANGUAGE': 'en_US:en', 14:00:48 INFO - 'LOGNAME': 'cltbld', 14:00:48 INFO - 'MAIL': '/var/mail/cltbld', 14:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:48 INFO - 'MOZ_NO_REMOTE': '1', 14:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:48 INFO - 'NO_EM_RESTART': '1', 14:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:48 INFO - 'PWD': '/builds/slave/test', 14:00:48 INFO - 'SHELL': '/bin/bash', 14:00:48 INFO - 'SHLVL': '1', 14:00:48 INFO - 'TERM': 'linux', 14:00:48 INFO - 'TMOUT': '86400', 14:00:48 INFO - 'USER': 'cltbld', 14:00:48 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:48 INFO - '_': '/tools/buildbot/bin/python'} 14:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:00:49 INFO - Running setup.py (path:/tmp/pip-2dbU2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:00:49 INFO - Running setup.py (path:/tmp/pip-wkkJsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:00:49 INFO - Running setup.py (path:/tmp/pip-Kkx0KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:00:49 INFO - Running setup.py (path:/tmp/pip-Ng8gPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:00:49 INFO - Running setup.py (path:/tmp/pip-9eGFxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:00:49 INFO - Running setup.py (path:/tmp/pip-7KDPep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:00:49 INFO - Running setup.py (path:/tmp/pip-5DATVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:00:49 INFO - Running setup.py (path:/tmp/pip-zyB7yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:00:49 INFO - Running setup.py (path:/tmp/pip-fB19OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:00:49 INFO - Running setup.py (path:/tmp/pip-5AAG2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:00:49 INFO - Running setup.py (path:/tmp/pip-UFzfos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:00:49 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)) 14:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:00:50 INFO - Running setup.py (path:/tmp/pip-sWtlQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:00:50 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)) 14:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:00:50 INFO - Running setup.py (path:/tmp/pip-qtxYUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:00:50 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)) 14:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:00:50 INFO - Running setup.py (path:/tmp/pip-nh9GJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:00:50 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)) 14:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:50 INFO - Running setup.py (path:/tmp/pip-_J6U3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:00:50 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)) 14:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:00:50 INFO - Running setup.py (path:/tmp/pip-4G_wtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:00:50 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)) 14:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:00:50 INFO - Running setup.py (path:/tmp/pip-1PKrHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:00:50 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)) 14:00:50 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)) 14:00:50 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)) 14:00:50 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)) 14:00:50 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)) 14:00:50 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)) 14:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00: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 14:00:52 INFO - Downloading blessings-1.6.tar.gz 14:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:00:52 INFO - Installing collected packages: blessings 14:00:52 INFO - Running setup.py install for blessings 14:00:52 INFO - Successfully installed blessings 14:00:52 INFO - Cleaning up... 14:00:52 INFO - Return code: 0 14:00:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:00:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:52 INFO - Reading from file tmpfile_stdout 14:00:52 INFO - Current package versions: 14:00:52 INFO - argparse == 1.2.1 14:00:52 INFO - blessings == 1.6 14:00:52 INFO - blobuploader == 1.2.4 14:00:52 INFO - docopt == 0.6.1 14:00:52 INFO - manifestparser == 1.1 14:00:52 INFO - mozInstall == 1.12 14:00:52 INFO - mozcrash == 0.17 14:00:52 INFO - mozdebug == 0.1 14:00:52 INFO - mozdevice == 0.48 14:00:52 INFO - mozfile == 1.2 14:00:52 INFO - mozhttpd == 0.7 14:00:52 INFO - mozinfo == 0.9 14:00:52 INFO - mozleak == 0.1 14:00:52 INFO - mozlog == 3.1 14:00:52 INFO - moznetwork == 0.27 14:00:52 INFO - mozprocess == 0.22 14:00:52 INFO - mozprofile == 0.28 14:00:52 INFO - mozrunner == 6.11 14:00:52 INFO - mozscreenshot == 0.1 14:00:52 INFO - mozsystemmonitor == 0.0 14:00:52 INFO - moztest == 0.7 14:00:52 INFO - mozversion == 1.4 14:00:52 INFO - psutil == 3.1.1 14:00:52 INFO - requests == 1.2.3 14:00:52 INFO - wsgiref == 0.1.2 14:00:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:52 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 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:52 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 14:00:52 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 14:00:52 INFO - Using env: {'DISPLAY': ':0', 14:00:52 INFO - 'HOME': '/home/cltbld', 14:00:52 INFO - 'LANG': 'en_US.UTF-8', 14:00:52 INFO - 'LANGUAGE': 'en_US:en', 14:00:52 INFO - 'LOGNAME': 'cltbld', 14:00:52 INFO - 'MAIL': '/var/mail/cltbld', 14:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:52 INFO - 'MOZ_NO_REMOTE': '1', 14:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:52 INFO - 'NO_EM_RESTART': '1', 14:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:52 INFO - 'PWD': '/builds/slave/test', 14:00:52 INFO - 'SHELL': '/bin/bash', 14:00:52 INFO - 'SHLVL': '1', 14:00:52 INFO - 'TERM': 'linux', 14:00:52 INFO - 'TMOUT': '86400', 14:00:52 INFO - 'USER': 'cltbld', 14:00:52 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:52 INFO - '_': '/tools/buildbot/bin/python'} 14:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 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)) 14:00:52 INFO - Cleaning up... 14:00:52 INFO - Return code: 0 14:00:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:00:52 INFO - Using env: {'DISPLAY': ':0', 14:00:52 INFO - 'HOME': '/home/cltbld', 14:00:52 INFO - 'LANG': 'en_US.UTF-8', 14:00:52 INFO - 'LANGUAGE': 'en_US:en', 14:00:52 INFO - 'LOGNAME': 'cltbld', 14:00:52 INFO - 'MAIL': '/var/mail/cltbld', 14:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:52 INFO - 'MOZ_NO_REMOTE': '1', 14:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:52 INFO - 'NO_EM_RESTART': '1', 14:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:52 INFO - 'PWD': '/builds/slave/test', 14:00:52 INFO - 'SHELL': '/bin/bash', 14:00:52 INFO - 'SHLVL': '1', 14:00:52 INFO - 'TERM': 'linux', 14:00:52 INFO - 'TMOUT': '86400', 14:00:52 INFO - 'USER': 'cltbld', 14:00:52 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:52 INFO - '_': '/tools/buildbot/bin/python'} 14:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:53 INFO - Downloading/unpacking jsonschema 14:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:00:55 INFO - Downloading/unpacking functools32 (from jsonschema) 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - Downloading functools32-3.2.3-2.tar.gz 14:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:00:55 INFO - warning: no files found matching '*.txt' 14:00:55 INFO - no previously-included directories found matching 'build' 14:00:55 INFO - no previously-included directories found matching 'dist' 14:00:55 INFO - no previously-included directories found matching '.git*' 14:00:55 INFO - Installing collected packages: jsonschema, functools32 14:00:55 INFO - Running setup.py install for functools32 14:00:55 INFO - warning: no files found matching '*.txt' 14:00:55 INFO - no previously-included directories found matching 'build' 14:00:55 INFO - no previously-included directories found matching 'dist' 14:00:55 INFO - no previously-included directories found matching '.git*' 14:00:55 INFO - Successfully installed jsonschema functools32 14:00:55 INFO - Cleaning up... 14:00:55 INFO - Return code: 0 14:00:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:00: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')]} 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:00:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00: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')]} 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:00:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:00:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c00e6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11af8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x127a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, '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': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', '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 14:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:00:55 INFO - Using env: {'DISPLAY': ':0', 14:00:55 INFO - 'HOME': '/home/cltbld', 14:00:55 INFO - 'LANG': 'en_US.UTF-8', 14:00:55 INFO - 'LANGUAGE': 'en_US:en', 14:00:55 INFO - 'LOGNAME': 'cltbld', 14:00:55 INFO - 'MAIL': '/var/mail/cltbld', 14:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:00:55 INFO - 'MOZ_NO_REMOTE': '1', 14:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:00:55 INFO - 'NO_EM_RESTART': '1', 14:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:00:55 INFO - 'PWD': '/builds/slave/test', 14:00:55 INFO - 'SHELL': '/bin/bash', 14:00:55 INFO - 'SHLVL': '1', 14:00:55 INFO - 'TERM': 'linux', 14:00:55 INFO - 'TMOUT': '86400', 14:00:55 INFO - 'USER': 'cltbld', 14:00:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:00:55 INFO - '_': '/tools/buildbot/bin/python'} 14:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:00:55 INFO - Downloading/unpacking flake8 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:00:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:00:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:58 INFO - no previously-included directories found matching 'docs/_build' 14:00:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:00:58 INFO - Running setup.py install for pep8 14:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:00:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:00:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:00:58 INFO - no previously-included directories found matching 'docs/_build' 14:00:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:00:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:00:58 INFO - Cleaning up... 14:00:58 INFO - Return code: 0 14:00:58 INFO - Running post-action listener: _resource_record_post_action 14:00:58 INFO - Running post-action listener: _start_resource_monitoring 14:00:58 INFO - Starting resource monitoring. 14:00:58 INFO - ##### 14:00:58 INFO - ##### Running install step. 14:00:58 INFO - ##### 14:00:58 INFO - Running pre-action listener: _resource_record_pre_action 14:00:58 INFO - Running main action method: install 14:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:00:58 INFO - Reading from file tmpfile_stdout 14:00:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:00:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:00:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:00:58 INFO - Reading from file tmpfile_stdout 14:00:58 INFO - Output received: 14:00:58 INFO - Usage: mozinstall [options] installer 14:00:58 INFO - Options: 14:00:58 INFO - -h, --help show this help message and exit 14:00:58 INFO - -d DEST, --destination=DEST 14:00:58 INFO - Directory to install application into. [default: 14:00:58 INFO - "/builds/slave/test"] 14:00:58 INFO - --app=APP Application being installed. [default: firefox] 14:00:58 INFO - mkdir: /builds/slave/test/build/application 14:00:58 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'] 14:00:58 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 14:01:14 INFO - Reading from file tmpfile_stdout 14:01:14 INFO - Output received: 14:01:14 INFO - /builds/slave/test/build/application/firefox/firefox 14:01:14 INFO - Running post-action listener: _resource_record_post_action 14:01:14 INFO - ##### 14:01:14 INFO - ##### Running run-tests step. 14:01:14 INFO - ##### 14:01:14 INFO - Running pre-action listener: _resource_record_pre_action 14:01:14 INFO - Running main action method: run_tests 14:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:01:14 INFO - Python 2.7.3 14:01:14 INFO - Return code: 0 14:01:14 INFO - grabbing minidump binary from tooltool 14:01:14 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')]} 14:01:14 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 0x1309410>, '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 0x130a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x130a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:01:14 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 14:01:14 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 14:01:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:01:14 INFO - Return code: 0 14:01:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:01:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:01:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:01:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:01:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:01:15 INFO - Return code: 0 14:01:15 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/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:01:15 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/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 14:01:15 INFO - Using env: {'DISPLAY': ':0', 14:01:15 INFO - 'HOME': '/home/cltbld', 14:01:15 INFO - 'LANG': 'en_US.UTF-8', 14:01:15 INFO - 'LANGUAGE': 'en_US:en', 14:01:15 INFO - 'LOGNAME': 'cltbld', 14:01:15 INFO - 'MAIL': '/var/mail/cltbld', 14:01:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:01:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:01:15 INFO - 'MOZ_NO_REMOTE': '1', 14:01:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:01:15 INFO - 'NO_EM_RESTART': '1', 14:01:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:01:15 INFO - 'PWD': '/builds/slave/test', 14:01:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:01:15 INFO - 'SHELL': '/bin/bash', 14:01:15 INFO - 'SHLVL': '1', 14:01:15 INFO - 'TERM': 'linux', 14:01:15 INFO - 'TMOUT': '86400', 14:01:15 INFO - 'USER': 'cltbld', 14:01:15 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551', 14:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:01:15 INFO - '_': '/tools/buildbot/bin/python'} 14:01:15 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/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 14:01:15 INFO - mozversion application_buildid: 20160425132510 14:01:15 INFO - mozversion application_changeset: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 14:01:15 INFO - mozversion application_display_name: Nightly 14:01:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:01:15 INFO - mozversion application_name: Firefox 14:01:15 INFO - mozversion application_remotingname: firefox 14:01:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:01:15 INFO - mozversion application_vendor: Mozilla 14:01:15 INFO - mozversion application_version: 48.0a1 14:01:15 INFO - mozversion platform_buildid: 20160425132510 14:01:15 INFO - mozversion platform_changeset: 86e0ea42f55c34fc90dd9e32439783a9929f28f4 14:01:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:01:15 INFO - mozversion platform_version: 48.0a1 14:01:15 INFO - using testdate: 1461618075 14:01:15 INFO - actual date: 1461618075 14:01:15 INFO - starting webserver on 'localhost:45573' 14:01:15 INFO - SUITE-START | Running 2 tests 14:01:15 INFO - TEST-START | dromaeo_css 14:01:15 INFO - operating with platform_type : linux_ 14:01:15 INFO - Initialising browser for dromaeo_css test... 14:01:15 INFO - TEST-INFO | started process 14767 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnB84uK/profile http://localhost:45573/getInfo.html) 14:01:19 INFO - PROCESS | 14767 | __metrics Screen width/height:1600/1200 14:01:19 INFO - PROCESS | 14767 | colorDepth:24 14:01:19 INFO - PROCESS | 14767 | Browser inner width/height: 1024/697 14:01:19 INFO - PROCESS | 14767 | __metrics 14:01:21 ERROR - PROCESS | 14767 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:01:22 INFO - TEST-INFO | 14767: exit 0 14:01:22 INFO - Browser initialized. 14:01:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:01:22 INFO - TEST-INFO | started process 14849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnB84uK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:01:34 INFO - PROCESS | 14849 | RSS: Main: 155910144 14:01:34 INFO - PROCESS | 14849 | 14:02:25 INFO - PROCESS | 14849 | 1461618145454 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] 14:04:36 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:45573/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45573/tests/dromaeo/cssquery-ext.html) 14:04:37 INFO - PROCESS | 14849 | RSS: Main: 263368704 14:04:37 INFO - PROCESS | 14849 | 14:07:40 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:45573/tests/dromaeo/cssquery-ext.html (next: http://localhost:45573/tests/dromaeo/cssquery-jquery.html) 14:07:41 INFO - PROCESS | 14849 | RSS: Main: 234946560 14:07:41 INFO - PROCESS | 14849 | 14:10:43 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:45573/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45573/tests/dromaeo/cssquery-mootools.html) 14:10:43 INFO - PROCESS | 14849 | RSS: Main: 237907968 14:10:43 INFO - PROCESS | 14849 | 14:13:45 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:45573/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45573/tests/dromaeo/cssquery-prototype.html) 14:13:46 INFO - PROCESS | 14849 | RSS: Main: 233594880 14:13:46 INFO - PROCESS | 14849 | 14:16:49 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:45573/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45573/tests/dromaeo/cssquery-yui.html) 14:16:50 INFO - PROCESS | 14849 | RSS: Main: 213803008 14:16:50 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | Cycle 1(1): loaded http://localhost:45573/tests/dromaeo/cssquery-yui.html (next: http://localhost:45573/tests/dromaeo/cssquery-dojo.html) 14:19:52 INFO - PROCESS | 14849 | RSS: Main: 268021760 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | __start_tp_report 14:19:52 INFO - PROCESS | 14849 | _x_x_mozilla_page_load 14:19:52 INFO - PROCESS | 14849 | _x_x_mozilla_page_load_details 14:19:52 INFO - PROCESS | 14849 | |i|pagename|runs| 14:19:52 INFO - PROCESS | 14849 | |0;dojo.html;2576.3301541599185;2693.165118813167;2695.9865200673994;2702.500037493064;2732;4586.67893247472;4657.743824089674;4657.953420465794;4662.184117779392;4673.813047478101;4586.678932474728;4609.539046095389;4661.13768952744;4723.952760472394;4734.1951868182405;4227.936580951288;4243.045314804175;4278.058827058042;4319.287317592609;4413.139437809612;4348.239058164824;4369.213541562517;4369.825206991716;4398.626116780061;4429.77851107445;4171.874843754692;4257.808398622069;4262.339337402676;4301.612854843079;4330.39374487572;4296.57034296571;4310.762908040057;4320.870373888788;4327.156204540116;4378.649708023382;4241.088166044285;4281.486221653421;4308.310670292738;4313.460817397825;4340.153670034345;4372.912541749179;4555.908881822345;4562.429696287964;4606.585407313358;4640.141573808856;4900.191468407708;4958.851234462972;4959.6528243023;4965.404151501807;4981.053599816059;4960.082384758795;4960.379952505937;4992.226204938241;5000.849974500735;5038.269450929632;4486.820527178909;4623.514530974267;4630.837920672794;4706.011737535087;4710.646701497401;5130.226131029222;5132.153194722829;5139.331886854685;5159.2003239497935;5206.453322401169;4911.803527858917;4931.087748766489;4931.975340123348;4938;4983.875403114951;4876.317315575822;4973.52751488608;5010.824621138243;5016.824411145665;5060.2662613920775;4904.60763138948;4912.263160525878;4958.181899986462;4960.330355401975;4969.925451118236;4890.343340157288;4893.584045356113;4897.975510122426;4913.582345500601;4939.728314942713;4108.548059713429;4181.707280490397;4193.329067349209;4194.853180138742;4238.067625122468;3660.5058317127377;3691.6492933171307;3726.9378227205657;3731.9067023324633;3781.3193625147187;4365.432493775852;4365.890852728708;4376.562343765661;4382.517923028464;4420.469543654782;4884.633652476007;4970.254461830755;5017.623678224148;5034.043531729033;5080.441151473335;4359.760213188241;4360.563943605677;4371.606555410029;4407.493138289074;4408.713433626868;4478.0596074824;4497.505274419811;4507.2788353863225;4508.413906192174;4554.339620754972;4605.861824145281;4697.718136911796;4734.502877197913;4752.382190315237;4769.904601907873;4993.700377977333;5014.52362025607;5021.447640759587;5024.547790698854;5039.193729003342;4734.621230301636;4758.1911075118005;4764.9047019058735;4789.544993225638;4790.880227994328;4754.786034628519;4856.562909338177;4928.162212423825;4931.13705101613;4959.801607935642;4974.651774375759;4991.126552853164;5012.348394708811;5014.0974624567925;5034.345535080416;4871.3423687803115;4875.19559272716;4876.829310974099;4879.5120487952345;4912.557869791593;4713.78787954536;4789.042191561632;4872.366592342973;4905.068037072945;4905.705657660552;4768.070226305837;4768.8092476301945;4782.210935195653;4784.976075119602;4797.424309082932;4865.635077369141;4869.95130048695;4880.6095512358215;4882.316475693335;4926.359573255454;4589.5639914208095;4770.689905156154;4832.081904438145;4863.2461968394955;4885.560299573055 14:19:52 INFO - PROCESS | 14849 | |1;ext.html;568.4826807605077;594.9796099689032;605.07423641828;621.4624349937303;623.2520974830205;27295;27867.163985080428;27915.860420697893;27937.161885143454;28004.439911201815;35001.12497187572;36088.81955590225;36117.81941090297;36140;36206.094847628825;7706.306432421067;7883.290503854652;7894.60526973649;7899.526028438283;7902.130765615806;7625.504342217766;7732.884006739903;7762.30139287464;7782.688692452323;7789.454738168331;7792.610369481532;7838.333741631968;7845.7646270611685;7853.764387068397;8092.433529652927;7950.1652326505755;8012.399070069768;8024.919750802475;8026.678932842738;8028.036635603707;7837.6864925402915;7909.723159689441;7918.2477664621765;7936.761897143095;7937.48406353591;38171.80914095439;38727;38820.50615444624;38870.611293886985;38871.41692874609;2791.82922668407;2895.0880472651047;3125.3749250149835;3201.9913727175867;3562.340966921128;29167.70832291671;29204.561931571043;29416.70583294161;29716.257093572618;29904.55143172854;3335.96664033359;3338.282269312085;3380.1042723678247;3393.9490907636405;3415.419378705626;159177;159396;159632;159977.4002259974;160353.19823400924;30523.8473807634;50891.745541272794;51596.35632792991;51642.483575163766;51690.48309516932;30686.53970190449;30745.538816917764;30807.845960770053;30830.53754193689;30869.69130308713;11949.701257468632;12138.514459421702;12148.939255303667;12150;12155.331456769962;10448.477576121315;10480.266381353233;10503;10503.422311772772;10503.579856805794;7739.380849532024;7749.651265693057;8264.338852891755;8265.545395003333;8329.708460203985;3190.218396492874;3190.8883189088733;3250.268689544881;3265.1837040739815;3275.7706960512537;846.627483907079;868.5961028121953;888.4692787398521;918.9402688825205;973.0415540692412;27272.727272727017;27952.12938435665;28021.862728444707;28042;28454.288642783682;936.2930987104828;979.5053497983473;992.6823416506793;1025.0108645157459;1033.8552602635637;14507.492237771627;14882.92558537222;14973.251337433085;15338.769918451233;15399.92300038515;323174;326604;327178;329494;330265;49238.26142607792;49852.50147498478;49904.75047624738;49975.75012124989;50045;1074.3392813419691;1076.2520048566328;1187.8752730963297;1213.1023042948154;1301.4989229146656;25112.62331064999;25832.225033249033;26111.477770444104;26264.34339141537;26319.736802631727;35787.28425431529;35822;36003.27993440064;36056;36081.81959090293;181588;181662.0916895407;182962;183222;183276;20832.895835521333;23207.535849282584;23282.76717232874;23457.41356466102;25620.359491012874;35857.82071089628;35858.28283434369;36192.55042692736;36258;36735.63264367322;32109.839450802596;34589;34745.65254347424;34872.65127348796;35199;33392.66607333896;33641.3271734559;34087.48868766921;34225.14437139092;34512.82743586266;33379.499307510894;33705.662943370255;33992.490112647836;34374.48438273478;34376.48435273423;29700.554491683073;30787.384252315278;30812;30850.845745771127;31026.224344391572;23171.841407929875;23975.400614984766;24206.75793242045;24547.263582092564;24581.754182458662 14:19:52 INFO - PROCESS | 14849 | |2;jquery.html;369.15095280854047;371.5726914048843;378.63461759402173;380.5509498791425;386.6269050366397;15550.766738498918;17139.228734706954;17720.82279177208;17740.112994350264;17749.02380369081;15810.13044282564;16758.83241167588;16942.49172524823;16949.372847208673;16950.406735764253;4988.900221995558;5207.791688332462;5246.842594722146;5254.21186821976;5254.973725131388;3741.195642936768;5157.123289040872;5607.719614019283;5920.052791553352;5922.3485416604135;5852.824415267549;5866.970665146669;5876.294844618652;5879.52963762898;5881.3530511643685;5810.825675229728;5880.117982302646;5884.7940322088525;5886.293644762656;5891.587588868781;3425.2122011937145;4985.227289770091;5051.292819005343;5226.581873450153;5230.320058392384;19387.515312117168;19412;19638.312659057006;19825.603487930162;20292.79707202924;1809.5837957269903;1944.5041514413876;2000.7198992141111;2035.6844689073068;2486.2292689266205;12640.367981600883;12949.352532373343;12998.285094319808;13089.08376413642;13187.86812131876;1738.4350086222028;1764.5059383372677;1788.534980904974;1790.113893622652;1826.3333883132561;66027.33972660308;66530.66734666344;67035;67318.32681673218;68234.31765682329;9354.625814967325;9469;9657.275704322205;9849.359791613522;9885.357451765612;13290.534831280858;13383.464661413434;13421.530246441524;13435.865641343657;13450.394732237073;6958.965205174043;6963.373296403247;7093.290670932865;7112.822179445555;7144.035555199982;6616.073749675049;6677.399034086956;6780.321967803279;6798.898016529756;6802.93197068023;5935.198748168942;5969.104634304889;5979.133025711248;6001.369856165127;6022.307434644984;1665.6751933372875;1711.6747817914556;1728.4641761054113;1789.4184390073278;1829.5151784777045;786.3905473258156;956.9521523923776;983.8770153730784;1004.57305645102;1008.2488546033105;15561.688766224612;16002.679946401007;16131.467510586475;17388.739168912478;17685.93884366942;853.6372041882299;867.3798234262532;921.9446833189896;928.5032507608397;933.9579718912665;9620.855687164698;9726.805463890683;10053.296269261227;10059.597616095274;10104.141148002354;332179;337699;348171;353154;353356;69565.65217173983;70047.64976175087;71732.2826771736;72087;72170.27829721635;877.4779006491127;898.9595468203946;905.8550631898864;906.2885634776669;938.671464987249;15231.619209519407;15242.923785381003;15352.846471535142;15481.53555393295;15555.688886222439;32103.839480802446;32198.678013220506;32224;32631.347373052882;33548.99353019414;40890.59109408987;43499;44345.55654443414;44987.775061124485;45252;7565.6973721050545;7620.80947976305;7653.6555854985545;7690.230976902265;7796.064472263365;11451;11484.827727583926;11533.135014873751;11622.767544649229;11867.465964031811;10066.748331291776;10183.185345172516;10255.538500767632;10270.281080324306;10437;9917.504124793588;10040.799184016425;10090.192784577363;10338.793224135625;10785.245032847626;10110.191184705352;10316.071553559916;10465.9476702616;10476;10747.785044298915;7404.407647388089;7424.524488054164;7523.495300939724;7665.23347665229;7684.346830519245;10179.949100254451;10219.642312519027;10345.896541034494;10365.170786337225;10504.791948925971 14:19:52 INFO - PROCESS | 14849 | |3;mootools.html;1221.4930803716459;1440.4886265375794;1442.3076923076924;1579.3524654891496;1731.7229243321062;6674.766383176584;7513.135989361225;7739.806504837382;7765.534067955927;7779.533228006324;7468.51454655447;7635.694572217105;7646.273604007624;7647.34997525211;7652.540847549151;2186.7922547358057;2213.9889300553473;2222.122261706625;2222.9888850555726;2223.566404551113;2098.517341011568;2140.7538133114736;2197.0333053456507;2206.470447092702;2208.4699672078664;2064.370367038053;2089.0912453082883;2098.4963608733947;2099.632564301241;2103.863248888825;1895.1945423195157;1896.0614495824586;1900.4583693647244;1902.3627084926566;1902.5624106455523;2029.046348216336;2053.5892821435623;2083.0522112438803;2088.321295578943;2088.4361222469847;7451.664675089634;7621.885671714873;7700.229977002311;7715.305622493946;7729.690812367498;4506.301523263899;4644.210484217691;4650.372199753024;4653.627709783209;4661.6969896956925;2855.229088146189;2891.6963718809434;2895.17487516059;2933.809302395359;2943.838088905131;858.4591707224471;866.6966561703354;871.0418539606445;872.2324354568003;883.4081165619051;9801.852972205423;9889.258305627107;10141.138003269805;10159.746006349826;10206.693799186036;3949.585293544194;4022.3765316376007;4097.344424892003;4108.958910410857;4129.772862492532;8057.274845263954;8092.473989190684;8097.878531822027;8105.189481051848;8107.797305067303;4375.387445757597;4408.911821763547;4425.601695847389;4432.778361081933;4440.489343725513;3660.9633903661156;4117.094239267356;4151.709380343347;4190.120074784269;4250.638695710899;3368.1074515253476;3380.8985730428126;3450;3455.3434847378917;3473.600535938349;1016.5730393234859;1065.912768975656;1071.314358810362;1087.141158484804;1090.4547726136932;679.8198477403492;784.3762614055973;792.1326147868075;821.5686764448593;835.9832803343899;4898.387701537308;4899.363082799285;4923.679960802537;4927.975360123177;5014.824481143215;367.13173345039326;372.97948612826553;373.82617083055965;374.12081608220467;384.1012031845439;3364.9495257571157;3429.4684323929832;3436.7250619950346;3466.705330046924;3515.736319776027;9126.634934602675;9504.42973421597;9649.179819715402;9661.227101831837;9664.226861851035;9317.580708868118;9452.385594936444;9467.337286389886;9588.472634005197;9598.040195980486;7182.42540596751;7227.421806255382;7299.963500182571;7321.524100933422;7347.228541003225;4778.331033655221;4841.104395686809;4867.878303042311;5284.9735751320995;5287.735613219401;8567.228949394585;8690.391672582859;8718.694845680371;8770.342224333073;8784.956075219583;8219.95890020546;8696.91303086961;8717.607707653298;8813;8821.867671984797;5949.137375080676;6352.460040896391;6539.771108011197;6595.307492713388;6779.932200678128;7287.4534409920525;7345.485815993043;7358.852822943618;7387.519811212254;7415.443841711785;6403.807885763248;6507.577007494498;6555.180602424697;6682.899756503753;6705.262421133574;6385.106085148176;6404.4876409886165;6460.903086453801;6648;6748.460123190232;5627.099664053731;5668.631538949955;5678.829635110953;5686.147077938177;5687.9431205687415;4143.875683729493;4330.9350359744;4354.651627869699;4389.473263208435;4468.195724769573;4281.871543853689;4298.9570104298555;4328.220920234262;4345.435093437833;4392.3411488277015 14:19:52 INFO - PROCESS | 14849 | |4;prototype.html;290.89963962432967;299.9910002699919;305.9219898925774;307.1982126649446;307.8506924141792;4643.883902902429;4682.625389968803;4697.835575754853;4698.741569213692;4712.952870471294;4333.804978775955;4466.8436604718845;4600.194965880966;4660.1844677181525;4661.5804577588015;3671.761335513183;3693;3719.9070023249365;3745.4007358822596;3748.6063963283873;3707.462417949396;3724.7951362675044;3725.18046029873;3752.662260396564;3754.1740817020213;3489.5114683944266;3594.3530164570366;3718.2563487302646;3727.2545490901794;3734.271816995687;3656.8537258509627;3670.541182352206;3673.8588506826814;3695.4826324314618;3710.07248187953;3323.9501407478665;3325.235195904931;3334.0997930558856;3344.6822551857535;3345.7657963942534;4336.327869180251;4423.601875831158;4451.844185453526;4480.372747815309;4506.864794056183;4189.413482112506;4214.36784482327;4221.7255878367805;4224.197402493516;4245.172191422674;4846.854594362175;4861.562459378638;4871.975640121776;4877.1708809502115;4895.094407534618;3596.334678084537;3601.675849173561;3618.4572314152824;3622.42041273395;3626.3110009098186;5000.499950005007;5055;5103.157978933472;5108.463611320795;5129.487051294878;3679.687226585717;3684;3700;3702.315071711742;3705.27747089315;3735.7945313008045;3739.5886452490204;3760.0483620357886;3763.6612704856148;3764.887053388348;4036.1524079943542;4190.937135942963;4196.880575309449;4205.747655140702;4215.768132752667;4865.0756356292195;4869.269609558523;4878.512148785093;4887.902241955141;4896.11869863428;1284.8201251824753;1326.8208791813174;1355.4307190979812;1370.4449697872378;1371.7530844447895;935.7239614313794;936.864154697565;952.1716106986827;960.3757557587624;960.7742180587557;4619.792109355087;4628.514006029319;4637.25803871379;4640.211164102111;4651.534846515389;5306.116328703332;5317.9202311965355;5332.30680011596;5340.8250184960025;5340.973295133577;4483.843065492692;4606.078784243165;4607.424071991001;4607.44710634726;4619.445666520039;2819.9859000704864;2840.076974983139;2845.2744550139582;2849;2855.300451389423;5032.094223039815;5046.394432668103;5050;5053.722045287471;5085.7202853842655;5208.791648334024;5411.161270003156;5464.453554644504;5479.17812328146;5488.502731257268;5007.9499205008215;5034.572061374751;5036.496350364934;5044.86490539633;5047.470015648378;5285.9471405286995;5303.098473259633;5304.416514183514;5316.734163291742;5327.440618735132;4713.2223183175765;5005.974970125126;5007.499250074963;5230.084735171254;5233.450487698737;4788.497207793132;4789.85043589543;4834.5890599299455;4837.564619184291;4850.636202284913;3524.7532672712664;3570.7143428525137;3578.373784587635;3580.8567657293415;3590.856365745341;4802.567768900815;4837.177679794514;5056.418511871182;5082.796688132434;5125.666831655931;4790.305405716222;4895.33912921751;4942.20924652054;4952.331435256338;4965.329680493087;4887.951120488749;4903.33804936329;4917.213245880642;4941.579965702956;4951.72765497901;4634.72191668501;4868.196747536758;4872.342233798392;4884.63365247615;4886.706797592155;4905.926411103765;4968.8757781055765;5002.149634562061;5011.398632164163;5019.498050194951;4861.1979023460735;4880.145974454527;4913.140200464976;4921.655484116221;4929.926051109308 14:19:52 INFO - PROCESS | 14849 | |5;yui.html;647.2427260105677;734.3684431389005;749.3555542233678;754.0875540595879;769.5382770337798;11539.942300288498;11648.24286421382;11675.591354302602;11717.0626349892;11981.400929953501;12452.564160254393;12782.488700451971;12814.231146131238;12827.679308017305;12853.22880627163;638.936106389362;793.8372633610096;796.4066770256168;799.4523751230397;800.1478425476878;782.6634547144754;812.0782911395579;814.4950130918838;814.7311387242225;815.0830315894618;846.2172490446343;846.6824940647257;847.737201467544;848.855694531928;849.8852654891572;660.4419265720459;802.5585927739778;843.1947490146895;845.121074082953;846.7925358287198;608.7960533221376;609.1380696314709;609.2962628164477;609.5306613907267;610.5634471353004;12976.15654982423;13066.673333166651;13085.149465284727;13087.345632718327;13101.737965240642;11237;11788.764224715544;11794.705132371673;12024.759504809856;12226.449809758493;9687.951560242154;9829;9848.359856609297;9876.209903207726;9972.351797133164;3287.063186991696;3329.1177837872983;3362.193073662328;3381.1716129548417;3449.3273811606746;45344.3198352025;46058.76970615125;46306.30540541895;46311;46749.76625116887;9491.525423728786;9519.476428796344;9562.856557151648;9675.564599592895;9771.876234233012;17175.742363864552;17224.311027558757;17275.654486910444;17294.13529323529;17302.22140003678;5923.911141332884;6089.634621922699;6251.906221406683;6296.307406185316;6368.490520758328;3381.1378098585196;3439.7592168547963;3440.0367896988882;3448.567323134107;3494.3011397720556;2708.295843080813;2831.759300459484;2832.9433411331656;2835.5463125899755;2835.631367922157;485.34236110070344;496.6994968044281;510.91569890968316;513.7482633509553;513.8252993982064;380.9333366660823;561.6798424897769;564.3509963541877;568.8350378390303;591.9082542205879;6965.283320031964;7307.269273072757;7404.629768511553;7570.16728159902;7607.35337496308;540.9053415652245;546.1561886884773;558.6592178770946;558.7848678258819;562.103445005216;3493.7554371194283;3692.667659910621;3701.9233151788317;3732.1789206374556;3743.2648646492894;54567.45432545703;55213;55300.44699552953;55882.720586396805;56896.431035689115;45710;47113.764431177624;47552;47582.762086189345;49205.50794492009;42315.788421058314;43453.56546434495;43518.34722479165;43720.344194837104;44127.558724412986;7099.538529995534;7141.321574450419;7287.890681639674;7317.817054573678;7403.777886663409;28450.146495605164;28940.42119157647;29487.410251794416;29638;29676;36383.63616363909;38153.236935261695;38607;38953.61046389613;39368;8773.649054038022;8804.691835785718;8874.866876996979;9089.272858171462;9198.402103863227;9689.467079310705;9747.561359738687;9873.605055797687;10010.249231307535;10161.898381016392;8240.793980150544;9659.227261819178;9955.352902061633;10135.290529662852;10285.588576456857;10216.897831021595;10389.636362727268;10468.738281543023;10554.313969591953;10739.087177589992;9025.774355641162;9124.680636177702;9181.21959633412;9190.58642361082;9275.582598783207;7809.882851757115;8310.958445207736;8397.664093436195;8535.573221339033;8777.780555485908;8678.218960293603;8825.338099642424;8880.200781929658;8912.465252084896;9230.723078307661 14:19:52 INFO - PROCESS | 14849 | __end_tp_report 14:19:52 INFO - PROCESS | 14849 | __start_cc_report 14:19:52 INFO - PROCESS | 14849 | _x_x_mozilla_cycle_collect,1011 14:19:52 INFO - PROCESS | 14849 | __end_cc_report 14:19:52 INFO - PROCESS | 14849 | __startTimestamp1461619192845__endTimestamp 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | ------- Summary: start ------- 14:19:52 INFO - PROCESS | 14849 | Number of tests: 6 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | [#0] dojo.html Cycles:165 Average:4616.53 Median:4754.79 stddev:468.59 (9.9%) stddev-sans-first:441.85 14:19:52 INFO - PROCESS | 14849 | Values: 2576.3 2693.2 2696.0 2702.5 2732.0 4586.7 4657.7 4658.0 4662.2 4673.8 4586.7 4609.5 4661.1 4724.0 4734.2 4227.9 4243.0 4278.1 4319.3 4413.1 4348.2 4369.2 4369.8 4398.6 4429.8 4171.9 4257.8 4262.3 4301.6 4330.4 4296.6 4310.8 4320.9 4327.2 4378.6 4241.1 4281.5 4308.3 4313.5 4340.2 4372.9 4555.9 4562.4 4606.6 4640.1 4900.2 4958.9 4959.7 4965.4 4981.1 4960.1 4960.4 4992.2 5000.8 5038.3 4486.8 4623.5 4630.8 4706.0 4710.6 5130.2 5132.2 5139.3 5159.2 5206.5 4911.8 4931.1 4932.0 4938.0 4983.9 4876.3 4973.5 5010.8 5016.8 5060.3 4904.6 4912.3 4958.2 4960.3 4969.9 4890.3 4893.6 4898.0 4913.6 4939.7 4108.5 4181.7 4193.3 4194.9 4238.1 3660.5 3691.6 3726.9 3731.9 3781.3 4365.4 4365.9 4376.6 4382.5 4420.5 4884.6 4970.3 5017.6 5034.0 5080.4 4359.8 4360.6 4371.6 4407.5 4408.7 4478.1 4497.5 4507.3 4508.4 4554.3 4605.9 4697.7 4734.5 4752.4 4769.9 4993.7 5014.5 5021.4 5024.5 5039.2 4734.6 4758.2 4764.9 4789.5 4790.9 4754.8 4856.6 4928.2 4931.1 4959.8 4974.7 4991.1 5012.3 5014.1 5034.3 4871.3 4875.2 4876.8 4879.5 4912.6 4713.8 4789.0 4872.4 4905.1 4905.7 4768.1 4768.8 4782.2 4785.0 4797.4 4865.6 4870.0 4880.6 4882.3 4926.4 4589.6 4770.7 4832.1 4863.2 4885.6 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | [#1] ext.html Cycles:180 Average:37057.59 Median:18365.47 stddev:61908.99 (337.1%) stddev-sans-first:62022.04 14:19:52 INFO - PROCESS | 14849 | Values: 568.5 595.0 605.1 621.5 623.3 27295.0 27867.2 27915.9 27937.2 28004.4 35001.1 36088.8 36117.8 36140.0 36206.1 7706.3 7883.3 7894.6 7899.5 7902.1 7625.5 7732.9 7762.3 7782.7 7789.5 7792.6 7838.3 7845.8 7853.8 8092.4 7950.2 8012.4 8024.9 8026.7 8028.0 7837.7 7909.7 7918.2 7936.8 7937.5 38171.8 38727.0 38820.5 38870.6 38871.4 2791.8 2895.1 3125.4 3202.0 3562.3 29167.7 29204.6 29416.7 29716.3 29904.6 3336.0 3338.3 3380.1 3393.9 3415.4 159177.0 159396.0 159632.0 159977.4 160353.2 30523.8 50891.7 51596.4 51642.5 51690.5 30686.5 30745.5 30807.8 30830.5 30869.7 11949.7 12138.5 12148.9 12150.0 12155.3 10448.5 10480.3 10503.0 10503.4 10503.6 7739.4 7749.7 8264.3 8265.5 8329.7 3190.2 3190.9 3250.3 3265.2 3275.8 846.6 868.6 888.5 918.9 973.0 27272.7 27952.1 28021.9 28042.0 28454.3 936.3 979.5 992.7 1025.0 1033.9 14507.5 14882.9 14973.3 15338.8 15399.9 323174.0 326604.0 327178.0 329494.0 330265.0 49238.3 49852.5 49904.8 49975.8 50045.0 1074.3 1076.3 1187.9 1213.1 1301.5 25112.6 25832.2 26111.5 26264.3 26319.7 35787.3 35822.0 36003.3 36056.0 36081.8 181588.0 181662.1 182962.0 183222.0 183276.0 20832.9 23207.5 23282.8 23457.4 25620.4 35857.8 35858.3 36192.6 36258.0 36735.6 32109.8 34589.0 34745.7 34872.7 35199.0 33392.7 33641.3 34087.5 34225.1 34512.8 33379.5 33705.7 33992.5 34374.5 34376.5 29700.6 30787.4 30812.0 30850.8 31026.2 23171.8 23975.4 24206.8 24547.3 24581.8 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | [#2] jquery.html Cycles:180 Average:22619.88 Median:370.36 stddev:56954.79 (15378.1%) stddev-sans-first:57090.07 14:19:52 INFO - PROCESS | 14849 | Values: 369.2 371.6 378.6 380.6 386.6 15550.8 17139.2 17720.8 17740.1 17749.0 15810.1 16758.8 16942.5 16949.4 16950.4 4988.9 5207.8 5246.8 5254.2 5255.0 3741.2 5157.1 5607.7 5920.1 5922.3 5852.8 5867.0 5876.3 5879.5 5881.4 5810.8 5880.1 5884.8 5886.3 5891.6 3425.2 4985.2 5051.3 5226.6 5230.3 19387.5 19412.0 19638.3 19825.6 20292.8 1809.6 1944.5 2000.7 2035.7 2486.2 12640.4 12949.4 12998.3 13089.1 13187.9 1738.4 1764.5 1788.5 1790.1 1826.3 66027.3 66530.7 67035.0 67318.3 68234.3 9354.6 9469.0 9657.3 9849.4 9885.4 13290.5 13383.5 13421.5 13435.9 13450.4 6959.0 6963.4 7093.3 7112.8 7144.0 6616.1 6677.4 6780.3 6798.9 6802.9 5935.2 5969.1 5979.1 6001.4 6022.3 1665.7 1711.7 1728.5 1789.4 1829.5 786.4 957.0 983.9 1004.6 1008.2 15561.7 16002.7 16131.5 17388.7 17685.9 853.6 867.4 921.9 928.5 934.0 9620.9 9726.8 10053.3 10059.6 10104.1 332179.0 337699.0 348171.0 353154.0 353356.0 69565.7 70047.6 71732.3 72087.0 72170.3 877.5 899.0 905.9 906.3 938.7 15231.6 15242.9 15352.8 15481.5 15555.7 32103.8 32198.7 32224.0 32631.3 33549.0 40890.6 43499.0 44345.6 44987.8 45252.0 7565.7 7620.8 7653.7 7690.2 7796.1 11451.0 11484.8 11533.1 11622.8 11867.5 10066.7 10183.2 10255.5 10270.3 10437.0 9917.5 10040.8 10090.2 10338.8 10785.2 10110.2 10316.1 10465.9 10476.0 10747.8 7404.4 7424.5 7523.5 7665.2 7684.3 10179.9 10219.6 10345.9 10365.2 10504.8 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | [#3] mootools.html Cycles:180 Average:4935.38 Median:4883.13 stddev:2797.11 (57.3%) stddev-sans-first:2791.03 14:19:52 INFO - PROCESS | 14849 | Values: 1221.5 1440.5 1442.3 1579.4 1731.7 6674.8 7513.1 7739.8 7765.5 7779.5 7468.5 7635.7 7646.3 7647.3 7652.5 2186.8 2214.0 2222.1 2223.0 2223.6 2098.5 2140.8 2197.0 2206.5 2208.5 2064.4 2089.1 2098.5 2099.6 2103.9 1895.2 1896.1 1900.5 1902.4 1902.6 2029.0 2053.6 2083.1 2088.3 2088.4 7451.7 7621.9 7700.2 7715.3 7729.7 4506.3 4644.2 4650.4 4653.6 4661.7 2855.2 2891.7 2895.2 2933.8 2943.8 858.5 866.7 871.0 872.2 883.4 9801.9 9889.3 10141.1 10159.7 10206.7 3949.6 4022.4 4097.3 4109.0 4129.8 8057.3 8092.5 8097.9 8105.2 8107.8 4375.4 4408.9 4425.6 4432.8 4440.5 3661.0 4117.1 4151.7 4190.1 4250.6 3368.1 3380.9 3450.0 3455.3 3473.6 1016.6 1065.9 1071.3 1087.1 1090.5 679.8 784.4 792.1 821.6 836.0 4898.4 4899.4 4923.7 4928.0 5014.8 367.1 373.0 373.8 374.1 384.1 3364.9 3429.5 3436.7 3466.7 3515.7 9126.6 9504.4 9649.2 9661.2 9664.2 9317.6 9452.4 9467.3 9588.5 9598.0 7182.4 7227.4 7300.0 7321.5 7347.2 4778.3 4841.1 4867.9 5285.0 5287.7 8567.2 8690.4 8718.7 8770.3 8785.0 8220.0 8696.9 8717.6 8813.0 8821.9 5949.1 6352.5 6539.8 6595.3 6779.9 7287.5 7345.5 7358.9 7387.5 7415.4 6403.8 6507.6 6555.2 6682.9 6705.3 6385.1 6404.5 6460.9 6648.0 6748.5 5627.1 5668.6 5678.8 5686.1 5687.9 4143.9 4330.9 4354.7 4389.5 4468.2 4281.9 4299.0 4328.2 4345.4 4392.3 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | [#4] prototype.html Cycles:180 Average:4161.26 Median:4660.88 stddev:1191.87 (25.6%) stddev-sans-first:1159.27 14:19:52 INFO - PROCESS | 14849 | Values: 290.9 300.0 305.9 307.2 307.9 4643.9 4682.6 4697.8 4698.7 4713.0 4333.8 4466.8 4600.2 4660.2 4661.6 3671.8 3693.0 3719.9 3745.4 3748.6 3707.5 3724.8 3725.2 3752.7 3754.2 3489.5 3594.4 3718.3 3727.3 3734.3 3656.9 3670.5 3673.9 3695.5 3710.1 3324.0 3325.2 3334.1 3344.7 3345.8 4336.3 4423.6 4451.8 4480.4 4506.9 4189.4 4214.4 4221.7 4224.2 4245.2 4846.9 4861.6 4872.0 4877.2 4895.1 3596.3 3601.7 3618.5 3622.4 3626.3 5000.5 5055.0 5103.2 5108.5 5129.5 3679.7 3684.0 3700.0 3702.3 3705.3 3735.8 3739.6 3760.0 3763.7 3764.9 4036.2 4190.9 4196.9 4205.7 4215.8 4865.1 4869.3 4878.5 4887.9 4896.1 1284.8 1326.8 1355.4 1370.4 1371.8 935.7 936.9 952.2 960.4 960.8 4619.8 4628.5 4637.3 4640.2 4651.5 5306.1 5317.9 5332.3 5340.8 5341.0 4483.8 4606.1 4607.4 4607.4 4619.4 2820.0 2840.1 2845.3 2849.0 2855.3 5032.1 5046.4 5050.0 5053.7 5085.7 5208.8 5411.2 5464.5 5479.2 5488.5 5007.9 5034.6 5036.5 5044.9 5047.5 5285.9 5303.1 5304.4 5316.7 5327.4 4713.2 5006.0 5007.5 5230.1 5233.5 4788.5 4789.9 4834.6 4837.6 4850.6 3524.8 3570.7 3578.4 3580.9 3590.9 4802.6 4837.2 5056.4 5082.8 5125.7 4790.3 4895.3 4942.2 4952.3 4965.3 4888.0 4903.3 4917.2 4941.6 4951.7 4634.7 4868.2 4872.3 4884.6 4886.7 4905.9 4968.9 5002.1 5011.4 5019.5 4861.2 4880.1 4913.1 4921.7 4929.9 14:19:52 INFO - PROCESS | 14849 | 14:19:52 INFO - PROCESS | 14849 | [#5] yui.html Cycles:180 Average:12550.11 Median:558.72 stddev:14869.05 (2661.3%) stddev-sans-first:14883.89 14:19:52 INFO - PROCESS | 14849 | Values: 647.2 734.4 749.4 754.1 769.5 11539.9 11648.2 11675.6 11717.1 11981.4 12452.6 12782.5 12814.2 12827.7 12853.2 638.9 793.8 796.4 799.5 800.1 782.7 812.1 814.5 814.7 815.1 846.2 846.7 847.7 848.9 849.9 660.4 802.6 843.2 845.1 846.8 608.8 609.1 609.3 609.5 610.6 12976.2 13066.7 13085.1 13087.3 13101.7 11237.0 11788.8 11794.7 12024.8 12226.4 9688.0 9829.0 9848.4 9876.2 9972.4 3287.1 3329.1 3362.2 3381.2 3449.3 45344.3 46058.8 46306.3 46311.0 46749.8 9491.5 9519.5 9562.9 9675.6 9771.9 17175.7 17224.3 17275.7 17294.1 17302.2 5923.9 6089.6 6251.9 6296.3 6368.5 3381.1 3439.8 3440.0 3448.6 3494.3 2708.3 2831.8 2832.9 2835.5 2835.6 485.3 496.7 510.9 513.7 513.8 380.9 561.7 564.4 568.8 591.9 6965.3 7307.3 7404.6 7570.2 7607.4 540.9 546.2 558.7 558.8 562.1 3493.8 3692.7 3701.9 3732.2 3743.3 54567.5 55213.0 55300.4 55882.7 56896.4 45710.0 47113.8 47552.0 47582.8 49205.5 42315.8 43453.6 43518.3 43720.3 44127.6 7099.5 7141.3 7287.9 7317.8 7403.8 28450.1 28940.4 29487.4 29638.0 29676.0 36383.6 38153.2 38607.0 38953.6 39368.0 8773.6 8804.7 8874.9 9089.3 9198.4 9689.5 9747.6 9873.6 10010.2 10161.9 8240.8 9659.2 9955.4 10135.3 10285.6 10216.9 10389.6 10468.7 10554.3 10739.1 9025.8 9124.7 9181.2 9190.6 9275.6 7809.9 8311.0 8397.7 8535.6 8777.8 8678.2 8825.3 8880.2 8912.5 9230.7 14:19:52 INFO - PROCESS | 14849 | -------- Summary: end -------- 14:19:52 INFO - PROCESS | 14849 | 14:19:53 INFO - TEST-INFO | 14849: exit 0 14:19:53 INFO - TEST-OK | dromaeo_css | took 1117757ms 14:19:53 INFO - TEST-START | kraken 14:19:53 INFO - operating with platform_type : linux_ 14:19:53 INFO - Initialising browser for kraken test... 14:19:53 INFO - TEST-INFO | started process 15033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uMXa7/profile http://localhost:45573/getInfo.html) 14:19:57 INFO - PROCESS | 15033 | __metrics Screen width/height:1600/1200 14:19:57 INFO - PROCESS | 15033 | colorDepth:24 14:19:57 INFO - PROCESS | 15033 | Browser inner width/height: 1024/697 14:19:57 INFO - PROCESS | 15033 | __metrics 14:19:58 ERROR - PROCESS | 15033 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:19:59 INFO - TEST-INFO | 15033: exit 0 14:19:59 INFO - Browser initialized. 14:19:59 INFO - Running cycle 1/1 for kraken test... 14:19:59 INFO - TEST-INFO | started process 15117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6uMXa7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:20:11 INFO - PROCESS | 15117 | RSS: Main: 156233728 14:20:11 INFO - PROCESS | 15117 | 14:20:14 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45573/tests/kraken/driver.html?testName=audio-beat-detection) 14:20:15 INFO - PROCESS | 15117 | RSS: Main: 210653184 14:20:15 INFO - PROCESS | 15117 | 14:20:18 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45573/tests/kraken/driver.html?testName=audio-dft) 14:20:18 INFO - PROCESS | 15117 | RSS: Main: 196939776 14:20:18 INFO - PROCESS | 15117 | 14:20:21 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45573/tests/kraken/driver.html?testName=audio-fft) 14:20:22 INFO - PROCESS | 15117 | RSS: Main: 266534912 14:20:22 INFO - PROCESS | 15117 | 14:20:24 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45573/tests/kraken/driver.html?testName=audio-oscillator) 14:20:25 INFO - PROCESS | 15117 | RSS: Main: 175706112 14:20:25 INFO - PROCESS | 15117 | 14:20:27 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45573/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:20:28 INFO - PROCESS | 15117 | RSS: Main: 179625984 14:20:28 INFO - PROCESS | 15117 | 14:20:31 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45573/tests/kraken/driver.html?testName=imaging-darkroom) 14:20:31 INFO - PROCESS | 15117 | RSS: Main: 215597056 14:20:31 INFO - PROCESS | 15117 | 14:20:35 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45573/tests/kraken/driver.html?testName=imaging-desaturate) 14:20:35 INFO - PROCESS | 15117 | RSS: Main: 216698880 14:20:35 INFO - PROCESS | 15117 | 14:20:38 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45573/tests/kraken/driver.html?testName=json-parse-financial) 14:20:39 INFO - PROCESS | 15117 | RSS: Main: 216760320 14:20:39 INFO - PROCESS | 15117 | 14:20:41 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45573/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:20:41 INFO - PROCESS | 15117 | RSS: Main: 203055104 14:20:41 INFO - PROCESS | 15117 | 14:20:43 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:20:44 INFO - PROCESS | 15117 | RSS: Main: 206704640 14:20:44 INFO - PROCESS | 15117 | 14:20:46 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:20:47 INFO - PROCESS | 15117 | RSS: Main: 217292800 14:20:47 INFO - PROCESS | 15117 | 14:20:49 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:20:50 INFO - PROCESS | 15117 | RSS: Main: 226127872 14:20:50 INFO - PROCESS | 15117 | 14:20:53 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:20:53 INFO - PROCESS | 15117 | RSS: Main: 221786112 14:20:53 INFO - PROCESS | 15117 | 14:20:55 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:45573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45573/tests/kraken/driver.html?testName=ai-astar) 14:20:56 INFO - PROCESS | 15117 | RSS: Main: 285163520 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | __start_tp_report 14:20:56 INFO - PROCESS | 15117 | _x_x_mozilla_page_load 14:20:56 INFO - PROCESS | 15117 | _x_x_mozilla_page_load_details 14:20:56 INFO - PROCESS | 15117 | |i|pagename|runs| 14:20:56 INFO - PROCESS | 15117 | |0;ai-astar;113;116;109;113;114;117;102;113;113;115 14:20:56 INFO - PROCESS | 15117 | |1;audio-beat-detection;155;131;155;181;137;161;158;140;183;133 14:20:56 INFO - PROCESS | 15117 | |2;audio-dft;161;162;161;161;162;161;161;161;162;162 14:20:56 INFO - PROCESS | 15117 | |3;audio-fft;76;74;108;111;73;74;76;120;101;74 14:20:56 INFO - PROCESS | 15117 | |4;audio-oscillator;94;94;141;95;95;94;145;94;93;156 14:20:56 INFO - PROCESS | 15117 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;118 14:20:56 INFO - PROCESS | 15117 | |6;imaging-darkroom;146;146;145;146;145;146;146;147;147;147 14:20:56 INFO - PROCESS | 15117 | |7;imaging-desaturate;95;94;94;94;95;95;95;95;95;95 14:20:56 INFO - PROCESS | 15117 | |8;json-parse-financial;65;66;66;65;65;66;66;83;63;66 14:20:56 INFO - PROCESS | 15117 | |9;json-stringify-tinderbox;64;64;64;63;64;64;63;64;63;64 14:20:56 INFO - PROCESS | 15117 | |10;stanford-crypto-aes;80;78;77;86;79;80;81;80;80;80 14:20:56 INFO - PROCESS | 15117 | |11;stanford-crypto-ccm;131;139;131;136;131;128;128;131;163;134 14:20:56 INFO - PROCESS | 15117 | |12;stanford-crypto-pbkdf2;173;181;173;172;173;176;174;172;174;174 14:20:56 INFO - PROCESS | 15117 | |13;stanford-crypto-sha256-iterative;74;73;74;74;73;73;72;73;72;72 14:20:56 INFO - PROCESS | 15117 | __end_tp_report 14:20:56 INFO - PROCESS | 15117 | __start_cc_report 14:20:56 INFO - PROCESS | 15117 | _x_x_mozilla_cycle_collect,1924 14:20:56 INFO - PROCESS | 15117 | __end_cc_report 14:20:56 INFO - PROCESS | 15117 | __startTimestamp1461619256024__endTimestamp 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | ------- Summary: start ------- 14:20:56 INFO - PROCESS | 15117 | Number of tests: 14 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:4.28 (3.8%) stddev-sans-first:4.53 14:20:56 INFO - PROCESS | 15117 | Values: 113.0 116.0 109.0 113.0 114.0 117.0 102.0 113.0 113.0 115.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:156.50 stddev:18.52 (11.8%) stddev-sans-first:19.64 14:20:56 INFO - PROCESS | 15117 | Values: 155.0 131.0 155.0 181.0 137.0 161.0 158.0 140.0 183.0 133.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 14:20:56 INFO - PROCESS | 15117 | Values: 161.0 162.0 161.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#3] audio-fft Cycles:10 Average:88.70 Median:74.00 stddev:18.91 (25.6%) stddev-sans-first:19.49 14:20:56 INFO - PROCESS | 15117 | Values: 76.0 74.0 108.0 111.0 73.0 74.0 76.0 120.0 101.0 74.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:94.00 stddev:25.96 (27.6%) stddev-sans-first:26.87 14:20:56 INFO - PROCESS | 15117 | Values: 94.0 94.0 141.0 95.0 95.0 94.0 145.0 94.0 93.0 156.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 14:20:56 INFO - PROCESS | 15117 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 14:20:56 INFO - PROCESS | 15117 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 147.0 147.0 147.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 14:20:56 INFO - PROCESS | 15117 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.00 stddev:5.67 (8.6%) stddev-sans-first:5.96 14:20:56 INFO - PROCESS | 15117 | Values: 65.0 66.0 66.0 65.0 65.0 66.0 66.0 83.0 63.0 66.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 14:20:56 INFO - PROCESS | 15117 | Values: 64.0 64.0 64.0 63.0 64.0 64.0 63.0 64.0 63.0 64.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.38 (3.0%) stddev-sans-first:2.52 14:20:56 INFO - PROCESS | 15117 | Values: 80.0 78.0 77.0 86.0 79.0 80.0 81.0 80.0 80.0 80.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:132.50 stddev:10.35 (7.8%) stddev-sans-first:10.86 14:20:56 INFO - PROCESS | 15117 | Values: 131.0 139.0 131.0 136.0 131.0 128.0 128.0 131.0 163.0 134.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.00 stddev:2.66 (1.5%) stddev-sans-first:2.78 14:20:56 INFO - PROCESS | 15117 | Values: 173.0 181.0 173.0 172.0 173.0 176.0 174.0 172.0 174.0 174.0 14:20:56 INFO - PROCESS | 15117 | 14:20:56 INFO - PROCESS | 15117 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.78 14:20:56 INFO - PROCESS | 15117 | Values: 74.0 73.0 74.0 74.0 73.0 73.0 72.0 73.0 72.0 72.0 14:20:56 INFO - PROCESS | 15117 | -------- Summary: end -------- 14:20:56 INFO - PROCESS | 15117 | 14:20:57 INFO - TEST-INFO | 15117: exit 0 14:20:57 INFO - TEST-OK | kraken | took 63464ms 14:20:57 INFO - SUITE-END | took 1181s 14:20:57 INFO - Completed test suite (00:19:41) 14:20:57 INFO - javascript benchmark 14:20:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.3301541599185, 2693.165118813167, 2695.9865200673994, 2702.500037493064, 2732.0, 4586.67893247472, 4657.743824089674, 4657.953420465794, 4662.184117779392, 4673.813047478101, 4586.678932474728, 4609.539046095389, 4661.13768952744, 4723.952760472394, 4734.1951868182405, 4227.936580951288, 4243.045314804175, 4278.058827058042, 4319.287317592609, 4413.139437809612, 4348.239058164824, 4369.213541562517, 4369.825206991716, 4398.626116780061, 4429.77851107445, 4171.874843754692, 4257.808398622069, 4262.339337402676, 4301.612854843079, 4330.39374487572, 4296.57034296571, 4310.762908040057, 4320.870373888788, 4327.156204540116, 4378.649708023382, 4241.088166044285, 4281.486221653421, 4308.310670292738, 4313.460817397825, 4340.153670034345, 4372.912541749179, 4555.908881822345, 4562.429696287964, 4606.585407313358, 4640.141573808856, 4900.191468407708, 4958.851234462972, 4959.6528243023, 4965.404151501807, 4981.053599816059, 4960.082384758795, 4960.379952505937, 4992.226204938241, 5000.849974500735, 5038.269450929632, 4486.820527178909, 4623.514530974267, 4630.837920672794, 4706.011737535087, 4710.646701497401, 5130.226131029222, 5132.153194722829, 5139.331886854685, 5159.2003239497935, 5206.453322401169, 4911.803527858917, 4931.087748766489, 4931.975340123348, 4938.0, 4983.875403114951, 4876.317315575822, 4973.52751488608, 5010.824621138243, 5016.824411145665, 5060.2662613920775, 4904.60763138948, 4912.263160525878, 4958.181899986462, 4960.330355401975, 4969.925451118236, 4890.343340157288, 4893.584045356113, 4897.975510122426, 4913.582345500601, 4939.728314942713, 4108.548059713429, 4181.707280490397, 4193.329067349209, 4194.853180138742, 4238.067625122468, 3660.5058317127377, 3691.6492933171307, 3726.9378227205657, 3731.9067023324633, 3781.3193625147187, 4365.432493775852, 4365.890852728708, 4376.562343765661, 4382.517923028464, 4420.469543654782, 4884.633652476007, 4970.254461830755, 5017.623678224148, 5034.043531729033, 5080.441151473335, 4359.760213188241, 4360.563943605677, 4371.606555410029, 4407.493138289074, 4408.713433626868, 4478.0596074824, 4497.505274419811, 4507.2788353863225, 4508.413906192174, 4554.339620754972, 4605.861824145281, 4697.718136911796, 4734.502877197913, 4752.382190315237, 4769.904601907873, 4993.700377977333, 5014.52362025607, 5021.447640759587, 5024.547790698854, 5039.193729003342, 4734.621230301636, 4758.1911075118005, 4764.9047019058735, 4789.544993225638, 4790.880227994328, 4754.786034628519, 4856.562909338177, 4928.162212423825, 4931.13705101613, 4959.801607935642, 4974.651774375759, 4991.126552853164, 5012.348394708811, 5014.0974624567925, 5034.345535080416, 4871.3423687803115, 4875.19559272716, 4876.829310974099, 4879.5120487952345, 4912.557869791593, 4713.78787954536, 4789.042191561632, 4872.366592342973, 4905.068037072945, 4905.705657660552, 4768.070226305837, 4768.8092476301945, 4782.210935195653, 4784.976075119602, 4797.424309082932, 4865.635077369141, 4869.95130048695, 4880.6095512358215, 4882.316475693335, 4926.359573255454, 4589.5639914208095, 4770.689905156154, 4832.081904438145, 4863.2461968394955, 4885.560299573055], "value": 4587.91292189648, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4826807605077, 594.9796099689032, 605.07423641828, 621.4624349937303, 623.2520974830205, 27295.0, 27867.163985080428, 27915.860420697893, 27937.161885143454, 28004.439911201815, 35001.12497187572, 36088.81955590225, 36117.81941090297, 36140.0, 36206.094847628825, 7706.306432421067, 7883.290503854652, 7894.60526973649, 7899.526028438283, 7902.130765615806, 7625.504342217766, 7732.884006739903, 7762.30139287464, 7782.688692452323, 7789.454738168331, 7792.610369481532, 7838.333741631968, 7845.7646270611685, 7853.764387068397, 8092.433529652927, 7950.1652326505755, 8012.399070069768, 8024.919750802475, 8026.678932842738, 8028.036635603707, 7837.6864925402915, 7909.723159689441, 7918.2477664621765, 7936.761897143095, 7937.48406353591, 38171.80914095439, 38727.0, 38820.50615444624, 38870.611293886985, 38871.41692874609, 2791.82922668407, 2895.0880472651047, 3125.3749250149835, 3201.9913727175867, 3562.340966921128, 29167.70832291671, 29204.561931571043, 29416.70583294161, 29716.257093572618, 29904.55143172854, 3335.96664033359, 3338.282269312085, 3380.1042723678247, 3393.9490907636405, 3415.419378705626, 159177.0, 159396.0, 159632.0, 159977.4002259974, 160353.19823400924, 30523.8473807634, 50891.745541272794, 51596.35632792991, 51642.483575163766, 51690.48309516932, 30686.53970190449, 30745.538816917764, 30807.845960770053, 30830.53754193689, 30869.69130308713, 11949.701257468632, 12138.514459421702, 12148.939255303667, 12150.0, 12155.331456769962, 10448.477576121315, 10480.266381353233, 10503.0, 10503.422311772772, 10503.579856805794, 7739.380849532024, 7749.651265693057, 8264.338852891755, 8265.545395003333, 8329.708460203985, 3190.218396492874, 3190.8883189088733, 3250.268689544881, 3265.1837040739815, 3275.7706960512537, 846.627483907079, 868.5961028121953, 888.4692787398521, 918.9402688825205, 973.0415540692412, 27272.727272727017, 27952.12938435665, 28021.862728444707, 28042.0, 28454.288642783682, 936.2930987104828, 979.5053497983473, 992.6823416506793, 1025.0108645157459, 1033.8552602635637, 14507.492237771627, 14882.92558537222, 14973.251337433085, 15338.769918451233, 15399.92300038515, 323174.0, 326604.0, 327178.0, 329494.0, 330265.0, 49238.26142607792, 49852.50147498478, 49904.75047624738, 49975.75012124989, 50045.0, 1074.3392813419691, 1076.2520048566328, 1187.8752730963297, 1213.1023042948154, 1301.4989229146656, 25112.62331064999, 25832.225033249033, 26111.477770444104, 26264.34339141537, 26319.736802631727, 35787.28425431529, 35822.0, 36003.27993440064, 36056.0, 36081.81959090293, 181588.0, 181662.0916895407, 182962.0, 183222.0, 183276.0, 20832.895835521333, 23207.535849282584, 23282.76717232874, 23457.41356466102, 25620.359491012874, 35857.82071089628, 35858.28283434369, 36192.55042692736, 36258.0, 36735.63264367322, 32109.839450802596, 34589.0, 34745.65254347424, 34872.65127348796, 35199.0, 33392.66607333896, 33641.3271734559, 34087.48868766921, 34225.14437139092, 34512.82743586266, 33379.499307510894, 33705.662943370255, 33992.490112647836, 34374.48438273478, 34376.48435273423, 29700.554491683073, 30787.384252315278, 30812.0, 30850.845745771127, 31026.224344391572, 23171.841407929875, 23975.400614984766, 24206.75793242045, 24547.263582092564, 24581.754182458662], "value": 15355.824194695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.15095280854047, 371.5726914048843, 378.63461759402173, 380.5509498791425, 386.6269050366397, 15550.766738498918, 17139.228734706954, 17720.82279177208, 17740.112994350264, 17749.02380369081, 15810.13044282564, 16758.83241167588, 16942.49172524823, 16949.372847208673, 16950.406735764253, 4988.900221995558, 5207.791688332462, 5246.842594722146, 5254.21186821976, 5254.973725131388, 3741.195642936768, 5157.123289040872, 5607.719614019283, 5920.052791553352, 5922.3485416604135, 5852.824415267549, 5866.970665146669, 5876.294844618652, 5879.52963762898, 5881.3530511643685, 5810.825675229728, 5880.117982302646, 5884.7940322088525, 5886.293644762656, 5891.587588868781, 3425.2122011937145, 4985.227289770091, 5051.292819005343, 5226.581873450153, 5230.320058392384, 19387.515312117168, 19412.0, 19638.312659057006, 19825.603487930162, 20292.79707202924, 1809.5837957269903, 1944.5041514413876, 2000.7198992141111, 2035.6844689073068, 2486.2292689266205, 12640.367981600883, 12949.352532373343, 12998.285094319808, 13089.08376413642, 13187.86812131876, 1738.4350086222028, 1764.5059383372677, 1788.534980904974, 1790.113893622652, 1826.3333883132561, 66027.33972660308, 66530.66734666344, 67035.0, 67318.32681673218, 68234.31765682329, 9354.625814967325, 9469.0, 9657.275704322205, 9849.359791613522, 9885.357451765612, 13290.534831280858, 13383.464661413434, 13421.530246441524, 13435.865641343657, 13450.394732237073, 6958.965205174043, 6963.373296403247, 7093.290670932865, 7112.822179445555, 7144.035555199982, 6616.073749675049, 6677.399034086956, 6780.321967803279, 6798.898016529756, 6802.93197068023, 5935.198748168942, 5969.104634304889, 5979.133025711248, 6001.369856165127, 6022.307434644984, 1665.6751933372875, 1711.6747817914556, 1728.4641761054113, 1789.4184390073278, 1829.5151784777045, 786.3905473258156, 956.9521523923776, 983.8770153730784, 1004.57305645102, 1008.2488546033105, 15561.688766224612, 16002.679946401007, 16131.467510586475, 17388.739168912478, 17685.93884366942, 853.6372041882299, 867.3798234262532, 921.9446833189896, 928.5032507608397, 933.9579718912665, 9620.855687164698, 9726.805463890683, 10053.296269261227, 10059.597616095274, 10104.141148002354, 332179.0, 337699.0, 348171.0, 353154.0, 353356.0, 69565.65217173983, 70047.64976175087, 71732.2826771736, 72087.0, 72170.27829721635, 877.4779006491127, 898.9595468203946, 905.8550631898864, 906.2885634776669, 938.671464987249, 15231.619209519407, 15242.923785381003, 15352.846471535142, 15481.53555393295, 15555.688886222439, 32103.839480802446, 32198.678013220506, 32224.0, 32631.347373052882, 33548.99353019414, 40890.59109408987, 43499.0, 44345.55654443414, 44987.775061124485, 45252.0, 7565.6973721050545, 7620.80947976305, 7653.6555854985545, 7690.230976902265, 7796.064472263365, 11451.0, 11484.827727583926, 11533.135014873751, 11622.767544649229, 11867.465964031811, 10066.748331291776, 10183.185345172516, 10255.538500767632, 10270.281080324306, 10437.0, 9917.504124793588, 10040.799184016425, 10090.192784577363, 10338.793224135625, 10785.245032847626, 10110.191184705352, 10316.071553559916, 10465.9476702616, 10476.0, 10747.785044298915, 7404.407647388089, 7424.524488054164, 7523.495300939724, 7665.23347665229, 7684.346830519245, 10179.949100254451, 10219.642312519027, 10345.896541034494, 10365.170786337225, 10504.791948925971], "value": 8257.915844551755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.4930803716459, 1440.4886265375794, 1442.3076923076924, 1579.3524654891496, 1731.7229243321062, 6674.766383176584, 7513.135989361225, 7739.806504837382, 7765.534067955927, 7779.533228006324, 7468.51454655447, 7635.694572217105, 7646.273604007624, 7647.34997525211, 7652.540847549151, 2186.7922547358057, 2213.9889300553473, 2222.122261706625, 2222.9888850555726, 2223.566404551113, 2098.517341011568, 2140.7538133114736, 2197.0333053456507, 2206.470447092702, 2208.4699672078664, 2064.370367038053, 2089.0912453082883, 2098.4963608733947, 2099.632564301241, 2103.863248888825, 1895.1945423195157, 1896.0614495824586, 1900.4583693647244, 1902.3627084926566, 1902.5624106455523, 2029.046348216336, 2053.5892821435623, 2083.0522112438803, 2088.321295578943, 2088.4361222469847, 7451.664675089634, 7621.885671714873, 7700.229977002311, 7715.305622493946, 7729.690812367498, 4506.301523263899, 4644.210484217691, 4650.372199753024, 4653.627709783209, 4661.6969896956925, 2855.229088146189, 2891.6963718809434, 2895.17487516059, 2933.809302395359, 2943.838088905131, 858.4591707224471, 866.6966561703354, 871.0418539606445, 872.2324354568003, 883.4081165619051, 9801.852972205423, 9889.258305627107, 10141.138003269805, 10159.746006349826, 10206.693799186036, 3949.585293544194, 4022.3765316376007, 4097.344424892003, 4108.958910410857, 4129.772862492532, 8057.274845263954, 8092.473989190684, 8097.878531822027, 8105.189481051848, 8107.797305067303, 4375.387445757597, 4408.911821763547, 4425.601695847389, 4432.778361081933, 4440.489343725513, 3660.9633903661156, 4117.094239267356, 4151.709380343347, 4190.120074784269, 4250.638695710899, 3368.1074515253476, 3380.8985730428126, 3450.0, 3455.3434847378917, 3473.600535938349, 1016.5730393234859, 1065.912768975656, 1071.314358810362, 1087.141158484804, 1090.4547726136932, 679.8198477403492, 784.3762614055973, 792.1326147868075, 821.5686764448593, 835.9832803343899, 4898.387701537308, 4899.363082799285, 4923.679960802537, 4927.975360123177, 5014.824481143215, 367.13173345039326, 372.97948612826553, 373.82617083055965, 374.12081608220467, 384.1012031845439, 3364.9495257571157, 3429.4684323929832, 3436.7250619950346, 3466.705330046924, 3515.736319776027, 9126.634934602675, 9504.42973421597, 9649.179819715402, 9661.227101831837, 9664.226861851035, 9317.580708868118, 9452.385594936444, 9467.337286389886, 9588.472634005197, 9598.040195980486, 7182.42540596751, 7227.421806255382, 7299.963500182571, 7321.524100933422, 7347.228541003225, 4778.331033655221, 4841.104395686809, 4867.878303042311, 5284.9735751320995, 5287.735613219401, 8567.228949394585, 8690.391672582859, 8718.694845680371, 8770.342224333073, 8784.956075219583, 8219.95890020546, 8696.91303086961, 8717.607707653298, 8813.0, 8821.867671984797, 5949.137375080676, 6352.460040896391, 6539.771108011197, 6595.307492713388, 6779.932200678128, 7287.4534409920525, 7345.485815993043, 7358.852822943618, 7387.519811212254, 7415.443841711785, 6403.807885763248, 6507.577007494498, 6555.180602424697, 6682.899756503753, 6705.262421133574, 6385.106085148176, 6404.4876409886165, 6460.903086453801, 6648.0, 6748.460123190232, 5627.099664053731, 5668.631538949955, 5678.829635110953, 5686.147077938177, 5687.9431205687415, 4143.875683729493, 4330.9350359744, 4354.651627869699, 4389.473263208435, 4468.195724769573, 4281.871543853689, 4298.9570104298555, 4328.220920234262, 4345.435093437833, 4392.3411488277015], "value": 3890.4572434639695, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.89963962432967, 299.9910002699919, 305.9219898925774, 307.1982126649446, 307.8506924141792, 4643.883902902429, 4682.625389968803, 4697.835575754853, 4698.741569213692, 4712.952870471294, 4333.804978775955, 4466.8436604718845, 4600.194965880966, 4660.1844677181525, 4661.5804577588015, 3671.761335513183, 3693.0, 3719.9070023249365, 3745.4007358822596, 3748.6063963283873, 3707.462417949396, 3724.7951362675044, 3725.18046029873, 3752.662260396564, 3754.1740817020213, 3489.5114683944266, 3594.3530164570366, 3718.2563487302646, 3727.2545490901794, 3734.271816995687, 3656.8537258509627, 3670.541182352206, 3673.8588506826814, 3695.4826324314618, 3710.07248187953, 3323.9501407478665, 3325.235195904931, 3334.0997930558856, 3344.6822551857535, 3345.7657963942534, 4336.327869180251, 4423.601875831158, 4451.844185453526, 4480.372747815309, 4506.864794056183, 4189.413482112506, 4214.36784482327, 4221.7255878367805, 4224.197402493516, 4245.172191422674, 4846.854594362175, 4861.562459378638, 4871.975640121776, 4877.1708809502115, 4895.094407534618, 3596.334678084537, 3601.675849173561, 3618.4572314152824, 3622.42041273395, 3626.3110009098186, 5000.499950005007, 5055.0, 5103.157978933472, 5108.463611320795, 5129.487051294878, 3679.687226585717, 3684.0, 3700.0, 3702.315071711742, 3705.27747089315, 3735.7945313008045, 3739.5886452490204, 3760.0483620357886, 3763.6612704856148, 3764.887053388348, 4036.1524079943542, 4190.937135942963, 4196.880575309449, 4205.747655140702, 4215.768132752667, 4865.0756356292195, 4869.269609558523, 4878.512148785093, 4887.902241955141, 4896.11869863428, 1284.8201251824753, 1326.8208791813174, 1355.4307190979812, 1370.4449697872378, 1371.7530844447895, 935.7239614313794, 936.864154697565, 952.1716106986827, 960.3757557587624, 960.7742180587557, 4619.792109355087, 4628.514006029319, 4637.25803871379, 4640.211164102111, 4651.534846515389, 5306.116328703332, 5317.9202311965355, 5332.30680011596, 5340.8250184960025, 5340.973295133577, 4483.843065492692, 4606.078784243165, 4607.424071991001, 4607.44710634726, 4619.445666520039, 2819.9859000704864, 2840.076974983139, 2845.2744550139582, 2849.0, 2855.300451389423, 5032.094223039815, 5046.394432668103, 5050.0, 5053.722045287471, 5085.7202853842655, 5208.791648334024, 5411.161270003156, 5464.453554644504, 5479.17812328146, 5488.502731257268, 5007.9499205008215, 5034.572061374751, 5036.496350364934, 5044.86490539633, 5047.470015648378, 5285.9471405286995, 5303.098473259633, 5304.416514183514, 5316.734163291742, 5327.440618735132, 4713.2223183175765, 5005.974970125126, 5007.499250074963, 5230.084735171254, 5233.450487698737, 4788.497207793132, 4789.85043589543, 4834.5890599299455, 4837.564619184291, 4850.636202284913, 3524.7532672712664, 3570.7143428525137, 3578.373784587635, 3580.8567657293415, 3590.856365745341, 4802.567768900815, 4837.177679794514, 5056.418511871182, 5082.796688132434, 5125.666831655931, 4790.305405716222, 4895.33912921751, 4942.20924652054, 4952.331435256338, 4965.329680493087, 4887.951120488749, 4903.33804936329, 4917.213245880642, 4941.579965702956, 4951.72765497901, 4634.72191668501, 4868.196747536758, 4872.342233798392, 4884.63365247615, 4886.706797592155, 4905.926411103765, 4968.8757781055765, 5002.149634562061, 5011.398632164163, 5019.498050194951, 4861.1979023460735, 4880.145974454527, 4913.140200464976, 4921.655484116221, 4929.926051109308], "value": 3793.2116890536577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.2427260105677, 734.3684431389005, 749.3555542233678, 754.0875540595879, 769.5382770337798, 11539.942300288498, 11648.24286421382, 11675.591354302602, 11717.0626349892, 11981.400929953501, 12452.564160254393, 12782.488700451971, 12814.231146131238, 12827.679308017305, 12853.22880627163, 638.936106389362, 793.8372633610096, 796.4066770256168, 799.4523751230397, 800.1478425476878, 782.6634547144754, 812.0782911395579, 814.4950130918838, 814.7311387242225, 815.0830315894618, 846.2172490446343, 846.6824940647257, 847.737201467544, 848.855694531928, 849.8852654891572, 660.4419265720459, 802.5585927739778, 843.1947490146895, 845.121074082953, 846.7925358287198, 608.7960533221376, 609.1380696314709, 609.2962628164477, 609.5306613907267, 610.5634471353004, 12976.15654982423, 13066.673333166651, 13085.149465284727, 13087.345632718327, 13101.737965240642, 11237.0, 11788.764224715544, 11794.705132371673, 12024.759504809856, 12226.449809758493, 9687.951560242154, 9829.0, 9848.359856609297, 9876.209903207726, 9972.351797133164, 3287.063186991696, 3329.1177837872983, 3362.193073662328, 3381.1716129548417, 3449.3273811606746, 45344.3198352025, 46058.76970615125, 46306.30540541895, 46311.0, 46749.76625116887, 9491.525423728786, 9519.476428796344, 9562.856557151648, 9675.564599592895, 9771.876234233012, 17175.742363864552, 17224.311027558757, 17275.654486910444, 17294.13529323529, 17302.22140003678, 5923.911141332884, 6089.634621922699, 6251.906221406683, 6296.307406185316, 6368.490520758328, 3381.1378098585196, 3439.7592168547963, 3440.0367896988882, 3448.567323134107, 3494.3011397720556, 2708.295843080813, 2831.759300459484, 2832.9433411331656, 2835.5463125899755, 2835.631367922157, 485.34236110070344, 496.6994968044281, 510.91569890968316, 513.7482633509553, 513.8252993982064, 380.9333366660823, 561.6798424897769, 564.3509963541877, 568.8350378390303, 591.9082542205879, 6965.283320031964, 7307.269273072757, 7404.629768511553, 7570.16728159902, 7607.35337496308, 540.9053415652245, 546.1561886884773, 558.6592178770946, 558.7848678258819, 562.103445005216, 3493.7554371194283, 3692.667659910621, 3701.9233151788317, 3732.1789206374556, 3743.2648646492894, 54567.45432545703, 55213.0, 55300.44699552953, 55882.720586396805, 56896.431035689115, 45710.0, 47113.764431177624, 47552.0, 47582.762086189345, 49205.50794492009, 42315.788421058314, 43453.56546434495, 43518.34722479165, 43720.344194837104, 44127.558724412986, 7099.538529995534, 7141.321574450419, 7287.890681639674, 7317.817054573678, 7403.777886663409, 28450.146495605164, 28940.42119157647, 29487.410251794416, 29638.0, 29676.0, 36383.63616363909, 38153.236935261695, 38607.0, 38953.61046389613, 39368.0, 8773.649054038022, 8804.691835785718, 8874.866876996979, 9089.272858171462, 9198.402103863227, 9689.467079310705, 9747.561359738687, 9873.605055797687, 10010.249231307535, 10161.898381016392, 8240.793980150544, 9659.227261819178, 9955.352902061633, 10135.290529662852, 10285.588576456857, 10216.897831021595, 10389.636362727268, 10468.738281543023, 10554.313969591953, 10739.087177589992, 9025.774355641162, 9124.680636177702, 9181.21959633412, 9190.58642361082, 9275.582598783207, 7809.882851757115, 8310.958445207736, 8397.664093436195, 8535.573221339033, 8777.780555485908, 8678.218960293603, 8825.338099642424, 8880.200781929658, 8912.465252084896, 9230.723078307661], "value": 5687.713510523656, "unit": "score"}], "name": "dromaeo_css", "value": 6045.866198913313, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 109.0, 113.0, 114.0, 117.0, 102.0, 113.0, 113.0, 115.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 155.0, 181.0, 137.0, 161.0, 158.0, 140.0, 183.0, 133.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 108.0, 111.0, 73.0, 74.0, 76.0, 120.0, 101.0, 74.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 141.0, 95.0, 95.0, 94.0, 145.0, 94.0, 93.0, 156.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 147.0, 147.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 83.0, 63.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 77.0, 86.0, 79.0, 80.0, 81.0, 80.0, 80.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 139.0, 131.0, 136.0, 131.0, 128.0, 128.0, 131.0, 163.0, 134.0], "value": 135.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 181.0, 173.0, 172.0, 173.0, 176.0, 174.0, 172.0, 174.0, 174.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 74.0, 73.0, 73.0, 72.0, 73.0, 72.0, 72.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1577.2, "alertThreshold": 2.0}]} 14:20:57 INFO - Return code: 0 14:20:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:20:57 ERROR - # TBPL SUCCESS # 14:20:57 INFO - Running post-action listener: _resource_record_post_action 14:20:57 INFO - Running post-run listener: _resource_record_post_run 14:20:58 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 524341248; Read time: 0; Write time: 924256 14:20:58 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 241438720; Read time: 0; Write time: 607144 14:20:58 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 280764416; Read time: 0; Write time: 317020 14:20:58 INFO - Running post-run listener: _upload_blobber_files 14:20:58 INFO - Blob upload gear active. 14:20:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:20:58 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 14:20:58 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'] 14:20:58 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 14:20:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:20:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:20:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:20:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:20:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:20:59 INFO - (blobuploader) - INFO - Done attempting. 14:20:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:20:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:20:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:21:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:21:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:21:00 INFO - (blobuploader) - INFO - Done attempting. 14:21:00 INFO - (blobuploader) - INFO - Iteration through files over. 14:21:00 INFO - Return code: 0 14:21:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:21:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:21:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9166cb003936cb95040c809e040af1d305e14d108b7e2ce3800b5c4c261a3fbb4d14ab35819700be804a13fed1eac21f54979fb80010b3ae033beb4b751cff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d23280737da482d99aecbd6092e54e823f1b5f9c92f2348716d9fac61e4cec7cf7f1005c394e7f67f7193a22351b341a8e9a64f10cd85c488266491d1b4fa40"} 14:21:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:21:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:21:00 INFO - Contents: 14:21:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9166cb003936cb95040c809e040af1d305e14d108b7e2ce3800b5c4c261a3fbb4d14ab35819700be804a13fed1eac21f54979fb80010b3ae033beb4b751cff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d23280737da482d99aecbd6092e54e823f1b5f9c92f2348716d9fac61e4cec7cf7f1005c394e7f67f7193a22351b341a8e9a64f10cd85c488266491d1b4fa40"} 14:21:00 INFO - Running post-run listener: copy_logs_to_upload_dir 14:21:00 INFO - Copying logs to upload dir... 14:21:00 INFO - mkdir: /builds/slave/test/build/upload/logs 14:21:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.236091 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-04-25 14:21:00.251694) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:21:00.255194) ========= 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=aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551 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/9166cb003936cb95040c809e040af1d305e14d108b7e2ce3800b5c4c261a3fbb4d14ab35819700be804a13fed1eac21f54979fb80010b3ae033beb4b751cff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d23280737da482d99aecbd6092e54e823f1b5f9c92f2348716d9fac61e4cec7cf7f1005c394e7f67f7193a22351b341a8e9a64f10cd85c488266491d1b4fa40"} build_url:https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/W3RvCyqQReGRhEvd5lLXTg/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/9166cb003936cb95040c809e040af1d305e14d108b7e2ce3800b5c4c261a3fbb4d14ab35819700be804a13fed1eac21f54979fb80010b3ae033beb4b751cff50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6d23280737da482d99aecbd6092e54e823f1b5f9c92f2348716d9fac61e4cec7cf7f1005c394e7f67f7193a22351b341a8e9a64f10cd85c488266491d1b4fa40"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 14:21:00.280084) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:21:00.280440) ========= 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=aa52b8aba932b19cc50b5275000001de-1461618020.788633-1664256551 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004620 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 14:21:00.363720) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:21:00.364033) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 14:21:00.364332) ========= ========= Total master_lag: 0.17 =========