builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1461960932.85 results: success (0) buildid: 20160429123137 builduid: e168573f9bac424191d4cc8c1a157a97 revision: f60f1ab969dae2f69206b9b6affa285b947ec4f6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:32.855181) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:32.855688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:32.856005) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:32.892137) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:32.892401) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-29 13:15:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 46.4M=0s 2016-04-29 13:15:33 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087543 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.008935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.009432) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019657 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.078760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.079485) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f60f1ab969dae2f69206b9b6affa285b947ec4f6 --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 f60f1ab969dae2f69206b9b6affa285b947ec4f6 --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=d6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-29 13:15:33,271 truncating revision to first 12 chars 2016-04-29 13:15:33,271 Setting DEBUG logging. 2016-04-29 13:15:33,271 attempt 1/10 2016-04-29 13:15:33,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f60f1ab969da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 13:15:33,530 unpacking tar archive at: fx-team-f60f1ab969da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.515645 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.624610) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.624935) ========= script_repo_revision: f60f1ab969dae2f69206b9b6affa285b947ec4f6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.625355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.625632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 13:15:33.635486) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-29 13:15:33.635756) ========= /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=d6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:15:33 INFO - MultiFileLogger online at 20160429 13:15:33 in /builds/slave/test 13:15:33 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 13:15:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:15:33 INFO - {'append_to_log': False, 13:15:33 INFO - 'base_work_dir': '/builds/slave/test', 13:15:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:15:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:15:33 INFO - 'branch': 'Fx-Team-Non-PGO', 13:15:33 INFO - 'buildbot_json_path': 'buildprops.json', 13:15:33 INFO - 'config_files': ('talos/linux_config.py',), 13:15:33 INFO - 'default_actions': ('clobber', 13:15:33 INFO - 'read-buildbot-config', 13:15:33 INFO - 'download-and-extract', 13:15:33 INFO - 'populate-webroot', 13:15:33 INFO - 'create-virtualenv', 13:15:33 INFO - 'install', 13:15:33 INFO - 'run-tests'), 13:15:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:15:33 INFO - 'download_minidump_stackwalk': True, 13:15:33 INFO - 'download_symbols': 'ondemand', 13:15:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:15:33 INFO - 'tooltool.py': '/tools/tooltool.py', 13:15:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:15:33 INFO - '/tools/misc-python/virtualenv.py')}, 13:15:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:15:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:15:33 INFO - 'installer_path': 'installer.exe', 13:15:33 INFO - 'log_level': 'info', 13:15:33 INFO - 'log_name': 'talos', 13:15:33 INFO - 'log_to_console': True, 13:15:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:15:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:15:33 INFO - 'opt_config_files': (), 13:15:33 INFO - 'pip_index': False, 13:15:33 INFO - 'sps_profile': False, 13:15:33 INFO - 'sps_profile_interval': 0, 13:15:33 INFO - 'suite': 'dromaeojs', 13:15:33 INFO - 'system_bits': '32', 13:15:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:15:33 INFO - 'title': 'talos-linux64-ix-034', 13:15:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:15:33 INFO - 'use_talos_json': True, 13:15:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:15:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:15:33 INFO - 'work_dir': 'build'} 13:15:33 INFO - ##### 13:15:33 INFO - ##### Running clobber step. 13:15:33 INFO - ##### 13:15:33 INFO - Running pre-action listener: _resource_record_pre_action 13:15:33 INFO - Running main action method: clobber 13:15:33 INFO - rmtree: /builds/slave/test/build 13:15:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:15:34 INFO - Running post-action listener: _resource_record_post_action 13:15:34 INFO - ##### 13:15:34 INFO - ##### Running read-buildbot-config step. 13:15:34 INFO - ##### 13:15:34 INFO - Running pre-action listener: _resource_record_pre_action 13:15:34 INFO - Running main action method: read_buildbot_config 13:15:34 INFO - Using buildbot properties: 13:15:34 INFO - { 13:15:34 INFO - "project": "", 13:15:34 INFO - "product": "firefox", 13:15:34 INFO - "script_repo_revision": "production", 13:15:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:15:34 INFO - "repository": "", 13:15:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:15:34 INFO - "buildid": "20160429123137", 13:15:34 INFO - "pgo_build": "False", 13:15:34 INFO - "basedir": "/builds/slave/test", 13:15:34 INFO - "buildnumber": 1622, 13:15:34 INFO - "slavename": "talos-linux64-ix-034", 13:15:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:15:34 INFO - "platform": "ubuntu64_hw", 13:15:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:15:34 INFO - "branch": "fx-team", 13:15:34 INFO - "repo_path": "integration/fx-team", 13:15:34 INFO - "revision": "f60f1ab969dae2f69206b9b6affa285b947ec4f6", 13:15:34 INFO - "stage_platform": "linux64", 13:15:34 INFO - "builduid": "e168573f9bac424191d4cc8c1a157a97", 13:15:34 INFO - "slavebuilddir": "test" 13:15:34 INFO - } 13:15:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 13:15:34 INFO - Running post-action listener: _resource_record_post_action 13:15:34 INFO - ##### 13:15:34 INFO - ##### Running download-and-extract step. 13:15:34 INFO - ##### 13:15:34 INFO - Running pre-action listener: _resource_record_pre_action 13:15:34 INFO - Running main action method: download_and_extract 13:15:34 INFO - mkdir: /builds/slave/test/build/tests 13:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:34 INFO - https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:15:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:15:35 INFO - Downloaded 1361 bytes. 13:15:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 13:15:35 INFO - Using the following test package requirements: 13:15:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:15:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:15:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:15:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'jsshell-linux-x86_64.zip'], 13:15:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:15:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 13:15:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:15:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:15:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:15:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 13:15:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:15:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:35 INFO - https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:15:37 INFO - Downloaded 22301146 bytes. 13:15:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:15:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:15:38 INFO - Return code: 0 13:15:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:38 INFO - https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:15:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 13:15:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:15:39 INFO - Downloaded 22301146 bytes. 13:15:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:15:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:15:41 INFO - Return code: 0 13:15: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')]} 13:15:41 INFO - https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:15:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:15:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:15:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 13:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:15:43 INFO - Downloaded 10840145 bytes. 13:15:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:15:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 13:15:44 INFO - Return code: 0 13:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:44 INFO - https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:15:46 INFO - Downloaded 54852659 bytes. 13:15:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:46 INFO - mkdir: /builds/slave/test/properties 13:15:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:15:46 INFO - Writing to file /builds/slave/test/properties/build_url 13:15:46 INFO - Contents: 13:15:46 INFO - build_url:https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 13:15:47 INFO - Running post-action listener: _resource_record_post_action 13:15:47 INFO - Running post-action listener: set_extra_try_arguments 13:15:47 INFO - ##### 13:15:47 INFO - ##### Running populate-webroot step. 13:15:47 INFO - ##### 13:15:47 INFO - Running pre-action listener: _resource_record_pre_action 13:15:47 INFO - Running main action method: populate_webroot 13:15:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:15:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:15:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:15:47 INFO - '--tppagecycles', 13:15:47 INFO - '7'], 13:15:47 INFO - 'tests': ['tsvgm']}}, 13:15:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:15:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:15:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:15:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:15:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:15:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['damp', 'tps']}, 13:15:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'tests': ['damp', 'tps']}, 13:15:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['dromaeo_dom']}, 13:15:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:15:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['a11yr', 13:15:47 INFO - 'ts_paint', 13:15:47 INFO - 'tpaint', 13:15:47 INFO - 'sessionrestore', 13:15:47 INFO - 'sessionrestore_no_auto_restore', 13:15:47 INFO - 'tabpaint']}, 13:15:47 INFO - 'other-e10s': {'tests': ['a11yr', 13:15:47 INFO - 'ts_paint', 13:15:47 INFO - 'tpaint', 13:15:47 INFO - 'sessionrestore', 13:15:47 INFO - 'sessionrestore_no_auto_restore', 13:15:47 INFO - 'tabpaint']}, 13:15:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:15:47 INFO - 'ts_paint', 13:15:47 INFO - 'tpaint', 13:15:47 INFO - 'sessionrestore', 13:15:47 INFO - 'sessionrestore_no_auto_restore', 13:15:47 INFO - 'tabpaint']}, 13:15:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:15:47 INFO - 'ts_paint', 13:15:47 INFO - 'tpaint', 13:15:47 INFO - 'sessionrestore', 13:15:47 INFO - 'sessionrestore_no_auto_restore', 13:15:47 INFO - 'tabpaint']}, 13:15:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['a11yr', 13:15:47 INFO - 'ts_paint', 13:15:47 INFO - 'tpaint', 13:15:47 INFO - 'sessionrestore', 13:15:47 INFO - 'sessionrestore_no_auto_restore', 13:15:47 INFO - 'tabpaint']}, 13:15:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['a11yr', 13:15:47 INFO - 'ts_paint', 13:15:47 INFO - 'tpaint', 13:15:47 INFO - 'sessionrestore', 13:15:47 INFO - 'sessionrestore_no_auto_restore', 13:15:47 INFO - 'tabpaint']}, 13:15:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['tsvgx', 13:15:47 INFO - 'tsvgr_opacity', 13:15:47 INFO - 'tart', 13:15:47 INFO - 'tscrollx', 13:15:47 INFO - 'cart']}, 13:15:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:15:47 INFO - 'tsvgr_opacity', 13:15:47 INFO - 'tart', 13:15:47 INFO - 'tscrollx', 13:15:47 INFO - 'cart']}, 13:15:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'talos_options': ['--disable-e10s'], 13:15:47 INFO - 'tests': ['tp5o']}, 13:15:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'tests': ['tp5o']}, 13:15:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'talos_options': ['--disable-e10s', 13:15:47 INFO - '--xperf_path', 13:15:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:47 INFO - 'tests': ['tp5n']}, 13:15:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:15:47 INFO - 'talos_options': ['--xperf_path', 13:15:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:15:47 INFO - 'tests': ['tp5n']}}, 13:15:47 INFO - 'talos.zip': {'path': '', 13:15:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:15:47 INFO - Running post-action listener: _resource_record_post_action 13:15:47 INFO - ##### 13:15:47 INFO - ##### Running create-virtualenv step. 13:15:47 INFO - ##### 13:15:47 INFO - Running pre-action listener: _resource_record_pre_action 13:15:47 INFO - Running main action method: create_virtualenv 13:15:47 INFO - Creating virtualenv /builds/slave/test/build/venv 13:15:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:15:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:15:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:15:47 INFO - Using real prefix '/usr' 13:15:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:15:48 INFO - Installing distribute.............................................................................................................................................................................................done. 13:15:50 INFO - Installing pip.................done. 13:15:50 INFO - Return code: 0 13:15:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:15:50 INFO - Using env: {'DISPLAY': ':0', 13:15:50 INFO - 'HOME': '/home/cltbld', 13:15:50 INFO - 'LANG': 'en_US.UTF-8', 13:15:50 INFO - 'LANGUAGE': 'en_US:en', 13:15:50 INFO - 'LOGNAME': 'cltbld', 13:15:50 INFO - 'MAIL': '/var/mail/cltbld', 13:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:50 INFO - 'MOZ_NO_REMOTE': '1', 13:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:50 INFO - 'NO_EM_RESTART': '1', 13:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:50 INFO - 'PWD': '/builds/slave/test', 13:15:50 INFO - 'SHELL': '/bin/bash', 13:15:50 INFO - 'SHLVL': '1', 13:15:50 INFO - 'TERM': 'linux', 13:15:50 INFO - 'TMOUT': '86400', 13:15:50 INFO - 'USER': 'cltbld', 13:15:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:50 INFO - '_': '/tools/buildbot/bin/python'} 13:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:50 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 13:15:50 INFO - Cleaning up... 13:15:50 INFO - Return code: 0 13:15:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:15:50 INFO - Using env: {'DISPLAY': ':0', 13:15:50 INFO - 'HOME': '/home/cltbld', 13:15:50 INFO - 'LANG': 'en_US.UTF-8', 13:15:50 INFO - 'LANGUAGE': 'en_US:en', 13:15:50 INFO - 'LOGNAME': 'cltbld', 13:15:50 INFO - 'MAIL': '/var/mail/cltbld', 13:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:50 INFO - 'MOZ_NO_REMOTE': '1', 13:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:50 INFO - 'NO_EM_RESTART': '1', 13:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:50 INFO - 'PWD': '/builds/slave/test', 13:15:50 INFO - 'SHELL': '/bin/bash', 13:15:50 INFO - 'SHLVL': '1', 13:15:50 INFO - 'TERM': 'linux', 13:15:50 INFO - 'TMOUT': '86400', 13:15:50 INFO - 'USER': 'cltbld', 13:15:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:50 INFO - '_': '/tools/buildbot/bin/python'} 13:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:50 INFO - Downloading/unpacking psutil>=0.7.1 13:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:15:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:52 INFO - Installing collected packages: psutil 13:15:52 INFO - Running setup.py install for psutil 13:15:52 INFO - building 'psutil._psutil_linux' extension 13:15:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:15:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:15:52 INFO - building 'psutil._psutil_posix' extension 13:15:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:15:53 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 13:15:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:15:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:15:53 INFO - Successfully installed psutil 13:15:53 INFO - Cleaning up... 13:15:53 INFO - Return code: 0 13:15:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:15:53 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')]} 13:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:53 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')]} 13:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:53 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 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:15:53 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 13:15:53 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 13:15:53 INFO - Using env: {'DISPLAY': ':0', 13:15:53 INFO - 'HOME': '/home/cltbld', 13:15:53 INFO - 'LANG': 'en_US.UTF-8', 13:15:53 INFO - 'LANGUAGE': 'en_US:en', 13:15:53 INFO - 'LOGNAME': 'cltbld', 13:15:53 INFO - 'MAIL': '/var/mail/cltbld', 13:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:53 INFO - 'MOZ_NO_REMOTE': '1', 13:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:53 INFO - 'NO_EM_RESTART': '1', 13:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:53 INFO - 'PWD': '/builds/slave/test', 13:15:53 INFO - 'SHELL': '/bin/bash', 13:15:53 INFO - 'SHLVL': '1', 13:15:53 INFO - 'TERM': 'linux', 13:15:53 INFO - 'TMOUT': '86400', 13:15:53 INFO - 'USER': 'cltbld', 13:15:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:53 INFO - '_': '/tools/buildbot/bin/python'} 13:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:15:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:15:55 INFO - Installing collected packages: mozsystemmonitor 13:15:55 INFO - Running setup.py install for mozsystemmonitor 13:15:55 INFO - Successfully installed mozsystemmonitor 13:15:55 INFO - Cleaning up... 13:15:55 INFO - Return code: 0 13:15:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:15:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:15:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:15:55 INFO - Using env: {'DISPLAY': ':0', 13:15:55 INFO - 'HOME': '/home/cltbld', 13:15:55 INFO - 'LANG': 'en_US.UTF-8', 13:15:55 INFO - 'LANGUAGE': 'en_US:en', 13:15:55 INFO - 'LOGNAME': 'cltbld', 13:15:55 INFO - 'MAIL': '/var/mail/cltbld', 13:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:55 INFO - 'MOZ_NO_REMOTE': '1', 13:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:55 INFO - 'NO_EM_RESTART': '1', 13:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:55 INFO - 'PWD': '/builds/slave/test', 13:15:55 INFO - 'SHELL': '/bin/bash', 13:15:55 INFO - 'SHLVL': '1', 13:15:55 INFO - 'TERM': 'linux', 13:15:55 INFO - 'TMOUT': '86400', 13:15:55 INFO - 'USER': 'cltbld', 13:15:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:55 INFO - '_': '/tools/buildbot/bin/python'} 13:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:55 INFO - Downloading/unpacking blobuploader==1.2.4 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:57 INFO - Downloading blobuploader-1.2.4.tar.gz 13:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:15:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:15:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15: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 13:15:58 INFO - Downloading docopt-0.6.1.tar.gz 13:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:15:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:15:58 INFO - Running setup.py install for blobuploader 13:15:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:15:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:15:58 INFO - Running setup.py install for requests 13:15:58 INFO - Running setup.py install for docopt 13:15:58 INFO - Successfully installed blobuploader requests docopt 13:15:58 INFO - Cleaning up... 13:15:58 INFO - Return code: 0 13:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:58 INFO - Using env: {'DISPLAY': ':0', 13:15:58 INFO - 'HOME': '/home/cltbld', 13:15:58 INFO - 'LANG': 'en_US.UTF-8', 13:15:58 INFO - 'LANGUAGE': 'en_US:en', 13:15:58 INFO - 'LOGNAME': 'cltbld', 13:15:58 INFO - 'MAIL': '/var/mail/cltbld', 13:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:58 INFO - 'MOZ_NO_REMOTE': '1', 13:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:58 INFO - 'NO_EM_RESTART': '1', 13:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:58 INFO - 'PWD': '/builds/slave/test', 13:15:58 INFO - 'SHELL': '/bin/bash', 13:15:58 INFO - 'SHLVL': '1', 13:15:58 INFO - 'TERM': 'linux', 13:15:58 INFO - 'TMOUT': '86400', 13:15:58 INFO - 'USER': 'cltbld', 13:15:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:58 INFO - '_': '/tools/buildbot/bin/python'} 13:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:59 INFO - Running setup.py (path:/tmp/pip-Ec0QPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:59 INFO - Running setup.py (path:/tmp/pip-1l_Hih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:59 INFO - Running setup.py (path:/tmp/pip-rchlwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:59 INFO - Running setup.py (path:/tmp/pip-_Zvr0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:59 INFO - Running setup.py (path:/tmp/pip-bD5PDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:59 INFO - Running setup.py (path:/tmp/pip-OmOKrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:59 INFO - Running setup.py (path:/tmp/pip-ief7ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:59 INFO - Running setup.py (path:/tmp/pip-lsKVo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:59 INFO - Running setup.py (path:/tmp/pip-AhnD6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:59 INFO - Running setup.py (path:/tmp/pip-mpGbK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:59 INFO - Running setup.py (path:/tmp/pip-dPk7bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:59 INFO - Running setup.py (path:/tmp/pip-Pu5rE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:59 INFO - Running setup.py (path:/tmp/pip-njl_gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:59 INFO - Running setup.py (path:/tmp/pip-GXMxns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:00 INFO - Running setup.py (path:/tmp/pip-IGAOaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:00 INFO - Running setup.py (path:/tmp/pip-8cnfeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:00 INFO - Running setup.py (path:/tmp/pip-uGFQiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:16:00 INFO - Running setup.py install for manifestparser 13:16:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:16:00 INFO - Running setup.py install for mozcrash 13:16:00 INFO - Running setup.py install for mozdebug 13:16:00 INFO - Running setup.py install for mozdevice 13:16:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:16:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:16:00 INFO - Running setup.py install for mozfile 13:16:00 INFO - Running setup.py install for mozhttpd 13:16:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:16:00 INFO - Running setup.py install for mozinfo 13:16:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Running setup.py install for mozInstall 13:16:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Running setup.py install for mozleak 13:16:01 INFO - Running setup.py install for mozlog 13:16:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Running setup.py install for moznetwork 13:16:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Running setup.py install for mozprocess 13:16:01 INFO - Running setup.py install for mozprofile 13:16:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Running setup.py install for mozrunner 13:16:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:16:01 INFO - Running setup.py install for mozscreenshot 13:16:01 INFO - Running setup.py install for moztest 13:16:01 INFO - Running setup.py install for mozversion 13:16:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:16:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:16:02 INFO - Cleaning up... 13:16:02 INFO - Return code: 0 13:16:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:02 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')]} 13:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:02 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')]} 13:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:02 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 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:16:02 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 13:16:02 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 13:16:02 INFO - Using env: {'DISPLAY': ':0', 13:16:02 INFO - 'HOME': '/home/cltbld', 13:16:02 INFO - 'LANG': 'en_US.UTF-8', 13:16:02 INFO - 'LANGUAGE': 'en_US:en', 13:16:02 INFO - 'LOGNAME': 'cltbld', 13:16:02 INFO - 'MAIL': '/var/mail/cltbld', 13:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:02 INFO - 'MOZ_NO_REMOTE': '1', 13:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:02 INFO - 'NO_EM_RESTART': '1', 13:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:02 INFO - 'PWD': '/builds/slave/test', 13:16:02 INFO - 'SHELL': '/bin/bash', 13:16:02 INFO - 'SHLVL': '1', 13:16:02 INFO - 'TERM': 'linux', 13:16:02 INFO - 'TMOUT': '86400', 13:16:02 INFO - 'USER': 'cltbld', 13:16:02 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:02 INFO - '_': '/tools/buildbot/bin/python'} 13:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:16:02 INFO - Running setup.py (path:/tmp/pip-PnI0RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:16:02 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)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:16:02 INFO - Running setup.py (path:/tmp/pip-yRFMr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:16:02 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)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:16:02 INFO - Running setup.py (path:/tmp/pip-Jykgo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:16:02 INFO - Running setup.py (path:/tmp/pip-i1FU5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:16:02 INFO - Running setup.py (path:/tmp/pip-SvYzDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:16:02 INFO - Running setup.py (path:/tmp/pip-x9szYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:16:02 INFO - Running setup.py (path:/tmp/pip-m3lZNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:16:02 INFO - Running setup.py (path:/tmp/pip-v79dKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:16:02 INFO - Running setup.py (path:/tmp/pip-cX5iPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:16:02 INFO - Running setup.py (path:/tmp/pip-2Br93O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:16:03 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)) 13:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:16:03 INFO - Running setup.py (path:/tmp/pip-dhnPmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:16:03 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)) 13:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:16:03 INFO - Running setup.py (path:/tmp/pip-JyYyci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:16:03 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)) 13:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:16:03 INFO - Running setup.py (path:/tmp/pip-jlodlL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:16:03 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)) 13:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:16:03 INFO - Running setup.py (path:/tmp/pip-nxybIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:16:03 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)) 13:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:03 INFO - Running setup.py (path:/tmp/pip-OqrJWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:16:03 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)) 13:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:16:03 INFO - Running setup.py (path:/tmp/pip-LDtxyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:16:03 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)) 13:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:16:03 INFO - Running setup.py (path:/tmp/pip-59qgYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:16:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:16:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:05 INFO - Downloading blessings-1.6.tar.gz 13:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:16:05 INFO - Installing collected packages: blessings 13:16:05 INFO - Running setup.py install for blessings 13:16:05 INFO - Successfully installed blessings 13:16:05 INFO - Cleaning up... 13:16:05 INFO - Return code: 0 13:16:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:16:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:05 INFO - Reading from file tmpfile_stdout 13:16:05 INFO - Current package versions: 13:16:05 INFO - argparse == 1.2.1 13:16:05 INFO - blessings == 1.6 13:16:05 INFO - blobuploader == 1.2.4 13:16:05 INFO - docopt == 0.6.1 13:16:05 INFO - manifestparser == 1.1 13:16:05 INFO - mozInstall == 1.12 13:16:05 INFO - mozcrash == 0.17 13:16:05 INFO - mozdebug == 0.1 13:16:05 INFO - mozdevice == 0.48 13:16:05 INFO - mozfile == 1.2 13:16:05 INFO - mozhttpd == 0.7 13:16:05 INFO - mozinfo == 0.9 13:16:05 INFO - mozleak == 0.1 13:16:05 INFO - mozlog == 3.1 13:16:05 INFO - moznetwork == 0.27 13:16:05 INFO - mozprocess == 0.22 13:16:05 INFO - mozprofile == 0.28 13:16:05 INFO - mozrunner == 6.11 13:16:05 INFO - mozscreenshot == 0.1 13:16:05 INFO - mozsystemmonitor == 0.0 13:16:05 INFO - moztest == 0.7 13:16:05 INFO - mozversion == 1.4 13:16:05 INFO - psutil == 3.1.1 13:16:05 INFO - requests == 1.2.3 13:16:05 INFO - wsgiref == 0.1.2 13:16:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:16:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:16:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:16:05 INFO - Using env: {'DISPLAY': ':0', 13:16:05 INFO - 'HOME': '/home/cltbld', 13:16:05 INFO - 'LANG': 'en_US.UTF-8', 13:16:05 INFO - 'LANGUAGE': 'en_US:en', 13:16:05 INFO - 'LOGNAME': 'cltbld', 13:16:05 INFO - 'MAIL': '/var/mail/cltbld', 13:16:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:05 INFO - 'MOZ_NO_REMOTE': '1', 13:16:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:05 INFO - 'NO_EM_RESTART': '1', 13:16:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:05 INFO - 'PWD': '/builds/slave/test', 13:16:05 INFO - 'SHELL': '/bin/bash', 13:16:05 INFO - 'SHLVL': '1', 13:16:05 INFO - 'TERM': 'linux', 13:16:05 INFO - 'TMOUT': '86400', 13:16:05 INFO - 'USER': 'cltbld', 13:16:05 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:16:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:05 INFO - '_': '/tools/buildbot/bin/python'} 13:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 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)) 13:16:06 INFO - Cleaning up... 13:16:06 INFO - Return code: 0 13:16:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:16:06 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')]} 13:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:06 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')]} 13:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:06 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 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:16:06 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 13:16:06 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 13:16:06 INFO - Using env: {'DISPLAY': ':0', 13:16:06 INFO - 'HOME': '/home/cltbld', 13:16:06 INFO - 'LANG': 'en_US.UTF-8', 13:16:06 INFO - 'LANGUAGE': 'en_US:en', 13:16:06 INFO - 'LOGNAME': 'cltbld', 13:16:06 INFO - 'MAIL': '/var/mail/cltbld', 13:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:06 INFO - 'MOZ_NO_REMOTE': '1', 13:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:06 INFO - 'NO_EM_RESTART': '1', 13:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:06 INFO - 'PWD': '/builds/slave/test', 13:16:06 INFO - 'SHELL': '/bin/bash', 13:16:06 INFO - 'SHLVL': '1', 13:16:06 INFO - 'TERM': 'linux', 13:16:06 INFO - 'TMOUT': '86400', 13:16:06 INFO - 'USER': 'cltbld', 13:16:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:06 INFO - '_': '/tools/buildbot/bin/python'} 13:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:06 INFO - Downloading/unpacking jsonschema 13:16:06 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 13:16:06 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 13:16:06 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 13:16:06 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 13:16:06 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 13:16:06 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 13:16:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:16:08 INFO - Downloading/unpacking functools32 (from jsonschema) 13:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:08 INFO - Downloading functools32-3.2.3-2.tar.gz 13:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:16:08 INFO - warning: no files found matching '*.txt' 13:16:08 INFO - no previously-included directories found matching 'build' 13:16:08 INFO - no previously-included directories found matching 'dist' 13:16:08 INFO - no previously-included directories found matching '.git*' 13:16:08 INFO - Installing collected packages: jsonschema, functools32 13:16:08 INFO - Running setup.py install for functools32 13:16:08 INFO - warning: no files found matching '*.txt' 13:16:08 INFO - no previously-included directories found matching 'build' 13:16:08 INFO - no previously-included directories found matching 'dist' 13:16:08 INFO - no previously-included directories found matching '.git*' 13:16:08 INFO - Successfully installed jsonschema functools32 13:16:08 INFO - Cleaning up... 13:16:08 INFO - Return code: 0 13:16:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:16:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:16:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:16:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb7bafef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aee5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', '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 13:16:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:16:08 INFO - Using env: {'DISPLAY': ':0', 13:16:08 INFO - 'HOME': '/home/cltbld', 13:16:08 INFO - 'LANG': 'en_US.UTF-8', 13:16:08 INFO - 'LANGUAGE': 'en_US:en', 13:16:08 INFO - 'LOGNAME': 'cltbld', 13:16:08 INFO - 'MAIL': '/var/mail/cltbld', 13:16:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:08 INFO - 'MOZ_NO_REMOTE': '1', 13:16:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:08 INFO - 'NO_EM_RESTART': '1', 13:16:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:08 INFO - 'PWD': '/builds/slave/test', 13:16:08 INFO - 'SHELL': '/bin/bash', 13:16:08 INFO - 'SHLVL': '1', 13:16:08 INFO - 'TERM': 'linux', 13:16:08 INFO - 'TMOUT': '86400', 13:16:08 INFO - 'USER': 'cltbld', 13:16:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:16:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:08 INFO - '_': '/tools/buildbot/bin/python'} 13:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:16:08 INFO - Downloading/unpacking flake8 13:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:16:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:16:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:16:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:16:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:16:11 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 13:16:11 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 13:16:11 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 13:16:11 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 13:16:11 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 13:16:11 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 13:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:16:11 INFO - no previously-included directories found matching 'docs/_build' 13:16:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:16:11 INFO - Running setup.py install for pep8 13:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:16:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:16:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:16:11 INFO - no previously-included directories found matching 'docs/_build' 13:16:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:16:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:16:11 INFO - Cleaning up... 13:16:11 INFO - Return code: 0 13:16:11 INFO - Running post-action listener: _resource_record_post_action 13:16:11 INFO - Running post-action listener: _start_resource_monitoring 13:16:11 INFO - Starting resource monitoring. 13:16:11 INFO - ##### 13:16:11 INFO - ##### Running install step. 13:16:11 INFO - ##### 13:16:11 INFO - Running pre-action listener: _resource_record_pre_action 13:16:11 INFO - Running main action method: install 13:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:16:11 INFO - Reading from file tmpfile_stdout 13:16:11 INFO - Detecting whether we're running mozinstall >=1.0... 13:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:16:12 INFO - Reading from file tmpfile_stdout 13:16:12 INFO - Output received: 13:16:12 INFO - Usage: mozinstall [options] installer 13:16:12 INFO - Options: 13:16:12 INFO - -h, --help show this help message and exit 13:16:12 INFO - -d DEST, --destination=DEST 13:16:12 INFO - Directory to install application into. [default: 13:16:12 INFO - "/builds/slave/test"] 13:16:12 INFO - --app=APP Application being installed. [default: firefox] 13:16:12 INFO - mkdir: /builds/slave/test/build/application 13:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:16:27 INFO - Reading from file tmpfile_stdout 13:16:27 INFO - Output received: 13:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 13:16:27 INFO - Running post-action listener: _resource_record_post_action 13:16:27 INFO - ##### 13:16:27 INFO - ##### Running run-tests step. 13:16:27 INFO - ##### 13:16:27 INFO - Running pre-action listener: _resource_record_pre_action 13:16:27 INFO - Running main action method: run_tests 13:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:16:27 INFO - Python 2.7.3 13:16:27 INFO - Return code: 0 13:16:27 INFO - grabbing minidump binary from tooltool 13:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:16:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d410>, '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 0x2b7e310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b7e7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:16:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:16:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:16:27 INFO - Return code: 0 13:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:16:28 INFO - Return code: 0 13:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 13:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 13:16:28 INFO - Using env: {'DISPLAY': ':0', 13:16:28 INFO - 'HOME': '/home/cltbld', 13:16:28 INFO - 'LANG': 'en_US.UTF-8', 13:16:28 INFO - 'LANGUAGE': 'en_US:en', 13:16:28 INFO - 'LOGNAME': 'cltbld', 13:16:28 INFO - 'MAIL': '/var/mail/cltbld', 13:16:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:16:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:16:28 INFO - 'MOZ_NO_REMOTE': '1', 13:16:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:16:28 INFO - 'NO_EM_RESTART': '1', 13:16:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:16:28 INFO - 'PWD': '/builds/slave/test', 13:16:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:16:28 INFO - 'SHELL': '/bin/bash', 13:16:28 INFO - 'SHLVL': '1', 13:16:28 INFO - 'TERM': 'linux', 13:16:28 INFO - 'TMOUT': '86400', 13:16:28 INFO - 'USER': 'cltbld', 13:16:28 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949', 13:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:16:28 INFO - '_': '/tools/buildbot/bin/python'} 13:16:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 13:16:29 INFO - mozversion application_buildid: 20160429123137 13:16:29 INFO - mozversion application_changeset: f60f1ab969dae2f69206b9b6affa285b947ec4f6 13:16:29 INFO - mozversion application_display_name: Nightly 13:16:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:16:29 INFO - mozversion application_name: Firefox 13:16:29 INFO - mozversion application_remotingname: firefox 13:16:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:16:29 INFO - mozversion application_vendor: Mozilla 13:16:29 INFO - mozversion application_version: 49.0a1 13:16:29 INFO - mozversion platform_buildid: 20160429123137 13:16:29 INFO - mozversion platform_changeset: f60f1ab969dae2f69206b9b6affa285b947ec4f6 13:16:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:16:29 INFO - mozversion platform_version: 49.0a1 13:16:29 INFO - using testdate: 1461960989 13:16:29 INFO - actual date: 1461960989 13:16:29 INFO - starting webserver on 'localhost:46422' 13:16:29 INFO - SUITE-START | Running 2 tests 13:16:29 INFO - TEST-START | dromaeo_css 13:16:29 INFO - operating with platform_type : linux_ 13:16:29 INFO - Initialising browser for dromaeo_css test... 13:16:29 INFO - TEST-INFO | started process 22300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_7fXnQ/profile http://localhost:46422/getInfo.html) 13:16:33 INFO - PROCESS | 22300 | __metrics Screen width/height:1600/1200 13:16:33 INFO - PROCESS | 22300 | colorDepth:24 13:16:33 INFO - PROCESS | 22300 | Browser inner width/height: 1024/697 13:16:33 INFO - PROCESS | 22300 | __metrics 13:16:34 ERROR - PROCESS | 22300 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:16:35 INFO - TEST-INFO | 22300: exit 0 13:16:35 INFO - Browser initialized. 13:16:35 INFO - Running cycle 1/1 for dromaeo_css test... 13:16:35 INFO - TEST-INFO | started process 22381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_7fXnQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:47 INFO - PROCESS | 22381 | RSS: Main: 156401664 13:16:47 INFO - PROCESS | 22381 | 13:17:38 INFO - PROCESS | 22381 | 1461961058690 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] 13:19:51 INFO - PROCESS | 22381 | Cycle 1(1): loaded http://localhost:46422/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46422/tests/dromaeo/cssquery-ext.html) 13:19:52 INFO - PROCESS | 22381 | RSS: Main: 266657792 13:19:52 INFO - PROCESS | 22381 | 13:22:55 INFO - PROCESS | 22381 | Cycle 1(1): loaded http://localhost:46422/tests/dromaeo/cssquery-ext.html (next: http://localhost:46422/tests/dromaeo/cssquery-jquery.html) 13:22:55 INFO - PROCESS | 22381 | RSS: Main: 234708992 13:22:55 INFO - PROCESS | 22381 | 13:25:58 INFO - PROCESS | 22381 | Cycle 1(1): loaded http://localhost:46422/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46422/tests/dromaeo/cssquery-mootools.html) 13:25:58 INFO - PROCESS | 22381 | RSS: Main: 234586112 13:25:58 INFO - PROCESS | 22381 | 13:29:00 INFO - PROCESS | 22381 | Cycle 1(1): loaded http://localhost:46422/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46422/tests/dromaeo/cssquery-prototype.html) 13:29:01 INFO - PROCESS | 22381 | RSS: Main: 231641088 13:29:01 INFO - PROCESS | 22381 | 13:32:04 INFO - PROCESS | 22381 | Cycle 1(1): loaded http://localhost:46422/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46422/tests/dromaeo/cssquery-yui.html) 13:32:05 INFO - PROCESS | 22381 | RSS: Main: 214237184 13:32:05 INFO - PROCESS | 22381 | 13:35:07 INFO - PROCESS | 22381 | Cycle 1(1): loaded http://localhost:46422/tests/dromaeo/cssquery-yui.html (next: http://localhost:46422/tests/dromaeo/cssquery-dojo.html) 13:35:08 INFO - PROCESS | 22381 | RSS: Main: 268906496 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | __start_tp_report 13:35:08 INFO - PROCESS | 22381 | _x_x_mozilla_page_load 13:35:08 INFO - PROCESS | 22381 | _x_x_mozilla_page_load_details 13:35:08 INFO - PROCESS | 22381 | |i|pagename|runs| 13:35:08 INFO - PROCESS | 22381 | |0;dojo.html;2571.3443072016635;2642.603609458582;2643.2598872315757;2653.5754279315315;2677.598360245963;4498.865034048984;4573.268277075668;4574.03945171514;4591.540845915407;4594.218982772933;4565.2010898092785;4607.378003969463;4659.068186362732;4668.85993420198;4676.97661511692;4189.099343641116;4234.555371685982;4241.066965267636;4298.677599180059;4417.823287068513;4315.654747620199;4346.6522678185665;4380.605745482906;4390.936259957814;4407.625351845097;4133.1940271647045;4212.957870421287;4215.747055176699;4243.724157929724;4321.416608757841;4199.748015119103;4248.596383343577;4249.787510624456;4297.39836422901;4317.4819021717285;4185.079282557833;4196.181744559812;4207.326827707552;4217;4238.872833814959;4333.2200203963275;4476.171908196994;4496.505384407713;4511.954880451219;4603.286490593963;4937.5556199942175;4952.034353301072;4955.82654607087;4960.975195124038;4992.975035124838;4945.332380128672;4968.925466118011;4972.378452693413;4981.476944920767;5000.149974504343;4471.038726673781;4532.818687252473;4627.444706635191;4677.22825733757;4677.812887484462;5009.974950125299;5029.321041659402;5032.270320803463;5034.043531728959;5035.496450354935;4771.856844294677;4784.4497882743235;4813.253945638432;4813.518648135228;4856.562909338177;4771.355866957986;4928.802847886116;4991.700497970133;5013.348264725562;5027.622928280393;4831.73425461603;4843.055604157226;4851.203620538186;4854.053459575349;4905.264210368402;4637.072585482917;4830.8309209178215;4833.275008748646;4836.371271734652;4887.875788568578;4147.419361289422;4174.749515029108;4242.363645453145;4243.830246790156;4246.214450326699;3629.0745859806107;3634.1823089804584;3637.363461394298;3654.744167908221;3680.4847321375028;4219.578042195817;4221.197972385237;4223.788810559521;4226.17589570037;4262.998195424073;4765.475797662254;4867.3915760529935;4894.437139728977;4920.21276595743;4949.059678661115;4215.388768628593;4239.9788001060415;4252.213340532012;4252.978735106367;4254;4333.674974376871;4449.976505403775;4456.487503937024;4489.7979590918485;4497.9325310120375;4623.42207224097;4667.159911216014;4667.183242932405;4710.7880145392855;4731.313959475926;4907.97546012282;4908.165611845923;4909.95090049095;4912.263160525807;4919.532644398776;4495.2358099122575;4640;4645.094206629675;4665.440147182359;4681.836135735233;4848.17581011236;4867.1969125095375;4893.266010098371;4913.508649135058;4913.828016019422;4937.333459983;4940;4942.703437793743;4955.033768415268;4986.9251961221335;4584.9312260315455;4738.170820106537;4774.283857421415;4809.591184749195;4862.586680132087;4788.545088216753;4807.230843065093;4809.278608208657;4823.903521929472;4859.07677541266;4687.67186296956;4710.081534100817;4710.670253082251;4733.857984260478;4770.141374552614;4680.836170734008;4732.171869922819;4801.303810947463;4823.059503396804;4840.34655321527;4705;4724.71651700899;4742.810287588596;4748.596369308648;4781.808727650855 13:35:08 INFO - PROCESS | 22381 | |1;ext.html;573.8163787587973;595.7736060297087;608.9421504957028;619.5353484886336;625.9968700156498;26761.4647707046;33604.66395336046;33684.15789605261;34555.136121596974;34865.82567087161;40673.79663101688;41153.58846411535;41203.38194927071;41226.58773412265;41238;7322.890156647654;7731.690732370713;7958.721444749435;7960.840783184332;7964.323032542241;9422.670206542773;9696.854547181798;9703.708888733348;9707.223422126248;9709.563069661883;9798.265130115235;9987;9987.101160895518;9994.9500252499;9999.700008999742;9822.066903644178;9966.950165249164;9973.35173213746;9975.102240798291;9979.30144889858;9703.854442183372;9828.754281142958;9831;10155.238357123246;10162.796744065152;37365.62634373648;37915.62084379148;37957.81021094904;37980.810095949346;38035.61964380376;3168.714815666601;3186.4583020886503;3192.6488086310487;3192.9361412771614;3199.04028791364;29486.41027179466;29746.40507189844;29901.401971960655;30026.69973300261;30374.392512149854;3187.7609179311644;3200.9679903200904;3216.710496055343;3225.1292151119064;3296.901092967215;184825;186772;187078;187195;188240;47028.5297147031;47485;47531.5246847534;47594;47662;54721.72639136779;54932;54939.45060549423;54962.45037549653;54966.17550736742;13399.866001340057;13934;14014;14040.508582199778;14041.1575305482;9394.95302523483;9658.32391732586;9659.420434773936;9669.129778319984;10703.411312377739;14564.344604492824;14756.704865902837;15030.774538381933;15030.774538381933;15036.398544058115;5990.460858522754;6062.363451837582;6067.362926892701;6124.35694252106;6154.169187159766;896.4442045931564;938.5166639180827;986.2011770465803;1023.5752162852482;1068.0387651113904;28212.43575128486;28404.43191136166;29003.41993160125;29071.41857162845;29144.27139321534;1010.2322235101229;1033.01347213411;1039.7868436970402;1060.8090543702053;1078.7734575739025;14483.203423811581;14981.475648352256;15271.301980222583;15352.539423817303;15378.980607992522;336338;340141;342784;342946;343078;48243;48542.5145748538;48606.27090593644;48662.27006594904;48811;1117.4468638024068;1224.0513601958376;1246.9636435280122;1254.5358217459598;1256.8931640810633;24488.75511244865;25731.3567160815;27274.318142046606;28050.438991220468;28585.571216432185;38283.23433531258;38912.80543597264;39072.41391379075;39099.218015640094;39119.41320880132;232652;239259;239340;239357;239912;27344.589831152152;30768.538471922493;31712;32497.675023249463;32516.512252315762;35112;35854.82072589621;35955.101122472144;36119.27761444704;36459.27081458409;29230.56154157647;30933;31204.21989450191;31540;31999.200019999687;31334.843325783226;31436;31605.84197079;33773.49339759856;34775.826120869235;31072.22319442032;31147.84426077855;32866.67133328636;34608.134796630286;34865.651343487254;30751.220484208072;31231.531527027568;31507;31832.840835795672;31901.20246993751;24563.87718061398;24608;24754.752452475244;25001.624975625018;25053 13:35:08 INFO - PROCESS | 22381 | |2;jquery.html;379.7911148868123;384.2066133434458;386.79886459041296;397.21351723587316;397.28290435763455;15806.920965395171;16737.83262167378;16862.494125176265;17169.055701936402;17219;15686.372545098211;16361.918190409031;16739.16304184789;17325.393611223608;17338.56653583658;4713.245880659087;4847.684900481475;4888.193448081062;4892.9755351223375;4895.779689913945;3478.1652403423122;5352.116900711398;5652.830415087554;5658.603897727161;5663.348714897777;5582;5593.636413633121;5643.181738647893;5648.491635752782;5653.604247702662;5547.750351234205;5715.514181294595;5724.427557244242;5767.394423585505;5767.45209205127;3406.2846802171575;3542.6988705960025;3583.283343331318;3585.175409655768;5104.515071068243;12045.93977030118;12085.818712719229;12293.754124917541;12294.446749896186;12369.567065152767;1879.4737473507303;1899.2877670873422;1902.6004539046817;1976.7529058867642;1998.760148782141;8934.776630584221;9284.396514226553;9546.522673866279;9618.951905240428;9791.167750741195;1743.3375317379441;1763.074385947375;1770.4600096970419;1849.5745978425039;1886.8018858019848;66221.66889165572;72135;72572.63713681398;72631.63684181598;73267;10054.59781608742;10061;10191.7452063699;10309.48452577383;10319.742006449898;14309.64225894361;14389.856101439062;14471.92764036194;14487.058341207789;14512.927435362755;7089.7873063808165;7140.92859071413;7159.57042577447;7282.854342913218;7294.708211671474;6613.834654133589;6639.933600664028;6653.4677225821815;6786.287439818847;6787.355201255873;4447.866564003085;4504.684672072924;4505.954940450619;4511.120331535319;4579.91613815713;1661.9916900415662;1719.131838421614;1788.50816025594;1893.7822150452873;1909.6562618728485;868.3660927522943;904.1771987491351;945.6737425588161;967.7580604848788;980.9993806317659;16164.43424480161;16482.42311519091;17043.784308039874;17055.658886822443;17504.387346442814;892.9151730585584;926.064674678566;934.7055677461578;960.6637676813059;987.8073775613686;9386.577604007836;9490.145886870216;9630.181434578139;9638.469884156299;9673.226141908772;362952;363611;363816;365031;403752;77876;79802.20197797948;82028;82239.5888020556;82567;958.0515289863125;960.078324808192;974.1768205866032;977.9217662586976;978.2760757039881;14886.404543818126;14892.702145957237;15082.321295541946;15199.848001519844;15344;33450.31695562672;34140;34367.656323436444;35409.468857967666;35983;45757.31364029609;48420.03159936852;50300.24549631685;50328.74835625799;50912.49087509078;7539.698412063456;7638.350740186924;7648.694052238071;7750.379969602531;7798.766037018899;7741.806454838674;10072;10596.947015264874;11109.333439993627;11502.367369794407;8908.955455222682;9173.908260917306;9469.526523673927;9518.714438566854;9745.463999480096;9112.635494580143;9452.669156579486;9517.333786634868;10259.640912568024;10288.074073333435;9692.127708506268;9767.218622510325;9861.408315501092;9913.950430247802;10001.99064397321;7529.60286842021;7630.580318082559;7728.8454230916195;7774.572398517909;7856.607169641381;9405.341626086381;9907.752306192402;9975;10101.5454304555;10167.84748228792 13:35:08 INFO - PROCESS | 22381 | |3;mootools.html;1279.4050766393625;1465.7361674898514;1494.1184701026395;1606.5100144455944;1787.3654852527345;6615.801525954217;7562.735304264345;7769.728059517918;7821.921780782191;7825.804354891124;7553.942448057276;7570.0915890093265;7661.502002369842;7674.769756907288;7683.193264707195;1851.2502436513234;2138.134055707441;2193.2981445937307;2227.0757635581213;2227.3206671965045;2209.8232141428725;2232.966505502419;2234.162189179058;2239.193890199527;2240.383894429037;2167.8374121940838;2179.8038176564105;2194.58302922445;2206.889655517226;2213.4245096275004;1816.9000704961288;2095.8532902696816;2172.2940044485604;2176.379731776452;2176.4450065233264;2132.648113061343;2148.7099241602496;2151.3008272311404;2154.4613846538364;2155.7089792878073;7475.738349157753;7542.472026958115;7543.811404714871;7550.848983020309;7551.358134558569;4358.847440339573;4499.730016199039;4514.503404625489;4516.458025036984;4529.433820772403;2722.823016503921;2888.8411137387434;2904.7821413393867;2915.4752144613963;2918.0953904289527;1667.7831881855282;1718.8109307976238;1731.2728653965364;1734.9219285132074;1765.5497848048794;10138.594456221743;10225.028622280872;10244.02681745233;10266.589336426608;10271.178305735599;4069.654079403284;4218.767967761742;4234.153169366139;4244.8514301999285;4272.060146767706;8515.914840851512;8569.914300857037;8593.570321483901;8593.828123437495;8597.18326758957;4620.653450991189;4646;4655.790489427916;4662.860114196579;4668.4631267404;3646.361886669822;4081.9795901020307;4205.137946720976;4237.576242375738;4255.255330317244;3308.123347312964;3367.2423704666253;3405.659434056624;3432.1934345429304;3452.879149229815;1004.3321191407632;1020.2093377632394;1021.5096753558333;1037.2946396450486;1040.6409788622914;720.2689270390558;778.4473024152802;824.995875020621;854.747849384433;865.0700496965787;4965.503449655078;4988.451270360258;5018.272350509229;5136.845894623168;5153;417.3385184482568;417.7660510114285;421.7090207756638;430.0753380232463;431.04738527853794;3469.8091604961464;3484.9128771780906;3491.5810102787827;3538.2039041216035;3538.2215912499723;8908.10918908104;9203.861942070875;9316.114969077928;9323;9378.249740020781;9090.181883630372;9111.589978450986;9191.08089191089;9289.396189247676;9305.674301399418;6832.214295355998;6840.452763778886;6854.34883686049;6895.5173137879865;6915.550489218285;4796.664233503621;4866.90266194667;4925.975370123127;4961.652684312064;5011.949880501148;8582.442141260799;8587.22714955632;8641.222289993932;8713.956430217808;8743.256823169848;8547.658093676431;8599.484030958163;8622;8772.035076141492;8872.955635221782;5530.198121272312;5665.291838520185;6131.96934015345;6196.907046394217;6231.563790534619;7366.079240094989;7470.103587569526;7476.401887849068;7500.774976750707;7510.511816731895;6615.37153970372;6757.087793148059;6837.453003759787;6872.793816185523;6919.619420931897;6707;6739.427148692416;6746.730130794714;6785.253622101466;6799.490038247251;6197.783077592263;6261.060840873905;6265.561410701207;6266.592671476339;6277.2153480814895;4503.121891231179;4505.031418245093;4533.977330113328;4555.088982203639;4593.793279302507;4530.411046563926;4562.703424277412;4662.230731929194;4685.250359942529;4738.194506933761 13:35:08 INFO - PROCESS | 22381 | |4;prototype.html;290.649767030728;303.76002957663445;308.76842368223834;313.54066292880924;314.60831265074984;4567.451905771304;4694.718316900989;4786.186348320785;4832.646858879511;4864.4162700475945;4597.747123908192;4768.78540465679;4774.570288674018;4782.641301902362;4784.641151913612;3799.487069245658;3805.344675066348;3824.2160357126863;3826;3841.865534706286;3626.8186590670493;3645.7994810285422;3787.431885217212;3795.8481660733537;3838.5201849768778;3783.089539782406;3784.883459379476;3797.2215695782297;3830.444585535096;3833.15670552478;3776.055986003499;3779.5842457329672;3793.620637936212;3805.162864169878;3821.7515861468914;3411.096059544223;3414.6243913169533;3415.64135765746;3418.077119177833;3426.4517677171534;4453.599176074169;4526.79629416677;4534.251848445003;4544.772761361919;4567.223571992736;4281.614654681093;4291.141771645684;4302.698811083225;4310.849120280806;4315.784210789448;4920.040592084545;4922.901541969176;4970.055689418999;4973.52751488608;4990.126727822653;3394.7114495267933;3568.3398571264397;3605.801680907549;3653.707703383723;3674.6876515496215;5168.302279192299;5186.688798672092;5186.818461353834;5213.635045546814;5256.237845512379;3655.817209139532;3669.522962014921;3696.057505336122;3698.3158115748674;3698.4452332149854;3714.405695088773;3739.383001804726;3743.1016556026357;3749.3813520769313;3754.737168398186;4091.8747344480507;4312.719673221231;4322.200392927319;4340.631046361032;4344.6089851913475;4964.652474326835;4988.925166122511;5014.323066386064;5017.473165317662;5022.648414610942;1330.1752913193882;1358.8505264420905;1391.0610338021795;1413.3922413362147;1417.078898715843;963.4508330251689;966.7824739433571;978.1001478639669;979.647326962293;988.8862780780303;4633.930491042637;4636.211843986531;4636.930446043312;4637.1421287062;4640.69835460694;5424.907802552507;5428.4028756836715;5434.375046869582;5445.611369100854;5449.509544141047;4192.266353388206;4599.67802253839;4631.560001799824;4637;4637.907241855211;2932.4428358611794;2943.514320137196;2960.363521842814;2966.8516574171636;2976.851157442119;5228.581713462914;5237.73811309433;5243.790248390098;5254.92117618236;5270.183121616155;5483.314585676791;5643.701948551856;5662.716864156858;5698.715064246771;5706.885862282731;5185.714785686748;5187.118189907725;5194;5220.190870415092;5227.973860130675;5538.91691624634;5555.58332625178;5568.610197286151;5569.415211402745;5579.944200558105;5304.117038451294;5389.83830485086;5390.757415916371;5423.891522169455;5425.593080518898;5167.276581278549;5175.689458632494;5189.6107791915;5198.636095473432;5222.843314700565;3796.8101594920695;3826.6173382662623;3836.731428799957;3860.4981352424006;3870.5291989043985;4850.684705494132;5406.540444062299;5436.266104076058;5498.092814685532;5524.64646161693;4808.663393562417;4945.975270123627;4969.3291405659775;4974.040445934663;4980.925286120783;4916.115099282163;4947.628927830355;4950.554450099365;4991.6006719463085;4993.550580447632;4669.556392142741;4900.607951363811;4911.287863259879;4923.193779545624;4931.48219436954;5012.398512178562;5051.696898186121;5077.796888124433;5077.847664570068;5088.643794934319;4924.4090709115135;4925;4944.159492886146;4950.232713929347;4955.702657840541 13:35:08 INFO - PROCESS | 22381 | |5;yui.html;613.7207570555396;706.2866504830117;710.2187593646987;711.0827033127266;717.7487879242262;11257.774844503116;12098.81851772224;12354.073444491654;12366.629001129959;12374.876251237485;11229.270097443661;11266.493007814648;11304.321740695543;11313.604023859167;11324.60363887264;631.9273283572379;780.6721177105629;800.2437696376911;814.7392834293029;815.8572249856281;810.7405630198309;814.3200427642926;814.3932770086294;814.5194335342177;816.8202995341015;846;847.9109693482188;848.2704873808519;849.2526576612572;849.7493239494333;659.5679829711546;809.7408829174666;838.6561509780961;840.2479780596393;845.6406027438345;615.5875563372551;616.8550390658191;617.0897925559808;618.1932577985726;620.2247191011236;11897.464614092387;11956.70108247292;11982.101342399268;11988;12010.159288849783;11614.245074070159;11803.527858885634;11891.167618266725;11991.280523168638;12203.938980305042;9821.90178098217;9908;9981.70054898347;10137.39175649456;10181.643642472478;3254.2189874430205;3259.6414394416597;3259.706626403611;3300.471924492094;3318.386098571772;41647.167056659004;42186.57813421857;42286.788566056974;42404;43051.569484305066;9197.264218862474;9390.71827845152;9452.810943781085;9672.22622190223;9727.027297270359;16148.919255403647;16219.594510137342;16242.269097890623;16267.51197464078;16382.344706211856;6507.9023814642815;6894.517383783087;6929.237783843773;7013.228544860061;7165.928340716526;3702.3520883845217;3728.4034554471696;3781.4138808484727;3794.658480736747;3928.4107383892647;2838.914832555027;2900.8114472559214;2910.6652734935756;2912.8689208985647;2914.12576227131;496.63497329462814;504.66944151580776;518.1631664861297;524.8819015721432;532.430299579454;585.3502612100565;602.135934933372;617.8023032629516;636.7834936121649;638.5721566550329;7753.573553454501;7852.332551733167;7963.323117535075;8088.002218876265;8168.918310816815;575.5710900001985;590.8712376571401;596.2695697770197;596.5645079092287;602.7498588085896;3739.7943113128495;3847.961520384816;3920.6471417572557;3946.506686664167;3965.980170099189;51083.74458127686;55480.16779748307;56612.716936415054;56660.86678266412;57221.71389143111;46420;47824;48078.519214807406;48256;49019;41813.37279940803;42755.786221068694;43107.56892431098;43475.56524434778;44188.337174942404;8086.757397278091;8194.180581941997;8215.753527394188;8392.20274073962;8433.409661323649;27720.703290989928;28737.42525149527;29329.560056599596;29368.412631747673;30258.84870575633;35683.46474802932;35926.101847454025;37657.4351384724;37680.623193767715;38471.03822404462;9880.35777674449;10394.064534191959;10436.947815260875;10550.736231594272;10742.3017503862;11648.767024659628;11809.645710628694;11954.521819127485;11962.880371196177;12220.388980550759;10660.733481663021;10757.731056723644;10825.404602746925;10835.404052777172;11170.609028683957;11084.334939903632;11150.219484635998;11590.420478976186;11599.76800463969;11649.068074554185;10758.569657213937;10814.56741730322;10907;11219.66341009771;11478.770424591628;9421.528923553931;9518.428894266366;9532.714018579454;9743.512824358895;9908.504574771088;9020;9289.767755806159;9293;9365.953170234105;9398.154166125081 13:35:08 INFO - PROCESS | 22381 | __end_tp_report 13:35:08 INFO - PROCESS | 22381 | __start_cc_report 13:35:08 INFO - PROCESS | 22381 | _x_x_mozilla_cycle_collect,1090 13:35:08 INFO - PROCESS | 22381 | __end_cc_report 13:35:08 INFO - PROCESS | 22381 | __startTimestamp1461962108182__endTimestamp 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | ------- Summary: start ------- 13:35:08 INFO - PROCESS | 22381 | Number of tests: 6 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | [#0] dojo.html Cycles:165 Average:4550.43 Median:4677.23 stddev:462.93 (9.9%) stddev-sans-first:437.54 13:35:08 INFO - PROCESS | 22381 | Values: 2571.3 2642.6 2643.3 2653.6 2677.6 4498.9 4573.3 4574.0 4591.5 4594.2 4565.2 4607.4 4659.1 4668.9 4677.0 4189.1 4234.6 4241.1 4298.7 4417.8 4315.7 4346.7 4380.6 4390.9 4407.6 4133.2 4213.0 4215.7 4243.7 4321.4 4199.7 4248.6 4249.8 4297.4 4317.5 4185.1 4196.2 4207.3 4217.0 4238.9 4333.2 4476.2 4496.5 4512.0 4603.3 4937.6 4952.0 4955.8 4961.0 4993.0 4945.3 4968.9 4972.4 4981.5 5000.1 4471.0 4532.8 4627.4 4677.2 4677.8 5010.0 5029.3 5032.3 5034.0 5035.5 4771.9 4784.4 4813.3 4813.5 4856.6 4771.4 4928.8 4991.7 5013.3 5027.6 4831.7 4843.1 4851.2 4854.1 4905.3 4637.1 4830.8 4833.3 4836.4 4887.9 4147.4 4174.7 4242.4 4243.8 4246.2 3629.1 3634.2 3637.4 3654.7 3680.5 4219.6 4221.2 4223.8 4226.2 4263.0 4765.5 4867.4 4894.4 4920.2 4949.1 4215.4 4240.0 4252.2 4253.0 4254.0 4333.7 4450.0 4456.5 4489.8 4497.9 4623.4 4667.2 4667.2 4710.8 4731.3 4908.0 4908.2 4910.0 4912.3 4919.5 4495.2 4640.0 4645.1 4665.4 4681.8 4848.2 4867.2 4893.3 4913.5 4913.8 4937.3 4940.0 4942.7 4955.0 4986.9 4584.9 4738.2 4774.3 4809.6 4862.6 4788.5 4807.2 4809.3 4823.9 4859.1 4687.7 4710.1 4710.7 4733.9 4770.1 4680.8 4732.2 4801.3 4823.1 4840.3 4705.0 4724.7 4742.8 4748.6 4781.8 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | [#1] ext.html Cycles:180 Average:41384.58 Median:18081.79 stddev:68965.91 (381.4%) stddev-sans-first:69091.30 13:35:08 INFO - PROCESS | 22381 | Values: 573.8 595.8 608.9 619.5 626.0 26761.5 33604.7 33684.2 34555.1 34865.8 40673.8 41153.6 41203.4 41226.6 41238.0 7322.9 7731.7 7958.7 7960.8 7964.3 9422.7 9696.9 9703.7 9707.2 9709.6 9798.3 9987.0 9987.1 9995.0 9999.7 9822.1 9967.0 9973.4 9975.1 9979.3 9703.9 9828.8 9831.0 10155.2 10162.8 37365.6 37915.6 37957.8 37980.8 38035.6 3168.7 3186.5 3192.6 3192.9 3199.0 29486.4 29746.4 29901.4 30026.7 30374.4 3187.8 3201.0 3216.7 3225.1 3296.9 184825.0 186772.0 187078.0 187195.0 188240.0 47028.5 47485.0 47531.5 47594.0 47662.0 54721.7 54932.0 54939.5 54962.5 54966.2 13399.9 13934.0 14014.0 14040.5 14041.2 9395.0 9658.3 9659.4 9669.1 10703.4 14564.3 14756.7 15030.8 15030.8 15036.4 5990.5 6062.4 6067.4 6124.4 6154.2 896.4 938.5 986.2 1023.6 1068.0 28212.4 28404.4 29003.4 29071.4 29144.3 1010.2 1033.0 1039.8 1060.8 1078.8 14483.2 14981.5 15271.3 15352.5 15379.0 336338.0 340141.0 342784.0 342946.0 343078.0 48243.0 48542.5 48606.3 48662.3 48811.0 1117.4 1224.1 1247.0 1254.5 1256.9 24488.8 25731.4 27274.3 28050.4 28585.6 38283.2 38912.8 39072.4 39099.2 39119.4 232652.0 239259.0 239340.0 239357.0 239912.0 27344.6 30768.5 31712.0 32497.7 32516.5 35112.0 35854.8 35955.1 36119.3 36459.3 29230.6 30933.0 31204.2 31540.0 31999.2 31334.8 31436.0 31605.8 33773.5 34775.8 31072.2 31147.8 32866.7 34608.1 34865.7 30751.2 31231.5 31507.0 31832.8 31901.2 24563.9 24608.0 24754.8 25001.6 25053.0 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | [#2] jquery.html Cycles:180 Average:23497.44 Median:27598.01 stddev:61744.56 (223.7%) stddev-sans-first:61893.37 13:35:08 INFO - PROCESS | 22381 | Values: 379.8 384.2 386.8 397.2 397.3 15806.9 16737.8 16862.5 17169.1 17219.0 15686.4 16361.9 16739.2 17325.4 17338.6 4713.2 4847.7 4888.2 4893.0 4895.8 3478.2 5352.1 5652.8 5658.6 5663.3 5582.0 5593.6 5643.2 5648.5 5653.6 5547.8 5715.5 5724.4 5767.4 5767.5 3406.3 3542.7 3583.3 3585.2 5104.5 12045.9 12085.8 12293.8 12294.4 12369.6 1879.5 1899.3 1902.6 1976.8 1998.8 8934.8 9284.4 9546.5 9619.0 9791.2 1743.3 1763.1 1770.5 1849.6 1886.8 66221.7 72135.0 72572.6 72631.6 73267.0 10054.6 10061.0 10191.7 10309.5 10319.7 14309.6 14389.9 14471.9 14487.1 14512.9 7089.8 7140.9 7159.6 7282.9 7294.7 6613.8 6639.9 6653.5 6786.3 6787.4 4447.9 4504.7 4506.0 4511.1 4579.9 1662.0 1719.1 1788.5 1893.8 1909.7 868.4 904.2 945.7 967.8 981.0 16164.4 16482.4 17043.8 17055.7 17504.4 892.9 926.1 934.7 960.7 987.8 9386.6 9490.1 9630.2 9638.5 9673.2 362952.0 363611.0 363816.0 365031.0 403752.0 77876.0 79802.2 82028.0 82239.6 82567.0 958.1 960.1 974.2 977.9 978.3 14886.4 14892.7 15082.3 15199.8 15344.0 33450.3 34140.0 34367.7 35409.5 35983.0 45757.3 48420.0 50300.2 50328.7 50912.5 7539.7 7638.4 7648.7 7750.4 7798.8 7741.8 10072.0 10596.9 11109.3 11502.4 8909.0 9173.9 9469.5 9518.7 9745.5 9112.6 9452.7 9517.3 10259.6 10288.1 9692.1 9767.2 9861.4 9914.0 10002.0 7529.6 7630.6 7728.8 7774.6 7856.6 9405.3 9907.8 9975.0 10101.5 10167.8 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | [#3] mootools.html Cycles:180 Average:4999.06 Median:4662.55 stddev:2747.11 (58.9%) stddev-sans-first:2740.60 13:35:08 INFO - PROCESS | 22381 | Values: 1279.4 1465.7 1494.1 1606.5 1787.4 6615.8 7562.7 7769.7 7821.9 7825.8 7553.9 7570.1 7661.5 7674.8 7683.2 1851.3 2138.1 2193.3 2227.1 2227.3 2209.8 2233.0 2234.2 2239.2 2240.4 2167.8 2179.8 2194.6 2206.9 2213.4 1816.9 2095.9 2172.3 2176.4 2176.4 2132.6 2148.7 2151.3 2154.5 2155.7 7475.7 7542.5 7543.8 7550.8 7551.4 4358.8 4499.7 4514.5 4516.5 4529.4 2722.8 2888.8 2904.8 2915.5 2918.1 1667.8 1718.8 1731.3 1734.9 1765.5 10138.6 10225.0 10244.0 10266.6 10271.2 4069.7 4218.8 4234.2 4244.9 4272.1 8515.9 8569.9 8593.6 8593.8 8597.2 4620.7 4646.0 4655.8 4662.9 4668.5 3646.4 4082.0 4205.1 4237.6 4255.3 3308.1 3367.2 3405.7 3432.2 3452.9 1004.3 1020.2 1021.5 1037.3 1040.6 720.3 778.4 825.0 854.7 865.1 4965.5 4988.5 5018.3 5136.8 5153.0 417.3 417.8 421.7 430.1 431.0 3469.8 3484.9 3491.6 3538.2 3538.2 8908.1 9203.9 9316.1 9323.0 9378.2 9090.2 9111.6 9191.1 9289.4 9305.7 6832.2 6840.5 6854.3 6895.5 6915.6 4796.7 4866.9 4926.0 4961.7 5011.9 8582.4 8587.2 8641.2 8714.0 8743.3 8547.7 8599.5 8622.0 8772.0 8873.0 5530.2 5665.3 6132.0 6196.9 6231.6 7366.1 7470.1 7476.4 7500.8 7510.5 6615.4 6757.1 6837.5 6872.8 6919.6 6707.0 6739.4 6746.7 6785.3 6799.5 6197.8 6261.1 6265.6 6266.6 6277.2 4503.1 4505.0 4534.0 4555.1 4593.8 4530.4 4562.7 4662.2 4685.3 4738.2 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | [#4] prototype.html Cycles:180 Average:4270.73 Median:4778.61 stddev:1235.78 (25.9%) stddev-sans-first:1202.59 13:35:08 INFO - PROCESS | 22381 | Values: 290.6 303.8 308.8 313.5 314.6 4567.5 4694.7 4786.2 4832.6 4864.4 4597.7 4768.8 4774.6 4782.6 4784.6 3799.5 3805.3 3824.2 3826.0 3841.9 3626.8 3645.8 3787.4 3795.8 3838.5 3783.1 3784.9 3797.2 3830.4 3833.2 3776.1 3779.6 3793.6 3805.2 3821.8 3411.1 3414.6 3415.6 3418.1 3426.5 4453.6 4526.8 4534.3 4544.8 4567.2 4281.6 4291.1 4302.7 4310.8 4315.8 4920.0 4922.9 4970.1 4973.5 4990.1 3394.7 3568.3 3605.8 3653.7 3674.7 5168.3 5186.7 5186.8 5213.6 5256.2 3655.8 3669.5 3696.1 3698.3 3698.4 3714.4 3739.4 3743.1 3749.4 3754.7 4091.9 4312.7 4322.2 4340.6 4344.6 4964.7 4988.9 5014.3 5017.5 5022.6 1330.2 1358.9 1391.1 1413.4 1417.1 963.5 966.8 978.1 979.6 988.9 4633.9 4636.2 4636.9 4637.1 4640.7 5424.9 5428.4 5434.4 5445.6 5449.5 4192.3 4599.7 4631.6 4637.0 4637.9 2932.4 2943.5 2960.4 2966.9 2976.9 5228.6 5237.7 5243.8 5254.9 5270.2 5483.3 5643.7 5662.7 5698.7 5706.9 5185.7 5187.1 5194.0 5220.2 5228.0 5538.9 5555.6 5568.6 5569.4 5579.9 5304.1 5389.8 5390.8 5423.9 5425.6 5167.3 5175.7 5189.6 5198.6 5222.8 3796.8 3826.6 3836.7 3860.5 3870.5 4850.7 5406.5 5436.3 5498.1 5524.6 4808.7 4946.0 4969.3 4974.0 4980.9 4916.1 4947.6 4950.6 4991.6 4993.6 4669.6 4900.6 4911.3 4923.2 4931.5 5012.4 5051.7 5077.8 5077.8 5088.6 4924.4 4925.0 4944.2 4950.2 4955.7 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - PROCESS | 22381 | [#5] yui.html Cycles:180 Average:12656.46 Median:45304.17 stddev:14492.81 (32.0%) stddev-sans-first:14505.25 13:35:08 INFO - PROCESS | 22381 | Values: 613.7 706.3 710.2 711.1 717.7 11257.8 12098.8 12354.1 12366.6 12374.9 11229.3 11266.5 11304.3 11313.6 11324.6 631.9 780.7 800.2 814.7 815.9 810.7 814.3 814.4 814.5 816.8 846.0 847.9 848.3 849.3 849.7 659.6 809.7 838.7 840.2 845.6 615.6 616.9 617.1 618.2 620.2 11897.5 11956.7 11982.1 11988.0 12010.2 11614.2 11803.5 11891.2 11991.3 12203.9 9821.9 9908.0 9981.7 10137.4 10181.6 3254.2 3259.6 3259.7 3300.5 3318.4 41647.2 42186.6 42286.8 42404.0 43051.6 9197.3 9390.7 9452.8 9672.2 9727.0 16148.9 16219.6 16242.3 16267.5 16382.3 6507.9 6894.5 6929.2 7013.2 7165.9 3702.4 3728.4 3781.4 3794.7 3928.4 2838.9 2900.8 2910.7 2912.9 2914.1 496.6 504.7 518.2 524.9 532.4 585.4 602.1 617.8 636.8 638.6 7753.6 7852.3 7963.3 8088.0 8168.9 575.6 590.9 596.3 596.6 602.7 3739.8 3848.0 3920.6 3946.5 3966.0 51083.7 55480.2 56612.7 56660.9 57221.7 46420.0 47824.0 48078.5 48256.0 49019.0 41813.4 42755.8 43107.6 43475.6 44188.3 8086.8 8194.2 8215.8 8392.2 8433.4 27720.7 28737.4 29329.6 29368.4 30258.8 35683.5 35926.1 37657.4 37680.6 38471.0 9880.4 10394.1 10436.9 10550.7 10742.3 11648.8 11809.6 11954.5 11962.9 12220.4 10660.7 10757.7 10825.4 10835.4 11170.6 11084.3 11150.2 11590.4 11599.8 11649.1 10758.6 10814.6 10907.0 11219.7 11478.8 9421.5 9518.4 9532.7 9743.5 9908.5 9020.0 9289.8 9293.0 9366.0 9398.2 13:35:08 INFO - PROCESS | 22381 | -------- Summary: end -------- 13:35:08 INFO - PROCESS | 22381 | 13:35:08 INFO - TEST-INFO | 22381: exit 0 13:35:08 INFO - TEST-OK | dromaeo_css | took 1119916ms 13:35:08 INFO - TEST-START | kraken 13:35:08 INFO - operating with platform_type : linux_ 13:35:08 INFO - Initialising browser for kraken test... 13:35:08 INFO - TEST-INFO | started process 22562 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphymh4p/profile http://localhost:46422/getInfo.html) 13:35:13 INFO - PROCESS | 22562 | __metrics Screen width/height:1600/1200 13:35:13 INFO - PROCESS | 22562 | colorDepth:24 13:35:13 INFO - PROCESS | 22562 | Browser inner width/height: 1024/697 13:35:13 INFO - PROCESS | 22562 | __metrics 13:35:14 ERROR - PROCESS | 22562 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:35:15 INFO - TEST-INFO | 22562: exit 0 13:35:15 INFO - Browser initialized. 13:35:15 INFO - Running cycle 1/1 for kraken test... 13:35:15 INFO - TEST-INFO | started process 22642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphymh4p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:35:27 INFO - PROCESS | 22642 | RSS: Main: 156844032 13:35:27 INFO - PROCESS | 22642 | 13:35:29 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46422/tests/kraken/driver.html?testName=audio-beat-detection) 13:35:30 INFO - PROCESS | 22642 | RSS: Main: 211369984 13:35:30 INFO - PROCESS | 22642 | 13:35:33 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46422/tests/kraken/driver.html?testName=audio-dft) 13:35:34 INFO - PROCESS | 22642 | RSS: Main: 196984832 13:35:34 INFO - PROCESS | 22642 | 13:35:37 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46422/tests/kraken/driver.html?testName=audio-fft) 13:35:37 INFO - PROCESS | 22642 | RSS: Main: 267997184 13:35:37 INFO - PROCESS | 22642 | 13:35:39 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46422/tests/kraken/driver.html?testName=audio-oscillator) 13:35:40 INFO - PROCESS | 22642 | RSS: Main: 175685632 13:35:40 INFO - PROCESS | 22642 | 13:35:42 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46422/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:35:43 INFO - PROCESS | 22642 | RSS: Main: 179634176 13:35:43 INFO - PROCESS | 22642 | 13:35:46 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46422/tests/kraken/driver.html?testName=imaging-darkroom) 13:35:47 INFO - PROCESS | 22642 | RSS: Main: 216100864 13:35:47 INFO - PROCESS | 22642 | 13:35:50 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46422/tests/kraken/driver.html?testName=imaging-desaturate) 13:35:51 INFO - PROCESS | 22642 | RSS: Main: 216788992 13:35:51 INFO - PROCESS | 22642 | 13:35:54 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46422/tests/kraken/driver.html?testName=json-parse-financial) 13:35:54 INFO - PROCESS | 22642 | RSS: Main: 216948736 13:35:54 INFO - PROCESS | 22642 | 13:35:56 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46422/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:35:57 INFO - PROCESS | 22642 | RSS: Main: 202870784 13:35:57 INFO - PROCESS | 22642 | 13:35:58 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:35:59 INFO - PROCESS | 22642 | RSS: Main: 205385728 13:35:59 INFO - PROCESS | 22642 | 13:36:01 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:36:02 INFO - PROCESS | 22642 | RSS: Main: 217436160 13:36:02 INFO - PROCESS | 22642 | 13:36:05 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:36:05 INFO - PROCESS | 22642 | RSS: Main: 224456704 13:36:05 INFO - PROCESS | 22642 | 13:36:08 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:36:09 INFO - PROCESS | 22642 | RSS: Main: 220958720 13:36:09 INFO - PROCESS | 22642 | 13:36:10 INFO - PROCESS | 22642 | Cycle 1(1): loaded http://localhost:46422/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46422/tests/kraken/driver.html?testName=ai-astar) 13:36:11 INFO - PROCESS | 22642 | RSS: Main: 283582464 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | __start_tp_report 13:36:11 INFO - PROCESS | 22642 | _x_x_mozilla_page_load 13:36:11 INFO - PROCESS | 22642 | _x_x_mozilla_page_load_details 13:36:11 INFO - PROCESS | 22642 | |i|pagename|runs| 13:36:11 INFO - PROCESS | 22642 | |0;ai-astar;111;114;109;113;115;114;102;112;112;113 13:36:11 INFO - PROCESS | 22642 | |1;audio-beat-detection;170;134;156;186;131;152;163;132;187;140 13:36:11 INFO - PROCESS | 22642 | |2;audio-dft;163;161;161;161;163;163;163;162;163;162 13:36:11 INFO - PROCESS | 22642 | |3;audio-fft;77;74;118;110;77;72;74;112;99;76 13:36:11 INFO - PROCESS | 22642 | |4;audio-oscillator;94;93;150;94;94;93;150;94;93;142 13:36:11 INFO - PROCESS | 22642 | |5;imaging-gaussian-blur;116;117;116;116;116;117;118;117;117;116 13:36:11 INFO - PROCESS | 22642 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;145;146 13:36:11 INFO - PROCESS | 22642 | |7;imaging-desaturate;94;95;94;95;95;95;94;95;94;95 13:36:11 INFO - PROCESS | 22642 | |8;json-parse-financial;65;63;64;64;64;64;64;80;63;62 13:36:11 INFO - PROCESS | 22642 | |9;json-stringify-tinderbox;66;65;65;66;65;65;65;65;65;72 13:36:11 INFO - PROCESS | 22642 | |10;stanford-crypto-aes;78;76;79;76;79;80;78;82;82;78 13:36:11 INFO - PROCESS | 22642 | |11;stanford-crypto-ccm;132;132;129;130;126;127;127;130;161;131 13:36:11 INFO - PROCESS | 22642 | |12;stanford-crypto-pbkdf2;174;173;176;172;173;173;171;176;170;170 13:36:11 INFO - PROCESS | 22642 | |13;stanford-crypto-sha256-iterative;73;71;71;72;70;72;71;79;71;71 13:36:11 INFO - PROCESS | 22642 | __end_tp_report 13:36:11 INFO - PROCESS | 22642 | __start_cc_report 13:36:11 INFO - PROCESS | 22642 | _x_x_mozilla_cycle_collect,1945 13:36:11 INFO - PROCESS | 22642 | __end_cc_report 13:36:11 INFO - PROCESS | 22642 | __startTimestamp1461962171226__endTimestamp 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | ------- Summary: start ------- 13:36:11 INFO - PROCESS | 22642 | Number of tests: 14 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:3.97 13:36:11 INFO - PROCESS | 22642 | Values: 111.0 114.0 109.0 113.0 115.0 114.0 102.0 112.0 112.0 113.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:159.50 stddev:21.23 (13.3%) stddev-sans-first:21.82 13:36:11 INFO - PROCESS | 22642 | Values: 170.0 134.0 156.0 186.0 131.0 152.0 163.0 132.0 187.0 140.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 13:36:11 INFO - PROCESS | 22642 | Values: 163.0 161.0 161.0 161.0 163.0 163.0 163.0 162.0 163.0 162.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#3] audio-fft Cycles:10 Average:88.90 Median:75.00 stddev:18.58 (24.8%) stddev-sans-first:19.20 13:36:11 INFO - PROCESS | 22642 | Values: 77.0 74.0 118.0 110.0 77.0 72.0 74.0 112.0 99.0 76.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:93.50 stddev:26.06 (27.9%) stddev-sans-first:27.02 13:36:11 INFO - PROCESS | 22642 | Values: 94.0 93.0 150.0 94.0 94.0 93.0 150.0 94.0 93.0 142.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 13:36:11 INFO - PROCESS | 22642 | Values: 116.0 117.0 116.0 116.0 116.0 117.0 118.0 117.0 117.0 116.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 13:36:11 INFO - PROCESS | 22642 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 13:36:11 INFO - PROCESS | 22642 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:64.00 stddev:5.23 (8.2%) stddev-sans-first:5.55 13:36:11 INFO - PROCESS | 22642 | Values: 65.0 63.0 64.0 64.0 64.0 64.0 64.0 80.0 63.0 62.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:65.00 stddev:2.18 (3.4%) stddev-sans-first:2.32 13:36:11 INFO - PROCESS | 22642 | Values: 66.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 65.0 72.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:79.00 stddev:2.10 (2.7%) stddev-sans-first:2.20 13:36:11 INFO - PROCESS | 22642 | Values: 78.0 76.0 79.0 76.0 79.0 80.0 78.0 82.0 82.0 78.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:130.50 stddev:10.23 (7.8%) stddev-sans-first:10.85 13:36:11 INFO - PROCESS | 22642 | Values: 132.0 132.0 129.0 130.0 126.0 127.0 127.0 130.0 161.0 131.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:2.15 (1.2%) stddev-sans-first:2.24 13:36:11 INFO - PROCESS | 22642 | Values: 174.0 173.0 176.0 172.0 173.0 173.0 171.0 176.0 170.0 170.0 13:36:11 INFO - PROCESS | 22642 | 13:36:11 INFO - PROCESS | 22642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:71.50 stddev:2.56 (3.6%) stddev-sans-first:2.69 13:36:11 INFO - PROCESS | 22642 | Values: 73.0 71.0 71.0 72.0 70.0 72.0 71.0 79.0 71.0 71.0 13:36:11 INFO - PROCESS | 22642 | -------- Summary: end -------- 13:36:11 INFO - PROCESS | 22642 | 13:36:12 INFO - TEST-INFO | 22642: exit 0 13:36:12 INFO - TEST-OK | kraken | took 63340ms 13:36:12 INFO - SUITE-END | took 1183s 13:36:12 INFO - Completed test suite (00:19:43) 13:36:12 INFO - javascript benchmark 13:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.3443072016635, 2642.603609458582, 2643.2598872315757, 2653.5754279315315, 2677.598360245963, 4498.865034048984, 4573.268277075668, 4574.03945171514, 4591.540845915407, 4594.218982772933, 4565.2010898092785, 4607.378003969463, 4659.068186362732, 4668.85993420198, 4676.97661511692, 4189.099343641116, 4234.555371685982, 4241.066965267636, 4298.677599180059, 4417.823287068513, 4315.654747620199, 4346.6522678185665, 4380.605745482906, 4390.936259957814, 4407.625351845097, 4133.1940271647045, 4212.957870421287, 4215.747055176699, 4243.724157929724, 4321.416608757841, 4199.748015119103, 4248.596383343577, 4249.787510624456, 4297.39836422901, 4317.4819021717285, 4185.079282557833, 4196.181744559812, 4207.326827707552, 4217.0, 4238.872833814959, 4333.2200203963275, 4476.171908196994, 4496.505384407713, 4511.954880451219, 4603.286490593963, 4937.5556199942175, 4952.034353301072, 4955.82654607087, 4960.975195124038, 4992.975035124838, 4945.332380128672, 4968.925466118011, 4972.378452693413, 4981.476944920767, 5000.149974504343, 4471.038726673781, 4532.818687252473, 4627.444706635191, 4677.22825733757, 4677.812887484462, 5009.974950125299, 5029.321041659402, 5032.270320803463, 5034.043531728959, 5035.496450354935, 4771.856844294677, 4784.4497882743235, 4813.253945638432, 4813.518648135228, 4856.562909338177, 4771.355866957986, 4928.802847886116, 4991.700497970133, 5013.348264725562, 5027.622928280393, 4831.73425461603, 4843.055604157226, 4851.203620538186, 4854.053459575349, 4905.264210368402, 4637.072585482917, 4830.8309209178215, 4833.275008748646, 4836.371271734652, 4887.875788568578, 4147.419361289422, 4174.749515029108, 4242.363645453145, 4243.830246790156, 4246.214450326699, 3629.0745859806107, 3634.1823089804584, 3637.363461394298, 3654.744167908221, 3680.4847321375028, 4219.578042195817, 4221.197972385237, 4223.788810559521, 4226.17589570037, 4262.998195424073, 4765.475797662254, 4867.3915760529935, 4894.437139728977, 4920.21276595743, 4949.059678661115, 4215.388768628593, 4239.9788001060415, 4252.213340532012, 4252.978735106367, 4254.0, 4333.674974376871, 4449.976505403775, 4456.487503937024, 4489.7979590918485, 4497.9325310120375, 4623.42207224097, 4667.159911216014, 4667.183242932405, 4710.7880145392855, 4731.313959475926, 4907.97546012282, 4908.165611845923, 4909.95090049095, 4912.263160525807, 4919.532644398776, 4495.2358099122575, 4640.0, 4645.094206629675, 4665.440147182359, 4681.836135735233, 4848.17581011236, 4867.1969125095375, 4893.266010098371, 4913.508649135058, 4913.828016019422, 4937.333459983, 4940.0, 4942.703437793743, 4955.033768415268, 4986.9251961221335, 4584.9312260315455, 4738.170820106537, 4774.283857421415, 4809.591184749195, 4862.586680132087, 4788.545088216753, 4807.230843065093, 4809.278608208657, 4823.903521929472, 4859.07677541266, 4687.67186296956, 4710.081534100817, 4710.670253082251, 4733.857984260478, 4770.141374552614, 4680.836170734008, 4732.171869922819, 4801.303810947463, 4823.059503396804, 4840.34655321527, 4705.0, 4724.71651700899, 4742.810287588596, 4748.596369308648, 4781.808727650855], "value": 4522.090299805009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8163787587973, 595.7736060297087, 608.9421504957028, 619.5353484886336, 625.9968700156498, 26761.4647707046, 33604.66395336046, 33684.15789605261, 34555.136121596974, 34865.82567087161, 40673.79663101688, 41153.58846411535, 41203.38194927071, 41226.58773412265, 41238.0, 7322.890156647654, 7731.690732370713, 7958.721444749435, 7960.840783184332, 7964.323032542241, 9422.670206542773, 9696.854547181798, 9703.708888733348, 9707.223422126248, 9709.563069661883, 9798.265130115235, 9987.0, 9987.101160895518, 9994.9500252499, 9999.700008999742, 9822.066903644178, 9966.950165249164, 9973.35173213746, 9975.102240798291, 9979.30144889858, 9703.854442183372, 9828.754281142958, 9831.0, 10155.238357123246, 10162.796744065152, 37365.62634373648, 37915.62084379148, 37957.81021094904, 37980.810095949346, 38035.61964380376, 3168.714815666601, 3186.4583020886503, 3192.6488086310487, 3192.9361412771614, 3199.04028791364, 29486.41027179466, 29746.40507189844, 29901.401971960655, 30026.69973300261, 30374.392512149854, 3187.7609179311644, 3200.9679903200904, 3216.710496055343, 3225.1292151119064, 3296.901092967215, 184825.0, 186772.0, 187078.0, 187195.0, 188240.0, 47028.5297147031, 47485.0, 47531.5246847534, 47594.0, 47662.0, 54721.72639136779, 54932.0, 54939.45060549423, 54962.45037549653, 54966.17550736742, 13399.866001340057, 13934.0, 14014.0, 14040.508582199778, 14041.1575305482, 9394.95302523483, 9658.32391732586, 9659.420434773936, 9669.129778319984, 10703.411312377739, 14564.344604492824, 14756.704865902837, 15030.774538381933, 15030.774538381933, 15036.398544058115, 5990.460858522754, 6062.363451837582, 6067.362926892701, 6124.35694252106, 6154.169187159766, 896.4442045931564, 938.5166639180827, 986.2011770465803, 1023.5752162852482, 1068.0387651113904, 28212.43575128486, 28404.43191136166, 29003.41993160125, 29071.41857162845, 29144.27139321534, 1010.2322235101229, 1033.01347213411, 1039.7868436970402, 1060.8090543702053, 1078.7734575739025, 14483.203423811581, 14981.475648352256, 15271.301980222583, 15352.539423817303, 15378.980607992522, 336338.0, 340141.0, 342784.0, 342946.0, 343078.0, 48243.0, 48542.5145748538, 48606.27090593644, 48662.27006594904, 48811.0, 1117.4468638024068, 1224.0513601958376, 1246.9636435280122, 1254.5358217459598, 1256.8931640810633, 24488.75511244865, 25731.3567160815, 27274.318142046606, 28050.438991220468, 28585.571216432185, 38283.23433531258, 38912.80543597264, 39072.41391379075, 39099.218015640094, 39119.41320880132, 232652.0, 239259.0, 239340.0, 239357.0, 239912.0, 27344.589831152152, 30768.538471922493, 31712.0, 32497.675023249463, 32516.512252315762, 35112.0, 35854.82072589621, 35955.101122472144, 36119.27761444704, 36459.27081458409, 29230.56154157647, 30933.0, 31204.21989450191, 31540.0, 31999.200019999687, 31334.843325783226, 31436.0, 31605.84197079, 33773.49339759856, 34775.826120869235, 31072.22319442032, 31147.84426077855, 32866.67133328636, 34608.134796630286, 34865.651343487254, 30751.220484208072, 31231.531527027568, 31507.0, 31832.840835795672, 31901.20246993751, 24563.87718061398, 24608.0, 24754.752452475244, 25001.624975625018, 25053.0], "value": 17150.68115660655, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.7911148868123, 384.2066133434458, 386.79886459041296, 397.21351723587316, 397.28290435763455, 15806.920965395171, 16737.83262167378, 16862.494125176265, 17169.055701936402, 17219.0, 15686.372545098211, 16361.918190409031, 16739.16304184789, 17325.393611223608, 17338.56653583658, 4713.245880659087, 4847.684900481475, 4888.193448081062, 4892.9755351223375, 4895.779689913945, 3478.1652403423122, 5352.116900711398, 5652.830415087554, 5658.603897727161, 5663.348714897777, 5582.0, 5593.636413633121, 5643.181738647893, 5648.491635752782, 5653.604247702662, 5547.750351234205, 5715.514181294595, 5724.427557244242, 5767.394423585505, 5767.45209205127, 3406.2846802171575, 3542.6988705960025, 3583.283343331318, 3585.175409655768, 5104.515071068243, 12045.93977030118, 12085.818712719229, 12293.754124917541, 12294.446749896186, 12369.567065152767, 1879.4737473507303, 1899.2877670873422, 1902.6004539046817, 1976.7529058867642, 1998.760148782141, 8934.776630584221, 9284.396514226553, 9546.522673866279, 9618.951905240428, 9791.167750741195, 1743.3375317379441, 1763.074385947375, 1770.4600096970419, 1849.5745978425039, 1886.8018858019848, 66221.66889165572, 72135.0, 72572.63713681398, 72631.63684181598, 73267.0, 10054.59781608742, 10061.0, 10191.7452063699, 10309.48452577383, 10319.742006449898, 14309.64225894361, 14389.856101439062, 14471.92764036194, 14487.058341207789, 14512.927435362755, 7089.7873063808165, 7140.92859071413, 7159.57042577447, 7282.854342913218, 7294.708211671474, 6613.834654133589, 6639.933600664028, 6653.4677225821815, 6786.287439818847, 6787.355201255873, 4447.866564003085, 4504.684672072924, 4505.954940450619, 4511.120331535319, 4579.91613815713, 1661.9916900415662, 1719.131838421614, 1788.50816025594, 1893.7822150452873, 1909.6562618728485, 868.3660927522943, 904.1771987491351, 945.6737425588161, 967.7580604848788, 980.9993806317659, 16164.43424480161, 16482.42311519091, 17043.784308039874, 17055.658886822443, 17504.387346442814, 892.9151730585584, 926.064674678566, 934.7055677461578, 960.6637676813059, 987.8073775613686, 9386.577604007836, 9490.145886870216, 9630.181434578139, 9638.469884156299, 9673.226141908772, 362952.0, 363611.0, 363816.0, 365031.0, 403752.0, 77876.0, 79802.20197797948, 82028.0, 82239.5888020556, 82567.0, 958.0515289863125, 960.078324808192, 974.1768205866032, 977.9217662586976, 978.2760757039881, 14886.404543818126, 14892.702145957237, 15082.321295541946, 15199.848001519844, 15344.0, 33450.31695562672, 34140.0, 34367.656323436444, 35409.468857967666, 35983.0, 45757.31364029609, 48420.03159936852, 50300.24549631685, 50328.74835625799, 50912.49087509078, 7539.698412063456, 7638.350740186924, 7648.694052238071, 7750.379969602531, 7798.766037018899, 7741.806454838674, 10072.0, 10596.947015264874, 11109.333439993627, 11502.367369794407, 8908.955455222682, 9173.908260917306, 9469.526523673927, 9518.714438566854, 9745.463999480096, 9112.635494580143, 9452.669156579486, 9517.333786634868, 10259.640912568024, 10288.074073333435, 9692.127708506268, 9767.218622510325, 9861.408315501092, 9913.950430247802, 10001.99064397321, 7529.60286842021, 7630.580318082559, 7728.8454230916195, 7774.572398517909, 7856.607169641381, 9405.341626086381, 9907.752306192402, 9975.0, 10101.5454304555, 10167.84748228792], "value": 7993.68697603777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.4050766393625, 1465.7361674898514, 1494.1184701026395, 1606.5100144455944, 1787.3654852527345, 6615.801525954217, 7562.735304264345, 7769.728059517918, 7821.921780782191, 7825.804354891124, 7553.942448057276, 7570.0915890093265, 7661.502002369842, 7674.769756907288, 7683.193264707195, 1851.2502436513234, 2138.134055707441, 2193.2981445937307, 2227.0757635581213, 2227.3206671965045, 2209.8232141428725, 2232.966505502419, 2234.162189179058, 2239.193890199527, 2240.383894429037, 2167.8374121940838, 2179.8038176564105, 2194.58302922445, 2206.889655517226, 2213.4245096275004, 1816.9000704961288, 2095.8532902696816, 2172.2940044485604, 2176.379731776452, 2176.4450065233264, 2132.648113061343, 2148.7099241602496, 2151.3008272311404, 2154.4613846538364, 2155.7089792878073, 7475.738349157753, 7542.472026958115, 7543.811404714871, 7550.848983020309, 7551.358134558569, 4358.847440339573, 4499.730016199039, 4514.503404625489, 4516.458025036984, 4529.433820772403, 2722.823016503921, 2888.8411137387434, 2904.7821413393867, 2915.4752144613963, 2918.0953904289527, 1667.7831881855282, 1718.8109307976238, 1731.2728653965364, 1734.9219285132074, 1765.5497848048794, 10138.594456221743, 10225.028622280872, 10244.02681745233, 10266.589336426608, 10271.178305735599, 4069.654079403284, 4218.767967761742, 4234.153169366139, 4244.8514301999285, 4272.060146767706, 8515.914840851512, 8569.914300857037, 8593.570321483901, 8593.828123437495, 8597.18326758957, 4620.653450991189, 4646.0, 4655.790489427916, 4662.860114196579, 4668.4631267404, 3646.361886669822, 4081.9795901020307, 4205.137946720976, 4237.576242375738, 4255.255330317244, 3308.123347312964, 3367.2423704666253, 3405.659434056624, 3432.1934345429304, 3452.879149229815, 1004.3321191407632, 1020.2093377632394, 1021.5096753558333, 1037.2946396450486, 1040.6409788622914, 720.2689270390558, 778.4473024152802, 824.995875020621, 854.747849384433, 865.0700496965787, 4965.503449655078, 4988.451270360258, 5018.272350509229, 5136.845894623168, 5153.0, 417.3385184482568, 417.7660510114285, 421.7090207756638, 430.0753380232463, 431.04738527853794, 3469.8091604961464, 3484.9128771780906, 3491.5810102787827, 3538.2039041216035, 3538.2215912499723, 8908.10918908104, 9203.861942070875, 9316.114969077928, 9323.0, 9378.249740020781, 9090.181883630372, 9111.589978450986, 9191.08089191089, 9289.396189247676, 9305.674301399418, 6832.214295355998, 6840.452763778886, 6854.34883686049, 6895.5173137879865, 6915.550489218285, 4796.664233503621, 4866.90266194667, 4925.975370123127, 4961.652684312064, 5011.949880501148, 8582.442141260799, 8587.22714955632, 8641.222289993932, 8713.956430217808, 8743.256823169848, 8547.658093676431, 8599.484030958163, 8622.0, 8772.035076141492, 8872.955635221782, 5530.198121272312, 5665.291838520185, 6131.96934015345, 6196.907046394217, 6231.563790534619, 7366.079240094989, 7470.103587569526, 7476.401887849068, 7500.774976750707, 7510.511816731895, 6615.37153970372, 6757.087793148059, 6837.453003759787, 6872.793816185523, 6919.619420931897, 6707.0, 6739.427148692416, 6746.730130794714, 6785.253622101466, 6799.490038247251, 6197.783077592263, 6261.060840873905, 6265.561410701207, 6266.592671476339, 6277.2153480814895, 4503.121891231179, 4505.031418245093, 4533.977330113328, 4555.088982203639, 4593.793279302507, 4530.411046563926, 4562.703424277412, 4662.230731929194, 4685.250359942529, 4738.194506933761], "value": 4023.9946412696663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.649767030728, 303.76002957663445, 308.76842368223834, 313.54066292880924, 314.60831265074984, 4567.451905771304, 4694.718316900989, 4786.186348320785, 4832.646858879511, 4864.4162700475945, 4597.747123908192, 4768.78540465679, 4774.570288674018, 4782.641301902362, 4784.641151913612, 3799.487069245658, 3805.344675066348, 3824.2160357126863, 3826.0, 3841.865534706286, 3626.8186590670493, 3645.7994810285422, 3787.431885217212, 3795.8481660733537, 3838.5201849768778, 3783.089539782406, 3784.883459379476, 3797.2215695782297, 3830.444585535096, 3833.15670552478, 3776.055986003499, 3779.5842457329672, 3793.620637936212, 3805.162864169878, 3821.7515861468914, 3411.096059544223, 3414.6243913169533, 3415.64135765746, 3418.077119177833, 3426.4517677171534, 4453.599176074169, 4526.79629416677, 4534.251848445003, 4544.772761361919, 4567.223571992736, 4281.614654681093, 4291.141771645684, 4302.698811083225, 4310.849120280806, 4315.784210789448, 4920.040592084545, 4922.901541969176, 4970.055689418999, 4973.52751488608, 4990.126727822653, 3394.7114495267933, 3568.3398571264397, 3605.801680907549, 3653.707703383723, 3674.6876515496215, 5168.302279192299, 5186.688798672092, 5186.818461353834, 5213.635045546814, 5256.237845512379, 3655.817209139532, 3669.522962014921, 3696.057505336122, 3698.3158115748674, 3698.4452332149854, 3714.405695088773, 3739.383001804726, 3743.1016556026357, 3749.3813520769313, 3754.737168398186, 4091.8747344480507, 4312.719673221231, 4322.200392927319, 4340.631046361032, 4344.6089851913475, 4964.652474326835, 4988.925166122511, 5014.323066386064, 5017.473165317662, 5022.648414610942, 1330.1752913193882, 1358.8505264420905, 1391.0610338021795, 1413.3922413362147, 1417.078898715843, 963.4508330251689, 966.7824739433571, 978.1001478639669, 979.647326962293, 988.8862780780303, 4633.930491042637, 4636.211843986531, 4636.930446043312, 4637.1421287062, 4640.69835460694, 5424.907802552507, 5428.4028756836715, 5434.375046869582, 5445.611369100854, 5449.509544141047, 4192.266353388206, 4599.67802253839, 4631.560001799824, 4637.0, 4637.907241855211, 2932.4428358611794, 2943.514320137196, 2960.363521842814, 2966.8516574171636, 2976.851157442119, 5228.581713462914, 5237.73811309433, 5243.790248390098, 5254.92117618236, 5270.183121616155, 5483.314585676791, 5643.701948551856, 5662.716864156858, 5698.715064246771, 5706.885862282731, 5185.714785686748, 5187.118189907725, 5194.0, 5220.190870415092, 5227.973860130675, 5538.91691624634, 5555.58332625178, 5568.610197286151, 5569.415211402745, 5579.944200558105, 5304.117038451294, 5389.83830485086, 5390.757415916371, 5423.891522169455, 5425.593080518898, 5167.276581278549, 5175.689458632494, 5189.6107791915, 5198.636095473432, 5222.843314700565, 3796.8101594920695, 3826.6173382662623, 3836.731428799957, 3860.4981352424006, 3870.5291989043985, 4850.684705494132, 5406.540444062299, 5436.266104076058, 5498.092814685532, 5524.64646161693, 4808.663393562417, 4945.975270123627, 4969.3291405659775, 4974.040445934663, 4980.925286120783, 4916.115099282163, 4947.628927830355, 4950.554450099365, 4991.6006719463085, 4993.550580447632, 4669.556392142741, 4900.607951363811, 4911.287863259879, 4923.193779545624, 4931.48219436954, 5012.398512178562, 5051.696898186121, 5077.796888124433, 5077.847664570068, 5088.643794934319, 4924.4090709115135, 4925.0, 4944.159492886146, 4950.232713929347, 4955.702657840541], "value": 3889.6024696623363, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.7207570555396, 706.2866504830117, 710.2187593646987, 711.0827033127266, 717.7487879242262, 11257.774844503116, 12098.81851772224, 12354.073444491654, 12366.629001129959, 12374.876251237485, 11229.270097443661, 11266.493007814648, 11304.321740695543, 11313.604023859167, 11324.60363887264, 631.9273283572379, 780.6721177105629, 800.2437696376911, 814.7392834293029, 815.8572249856281, 810.7405630198309, 814.3200427642926, 814.3932770086294, 814.5194335342177, 816.8202995341015, 846.0, 847.9109693482188, 848.2704873808519, 849.2526576612572, 849.7493239494333, 659.5679829711546, 809.7408829174666, 838.6561509780961, 840.2479780596393, 845.6406027438345, 615.5875563372551, 616.8550390658191, 617.0897925559808, 618.1932577985726, 620.2247191011236, 11897.464614092387, 11956.70108247292, 11982.101342399268, 11988.0, 12010.159288849783, 11614.245074070159, 11803.527858885634, 11891.167618266725, 11991.280523168638, 12203.938980305042, 9821.90178098217, 9908.0, 9981.70054898347, 10137.39175649456, 10181.643642472478, 3254.2189874430205, 3259.6414394416597, 3259.706626403611, 3300.471924492094, 3318.386098571772, 41647.167056659004, 42186.57813421857, 42286.788566056974, 42404.0, 43051.569484305066, 9197.264218862474, 9390.71827845152, 9452.810943781085, 9672.22622190223, 9727.027297270359, 16148.919255403647, 16219.594510137342, 16242.269097890623, 16267.51197464078, 16382.344706211856, 6507.9023814642815, 6894.517383783087, 6929.237783843773, 7013.228544860061, 7165.928340716526, 3702.3520883845217, 3728.4034554471696, 3781.4138808484727, 3794.658480736747, 3928.4107383892647, 2838.914832555027, 2900.8114472559214, 2910.6652734935756, 2912.8689208985647, 2914.12576227131, 496.63497329462814, 504.66944151580776, 518.1631664861297, 524.8819015721432, 532.430299579454, 585.3502612100565, 602.135934933372, 617.8023032629516, 636.7834936121649, 638.5721566550329, 7753.573553454501, 7852.332551733167, 7963.323117535075, 8088.002218876265, 8168.918310816815, 575.5710900001985, 590.8712376571401, 596.2695697770197, 596.5645079092287, 602.7498588085896, 3739.7943113128495, 3847.961520384816, 3920.6471417572557, 3946.506686664167, 3965.980170099189, 51083.74458127686, 55480.16779748307, 56612.716936415054, 56660.86678266412, 57221.71389143111, 46420.0, 47824.0, 48078.519214807406, 48256.0, 49019.0, 41813.37279940803, 42755.786221068694, 43107.56892431098, 43475.56524434778, 44188.337174942404, 8086.757397278091, 8194.180581941997, 8215.753527394188, 8392.20274073962, 8433.409661323649, 27720.703290989928, 28737.42525149527, 29329.560056599596, 29368.412631747673, 30258.84870575633, 35683.46474802932, 35926.101847454025, 37657.4351384724, 37680.623193767715, 38471.03822404462, 9880.35777674449, 10394.064534191959, 10436.947815260875, 10550.736231594272, 10742.3017503862, 11648.767024659628, 11809.645710628694, 11954.521819127485, 11962.880371196177, 12220.388980550759, 10660.733481663021, 10757.731056723644, 10825.404602746925, 10835.404052777172, 11170.609028683957, 11084.334939903632, 11150.219484635998, 11590.420478976186, 11599.76800463969, 11649.068074554185, 10758.569657213937, 10814.56741730322, 10907.0, 11219.66341009771, 11478.770424591628, 9421.528923553931, 9518.428894266366, 9532.714018579454, 9743.512824358895, 9908.504574771088, 9020.0, 9289.767755806159, 9293.0, 9365.953170234105, 9398.154166125081], "value": 5885.977841406041, "unit": "score"}], "name": "dromaeo_css", "value": 6205.827330378827, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 109.0, 113.0, 115.0, 114.0, 102.0, 112.0, 112.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 134.0, 156.0, 186.0, 131.0, 152.0, 163.0, 132.0, 187.0, 140.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 161.0, 163.0, 163.0, 163.0, 162.0, 163.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 118.0, 110.0, 77.0, 72.0, 74.0, 112.0, 99.0, 76.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 150.0, 94.0, 94.0, 93.0, 150.0, 94.0, 93.0, 142.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 116.0, 117.0, 118.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 80.0, 63.0, 62.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 72.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 79.0, 76.0, 79.0, 80.0, 78.0, 82.0, 82.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 129.0, 130.0, 126.0, 127.0, 127.0, 130.0, 161.0, 131.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 176.0, 172.0, 173.0, 173.0, 171.0, 176.0, 170.0, 170.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 71.0, 72.0, 70.0, 72.0, 71.0, 79.0, 71.0, 71.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1571.8000000000002, "alertThreshold": 2.0}]} 13:36:12 INFO - Return code: 0 13:36:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:36:12 ERROR - # TBPL SUCCESS # 13:36:12 INFO - Running post-action listener: _resource_record_post_action 13:36:12 INFO - Running post-run listener: _resource_record_post_run 13:36:13 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525889536; Read time: 8; Write time: 691292 13:36:13 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 245727232; Read time: 0; Write time: 425448 13:36:13 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280162304; Read time: 8; Write time: 265844 13:36:13 INFO - Running post-run listener: _upload_blobber_files 13:36:13 INFO - Blob upload gear active. 13:36:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:36:13 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 13:36:13 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'] 13:36:13 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 13:36:14 INFO - (blobuploader) - INFO - Open directory for files ... 13:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:14 INFO - (blobuploader) - INFO - Done attempting. 13:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:36:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:36:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:36:15 INFO - (blobuploader) - INFO - Done attempting. 13:36:15 INFO - (blobuploader) - INFO - Iteration through files over. 13:36:15 INFO - Return code: 0 13:36:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:36:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:36:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dff83b8d8a428f7acadcd18e20b3aa665bce22d6859fd8429d4d92823399fb3a6bfa7e98d5c1fff8900a9ac443efcdd922853a547c65a071676fa48a437a1370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/152888ff278eac827af805a36caeb837337f70826b7fa634db4960c329cac4ed002cf5f70392f6c7818b7eb52ec0fd6906c396ce3f829a9c31847a0729389061"} 13:36:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:36:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:36:15 INFO - Contents: 13:36:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dff83b8d8a428f7acadcd18e20b3aa665bce22d6859fd8429d4d92823399fb3a6bfa7e98d5c1fff8900a9ac443efcdd922853a547c65a071676fa48a437a1370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/152888ff278eac827af805a36caeb837337f70826b7fa634db4960c329cac4ed002cf5f70392f6c7818b7eb52ec0fd6906c396ce3f829a9c31847a0729389061"} 13:36:15 INFO - Running post-run listener: copy_logs_to_upload_dir 13:36:15 INFO - Copying logs to upload dir... 13:36:15 INFO - mkdir: /builds/slave/test/build/upload/logs 13:36:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.939194 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-04-29 13:36:15.587155) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 13:36:15.590571) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949 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/dff83b8d8a428f7acadcd18e20b3aa665bce22d6859fd8429d4d92823399fb3a6bfa7e98d5c1fff8900a9ac443efcdd922853a547c65a071676fa48a437a1370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/152888ff278eac827af805a36caeb837337f70826b7fa634db4960c329cac4ed002cf5f70392f6c7818b7eb52ec0fd6906c396ce3f829a9c31847a0729389061"} build_url:https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/GHXB0VGoSIeJhG1o02AXRA/artifacts/public/build/firefox-49.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/dff83b8d8a428f7acadcd18e20b3aa665bce22d6859fd8429d4d92823399fb3a6bfa7e98d5c1fff8900a9ac443efcdd922853a547c65a071676fa48a437a1370", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/152888ff278eac827af805a36caeb837337f70826b7fa634db4960c329cac4ed002cf5f70392f6c7818b7eb52ec0fd6906c396ce3f829a9c31847a0729389061"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 13:36:15.615909) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:36:15.616282) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1461959170.613717-1427537949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004367 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 13:36:15.699289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:36:15.699601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 13:36:15.700013) ========= ========= Total master_lag: 0.21 =========