builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1461644373.16 results: success (0) buildid: 20160425204203 builduid: f25ac29b8a8b41e4a2db418ddd501fc3 revision: f2b20c6eb71dbf7a2884a776251e760e73b8c69b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.165473) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.166024) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.166356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.217142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.217409) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 21:19:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-25 21:19:34 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.387807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.388119) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014287 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.438619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:33.438924) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f2b20c6eb71dbf7a2884a776251e760e73b8c69b --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 f2b20c6eb71dbf7a2884a776251e760e73b8c69b --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=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 21:19:34,372 truncating revision to first 12 chars 2016-04-25 21:19:34,372 Setting DEBUG logging. 2016-04-25 21:19:34,372 attempt 1/10 2016-04-25 21:19:34,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f2b20c6eb71d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 21:19:34,678 unpacking tar archive at: fx-team-f2b20c6eb71d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.035908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.036226) ========= script_repo_revision: f2b20c6eb71dbf7a2884a776251e760e73b8c69b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.036598) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.036862) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 21:19:34.052752) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-25 21:19:34.053053) ========= /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=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:19:35 INFO - MultiFileLogger online at 20160425 21:19:35 in /builds/slave/test 21:19:35 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 21:19:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:19:35 INFO - {'append_to_log': False, 21:19:35 INFO - 'base_work_dir': '/builds/slave/test', 21:19:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:19:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:19:35 INFO - 'branch': 'Fx-Team-Non-PGO', 21:19:35 INFO - 'buildbot_json_path': 'buildprops.json', 21:19:35 INFO - 'config_files': ('talos/linux_config.py',), 21:19:35 INFO - 'default_actions': ('clobber', 21:19:35 INFO - 'read-buildbot-config', 21:19:35 INFO - 'download-and-extract', 21:19:35 INFO - 'populate-webroot', 21:19:35 INFO - 'create-virtualenv', 21:19:35 INFO - 'install', 21:19:35 INFO - 'run-tests'), 21:19:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:19:35 INFO - 'download_minidump_stackwalk': True, 21:19:35 INFO - 'download_symbols': 'ondemand', 21:19:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:19:35 INFO - 'tooltool.py': '/tools/tooltool.py', 21:19:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:19:35 INFO - '/tools/misc-python/virtualenv.py')}, 21:19:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:19:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:19:35 INFO - 'installer_path': 'installer.exe', 21:19:35 INFO - 'log_level': 'info', 21:19:35 INFO - 'log_name': 'talos', 21:19:35 INFO - 'log_to_console': True, 21:19:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:19:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:19:35 INFO - 'opt_config_files': (), 21:19:35 INFO - 'pip_index': False, 21:19:35 INFO - 'sps_profile': False, 21:19:35 INFO - 'sps_profile_interval': 0, 21:19:35 INFO - 'suite': 'dromaeojs', 21:19:35 INFO - 'system_bits': '32', 21:19:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:19:35 INFO - 'title': 'talos-linux64-ix-039', 21:19:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:19:35 INFO - 'use_talos_json': True, 21:19:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:19:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:19:35 INFO - 'work_dir': 'build'} 21:19:35 INFO - ##### 21:19:35 INFO - ##### Running clobber step. 21:19:35 INFO - ##### 21:19:35 INFO - Running pre-action listener: _resource_record_pre_action 21:19:35 INFO - Running main action method: clobber 21:19:35 INFO - rmtree: /builds/slave/test/build 21:19:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:19:35 INFO - Running post-action listener: _resource_record_post_action 21:19:35 INFO - ##### 21:19:35 INFO - ##### Running read-buildbot-config step. 21:19:35 INFO - ##### 21:19:35 INFO - Running pre-action listener: _resource_record_pre_action 21:19:35 INFO - Running main action method: read_buildbot_config 21:19:35 INFO - Using buildbot properties: 21:19:35 INFO - { 21:19:35 INFO - "project": "", 21:19:35 INFO - "product": "firefox", 21:19:35 INFO - "script_repo_revision": "production", 21:19:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:19:35 INFO - "repository": "", 21:19:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:19:35 INFO - "buildid": "20160425204203", 21:19:35 INFO - "pgo_build": "False", 21:19:35 INFO - "basedir": "/builds/slave/test", 21:19:35 INFO - "buildnumber": 1603, 21:19:35 INFO - "slavename": "talos-linux64-ix-039", 21:19:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:19:35 INFO - "platform": "ubuntu64_hw", 21:19:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:19:35 INFO - "branch": "fx-team", 21:19:35 INFO - "repo_path": "integration/fx-team", 21:19:35 INFO - "revision": "f2b20c6eb71dbf7a2884a776251e760e73b8c69b", 21:19:35 INFO - "stage_platform": "linux64", 21:19:35 INFO - "builduid": "f25ac29b8a8b41e4a2db418ddd501fc3", 21:19:35 INFO - "slavebuilddir": "test" 21:19:35 INFO - } 21:19:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:19:35 INFO - Running post-action listener: _resource_record_post_action 21:19:35 INFO - ##### 21:19:35 INFO - ##### Running download-and-extract step. 21:19:35 INFO - ##### 21:19:35 INFO - Running pre-action listener: _resource_record_pre_action 21:19:35 INFO - Running main action method: download_and_extract 21:19:35 INFO - mkdir: /builds/slave/test/build/tests 21:19: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')]} 21:19:35 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:19:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:19:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:19:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:42 INFO - Downloaded 1361 bytes. 21:19:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:19:42 INFO - Using the following test package requirements: 21:19:42 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:42 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:19:42 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:19:42 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'jsshell-linux-x86_64.zip'], 21:19:42 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:19:42 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 21:19:42 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:19:42 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:19:42 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:19:42 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 21:19:42 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:19:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:42 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:19:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:19:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:19:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:47 INFO - Downloaded 22290132 bytes. 21:19:47 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'] 21:19:47 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 21:19:48 INFO - Return code: 0 21:19:48 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 21:19:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:48 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:19:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:19:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 21:19:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:51 INFO - Downloaded 22290132 bytes. 21:19:51 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'] 21:19:51 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 21:19:52 INFO - Return code: 0 21:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:52 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 21:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:53 INFO - Downloaded 10840145 bytes. 21:19:53 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'] 21:19:53 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 21:19:54 INFO - Return code: 0 21:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:54 INFO - https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/P_gzoILRQdG0TUeSUR63rg/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 21:19:56 INFO - Downloaded 54818005 bytes. 21:19:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:19:56 INFO - mkdir: /builds/slave/test/properties 21:19:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:19:56 INFO - Writing to file /builds/slave/test/properties/build_url 21:19:56 INFO - Contents: 21:19:56 INFO - build_url:https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 21:19:57 INFO - Running post-action listener: _resource_record_post_action 21:19:57 INFO - Running post-action listener: set_extra_try_arguments 21:19:57 INFO - ##### 21:19:57 INFO - ##### Running populate-webroot step. 21:19:57 INFO - ##### 21:19:57 INFO - Running pre-action listener: _resource_record_pre_action 21:19:57 INFO - Running main action method: populate_webroot 21:19:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:19:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:19:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:19:57 INFO - '--tppagecycles', 21:19:57 INFO - '7'], 21:19:57 INFO - 'tests': ['tsvgm']}}, 21:19:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:19:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:19:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:19:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:19:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:19:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['damp', 'tps']}, 21:19:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'tests': ['damp', 'tps']}, 21:19:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['dromaeo_dom']}, 21:19:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:19:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['a11yr', 21:19:57 INFO - 'ts_paint', 21:19:57 INFO - 'tpaint', 21:19:57 INFO - 'sessionrestore', 21:19:57 INFO - 'sessionrestore_no_auto_restore', 21:19:57 INFO - 'tabpaint']}, 21:19:57 INFO - 'other-e10s': {'tests': ['a11yr', 21:19:57 INFO - 'ts_paint', 21:19:57 INFO - 'tpaint', 21:19:57 INFO - 'sessionrestore', 21:19:57 INFO - 'sessionrestore_no_auto_restore', 21:19:57 INFO - 'tabpaint']}, 21:19:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:19:57 INFO - 'ts_paint', 21:19:57 INFO - 'tpaint', 21:19:57 INFO - 'sessionrestore', 21:19:57 INFO - 'sessionrestore_no_auto_restore', 21:19:57 INFO - 'tabpaint']}, 21:19:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:19:57 INFO - 'ts_paint', 21:19:57 INFO - 'tpaint', 21:19:57 INFO - 'sessionrestore', 21:19:57 INFO - 'sessionrestore_no_auto_restore', 21:19:57 INFO - 'tabpaint']}, 21:19:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['a11yr', 21:19:57 INFO - 'ts_paint', 21:19:57 INFO - 'tpaint', 21:19:57 INFO - 'sessionrestore', 21:19:57 INFO - 'sessionrestore_no_auto_restore', 21:19:57 INFO - 'tabpaint']}, 21:19:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['a11yr', 21:19:57 INFO - 'ts_paint', 21:19:57 INFO - 'tpaint', 21:19:57 INFO - 'sessionrestore', 21:19:57 INFO - 'sessionrestore_no_auto_restore', 21:19:57 INFO - 'tabpaint']}, 21:19:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['tsvgx', 21:19:57 INFO - 'tsvgr_opacity', 21:19:57 INFO - 'tart', 21:19:57 INFO - 'tscrollx', 21:19:57 INFO - 'cart']}, 21:19:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:19:57 INFO - 'tsvgr_opacity', 21:19:57 INFO - 'tart', 21:19:57 INFO - 'tscrollx', 21:19:57 INFO - 'cart']}, 21:19:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'talos_options': ['--disable-e10s'], 21:19:57 INFO - 'tests': ['tp5o']}, 21:19:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'tests': ['tp5o']}, 21:19:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'talos_options': ['--disable-e10s', 21:19:57 INFO - '--xperf_path', 21:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:57 INFO - 'tests': ['tp5n']}, 21:19:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:19:57 INFO - 'talos_options': ['--xperf_path', 21:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:19:57 INFO - 'tests': ['tp5n']}}, 21:19:57 INFO - 'talos.zip': {'path': '', 21:19:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:19:57 INFO - Running post-action listener: _resource_record_post_action 21:19:57 INFO - ##### 21:19:57 INFO - ##### Running create-virtualenv step. 21:19:57 INFO - ##### 21:19:57 INFO - Running pre-action listener: _resource_record_pre_action 21:19:57 INFO - Running main action method: create_virtualenv 21:19:57 INFO - Creating virtualenv /builds/slave/test/build/venv 21:19:57 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 21:19:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:19:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:19:57 INFO - Using real prefix '/usr' 21:19:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:19:57 INFO - Installing distribute.............................................................................................................................................................................................done. 21:19:59 INFO - Installing pip.................done. 21:19:59 INFO - Return code: 0 21:19:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:19:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:19:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:19:59 INFO - Using env: {'DISPLAY': ':0', 21:19:59 INFO - 'HOME': '/home/cltbld', 21:19:59 INFO - 'LANG': 'en_US.UTF-8', 21:19:59 INFO - 'LANGUAGE': 'en_US:en', 21:19:59 INFO - 'LOGNAME': 'cltbld', 21:19:59 INFO - 'MAIL': '/var/mail/cltbld', 21:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:19:59 INFO - 'MOZ_NO_REMOTE': '1', 21:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:19:59 INFO - 'NO_EM_RESTART': '1', 21:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:19:59 INFO - 'PWD': '/builds/slave/test', 21:19:59 INFO - 'SHELL': '/bin/bash', 21:19:59 INFO - 'SHLVL': '1', 21:19:59 INFO - 'TERM': 'linux', 21:19:59 INFO - 'TMOUT': '86400', 21:19:59 INFO - 'USER': 'cltbld', 21:19:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:19:59 INFO - '_': '/tools/buildbot/bin/python'} 21:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:00 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 21:20:00 INFO - Cleaning up... 21:20:00 INFO - Return code: 0 21:20:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:20:00 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')]} 21:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:00 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')]} 21:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:00 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:00 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 21:20:00 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 21:20:00 INFO - Using env: {'DISPLAY': ':0', 21:20:00 INFO - 'HOME': '/home/cltbld', 21:20:00 INFO - 'LANG': 'en_US.UTF-8', 21:20:00 INFO - 'LANGUAGE': 'en_US:en', 21:20:00 INFO - 'LOGNAME': 'cltbld', 21:20:00 INFO - 'MAIL': '/var/mail/cltbld', 21:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:00 INFO - 'MOZ_NO_REMOTE': '1', 21:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:00 INFO - 'NO_EM_RESTART': '1', 21:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:00 INFO - 'PWD': '/builds/slave/test', 21:20:00 INFO - 'SHELL': '/bin/bash', 21:20:00 INFO - 'SHLVL': '1', 21:20:00 INFO - 'TERM': 'linux', 21:20:00 INFO - 'TMOUT': '86400', 21:20:00 INFO - 'USER': 'cltbld', 21:20:00 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:00 INFO - '_': '/tools/buildbot/bin/python'} 21:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:00 INFO - Downloading/unpacking psutil>=0.7.1 21:20:00 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 21:20:00 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 21:20:00 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 21:20:00 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 21:20:00 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 21:20:00 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 21:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:02 INFO - Installing collected packages: psutil 21:20:02 INFO - Running setup.py install for psutil 21:20:02 INFO - building 'psutil._psutil_linux' extension 21:20:02 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 21:20:02 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 21:20:02 INFO - building 'psutil._psutil_posix' extension 21:20:02 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 21:20:02 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 21:20:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:20:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:20:02 INFO - Successfully installed psutil 21:20:02 INFO - Cleaning up... 21:20:02 INFO - Return code: 0 21:20:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:02 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:02 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 21:20:02 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 21:20:02 INFO - Using env: {'DISPLAY': ':0', 21:20:02 INFO - 'HOME': '/home/cltbld', 21:20:02 INFO - 'LANG': 'en_US.UTF-8', 21:20:02 INFO - 'LANGUAGE': 'en_US:en', 21:20:02 INFO - 'LOGNAME': 'cltbld', 21:20:02 INFO - 'MAIL': '/var/mail/cltbld', 21:20:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:02 INFO - 'MOZ_NO_REMOTE': '1', 21:20:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:02 INFO - 'NO_EM_RESTART': '1', 21:20:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:02 INFO - 'PWD': '/builds/slave/test', 21:20:02 INFO - 'SHELL': '/bin/bash', 21:20:02 INFO - 'SHLVL': '1', 21:20:02 INFO - 'TERM': 'linux', 21:20:02 INFO - 'TMOUT': '86400', 21:20:02 INFO - 'USER': 'cltbld', 21:20:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:02 INFO - '_': '/tools/buildbot/bin/python'} 21:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:20: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 21:20: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 21:20: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 21:20: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 21:20: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 21:20: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 21:20:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:20:04 INFO - Installing collected packages: mozsystemmonitor 21:20:04 INFO - Running setup.py install for mozsystemmonitor 21:20:05 INFO - Successfully installed mozsystemmonitor 21:20:05 INFO - Cleaning up... 21:20:05 INFO - Return code: 0 21:20:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:05 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:05 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 21:20:05 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 21:20:05 INFO - Using env: {'DISPLAY': ':0', 21:20:05 INFO - 'HOME': '/home/cltbld', 21:20:05 INFO - 'LANG': 'en_US.UTF-8', 21:20:05 INFO - 'LANGUAGE': 'en_US:en', 21:20:05 INFO - 'LOGNAME': 'cltbld', 21:20:05 INFO - 'MAIL': '/var/mail/cltbld', 21:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:05 INFO - 'MOZ_NO_REMOTE': '1', 21:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:05 INFO - 'NO_EM_RESTART': '1', 21:20:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:05 INFO - 'PWD': '/builds/slave/test', 21:20:05 INFO - 'SHELL': '/bin/bash', 21:20:05 INFO - 'SHLVL': '1', 21:20:05 INFO - 'TERM': 'linux', 21:20:05 INFO - 'TMOUT': '86400', 21:20:05 INFO - 'USER': 'cltbld', 21:20:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:05 INFO - '_': '/tools/buildbot/bin/python'} 21:20:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:05 INFO - Downloading/unpacking blobuploader==1.2.4 21:20:05 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 21:20:05 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 21:20:05 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 21:20:05 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 21:20:05 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 21:20:05 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 21:20:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:20:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:20:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 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 21:20:07 INFO - Downloading docopt-0.6.1.tar.gz 21:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:20:07 INFO - Installing collected packages: blobuploader, requests, docopt 21:20:07 INFO - Running setup.py install for blobuploader 21:20:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:20:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:20:08 INFO - Running setup.py install for requests 21:20:08 INFO - Running setup.py install for docopt 21:20:08 INFO - Successfully installed blobuploader requests docopt 21:20:08 INFO - Cleaning up... 21:20:08 INFO - Return code: 0 21:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20: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')]} 21:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20: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')]} 21:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:08 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:08 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 21:20:08 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 21:20:08 INFO - Using env: {'DISPLAY': ':0', 21:20:08 INFO - 'HOME': '/home/cltbld', 21:20:08 INFO - 'LANG': 'en_US.UTF-8', 21:20:08 INFO - 'LANGUAGE': 'en_US:en', 21:20:08 INFO - 'LOGNAME': 'cltbld', 21:20:08 INFO - 'MAIL': '/var/mail/cltbld', 21:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:08 INFO - 'MOZ_NO_REMOTE': '1', 21:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:08 INFO - 'NO_EM_RESTART': '1', 21:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:08 INFO - 'PWD': '/builds/slave/test', 21:20:08 INFO - 'SHELL': '/bin/bash', 21:20:08 INFO - 'SHLVL': '1', 21:20:08 INFO - 'TERM': 'linux', 21:20:08 INFO - 'TMOUT': '86400', 21:20:08 INFO - 'USER': 'cltbld', 21:20:08 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:08 INFO - '_': '/tools/buildbot/bin/python'} 21:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:20:08 INFO - Running setup.py (path:/tmp/pip-3o3KY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:20:08 INFO - Running setup.py (path:/tmp/pip-CqzEKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:20:08 INFO - Running setup.py (path:/tmp/pip-4Tkwly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:20:09 INFO - Running setup.py (path:/tmp/pip-du5FjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:20:09 INFO - Running setup.py (path:/tmp/pip-amw8SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:20:09 INFO - Running setup.py (path:/tmp/pip-S0JJCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:20:09 INFO - Running setup.py (path:/tmp/pip-CtmMqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:20:09 INFO - Running setup.py (path:/tmp/pip-10qGfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:20:09 INFO - Running setup.py (path:/tmp/pip-CITLXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:20:09 INFO - Running setup.py (path:/tmp/pip-KLMxxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:20:09 INFO - Running setup.py (path:/tmp/pip-dlHWT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:20:09 INFO - Running setup.py (path:/tmp/pip-4VdmQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:20:09 INFO - Running setup.py (path:/tmp/pip-rsOWdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:20:09 INFO - Running setup.py (path:/tmp/pip-Z063gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:09 INFO - Running setup.py (path:/tmp/pip-SRqLjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:20:09 INFO - Running setup.py (path:/tmp/pip-49sUxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:20:09 INFO - Running setup.py (path:/tmp/pip-NAHjyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:20:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:20:09 INFO - Running setup.py install for manifestparser 21:20:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Running setup.py install for mozcrash 21:20:10 INFO - Running setup.py install for mozdebug 21:20:10 INFO - Running setup.py install for mozdevice 21:20:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Running setup.py install for mozfile 21:20:10 INFO - Running setup.py install for mozhttpd 21:20:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Running setup.py install for mozinfo 21:20:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Running setup.py install for mozInstall 21:20:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:20:10 INFO - Running setup.py install for mozleak 21:20:10 INFO - Running setup.py install for mozlog 21:20:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:20:11 INFO - Running setup.py install for moznetwork 21:20:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:20:11 INFO - Running setup.py install for mozprocess 21:20:11 INFO - Running setup.py install for mozprofile 21:20:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:20:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:20:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:20:11 INFO - Running setup.py install for mozrunner 21:20:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:20:11 INFO - Running setup.py install for mozscreenshot 21:20:11 INFO - Running setup.py install for moztest 21:20:11 INFO - Running setup.py install for mozversion 21:20:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:20:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:20:11 INFO - Cleaning up... 21:20:11 INFO - Return code: 0 21:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20:11 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')]} 21:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:11 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')]} 21:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:11 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:11 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 21:20:11 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 21:20:11 INFO - Using env: {'DISPLAY': ':0', 21:20:11 INFO - 'HOME': '/home/cltbld', 21:20:11 INFO - 'LANG': 'en_US.UTF-8', 21:20:11 INFO - 'LANGUAGE': 'en_US:en', 21:20:11 INFO - 'LOGNAME': 'cltbld', 21:20:11 INFO - 'MAIL': '/var/mail/cltbld', 21:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:11 INFO - 'MOZ_NO_REMOTE': '1', 21:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:11 INFO - 'NO_EM_RESTART': '1', 21:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:11 INFO - 'PWD': '/builds/slave/test', 21:20:11 INFO - 'SHELL': '/bin/bash', 21:20:11 INFO - 'SHLVL': '1', 21:20:11 INFO - 'TERM': 'linux', 21:20:11 INFO - 'TMOUT': '86400', 21:20:11 INFO - 'USER': 'cltbld', 21:20:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:11 INFO - '_': '/tools/buildbot/bin/python'} 21:20:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:20:11 INFO - Running setup.py (path:/tmp/pip-OERZCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:20:12 INFO - Running setup.py (path:/tmp/pip-cymErA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:20:12 INFO - Running setup.py (path:/tmp/pip-ueOpLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:20:12 INFO - Running setup.py (path:/tmp/pip-NmNihp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:20:12 INFO - Running setup.py (path:/tmp/pip-ftQ5Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:20:12 INFO - Running setup.py (path:/tmp/pip-ur92G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:20:12 INFO - Running setup.py (path:/tmp/pip-X0JoTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:20:12 INFO - Running setup.py (path:/tmp/pip-BAqnCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:20:12 INFO - Running setup.py (path:/tmp/pip-Bbnlbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:20:12 INFO - Running setup.py (path:/tmp/pip-zax6j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:20:12 INFO - Running setup.py (path:/tmp/pip-hYyMCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:20:12 INFO - Running setup.py (path:/tmp/pip-MZ2R90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:20:12 INFO - Running setup.py (path:/tmp/pip-Mjltv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:20:12 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)) 21:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:20:12 INFO - Running setup.py (path:/tmp/pip-gHx0JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:20:13 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)) 21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:13 INFO - Running setup.py (path:/tmp/pip-waL45C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:20:13 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)) 21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:20:13 INFO - Running setup.py (path:/tmp/pip-KVTdHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:20:13 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)) 21:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:20:13 INFO - Running setup.py (path:/tmp/pip-QkFRNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:20:13 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)) 21:20:13 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)) 21:20:13 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)) 21:20:13 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)) 21:20:13 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)) 21:20:13 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)) 21:20:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:20:13 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 21:20:13 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 21:20:13 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 21:20:13 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 21:20:13 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 21:20:13 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 21:20:15 INFO - Downloading blessings-1.6.tar.gz 21:20:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:20:15 INFO - Installing collected packages: blessings 21:20:15 INFO - Running setup.py install for blessings 21:20:15 INFO - Successfully installed blessings 21:20:15 INFO - Cleaning up... 21:20:15 INFO - Return code: 0 21:20:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:20:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:15 INFO - Reading from file tmpfile_stdout 21:20:15 INFO - Current package versions: 21:20:15 INFO - argparse == 1.2.1 21:20:15 INFO - blessings == 1.6 21:20:15 INFO - blobuploader == 1.2.4 21:20:15 INFO - docopt == 0.6.1 21:20:15 INFO - manifestparser == 1.1 21:20:15 INFO - mozInstall == 1.12 21:20:15 INFO - mozcrash == 0.17 21:20:15 INFO - mozdebug == 0.1 21:20:15 INFO - mozdevice == 0.48 21:20:15 INFO - mozfile == 1.2 21:20:15 INFO - mozhttpd == 0.7 21:20:15 INFO - mozinfo == 0.9 21:20:15 INFO - mozleak == 0.1 21:20:15 INFO - mozlog == 3.1 21:20:15 INFO - moznetwork == 0.27 21:20:15 INFO - mozprocess == 0.22 21:20:15 INFO - mozprofile == 0.28 21:20:15 INFO - mozrunner == 6.11 21:20:15 INFO - mozscreenshot == 0.1 21:20:15 INFO - mozsystemmonitor == 0.0 21:20:15 INFO - moztest == 0.7 21:20:15 INFO - mozversion == 1.4 21:20:15 INFO - psutil == 3.1.1 21:20:15 INFO - requests == 1.2.3 21:20:15 INFO - wsgiref == 0.1.2 21:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:15 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 21:20:15 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 21:20:15 INFO - Using env: {'DISPLAY': ':0', 21:20:15 INFO - 'HOME': '/home/cltbld', 21:20:15 INFO - 'LANG': 'en_US.UTF-8', 21:20:15 INFO - 'LANGUAGE': 'en_US:en', 21:20:15 INFO - 'LOGNAME': 'cltbld', 21:20:15 INFO - 'MAIL': '/var/mail/cltbld', 21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:15 INFO - 'MOZ_NO_REMOTE': '1', 21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:15 INFO - 'NO_EM_RESTART': '1', 21:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:15 INFO - 'PWD': '/builds/slave/test', 21:20:15 INFO - 'SHELL': '/bin/bash', 21:20:15 INFO - 'SHLVL': '1', 21:20:15 INFO - 'TERM': 'linux', 21:20:15 INFO - 'TMOUT': '86400', 21:20:15 INFO - 'USER': 'cltbld', 21:20:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:15 INFO - '_': '/tools/buildbot/bin/python'} 21:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 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)) 21:20:15 INFO - Cleaning up... 21:20:15 INFO - Return code: 0 21:20:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:15 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:15 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 21:20:15 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 21:20:15 INFO - Using env: {'DISPLAY': ':0', 21:20:15 INFO - 'HOME': '/home/cltbld', 21:20:15 INFO - 'LANG': 'en_US.UTF-8', 21:20:15 INFO - 'LANGUAGE': 'en_US:en', 21:20:15 INFO - 'LOGNAME': 'cltbld', 21:20:15 INFO - 'MAIL': '/var/mail/cltbld', 21:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:15 INFO - 'MOZ_NO_REMOTE': '1', 21:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:15 INFO - 'NO_EM_RESTART': '1', 21:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:15 INFO - 'PWD': '/builds/slave/test', 21:20:15 INFO - 'SHELL': '/bin/bash', 21:20:15 INFO - 'SHLVL': '1', 21:20:15 INFO - 'TERM': 'linux', 21:20:15 INFO - 'TMOUT': '86400', 21:20:15 INFO - 'USER': 'cltbld', 21:20:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:15 INFO - '_': '/tools/buildbot/bin/python'} 21:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:15 INFO - Downloading/unpacking jsonschema 21:20:15 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 21:20:15 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 21:20:15 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 21:20:15 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 21:20:15 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 21:20:15 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 21:20:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:20:17 INFO - Downloading/unpacking functools32 (from jsonschema) 21:20:17 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 21:20:17 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 21:20:17 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 21:20:17 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 21:20:17 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 21:20:17 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 21:20:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:20:18 INFO - warning: no files found matching '*.txt' 21:20:18 INFO - no previously-included directories found matching 'build' 21:20:18 INFO - no previously-included directories found matching 'dist' 21:20:18 INFO - no previously-included directories found matching '.git*' 21:20:18 INFO - Installing collected packages: jsonschema, functools32 21:20:18 INFO - Running setup.py install for functools32 21:20:18 INFO - warning: no files found matching '*.txt' 21:20:18 INFO - no previously-included directories found matching 'build' 21:20:18 INFO - no previously-included directories found matching 'dist' 21:20:18 INFO - no previously-included directories found matching '.git*' 21:20:18 INFO - Successfully installed jsonschema functools32 21:20:18 INFO - Cleaning up... 21:20:18 INFO - Return code: 0 21:20:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:20:18 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 0x7ff93a51ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13cc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, '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': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', '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 21:20:18 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 21:20:18 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 21:20:18 INFO - Using env: {'DISPLAY': ':0', 21:20:18 INFO - 'HOME': '/home/cltbld', 21:20:18 INFO - 'LANG': 'en_US.UTF-8', 21:20:18 INFO - 'LANGUAGE': 'en_US:en', 21:20:18 INFO - 'LOGNAME': 'cltbld', 21:20:18 INFO - 'MAIL': '/var/mail/cltbld', 21:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:18 INFO - 'MOZ_NO_REMOTE': '1', 21:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:18 INFO - 'NO_EM_RESTART': '1', 21:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:18 INFO - 'PWD': '/builds/slave/test', 21:20:18 INFO - 'SHELL': '/bin/bash', 21:20:18 INFO - 'SHLVL': '1', 21:20:18 INFO - 'TERM': 'linux', 21:20:18 INFO - 'TMOUT': '86400', 21:20:18 INFO - 'USER': 'cltbld', 21:20:18 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:18 INFO - '_': '/tools/buildbot/bin/python'} 21:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:20:18 INFO - Downloading/unpacking flake8 21:20:18 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 21:20:18 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 21:20:18 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 21:20:18 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 21:20:18 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 21:20:18 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 21:20:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:20:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:20:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:20 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 21:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:20:21 INFO - no previously-included directories found matching 'docs/_build' 21:20:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:20:21 INFO - Running setup.py install for pep8 21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:20:21 INFO - no previously-included directories found matching 'docs/_build' 21:20:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:20:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:20:21 INFO - Cleaning up... 21:20:21 INFO - Return code: 0 21:20:21 INFO - Running post-action listener: _resource_record_post_action 21:20:21 INFO - Running post-action listener: _start_resource_monitoring 21:20:21 INFO - Starting resource monitoring. 21:20:21 INFO - ##### 21:20:21 INFO - ##### Running install step. 21:20:21 INFO - ##### 21:20:21 INFO - Running pre-action listener: _resource_record_pre_action 21:20:21 INFO - Running main action method: install 21:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:20:21 INFO - Reading from file tmpfile_stdout 21:20:21 INFO - Detecting whether we're running mozinstall >=1.0... 21:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:20:21 INFO - Reading from file tmpfile_stdout 21:20:21 INFO - Output received: 21:20:21 INFO - Usage: mozinstall [options] installer 21:20:21 INFO - Options: 21:20:21 INFO - -h, --help show this help message and exit 21:20:21 INFO - -d DEST, --destination=DEST 21:20:21 INFO - Directory to install application into. [default: 21:20:21 INFO - "/builds/slave/test"] 21:20:21 INFO - --app=APP Application being installed. [default: firefox] 21:20:21 INFO - mkdir: /builds/slave/test/build/application 21:20:21 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'] 21:20:21 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 21:20:37 INFO - Reading from file tmpfile_stdout 21:20:37 INFO - Output received: 21:20:37 INFO - /builds/slave/test/build/application/firefox/firefox 21:20:37 INFO - Running post-action listener: _resource_record_post_action 21:20:37 INFO - ##### 21:20:37 INFO - ##### Running run-tests step. 21:20:37 INFO - ##### 21:20:37 INFO - Running pre-action listener: _resource_record_pre_action 21:20:37 INFO - Running main action method: run_tests 21:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:20:37 INFO - Python 2.7.3 21:20:37 INFO - Return code: 0 21:20:37 INFO - grabbing minidump binary from tooltool 21:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:20:37 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 0x145b410>, '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 0x145c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:20:37 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 21:20:37 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 21:20:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:20:37 INFO - Return code: 0 21:20:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:20:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:20:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:20:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:20:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:20:38 INFO - Return code: 0 21:20:38 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/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 21:20:38 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/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 21:20:38 INFO - Using env: {'DISPLAY': ':0', 21:20:38 INFO - 'HOME': '/home/cltbld', 21:20:38 INFO - 'LANG': 'en_US.UTF-8', 21:20:38 INFO - 'LANGUAGE': 'en_US:en', 21:20:38 INFO - 'LOGNAME': 'cltbld', 21:20:38 INFO - 'MAIL': '/var/mail/cltbld', 21:20:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:20:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:20:38 INFO - 'MOZ_NO_REMOTE': '1', 21:20:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:20:38 INFO - 'NO_EM_RESTART': '1', 21:20:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:20:38 INFO - 'PWD': '/builds/slave/test', 21:20:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:20:38 INFO - 'SHELL': '/bin/bash', 21:20:38 INFO - 'SHLVL': '1', 21:20:38 INFO - 'TERM': 'linux', 21:20:38 INFO - 'TMOUT': '86400', 21:20:38 INFO - 'USER': 'cltbld', 21:20:38 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883', 21:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:20:38 INFO - '_': '/tools/buildbot/bin/python'} 21:20:38 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/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 21:20:38 INFO - mozversion application_buildid: 20160425204203 21:20:38 INFO - mozversion application_changeset: f2b20c6eb71dbf7a2884a776251e760e73b8c69b 21:20:38 INFO - mozversion application_display_name: Nightly 21:20:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:20:38 INFO - mozversion application_name: Firefox 21:20:38 INFO - mozversion application_remotingname: firefox 21:20:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:20:38 INFO - mozversion application_vendor: Mozilla 21:20:38 INFO - mozversion application_version: 49.0a1 21:20:38 INFO - mozversion platform_buildid: 20160425204203 21:20:38 INFO - mozversion platform_changeset: f2b20c6eb71dbf7a2884a776251e760e73b8c69b 21:20:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:20:38 INFO - mozversion platform_version: 49.0a1 21:20:38 INFO - using testdate: 1461644438 21:20:38 INFO - actual date: 1461644438 21:20:38 INFO - starting webserver on 'localhost:52549' 21:20:38 INFO - SUITE-START | Running 2 tests 21:20:38 INFO - TEST-START | dromaeo_css 21:20:38 INFO - operating with platform_type : linux_ 21:20:38 INFO - Initialising browser for dromaeo_css test... 21:20:38 INFO - TEST-INFO | started process 9320 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTyuVQ/profile http://localhost:52549/getInfo.html) 21:20:43 INFO - PROCESS | 9320 | __metrics Screen width/height:1600/1200 21:20:43 INFO - PROCESS | 9320 | colorDepth:24 21:20:43 INFO - PROCESS | 9320 | Browser inner width/height: 1024/697 21:20:43 INFO - PROCESS | 9320 | __metrics 21:20:44 ERROR - PROCESS | 9320 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:20:45 INFO - TEST-INFO | 9320: exit 0 21:20:45 INFO - Browser initialized. 21:20:45 INFO - Running cycle 1/1 for dromaeo_css test... 21:20:45 INFO - TEST-INFO | started process 9406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmTyuVQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:20:57 INFO - PROCESS | 9406 | RSS: Main: 155533312 21:20:57 INFO - PROCESS | 9406 | 21:21:48 INFO - PROCESS | 9406 | 1461644508758 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] 21:24:00 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52549/tests/dromaeo/cssquery-ext.html) 21:24:01 INFO - PROCESS | 9406 | RSS: Main: 247427072 21:24:01 INFO - PROCESS | 9406 | 21:27:03 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-ext.html (next: http://localhost:52549/tests/dromaeo/cssquery-jquery.html) 21:27:04 INFO - PROCESS | 9406 | RSS: Main: 236052480 21:27:04 INFO - PROCESS | 9406 | 21:30:06 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52549/tests/dromaeo/cssquery-mootools.html) 21:30:06 INFO - PROCESS | 9406 | RSS: Main: 241004544 21:30:06 INFO - PROCESS | 9406 | 21:33:09 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52549/tests/dromaeo/cssquery-prototype.html) 21:33:09 INFO - PROCESS | 9406 | RSS: Main: 235798528 21:33:09 INFO - PROCESS | 9406 | 21:36:12 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52549/tests/dromaeo/cssquery-yui.html) 21:36:13 INFO - PROCESS | 9406 | RSS: Main: 213426176 21:36:13 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:52549/tests/dromaeo/cssquery-yui.html (next: http://localhost:52549/tests/dromaeo/cssquery-dojo.html) 21:39:16 INFO - PROCESS | 9406 | RSS: Main: 280621056 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | __start_tp_report 21:39:16 INFO - PROCESS | 9406 | _x_x_mozilla_page_load 21:39:16 INFO - PROCESS | 9406 | _x_x_mozilla_page_load_details 21:39:16 INFO - PROCESS | 9406 | |i|pagename|runs| 21:39:16 INFO - PROCESS | 9406 | |0;dojo.html;2576.4847030593883;2645.8941642334307;2648.417348183399;2670.4659068186365;2687.744664256895;4542.091581683669;4616.12293664204;4628.490866004741;4656;4656.534346565341;4637.559431853977;4652.906941861161;4695.506971767966;4720.622350211984;4732.1245569569655;4229.513605935326;4237.4703162104815;4270.316749320109;4296.656267498593;4392.758398288093;4310.827566897336;4338.826446942118;4350.042990542076;4366.366876802862;4399.142167277382;4158.6673066154635;4189.07840275139;4246.8725938221905;4247.256730072256;4271.743695378287;4202.85290014851;4259.91480170398;4262.850800221977;4309.82760689572;4330.112326972963;4204.705670603059;4247.575242475758;4255.1915136124035;4261.105167914741;4306.935395969063;4414.933775993362;4461.0854774771415;4489.1919454498175;4525.140223357585;4577.610903073243;4992.276119962585;5013.623978201613;5017.347744793154;5021.372328458942;5068.543831055186;5021.497850214986;5040.722760248185;5044.697318160922;5048.29323894655;5060.089183946925;4431.645468362523;4658.627309815274;4688.5545873142;4708.693934894221;4751.548602882721;5068.4424713281505;5069.44236134025;5085.6948583084395;5127.820526281562;5146.022255771391;4868.148074087091;4886.65793394459;4890;4894.608431325485;4935.259711043373;4751.619870410359;4915.188993816052;4929.383827021622;4947.802087916515;5015.448300686921;4886.242632391985;4911.068624172008;4913.950860491421;4919.877003074952;4943.382077240345;4902.730349830794;4905.411350637875;4910.083349563767;4914.778834952435;4931.211006239057;4111.424400583921;4189.790510474464;4191.266528357525;4195.139996300751;4288.485381754147;3667.541557305337;3692.4461330800596;3703.777773333609;3722.6277372262557;3751.1934933989323;4315.762633055149;4316.525182229952;4316.956830431718;4353.564643535621;4364.323529852878;5014.047331007097;5027.271045698353;5035.320231768737;5036.395632524121;5084.313617661643;4125.91748165035;4210.263203939298;4265.125649241898;4290.957090429119;4300.247456695066;4541.091781643619;4541.8183272669385;4546.931796023062;4572.702774319659;4583.977080114578;4711.586524042842;4717.976410117996;4719.551642593948;4720.339152518582;4729.834455794031;4755.310479980452;4867.3915760529935;5000.1749711297225;5008.774605142705;5027.69833809958;4648.418947631546;4660.394148760775;4664.813407463799;4673.976630116827;4711.316859055486;4888.266759986031;4899.240617704261;4900.14247506692;4906.362172917497;4943.011397720398;4732.905341893212;4901.975490122527;4963.131451995814;4974.751262436791;5002.349694539686;4816.735079570657;4837.927431088466;4844.854654360375;4864.635152363658;4883.90232195347;4792.2332426811545;4821.325014498043;4830.4444988826735;4832;4880.048390563806;4504.054148628694;4747.762611869462;4758.095961767253;4844.612431005582;4867.756612169448;4805.831795887128;4809.615230781599;4816.783244753924;4824.903501930012;4828.058528586892;4739.905201896012;4745.549172828576;4747.548982846624;4781.258904869751;4787.257975013878 21:39:16 INFO - PROCESS | 9406 | |1;ext.html;583.9838680695589;603.7343568829715;605.4278706622242;622.5828694774502;624.4972796898501;26657.866710666443;33367.49948750767;33929.49105763409;34364.31271374574;34450;39141.41287880684;39787;39884.80057599715;39897.202055958864;39999;7609.162992070882;7807.648655810473;7815.882761758549;7816.140224575292;7817;7695.653695583685;7805.804854878616;7829.373650108007;7831.138574756772;7831.843363132734;7820.100688420819;7832.373410127205;7889.211078892123;7897.368210543143;7897.605119744018;7754.340881025119;7836;7837;7837.647305871221;7841.96079019607;7621.3902887768845;7729.497582657109;7742.729004484816;7743.264389882952;7748.418868584822;35835;36239.4564081539;36391.81804090989;36406.81796591027;36559.63440365589;3011.6687164411896;3143.984280078585;3191.2341038150676;3438.6045604755523;3733.9813300933592;27596.172114836587;27942;28160.577591336147;28264.858675706695;28753.71246287531;3490.336836001152;3524.1894364296354;3530.699890509284;3552.0587044433246;3638.909027274313;224626.99999999837;224709;226960;227187;228239;49541.50458495441;50409;50516;50591;50614.697750690866;48986;50391.49608503941;50455;50469;50479;13288.601341959757;13445.32773361328;13463;13470.595882123553;13478.056536042579;10786.622468213574;10879.075278601249;10895.019448249695;10900.07349375312;10900.563977440972;17751.11244437773;17831.554211144827;17959.910200448914;17983.73024404635;18603.162857671436;6698.63157526331;6861.656917154122;6952.93047069533;7058.71765129389;7308.707651693979;847.4025811802665;887.8401887660283;896.3232759266842;989.1938070472542;1019.7909428567126;24532.50934981326;24865.129720459696;25067.37331566689;25086.247412577653;25092.372690682878;962.5139304651246;987.8024395121005;1006.436395618456;1030.5227714696364;1071.0253669161182;13615.251161186032;13929.791053134211;14059.437622494986;14175.71648567023;14272.85727142736;312993;314264;318249;318498;319105;45793.5420645796;46574;46577.30134047992;46600.5339946603;46635.30047049297;1059.586761163147;1204.8132539456399;1266.5630357526638;1272.3574594829552;1286.5111257722006;25079.49841003206;27067.864660676572;27208.72791272062;27463.588046178924;27665.446691066467;39920.60079399169;40791.59208407878;40884.18231635291;40939.59060409358;40952.79523602363;220755;221240;221416;221658;222307;21239.256626018014;22564.097436102373;23169.652455213523;23204.76795232026;24051;35217.295654086265;35588.110297242776;35612.28775424529;35625.287494250486;36328.09179770527;30646.233844154074;32698.673013269563;33440;33650.83174584111;33722;30418.695813042472;33274.667253327156;33472.66527334793;33792.15519611931;34023.65976340304;32921.34157316793;33495.33009339751;33660;33744.83127584346;33760;28795.712042879302;29897.850510747307;29968.700312997462;30355.2411189722;30370.54444183295;23400.414989625395;23566.130718303277;23808.642870356613;23932.28203153908;24008.87995560011 21:39:16 INFO - PROCESS | 9406 | |2;jquery.html;381.7270651484189;383.84262452394523;383.99232015359695;386.87813338798276;395.70915377197775;15480.458183963563;16434.096124713134;16528.75206871898;16553.91723041383;16728.163591820423;16039;16417.91791041043;17059.744103838453;17071.48785536433;17077.91461042693;5022.522860328263;5222.007818514489;5243.659162154467;5251.133562962125;5256.027634887539;3620.275944811035;5693.402192769761;6000.18997435345;6015.6992150392525;6021.578489505737;5863.237779088712;5949.5537834662355;5955.464008239258;5962.34414214436;5964.105384192362;5817.796377126801;5963.761449542057;6004.249468816398;6009.158717779536;6012.128241404994;3337.7997320160866;3524.84138213781;3526.453399723047;3528.541289632357;5050.696958182521;19590.902045489824;19596.118174682175;19648.80351196484;20073.096710648057;20804.16783328665;1904.9142788574409;1983.7421135252469;2022.8179463848178;2067.400453868376;2616.7906567474556;8751.649934002633;9049.78280321319;9406.858897116548;11281.461671123932;13041.08712390133;1666.9166541672869;1768.6109056007786;1797.604527004057;1806.9277228910828;1841.686913224755;57943.42056579422;59645.701771490865;59873;59929.99999999956;60753;9780.364276322016;9853.852192217122;9916.900830991597;9979.852316983495;10023.949880250699;13986.230757308242;14280.285985700673;14288.071275367276;14293.928530357281;14312.427502899767;7362.190159082496;7366;7443.590602516913;7539.547627142389;7566;6904.585724856524;6924.4114250289285;6941.201761797458;7072.823179420556;7124.323189297009;4406.669499787465;4410;4430.246858034077;4492.427650322361;4534.161180181677;1721.4491362763795;1743.744503957149;1831.1759708131394;1837.1916356802965;1854;842.9494230346199;843.3084870406208;880.903100658927;886.2156991062827;965.6330594374093;15345.232738363036;15515.456959006606;15973.440929567409;16107.114108724132;16160.595985100466;795.0221227889613;844.6663567890648;847.2290215903498;859.4155973937658;864.2481041493941;9134.451932884049;9552;9593.856092158623;9619.18236949853;9647.602254948193;349437;358129;363865;366989;368225;78025;79159.20840791633;79489.60255198687;80029.59985200036;82518;929.6002718830832;957.9856302155334;979.9657012004545;987.3187500624546;993.0119531066634;14147.64630884236;14477.276136193359;14880.107193568421;15982.120983346027;16212.189390530662;35320.47019294764;35426.82286588551;36185.45721814228;36602.63397366099;37004.25991480209;45266.32100518561;46754.25965922786;46969.29546056744;47157;47275.290870637655;7815.25755053269;7969.481983671043;7999.280064794197;8032.718854840053;8102.716404925799;10852.565897364017;11186.440677966231;11241.49413276388;11488.79367666383;12053.638390847938;10286.691399258034;10549.472526373496;10571.101456376295;10830.241883068109;11248.606298779503;10360.378377297386;10365.84451233217;10624.84062739044;10675.359478431319;10853.294535855144;5633.0705433604635;6834.829129271609;10760.332148516993;10885.23803333759;11148.442577871236;7771.222877712184;7963.16386779403;8110.580648386626;8130.6573786687995;8279.668813247403;8238;10038.19694424459;11002.50488728025;11048.281861678965;11055.557777688802 21:39:16 INFO - PROCESS | 9406 | |3;mootools.html;1196.1088988703407;1290.2129700882463;1399.9370028348724;1436.3033928544653;1816.3098022751353;6161.414665606766;7047.224805271422;7192.352688258055;7200.96399518003;7202.819929501758;6857.554258973163;7011.929880701192;7019.192792828826;7019.227884932666;7026.85946281074;1833.5599456130567;2101.2015434135005;2159.3306075116684;2182.432567532437;2186.4752459409788;2202.548477562104;2233.6426171812514;2234.1398561553838;2238.4851484158653;2242.495438526335;2143.839212059094;2195.034184958613;2196.9450763730956;2196.9780302197014;2198.0658220256405;1833.8441232495254;2130.1053557505884;2184.224600266898;2188;2188.518525924294;2147.957040859174;2160.2547121243147;2169.967450488244;2170.533335332895;2207.7792220777956;7401.888971665429;7527.059117610299;7578.772636820849;7585.658645360972;7603.353714934237;4357.912841743179;4575.816967321303;4578.221702310615;4579;4581.060882519076;2832.9433411331656;2835.248659105339;2878.0070875548113;2887.220450478359;2893.652761668613;924.4129977464358;937.1331518345503;942.3074040580168;958.0515289863055;968.099667309402;10206.387616742944;10225.386476811414;10246.38521688701;10248.538815753309;10262.281640285182;4153.7300075494995;4196.118815048874;4291.957080429156;4296.183725092223;4308.6983911126545;8719.215270625675;8768.430052046597;8788.692395766118;8804.251638610789;8807.779805504786;3761.7366784324836;4552.795124219418;4638.466576343763;4656.976715116402;4660.300954856731;4037.1723796621623;4137.91724165521;4149.688773342012;4151.4395556600075;4152.937705934413;3454.758166928291;3472.722182225416;3590.1024743814046;3610.9638903611153;3618.0412190769466;1162.215504534436;1170.7482891178438;1176.758764453285;1177.370106992772;1182.8876256755595;823.7693445835175;839;846.8729690546468;861.2335021830576;861.9957749222211;4893.804247830119;5088.084144853962;5149.76826042829;5165.199394093921;5185.0148471790235;401.5201833808571;414.9688773342011;423.18536816628483;436.5699785711072;445.62567443347746;3336.899893003214;3395.6264810870784;3455.188030812757;3475.42655461851;3495.4232551629207;8462.61918213682;8757.824843503222;8771.122887711177;8793.296536277083;8865.778355541162;8674.175953284428;8754.649814007496;8758.781030474162;8772.956135219283;8797.736067917973;6677.966610166918;6759.290274521104;6799.286074962058;6807.761728339583;6816.113905192393;4854.126257273725;4942.382202224722;4982.7259500727805;5131.974340128276;5179.326687530597;8265.421420500506;8325.666973321;8327;8387.874181887399;8445.239928406472;8132.942717446694;8433.83132337362;8459.06950235486;8655.82688346217;8660.653573856975;5602.075657516627;6299.716512757029;6314.179156709598;6464.7393758216695;6590.538662293785;7242.420606351585;7244.927550724636;7299.963500182465;7313.049303590499;7333.6699848508015;6365.681715914093;6568.343165683585;6568.8357791055605;6666.066750654815;6670.199576050905;6029.577929545065;6480.481561475165;6515.478761699147;6595.307492713388;6644.800655980328;6011.489023432882;6070.726817293321;6089.421504957022;6090.9390906090375;6092.299385570716;4180.707350485437;4364.148990946735;4385.079133382025;4446.021875187454;4476.888077797951;4327.459067616548;4399.362092496634;4408.470983482002;4434.423524941737;4477.261251893401 21:39:16 INFO - PROCESS | 9406 | |4;prototype.html;283.8297021786927;301.50101581881984;303.59015329305424;305.0710586264824;305.1151660185462;4485.618722408599;4620.676552641316;4634.397528321313;4716;4718.952810471894;4498.415206023221;4601.217792975194;4635.559621835929;4638.072385522892;4641.396618439607;3686.447032945053;3708.83310251038;3720.7581507202012;3729.3100776356323;3740.700743940492;3524.990755269497;3554.7689400188906;3704.259148170363;3740.831662575191;3744.6255374462608;3696.1683621185152;3705.6294370562864;3707.499487569184;3709.202521457886;3710.810621733177;3661.853525858976;3687.3178461984617;3693.319539609471;3697.7041836653;3707.4253490708984;3293.2919422324076;3298.4887342461716;3303.438415469376;3314.005798260512;3315.635280119185;4288.078063216423;4497.123061003105;4529.660275479319;4554.134714404253;4554.316852472122;4152.356384760367;4160.438340824011;4163.458750362433;4176.373543968399;4204.11713540157;4898.730569818694;4905.2642103684375;4908.558229759339;4932.284818701268;4937.802487900515;3308.652591477884;3505.8948231553095;3517.296540691872;3526.1008442847165;3532.6114127445962;5073.162928116856;5093.5415812576675;5120.871978200537;5136.563392111675;5138.897222055575;3553.4136867416587;3567.108222944264;3573.1960308930284;3582.7671201371827;3589.4615807628543;3623.6195199503672;3634.9636503635156;3635.2002559436883;3636.8363423646;3655.415133578668;3918.1771827916455;4158.272302347077;4160;4170.791460426966;4177.227212965611;4892.241702536113;4934.185859333242;4943.24514797249;4944.159492886218;4945.082401383202;1240.9131360804656;1250.8624051354343;1316.776148054833;1324.569514907659;1334.6863487080527;879.5909901895521;884.920357167845;901.7430032440855;905.9909400905907;906.7597086771879;4572.634189264851;4577.244754615451;4578.97710511452;4582;4590.655700822452;5310.336207974004;5316.707581083;5327.866803329948;5345.118055520873;5345.198220266913;4469.904873305995;4576;4596.770161491912;4600.539946005372;4620.353150558924;2836.6170566973196;2856.8428736419282;2865.3409715765074;2869.8421586812924;2871.3682989742224;5000.499950004971;5011.298418221452;5037.722925239073;5040.067587496325;5045.142325804622;5311.442298558673;5444.809431669952;5478.726063696879;5485.972570137204;5491.807786727445;5006.3992320921725;5022.146235140035;5037.19404895215;5039.193729003342;5050.292958985745;5361.490658387447;5361.758720857492;5370.845268267341;5371.946280537145;5382.111951528111;5033.446320904624;5219.451957544555;5237.895242095213;5258.89482210346;5260.158374660036;5030.496950304941;5035.5468007878;5050.141475949171;5074.5686616637995;5077.568406685473;3775.11284848055;3780.0549862534367;3780.2250538640064;3787.3182827091387;3792.1088544192644;4784.569388755029;5218.504242096995;5343.091674415281;5351.1973204019705;5372.952274306473;4743.193657078236;4849.393825771778;4904.449686163104;4924.187509060965;4943.802247910044;4881.755912204305;4897.730624815526;4905.852824415273;4934.100371356982;4940.8764780880765;4637.310359991265;4861.732604706775;4869.902601947871;4880.341153944314;4885.95114048855;4993.650444468853;4994.800207991785;5012.4736902626155;5017.473165317735;5038.319826823332;4905.533974272438;4931.901361972812;4946.505349465168;4965.851024469272;4966.261808367042 21:39:16 INFO - PROCESS | 9406 | |5;yui.html;665.7337065173931;708.7909066825284;760.9505382150163;790.2650535002449;792.7463211772235;12093.879061209385;12440.129190956637;12444.688882777946;12480.812787808167;12489.812652810204;11661.708457288572;11895.881041189585;12027.639170824867;12034.097442691811;12042.759144817099;644.0789670770796;779.4504874063786;808.7856717969743;809.9271065604095;814.8818421328904;767.1484652036236;802.8514724775906;805.3838813307824;805.5851236613149;806.31060443321;851.8935133108362;857.9571021448934;858.669412276275;858.909814469481;859.1794835931702;675.6419097878132;692.3664846665296;852.846487632226;853.803625166209;854.1757204297851;512.7513156119279;609.1684850179518;626.9561130720851;627.3851625407127;627.8179327994876;12181.208221465666;12186.329751863645;12194.75610487794;12212.08409369292;12223.388830558526;11690.649280521598;12060.155789094766;12092.697682557919;12468.875311246953;12851.293178875158;9415.05849415053;9808.95095524525;9814.803703925953;9888.307818452711;10004.449755263458;3331;3354.681305275995;3356.9832150839334;3415.043787739437;3421.3328400961823;43746.34380484295;44461;44810.32784508235;44941.32588011182;46299.76850115762;9415.670451534163;9635.614575416905;9646.565904534313;9682.177014953668;9752.609895604097;16231.594210144605;16384.672306553803;16475.58811029734;16549.338026479047;16584.08787516698;6767.593944363354;6771.762988295484;6839.487038472134;6905.1713794345;6999.265077166926;3806.3909774435956;3849.2493963676816;3888.727789054739;3960.0495880988356;4007.479027726435;2812.774978001755;2906.070057581596;2913.038697229909;2913.4901392256693;2918.124562631202;523.7931017248166;533.557147567518;537.1432565058725;540.2544488605699;544.335910189576;528.6748649580558;583.8569550460079;592.1473078766649;621.3413781391739;641.8491654461197;7576.24237576238;7962.7213047543055;8001.319887809602;8258.958705206556;8471.279941204943;594.3669991459083;608.9360617135226;638.5306799502362;640.078287266335;653.1541653558653;3833.8085782960034;3920.3923391874305;4006.278869803405;4071.1247081877536;4132.483439570054;45811.54188458139;46001;47480.52519474761;50167.498325016284;51689.741551292755;40660.18679626391;41028.79485602553;41223.763287101436;46091;46914.29628555574;44216.55783442124;44220.11559768851;44517.332240016425;44937.32594011027;45285;8586.356023298153;8587.871181932402;8658.134186581292;8733.56332183401;8867;28919.855400722863;28987;29709.702902970694;29768.255793605334;30072;35467.645323546436;36976;39395;39621.60378396179;40091.79954100211;10080.495975201356;10103.494825258855;10150;10221.182305415698;10526.263161578616;11407.714807129889;11491.885081149416;12307.56923507673;12339.568115115928;12477.188982716094;10723.678289651323;11312.20814543007;11370.31778093317;11392.601258956229;11742.295462272292;10949.671509854717;11255.606053788078;11449.42752862337;11523.366214858263;11566;11112.611058612909;11338.65935332573;11427.085833133164;11569.19015668895;11588.420578970849;9294.581743821409;9495.620175192915;9560.76098097553;9681.322307438411;9700.514974251118;9430.82114735658;9540.379875308083;9598.616055357708;9618.086281803218;9670.70987870365 21:39:16 INFO - PROCESS | 9406 | __end_tp_report 21:39:16 INFO - PROCESS | 9406 | __start_cc_report 21:39:16 INFO - PROCESS | 9406 | _x_x_mozilla_cycle_collect,937 21:39:16 INFO - PROCESS | 9406 | __end_cc_report 21:39:16 INFO - PROCESS | 9406 | __startTimestamp1461645556566__endTimestamp 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | ------- Summary: start ------- 21:39:16 INFO - PROCESS | 9406 | Number of tests: 6 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | [#0] dojo.html Cycles:165 Average:4591.03 Median:4720.62 stddev:473.39 (10.0%) stddev-sans-first:447.69 21:39:16 INFO - PROCESS | 9406 | Values: 2576.5 2645.9 2648.4 2670.5 2687.7 4542.1 4616.1 4628.5 4656.0 4656.5 4637.6 4652.9 4695.5 4720.6 4732.1 4229.5 4237.5 4270.3 4296.7 4392.8 4310.8 4338.8 4350.0 4366.4 4399.1 4158.7 4189.1 4246.9 4247.3 4271.7 4202.9 4259.9 4262.9 4309.8 4330.1 4204.7 4247.6 4255.2 4261.1 4306.9 4414.9 4461.1 4489.2 4525.1 4577.6 4992.3 5013.6 5017.3 5021.4 5068.5 5021.5 5040.7 5044.7 5048.3 5060.1 4431.6 4658.6 4688.6 4708.7 4751.5 5068.4 5069.4 5085.7 5127.8 5146.0 4868.1 4886.7 4890.0 4894.6 4935.3 4751.6 4915.2 4929.4 4947.8 5015.4 4886.2 4911.1 4914.0 4919.9 4943.4 4902.7 4905.4 4910.1 4914.8 4931.2 4111.4 4189.8 4191.3 4195.1 4288.5 3667.5 3692.4 3703.8 3722.6 3751.2 4315.8 4316.5 4317.0 4353.6 4364.3 5014.0 5027.3 5035.3 5036.4 5084.3 4125.9 4210.3 4265.1 4291.0 4300.2 4541.1 4541.8 4546.9 4572.7 4584.0 4711.6 4718.0 4719.6 4720.3 4729.8 4755.3 4867.4 5000.2 5008.8 5027.7 4648.4 4660.4 4664.8 4674.0 4711.3 4888.3 4899.2 4900.1 4906.4 4943.0 4732.9 4902.0 4963.1 4974.8 5002.3 4816.7 4837.9 4844.9 4864.6 4883.9 4792.2 4821.3 4830.4 4832.0 4880.0 4504.1 4747.8 4758.1 4844.6 4867.8 4805.8 4809.6 4816.8 4824.9 4828.1 4739.9 4745.5 4747.5 4781.3 4787.3 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | [#1] ext.html Cycles:180 Average:40694.75 Median:33752.42 stddev:67607.46 (200.3%) stddev-sans-first:67730.04 21:39:16 INFO - PROCESS | 9406 | Values: 584.0 603.7 605.4 622.6 624.5 26657.9 33367.5 33929.5 34364.3 34450.0 39141.4 39787.0 39884.8 39897.2 39999.0 7609.2 7807.6 7815.9 7816.1 7817.0 7695.7 7805.8 7829.4 7831.1 7831.8 7820.1 7832.4 7889.2 7897.4 7897.6 7754.3 7836.0 7837.0 7837.6 7842.0 7621.4 7729.5 7742.7 7743.3 7748.4 35835.0 36239.5 36391.8 36406.8 36559.6 3011.7 3144.0 3191.2 3438.6 3734.0 27596.2 27942.0 28160.6 28264.9 28753.7 3490.3 3524.2 3530.7 3552.1 3638.9 224627.0 224709.0 226960.0 227187.0 228239.0 49541.5 50409.0 50516.0 50591.0 50614.7 48986.0 50391.5 50455.0 50469.0 50479.0 13288.6 13445.3 13463.0 13470.6 13478.1 10786.6 10879.1 10895.0 10900.1 10900.6 17751.1 17831.6 17959.9 17983.7 18603.2 6698.6 6861.7 6952.9 7058.7 7308.7 847.4 887.8 896.3 989.2 1019.8 24532.5 24865.1 25067.4 25086.2 25092.4 962.5 987.8 1006.4 1030.5 1071.0 13615.3 13929.8 14059.4 14175.7 14272.9 312993.0 314264.0 318249.0 318498.0 319105.0 45793.5 46574.0 46577.3 46600.5 46635.3 1059.6 1204.8 1266.6 1272.4 1286.5 25079.5 27067.9 27208.7 27463.6 27665.4 39920.6 40791.6 40884.2 40939.6 40952.8 220755.0 221240.0 221416.0 221658.0 222307.0 21239.3 22564.1 23169.7 23204.8 24051.0 35217.3 35588.1 35612.3 35625.3 36328.1 30646.2 32698.7 33440.0 33650.8 33722.0 30418.7 33274.7 33472.7 33792.2 34023.7 32921.3 33495.3 33660.0 33744.8 33760.0 28795.7 29897.9 29968.7 30355.2 30370.5 23400.4 23566.1 23808.6 23932.3 24008.9 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | [#2] jquery.html Cycles:180 Average:23154.95 Median:4408.33 stddev:59703.28 (1354.3%) stddev-sans-first:59846.28 21:39:16 INFO - PROCESS | 9406 | Values: 381.7 383.8 384.0 386.9 395.7 15480.5 16434.1 16528.8 16553.9 16728.2 16039.0 16417.9 17059.7 17071.5 17077.9 5022.5 5222.0 5243.7 5251.1 5256.0 3620.3 5693.4 6000.2 6015.7 6021.6 5863.2 5949.6 5955.5 5962.3 5964.1 5817.8 5963.8 6004.2 6009.2 6012.1 3337.8 3524.8 3526.5 3528.5 5050.7 19590.9 19596.1 19648.8 20073.1 20804.2 1904.9 1983.7 2022.8 2067.4 2616.8 8751.6 9049.8 9406.9 11281.5 13041.1 1666.9 1768.6 1797.6 1806.9 1841.7 57943.4 59645.7 59873.0 59930.0 60753.0 9780.4 9853.9 9916.9 9979.9 10023.9 13986.2 14280.3 14288.1 14293.9 14312.4 7362.2 7366.0 7443.6 7539.5 7566.0 6904.6 6924.4 6941.2 7072.8 7124.3 4406.7 4410.0 4430.2 4492.4 4534.2 1721.4 1743.7 1831.2 1837.2 1854.0 842.9 843.3 880.9 886.2 965.6 15345.2 15515.5 15973.4 16107.1 16160.6 795.0 844.7 847.2 859.4 864.2 9134.5 9552.0 9593.9 9619.2 9647.6 349437.0 358129.0 363865.0 366989.0 368225.0 78025.0 79159.2 79489.6 80029.6 82518.0 929.6 958.0 980.0 987.3 993.0 14147.6 14477.3 14880.1 15982.1 16212.2 35320.5 35426.8 36185.5 36602.6 37004.3 45266.3 46754.3 46969.3 47157.0 47275.3 7815.3 7969.5 7999.3 8032.7 8102.7 10852.6 11186.4 11241.5 11488.8 12053.6 10286.7 10549.5 10571.1 10830.2 11248.6 10360.4 10365.8 10624.8 10675.4 10853.3 5633.1 6834.8 10760.3 10885.2 11148.4 7771.2 7963.2 8110.6 8130.7 8279.7 8238.0 10038.2 11002.5 11048.3 11055.6 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | [#3] mootools.html Cycles:180 Average:4886.58 Median:4873.97 stddev:2680.55 (55.0%) stddev-sans-first:2673.72 21:39:16 INFO - PROCESS | 9406 | Values: 1196.1 1290.2 1399.9 1436.3 1816.3 6161.4 7047.2 7192.4 7201.0 7202.8 6857.6 7011.9 7019.2 7019.2 7026.9 1833.6 2101.2 2159.3 2182.4 2186.5 2202.5 2233.6 2234.1 2238.5 2242.5 2143.8 2195.0 2196.9 2197.0 2198.1 1833.8 2130.1 2184.2 2188.0 2188.5 2148.0 2160.3 2170.0 2170.5 2207.8 7401.9 7527.1 7578.8 7585.7 7603.4 4357.9 4575.8 4578.2 4579.0 4581.1 2832.9 2835.2 2878.0 2887.2 2893.7 924.4 937.1 942.3 958.1 968.1 10206.4 10225.4 10246.4 10248.5 10262.3 4153.7 4196.1 4292.0 4296.2 4308.7 8719.2 8768.4 8788.7 8804.3 8807.8 3761.7 4552.8 4638.5 4657.0 4660.3 4037.2 4137.9 4149.7 4151.4 4152.9 3454.8 3472.7 3590.1 3611.0 3618.0 1162.2 1170.7 1176.8 1177.4 1182.9 823.8 839.0 846.9 861.2 862.0 4893.8 5088.1 5149.8 5165.2 5185.0 401.5 415.0 423.2 436.6 445.6 3336.9 3395.6 3455.2 3475.4 3495.4 8462.6 8757.8 8771.1 8793.3 8865.8 8674.2 8754.6 8758.8 8773.0 8797.7 6678.0 6759.3 6799.3 6807.8 6816.1 4854.1 4942.4 4982.7 5132.0 5179.3 8265.4 8325.7 8327.0 8387.9 8445.2 8132.9 8433.8 8459.1 8655.8 8660.7 5602.1 6299.7 6314.2 6464.7 6590.5 7242.4 7244.9 7300.0 7313.0 7333.7 6365.7 6568.3 6568.8 6666.1 6670.2 6029.6 6480.5 6515.5 6595.3 6644.8 6011.5 6070.7 6089.4 6090.9 6092.3 4180.7 4364.1 4385.1 4446.0 4476.9 4327.5 4399.4 4408.5 4434.4 4477.3 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | [#4] prototype.html Cycles:180 Average:4173.68 Median:4636.43 stddev:1219.17 (26.3%) stddev-sans-first:1187.12 21:39:16 INFO - PROCESS | 9406 | Values: 283.8 301.5 303.6 305.1 305.1 4485.6 4620.7 4634.4 4716.0 4719.0 4498.4 4601.2 4635.6 4638.1 4641.4 3686.4 3708.8 3720.8 3729.3 3740.7 3525.0 3554.8 3704.3 3740.8 3744.6 3696.2 3705.6 3707.5 3709.2 3710.8 3661.9 3687.3 3693.3 3697.7 3707.4 3293.3 3298.5 3303.4 3314.0 3315.6 4288.1 4497.1 4529.7 4554.1 4554.3 4152.4 4160.4 4163.5 4176.4 4204.1 4898.7 4905.3 4908.6 4932.3 4937.8 3308.7 3505.9 3517.3 3526.1 3532.6 5073.2 5093.5 5120.9 5136.6 5138.9 3553.4 3567.1 3573.2 3582.8 3589.5 3623.6 3635.0 3635.2 3636.8 3655.4 3918.2 4158.3 4160.0 4170.8 4177.2 4892.2 4934.2 4943.2 4944.2 4945.1 1240.9 1250.9 1316.8 1324.6 1334.7 879.6 884.9 901.7 906.0 906.8 4572.6 4577.2 4579.0 4582.0 4590.7 5310.3 5316.7 5327.9 5345.1 5345.2 4469.9 4576.0 4596.8 4600.5 4620.4 2836.6 2856.8 2865.3 2869.8 2871.4 5000.5 5011.3 5037.7 5040.1 5045.1 5311.4 5444.8 5478.7 5486.0 5491.8 5006.4 5022.1 5037.2 5039.2 5050.3 5361.5 5361.8 5370.8 5371.9 5382.1 5033.4 5219.5 5237.9 5258.9 5260.2 5030.5 5035.5 5050.1 5074.6 5077.6 3775.1 3780.1 3780.2 3787.3 3792.1 4784.6 5218.5 5343.1 5351.2 5373.0 4743.2 4849.4 4904.4 4924.2 4943.8 4881.8 4897.7 4905.9 4934.1 4940.9 4637.3 4861.7 4869.9 4880.3 4886.0 4993.7 4994.8 5012.5 5017.5 5038.3 4905.5 4931.9 4946.5 4965.9 4966.3 21:39:16 INFO - PROCESS | 9406 | 21:39:16 INFO - PROCESS | 9406 | [#5] yui.html Cycles:180 Average:12577.57 Median:44939.33 stddev:13952.67 (31.0%) stddev-sans-first:13963.13 21:39:16 INFO - PROCESS | 9406 | Values: 665.7 708.8 761.0 790.3 792.7 12093.9 12440.1 12444.7 12480.8 12489.8 11661.7 11895.9 12027.6 12034.1 12042.8 644.1 779.5 808.8 809.9 814.9 767.1 802.9 805.4 805.6 806.3 851.9 858.0 858.7 858.9 859.2 675.6 692.4 852.8 853.8 854.2 512.8 609.2 627.0 627.4 627.8 12181.2 12186.3 12194.8 12212.1 12223.4 11690.6 12060.2 12092.7 12468.9 12851.3 9415.1 9809.0 9814.8 9888.3 10004.4 3331.0 3354.7 3357.0 3415.0 3421.3 43746.3 44461.0 44810.3 44941.3 46299.8 9415.7 9635.6 9646.6 9682.2 9752.6 16231.6 16384.7 16475.6 16549.3 16584.1 6767.6 6771.8 6839.5 6905.2 6999.3 3806.4 3849.2 3888.7 3960.0 4007.5 2812.8 2906.1 2913.0 2913.5 2918.1 523.8 533.6 537.1 540.3 544.3 528.7 583.9 592.1 621.3 641.8 7576.2 7962.7 8001.3 8259.0 8471.3 594.4 608.9 638.5 640.1 653.2 3833.8 3920.4 4006.3 4071.1 4132.5 45811.5 46001.0 47480.5 50167.5 51689.7 40660.2 41028.8 41223.8 46091.0 46914.3 44216.6 44220.1 44517.3 44937.3 45285.0 8586.4 8587.9 8658.1 8733.6 8867.0 28919.9 28987.0 29709.7 29768.3 30072.0 35467.6 36976.0 39395.0 39621.6 40091.8 10080.5 10103.5 10150.0 10221.2 10526.3 11407.7 11491.9 12307.6 12339.6 12477.2 10723.7 11312.2 11370.3 11392.6 11742.3 10949.7 11255.6 11449.4 11523.4 11566.0 11112.6 11338.7 11427.1 11569.2 11588.4 9294.6 9495.6 9560.8 9681.3 9700.5 9430.8 9540.4 9598.6 9618.1 9670.7 21:39:16 INFO - PROCESS | 9406 | -------- Summary: end -------- 21:39:16 INFO - PROCESS | 9406 | 21:39:17 INFO - TEST-INFO | 9406: exit 0 21:39:17 INFO - TEST-OK | dromaeo_css | took 1118763ms 21:39:17 INFO - TEST-START | kraken 21:39:17 INFO - operating with platform_type : linux_ 21:39:17 INFO - Initialising browser for kraken test... 21:39:17 INFO - TEST-INFO | started process 9581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNh3Kab/profile http://localhost:52549/getInfo.html) 21:39:21 INFO - PROCESS | 9581 | __metrics Screen width/height:1600/1200 21:39:21 INFO - PROCESS | 9581 | colorDepth:24 21:39:21 INFO - PROCESS | 9581 | Browser inner width/height: 1024/697 21:39:21 INFO - PROCESS | 9581 | __metrics 21:39:23 ERROR - PROCESS | 9581 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:39:23 INFO - TEST-INFO | 9581: exit 0 21:39:23 INFO - Browser initialized. 21:39:23 INFO - Running cycle 1/1 for kraken test... 21:39:23 INFO - TEST-INFO | started process 9665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNh3Kab/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:39:35 INFO - PROCESS | 9665 | RSS: Main: 156512256 21:39:35 INFO - PROCESS | 9665 | 21:39:38 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-beat-detection) 21:39:39 INFO - PROCESS | 9665 | RSS: Main: 211550208 21:39:39 INFO - PROCESS | 9665 | 21:39:42 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-dft) 21:39:42 INFO - PROCESS | 9665 | RSS: Main: 195354624 21:39:42 INFO - PROCESS | 9665 | 21:39:46 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-fft) 21:39:46 INFO - PROCESS | 9665 | RSS: Main: 268152832 21:39:46 INFO - PROCESS | 9665 | 21:39:48 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52549/tests/kraken/driver.html?testName=audio-oscillator) 21:39:49 INFO - PROCESS | 9665 | RSS: Main: 174776320 21:39:49 INFO - PROCESS | 9665 | 21:39:51 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52549/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:39:52 INFO - PROCESS | 9665 | RSS: Main: 179765248 21:39:52 INFO - PROCESS | 9665 | 21:39:55 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52549/tests/kraken/driver.html?testName=imaging-darkroom) 21:39:56 INFO - PROCESS | 9665 | RSS: Main: 216100864 21:39:56 INFO - PROCESS | 9665 | 21:39:59 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52549/tests/kraken/driver.html?testName=imaging-desaturate) 21:40:00 INFO - PROCESS | 9665 | RSS: Main: 216174592 21:40:00 INFO - PROCESS | 9665 | 21:40:02 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52549/tests/kraken/driver.html?testName=json-parse-financial) 21:40:03 INFO - PROCESS | 9665 | RSS: Main: 217190400 21:40:03 INFO - PROCESS | 9665 | 21:40:05 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52549/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:40:05 INFO - PROCESS | 9665 | RSS: Main: 205131776 21:40:05 INFO - PROCESS | 9665 | 21:40:07 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:40:08 INFO - PROCESS | 9665 | RSS: Main: 206831616 21:40:08 INFO - PROCESS | 9665 | 21:40:10 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:40:11 INFO - PROCESS | 9665 | RSS: Main: 217382912 21:40:11 INFO - PROCESS | 9665 | 21:40:14 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:40:14 INFO - PROCESS | 9665 | RSS: Main: 225337344 21:40:14 INFO - PROCESS | 9665 | 21:40:17 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:40:18 INFO - PROCESS | 9665 | RSS: Main: 220594176 21:40:18 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | Cycle 1(1): loaded http://localhost:52549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52549/tests/kraken/driver.html?testName=ai-astar) 21:40:20 INFO - PROCESS | 9665 | RSS: Main: 284393472 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | __start_tp_report 21:40:20 INFO - PROCESS | 9665 | _x_x_mozilla_page_load 21:40:20 INFO - PROCESS | 9665 | _x_x_mozilla_page_load_details 21:40:20 INFO - PROCESS | 9665 | |i|pagename|runs| 21:40:20 INFO - PROCESS | 9665 | |0;ai-astar;112;113;113;114;114;114;121;112;113;114 21:40:20 INFO - PROCESS | 9665 | |1;audio-beat-detection;154;131;153;198;136;164;158;132;202;134 21:40:20 INFO - PROCESS | 9665 | |2;audio-dft;160;161;160;160;162;163;162;162;160;161 21:40:20 INFO - PROCESS | 9665 | |3;audio-fft;78;75;105;102;75;75;76;115;121;74 21:40:20 INFO - PROCESS | 9665 | |4;audio-oscillator;95;95;141;94;94;94;150;94;93;143 21:40:20 INFO - PROCESS | 9665 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;117;117;116 21:40:20 INFO - PROCESS | 9665 | |6;imaging-darkroom;146;146;146;146;146;147;147;146;146;147 21:40:20 INFO - PROCESS | 9665 | |7;imaging-desaturate;94;95;94;94;95;94;95;95;95;94 21:40:20 INFO - PROCESS | 9665 | |8;json-parse-financial;66;67;67;67;67;68;68;85;66;64 21:40:20 INFO - PROCESS | 9665 | |9;json-stringify-tinderbox;64;64;65;64;65;66;65;65;64;65 21:40:20 INFO - PROCESS | 9665 | |10;stanford-crypto-aes;80;81;82;79;89;81;81;82;82;89 21:40:20 INFO - PROCESS | 9665 | |11;stanford-crypto-ccm;131;136;129;131;145;127;130;133;170;132 21:40:20 INFO - PROCESS | 9665 | |12;stanford-crypto-pbkdf2;180;183;179;184;179;179;181;185;177;183 21:40:20 INFO - PROCESS | 9665 | |13;stanford-crypto-sha256-iterative;73;77;73;74;74;72;82;73;73;73 21:40:20 INFO - PROCESS | 9665 | __end_tp_report 21:40:20 INFO - PROCESS | 9665 | __start_cc_report 21:40:20 INFO - PROCESS | 9665 | _x_x_mozilla_cycle_collect,1894 21:40:20 INFO - PROCESS | 9665 | __end_cc_report 21:40:20 INFO - PROCESS | 9665 | __startTimestamp1461645620359__endTimestamp 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | ------- Summary: start ------- 21:40:20 INFO - PROCESS | 9665 | Number of tests: 14 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:2.58 (2.3%) stddev-sans-first:2.64 21:40:20 INFO - PROCESS | 9665 | Values: 112.0 113.0 113.0 114.0 114.0 114.0 121.0 112.0 113.0 114.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:156.00 stddev:25.92 (16.6%) stddev-sans-first:27.48 21:40:20 INFO - PROCESS | 9665 | Values: 154.0 131.0 153.0 198.0 136.0 164.0 158.0 132.0 202.0 134.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 21:40:20 INFO - PROCESS | 9665 | Values: 160.0 161.0 160.0 160.0 162.0 163.0 162.0 162.0 160.0 161.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#3] audio-fft Cycles:10 Average:89.60 Median:75.00 stddev:18.93 (25.2%) stddev-sans-first:19.61 21:40:20 INFO - PROCESS | 9665 | Values: 78.0 75.0 105.0 102.0 75.0 75.0 76.0 115.0 121.0 74.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:94.00 stddev:24.51 (26.1%) stddev-sans-first:25.45 21:40:20 INFO - PROCESS | 9665 | Values: 95.0 95.0 141.0 94.0 94.0 94.0 150.0 94.0 93.0 143.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:40:20 INFO - PROCESS | 9665 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 21:40:20 INFO - PROCESS | 9665 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 21:40:20 INFO - PROCESS | 9665 | Values: 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#8] json-parse-financial Cycles:10 Average:68.50 Median:67.00 stddev:5.91 (8.8%) stddev-sans-first:6.20 21:40:20 INFO - PROCESS | 9665 | Values: 66.0 67.0 67.0 67.0 67.0 68.0 68.0 85.0 66.0 64.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 21:40:20 INFO - PROCESS | 9665 | Values: 64.0 64.0 65.0 64.0 65.0 66.0 65.0 65.0 64.0 65.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.50 (4.3%) stddev-sans-first:3.59 21:40:20 INFO - PROCESS | 9665 | Values: 80.0 81.0 82.0 79.0 89.0 81.0 81.0 82.0 82.0 89.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:132.50 stddev:12.81 (9.7%) stddev-sans-first:13.44 21:40:20 INFO - PROCESS | 9665 | Values: 131.0 136.0 129.0 131.0 145.0 127.0 130.0 133.0 170.0 132.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:182.00 stddev:2.62 (1.4%) stddev-sans-first:2.76 21:40:20 INFO - PROCESS | 9665 | Values: 180.0 183.0 179.0 184.0 179.0 179.0 181.0 185.0 177.0 183.0 21:40:20 INFO - PROCESS | 9665 | 21:40:20 INFO - PROCESS | 9665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:73.50 stddev:2.99 (4.1%) stddev-sans-first:3.13 21:40:20 INFO - PROCESS | 9665 | Values: 73.0 77.0 73.0 74.0 74.0 72.0 82.0 73.0 73.0 73.0 21:40:20 INFO - PROCESS | 9665 | -------- Summary: end -------- 21:40:20 INFO - PROCESS | 9665 | 21:40:21 INFO - TEST-INFO | 9665: exit 0 21:40:21 INFO - TEST-OK | kraken | took 64101ms 21:40:21 INFO - SUITE-END | took 1182s 21:40:21 INFO - Completed test suite (00:19:42) 21:40:21 INFO - javascript benchmark 21:40:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2576.4847030593883, 2645.8941642334307, 2648.417348183399, 2670.4659068186365, 2687.744664256895, 4542.091581683669, 4616.12293664204, 4628.490866004741, 4656.0, 4656.534346565341, 4637.559431853977, 4652.906941861161, 4695.506971767966, 4720.622350211984, 4732.1245569569655, 4229.513605935326, 4237.4703162104815, 4270.316749320109, 4296.656267498593, 4392.758398288093, 4310.827566897336, 4338.826446942118, 4350.042990542076, 4366.366876802862, 4399.142167277382, 4158.6673066154635, 4189.07840275139, 4246.8725938221905, 4247.256730072256, 4271.743695378287, 4202.85290014851, 4259.91480170398, 4262.850800221977, 4309.82760689572, 4330.112326972963, 4204.705670603059, 4247.575242475758, 4255.1915136124035, 4261.105167914741, 4306.935395969063, 4414.933775993362, 4461.0854774771415, 4489.1919454498175, 4525.140223357585, 4577.610903073243, 4992.276119962585, 5013.623978201613, 5017.347744793154, 5021.372328458942, 5068.543831055186, 5021.497850214986, 5040.722760248185, 5044.697318160922, 5048.29323894655, 5060.089183946925, 4431.645468362523, 4658.627309815274, 4688.5545873142, 4708.693934894221, 4751.548602882721, 5068.4424713281505, 5069.44236134025, 5085.6948583084395, 5127.820526281562, 5146.022255771391, 4868.148074087091, 4886.65793394459, 4890.0, 4894.608431325485, 4935.259711043373, 4751.619870410359, 4915.188993816052, 4929.383827021622, 4947.802087916515, 5015.448300686921, 4886.242632391985, 4911.068624172008, 4913.950860491421, 4919.877003074952, 4943.382077240345, 4902.730349830794, 4905.411350637875, 4910.083349563767, 4914.778834952435, 4931.211006239057, 4111.424400583921, 4189.790510474464, 4191.266528357525, 4195.139996300751, 4288.485381754147, 3667.541557305337, 3692.4461330800596, 3703.777773333609, 3722.6277372262557, 3751.1934933989323, 4315.762633055149, 4316.525182229952, 4316.956830431718, 4353.564643535621, 4364.323529852878, 5014.047331007097, 5027.271045698353, 5035.320231768737, 5036.395632524121, 5084.313617661643, 4125.91748165035, 4210.263203939298, 4265.125649241898, 4290.957090429119, 4300.247456695066, 4541.091781643619, 4541.8183272669385, 4546.931796023062, 4572.702774319659, 4583.977080114578, 4711.586524042842, 4717.976410117996, 4719.551642593948, 4720.339152518582, 4729.834455794031, 4755.310479980452, 4867.3915760529935, 5000.1749711297225, 5008.774605142705, 5027.69833809958, 4648.418947631546, 4660.394148760775, 4664.813407463799, 4673.976630116827, 4711.316859055486, 4888.266759986031, 4899.240617704261, 4900.14247506692, 4906.362172917497, 4943.011397720398, 4732.905341893212, 4901.975490122527, 4963.131451995814, 4974.751262436791, 5002.349694539686, 4816.735079570657, 4837.927431088466, 4844.854654360375, 4864.635152363658, 4883.90232195347, 4792.2332426811545, 4821.325014498043, 4830.4444988826735, 4832.0, 4880.048390563806, 4504.054148628694, 4747.762611869462, 4758.095961767253, 4844.612431005582, 4867.756612169448, 4805.831795887128, 4809.615230781599, 4816.783244753924, 4824.903501930012, 4828.058528586892, 4739.905201896012, 4745.549172828576, 4747.548982846624, 4781.258904869751, 4787.257975013878], "value": 4561.698426562047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9838680695589, 603.7343568829715, 605.4278706622242, 622.5828694774502, 624.4972796898501, 26657.866710666443, 33367.49948750767, 33929.49105763409, 34364.31271374574, 34450.0, 39141.41287880684, 39787.0, 39884.80057599715, 39897.202055958864, 39999.0, 7609.162992070882, 7807.648655810473, 7815.882761758549, 7816.140224575292, 7817.0, 7695.653695583685, 7805.804854878616, 7829.373650108007, 7831.138574756772, 7831.843363132734, 7820.100688420819, 7832.373410127205, 7889.211078892123, 7897.368210543143, 7897.605119744018, 7754.340881025119, 7836.0, 7837.0, 7837.647305871221, 7841.96079019607, 7621.3902887768845, 7729.497582657109, 7742.729004484816, 7743.264389882952, 7748.418868584822, 35835.0, 36239.4564081539, 36391.81804090989, 36406.81796591027, 36559.63440365589, 3011.6687164411896, 3143.984280078585, 3191.2341038150676, 3438.6045604755523, 3733.9813300933592, 27596.172114836587, 27942.0, 28160.577591336147, 28264.858675706695, 28753.71246287531, 3490.336836001152, 3524.1894364296354, 3530.699890509284, 3552.0587044433246, 3638.909027274313, 224626.99999999837, 224709.0, 226960.0, 227187.0, 228239.0, 49541.50458495441, 50409.0, 50516.0, 50591.0, 50614.697750690866, 48986.0, 50391.49608503941, 50455.0, 50469.0, 50479.0, 13288.601341959757, 13445.32773361328, 13463.0, 13470.595882123553, 13478.056536042579, 10786.622468213574, 10879.075278601249, 10895.019448249695, 10900.07349375312, 10900.563977440972, 17751.11244437773, 17831.554211144827, 17959.910200448914, 17983.73024404635, 18603.162857671436, 6698.63157526331, 6861.656917154122, 6952.93047069533, 7058.71765129389, 7308.707651693979, 847.4025811802665, 887.8401887660283, 896.3232759266842, 989.1938070472542, 1019.7909428567126, 24532.50934981326, 24865.129720459696, 25067.37331566689, 25086.247412577653, 25092.372690682878, 962.5139304651246, 987.8024395121005, 1006.436395618456, 1030.5227714696364, 1071.0253669161182, 13615.251161186032, 13929.791053134211, 14059.437622494986, 14175.71648567023, 14272.85727142736, 312993.0, 314264.0, 318249.0, 318498.0, 319105.0, 45793.5420645796, 46574.0, 46577.30134047992, 46600.5339946603, 46635.30047049297, 1059.586761163147, 1204.8132539456399, 1266.5630357526638, 1272.3574594829552, 1286.5111257722006, 25079.49841003206, 27067.864660676572, 27208.72791272062, 27463.588046178924, 27665.446691066467, 39920.60079399169, 40791.59208407878, 40884.18231635291, 40939.59060409358, 40952.79523602363, 220755.0, 221240.0, 221416.0, 221658.0, 222307.0, 21239.256626018014, 22564.097436102373, 23169.652455213523, 23204.76795232026, 24051.0, 35217.295654086265, 35588.110297242776, 35612.28775424529, 35625.287494250486, 36328.09179770527, 30646.233844154074, 32698.673013269563, 33440.0, 33650.83174584111, 33722.0, 30418.695813042472, 33274.667253327156, 33472.66527334793, 33792.15519611931, 34023.65976340304, 32921.34157316793, 33495.33009339751, 33660.0, 33744.83127584346, 33760.0, 28795.712042879302, 29897.850510747307, 29968.700312997462, 30355.2411189722, 30370.54444183295, 23400.414989625395, 23566.130718303277, 23808.642870356613, 23932.28203153908, 24008.87995560011], "value": 16607.881799275463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.7270651484189, 383.84262452394523, 383.99232015359695, 386.87813338798276, 395.70915377197775, 15480.458183963563, 16434.096124713134, 16528.75206871898, 16553.91723041383, 16728.163591820423, 16039.0, 16417.91791041043, 17059.744103838453, 17071.48785536433, 17077.91461042693, 5022.522860328263, 5222.007818514489, 5243.659162154467, 5251.133562962125, 5256.027634887539, 3620.275944811035, 5693.402192769761, 6000.18997435345, 6015.6992150392525, 6021.578489505737, 5863.237779088712, 5949.5537834662355, 5955.464008239258, 5962.34414214436, 5964.105384192362, 5817.796377126801, 5963.761449542057, 6004.249468816398, 6009.158717779536, 6012.128241404994, 3337.7997320160866, 3524.84138213781, 3526.453399723047, 3528.541289632357, 5050.696958182521, 19590.902045489824, 19596.118174682175, 19648.80351196484, 20073.096710648057, 20804.16783328665, 1904.9142788574409, 1983.7421135252469, 2022.8179463848178, 2067.400453868376, 2616.7906567474556, 8751.649934002633, 9049.78280321319, 9406.858897116548, 11281.461671123932, 13041.08712390133, 1666.9166541672869, 1768.6109056007786, 1797.604527004057, 1806.9277228910828, 1841.686913224755, 57943.42056579422, 59645.701771490865, 59873.0, 59929.99999999956, 60753.0, 9780.364276322016, 9853.852192217122, 9916.900830991597, 9979.852316983495, 10023.949880250699, 13986.230757308242, 14280.285985700673, 14288.071275367276, 14293.928530357281, 14312.427502899767, 7362.190159082496, 7366.0, 7443.590602516913, 7539.547627142389, 7566.0, 6904.585724856524, 6924.4114250289285, 6941.201761797458, 7072.823179420556, 7124.323189297009, 4406.669499787465, 4410.0, 4430.246858034077, 4492.427650322361, 4534.161180181677, 1721.4491362763795, 1743.744503957149, 1831.1759708131394, 1837.1916356802965, 1854.0, 842.9494230346199, 843.3084870406208, 880.903100658927, 886.2156991062827, 965.6330594374093, 15345.232738363036, 15515.456959006606, 15973.440929567409, 16107.114108724132, 16160.595985100466, 795.0221227889613, 844.6663567890648, 847.2290215903498, 859.4155973937658, 864.2481041493941, 9134.451932884049, 9552.0, 9593.856092158623, 9619.18236949853, 9647.602254948193, 349437.0, 358129.0, 363865.0, 366989.0, 368225.0, 78025.0, 79159.20840791633, 79489.60255198687, 80029.59985200036, 82518.0, 929.6002718830832, 957.9856302155334, 979.9657012004545, 987.3187500624546, 993.0119531066634, 14147.64630884236, 14477.276136193359, 14880.107193568421, 15982.120983346027, 16212.189390530662, 35320.47019294764, 35426.82286588551, 36185.45721814228, 36602.63397366099, 37004.25991480209, 45266.32100518561, 46754.25965922786, 46969.29546056744, 47157.0, 47275.290870637655, 7815.25755053269, 7969.481983671043, 7999.280064794197, 8032.718854840053, 8102.716404925799, 10852.565897364017, 11186.440677966231, 11241.49413276388, 11488.79367666383, 12053.638390847938, 10286.691399258034, 10549.472526373496, 10571.101456376295, 10830.241883068109, 11248.606298779503, 10360.378377297386, 10365.84451233217, 10624.84062739044, 10675.359478431319, 10853.294535855144, 5633.0705433604635, 6834.829129271609, 10760.332148516993, 10885.23803333759, 11148.442577871236, 7771.222877712184, 7963.16386779403, 8110.580648386626, 8130.6573786687995, 8279.668813247403, 8238.0, 10038.19694424459, 11002.50488728025, 11048.281861678965, 11055.557777688802], "value": 8165.478593354349, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1196.1088988703407, 1290.2129700882463, 1399.9370028348724, 1436.3033928544653, 1816.3098022751353, 6161.414665606766, 7047.224805271422, 7192.352688258055, 7200.96399518003, 7202.819929501758, 6857.554258973163, 7011.929880701192, 7019.192792828826, 7019.227884932666, 7026.85946281074, 1833.5599456130567, 2101.2015434135005, 2159.3306075116684, 2182.432567532437, 2186.4752459409788, 2202.548477562104, 2233.6426171812514, 2234.1398561553838, 2238.4851484158653, 2242.495438526335, 2143.839212059094, 2195.034184958613, 2196.9450763730956, 2196.9780302197014, 2198.0658220256405, 1833.8441232495254, 2130.1053557505884, 2184.224600266898, 2188.0, 2188.518525924294, 2147.957040859174, 2160.2547121243147, 2169.967450488244, 2170.533335332895, 2207.7792220777956, 7401.888971665429, 7527.059117610299, 7578.772636820849, 7585.658645360972, 7603.353714934237, 4357.912841743179, 4575.816967321303, 4578.221702310615, 4579.0, 4581.060882519076, 2832.9433411331656, 2835.248659105339, 2878.0070875548113, 2887.220450478359, 2893.652761668613, 924.4129977464358, 937.1331518345503, 942.3074040580168, 958.0515289863055, 968.099667309402, 10206.387616742944, 10225.386476811414, 10246.38521688701, 10248.538815753309, 10262.281640285182, 4153.7300075494995, 4196.118815048874, 4291.957080429156, 4296.183725092223, 4308.6983911126545, 8719.215270625675, 8768.430052046597, 8788.692395766118, 8804.251638610789, 8807.779805504786, 3761.7366784324836, 4552.795124219418, 4638.466576343763, 4656.976715116402, 4660.300954856731, 4037.1723796621623, 4137.91724165521, 4149.688773342012, 4151.4395556600075, 4152.937705934413, 3454.758166928291, 3472.722182225416, 3590.1024743814046, 3610.9638903611153, 3618.0412190769466, 1162.215504534436, 1170.7482891178438, 1176.758764453285, 1177.370106992772, 1182.8876256755595, 823.7693445835175, 839.0, 846.8729690546468, 861.2335021830576, 861.9957749222211, 4893.804247830119, 5088.084144853962, 5149.76826042829, 5165.199394093921, 5185.0148471790235, 401.5201833808571, 414.9688773342011, 423.18536816628483, 436.5699785711072, 445.62567443347746, 3336.899893003214, 3395.6264810870784, 3455.188030812757, 3475.42655461851, 3495.4232551629207, 8462.61918213682, 8757.824843503222, 8771.122887711177, 8793.296536277083, 8865.778355541162, 8674.175953284428, 8754.649814007496, 8758.781030474162, 8772.956135219283, 8797.736067917973, 6677.966610166918, 6759.290274521104, 6799.286074962058, 6807.761728339583, 6816.113905192393, 4854.126257273725, 4942.382202224722, 4982.7259500727805, 5131.974340128276, 5179.326687530597, 8265.421420500506, 8325.666973321, 8327.0, 8387.874181887399, 8445.239928406472, 8132.942717446694, 8433.83132337362, 8459.06950235486, 8655.82688346217, 8660.653573856975, 5602.075657516627, 6299.716512757029, 6314.179156709598, 6464.7393758216695, 6590.538662293785, 7242.420606351585, 7244.927550724636, 7299.963500182465, 7313.049303590499, 7333.6699848508015, 6365.681715914093, 6568.343165683585, 6568.8357791055605, 6666.066750654815, 6670.199576050905, 6029.577929545065, 6480.481561475165, 6515.478761699147, 6595.307492713388, 6644.800655980328, 6011.489023432882, 6070.726817293321, 6089.421504957022, 6090.9390906090375, 6092.299385570716, 4180.707350485437, 4364.148990946735, 4385.079133382025, 4446.021875187454, 4476.888077797951, 4327.459067616548, 4399.362092496634, 4408.470983482002, 4434.423524941737, 4477.261251893401], "value": 3920.701514316074, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.8297021786927, 301.50101581881984, 303.59015329305424, 305.0710586264824, 305.1151660185462, 4485.618722408599, 4620.676552641316, 4634.397528321313, 4716.0, 4718.952810471894, 4498.415206023221, 4601.217792975194, 4635.559621835929, 4638.072385522892, 4641.396618439607, 3686.447032945053, 3708.83310251038, 3720.7581507202012, 3729.3100776356323, 3740.700743940492, 3524.990755269497, 3554.7689400188906, 3704.259148170363, 3740.831662575191, 3744.6255374462608, 3696.1683621185152, 3705.6294370562864, 3707.499487569184, 3709.202521457886, 3710.810621733177, 3661.853525858976, 3687.3178461984617, 3693.319539609471, 3697.7041836653, 3707.4253490708984, 3293.2919422324076, 3298.4887342461716, 3303.438415469376, 3314.005798260512, 3315.635280119185, 4288.078063216423, 4497.123061003105, 4529.660275479319, 4554.134714404253, 4554.316852472122, 4152.356384760367, 4160.438340824011, 4163.458750362433, 4176.373543968399, 4204.11713540157, 4898.730569818694, 4905.2642103684375, 4908.558229759339, 4932.284818701268, 4937.802487900515, 3308.652591477884, 3505.8948231553095, 3517.296540691872, 3526.1008442847165, 3532.6114127445962, 5073.162928116856, 5093.5415812576675, 5120.871978200537, 5136.563392111675, 5138.897222055575, 3553.4136867416587, 3567.108222944264, 3573.1960308930284, 3582.7671201371827, 3589.4615807628543, 3623.6195199503672, 3634.9636503635156, 3635.2002559436883, 3636.8363423646, 3655.415133578668, 3918.1771827916455, 4158.272302347077, 4160.0, 4170.791460426966, 4177.227212965611, 4892.241702536113, 4934.185859333242, 4943.24514797249, 4944.159492886218, 4945.082401383202, 1240.9131360804656, 1250.8624051354343, 1316.776148054833, 1324.569514907659, 1334.6863487080527, 879.5909901895521, 884.920357167845, 901.7430032440855, 905.9909400905907, 906.7597086771879, 4572.634189264851, 4577.244754615451, 4578.97710511452, 4582.0, 4590.655700822452, 5310.336207974004, 5316.707581083, 5327.866803329948, 5345.118055520873, 5345.198220266913, 4469.904873305995, 4576.0, 4596.770161491912, 4600.539946005372, 4620.353150558924, 2836.6170566973196, 2856.8428736419282, 2865.3409715765074, 2869.8421586812924, 2871.3682989742224, 5000.499950004971, 5011.298418221452, 5037.722925239073, 5040.067587496325, 5045.142325804622, 5311.442298558673, 5444.809431669952, 5478.726063696879, 5485.972570137204, 5491.807786727445, 5006.3992320921725, 5022.146235140035, 5037.19404895215, 5039.193729003342, 5050.292958985745, 5361.490658387447, 5361.758720857492, 5370.845268267341, 5371.946280537145, 5382.111951528111, 5033.446320904624, 5219.451957544555, 5237.895242095213, 5258.89482210346, 5260.158374660036, 5030.496950304941, 5035.5468007878, 5050.141475949171, 5074.5686616637995, 5077.568406685473, 3775.11284848055, 3780.0549862534367, 3780.2250538640064, 3787.3182827091387, 3792.1088544192644, 4784.569388755029, 5218.504242096995, 5343.091674415281, 5351.1973204019705, 5372.952274306473, 4743.193657078236, 4849.393825771778, 4904.449686163104, 4924.187509060965, 4943.802247910044, 4881.755912204305, 4897.730624815526, 4905.852824415273, 4934.100371356982, 4940.8764780880765, 4637.310359991265, 4861.732604706775, 4869.902601947871, 4880.341153944314, 4885.95114048855, 4993.650444468853, 4994.800207991785, 5012.4736902626155, 5017.473165317735, 5038.319826823332, 4905.533974272438, 4931.901361972812, 4946.505349465168, 4965.851024469272, 4966.261808367042], "value": 3791.86939211851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.7337065173931, 708.7909066825284, 760.9505382150163, 790.2650535002449, 792.7463211772235, 12093.879061209385, 12440.129190956637, 12444.688882777946, 12480.812787808167, 12489.812652810204, 11661.708457288572, 11895.881041189585, 12027.639170824867, 12034.097442691811, 12042.759144817099, 644.0789670770796, 779.4504874063786, 808.7856717969743, 809.9271065604095, 814.8818421328904, 767.1484652036236, 802.8514724775906, 805.3838813307824, 805.5851236613149, 806.31060443321, 851.8935133108362, 857.9571021448934, 858.669412276275, 858.909814469481, 859.1794835931702, 675.6419097878132, 692.3664846665296, 852.846487632226, 853.803625166209, 854.1757204297851, 512.7513156119279, 609.1684850179518, 626.9561130720851, 627.3851625407127, 627.8179327994876, 12181.208221465666, 12186.329751863645, 12194.75610487794, 12212.08409369292, 12223.388830558526, 11690.649280521598, 12060.155789094766, 12092.697682557919, 12468.875311246953, 12851.293178875158, 9415.05849415053, 9808.95095524525, 9814.803703925953, 9888.307818452711, 10004.449755263458, 3331.0, 3354.681305275995, 3356.9832150839334, 3415.043787739437, 3421.3328400961823, 43746.34380484295, 44461.0, 44810.32784508235, 44941.32588011182, 46299.76850115762, 9415.670451534163, 9635.614575416905, 9646.565904534313, 9682.177014953668, 9752.609895604097, 16231.594210144605, 16384.672306553803, 16475.58811029734, 16549.338026479047, 16584.08787516698, 6767.593944363354, 6771.762988295484, 6839.487038472134, 6905.1713794345, 6999.265077166926, 3806.3909774435956, 3849.2493963676816, 3888.727789054739, 3960.0495880988356, 4007.479027726435, 2812.774978001755, 2906.070057581596, 2913.038697229909, 2913.4901392256693, 2918.124562631202, 523.7931017248166, 533.557147567518, 537.1432565058725, 540.2544488605699, 544.335910189576, 528.6748649580558, 583.8569550460079, 592.1473078766649, 621.3413781391739, 641.8491654461197, 7576.24237576238, 7962.7213047543055, 8001.319887809602, 8258.958705206556, 8471.279941204943, 594.3669991459083, 608.9360617135226, 638.5306799502362, 640.078287266335, 653.1541653558653, 3833.8085782960034, 3920.3923391874305, 4006.278869803405, 4071.1247081877536, 4132.483439570054, 45811.54188458139, 46001.0, 47480.52519474761, 50167.498325016284, 51689.741551292755, 40660.18679626391, 41028.79485602553, 41223.763287101436, 46091.0, 46914.29628555574, 44216.55783442124, 44220.11559768851, 44517.332240016425, 44937.32594011027, 45285.0, 8586.356023298153, 8587.871181932402, 8658.134186581292, 8733.56332183401, 8867.0, 28919.855400722863, 28987.0, 29709.702902970694, 29768.255793605334, 30072.0, 35467.645323546436, 36976.0, 39395.0, 39621.60378396179, 40091.79954100211, 10080.495975201356, 10103.494825258855, 10150.0, 10221.182305415698, 10526.263161578616, 11407.714807129889, 11491.885081149416, 12307.56923507673, 12339.568115115928, 12477.188982716094, 10723.678289651323, 11312.20814543007, 11370.31778093317, 11392.601258956229, 11742.295462272292, 10949.671509854717, 11255.606053788078, 11449.42752862337, 11523.366214858263, 11566.0, 11112.611058612909, 11338.65935332573, 11427.085833133164, 11569.19015668895, 11588.420578970849, 9294.581743821409, 9495.620175192915, 9560.76098097553, 9681.322307438411, 9700.514974251118, 9430.82114735658, 9540.379875308083, 9598.616055357708, 9618.086281803218, 9670.70987870365], "value": 5940.207579168084, "unit": "score"}], "name": "dromaeo_css", "value": 6160.016278035766, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 114.0, 114.0, 114.0, 121.0, 112.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 153.0, 198.0, 136.0, 164.0, 158.0, 132.0, 202.0, 134.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 160.0, 162.0, 163.0, 162.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 105.0, 102.0, 75.0, 75.0, 76.0, 115.0, 121.0, 74.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 141.0, 94.0, 94.0, 94.0, 150.0, 94.0, 93.0, 143.0], "value": 109.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 85.0, 66.0, 64.0], "value": 68.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 82.0, 79.0, 89.0, 81.0, 81.0, 82.0, 82.0, 89.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 136.0, 129.0, 131.0, 145.0, 127.0, 130.0, 133.0, 170.0, 132.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 179.0, 184.0, 179.0, 179.0, 181.0, 185.0, 177.0, 183.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 73.0, 74.0, 74.0, 72.0, 82.0, 73.0, 73.0, 73.0], "value": 74.4, "unit": "score"}], "name": "kraken", "value": 1595.4, "alertThreshold": 2.0}]} 21:40:21 INFO - Return code: 0 21:40:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:40:21 ERROR - # TBPL SUCCESS # 21:40:21 INFO - Running post-action listener: _resource_record_post_action 21:40:21 INFO - Running post-run listener: _resource_record_post_run 21:40:22 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 527638528; Read time: 0; Write time: 949096 21:40:22 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 234708992; Read time: 0; Write time: 554856 21:40:22 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 292868096; Read time: 0; Write time: 394020 21:40:22 INFO - Running post-run listener: _upload_blobber_files 21:40:22 INFO - Blob upload gear active. 21:40:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:40:22 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 21:40:22 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'] 21:40:22 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 21:40:23 INFO - (blobuploader) - INFO - Open directory for files ... 21:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:40:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:23 INFO - (blobuploader) - INFO - Done attempting. 21:40:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:40:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:40:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:40:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:40:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:40:24 INFO - (blobuploader) - INFO - Done attempting. 21:40:24 INFO - (blobuploader) - INFO - Iteration through files over. 21:40:24 INFO - Return code: 0 21:40:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:40:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:40:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"} 21:40:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:40:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:40:24 INFO - Contents: 21:40:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"} 21:40:24 INFO - Running post-run listener: copy_logs_to_upload_dir 21:40:24 INFO - Copying logs to upload dir... 21:40:24 INFO - mkdir: /builds/slave/test/build/upload/logs 21:40:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.765615 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-25 21:40:23.830472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.834396) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883 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/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"} build_url:https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/P_gzoILRQdG0TUeSUR63rg/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/5adfeebe8b31423655f572afd56402e27be713cc38428737b4a3fe0099ca9a92430da9fcaec8c1a7105f65346828f680375700659af5ad3232f146da4692160a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/251157d5cdf8e498d883df50820b42b12c55eeb6c0a756e6e5d8b0cdb105b8819e67ac2e31afcf5a02727a5de596861b13badc963a6b10cbfa026e2c224485ff"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.859393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.859716) ========= 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=5bd038846534b2fdfa68eeae000001e2-1461642794.996120-503866883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004389 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 21:40:23.943008) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 21:40:23.943318) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 21:40:23.943600) ========= ========= Total master_lag: 0.17 =========