builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1460748253.19 results: success (0) buildid: 20160415114641 builduid: 48579ca061c642c6bbc9183ea206671d revision: 009d7df1ba6d97a5abd2ed417a3464a8e948742c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.187810) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.188371) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.188664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.206255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.206610) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-15 12:24:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-04-15 12:24:13 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070972 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.291538) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.291827) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016392 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:13.342504) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 12:24:13.342907) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 009d7df1ba6d97a5abd2ed417a3464a8e948742c --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 009d7df1ba6d97a5abd2ed417a3464a8e948742c --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=9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-15 12:24:13,642 truncating revision to first 12 chars 2016-04-15 12:24:13,642 Setting DEBUG logging. 2016-04-15 12:24:13,642 attempt 1/10 2016-04-15 12:24:13,642 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/009d7df1ba6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 12:24:14,819 unpacking tar archive at: fx-team-009d7df1ba6d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.479189 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-15 12:24:14.835516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:14.835849) ========= script_repo_revision: 009d7df1ba6d97a5abd2ed417a3464a8e948742c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:14.836338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:14.836618) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 12:24:14.845638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-15 12:24:14.846041) ========= /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=9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:24:15 INFO - MultiFileLogger online at 20160415 12:24:15 in /builds/slave/test 12:24:15 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 12:24:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:24:15 INFO - {'append_to_log': False, 12:24:15 INFO - 'base_work_dir': '/builds/slave/test', 12:24:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:24:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:24:15 INFO - 'branch': 'Fx-Team-Non-PGO', 12:24:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:24:15 INFO - 'config_files': ('talos/linux_config.py',), 12:24:15 INFO - 'default_actions': ('clobber', 12:24:15 INFO - 'read-buildbot-config', 12:24:15 INFO - 'download-and-extract', 12:24:15 INFO - 'populate-webroot', 12:24:15 INFO - 'create-virtualenv', 12:24:15 INFO - 'install', 12:24:15 INFO - 'run-tests'), 12:24:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:24:15 INFO - 'download_minidump_stackwalk': True, 12:24:15 INFO - 'download_symbols': 'ondemand', 12:24:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:24:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:24:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:24:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:24:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:24:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:24:15 INFO - 'installer_path': 'installer.exe', 12:24:15 INFO - 'log_level': 'info', 12:24:15 INFO - 'log_name': 'talos', 12:24:15 INFO - 'log_to_console': True, 12:24:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:24:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:24:15 INFO - 'opt_config_files': (), 12:24:15 INFO - 'pip_index': False, 12:24:15 INFO - 'sps_profile': False, 12:24:15 INFO - 'sps_profile_interval': 0, 12:24:15 INFO - 'suite': 'dromaeojs', 12:24:15 INFO - 'system_bits': '32', 12:24:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:24:15 INFO - 'title': 'talos-linux64-ix-040', 12:24:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:24:15 INFO - 'use_talos_json': True, 12:24:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:24:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:24:15 INFO - 'work_dir': 'build'} 12:24:15 INFO - ##### 12:24:15 INFO - ##### Running clobber step. 12:24:15 INFO - ##### 12:24:15 INFO - Running pre-action listener: _resource_record_pre_action 12:24:15 INFO - Running main action method: clobber 12:24:15 INFO - rmtree: /builds/slave/test/build 12:24:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:24:15 INFO - Running post-action listener: _resource_record_post_action 12:24:15 INFO - ##### 12:24:15 INFO - ##### Running read-buildbot-config step. 12:24:15 INFO - ##### 12:24:15 INFO - Running pre-action listener: _resource_record_pre_action 12:24:15 INFO - Running main action method: read_buildbot_config 12:24:15 INFO - Using buildbot properties: 12:24:15 INFO - { 12:24:15 INFO - "project": "", 12:24:15 INFO - "product": "firefox", 12:24:15 INFO - "script_repo_revision": "production", 12:24:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:24:15 INFO - "repository": "", 12:24:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:24:15 INFO - "buildid": "20160415114641", 12:24:15 INFO - "pgo_build": "False", 12:24:15 INFO - "basedir": "/builds/slave/test", 12:24:15 INFO - "buildnumber": 2846, 12:24:15 INFO - "slavename": "talos-linux64-ix-040", 12:24:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:24:15 INFO - "platform": "ubuntu64_hw", 12:24:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:24:15 INFO - "branch": "fx-team", 12:24:15 INFO - "repo_path": "integration/fx-team", 12:24:15 INFO - "revision": "009d7df1ba6d97a5abd2ed417a3464a8e948742c", 12:24:15 INFO - "stage_platform": "linux64", 12:24:15 INFO - "builduid": "48579ca061c642c6bbc9183ea206671d", 12:24:15 INFO - "slavebuilddir": "test" 12:24:15 INFO - } 12:24:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:24:15 INFO - Running post-action listener: _resource_record_post_action 12:24:15 INFO - ##### 12:24:15 INFO - ##### Running download-and-extract step. 12:24:15 INFO - ##### 12:24:15 INFO - Running pre-action listener: _resource_record_pre_action 12:24:15 INFO - Running main action method: download_and_extract 12:24:15 INFO - mkdir: /builds/slave/test/build/tests 12:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:15 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:24:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:17 INFO - Downloaded 1361 bytes. 12:24:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:17 INFO - Using the following test package requirements: 12:24:17 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:24:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:24:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'jsshell-linux-x86_64.zip'], 12:24:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:24:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:24:17 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:24:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:24:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:17 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:24:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:17 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:24:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:21 INFO - Downloaded 22205647 bytes. 12:24:21 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'] 12:24:21 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 12:24:22 INFO - Return code: 0 12:24:22 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 12:24: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')]} 12:24:22 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:24:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:29 INFO - Downloaded 22205647 bytes. 12:24: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'] 12:24: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 12:24:30 INFO - Return code: 0 12:24: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')]} 12:24:30 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:24:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:24:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:24:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:31 INFO - Downloaded 10841076 bytes. 12:24:31 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'] 12:24:31 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 12:24:31 INFO - Return code: 0 12:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:31 INFO - https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:24:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bRdZkaOHQriQEHFhtjFi9A/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 12:24:33 INFO - Downloaded 54451733 bytes. 12:24:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:33 INFO - mkdir: /builds/slave/test/properties 12:24:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:24:33 INFO - Writing to file /builds/slave/test/properties/build_url 12:24:33 INFO - Contents: 12:24:33 INFO - build_url:https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:33 INFO - Running post-action listener: _resource_record_post_action 12:24:33 INFO - Running post-action listener: set_extra_try_arguments 12:24:33 INFO - ##### 12:24:33 INFO - ##### Running populate-webroot step. 12:24:33 INFO - ##### 12:24:33 INFO - Running pre-action listener: _resource_record_pre_action 12:24:33 INFO - Running main action method: populate_webroot 12:24:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:24:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:24:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:24:33 INFO - '--tppagecycles', 12:24:33 INFO - '7'], 12:24:33 INFO - 'tests': ['tsvgm']}}, 12:24:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:24:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:24:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:24:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:24:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['damp', 'tps']}, 12:24:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'tests': ['damp', 'tps']}, 12:24:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['dromaeo_dom']}, 12:24:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:24:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['a11yr', 12:24:33 INFO - 'ts_paint', 12:24:33 INFO - 'tpaint', 12:24:33 INFO - 'sessionrestore', 12:24:33 INFO - 'sessionrestore_no_auto_restore', 12:24:33 INFO - 'tabpaint']}, 12:24:33 INFO - 'other-e10s': {'tests': ['a11yr', 12:24:33 INFO - 'ts_paint', 12:24:33 INFO - 'tpaint', 12:24:33 INFO - 'sessionrestore', 12:24:33 INFO - 'sessionrestore_no_auto_restore', 12:24:33 INFO - 'tabpaint']}, 12:24:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:24:33 INFO - 'ts_paint', 12:24:33 INFO - 'tpaint', 12:24:33 INFO - 'sessionrestore', 12:24:33 INFO - 'sessionrestore_no_auto_restore', 12:24:33 INFO - 'tabpaint']}, 12:24:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:24:33 INFO - 'ts_paint', 12:24:33 INFO - 'tpaint', 12:24:33 INFO - 'sessionrestore', 12:24:33 INFO - 'sessionrestore_no_auto_restore', 12:24:33 INFO - 'tabpaint']}, 12:24:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['a11yr', 12:24:33 INFO - 'ts_paint', 12:24:33 INFO - 'tpaint', 12:24:33 INFO - 'sessionrestore', 12:24:33 INFO - 'sessionrestore_no_auto_restore', 12:24:33 INFO - 'tabpaint']}, 12:24:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['a11yr', 12:24:33 INFO - 'ts_paint', 12:24:33 INFO - 'tpaint', 12:24:33 INFO - 'sessionrestore', 12:24:33 INFO - 'sessionrestore_no_auto_restore', 12:24:33 INFO - 'tabpaint']}, 12:24:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['tsvgx', 12:24:33 INFO - 'tsvgr_opacity', 12:24:33 INFO - 'tart', 12:24:33 INFO - 'tscrollx', 12:24:33 INFO - 'cart']}, 12:24:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:24:33 INFO - 'tsvgr_opacity', 12:24:33 INFO - 'tart', 12:24:33 INFO - 'tscrollx', 12:24:33 INFO - 'cart']}, 12:24:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'talos_options': ['--disable-e10s'], 12:24:33 INFO - 'tests': ['tp5o']}, 12:24:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'tests': ['tp5o']}, 12:24:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'talos_options': ['--disable-e10s', 12:24:33 INFO - '--xperf_path', 12:24:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:33 INFO - 'tests': ['tp5n']}, 12:24:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:33 INFO - 'talos_options': ['--xperf_path', 12:24:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:33 INFO - 'tests': ['tp5n']}}, 12:24:33 INFO - 'talos.zip': {'path': '', 12:24:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:24:33 INFO - Running post-action listener: _resource_record_post_action 12:24:33 INFO - ##### 12:24:33 INFO - ##### Running create-virtualenv step. 12:24:33 INFO - ##### 12:24:33 INFO - Running pre-action listener: _resource_record_pre_action 12:24:33 INFO - Running main action method: create_virtualenv 12:24:33 INFO - Creating virtualenv /builds/slave/test/build/venv 12:24:33 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 12:24:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:24:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:24:33 INFO - Using real prefix '/usr' 12:24:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:24:34 INFO - Installing distribute.............................................................................................................................................................................................done. 12:24:36 INFO - Installing pip.................done. 12:24:36 INFO - Return code: 0 12:24:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:24:36 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')]} 12:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 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')]} 12:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 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 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24:36 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 12:24:36 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 12:24:36 INFO - Using env: {'DISPLAY': ':0', 12:24:36 INFO - 'HOME': '/home/cltbld', 12:24:36 INFO - 'LANG': 'en_US.UTF-8', 12:24:36 INFO - 'LANGUAGE': 'en_US:en', 12:24:36 INFO - 'LOGNAME': 'cltbld', 12:24:36 INFO - 'MAIL': '/var/mail/cltbld', 12:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:36 INFO - 'MOZ_NO_REMOTE': '1', 12:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:36 INFO - 'NO_EM_RESTART': '1', 12:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:36 INFO - 'PWD': '/builds/slave/test', 12:24:36 INFO - 'SHELL': '/bin/bash', 12:24:36 INFO - 'SHLVL': '1', 12:24:36 INFO - 'TERM': 'linux', 12:24:36 INFO - 'TMOUT': '86400', 12:24:36 INFO - 'USER': 'cltbld', 12:24:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:36 INFO - '_': '/tools/buildbot/bin/python'} 12:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:36 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 12:24:36 INFO - Cleaning up... 12:24:36 INFO - Return code: 0 12:24:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:24:36 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')]} 12:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 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')]} 12:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:36 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 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24:36 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 12:24:36 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 12:24:36 INFO - Using env: {'DISPLAY': ':0', 12:24:36 INFO - 'HOME': '/home/cltbld', 12:24:36 INFO - 'LANG': 'en_US.UTF-8', 12:24:36 INFO - 'LANGUAGE': 'en_US:en', 12:24:36 INFO - 'LOGNAME': 'cltbld', 12:24:36 INFO - 'MAIL': '/var/mail/cltbld', 12:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:36 INFO - 'MOZ_NO_REMOTE': '1', 12:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:36 INFO - 'NO_EM_RESTART': '1', 12:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:36 INFO - 'PWD': '/builds/slave/test', 12:24:36 INFO - 'SHELL': '/bin/bash', 12:24:36 INFO - 'SHLVL': '1', 12:24:36 INFO - 'TERM': 'linux', 12:24:36 INFO - 'TMOUT': '86400', 12:24:36 INFO - 'USER': 'cltbld', 12:24:36 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:36 INFO - '_': '/tools/buildbot/bin/python'} 12:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:36 INFO - Downloading/unpacking psutil>=0.7.1 12:24:36 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 12:24:36 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 12:24:36 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 12:24:36 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 12:24:36 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 12:24:36 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 12:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:24:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:38 INFO - Installing collected packages: psutil 12:24:38 INFO - Running setup.py install for psutil 12:24:38 INFO - building 'psutil._psutil_linux' extension 12:24:38 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 12:24: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 12:24:39 INFO - building 'psutil._psutil_posix' extension 12:24: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 12:24: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 12:24:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:39 INFO - Successfully installed psutil 12:24:39 INFO - Cleaning up... 12:24:39 INFO - Return code: 0 12:24:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:39 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 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24:39 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 12:24:39 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 12:24:39 INFO - Using env: {'DISPLAY': ':0', 12:24:39 INFO - 'HOME': '/home/cltbld', 12:24:39 INFO - 'LANG': 'en_US.UTF-8', 12:24:39 INFO - 'LANGUAGE': 'en_US:en', 12:24:39 INFO - 'LOGNAME': 'cltbld', 12:24:39 INFO - 'MAIL': '/var/mail/cltbld', 12:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:39 INFO - 'MOZ_NO_REMOTE': '1', 12:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:39 INFO - 'NO_EM_RESTART': '1', 12:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:39 INFO - 'PWD': '/builds/slave/test', 12:24:39 INFO - 'SHELL': '/bin/bash', 12:24:39 INFO - 'SHLVL': '1', 12:24:39 INFO - 'TERM': 'linux', 12:24:39 INFO - 'TMOUT': '86400', 12:24:39 INFO - 'USER': 'cltbld', 12:24:39 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:39 INFO - '_': '/tools/buildbot/bin/python'} 12:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:24:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:24:41 INFO - Installing collected packages: mozsystemmonitor 12:24:41 INFO - Running setup.py install for mozsystemmonitor 12:24:41 INFO - Successfully installed mozsystemmonitor 12:24:41 INFO - Cleaning up... 12:24:41 INFO - Return code: 0 12:24:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:24:41 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')]} 12:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:41 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')]} 12:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:41 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 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24:41 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 12:24:41 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 12:24:41 INFO - Using env: {'DISPLAY': ':0', 12:24:41 INFO - 'HOME': '/home/cltbld', 12:24:41 INFO - 'LANG': 'en_US.UTF-8', 12:24:41 INFO - 'LANGUAGE': 'en_US:en', 12:24:41 INFO - 'LOGNAME': 'cltbld', 12:24:41 INFO - 'MAIL': '/var/mail/cltbld', 12:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:41 INFO - 'MOZ_NO_REMOTE': '1', 12:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:41 INFO - 'NO_EM_RESTART': '1', 12:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:41 INFO - 'PWD': '/builds/slave/test', 12:24:41 INFO - 'SHELL': '/bin/bash', 12:24:41 INFO - 'SHLVL': '1', 12:24:41 INFO - 'TERM': 'linux', 12:24:41 INFO - 'TMOUT': '86400', 12:24:41 INFO - 'USER': 'cltbld', 12:24:41 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:41 INFO - '_': '/tools/buildbot/bin/python'} 12:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:43 INFO - Downloading blobuploader-1.2.4.tar.gz 12:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:24:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:24:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24:44 INFO - Downloading docopt-0.6.1.tar.gz 12:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:24:44 INFO - Installing collected packages: blobuploader, requests, docopt 12:24:44 INFO - Running setup.py install for blobuploader 12:24:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:24:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:24:44 INFO - Running setup.py install for requests 12:24:44 INFO - Running setup.py install for docopt 12:24:45 INFO - Successfully installed blobuploader requests docopt 12:24:45 INFO - Cleaning up... 12:24:45 INFO - Return code: 0 12:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24: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 12:24: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 12:24:45 INFO - Using env: {'DISPLAY': ':0', 12:24:45 INFO - 'HOME': '/home/cltbld', 12:24:45 INFO - 'LANG': 'en_US.UTF-8', 12:24:45 INFO - 'LANGUAGE': 'en_US:en', 12:24:45 INFO - 'LOGNAME': 'cltbld', 12:24:45 INFO - 'MAIL': '/var/mail/cltbld', 12:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:45 INFO - 'MOZ_NO_REMOTE': '1', 12:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:45 INFO - 'NO_EM_RESTART': '1', 12:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:45 INFO - 'PWD': '/builds/slave/test', 12:24:45 INFO - 'SHELL': '/bin/bash', 12:24:45 INFO - 'SHLVL': '1', 12:24:45 INFO - 'TERM': 'linux', 12:24:45 INFO - 'TMOUT': '86400', 12:24:45 INFO - 'USER': 'cltbld', 12:24:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:45 INFO - '_': '/tools/buildbot/bin/python'} 12:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:45 INFO - Running setup.py (path:/tmp/pip-uZlEkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:45 INFO - Running setup.py (path:/tmp/pip-el4Yo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:45 INFO - Running setup.py (path:/tmp/pip-_Ggukr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:45 INFO - Running setup.py (path:/tmp/pip-LYg0kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:45 INFO - Running setup.py (path:/tmp/pip-Pass8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:45 INFO - Running setup.py (path:/tmp/pip-ScUxjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:45 INFO - Running setup.py (path:/tmp/pip-hudB_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:45 INFO - Running setup.py (path:/tmp/pip-OF1jau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:45 INFO - Running setup.py (path:/tmp/pip-shJHWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:45 INFO - Running setup.py (path:/tmp/pip-AqSE1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:46 INFO - Running setup.py (path:/tmp/pip-SVeG88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:46 INFO - Running setup.py (path:/tmp/pip-NtR3mb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:46 INFO - Running setup.py (path:/tmp/pip-g1LY1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:46 INFO - Running setup.py (path:/tmp/pip-6B6_OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:46 INFO - Running setup.py (path:/tmp/pip-4We8jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:46 INFO - Running setup.py (path:/tmp/pip-FnA3o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:46 INFO - Running setup.py (path:/tmp/pip-AJUjgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:24:46 INFO - Running setup.py install for manifestparser 12:24:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:24:46 INFO - Running setup.py install for mozcrash 12:24:46 INFO - Running setup.py install for mozdebug 12:24:46 INFO - Running setup.py install for mozdevice 12:24:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:24:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:24:46 INFO - Running setup.py install for mozfile 12:24:47 INFO - Running setup.py install for mozhttpd 12:24:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Running setup.py install for mozinfo 12:24:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Running setup.py install for mozInstall 12:24:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Running setup.py install for mozleak 12:24:47 INFO - Running setup.py install for mozlog 12:24:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Running setup.py install for moznetwork 12:24:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Running setup.py install for mozprocess 12:24:47 INFO - Running setup.py install for mozprofile 12:24:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:24:47 INFO - Running setup.py install for mozrunner 12:24:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:24:48 INFO - Running setup.py install for mozscreenshot 12:24:48 INFO - Running setup.py install for moztest 12:24:48 INFO - Running setup.py install for mozversion 12:24:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:24:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:24:48 INFO - Cleaning up... 12:24:48 INFO - Return code: 0 12:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24: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 12:24: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 12:24:48 INFO - Using env: {'DISPLAY': ':0', 12:24:48 INFO - 'HOME': '/home/cltbld', 12:24:48 INFO - 'LANG': 'en_US.UTF-8', 12:24:48 INFO - 'LANGUAGE': 'en_US:en', 12:24:48 INFO - 'LOGNAME': 'cltbld', 12:24:48 INFO - 'MAIL': '/var/mail/cltbld', 12:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:48 INFO - 'MOZ_NO_REMOTE': '1', 12:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:48 INFO - 'NO_EM_RESTART': '1', 12:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:48 INFO - 'PWD': '/builds/slave/test', 12:24:48 INFO - 'SHELL': '/bin/bash', 12:24:48 INFO - 'SHLVL': '1', 12:24:48 INFO - 'TERM': 'linux', 12:24:48 INFO - 'TMOUT': '86400', 12:24:48 INFO - 'USER': 'cltbld', 12:24:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:48 INFO - '_': '/tools/buildbot/bin/python'} 12:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:48 INFO - Running setup.py (path:/tmp/pip-stLGgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:48 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)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:48 INFO - Running setup.py (path:/tmp/pip-huDZ24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:48 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)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:48 INFO - Running setup.py (path:/tmp/pip-aMafwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:48 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)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:48 INFO - Running setup.py (path:/tmp/pip-YkUvIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:48 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)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:48 INFO - Running setup.py (path:/tmp/pip-RAi4x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:48 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)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:48 INFO - Running setup.py (path:/tmp/pip-xubxyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:48 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)) 12:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:48 INFO - Running setup.py (path:/tmp/pip-IzglZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24: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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:49 INFO - Running setup.py (path:/tmp/pip-9HQhBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24: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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:49 INFO - Running setup.py (path:/tmp/pip-mnJvP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24: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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:49 INFO - Running setup.py (path:/tmp/pip-TMf87z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24: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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:49 INFO - Running setup.py (path:/tmp/pip-S96PPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24: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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:49 INFO - Running setup.py (path:/tmp/pip-ZlKRRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:49 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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:49 INFO - Running setup.py (path:/tmp/pip-J4SG2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:49 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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:49 INFO - Running setup.py (path:/tmp/pip-W2sjIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:49 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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:49 INFO - Running setup.py (path:/tmp/pip-qsL4hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:49 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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:49 INFO - Running setup.py (path:/tmp/pip-IokjI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:49 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)) 12:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:49 INFO - Running setup.py (path:/tmp/pip-_8aYbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:49 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)) 12:24:49 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)) 12:24:49 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)) 12:24:49 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)) 12:24:49 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)) 12:24:49 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)) 12:24:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:24:49 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 12:24:49 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 12:24:49 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 12:24:49 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 12:24:49 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 12:24:49 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 12:24:51 INFO - Downloading blessings-1.6.tar.gz 12:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:24:51 INFO - Installing collected packages: blessings 12:24:51 INFO - Running setup.py install for blessings 12:24:51 INFO - Successfully installed blessings 12:24:51 INFO - Cleaning up... 12:24:51 INFO - Return code: 0 12:24:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:24:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:52 INFO - Reading from file tmpfile_stdout 12:24:52 INFO - Current package versions: 12:24:52 INFO - argparse == 1.2.1 12:24:52 INFO - blessings == 1.6 12:24:52 INFO - blobuploader == 1.2.4 12:24:52 INFO - docopt == 0.6.1 12:24:52 INFO - manifestparser == 1.1 12:24:52 INFO - mozInstall == 1.12 12:24:52 INFO - mozcrash == 0.17 12:24:52 INFO - mozdebug == 0.1 12:24:52 INFO - mozdevice == 0.48 12:24:52 INFO - mozfile == 1.2 12:24:52 INFO - mozhttpd == 0.7 12:24:52 INFO - mozinfo == 0.9 12:24:52 INFO - mozleak == 0.1 12:24:52 INFO - mozlog == 3.1 12:24:52 INFO - moznetwork == 0.27 12:24:52 INFO - mozprocess == 0.22 12:24:52 INFO - mozprofile == 0.28 12:24:52 INFO - mozrunner == 6.11 12:24:52 INFO - mozscreenshot == 0.1 12:24:52 INFO - mozsystemmonitor == 0.0 12:24:52 INFO - moztest == 0.7 12:24:52 INFO - mozversion == 1.4 12:24:52 INFO - psutil == 3.1.1 12:24:52 INFO - requests == 1.2.3 12:24:52 INFO - wsgiref == 0.1.2 12:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24: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 12:24: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 12:24:52 INFO - Using env: {'DISPLAY': ':0', 12:24:52 INFO - 'HOME': '/home/cltbld', 12:24:52 INFO - 'LANG': 'en_US.UTF-8', 12:24:52 INFO - 'LANGUAGE': 'en_US:en', 12:24:52 INFO - 'LOGNAME': 'cltbld', 12:24:52 INFO - 'MAIL': '/var/mail/cltbld', 12:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:52 INFO - 'MOZ_NO_REMOTE': '1', 12:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:52 INFO - 'NO_EM_RESTART': '1', 12:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:52 INFO - 'PWD': '/builds/slave/test', 12:24:52 INFO - 'SHELL': '/bin/bash', 12:24:52 INFO - 'SHLVL': '1', 12:24:52 INFO - 'TERM': 'linux', 12:24:52 INFO - 'TMOUT': '86400', 12:24:52 INFO - 'USER': 'cltbld', 12:24:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:52 INFO - '_': '/tools/buildbot/bin/python'} 12:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24: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)) 12:24:52 INFO - Cleaning up... 12:24:52 INFO - Return code: 0 12:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:24:52 INFO - Using env: {'DISPLAY': ':0', 12:24:52 INFO - 'HOME': '/home/cltbld', 12:24:52 INFO - 'LANG': 'en_US.UTF-8', 12:24:52 INFO - 'LANGUAGE': 'en_US:en', 12:24:52 INFO - 'LOGNAME': 'cltbld', 12:24:52 INFO - 'MAIL': '/var/mail/cltbld', 12:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:52 INFO - 'MOZ_NO_REMOTE': '1', 12:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:52 INFO - 'NO_EM_RESTART': '1', 12:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:52 INFO - 'PWD': '/builds/slave/test', 12:24:52 INFO - 'SHELL': '/bin/bash', 12:24:52 INFO - 'SHLVL': '1', 12:24:52 INFO - 'TERM': 'linux', 12:24:52 INFO - 'TMOUT': '86400', 12:24:52 INFO - 'USER': 'cltbld', 12:24:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:52 INFO - '_': '/tools/buildbot/bin/python'} 12:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:52 INFO - Downloading/unpacking jsonschema 12:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:24:54 INFO - Downloading/unpacking functools32 (from jsonschema) 12:24:54 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 12:24:54 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 12:24:54 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 12:24:54 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 12:24:54 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 12:24:54 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 12:24:54 INFO - Downloading functools32-3.2.3-2.tar.gz 12:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:24:54 INFO - warning: no files found matching '*.txt' 12:24:54 INFO - no previously-included directories found matching 'build' 12:24:54 INFO - no previously-included directories found matching 'dist' 12:24:54 INFO - no previously-included directories found matching '.git*' 12:24:54 INFO - Installing collected packages: jsonschema, functools32 12:24:54 INFO - Running setup.py install for functools32 12:24:54 INFO - warning: no files found matching '*.txt' 12:24:54 INFO - no previously-included directories found matching 'build' 12:24:54 INFO - no previously-included directories found matching 'dist' 12:24:54 INFO - no previously-included directories found matching '.git*' 12:24:54 INFO - Successfully installed jsonschema functools32 12:24:54 INFO - Cleaning up... 12:24:54 INFO - Return code: 0 12:24:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc88012f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e588a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f235a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', '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 12:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:24:54 INFO - Using env: {'DISPLAY': ':0', 12:24:54 INFO - 'HOME': '/home/cltbld', 12:24:54 INFO - 'LANG': 'en_US.UTF-8', 12:24:54 INFO - 'LANGUAGE': 'en_US:en', 12:24:54 INFO - 'LOGNAME': 'cltbld', 12:24:54 INFO - 'MAIL': '/var/mail/cltbld', 12:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:54 INFO - 'MOZ_NO_REMOTE': '1', 12:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:54 INFO - 'NO_EM_RESTART': '1', 12:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:54 INFO - 'PWD': '/builds/slave/test', 12:24:54 INFO - 'SHELL': '/bin/bash', 12:24:54 INFO - 'SHLVL': '1', 12:24:54 INFO - 'TERM': 'linux', 12:24:54 INFO - 'TMOUT': '86400', 12:24:54 INFO - 'USER': 'cltbld', 12:24:54 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:54 INFO - '_': '/tools/buildbot/bin/python'} 12:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:55 INFO - Downloading/unpacking flake8 12:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:24:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:24:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:24:57 INFO - no previously-included directories found matching 'docs/_build' 12:24:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:24:57 INFO - Running setup.py install for pep8 12:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:24:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:24:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:24:57 INFO - no previously-included directories found matching 'docs/_build' 12:24:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:24:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:24:57 INFO - Cleaning up... 12:24:57 INFO - Return code: 0 12:24:57 INFO - Running post-action listener: _resource_record_post_action 12:24:57 INFO - Running post-action listener: _start_resource_monitoring 12:24:57 INFO - Starting resource monitoring. 12:24:57 INFO - ##### 12:24:57 INFO - ##### Running install step. 12:24:57 INFO - ##### 12:24:57 INFO - Running pre-action listener: _resource_record_pre_action 12:24:57 INFO - Running main action method: install 12:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:24:58 INFO - Reading from file tmpfile_stdout 12:24:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:24:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:24:58 INFO - Reading from file tmpfile_stdout 12:24:58 INFO - Output received: 12:24:58 INFO - Usage: mozinstall [options] installer 12:24:58 INFO - Options: 12:24:58 INFO - -h, --help show this help message and exit 12:24:58 INFO - -d DEST, --destination=DEST 12:24:58 INFO - Directory to install application into. [default: 12:24:58 INFO - "/builds/slave/test"] 12:24:58 INFO - --app=APP Application being installed. [default: firefox] 12:24:58 INFO - mkdir: /builds/slave/test/build/application 12:24: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'] 12:24: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 12:25:13 INFO - Reading from file tmpfile_stdout 12:25:13 INFO - Output received: 12:25:13 INFO - /builds/slave/test/build/application/firefox/firefox 12:25:13 INFO - Running post-action listener: _resource_record_post_action 12:25:13 INFO - ##### 12:25:13 INFO - ##### Running run-tests step. 12:25:13 INFO - ##### 12:25:13 INFO - Running pre-action listener: _resource_record_pre_action 12:25:13 INFO - Running main action method: run_tests 12:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:25:13 INFO - Python 2.7.3 12:25:13 INFO - Return code: 0 12:25:13 INFO - grabbing minidump binary from tooltool 12:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:13 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 0x1fb2410>, '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 0x1fb3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:25:13 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 12:25:13 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 12:25:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:25:13 INFO - Return code: 0 12:25:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:25:14 INFO - Return code: 0 12:25:14 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/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 12:25:14 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/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 12:25:14 INFO - Using env: {'DISPLAY': ':0', 12:25:14 INFO - 'HOME': '/home/cltbld', 12:25:14 INFO - 'LANG': 'en_US.UTF-8', 12:25:14 INFO - 'LANGUAGE': 'en_US:en', 12:25:14 INFO - 'LOGNAME': 'cltbld', 12:25:14 INFO - 'MAIL': '/var/mail/cltbld', 12:25:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:14 INFO - 'MOZ_NO_REMOTE': '1', 12:25:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:14 INFO - 'NO_EM_RESTART': '1', 12:25:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:14 INFO - 'PWD': '/builds/slave/test', 12:25:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:14 INFO - 'SHELL': '/bin/bash', 12:25:14 INFO - 'SHLVL': '1', 12:25:14 INFO - 'TERM': 'linux', 12:25:14 INFO - 'TMOUT': '86400', 12:25:14 INFO - 'USER': 'cltbld', 12:25:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034', 12:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:14 INFO - '_': '/tools/buildbot/bin/python'} 12:25:14 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/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 12:25:15 INFO - mozversion application_buildid: 20160415114641 12:25:15 INFO - mozversion application_changeset: 009d7df1ba6d97a5abd2ed417a3464a8e948742c 12:25:15 INFO - mozversion application_display_name: Nightly 12:25:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:25:15 INFO - mozversion application_name: Firefox 12:25:15 INFO - mozversion application_remotingname: firefox 12:25:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:25:15 INFO - mozversion application_vendor: Mozilla 12:25:15 INFO - mozversion application_version: 48.0a1 12:25:15 INFO - mozversion platform_buildid: 20160415114641 12:25:15 INFO - mozversion platform_changeset: 009d7df1ba6d97a5abd2ed417a3464a8e948742c 12:25:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:25:15 INFO - mozversion platform_version: 48.0a1 12:25:15 INFO - using testdate: 1460748315 12:25:15 INFO - actual date: 1460748315 12:25:15 INFO - starting webserver on 'localhost:48073' 12:25:15 INFO - SUITE-START | Running 2 tests 12:25:15 INFO - TEST-START | dromaeo_css 12:25:15 INFO - operating with platform_type : linux_ 12:25:15 INFO - Initialising browser for dromaeo_css test... 12:25:15 INFO - TEST-INFO | started process 22278 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdmnMEI/profile http://localhost:48073/getInfo.html) 12:25:19 INFO - PROCESS | 22278 | __metrics Screen width/height:1600/1200 12:25:19 INFO - PROCESS | 22278 | colorDepth:24 12:25:19 INFO - PROCESS | 22278 | Browser inner width/height: 1024/697 12:25:19 INFO - PROCESS | 22278 | __metrics 12:25:20 ERROR - PROCESS | 22278 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:25:21 INFO - TEST-INFO | 22278: exit 0 12:25:21 INFO - Browser initialized. 12:25:21 INFO - Running cycle 1/1 for dromaeo_css test... 12:25:21 INFO - TEST-INFO | started process 22359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdmnMEI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:33 INFO - PROCESS | 22359 | RSS: Main: 154570752 12:25:33 INFO - PROCESS | 22359 | 12:26:25 INFO - PROCESS | 22359 | 1460748385074 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] 12:28:36 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:48073/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48073/tests/dromaeo/cssquery-ext.html) 12:28:37 INFO - PROCESS | 22359 | RSS: Main: 241627136 12:28:37 INFO - PROCESS | 22359 | 12:31:39 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:48073/tests/dromaeo/cssquery-ext.html (next: http://localhost:48073/tests/dromaeo/cssquery-jquery.html) 12:31:40 INFO - PROCESS | 22359 | RSS: Main: 230961152 12:31:40 INFO - PROCESS | 22359 | 12:34:42 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:48073/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48073/tests/dromaeo/cssquery-mootools.html) 12:34:42 INFO - PROCESS | 22359 | RSS: Main: 225439744 12:34:42 INFO - PROCESS | 22359 | 12:37:44 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:48073/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48073/tests/dromaeo/cssquery-prototype.html) 12:37:45 INFO - PROCESS | 22359 | RSS: Main: 229085184 12:37:45 INFO - PROCESS | 22359 | 12:40:48 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:48073/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48073/tests/dromaeo/cssquery-yui.html) 12:40:48 INFO - PROCESS | 22359 | RSS: Main: 214335488 12:40:48 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:48073/tests/dromaeo/cssquery-yui.html (next: http://localhost:48073/tests/dromaeo/cssquery-dojo.html) 12:43:51 INFO - PROCESS | 22359 | RSS: Main: 267804672 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | __start_tp_report 12:43:51 INFO - PROCESS | 22359 | _x_x_mozilla_page_load 12:43:51 INFO - PROCESS | 22359 | _x_x_mozilla_page_load_details 12:43:51 INFO - PROCESS | 22359 | |i|pagename|runs| 12:43:51 INFO - PROCESS | 22359 | |0;dojo.html;2526.178991827656;2591.5335239656856;2596.4677241165564;2606.9869650651744;2611.843289402636;4383.101464199839;4464.799084041218;4467.4862390825065;4501.932471012938;4512.278035514322;4400.053988392495;4424.469063712351;4495.235809912315;4497.91004179917;4499.460064792222;4060.7157498975084;4075.5924407559305;4107.404426358184;4190.20386126635;4245.320748680212;4191.769452680117;4225.978870105645;4226.049138943744;4245.1934132514725;4268.274393353122;4031.5363733170766;4119.8352065917625;4125.278076336629;4190.057237121654;4215.873523794291;4096.365063415175;4108.938365924513;4132.876013719563;4133.379993001044;4134.813933373005;3956.8615098471705;4075.0831063010587;4093.2222877653153;4147.564505726916;4246.150769846043;4396.076823866992;4503.392042074311;4508.143452743968;4554.294084416888;4558.680892337537;4798.5441383068555;4824.638152138568;4829.10661527615;4864.975675121637;4872.415310162768;4613.792379342937;4809.567138957475;4851.054044461332;4885.145099607555;4912.852614421573;4528.25283828168;4556.88607784808;4560.863174104782;4604.930926036112;4606.953930460652;4931.358923340014;4977.502249775066;4980.377452818398;4989.201727723619;5000.874978125576;4512.4133862597655;4641.791119399635;4686.414198225222;4734.928976065362;4736.786844592001;4770.212914869077;4789.185838407479;4792.376990991219;4795.976020119877;4830.154722923475;4585.12882552314;4759.524047595212;4770.522947705202;4775.6418268629295;4821.373221481255;4793.640476964241;4870.829520966749;4884.0476107158765;4884.633652476078;4896.069746748107;4047.777372244555;4058.553559108496;4060.147369052473;4063.776492292893;4101.384792281122;3580.534530511017;3581.606023337431;3598.0824889653495;3609.9819500902327;3627.510286111341;4037.0714735610973;4126.00975765814;4208.284591619371;4258.6380157686945;4279.7646129462555;4846.5153484651955;4880.41435027799;4918.55732984026;4921.163402221631;4955.1823949048;4201.264778663722;4237.639800616982;4243.533211346749;4286.39990401344;4290.013296941721;4180.310248808913;4390.780460976938;4421.867343979686;4462.040661257845;4470.508244093147;4534.88662783433;4546.5226151254965;4557.5442455754155;4562.406887104655;4613.1235065336805;4669.463011753692;4794.041191761592;4795.304680821331;4800.135975524439;4826.638002149783;4563.885902852322;4595.609373203315;4599.356090147315;4603.470600880942;4635.026644404713;4716.8113275468595;4740.1230772307235;4745.715257084586;4747.169245382113;4787.473377928355;4573.496915339377;4745.857624271277;4748.786304616231;4788.162071637519;4843.418789745253;4654.86035418938;4665.113628410591;4668.6498512611015;4686.484486706528;4692.202325604587;4651.651126165483;4685.953140468551;4694.7887345068875;4726.763661816826;4737.786799593958;4344.695871288979;4579.335996280587;4636.11913736389;4640.466346370211;4685.835995740133;4731.384919960383;4734.6685731999805;4742.051589682008;4744.9051018978735;4795.9280610790165;4652.55800698933;4656.278276867091;4661.906761864811;4678.602318802804;4708.458527269408 12:43:51 INFO - PROCESS | 22359 | |1;ext.html;571.5656101362963;596.6599038548028;611.4588589098646;616.6916541729134;628.145721818327;27121.186364409074;27875.721242787567;33600.49599256013;34946.82526587364;35059;36398.27203455936;37074.81462592683;37158.07104822381;37158.62841371586;37162.44256336157;7563.319301262899;7743.651535680908;7744.574048427335;7744.690212391526;7751.263629955173;7578.3558397536;7668.654910529011;7680.577568233745;7695.653695583712;7701.268379503967;7824.72613458529;7878.803029924269;7892.802679933019;7917.366610671162;7920.089189743167;7835.569043702594;7897.802554936173;7898.052233731989;7899.842003159962;7900.407469439786;7788.805279867992;7883.211678832128;7899.723509677134;7900.933373994495;7905.960470197612;37805.81097094497;38301.425478617566;38308.233835323415;38352.616473835464;38376.42435363472;3211.7430605551735;3261.1684020574603;3266.4610339293986;3267.297531030816;3712.574850299401;28224.576631350545;28465;28715.856420717973;29025.709742902513;29215.41569168605;3399.1841957930164;3427.2141160502097;3477.9130521736906;3531.1172206948263;3589.246258285763;232356;232522;232886;233251;234323;33462.832685836416;50046.24930626043;50229.49770502321;50401.24398134031;50492.49507504878;32919.50620740691;33236;33377.165570860925;33394.16514587106;33400.49899251513;13441.462341506425;13535.59393218205;13614.38735256896;13618.795718064237;13620.114692544952;11261.380624065756;11296;11310.94344528272;11318.886811131782;11338.943305283421;8117.553534555656;8145.51126932386;8152;8152.8777068344025;8212.876806847902;3107.3163903941095;3144.7169754722186;3153.6215654121193;3205.83970801459;3218.3563287342627;883.7083762358407;911.4349103555838;926.5876684875301;943.4716558726998;958.9089036541517;27817.304567385574;27840.44319113647;28146.437071258868;28301.29246768806;28703.282417939718;932.6782260120248;965.2519297544319;987.770226068535;991.7570195302053;1023.6314926626409;14410.927945360207;14649.707005860037;14888.851111488962;15138.318775655121;15164.696706065817;345091;346623;349790;350116;350163;48398.758006210446;49139.50860491421;49252.7537362318;49305.75347123241;49376.50623493791;1077.73595469109;1157.6353448663813;1251.2742609286593;1255.2885766743789;1289.2135797163724;24314.756852431958;26864.32839179036;27965.300867478476;28425;28539.42921141607;38879.222415552096;39041;39401.211975760896;39518.802405987786;39526;223944;225280;225939;225953;226083;21557.24549640755;24888.377790554656;24904.252872413857;24905.62641560342;24912;39051;39969.40045899372;40235.59764402318;40644.59355406408;41009.38485922654;34166.487502686985;34594.65405346015;34608.30783384368;35314.29371412506;35669.46495802617;34159.829200853834;34480.65519344775;34507.65492345044;34784.304313913075;34787.65212347844;34197.487037694955;34332.31335373229;34542.82728586441;34817.825910870284;34995.65004349924;30303;31150;31252.218694532818;31653.525197121602;35331.11672208215;24201.878990604935;24346.51306973815;24537.754622453547;24896.50206995886;24986.500269994136 12:43:51 INFO - PROCESS | 22359 | |2;jquery.html;373.22741924216865;376.9057735566108;379.57298039705324;381.0739902038047;390.7948327128259;15852.920735396321;16791;17301.13494325282;17308.653826923455;17357.479275621736;14991.700165996674;16463.423780167697;16494.587635309123;17014.914925425357;17018.659626807457;5020.196768517028;5202.661826981253;5244.763985620656;5244.79020839166;5249.816256431026;3637.345277849986;5625.662460252377;5976.4919981801595;5980.491658209057;5985.072313791369;5855.531557475391;5902.173695682608;5912.586118971673;5931.199288096116;5933.258342707161;5793.159991801186;5859.853503662443;5937.584369094144;5937.792177273818;5950.04799232123;3319.3859136059905;4892.559669629715;5250.9737451312885;5259.947400525984;5263.368395792491;11711.765764684658;12373.62879113619;12373.690657733629;19114.71327930082;19242.903785480983;1856.3128101543575;1857.526330785641;1891.8013608571177;1964.0768838645813;2025.9594808103902;5726.742296596663;6866.793996180123;8862.291016718647;8935.195832375053;9388.483633400161;1742.9041402722971;1767.2665843674858;1784.580623553464;1787.2404228203093;1824.79927208007;67361.66319168422;69539;70196.6490167551;70241.29758702399;71639.64180179065;10053.69838904834;10179.440130792878;10312.587496500206;10325.74185645365;10354.068133867837;14112.2943852809;14227;14239.288035598178;14269;14284.142951422948;7152.9284707152265;7235.167955685059;7238.167610724729;7362.8527429451115;7369.115706115301;6779.457643388616;6780.423663988616;6794.607105543352;6852.862942741117;6882.277360877136;4446.6220371268155;4463.4420697412825;4469.128519938581;4476.753778542146;4479.753613551221;1722.8707846911282;1744.836402860444;1831.1180842771307;1885.4343696890878;1894.5453091257998;785.846759881829;859.6819176904461;928.8420968435382;932.9300302477342;971.6890595009529;15845.52463426099;16365.099919504304;16670.666586668198;16791.580210494834;17170.570735731708;857.7469646454311;867.2281669314315;869.9565021748887;880.2078129683337;912.8219997100501;8854.070322616162;8943.016268210491;9124.726258212264;9213.677521286723;9247.630094796268;414501;418442.7233591499;423702;426098;455632;80722.5963870177;82296;82879.5856020716;82981.17018829855;83907;910.988802429303;949.9667511637059;1030.922680798943;1047.9895201048043;1056.5404049238605;14865.182414967281;15015.32431040584;15231.31459084366;15270.083794972337;15283.083015019134;33226.335473290885;34210;34421.82789086038;34574.82712586421;35451.82274088716;44965.32552011657;45565.77217113893;48312;48827.75586122047;49652.50347496623;7110.57336559808;7113.75101871432;7158.821029474305;7320.011798407147;7330.266973302627;9065.274778017874;10500.527476263434;10982.341059536133;11165;11209.327440353605;9305.534723263674;9317.534123293673;9426.57580408897;9802.117809397188;10077.546510406903;9650.517474126405;9998.550065247227;10093.091621754078;10142.847857282295;10280.691579252634;9896.406215627085;10460.37237765706;10636.787264254826;10647.733806654896;10662.786744265226;6367.713452894724;6515.511336649675;7410.703571857065;7740.6903723852665;8090.1909809018625;8178.754637360888;8976.640934362553;9183.586738596912;9307.348485605942;9826.115649591571 12:43:51 INFO - PROCESS | 22359 | |3;mootools.html;1248.4132457744856;1439.2803598200896;1459.4454107439174;1596.9361225550979;1751.5008222656538;6708.195016598009;7731.45879788415;7963;7967.60161991901;7972.402069844763;7760.146383897767;7876.80307992299;7879.40904432167;7902.6048697565175;7906.130325664172;1875.1186942137242;1934.2456441987636;1937.5059359863214;2205.151016858513;2235.251190851067;2226.743924448685;2295.9426014349606;2296.609576372021;2298.6207275799475;2300.0914638717695;2227.2204728345114;2245.921392751254;2254.5152792149684;2256.424611724008;2271.3413110198107;1858.5353661584604;2191.364504293753;2193.046024979139;2206.7903549162725;2214.71208742864;2252.8085112765434;2277.36233854521;2278.6695929090356;2278.7721227877246;2281.133169395619;7768.378529717609;7791.1040230373665;7800.687972481094;7812.023497062867;7816.6091695415;4495.280755079171;4654.25531914892;4662.347271382009;4675.555822196886;4678.508756580544;2831.7026712195334;2974.5538169274564;2991.9401611967855;3002.4445477586714;3005.1285127313054;919.9862002069974;954.4750387286964;959.4147569982375;972.1979367022165;1010.9039641234071;10953.726156846064;10957.50691218897;10959.780804383947;10962.068224200952;10994.945025274903;4164.58404142593;4241.151769646083;4430.490493593214;4450.710703804307;4456;9291.628334866666;9310.906890931139;9313.161815436642;9315.347925645276;9353.204977576846;4662.230731929194;4667.953320466752;4673.135469938073;4682.2508398656055;4698.459677137104;3748.7001039917286;4202.915941681211;4294.806733696991;4323.092150648336;4347.413099231563;3676.3933950898336;3694.722895782827;3773.0755964788805;3809.942850857184;3836.0026393137987;1197.6466942252057;1205.584073494643;1214.574898785418;1228.8525376954644;1234.666640007211;809.8096947217399;823.54704912298;847.6948298612494;855.2516548020482;870.7474832298562;5024.924626130611;5201.843944681666;5214;5310.4424035476495;5500.559955203574;419.2913975381595;422.9133027729308;424.4651738809061;426.1881116473124;426.50951405882864;3564.750467467304;3619.5475565554307;3621.9818900905325;3633.8364773585254;3701.7964011979598;9475.28935329853;9869.555869985868;9896.455694936847;9994.850077248848;10002.849957250646;9799.853002204973;9806.362586431858;9807.411555306704;9808.656697015713;9828.017198280115;7250.528715633467;7409.7777066687;7572.545647261182;7574.280443357872;7587.62061896914;5209.088409528242;5256.710880901587;5382.19267109921;5407.810726624549;5434.510894019557;8909.109089091038;8931.106889311017;8956.507392093497;9182.95408522953;9330.813383732424;8987.550622468982;9137.77155571116;9333.953330233306;9380.57787399555;9461.432314061178;5988.6706231157705;6171.13604095418;6178.567500275118;6986.580805151707;7066.222715501393;7354.742584009534;7530.246975302426;7540.245975402416;7551.622418879144;7559.395248380227;6296.968515157578;6387.744490220525;6481.837954051187;6541.8691626168165;6578.342165783383;6814.965925170342;6815.931840681728;6855;6931.445484361138;6938.5836849789175;6294.779682711083;6342.207224096988;6353.7140828661895;6355.428011478989;6359.17330747;4284.143171365677;4413.691041627056;4462.352958821018;4471.664625153061;4557.954420455753;4588.977055114703;4621.6302695784925;4626.259798432235;4678.479494164342;4693 12:43:51 INFO - PROCESS | 22359 | |4;prototype.html;314.17215636797044;315.39444267007343;316.1069977314087;316.83524567225044;319.4728697648878;4976.527229913157;5021.096202683516;5058.11482990477;5058.570021548168;5065.593842924609;4990.725510096943;5008.549230569248;5009.223570346602;5013.5738462230665;5016.523430274118;3725.944110838333;3847.5960024197475;3849.441830934527;3948.743331683446;3951.8024098794945;3910.569837317893;3915.4322623219614;3938;3941.2314598653275;3971.9801400992956;3678.1724112074835;3923.8032400117954;3926.214757048587;3927.0771368728324;3931.1941052084253;3770.4532842737785;3871.6128387161057;3887.319719049169;3890.105275786585;3933.5279766427925;3469.392856250146;3472.291612542221;3477.23500829817;3477.6000759912426;3501.509788629594;4761.238201887716;4782.426108866958;4785.49752276013;4788.329633851264;4797.40032495938;4344.152890186415;4498.212812757754;4499.325101234808;4504.527024662396;4534.841280555198;5198.220266959948;5251.947480525222;5264.263003179558;5271.71005594696;5272.57819374453;3777.697784177259;3808.1812410331913;3825.6418971265357;3826.9043273918096;3829.215010922754;5333.306670132897;5493.862653433656;5512.448755124496;5536.141898005815;5558.749856256478;3906.5507466641134;3910.9608903911167;3918.4122381642983;3923.725339226227;3934.429507721364;3956.248312820555;3956.8812935611404;3968.0675041365835;3974.463447434617;3982.283189026003;4367.2575662137515;4494.853602478278;4499.6400287976885;4502.234620114588;4505.977470112629;5254.97372513135;5265.526102650703;5278.709670968134;5301.163877325613;5319.414864364994;1366.3031853754658;1373.6881278379124;1381.5924302330836;1389.7845833895763;1393.212834748364;877.1491653096614;928.7956649537091;942.4298299528687;958.1616085924816;967.3760424526141;4560.6807523473035;4564.406627138517;4569.885752856138;4571.085782843445;4610.05493873755;5415.1335786274;5420.105682562412;5426.620136590401;5427.348718153847;5432;4458.175237581057;4544.772761361919;4598.839040633628;4607.815687372535;4608.976955115203;2864;2880.9135725928254;2883.985580072128;2889.754370878457;2898.9855050724614;5117.360329958755;5120.92318615221;5125.513076257749;5140.485951404904;5157.07172708916;5403.83788486346;5473.534749546254;5550.639208451437;5556.833295001156;5572.247746554244;5087.516685914832;5089.949100508948;5094.312267843794;5116.976604679154;5127.077126117335;5371.428000379704;5390.137577987503;5390.676559406291;5393.379761327497;5407.324084489439;5099.77051032697;5307.089447798712;5310.097283461898;5322.308099946982;5322.547583455294;5101.158308878993;5117.513836185556;5123.948760512347;5127;5144.074066668036;3940.054386947055;3941.0738476457436;3946.2107578484993;3957.6240257175523;3959.3269144244973;5288.259643649815;5362.678239305654;5386.5152136307925;5398.7300634967305;5407.080796264566;5196;5212.582993360598;5217.2434996925995;5220.9477905220465;5237.450067742984;5037.974810125926;5193.350831146106;5213.973930130325;5223.213170451392;5227.137522308776;4918.631102667386;5111.105556527518;5116.488351164854;5143.3570803649545;5149.459306772735;5120.542139772855;5299.788008479618;5329.62692611529;5343.251944727819;5346.1713434417725;5199.55803756685;5217.973910130425;5227.268182454383;5230.921536176884;5237.266782650356 12:43:51 INFO - PROCESS | 22359 | |5;yui.html;742.9777106686798;754.9396048316136;781.8084569280527;782.2216894190282;784.4704824243635;11790.29258244506;11887.940560297186;11890.10824188186;11972.82040769387;12013;12034.217775844585;12070.939645301762;12125.151239413244;13171.736565268713;13679.52121675739;832.3757182113415;841.8484672758901;841.9284360829337;841.9536925469097;842.3261390887296;645.7158850105961;798.9960050199741;820.7496713502379;830.5888585150329;837.8282452097336;868.8001759595297;870.4255191573562;871.7036207689384;871.9869201961976;872.1932212703256;858.5707146426787;859.7850537365658;859.9613017414231;861.0743450790362;861.6036623153357;496.70694290368493;613.3835495327212;631.2204427531994;632.6710110742388;635.4312889963503;12990.545330913372;13100.868991310155;13247;13255.072144949858;13285.070045096847;12016.279023258632;12287.385630718429;12382.938085309606;12766;13074.738505229938;10037.347572407843;10040.347377420445;10079.5464204111;10259.281850270485;11346.602868899548;4202.327627579572;4236.894077648052;4249.298865687158;4284.785760711983;4324.502682191557;45439.318410223874;45803.541964580596;45928.54071459276;46360.5363946363;46798.2980255293;10430.947845260725;10441;10516.211284153718;10598.523066462029;10818;17557;17852.910735446498;18081.36715214961;18152.909235454;18519.629607407776;6896.517243792886;7066.540674856118;7223.494355395072;7237.457190710717;7319.34125928669;3777.54669439669;3866.6906647468136;3900.1029763154065;3944.5660977292473;3981.5620281768984;2850.5296626056884;2980.0463851567292;2985.626796650419;2987.462256793798;2991.2073300575366;532.1751285507526;536.3617295418439;549.5328970375149;556.7772890843695;559.5887023038064;532.0874699889707;534.6257619666171;597.2593983460564;607.4138456389517;607.750822162911;7548.584827834522;7611.505252158592;7619.276168763959;7635;7869.306713580166;510.27540891933546;545.1495666759868;560.3527925246347;593.7535922592076;599.5173885022512;3651.1602331463914;3704.759190652599;3744.1762812181278;3749.3251214781058;3772.905677358088;50501.74749126231;51034.23448648273;51213.74393128085;51321.743391282806;51690.22464663033;44012.3398149028;44992.55007449949;45336.54663453323;45520.77239613847;45773.77113114413;38330.23339533194;38987;39851;41146.38280425796;42102.15795684069;7204.53170543913;7235.674394652358;7278.96360518194;7345.889811652936;7474.2525747424825;28157.43685126327;28259.434811303247;28543.14370568886;29061.27346816262;29397.559036614897;34522;35880.282394351445;37051.258974819815;37737.81131094327;37914.62085379111;8986.505742183981;9245.815083698153;9249.491277979776;9250.161282318602;9619.807603847745;10200.99930177639;10321.122704570196;10338.483075846329;10374.844377334195;10565.683029509128;9585.568649410654;9896.950515247378;9935.403875767477;9958.452285124387;10164.644237451654;9455.905440945779;9899.554520046471;10120.240981926238;10225.693229203136;10512.632057877938;9660.516974151406;10076.244281678757;10119.949400252952;10198;10394.168466522811;7748.14770375247;8187.1403502631365;8210.384221183316;8414.705485307984;8587.65649374018;7994.880076798969;8572.571371431528;8632.525211113198;8698.739037828875;8788.472691638523 12:43:51 INFO - PROCESS | 22359 | __end_tp_report 12:43:51 INFO - PROCESS | 22359 | __start_cc_report 12:43:51 INFO - PROCESS | 22359 | _x_x_mozilla_cycle_collect,911 12:43:51 INFO - PROCESS | 22359 | __end_cc_report 12:43:51 INFO - PROCESS | 22359 | __startTimestamp1460749431923__endTimestamp 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | ------- Summary: start ------- 12:43:51 INFO - PROCESS | 22359 | Number of tests: 6 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | [#0] dojo.html Cycles:165 Average:4460.68 Median:4585.13 stddev:456.14 (9.9%) stddev-sans-first:431.56 12:43:51 INFO - PROCESS | 22359 | Values: 2526.2 2591.5 2596.5 2607.0 2611.8 4383.1 4464.8 4467.5 4501.9 4512.3 4400.1 4424.5 4495.2 4497.9 4499.5 4060.7 4075.6 4107.4 4190.2 4245.3 4191.8 4226.0 4226.0 4245.2 4268.3 4031.5 4119.8 4125.3 4190.1 4215.9 4096.4 4108.9 4132.9 4133.4 4134.8 3956.9 4075.1 4093.2 4147.6 4246.2 4396.1 4503.4 4508.1 4554.3 4558.7 4798.5 4824.6 4829.1 4865.0 4872.4 4613.8 4809.6 4851.1 4885.1 4912.9 4528.3 4556.9 4560.9 4604.9 4607.0 4931.4 4977.5 4980.4 4989.2 5000.9 4512.4 4641.8 4686.4 4734.9 4736.8 4770.2 4789.2 4792.4 4796.0 4830.2 4585.1 4759.5 4770.5 4775.6 4821.4 4793.6 4870.8 4884.0 4884.6 4896.1 4047.8 4058.6 4060.1 4063.8 4101.4 3580.5 3581.6 3598.1 3610.0 3627.5 4037.1 4126.0 4208.3 4258.6 4279.8 4846.5 4880.4 4918.6 4921.2 4955.2 4201.3 4237.6 4243.5 4286.4 4290.0 4180.3 4390.8 4421.9 4462.0 4470.5 4534.9 4546.5 4557.5 4562.4 4613.1 4669.5 4794.0 4795.3 4800.1 4826.6 4563.9 4595.6 4599.4 4603.5 4635.0 4716.8 4740.1 4745.7 4747.2 4787.5 4573.5 4745.9 4748.8 4788.2 4843.4 4654.9 4665.1 4668.6 4686.5 4692.2 4651.7 4686.0 4694.8 4726.8 4737.8 4344.7 4579.3 4636.1 4640.5 4685.8 4731.4 4734.7 4742.1 4744.9 4795.9 4652.6 4656.3 4661.9 4678.6 4708.5 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | [#1] ext.html Cycles:180 Average:41445.22 Median:175050.46 stddev:72188.36 (41.2%) stddev-sans-first:72325.64 12:43:51 INFO - PROCESS | 22359 | Values: 571.6 596.7 611.5 616.7 628.1 27121.2 27875.7 33600.5 34946.8 35059.0 36398.3 37074.8 37158.1 37158.6 37162.4 7563.3 7743.7 7744.6 7744.7 7751.3 7578.4 7668.7 7680.6 7695.7 7701.3 7824.7 7878.8 7892.8 7917.4 7920.1 7835.6 7897.8 7898.1 7899.8 7900.4 7788.8 7883.2 7899.7 7900.9 7906.0 37805.8 38301.4 38308.2 38352.6 38376.4 3211.7 3261.2 3266.5 3267.3 3712.6 28224.6 28465.0 28715.9 29025.7 29215.4 3399.2 3427.2 3477.9 3531.1 3589.2 232356.0 232522.0 232886.0 233251.0 234323.0 33462.8 50046.2 50229.5 50401.2 50492.5 32919.5 33236.0 33377.2 33394.2 33400.5 13441.5 13535.6 13614.4 13618.8 13620.1 11261.4 11296.0 11310.9 11318.9 11338.9 8117.6 8145.5 8152.0 8152.9 8212.9 3107.3 3144.7 3153.6 3205.8 3218.4 883.7 911.4 926.6 943.5 958.9 27817.3 27840.4 28146.4 28301.3 28703.3 932.7 965.3 987.8 991.8 1023.6 14410.9 14649.7 14888.9 15138.3 15164.7 345091.0 346623.0 349790.0 350116.0 350163.0 48398.8 49139.5 49252.8 49305.8 49376.5 1077.7 1157.6 1251.3 1255.3 1289.2 24314.8 26864.3 27965.3 28425.0 28539.4 38879.2 39041.0 39401.2 39518.8 39526.0 223944.0 225280.0 225939.0 225953.0 226083.0 21557.2 24888.4 24904.3 24905.6 24912.0 39051.0 39969.4 40235.6 40644.6 41009.4 34166.5 34594.7 34608.3 35314.3 35669.5 34159.8 34480.7 34507.7 34784.3 34787.7 34197.5 34332.3 34542.8 34817.8 34995.7 30303.0 31150.0 31252.2 31653.5 35331.1 24201.9 24346.5 24537.8 24896.5 24986.5 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | [#2] jquery.html Cycles:180 Average:25055.76 Median:26860.16 stddev:70568.75 (262.7%) stddev-sans-first:70742.38 12:43:51 INFO - PROCESS | 22359 | Values: 373.2 376.9 379.6 381.1 390.8 15852.9 16791.0 17301.1 17308.7 17357.5 14991.7 16463.4 16494.6 17014.9 17018.7 5020.2 5202.7 5244.8 5244.8 5249.8 3637.3 5625.7 5976.5 5980.5 5985.1 5855.5 5902.2 5912.6 5931.2 5933.3 5793.2 5859.9 5937.6 5937.8 5950.0 3319.4 4892.6 5251.0 5259.9 5263.4 11711.8 12373.6 12373.7 19114.7 19242.9 1856.3 1857.5 1891.8 1964.1 2026.0 5726.7 6866.8 8862.3 8935.2 9388.5 1742.9 1767.3 1784.6 1787.2 1824.8 67361.7 69539.0 70196.6 70241.3 71639.6 10053.7 10179.4 10312.6 10325.7 10354.1 14112.3 14227.0 14239.3 14269.0 14284.1 7152.9 7235.2 7238.2 7362.9 7369.1 6779.5 6780.4 6794.6 6852.9 6882.3 4446.6 4463.4 4469.1 4476.8 4479.8 1722.9 1744.8 1831.1 1885.4 1894.5 785.8 859.7 928.8 932.9 971.7 15845.5 16365.1 16670.7 16791.6 17170.6 857.7 867.2 870.0 880.2 912.8 8854.1 8943.0 9124.7 9213.7 9247.6 414501.0 418442.7 423702.0 426098.0 455632.0 80722.6 82296.0 82879.6 82981.2 83907.0 911.0 950.0 1030.9 1048.0 1056.5 14865.2 15015.3 15231.3 15270.1 15283.1 33226.3 34210.0 34421.8 34574.8 35451.8 44965.3 45565.8 48312.0 48827.8 49652.5 7110.6 7113.8 7158.8 7320.0 7330.3 9065.3 10500.5 10982.3 11165.0 11209.3 9305.5 9317.5 9426.6 9802.1 10077.5 9650.5 9998.6 10093.1 10142.8 10280.7 9896.4 10460.4 10636.8 10647.7 10662.8 6367.7 6515.5 7410.7 7740.7 8090.2 8178.8 8976.6 9183.6 9307.3 9826.1 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | [#3] mootools.html Cycles:180 Average:5180.79 Median:4695.73 stddev:2944.11 (62.7%) stddev-sans-first:2937.53 12:43:51 INFO - PROCESS | 22359 | Values: 1248.4 1439.3 1459.4 1596.9 1751.5 6708.2 7731.5 7963.0 7967.6 7972.4 7760.1 7876.8 7879.4 7902.6 7906.1 1875.1 1934.2 1937.5 2205.2 2235.3 2226.7 2295.9 2296.6 2298.6 2300.1 2227.2 2245.9 2254.5 2256.4 2271.3 1858.5 2191.4 2193.0 2206.8 2214.7 2252.8 2277.4 2278.7 2278.8 2281.1 7768.4 7791.1 7800.7 7812.0 7816.6 4495.3 4654.3 4662.3 4675.6 4678.5 2831.7 2974.6 2991.9 3002.4 3005.1 920.0 954.5 959.4 972.2 1010.9 10953.7 10957.5 10959.8 10962.1 10994.9 4164.6 4241.2 4430.5 4450.7 4456.0 9291.6 9310.9 9313.2 9315.3 9353.2 4662.2 4668.0 4673.1 4682.3 4698.5 3748.7 4202.9 4294.8 4323.1 4347.4 3676.4 3694.7 3773.1 3809.9 3836.0 1197.6 1205.6 1214.6 1228.9 1234.7 809.8 823.5 847.7 855.3 870.7 5024.9 5201.8 5214.0 5310.4 5500.6 419.3 422.9 424.5 426.2 426.5 3564.8 3619.5 3622.0 3633.8 3701.8 9475.3 9869.6 9896.5 9994.9 10002.8 9799.9 9806.4 9807.4 9808.7 9828.0 7250.5 7409.8 7572.5 7574.3 7587.6 5209.1 5256.7 5382.2 5407.8 5434.5 8909.1 8931.1 8956.5 9183.0 9330.8 8987.6 9137.8 9334.0 9380.6 9461.4 5988.7 6171.1 6178.6 6986.6 7066.2 7354.7 7530.2 7540.2 7551.6 7559.4 6297.0 6387.7 6481.8 6541.9 6578.3 6815.0 6815.9 6855.0 6931.4 6938.6 6294.8 6342.2 6353.7 6355.4 6359.2 4284.1 4413.7 4462.4 4471.7 4558.0 4589.0 4621.6 4626.3 4678.5 4693.0 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | [#4] prototype.html Cycles:180 Average:4373.62 Median:5015.05 stddev:1255.45 (25.0%) stddev-sans-first:1221.44 12:43:51 INFO - PROCESS | 22359 | Values: 314.2 315.4 316.1 316.8 319.5 4976.5 5021.1 5058.1 5058.6 5065.6 4990.7 5008.5 5009.2 5013.6 5016.5 3725.9 3847.6 3849.4 3948.7 3951.8 3910.6 3915.4 3938.0 3941.2 3972.0 3678.2 3923.8 3926.2 3927.1 3931.2 3770.5 3871.6 3887.3 3890.1 3933.5 3469.4 3472.3 3477.2 3477.6 3501.5 4761.2 4782.4 4785.5 4788.3 4797.4 4344.2 4498.2 4499.3 4504.5 4534.8 5198.2 5251.9 5264.3 5271.7 5272.6 3777.7 3808.2 3825.6 3826.9 3829.2 5333.3 5493.9 5512.4 5536.1 5558.7 3906.6 3911.0 3918.4 3923.7 3934.4 3956.2 3956.9 3968.1 3974.5 3982.3 4367.3 4494.9 4499.6 4502.2 4506.0 5255.0 5265.5 5278.7 5301.2 5319.4 1366.3 1373.7 1381.6 1389.8 1393.2 877.1 928.8 942.4 958.2 967.4 4560.7 4564.4 4569.9 4571.1 4610.1 5415.1 5420.1 5426.6 5427.3 5432.0 4458.2 4544.8 4598.8 4607.8 4609.0 2864.0 2880.9 2884.0 2889.8 2899.0 5117.4 5120.9 5125.5 5140.5 5157.1 5403.8 5473.5 5550.6 5556.8 5572.2 5087.5 5089.9 5094.3 5117.0 5127.1 5371.4 5390.1 5390.7 5393.4 5407.3 5099.8 5307.1 5310.1 5322.3 5322.5 5101.2 5117.5 5123.9 5127.0 5144.1 3940.1 3941.1 3946.2 3957.6 3959.3 5288.3 5362.7 5386.5 5398.7 5407.1 5196.0 5212.6 5217.2 5220.9 5237.5 5038.0 5193.4 5214.0 5223.2 5227.1 4918.6 5111.1 5116.5 5143.4 5149.5 5120.5 5299.8 5329.6 5343.3 5346.2 5199.6 5218.0 5227.3 5230.9 5237.3 12:43:51 INFO - PROCESS | 22359 | 12:43:51 INFO - PROCESS | 22359 | [#5] yui.html Cycles:180 Average:12408.09 Median:46144.54 stddev:14025.60 (30.4%) stddev-sans-first:14037.59 12:43:51 INFO - PROCESS | 22359 | Values: 743.0 754.9 781.8 782.2 784.5 11790.3 11887.9 11890.1 11972.8 12013.0 12034.2 12070.9 12125.2 13171.7 13679.5 832.4 841.8 841.9 842.0 842.3 645.7 799.0 820.7 830.6 837.8 868.8 870.4 871.7 872.0 872.2 858.6 859.8 860.0 861.1 861.6 496.7 613.4 631.2 632.7 635.4 12990.5 13100.9 13247.0 13255.1 13285.1 12016.3 12287.4 12382.9 12766.0 13074.7 10037.3 10040.3 10079.5 10259.3 11346.6 4202.3 4236.9 4249.3 4284.8 4324.5 45439.3 45803.5 45928.5 46360.5 46798.3 10430.9 10441.0 10516.2 10598.5 10818.0 17557.0 17852.9 18081.4 18152.9 18519.6 6896.5 7066.5 7223.5 7237.5 7319.3 3777.5 3866.7 3900.1 3944.6 3981.6 2850.5 2980.0 2985.6 2987.5 2991.2 532.2 536.4 549.5 556.8 559.6 532.1 534.6 597.3 607.4 607.8 7548.6 7611.5 7619.3 7635.0 7869.3 510.3 545.1 560.4 593.8 599.5 3651.2 3704.8 3744.2 3749.3 3772.9 50501.7 51034.2 51213.7 51321.7 51690.2 44012.3 44992.6 45336.5 45520.8 45773.8 38330.2 38987.0 39851.0 41146.4 42102.2 7204.5 7235.7 7279.0 7345.9 7474.3 28157.4 28259.4 28543.1 29061.3 29397.6 34522.0 35880.3 37051.3 37737.8 37914.6 8986.5 9245.8 9249.5 9250.2 9619.8 10201.0 10321.1 10338.5 10374.8 10565.7 9585.6 9897.0 9935.4 9958.5 10164.6 9455.9 9899.6 10120.2 10225.7 10512.6 9660.5 10076.2 10119.9 10198.0 10394.2 7748.1 8187.1 8210.4 8414.7 8587.7 7994.9 8572.6 8632.5 8698.7 8788.5 12:43:51 INFO - PROCESS | 22359 | -------- Summary: end -------- 12:43:51 INFO - PROCESS | 22359 | 12:43:52 INFO - TEST-INFO | 22359: exit 0 12:43:52 INFO - TEST-OK | dromaeo_css | took 1117495ms 12:43:52 INFO - TEST-START | kraken 12:43:52 INFO - operating with platform_type : linux_ 12:43:52 INFO - Initialising browser for kraken test... 12:43:52 INFO - TEST-INFO | started process 22535 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUMvIrx/profile http://localhost:48073/getInfo.html) 12:43:56 INFO - PROCESS | 22535 | __metrics Screen width/height:1600/1200 12:43:56 INFO - PROCESS | 22535 | colorDepth:24 12:43:56 INFO - PROCESS | 22535 | Browser inner width/height: 1024/697 12:43:56 INFO - PROCESS | 22535 | __metrics 12:43:57 ERROR - PROCESS | 22535 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:43:58 INFO - TEST-INFO | 22535: exit 0 12:43:58 INFO - Browser initialized. 12:43:58 INFO - Running cycle 1/1 for kraken test... 12:43:58 INFO - TEST-INFO | started process 22616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUMvIrx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:10 INFO - PROCESS | 22616 | RSS: Main: 154591232 12:44:10 INFO - PROCESS | 22616 | 12:44:13 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48073/tests/kraken/driver.html?testName=audio-beat-detection) 12:44:14 INFO - PROCESS | 22616 | RSS: Main: 209653760 12:44:14 INFO - PROCESS | 22616 | 12:44:17 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48073/tests/kraken/driver.html?testName=audio-dft) 12:44:17 INFO - PROCESS | 22616 | RSS: Main: 195723264 12:44:17 INFO - PROCESS | 22616 | 12:44:20 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48073/tests/kraken/driver.html?testName=audio-fft) 12:44:21 INFO - PROCESS | 22616 | RSS: Main: 266125312 12:44:21 INFO - PROCESS | 22616 | 12:44:23 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48073/tests/kraken/driver.html?testName=audio-oscillator) 12:44:24 INFO - PROCESS | 22616 | RSS: Main: 173940736 12:44:24 INFO - PROCESS | 22616 | 12:44:26 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48073/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:44:27 INFO - PROCESS | 22616 | RSS: Main: 178909184 12:44:27 INFO - PROCESS | 22616 | 12:44:30 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48073/tests/kraken/driver.html?testName=imaging-darkroom) 12:44:30 INFO - PROCESS | 22616 | RSS: Main: 214392832 12:44:30 INFO - PROCESS | 22616 | 12:44:34 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48073/tests/kraken/driver.html?testName=imaging-desaturate) 12:44:34 INFO - PROCESS | 22616 | RSS: Main: 215187456 12:44:34 INFO - PROCESS | 22616 | 12:44:37 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48073/tests/kraken/driver.html?testName=json-parse-financial) 12:44:38 INFO - PROCESS | 22616 | RSS: Main: 214880256 12:44:38 INFO - PROCESS | 22616 | 12:44:40 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48073/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:44:40 INFO - PROCESS | 22616 | RSS: Main: 201564160 12:44:40 INFO - PROCESS | 22616 | 12:44:42 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:44:43 INFO - PROCESS | 22616 | RSS: Main: 203214848 12:44:43 INFO - PROCESS | 22616 | 12:44:45 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:44:45 INFO - PROCESS | 22616 | RSS: Main: 214380544 12:44:45 INFO - PROCESS | 22616 | 12:44:48 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:44:49 INFO - PROCESS | 22616 | RSS: Main: 222408704 12:44:49 INFO - PROCESS | 22616 | 12:44:52 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:44:52 INFO - PROCESS | 22616 | RSS: Main: 218882048 12:44:52 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | Cycle 1(1): loaded http://localhost:48073/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48073/tests/kraken/driver.html?testName=ai-astar) 12:44:54 INFO - PROCESS | 22616 | RSS: Main: 282107904 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | __start_tp_report 12:44:54 INFO - PROCESS | 22616 | _x_x_mozilla_page_load 12:44:54 INFO - PROCESS | 22616 | _x_x_mozilla_page_load_details 12:44:54 INFO - PROCESS | 22616 | |i|pagename|runs| 12:44:54 INFO - PROCESS | 22616 | |0;ai-astar;112;114;109;112;114;114;106;116;113;115 12:44:54 INFO - PROCESS | 22616 | |1;audio-beat-detection;167;137;157;192;137;160;159;134;185;131 12:44:54 INFO - PROCESS | 22616 | |2;audio-dft;160;160;162;162;161;159;160;162;162;162 12:44:54 INFO - PROCESS | 22616 | |3;audio-fft;76;73;106;106;74;74;73;123;101;75 12:44:54 INFO - PROCESS | 22616 | |4;audio-oscillator;94;95;145;94;94;94;144;94;94;149 12:44:54 INFO - PROCESS | 22616 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 12:44:54 INFO - PROCESS | 22616 | |6;imaging-darkroom;146;148;147;146;146;146;147;145;146;145 12:44:54 INFO - PROCESS | 22616 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 12:44:54 INFO - PROCESS | 22616 | |8;json-parse-financial;65;65;65;65;64;66;64;83;62;65 12:44:54 INFO - PROCESS | 22616 | |9;json-stringify-tinderbox;65;65;65;65;64;64;65;64;65;65 12:44:54 INFO - PROCESS | 22616 | |10;stanford-crypto-aes;78;78;79;77;87;78;79;79;81;78 12:44:54 INFO - PROCESS | 22616 | |11;stanford-crypto-ccm;143;132;132;135;131;131;133;141;171;137 12:44:54 INFO - PROCESS | 22616 | |12;stanford-crypto-pbkdf2;174;178;172;175;178;179;176;172;176;173 12:44:54 INFO - PROCESS | 22616 | |13;stanford-crypto-sha256-iterative;74;72;73;73;70;72;71;70;70;69 12:44:54 INFO - PROCESS | 22616 | __end_tp_report 12:44:54 INFO - PROCESS | 22616 | __start_cc_report 12:44:54 INFO - PROCESS | 22616 | _x_x_mozilla_cycle_collect,1889 12:44:54 INFO - PROCESS | 22616 | __end_cc_report 12:44:54 INFO - PROCESS | 22616 | __startTimestamp1460749494851__endTimestamp 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | ------- Summary: start ------- 12:44:54 INFO - PROCESS | 22616 | Number of tests: 14 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:2.99 (2.6%) stddev-sans-first:3.17 12:44:54 INFO - PROCESS | 22616 | Values: 112.0 114.0 109.0 112.0 114.0 114.0 106.0 116.0 113.0 115.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#1] audio-beat-detection Cycles:10 Average:155.90 Median:159.50 stddev:21.38 (13.4%) stddev-sans-first:22.30 12:44:54 INFO - PROCESS | 22616 | Values: 167.0 137.0 157.0 192.0 137.0 160.0 159.0 134.0 185.0 131.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#2] audio-dft Cycles:10 Average:161.00 Median:162.00 stddev:1.15 (0.7%) stddev-sans-first:1.17 12:44:54 INFO - PROCESS | 22616 | Values: 160.0 160.0 162.0 162.0 161.0 159.0 160.0 162.0 162.0 162.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#3] audio-fft Cycles:10 Average:88.10 Median:73.50 stddev:18.85 (25.6%) stddev-sans-first:19.48 12:44:54 INFO - PROCESS | 22616 | Values: 76.0 73.0 106.0 106.0 74.0 74.0 73.0 123.0 101.0 75.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:94.00 stddev:25.08 (26.7%) stddev-sans-first:25.95 12:44:54 INFO - PROCESS | 22616 | Values: 94.0 95.0 145.0 94.0 94.0 94.0 144.0 94.0 94.0 149.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:44:54 INFO - PROCESS | 22616 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 12:44:54 INFO - PROCESS | 22616 | Values: 146.0 148.0 147.0 146.0 146.0 146.0 147.0 145.0 146.0 145.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:44:54 INFO - PROCESS | 22616 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.00 stddev:5.93 (9.1%) stddev-sans-first:6.27 12:44:54 INFO - PROCESS | 22616 | Values: 65.0 65.0 65.0 65.0 64.0 66.0 64.0 83.0 62.0 65.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 12:44:54 INFO - PROCESS | 22616 | Values: 65.0 65.0 65.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.00 stddev:2.88 (3.6%) stddev-sans-first:3.00 12:44:54 INFO - PROCESS | 22616 | Values: 78.0 78.0 79.0 77.0 87.0 78.0 79.0 79.0 81.0 78.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:136.00 stddev:12.13 (8.9%) stddev-sans-first:12.76 12:44:54 INFO - PROCESS | 22616 | Values: 143.0 132.0 132.0 135.0 131.0 131.0 133.0 141.0 171.0 137.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:176.00 stddev:2.54 (1.4%) stddev-sans-first:2.65 12:44:54 INFO - PROCESS | 22616 | Values: 174.0 178.0 172.0 175.0 178.0 179.0 176.0 172.0 176.0 173.0 12:44:54 INFO - PROCESS | 22616 | 12:44:54 INFO - PROCESS | 22616 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:72.00 stddev:1.65 (2.3%) stddev-sans-first:1.45 12:44:54 INFO - PROCESS | 22616 | Values: 74.0 72.0 73.0 73.0 70.0 72.0 71.0 70.0 70.0 69.0 12:44:54 INFO - PROCESS | 22616 | -------- Summary: end -------- 12:44:54 INFO - PROCESS | 22616 | 12:44:55 INFO - TEST-INFO | 22616: exit 0 12:44:55 INFO - TEST-OK | kraken | took 63267ms 12:44:55 INFO - SUITE-END | took 1180s 12:44:56 INFO - Completed test suite (00:19:40) 12:44:56 INFO - javascript benchmark 12:44:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2526.178991827656, 2591.5335239656856, 2596.4677241165564, 2606.9869650651744, 2611.843289402636, 4383.101464199839, 4464.799084041218, 4467.4862390825065, 4501.932471012938, 4512.278035514322, 4400.053988392495, 4424.469063712351, 4495.235809912315, 4497.91004179917, 4499.460064792222, 4060.7157498975084, 4075.5924407559305, 4107.404426358184, 4190.20386126635, 4245.320748680212, 4191.769452680117, 4225.978870105645, 4226.049138943744, 4245.1934132514725, 4268.274393353122, 4031.5363733170766, 4119.8352065917625, 4125.278076336629, 4190.057237121654, 4215.873523794291, 4096.365063415175, 4108.938365924513, 4132.876013719563, 4133.379993001044, 4134.813933373005, 3956.8615098471705, 4075.0831063010587, 4093.2222877653153, 4147.564505726916, 4246.150769846043, 4396.076823866992, 4503.392042074311, 4508.143452743968, 4554.294084416888, 4558.680892337537, 4798.5441383068555, 4824.638152138568, 4829.10661527615, 4864.975675121637, 4872.415310162768, 4613.792379342937, 4809.567138957475, 4851.054044461332, 4885.145099607555, 4912.852614421573, 4528.25283828168, 4556.88607784808, 4560.863174104782, 4604.930926036112, 4606.953930460652, 4931.358923340014, 4977.502249775066, 4980.377452818398, 4989.201727723619, 5000.874978125576, 4512.4133862597655, 4641.791119399635, 4686.414198225222, 4734.928976065362, 4736.786844592001, 4770.212914869077, 4789.185838407479, 4792.376990991219, 4795.976020119877, 4830.154722923475, 4585.12882552314, 4759.524047595212, 4770.522947705202, 4775.6418268629295, 4821.373221481255, 4793.640476964241, 4870.829520966749, 4884.0476107158765, 4884.633652476078, 4896.069746748107, 4047.777372244555, 4058.553559108496, 4060.147369052473, 4063.776492292893, 4101.384792281122, 3580.534530511017, 3581.606023337431, 3598.0824889653495, 3609.9819500902327, 3627.510286111341, 4037.0714735610973, 4126.00975765814, 4208.284591619371, 4258.6380157686945, 4279.7646129462555, 4846.5153484651955, 4880.41435027799, 4918.55732984026, 4921.163402221631, 4955.1823949048, 4201.264778663722, 4237.639800616982, 4243.533211346749, 4286.39990401344, 4290.013296941721, 4180.310248808913, 4390.780460976938, 4421.867343979686, 4462.040661257845, 4470.508244093147, 4534.88662783433, 4546.5226151254965, 4557.5442455754155, 4562.406887104655, 4613.1235065336805, 4669.463011753692, 4794.041191761592, 4795.304680821331, 4800.135975524439, 4826.638002149783, 4563.885902852322, 4595.609373203315, 4599.356090147315, 4603.470600880942, 4635.026644404713, 4716.8113275468595, 4740.1230772307235, 4745.715257084586, 4747.169245382113, 4787.473377928355, 4573.496915339377, 4745.857624271277, 4748.786304616231, 4788.162071637519, 4843.418789745253, 4654.86035418938, 4665.113628410591, 4668.6498512611015, 4686.484486706528, 4692.202325604587, 4651.651126165483, 4685.953140468551, 4694.7887345068875, 4726.763661816826, 4737.786799593958, 4344.695871288979, 4579.335996280587, 4636.11913736389, 4640.466346370211, 4685.835995740133, 4731.384919960383, 4734.6685731999805, 4742.051589682008, 4744.9051018978735, 4795.9280610790165, 4652.55800698933, 4656.278276867091, 4661.906761864811, 4678.602318802804, 4708.458527269408], "value": 4432.789347652015, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.5656101362963, 596.6599038548028, 611.4588589098646, 616.6916541729134, 628.145721818327, 27121.186364409074, 27875.721242787567, 33600.49599256013, 34946.82526587364, 35059.0, 36398.27203455936, 37074.81462592683, 37158.07104822381, 37158.62841371586, 37162.44256336157, 7563.319301262899, 7743.651535680908, 7744.574048427335, 7744.690212391526, 7751.263629955173, 7578.3558397536, 7668.654910529011, 7680.577568233745, 7695.653695583712, 7701.268379503967, 7824.72613458529, 7878.803029924269, 7892.802679933019, 7917.366610671162, 7920.089189743167, 7835.569043702594, 7897.802554936173, 7898.052233731989, 7899.842003159962, 7900.407469439786, 7788.805279867992, 7883.211678832128, 7899.723509677134, 7900.933373994495, 7905.960470197612, 37805.81097094497, 38301.425478617566, 38308.233835323415, 38352.616473835464, 38376.42435363472, 3211.7430605551735, 3261.1684020574603, 3266.4610339293986, 3267.297531030816, 3712.574850299401, 28224.576631350545, 28465.0, 28715.856420717973, 29025.709742902513, 29215.41569168605, 3399.1841957930164, 3427.2141160502097, 3477.9130521736906, 3531.1172206948263, 3589.246258285763, 232356.0, 232522.0, 232886.0, 233251.0, 234323.0, 33462.832685836416, 50046.24930626043, 50229.49770502321, 50401.24398134031, 50492.49507504878, 32919.50620740691, 33236.0, 33377.165570860925, 33394.16514587106, 33400.49899251513, 13441.462341506425, 13535.59393218205, 13614.38735256896, 13618.795718064237, 13620.114692544952, 11261.380624065756, 11296.0, 11310.94344528272, 11318.886811131782, 11338.943305283421, 8117.553534555656, 8145.51126932386, 8152.0, 8152.8777068344025, 8212.876806847902, 3107.3163903941095, 3144.7169754722186, 3153.6215654121193, 3205.83970801459, 3218.3563287342627, 883.7083762358407, 911.4349103555838, 926.5876684875301, 943.4716558726998, 958.9089036541517, 27817.304567385574, 27840.44319113647, 28146.437071258868, 28301.29246768806, 28703.282417939718, 932.6782260120248, 965.2519297544319, 987.770226068535, 991.7570195302053, 1023.6314926626409, 14410.927945360207, 14649.707005860037, 14888.851111488962, 15138.318775655121, 15164.696706065817, 345091.0, 346623.0, 349790.0, 350116.0, 350163.0, 48398.758006210446, 49139.50860491421, 49252.7537362318, 49305.75347123241, 49376.50623493791, 1077.73595469109, 1157.6353448663813, 1251.2742609286593, 1255.2885766743789, 1289.2135797163724, 24314.756852431958, 26864.32839179036, 27965.300867478476, 28425.0, 28539.42921141607, 38879.222415552096, 39041.0, 39401.211975760896, 39518.802405987786, 39526.0, 223944.0, 225280.0, 225939.0, 225953.0, 226083.0, 21557.24549640755, 24888.377790554656, 24904.252872413857, 24905.62641560342, 24912.0, 39051.0, 39969.40045899372, 40235.59764402318, 40644.59355406408, 41009.38485922654, 34166.487502686985, 34594.65405346015, 34608.30783384368, 35314.29371412506, 35669.46495802617, 34159.829200853834, 34480.65519344775, 34507.65492345044, 34784.304313913075, 34787.65212347844, 34197.487037694955, 34332.31335373229, 34542.82728586441, 34817.825910870284, 34995.65004349924, 30303.0, 31150.0, 31252.218694532818, 31653.525197121602, 35331.11672208215, 24201.878990604935, 24346.51306973815, 24537.754622453547, 24896.50206995886, 24986.500269994136], "value": 16011.010639722033, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.22741924216865, 376.9057735566108, 379.57298039705324, 381.0739902038047, 390.7948327128259, 15852.920735396321, 16791.0, 17301.13494325282, 17308.653826923455, 17357.479275621736, 14991.700165996674, 16463.423780167697, 16494.587635309123, 17014.914925425357, 17018.659626807457, 5020.196768517028, 5202.661826981253, 5244.763985620656, 5244.79020839166, 5249.816256431026, 3637.345277849986, 5625.662460252377, 5976.4919981801595, 5980.491658209057, 5985.072313791369, 5855.531557475391, 5902.173695682608, 5912.586118971673, 5931.199288096116, 5933.258342707161, 5793.159991801186, 5859.853503662443, 5937.584369094144, 5937.792177273818, 5950.04799232123, 3319.3859136059905, 4892.559669629715, 5250.9737451312885, 5259.947400525984, 5263.368395792491, 11711.765764684658, 12373.62879113619, 12373.690657733629, 19114.71327930082, 19242.903785480983, 1856.3128101543575, 1857.526330785641, 1891.8013608571177, 1964.0768838645813, 2025.9594808103902, 5726.742296596663, 6866.793996180123, 8862.291016718647, 8935.195832375053, 9388.483633400161, 1742.9041402722971, 1767.2665843674858, 1784.580623553464, 1787.2404228203093, 1824.79927208007, 67361.66319168422, 69539.0, 70196.6490167551, 70241.29758702399, 71639.64180179065, 10053.69838904834, 10179.440130792878, 10312.587496500206, 10325.74185645365, 10354.068133867837, 14112.2943852809, 14227.0, 14239.288035598178, 14269.0, 14284.142951422948, 7152.9284707152265, 7235.167955685059, 7238.167610724729, 7362.8527429451115, 7369.115706115301, 6779.457643388616, 6780.423663988616, 6794.607105543352, 6852.862942741117, 6882.277360877136, 4446.6220371268155, 4463.4420697412825, 4469.128519938581, 4476.753778542146, 4479.753613551221, 1722.8707846911282, 1744.836402860444, 1831.1180842771307, 1885.4343696890878, 1894.5453091257998, 785.846759881829, 859.6819176904461, 928.8420968435382, 932.9300302477342, 971.6890595009529, 15845.52463426099, 16365.099919504304, 16670.666586668198, 16791.580210494834, 17170.570735731708, 857.7469646454311, 867.2281669314315, 869.9565021748887, 880.2078129683337, 912.8219997100501, 8854.070322616162, 8943.016268210491, 9124.726258212264, 9213.677521286723, 9247.630094796268, 414501.0, 418442.7233591499, 423702.0, 426098.0, 455632.0, 80722.5963870177, 82296.0, 82879.5856020716, 82981.17018829855, 83907.0, 910.988802429303, 949.9667511637059, 1030.922680798943, 1047.9895201048043, 1056.5404049238605, 14865.182414967281, 15015.32431040584, 15231.31459084366, 15270.083794972337, 15283.083015019134, 33226.335473290885, 34210.0, 34421.82789086038, 34574.82712586421, 35451.82274088716, 44965.32552011657, 45565.77217113893, 48312.0, 48827.75586122047, 49652.50347496623, 7110.57336559808, 7113.75101871432, 7158.821029474305, 7320.011798407147, 7330.266973302627, 9065.274778017874, 10500.527476263434, 10982.341059536133, 11165.0, 11209.327440353605, 9305.534723263674, 9317.534123293673, 9426.57580408897, 9802.117809397188, 10077.546510406903, 9650.517474126405, 9998.550065247227, 10093.091621754078, 10142.847857282295, 10280.691579252634, 9896.406215627085, 10460.37237765706, 10636.787264254826, 10647.733806654896, 10662.786744265226, 6367.713452894724, 6515.511336649675, 7410.703571857065, 7740.6903723852665, 8090.1909809018625, 8178.754637360888, 8976.640934362553, 9183.586738596912, 9307.348485605942, 9826.115649591571], "value": 8064.508360518701, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.4132457744856, 1439.2803598200896, 1459.4454107439174, 1596.9361225550979, 1751.5008222656538, 6708.195016598009, 7731.45879788415, 7963.0, 7967.60161991901, 7972.402069844763, 7760.146383897767, 7876.80307992299, 7879.40904432167, 7902.6048697565175, 7906.130325664172, 1875.1186942137242, 1934.2456441987636, 1937.5059359863214, 2205.151016858513, 2235.251190851067, 2226.743924448685, 2295.9426014349606, 2296.609576372021, 2298.6207275799475, 2300.0914638717695, 2227.2204728345114, 2245.921392751254, 2254.5152792149684, 2256.424611724008, 2271.3413110198107, 1858.5353661584604, 2191.364504293753, 2193.046024979139, 2206.7903549162725, 2214.71208742864, 2252.8085112765434, 2277.36233854521, 2278.6695929090356, 2278.7721227877246, 2281.133169395619, 7768.378529717609, 7791.1040230373665, 7800.687972481094, 7812.023497062867, 7816.6091695415, 4495.280755079171, 4654.25531914892, 4662.347271382009, 4675.555822196886, 4678.508756580544, 2831.7026712195334, 2974.5538169274564, 2991.9401611967855, 3002.4445477586714, 3005.1285127313054, 919.9862002069974, 954.4750387286964, 959.4147569982375, 972.1979367022165, 1010.9039641234071, 10953.726156846064, 10957.50691218897, 10959.780804383947, 10962.068224200952, 10994.945025274903, 4164.58404142593, 4241.151769646083, 4430.490493593214, 4450.710703804307, 4456.0, 9291.628334866666, 9310.906890931139, 9313.161815436642, 9315.347925645276, 9353.204977576846, 4662.230731929194, 4667.953320466752, 4673.135469938073, 4682.2508398656055, 4698.459677137104, 3748.7001039917286, 4202.915941681211, 4294.806733696991, 4323.092150648336, 4347.413099231563, 3676.3933950898336, 3694.722895782827, 3773.0755964788805, 3809.942850857184, 3836.0026393137987, 1197.6466942252057, 1205.584073494643, 1214.574898785418, 1228.8525376954644, 1234.666640007211, 809.8096947217399, 823.54704912298, 847.6948298612494, 855.2516548020482, 870.7474832298562, 5024.924626130611, 5201.843944681666, 5214.0, 5310.4424035476495, 5500.559955203574, 419.2913975381595, 422.9133027729308, 424.4651738809061, 426.1881116473124, 426.50951405882864, 3564.750467467304, 3619.5475565554307, 3621.9818900905325, 3633.8364773585254, 3701.7964011979598, 9475.28935329853, 9869.555869985868, 9896.455694936847, 9994.850077248848, 10002.849957250646, 9799.853002204973, 9806.362586431858, 9807.411555306704, 9808.656697015713, 9828.017198280115, 7250.528715633467, 7409.7777066687, 7572.545647261182, 7574.280443357872, 7587.62061896914, 5209.088409528242, 5256.710880901587, 5382.19267109921, 5407.810726624549, 5434.510894019557, 8909.109089091038, 8931.106889311017, 8956.507392093497, 9182.95408522953, 9330.813383732424, 8987.550622468982, 9137.77155571116, 9333.953330233306, 9380.57787399555, 9461.432314061178, 5988.6706231157705, 6171.13604095418, 6178.567500275118, 6986.580805151707, 7066.222715501393, 7354.742584009534, 7530.246975302426, 7540.245975402416, 7551.622418879144, 7559.395248380227, 6296.968515157578, 6387.744490220525, 6481.837954051187, 6541.8691626168165, 6578.342165783383, 6814.965925170342, 6815.931840681728, 6855.0, 6931.445484361138, 6938.5836849789175, 6294.779682711083, 6342.207224096988, 6353.7140828661895, 6355.428011478989, 6359.17330747, 4284.143171365677, 4413.691041627056, 4462.352958821018, 4471.664625153061, 4557.954420455753, 4588.977055114703, 4621.6302695784925, 4626.259798432235, 4678.479494164342, 4693.0], "value": 4102.1269669175745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.17215636797044, 315.39444267007343, 316.1069977314087, 316.83524567225044, 319.4728697648878, 4976.527229913157, 5021.096202683516, 5058.11482990477, 5058.570021548168, 5065.593842924609, 4990.725510096943, 5008.549230569248, 5009.223570346602, 5013.5738462230665, 5016.523430274118, 3725.944110838333, 3847.5960024197475, 3849.441830934527, 3948.743331683446, 3951.8024098794945, 3910.569837317893, 3915.4322623219614, 3938.0, 3941.2314598653275, 3971.9801400992956, 3678.1724112074835, 3923.8032400117954, 3926.214757048587, 3927.0771368728324, 3931.1941052084253, 3770.4532842737785, 3871.6128387161057, 3887.319719049169, 3890.105275786585, 3933.5279766427925, 3469.392856250146, 3472.291612542221, 3477.23500829817, 3477.6000759912426, 3501.509788629594, 4761.238201887716, 4782.426108866958, 4785.49752276013, 4788.329633851264, 4797.40032495938, 4344.152890186415, 4498.212812757754, 4499.325101234808, 4504.527024662396, 4534.841280555198, 5198.220266959948, 5251.947480525222, 5264.263003179558, 5271.71005594696, 5272.57819374453, 3777.697784177259, 3808.1812410331913, 3825.6418971265357, 3826.9043273918096, 3829.215010922754, 5333.306670132897, 5493.862653433656, 5512.448755124496, 5536.141898005815, 5558.749856256478, 3906.5507466641134, 3910.9608903911167, 3918.4122381642983, 3923.725339226227, 3934.429507721364, 3956.248312820555, 3956.8812935611404, 3968.0675041365835, 3974.463447434617, 3982.283189026003, 4367.2575662137515, 4494.853602478278, 4499.6400287976885, 4502.234620114588, 4505.977470112629, 5254.97372513135, 5265.526102650703, 5278.709670968134, 5301.163877325613, 5319.414864364994, 1366.3031853754658, 1373.6881278379124, 1381.5924302330836, 1389.7845833895763, 1393.212834748364, 877.1491653096614, 928.7956649537091, 942.4298299528687, 958.1616085924816, 967.3760424526141, 4560.6807523473035, 4564.406627138517, 4569.885752856138, 4571.085782843445, 4610.05493873755, 5415.1335786274, 5420.105682562412, 5426.620136590401, 5427.348718153847, 5432.0, 4458.175237581057, 4544.772761361919, 4598.839040633628, 4607.815687372535, 4608.976955115203, 2864.0, 2880.9135725928254, 2883.985580072128, 2889.754370878457, 2898.9855050724614, 5117.360329958755, 5120.92318615221, 5125.513076257749, 5140.485951404904, 5157.07172708916, 5403.83788486346, 5473.534749546254, 5550.639208451437, 5556.833295001156, 5572.247746554244, 5087.516685914832, 5089.949100508948, 5094.312267843794, 5116.976604679154, 5127.077126117335, 5371.428000379704, 5390.137577987503, 5390.676559406291, 5393.379761327497, 5407.324084489439, 5099.77051032697, 5307.089447798712, 5310.097283461898, 5322.308099946982, 5322.547583455294, 5101.158308878993, 5117.513836185556, 5123.948760512347, 5127.0, 5144.074066668036, 3940.054386947055, 3941.0738476457436, 3946.2107578484993, 3957.6240257175523, 3959.3269144244973, 5288.259643649815, 5362.678239305654, 5386.5152136307925, 5398.7300634967305, 5407.080796264566, 5196.0, 5212.582993360598, 5217.2434996925995, 5220.9477905220465, 5237.450067742984, 5037.974810125926, 5193.350831146106, 5213.973930130325, 5223.213170451392, 5227.137522308776, 4918.631102667386, 5111.105556527518, 5116.488351164854, 5143.3570803649545, 5149.459306772735, 5120.542139772855, 5299.788008479618, 5329.62692611529, 5343.251944727819, 5346.1713434417725, 5199.55803756685, 5217.973910130425, 5227.268182454383, 5230.921536176884, 5237.266782650356], "value": 3979.362963388739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.9777106686798, 754.9396048316136, 781.8084569280527, 782.2216894190282, 784.4704824243635, 11790.29258244506, 11887.940560297186, 11890.10824188186, 11972.82040769387, 12013.0, 12034.217775844585, 12070.939645301762, 12125.151239413244, 13171.736565268713, 13679.52121675739, 832.3757182113415, 841.8484672758901, 841.9284360829337, 841.9536925469097, 842.3261390887296, 645.7158850105961, 798.9960050199741, 820.7496713502379, 830.5888585150329, 837.8282452097336, 868.8001759595297, 870.4255191573562, 871.7036207689384, 871.9869201961976, 872.1932212703256, 858.5707146426787, 859.7850537365658, 859.9613017414231, 861.0743450790362, 861.6036623153357, 496.70694290368493, 613.3835495327212, 631.2204427531994, 632.6710110742388, 635.4312889963503, 12990.545330913372, 13100.868991310155, 13247.0, 13255.072144949858, 13285.070045096847, 12016.279023258632, 12287.385630718429, 12382.938085309606, 12766.0, 13074.738505229938, 10037.347572407843, 10040.347377420445, 10079.5464204111, 10259.281850270485, 11346.602868899548, 4202.327627579572, 4236.894077648052, 4249.298865687158, 4284.785760711983, 4324.502682191557, 45439.318410223874, 45803.541964580596, 45928.54071459276, 46360.5363946363, 46798.2980255293, 10430.947845260725, 10441.0, 10516.211284153718, 10598.523066462029, 10818.0, 17557.0, 17852.910735446498, 18081.36715214961, 18152.909235454, 18519.629607407776, 6896.517243792886, 7066.540674856118, 7223.494355395072, 7237.457190710717, 7319.34125928669, 3777.54669439669, 3866.6906647468136, 3900.1029763154065, 3944.5660977292473, 3981.5620281768984, 2850.5296626056884, 2980.0463851567292, 2985.626796650419, 2987.462256793798, 2991.2073300575366, 532.1751285507526, 536.3617295418439, 549.5328970375149, 556.7772890843695, 559.5887023038064, 532.0874699889707, 534.6257619666171, 597.2593983460564, 607.4138456389517, 607.750822162911, 7548.584827834522, 7611.505252158592, 7619.276168763959, 7635.0, 7869.306713580166, 510.27540891933546, 545.1495666759868, 560.3527925246347, 593.7535922592076, 599.5173885022512, 3651.1602331463914, 3704.759190652599, 3744.1762812181278, 3749.3251214781058, 3772.905677358088, 50501.74749126231, 51034.23448648273, 51213.74393128085, 51321.743391282806, 51690.22464663033, 44012.3398149028, 44992.55007449949, 45336.54663453323, 45520.77239613847, 45773.77113114413, 38330.23339533194, 38987.0, 39851.0, 41146.38280425796, 42102.15795684069, 7204.53170543913, 7235.674394652358, 7278.96360518194, 7345.889811652936, 7474.2525747424825, 28157.43685126327, 28259.434811303247, 28543.14370568886, 29061.27346816262, 29397.559036614897, 34522.0, 35880.282394351445, 37051.258974819815, 37737.81131094327, 37914.62085379111, 8986.505742183981, 9245.815083698153, 9249.491277979776, 9250.161282318602, 9619.807603847745, 10200.99930177639, 10321.122704570196, 10338.483075846329, 10374.844377334195, 10565.683029509128, 9585.568649410654, 9896.950515247378, 9935.403875767477, 9958.452285124387, 10164.644237451654, 9455.905440945779, 9899.554520046471, 10120.240981926238, 10225.693229203136, 10512.632057877938, 9660.516974151406, 10076.244281678757, 10119.949400252952, 10198.0, 10394.168466522811, 7748.14770375247, 8187.1403502631365, 8210.384221183316, 8414.705485307984, 8587.65649374018, 7994.880076798969, 8572.571371431528, 8632.525211113198, 8698.739037828875, 8788.472691638523], "value": 5861.005669016236, "unit": "score"}], "name": "dromaeo_css", "value": 6162.43409294707, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 109.0, 112.0, 114.0, 114.0, 106.0, 116.0, 113.0, 115.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 137.0, 157.0, 192.0, 137.0, 160.0, 159.0, 134.0, 185.0, 131.0], "value": 155.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 159.0, 160.0, 162.0, 162.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 106.0, 106.0, 74.0, 74.0, 73.0, 123.0, 101.0, 75.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 145.0, 94.0, 94.0, 94.0, 144.0, 94.0, 94.0, 149.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 64.0, 83.0, 62.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 77.0, 87.0, 78.0, 79.0, 79.0, 81.0, 78.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 132.0, 135.0, 131.0, 131.0, 133.0, 141.0, 171.0, 137.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 178.0, 172.0, 175.0, 178.0, 179.0, 176.0, 172.0, 176.0, 173.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 73.0, 70.0, 72.0, 71.0, 70.0, 70.0, 69.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1581.0, "alertThreshold": 2.0}]} 12:44:56 INFO - Return code: 0 12:44:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:44:56 ERROR - # TBPL SUCCESS # 12:44:56 INFO - Running post-action listener: _resource_record_post_action 12:44:56 INFO - Running post-run listener: _resource_record_post_run 12:44:57 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516608000; Read time: 180; Write time: 484636 12:44:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233746432; Read time: 0; Write time: 274668 12:44:57 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282693632; Read time: 180; Write time: 209948 12:44:57 INFO - Running post-run listener: _upload_blobber_files 12:44:57 INFO - Blob upload gear active. 12:44:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:44:57 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 12:44:57 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'] 12:44:57 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 12:44:57 INFO - (blobuploader) - INFO - Open directory for files ... 12:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:44:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:58 INFO - (blobuploader) - INFO - Done attempting. 12:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:44:59 INFO - (blobuploader) - INFO - Done attempting. 12:44:59 INFO - (blobuploader) - INFO - Iteration through files over. 12:44:59 INFO - Return code: 0 12:44:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:44:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:44:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ba8a49c518d644419a59e73a7850a9401fbdd8aee434c153a1c74dcc94f986b49f242b11fb0dcd1f222619395689b5b95f8e8f18bbca1201a52ae8fbe7b37e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5e39503a2f2febdb3e3f9765eabd3d9c8842d0bc51b71176c5baabb6a4f6183574f8550e96fb7ed7743a815ce214e39333472ef7123f1a68b4e03dbe5291f28"} 12:44:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:44:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:44:59 INFO - Contents: 12:44:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6ba8a49c518d644419a59e73a7850a9401fbdd8aee434c153a1c74dcc94f986b49f242b11fb0dcd1f222619395689b5b95f8e8f18bbca1201a52ae8fbe7b37e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5e39503a2f2febdb3e3f9765eabd3d9c8842d0bc51b71176c5baabb6a4f6183574f8550e96fb7ed7743a815ce214e39333472ef7123f1a68b4e03dbe5291f28"} 12:44:59 INFO - Running post-run listener: copy_logs_to_upload_dir 12:44:59 INFO - Copying logs to upload dir... 12:44:59 INFO - mkdir: /builds/slave/test/build/upload/logs 12:44:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.443869 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-04-15 12:44:59.308418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 12:44:59.312585) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034 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/6ba8a49c518d644419a59e73a7850a9401fbdd8aee434c153a1c74dcc94f986b49f242b11fb0dcd1f222619395689b5b95f8e8f18bbca1201a52ae8fbe7b37e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5e39503a2f2febdb3e3f9765eabd3d9c8842d0bc51b71176c5baabb6a4f6183574f8550e96fb7ed7743a815ce214e39333472ef7123f1a68b4e03dbe5291f28"} build_url:https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/bRdZkaOHQriQEHFhtjFi9A/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/6ba8a49c518d644419a59e73a7850a9401fbdd8aee434c153a1c74dcc94f986b49f242b11fb0dcd1f222619395689b5b95f8e8f18bbca1201a52ae8fbe7b37e1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d5e39503a2f2febdb3e3f9765eabd3d9c8842d0bc51b71176c5baabb6a4f6183574f8550e96fb7ed7743a815ce214e39333472ef7123f1a68b4e03dbe5291f28"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 12:44:59.337694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:44:59.338058) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1460748118.789322-643513034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 12:44:59.422289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 12:44:59.422784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 12:44:59.423174) ========= ========= Total master_lag: 0.17 =========