builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1461584801.02 results: success (0) buildid: 20160422035709 builduid: 3af33a9a7de54ba3986a82f34ab86caa revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.019716) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.020072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.020329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.490459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.490732) ========= 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=af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 04:46:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-04-25 04:46:43 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.647166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.647459) ========= 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=af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013560 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.695991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:41.696284) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80598be5d80e695727ff74e712faa623b02f3c70 --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 80598be5d80e695727ff74e712faa623b02f3c70 --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=af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 04:46:43,984 truncating revision to first 12 chars 2016-04-25 04:46:43,984 Setting DEBUG logging. 2016-04-25 04:46:43,984 attempt 1/10 2016-04-25 04:46:43,984 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80598be5d80e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 04:46:44,273 unpacking tar archive at: fx-team-80598be5d80e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.546824 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.255658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.255943) ========= script_repo_revision: 80598be5d80e695727ff74e712faa623b02f3c70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.256309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.256566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 04:46:42.265931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-25 04:46:42.266203) ========= /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=af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:46:44 INFO - MultiFileLogger online at 20160425 04:46:44 in /builds/slave/test 04:46:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:46:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:46:44 INFO - {'append_to_log': False, 04:46:44 INFO - 'base_work_dir': '/builds/slave/test', 04:46:44 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:46:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:46:44 INFO - 'branch': 'Fx-Team-Non-PGO', 04:46:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:46:44 INFO - 'config_files': ('talos/linux_config.py',), 04:46:44 INFO - 'default_actions': ('clobber', 04:46:44 INFO - 'read-buildbot-config', 04:46:44 INFO - 'download-and-extract', 04:46:44 INFO - 'populate-webroot', 04:46:44 INFO - 'create-virtualenv', 04:46:44 INFO - 'install', 04:46:44 INFO - 'run-tests'), 04:46:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:46:44 INFO - 'download_minidump_stackwalk': True, 04:46:44 INFO - 'download_symbols': 'ondemand', 04:46:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:46:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:46:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:46:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:46:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:46:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:46:44 INFO - 'installer_path': 'installer.exe', 04:46:44 INFO - 'log_level': 'info', 04:46:44 INFO - 'log_name': 'talos', 04:46:44 INFO - 'log_to_console': True, 04:46:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:46:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:46:44 INFO - 'opt_config_files': (), 04:46:44 INFO - 'pip_index': False, 04:46:44 INFO - 'sps_profile': False, 04:46:44 INFO - 'sps_profile_interval': 0, 04:46:44 INFO - 'suite': 'dromaeojs', 04:46:44 INFO - 'system_bits': '32', 04:46:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:46:44 INFO - 'title': 'talos-linux64-ix-020', 04:46:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:46:44 INFO - 'use_talos_json': True, 04:46:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:46:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:46:44 INFO - 'work_dir': 'build'} 04:46:44 INFO - ##### 04:46:44 INFO - ##### Running clobber step. 04:46:44 INFO - ##### 04:46:44 INFO - Running pre-action listener: _resource_record_pre_action 04:46:44 INFO - Running main action method: clobber 04:46:44 INFO - rmtree: /builds/slave/test/build 04:46:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:46:45 INFO - Running post-action listener: _resource_record_post_action 04:46:45 INFO - ##### 04:46:45 INFO - ##### Running read-buildbot-config step. 04:46:45 INFO - ##### 04:46:45 INFO - Running pre-action listener: _resource_record_pre_action 04:46:45 INFO - Running main action method: read_buildbot_config 04:46:45 INFO - Using buildbot properties: 04:46:45 INFO - { 04:46:45 INFO - "project": "", 04:46:45 INFO - "product": "firefox", 04:46:45 INFO - "script_repo_revision": "production", 04:46:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:46:45 INFO - "repository": "", 04:46:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:46:45 INFO - "buildid": "20160422035709", 04:46:45 INFO - "pgo_build": "False", 04:46:45 INFO - "basedir": "/builds/slave/test", 04:46:45 INFO - "buildnumber": 2881, 04:46:45 INFO - "slavename": "talos-linux64-ix-020", 04:46:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:46:45 INFO - "platform": "ubuntu64_hw", 04:46:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:46:45 INFO - "branch": "fx-team", 04:46:45 INFO - "repo_path": "integration/fx-team", 04:46:45 INFO - "revision": "80598be5d80e695727ff74e712faa623b02f3c70", 04:46:45 INFO - "stage_platform": "linux64", 04:46:45 INFO - "builduid": "3af33a9a7de54ba3986a82f34ab86caa", 04:46:45 INFO - "slavebuilddir": "test" 04:46:45 INFO - } 04:46:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:46:45 INFO - Running post-action listener: _resource_record_post_action 04:46:45 INFO - ##### 04:46:45 INFO - ##### Running download-and-extract step. 04:46:45 INFO - ##### 04:46:45 INFO - Running pre-action listener: _resource_record_pre_action 04:46:45 INFO - Running main action method: download_and_extract 04:46:45 INFO - mkdir: /builds/slave/test/build/tests 04:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:45 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:46:48 INFO - Downloaded 1361 bytes. 04:46:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:46:48 INFO - Using the following test package requirements: 04:46:48 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:46:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:46:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'jsshell-linux-x86_64.zip'], 04:46:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:46:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:46:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:46:48 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:46:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:46:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:46:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:46:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:48 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:46:49 INFO - Downloaded 22281373 bytes. 04:46:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:46:50 INFO - Return code: 0 04:46:50 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:50 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:46:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:46:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:46:51 INFO - Downloaded 22281373 bytes. 04:46:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:46:53 INFO - Return code: 0 04:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:53 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:46:54 INFO - Downloaded 10845952 bytes. 04:46:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:46:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:46:54 INFO - Return code: 0 04:46: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')]} 04:46:54 INFO - https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:46:55 INFO - Downloaded 54650321 bytes. 04:46:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:55 INFO - mkdir: /builds/slave/test/properties 04:46:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:46:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:46:55 INFO - Contents: 04:46:55 INFO - build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:46:56 INFO - Running post-action listener: _resource_record_post_action 04:46:56 INFO - Running post-action listener: set_extra_try_arguments 04:46:56 INFO - ##### 04:46:56 INFO - ##### Running populate-webroot step. 04:46:56 INFO - ##### 04:46:56 INFO - Running pre-action listener: _resource_record_pre_action 04:46:56 INFO - Running main action method: populate_webroot 04:46:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:46:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:46:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:46:56 INFO - '--tppagecycles', 04:46:56 INFO - '7'], 04:46:56 INFO - 'tests': ['tsvgm']}}, 04:46:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:46:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:46:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:46:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:46:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:46:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['damp', 'tps']}, 04:46:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'tests': ['damp', 'tps']}, 04:46:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['dromaeo_dom']}, 04:46:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:46:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['a11yr', 04:46:56 INFO - 'ts_paint', 04:46:56 INFO - 'tpaint', 04:46:56 INFO - 'sessionrestore', 04:46:56 INFO - 'sessionrestore_no_auto_restore', 04:46:56 INFO - 'tabpaint']}, 04:46:56 INFO - 'other-e10s': {'tests': ['a11yr', 04:46:56 INFO - 'ts_paint', 04:46:56 INFO - 'tpaint', 04:46:56 INFO - 'sessionrestore', 04:46:56 INFO - 'sessionrestore_no_auto_restore', 04:46:56 INFO - 'tabpaint']}, 04:46:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:46:56 INFO - 'ts_paint', 04:46:56 INFO - 'tpaint', 04:46:56 INFO - 'sessionrestore', 04:46:56 INFO - 'sessionrestore_no_auto_restore', 04:46:56 INFO - 'tabpaint']}, 04:46:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:46:56 INFO - 'ts_paint', 04:46:56 INFO - 'tpaint', 04:46:56 INFO - 'sessionrestore', 04:46:56 INFO - 'sessionrestore_no_auto_restore', 04:46:56 INFO - 'tabpaint']}, 04:46:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['a11yr', 04:46:56 INFO - 'ts_paint', 04:46:56 INFO - 'tpaint', 04:46:56 INFO - 'sessionrestore', 04:46:56 INFO - 'sessionrestore_no_auto_restore', 04:46:56 INFO - 'tabpaint']}, 04:46:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['a11yr', 04:46:56 INFO - 'ts_paint', 04:46:56 INFO - 'tpaint', 04:46:56 INFO - 'sessionrestore', 04:46:56 INFO - 'sessionrestore_no_auto_restore', 04:46:56 INFO - 'tabpaint']}, 04:46:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['tsvgx', 04:46:56 INFO - 'tsvgr_opacity', 04:46:56 INFO - 'tart', 04:46:56 INFO - 'tscrollx', 04:46:56 INFO - 'cart']}, 04:46:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:46:56 INFO - 'tsvgr_opacity', 04:46:56 INFO - 'tart', 04:46:56 INFO - 'tscrollx', 04:46:56 INFO - 'cart']}, 04:46:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'talos_options': ['--disable-e10s'], 04:46:56 INFO - 'tests': ['tp5o']}, 04:46:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'tests': ['tp5o']}, 04:46:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'talos_options': ['--disable-e10s', 04:46:56 INFO - '--xperf_path', 04:46:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:56 INFO - 'tests': ['tp5n']}, 04:46:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:46:56 INFO - 'talos_options': ['--xperf_path', 04:46:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:46:56 INFO - 'tests': ['tp5n']}}, 04:46:56 INFO - 'talos.zip': {'path': '', 04:46:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:46:56 INFO - Running post-action listener: _resource_record_post_action 04:46:56 INFO - ##### 04:46:56 INFO - ##### Running create-virtualenv step. 04:46:56 INFO - ##### 04:46:56 INFO - Running pre-action listener: _resource_record_pre_action 04:46:56 INFO - Running main action method: create_virtualenv 04:46:56 INFO - Creating virtualenv /builds/slave/test/build/venv 04:46:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:46:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:46:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:46:56 INFO - Using real prefix '/usr' 04:46:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:46:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:46:59 INFO - Installing pip.................done. 04:46:59 INFO - Return code: 0 04:46:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:46: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 04:46: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 04:46:59 INFO - Using env: {'DISPLAY': ':0', 04:46:59 INFO - 'HOME': '/home/cltbld', 04:46:59 INFO - 'LANG': 'en_US.UTF-8', 04:46:59 INFO - 'LANGUAGE': 'en_US:en', 04:46:59 INFO - 'LOGNAME': 'cltbld', 04:46:59 INFO - 'MAIL': '/var/mail/cltbld', 04:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:59 INFO - 'MOZ_NO_REMOTE': '1', 04:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:59 INFO - 'NO_EM_RESTART': '1', 04:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:59 INFO - 'PWD': '/builds/slave/test', 04:46:59 INFO - 'SHELL': '/bin/bash', 04:46:59 INFO - 'SHLVL': '1', 04:46:59 INFO - 'TERM': 'linux', 04:46:59 INFO - 'TMOUT': '86400', 04:46:59 INFO - 'USER': 'cltbld', 04:46:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:59 INFO - '_': '/tools/buildbot/bin/python'} 04:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:46:59 INFO - Cleaning up... 04:46:59 INFO - Return code: 0 04:46:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:46: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', '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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:46: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:46: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 psutil>=0.7.1 04:46:59 INFO - Using env: {'DISPLAY': ':0', 04:46:59 INFO - 'HOME': '/home/cltbld', 04:46:59 INFO - 'LANG': 'en_US.UTF-8', 04:46:59 INFO - 'LANGUAGE': 'en_US:en', 04:46:59 INFO - 'LOGNAME': 'cltbld', 04:46:59 INFO - 'MAIL': '/var/mail/cltbld', 04:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:59 INFO - 'MOZ_NO_REMOTE': '1', 04:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:59 INFO - 'NO_EM_RESTART': '1', 04:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:59 INFO - 'PWD': '/builds/slave/test', 04:46:59 INFO - 'SHELL': '/bin/bash', 04:46:59 INFO - 'SHLVL': '1', 04:46:59 INFO - 'TERM': 'linux', 04:46:59 INFO - 'TMOUT': '86400', 04:46:59 INFO - 'USER': 'cltbld', 04:46:59 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:59 INFO - '_': '/tools/buildbot/bin/python'} 04:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:46:59 INFO - Downloading/unpacking psutil>=0.7.1 04:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:47:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:01 INFO - Installing collected packages: psutil 04:47:01 INFO - Running setup.py install for psutil 04:47:01 INFO - building 'psutil._psutil_linux' extension 04:47:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:47:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:47:01 INFO - building 'psutil._psutil_posix' extension 04:47:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:47: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 04:47:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:47:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:47:02 INFO - Successfully installed psutil 04:47:02 INFO - Cleaning up... 04:47:02 INFO - Return code: 0 04:47:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47: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 04:47: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 04:47:02 INFO - Using env: {'DISPLAY': ':0', 04:47:02 INFO - 'HOME': '/home/cltbld', 04:47:02 INFO - 'LANG': 'en_US.UTF-8', 04:47:02 INFO - 'LANGUAGE': 'en_US:en', 04:47:02 INFO - 'LOGNAME': 'cltbld', 04:47:02 INFO - 'MAIL': '/var/mail/cltbld', 04:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:02 INFO - 'MOZ_NO_REMOTE': '1', 04:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:02 INFO - 'NO_EM_RESTART': '1', 04:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:02 INFO - 'PWD': '/builds/slave/test', 04:47:02 INFO - 'SHELL': '/bin/bash', 04:47:02 INFO - 'SHLVL': '1', 04:47:02 INFO - 'TERM': 'linux', 04:47:02 INFO - 'TMOUT': '86400', 04:47:02 INFO - 'USER': 'cltbld', 04:47:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:02 INFO - '_': '/tools/buildbot/bin/python'} 04:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:47: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) 04:47:04 INFO - Installing collected packages: mozsystemmonitor 04:47:04 INFO - Running setup.py install for mozsystemmonitor 04:47:04 INFO - Successfully installed mozsystemmonitor 04:47:04 INFO - Cleaning up... 04:47:04 INFO - Return code: 0 04:47:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:04 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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:47:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:47:04 INFO - Using env: {'DISPLAY': ':0', 04:47:04 INFO - 'HOME': '/home/cltbld', 04:47:04 INFO - 'LANG': 'en_US.UTF-8', 04:47:04 INFO - 'LANGUAGE': 'en_US:en', 04:47:04 INFO - 'LOGNAME': 'cltbld', 04:47:04 INFO - 'MAIL': '/var/mail/cltbld', 04:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:04 INFO - 'MOZ_NO_REMOTE': '1', 04:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:04 INFO - 'NO_EM_RESTART': '1', 04:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:04 INFO - 'PWD': '/builds/slave/test', 04:47:04 INFO - 'SHELL': '/bin/bash', 04:47:04 INFO - 'SHLVL': '1', 04:47:04 INFO - 'TERM': 'linux', 04:47:04 INFO - 'TMOUT': '86400', 04:47:04 INFO - 'USER': 'cltbld', 04:47:04 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:04 INFO - '_': '/tools/buildbot/bin/python'} 04:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:47:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:47:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:07 INFO - Downloading docopt-0.6.1.tar.gz 04:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:47:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:47:07 INFO - Running setup.py install for blobuploader 04:47:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:47:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:47:07 INFO - Running setup.py install for requests 04:47:07 INFO - Running setup.py install for docopt 04:47:07 INFO - Successfully installed blobuploader requests docopt 04:47:07 INFO - Cleaning up... 04:47:07 INFO - Return code: 0 04:47:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:07 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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:07 INFO - Using env: {'DISPLAY': ':0', 04:47:07 INFO - 'HOME': '/home/cltbld', 04:47:07 INFO - 'LANG': 'en_US.UTF-8', 04:47:07 INFO - 'LANGUAGE': 'en_US:en', 04:47:07 INFO - 'LOGNAME': 'cltbld', 04:47:07 INFO - 'MAIL': '/var/mail/cltbld', 04:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:07 INFO - 'MOZ_NO_REMOTE': '1', 04:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:07 INFO - 'NO_EM_RESTART': '1', 04:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:07 INFO - 'PWD': '/builds/slave/test', 04:47:07 INFO - 'SHELL': '/bin/bash', 04:47:07 INFO - 'SHLVL': '1', 04:47:07 INFO - 'TERM': 'linux', 04:47:07 INFO - 'TMOUT': '86400', 04:47:07 INFO - 'USER': 'cltbld', 04:47:07 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:07 INFO - '_': '/tools/buildbot/bin/python'} 04:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:08 INFO - Running setup.py (path:/tmp/pip-NDuMXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:08 INFO - Running setup.py (path:/tmp/pip-KgTmIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:08 INFO - Running setup.py (path:/tmp/pip-2AdVV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:08 INFO - Running setup.py (path:/tmp/pip-mBcEIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:08 INFO - Running setup.py (path:/tmp/pip-L5WjoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:08 INFO - Running setup.py (path:/tmp/pip-qhiEjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:08 INFO - Running setup.py (path:/tmp/pip-gueI7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:08 INFO - Running setup.py (path:/tmp/pip-ZUi0EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:08 INFO - Running setup.py (path:/tmp/pip-sldCSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:08 INFO - Running setup.py (path:/tmp/pip-awAvih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:08 INFO - Running setup.py (path:/tmp/pip-GIblLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:08 INFO - Running setup.py (path:/tmp/pip-QMnIVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:09 INFO - Running setup.py (path:/tmp/pip-VEirDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:09 INFO - Running setup.py (path:/tmp/pip-inPH96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:09 INFO - Running setup.py (path:/tmp/pip-XeGzsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:09 INFO - Running setup.py (path:/tmp/pip-7AVRJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:09 INFO - Running setup.py (path:/tmp/pip-IiCYDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:47:09 INFO - Running setup.py install for manifestparser 04:47:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:47:09 INFO - Running setup.py install for mozcrash 04:47:09 INFO - Running setup.py install for mozdebug 04:47:09 INFO - Running setup.py install for mozdevice 04:47:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:47:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:47:09 INFO - Running setup.py install for mozfile 04:47:09 INFO - Running setup.py install for mozhttpd 04:47:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Running setup.py install for mozinfo 04:47:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Running setup.py install for mozInstall 04:47:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Running setup.py install for mozleak 04:47:10 INFO - Running setup.py install for mozlog 04:47:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Running setup.py install for moznetwork 04:47:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Running setup.py install for mozprocess 04:47:10 INFO - Running setup.py install for mozprofile 04:47:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Running setup.py install for mozrunner 04:47:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:47:10 INFO - Running setup.py install for mozscreenshot 04:47:10 INFO - Running setup.py install for moztest 04:47:11 INFO - Running setup.py install for mozversion 04:47:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:47:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:47:11 INFO - Cleaning up... 04:47:11 INFO - Return code: 0 04:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47: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')]} 04:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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')]} 04:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47: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 04:47: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 04:47:11 INFO - Using env: {'DISPLAY': ':0', 04:47:11 INFO - 'HOME': '/home/cltbld', 04:47:11 INFO - 'LANG': 'en_US.UTF-8', 04:47:11 INFO - 'LANGUAGE': 'en_US:en', 04:47:11 INFO - 'LOGNAME': 'cltbld', 04:47:11 INFO - 'MAIL': '/var/mail/cltbld', 04:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:11 INFO - 'MOZ_NO_REMOTE': '1', 04:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:11 INFO - 'NO_EM_RESTART': '1', 04:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:11 INFO - 'PWD': '/builds/slave/test', 04:47:11 INFO - 'SHELL': '/bin/bash', 04:47:11 INFO - 'SHLVL': '1', 04:47:11 INFO - 'TERM': 'linux', 04:47:11 INFO - 'TMOUT': '86400', 04:47:11 INFO - 'USER': 'cltbld', 04:47:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:11 INFO - '_': '/tools/buildbot/bin/python'} 04:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:47:11 INFO - Running setup.py (path:/tmp/pip-I183tx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:47:11 INFO - Running setup.py (path:/tmp/pip-1OsE9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:47:11 INFO - Running setup.py (path:/tmp/pip-K2t32m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:47:11 INFO - Running setup.py (path:/tmp/pip-GlOrKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:47:11 INFO - Running setup.py (path:/tmp/pip-MC0zkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:47:11 INFO - Running setup.py (path:/tmp/pip-6NjOP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:47:11 INFO - Running setup.py (path:/tmp/pip-1Uqxea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:47:11 INFO - Running setup.py (path:/tmp/pip-jLqnV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:47:11 INFO - Running setup.py (path:/tmp/pip-96wgGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:47: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)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:47:12 INFO - Running setup.py (path:/tmp/pip-O6sF8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:47: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)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:47:12 INFO - Running setup.py (path:/tmp/pip-fJCkGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:47: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)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:47:12 INFO - Running setup.py (path:/tmp/pip-6h_HTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:47: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)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:47:12 INFO - Running setup.py (path:/tmp/pip-vqfs3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:47: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)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:47:12 INFO - Running setup.py (path:/tmp/pip-veOKYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:12 INFO - Running setup.py (path:/tmp/pip-7XBJPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:47:12 INFO - Running setup.py (path:/tmp/pip-Eq3uQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:47:12 INFO - Running setup.py (path:/tmp/pip-JaVX6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:47:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:47:14 INFO - Downloading blessings-1.6.tar.gz 04:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:47:14 INFO - Installing collected packages: blessings 04:47:14 INFO - Running setup.py install for blessings 04:47:14 INFO - Successfully installed blessings 04:47:14 INFO - Cleaning up... 04:47:14 INFO - Return code: 0 04:47:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:47:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:14 INFO - Reading from file tmpfile_stdout 04:47:14 INFO - Current package versions: 04:47:14 INFO - argparse == 1.2.1 04:47:14 INFO - blessings == 1.6 04:47:14 INFO - blobuploader == 1.2.4 04:47:14 INFO - docopt == 0.6.1 04:47:14 INFO - manifestparser == 1.1 04:47:14 INFO - mozInstall == 1.12 04:47:14 INFO - mozcrash == 0.17 04:47:14 INFO - mozdebug == 0.1 04:47:14 INFO - mozdevice == 0.48 04:47:14 INFO - mozfile == 1.2 04:47:14 INFO - mozhttpd == 0.7 04:47:14 INFO - mozinfo == 0.9 04:47:14 INFO - mozleak == 0.1 04:47:14 INFO - mozlog == 3.1 04:47:14 INFO - moznetwork == 0.27 04:47:14 INFO - mozprocess == 0.22 04:47:14 INFO - mozprofile == 0.28 04:47:14 INFO - mozrunner == 6.11 04:47:14 INFO - mozscreenshot == 0.1 04:47:14 INFO - mozsystemmonitor == 0.0 04:47:14 INFO - moztest == 0.7 04:47:14 INFO - mozversion == 1.4 04:47:14 INFO - psutil == 3.1.1 04:47:14 INFO - requests == 1.2.3 04:47:14 INFO - wsgiref == 0.1.2 04:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:14 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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:47:14 INFO - Using env: {'DISPLAY': ':0', 04:47:14 INFO - 'HOME': '/home/cltbld', 04:47:14 INFO - 'LANG': 'en_US.UTF-8', 04:47:14 INFO - 'LANGUAGE': 'en_US:en', 04:47:14 INFO - 'LOGNAME': 'cltbld', 04:47:14 INFO - 'MAIL': '/var/mail/cltbld', 04:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:14 INFO - 'MOZ_NO_REMOTE': '1', 04:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:14 INFO - 'NO_EM_RESTART': '1', 04:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:14 INFO - 'PWD': '/builds/slave/test', 04:47:14 INFO - 'SHELL': '/bin/bash', 04:47:14 INFO - 'SHLVL': '1', 04:47:14 INFO - 'TERM': 'linux', 04:47:14 INFO - 'TMOUT': '86400', 04:47:14 INFO - 'USER': 'cltbld', 04:47:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:14 INFO - '_': '/tools/buildbot/bin/python'} 04:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47: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)) 04:47:15 INFO - Cleaning up... 04:47:15 INFO - Return code: 0 04:47:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47: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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47: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 04:47: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 04:47:15 INFO - Using env: {'DISPLAY': ':0', 04:47:15 INFO - 'HOME': '/home/cltbld', 04:47:15 INFO - 'LANG': 'en_US.UTF-8', 04:47:15 INFO - 'LANGUAGE': 'en_US:en', 04:47:15 INFO - 'LOGNAME': 'cltbld', 04:47:15 INFO - 'MAIL': '/var/mail/cltbld', 04:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:15 INFO - 'MOZ_NO_REMOTE': '1', 04:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:15 INFO - 'NO_EM_RESTART': '1', 04:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:15 INFO - 'PWD': '/builds/slave/test', 04:47:15 INFO - 'SHELL': '/bin/bash', 04:47:15 INFO - 'SHLVL': '1', 04:47:15 INFO - 'TERM': 'linux', 04:47:15 INFO - 'TMOUT': '86400', 04:47:15 INFO - 'USER': 'cltbld', 04:47:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:15 INFO - '_': '/tools/buildbot/bin/python'} 04:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:15 INFO - Downloading/unpacking jsonschema 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:47:17 INFO - Downloading/unpacking functools32 (from jsonschema) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:47:17 INFO - warning: no files found matching '*.txt' 04:47:17 INFO - no previously-included directories found matching 'build' 04:47:17 INFO - no previously-included directories found matching 'dist' 04:47:17 INFO - no previously-included directories found matching '.git*' 04:47:17 INFO - Installing collected packages: jsonschema, functools32 04:47:17 INFO - Running setup.py install for functools32 04:47:17 INFO - warning: no files found matching '*.txt' 04:47:17 INFO - no previously-included directories found matching 'build' 04:47:17 INFO - no previously-included directories found matching 'dist' 04:47:17 INFO - no previously-included directories found matching '.git*' 04:47:17 INFO - Successfully installed jsonschema functools32 04:47:17 INFO - Cleaning up... 04:47:17 INFO - Return code: 0 04:47:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:47:17 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 0x7f688980bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29b08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a7b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:47:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:47:17 INFO - Using env: {'DISPLAY': ':0', 04:47:17 INFO - 'HOME': '/home/cltbld', 04:47:17 INFO - 'LANG': 'en_US.UTF-8', 04:47:17 INFO - 'LANGUAGE': 'en_US:en', 04:47:17 INFO - 'LOGNAME': 'cltbld', 04:47:17 INFO - 'MAIL': '/var/mail/cltbld', 04:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:17 INFO - 'MOZ_NO_REMOTE': '1', 04:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:17 INFO - 'NO_EM_RESTART': '1', 04:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:17 INFO - 'PWD': '/builds/slave/test', 04:47:17 INFO - 'SHELL': '/bin/bash', 04:47:17 INFO - 'SHLVL': '1', 04:47:17 INFO - 'TERM': 'linux', 04:47:17 INFO - 'TMOUT': '86400', 04:47:17 INFO - 'USER': 'cltbld', 04:47:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:17 INFO - '_': '/tools/buildbot/bin/python'} 04:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:47:18 INFO - Downloading/unpacking flake8 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:47:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:47:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47: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 04:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:47:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:20 INFO - no previously-included directories found matching 'docs/_build' 04:47:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:47:20 INFO - Running setup.py install for pep8 04:47:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:47:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:47:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:47:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:47:20 INFO - no previously-included directories found matching 'docs/_build' 04:47:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:47:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:47:20 INFO - Cleaning up... 04:47:21 INFO - Return code: 0 04:47:21 INFO - Running post-action listener: _resource_record_post_action 04:47:21 INFO - Running post-action listener: _start_resource_monitoring 04:47:21 INFO - Starting resource monitoring. 04:47:21 INFO - ##### 04:47:21 INFO - ##### Running install step. 04:47:21 INFO - ##### 04:47:21 INFO - Running pre-action listener: _resource_record_pre_action 04:47:21 INFO - Running main action method: install 04:47:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:47:21 INFO - Reading from file tmpfile_stdout 04:47:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:47:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:47:21 INFO - Reading from file tmpfile_stdout 04:47:21 INFO - Output received: 04:47:21 INFO - Usage: mozinstall [options] installer 04:47:21 INFO - Options: 04:47:21 INFO - -h, --help show this help message and exit 04:47:21 INFO - -d DEST, --destination=DEST 04:47:21 INFO - Directory to install application into. [default: 04:47:21 INFO - "/builds/slave/test"] 04:47:21 INFO - --app=APP Application being installed. [default: firefox] 04:47:21 INFO - mkdir: /builds/slave/test/build/application 04:47:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:47:37 INFO - Reading from file tmpfile_stdout 04:47:37 INFO - Output received: 04:47:37 INFO - /builds/slave/test/build/application/firefox/firefox 04:47:37 INFO - Running post-action listener: _resource_record_post_action 04:47:37 INFO - ##### 04:47:37 INFO - ##### Running run-tests step. 04:47:37 INFO - ##### 04:47:37 INFO - Running pre-action listener: _resource_record_pre_action 04:47:37 INFO - Running main action method: run_tests 04:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:47:37 INFO - Python 2.7.3 04:47:37 INFO - Return code: 0 04:47:37 INFO - grabbing minidump binary from tooltool 04:47: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')]} 04:47: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 0x2b0a410>, '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 0x2b0b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b0b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:47: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 04:47: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 04:47:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:47:37 INFO - Return code: 0 04:47:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:47:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:47:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:47:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:47:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:47:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:47:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:47:38 INFO - Return code: 0 04:47: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/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:47: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/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:47:38 INFO - Using env: {'DISPLAY': ':0', 04:47:38 INFO - 'HOME': '/home/cltbld', 04:47:38 INFO - 'LANG': 'en_US.UTF-8', 04:47:38 INFO - 'LANGUAGE': 'en_US:en', 04:47:38 INFO - 'LOGNAME': 'cltbld', 04:47:38 INFO - 'MAIL': '/var/mail/cltbld', 04:47:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:47:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:47:38 INFO - 'MOZ_NO_REMOTE': '1', 04:47:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:47:38 INFO - 'NO_EM_RESTART': '1', 04:47:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:47:38 INFO - 'PWD': '/builds/slave/test', 04:47:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:47:38 INFO - 'SHELL': '/bin/bash', 04:47:38 INFO - 'SHLVL': '1', 04:47:38 INFO - 'TERM': 'linux', 04:47:38 INFO - 'TMOUT': '86400', 04:47:38 INFO - 'USER': 'cltbld', 04:47:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482', 04:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:47:38 INFO - '_': '/tools/buildbot/bin/python'} 04:47: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/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:47:39 INFO - mozversion application_buildid: 20160422035709 04:47:39 INFO - mozversion application_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:39 INFO - mozversion application_display_name: Nightly 04:47:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:47:39 INFO - mozversion application_name: Firefox 04:47:39 INFO - mozversion application_remotingname: firefox 04:47:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:47:39 INFO - mozversion application_vendor: Mozilla 04:47:39 INFO - mozversion application_version: 48.0a1 04:47:39 INFO - mozversion platform_buildid: 20160422035709 04:47:39 INFO - mozversion platform_changeset: 80598be5d80e695727ff74e712faa623b02f3c70 04:47:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:47:39 INFO - mozversion platform_version: 48.0a1 04:47:39 INFO - using testdate: 1461584859 04:47:39 INFO - actual date: 1461584859 04:47:39 INFO - starting webserver on 'localhost:54714' 04:47:39 INFO - SUITE-START | Running 2 tests 04:47:39 INFO - TEST-START | dromaeo_css 04:47:39 INFO - operating with platform_type : linux_ 04:47:39 INFO - Initialising browser for dromaeo_css test... 04:47:39 INFO - TEST-INFO | started process 10616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf3K2lg/profile http://localhost:54714/getInfo.html) 04:47:43 INFO - PROCESS | 10616 | __metrics Screen width/height:1600/1200 04:47:43 INFO - PROCESS | 10616 | colorDepth:24 04:47:43 INFO - PROCESS | 10616 | Browser inner width/height: 1024/697 04:47:43 INFO - PROCESS | 10616 | __metrics 04:47:44 ERROR - PROCESS | 10616 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:47:45 INFO - TEST-INFO | 10616: exit 0 04:47:45 INFO - Browser initialized. 04:47:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:47:45 INFO - TEST-INFO | started process 10697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf3K2lg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:57 INFO - PROCESS | 10697 | RSS: Main: 155508736 04:47:57 INFO - PROCESS | 10697 | 04:48:49 INFO - PROCESS | 10697 | 1461584929185 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:51:00 INFO - PROCESS | 10697 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54714/tests/dromaeo/cssquery-ext.html) 04:51:01 INFO - PROCESS | 10697 | RSS: Main: 235208704 04:51:01 INFO - PROCESS | 10697 | 04:54:04 INFO - PROCESS | 10697 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-ext.html (next: http://localhost:54714/tests/dromaeo/cssquery-jquery.html) 04:54:04 INFO - PROCESS | 10697 | RSS: Main: 236224512 04:54:04 INFO - PROCESS | 10697 | 04:57:06 INFO - PROCESS | 10697 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54714/tests/dromaeo/cssquery-mootools.html) 04:57:07 INFO - PROCESS | 10697 | RSS: Main: 238555136 04:57:07 INFO - PROCESS | 10697 | 05:00:09 INFO - PROCESS | 10697 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54714/tests/dromaeo/cssquery-prototype.html) 05:00:10 INFO - PROCESS | 10697 | RSS: Main: 232345600 05:00:10 INFO - PROCESS | 10697 | 05:03:13 INFO - PROCESS | 10697 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54714/tests/dromaeo/cssquery-yui.html) 05:03:13 INFO - PROCESS | 10697 | RSS: Main: 215310336 05:03:13 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | Cycle 1(1): loaded http://localhost:54714/tests/dromaeo/cssquery-yui.html (next: http://localhost:54714/tests/dromaeo/cssquery-dojo.html) 05:06:16 INFO - PROCESS | 10697 | RSS: Main: 272695296 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | __start_tp_report 05:06:16 INFO - PROCESS | 10697 | _x_x_mozilla_page_load 05:06:16 INFO - PROCESS | 10697 | _x_x_mozilla_page_load_details 05:06:16 INFO - PROCESS | 10697 | |i|pagename|runs| 05:06:16 INFO - PROCESS | 10697 | |0;dojo.html;2601.7008044074933;2669.906553270636;2672.0426093232786;2681.9731802681968;2705.5535836586964;4586.656000799945;4657.417822772153;4660.184467718149;4696.577308042276;4698.060387922412;4633.930491042637;4701.294805779135;4720.150372932871;4786.9042619147685;4804.639652026103;4267.573242675739;4273.679474039444;4308.913821723564;4337.544557821415;4397.978010109945;4329.913401731964;4352.782360881959;4375.14684636496;4385.934210986838;4430.335449682558;4214.768187749688;4262.680298977589;4321.848735294249;4351.782410879475;4354.107407981356;4245;4281.272183728774;4284.421603083606;4328.329108988112;4376.474823021226;4261.637760790337;4278.807453664593;4284.271673815459;4290.420793192941;4323.6757243206885;4443.777811109464;4594.632429405639;4615.861524154281;4671.205894997858;4687.20317546018;5012.8496145115705;5023.2214006828635;5025.597952163818;5031.974840125813;5036.874078148039;5047.848564543069;5056.115179843513;5064.18972964324;5069.188929771219;5094.821681241176;4555.04344087742;4633.467151277646;4711.764411779466;4712.410948631421;4718.95281047192;5148.0476111919415;5156.716380599103;5162.045021670928;5162.148245539444;5164.096283150434;4829.73436460991;4945.134601444733;4955.925661115086;4961.355023846949;5001.44984051754;5030.044291584587;5042.09242336383;5061.620378471629;5080.822171223989;5113.3097031900215;4916.385451818523;4926.704397736075;4927.482614325444;4932.21084626458;4978.5270399312;4832.95167048332;4912.336834527365;4912.901741965212;4932.827351042768;4951.72765497901;4219.282721937278;4226.661867050629;4244.405783190356;4253.2769429197115;4266.914661706748;3664.0656632558525;3682.1346983458866;3682.9447558286647;3709.870154544578;3734.141147536082;4229.936550951738;4272.764997925144;4277.379779931893;4297.892552686208;4317.158154159909;4964.925526117111;4974.054929563371;4984.252362145708;5012.8496145115705;5046.596272298208;4238.533761286256;4252.829886804555;4256.404103425523;4270.829166833292;4312.547182545787;4363;4421.314696222091;4440.62254708347;4467.843625473093;4485.641148708096;4671.392718946651;4693.366395536559;4695.906081878275;4721.315409265706;4732.361131247307;4982.900341993068;4989.451160372283;4992.350994370709;4999.875003124951;5048.091343558195;4657.953420465752;4694;4709;4767.880802979815;4772.308015337687;4899.632527560376;4919.532644398776;4929.580985616263;4932.580730637793;4985.875353116201;4973.925391119208;4987.950120498894;4989.80040798364;4990.750462476934;5067.011932673094;4768.546988036131;4873.049755297683;4930.8767280818265;4951.984843107082;4961.776720047678;4837.250226214942;4846.248831431134;4868.099401610713;4870.269459581091;4918.188498897642;4645.02454484562;4783.928241076456;4795.256735206049;4801.927971080367;4858.611311095033;4846.491118432514;4916.0905232532095;4917.459079501181;4969;4969.6272779542405;4809.735464549483;4834.6374021947795;4846.709197448024;4850.927236091532;4911.3369695090705 05:06:16 INFO - PROCESS | 10697 | |1;ext.html;581.7556626216989;592.7569696424467;602.990955135673;609.953929011745;635;32798;34087;34097.22638830559;34140.65859341406;34209.65790342096;36376.45435318472;36900.815495922485;37082.81458592703;37097.814510927405;37118.25763484729;7752.496087754306;7949.523028618272;7960;7965.8805117923275;7966.760997170094;7723.459357844953;7759.41804364672;7834.0990786059765;7843.33331666809;7848.136704962478;7817.726379576716;7877.566733829637;7885.921140788605;7888.60556972152;7890.289873911347;7810.843783124335;7852.528848269094;7858.332041776456;7869.2130786921425;7870.0949390820215;7770.844583108363;7861.606919653995;7873.212678732139;7883.448158628841;7890.64492097857;36939.81530092332;37367.06582335436;37520.24959500795;37528;37551;2620.1045869113277;2810.4519618674367;2922.327864591156;2924.8976285829895;3294.258791771856;28107.29731756702;28304.43391132166;28306.15081547557;28493.287667808472;28733.784812583002;3301.5377847101427;3380.6619338066243;3388.542546756181;3393.1686736749652;3416.931661366784;239274.8036259825;239508;239599;240786;241188;46009.07981840344;46049.07901841944;46169.61491155271;46432;49127.26309105366;52501.84988900678;52869;52883.20675189875;52951;53053.46946530485;12237.694057648452;12932.159409638343;13329.266890321125;13336.466541338432;13341.332933353293;9517.714468565953;9543.952280238555;9568.138867501819;9571.856422153673;9584.568694408768;13353.799693004612;14324.785128223086;14358.497452589108;14411.135331880121;14412.855871441361;5541.833744987657;5564.916526252109;5665.716714164275;5686.886262274731;5692.743826527816;857.2028013946964;906.8141031088611;912.8448163812168;956.8325543029941;959.2709540749081;26397;27528.311792204953;27569.724302756716;27708.722912771016;28214.43571128566;943.429225318686;954.6658669465631;972.9270304727032;1002.1181360402799;1027.342500799489;14179.346713341954;14779.26103694811;14892.255387230594;14896.851031489763;15703.921480392753;161512;164158;164456;164678;164987;47476;48776;48951.51048489541;48960;49012.509874900796;1145.5475087340453;1241.85097788266;1243.620695687806;1249.850017997828;1272.5673271087874;26678.866605666848;27685.446291073662;27740.583891241244;28138.118343253886;28452.85773571119;41316.586834132475;41786.1642767149;41831.7908410456;41869;41929;328462;329842;332144;332641;333344;21788.67316990278;23739.52520949606;23774.40563985845;24097.277081687578;24105.19211059213;37806;37940;38078.619213807506;38806.2238755229;38862;31772;32797.672023280415;33170.50244246387;33251.33497330088;33396.1650958728;32304.35391292208;32802.83598581992;33234.66765332316;34046;34679.47980780341;33467.49798752972;34021.829890850386;34320;34385.14037149091;34486.655133448345;30190;31250.531242031844;34413;34565.48151777675;34899.30201395907;23354.766452335258;23373.41566460852;23509.647355289344;23879;23972.40068998289 05:06:16 INFO - PROCESS | 10697 | |2;jquery.html;378.888227972748;383.2717836111388;384.1951112419481;388.3475760721986;391.41092655553405;15494.706606892632;17089.914550427246;17125.22936467862;17128.82871171288;17143.142842857855;11496.770064598702;15251.237438128104;15975;16001.19994000301;16032.198390080508;4600.539946005398;4701.059788042405;4757.452892917324;4758.643101767364;4759.928601070987;3502.5271588335504;5047.419546752134;5287.973560132214;5309.761060752276;5316.680999140045;5296.09966305727;5335.679859208441;5336.199570064483;5340.305760251182;5366.141417373221;5286.392064912527;5396.460353964611;5397.217403476494;5407.675539467645;5413.242146099549;4999.550040496373;5097.1844504879045;5178.508041736029;5181.145111056671;5181.274621552986;12662;12737.490500379974;12839.229646221256;12878.935605321913;12880.677983050406;1787.8480329172037;1854.7310639957266;1904.209752952523;1956.491312258823;1978.7328710624026;9007.324450666161;9180;9359.25125989926;9425.717228483156;13131.803022954664;1686.2496189195813;1688.2318545061967;1777.7066783980629;1781.6080462298273;1829.7621309229849;69911.26109236345;74784.25215747827;75193.62403188004;76182.6190869042;76272.61863690647;10309.639162629423;10461.581536738446;10477.947610262052;10561;10562.419066951237;14172.362243699059;14318.928405357907;14394.784078238834;14499.637509062359;14557.490487832874;6950.687219075154;6996.370326670624;7027.683754231072;7199;7238.493305468672;6546.0835483032415;6570.667413068388;6639.900401493885;6684.2981486944145;6697.832554186087;4328.8268469260875;4419.11617676466;4463.531329210451;4472.9552704472535;4487.6634252431195;1732.8440440360175;1753.2022929567017;1781.5747402078543;1805.9398183287274;1847.9907600462182;839.4417712221305;847.3390755210945;857.6655104509247;876.588003638289;896.188949001155;16193.433229836899;16545.420910268083;16622.085785281924;16965.13383527811;17222.827771722372;800.6477150053958;805.8912046873597;824.3611201318906;827.5365795154732;916.8991410944791;5693.775838194808;5800.6809625471005;5911.497522710618;5938.079597662283;9071.27429805614;302153;307408;310839;311490;316393;78315.60842195866;78785;82386.58806705927;83091;83236.58381708174;449.8425551057104;452.1883219620789;459.37754342864935;460.35550229678717;461.25046798951706;14147.36336864823;14697.338619761922;15463.226838658247;15490.302936368116;15896.682066358839;26098.217053488424;36558.4516232262;38701;39431.60568394394;40295;49700;51113;51146.48853511417;51407.74296128495;52178.73855137408;7639.159692433716;7768.689252429839;7858.371330293448;8030.919690803251;8186.017677878693;8782.473051616924;10209.642662506776;11272.718182045515;11451.370174640142;11741.530338786353;5594.468525490072;8146.75559733209;8626.792249085258;9822.165115964937;10057.949710251401;10241;10560.419176945341;10639.468026598484;10857.34855908648;10905.073068789241;10011.449370284414;10128.949355253177;10150.593976240867;10305.793884122426;10376.688699339033;7636.579988100708;7894.6842126314305;7926.207379262028;8060.073091594541;8162.2653961141405;10680.359178449318;10775.838362424727;10826.971437713404;10957.780844382909;10988.505517251902 05:06:16 INFO - PROCESS | 10697 | |3;mootools.html;1224.926504409735;1434.447737621016;1456.7814827775835;1577.4084718230663;1734.6617409605124;7602.7719168424965;7927.128015918259;7934;7934.56359900206;7963.283304502594;7703.845923081535;7849.68601255949;7850.528968261909;7861.56761378124;7863.488873223237;2242.8990695418665;2243.573720993006;2246.292417888368;2269.31920423873;2269.3645779181775;2190.912363505458;2207.87856667884;2226.220822712054;2235.307054813013;2243.046705150313;2199.659052846803;2199.846010779246;2201.9779802202015;2241.1035585765662;2300.148944890393;2149.1403438624675;2168.6963825064427;2172.0660116150048;2176.064292354287;2178.56428714257;2179.8801065941366;2186.7813218678166;2194.034624765098;2195.242641288769;2203.1848216159965;7366.373858222058;7541.283578060075;7851.332636725885;7892.171322011221;7904.130545639975;4614.284785858197;4754.690945088558;4759.952400476021;4761.333413322138;4777.784999674988;2850.4299140171843;2874.1377586723897;2899.246195989037;2900.4779139754837;2902.5646153076996;891.2379915172564;907.795745957161;927.6150397584994;933.2440723014312;946.2288235088449;10570.894291057068;10683.83974240387;10693.625723099733;10699.572017119306;10727.088197503144;4038.414429907647;4237.766922819274;4305.870823875289;4365.628921541641;4392.5607439256455;7927.603619818986;7972.681092756341;8016.799580010546;8024;8060.31487323584;4648.372469716613;4654.115718013567;4655.627549796008;4661.860144195612;4665.6967297125575;3751.981240093782;3887.688984881203;4084.7344922579937;4298.613124818781;4328.523862375137;3384.5430866833153;3519.1729943463265;3521.3837578423672;3528.8764893228613;3637.418013117888;1033.8397548380012;1044.4203467075845;1045.743792770776;1049.228816819637;1050.5325130316935;779.2207792207793;779.3414564692825;782.4131901074194;792.7027364738224;804.7746630943345;5032.7483625819295;5132.153194722829;5218.895622087537;5272.420033796279;5338.572914166857;415.45575296361864;437.06032031133316;440.11756428360934;901.5987885390938;905.1446383167975;3638.0904773806546;3674.6692797647806;3685.6867166291167;3695.5380577427823;3752.981235093807;9634.470104144199;9769.364991275545;9910.405375677483;10002.449865257335;10016.699499014896;9732.610695572239;9853.50732463374;9929.113468440974;9957.850632240523;9973.850392244121;7044.859102817915;7122.643867806589;7138.964305178441;7205.423566114699;7256.092988376558;5294.602904782234;5327.413984461628;5332.5467335276935;5344.625876188629;5366.6243362964215;8672.913270867211;8685;8750.081241469554;8758.518281494578;8777.03452620224;8761.518116503654;8888.60001299956;8922.464652120894;8983.371164018456;9046.954765226132;5861.472467477777;6592.80221593353;6633.2040155181685;6739.629320387229;6770.747411728846;7204.56772593646;7280.745173918887;7293.416526677747;7293.9635301823155;7299.635018249172;6445.742170313322;6587.176602924635;6594.307597702172;6697.832554186184;6723.764668236784;6620.2386725527185;6624.271330153583;6651.667416629246;6684.465242780663;6724.361185687352;6076.179715738495;6120.387961204022;6178.938210617836;6194.628322300677;6198.411150940653;4378.846740364072;4379.4525684289465;4481.932771008373;4517.480489743722;4521.728696278234;4402.207602631557;4431.003024319502;4459.6655250855665;4504.77476126199;4513.390692256503 05:06:16 INFO - PROCESS | 10697 | |4;prototype.html;302.8546297777067;304.4793403280391;304.71356924490976;311.8440779610195;314.4151877507837;5023.221400682895;5062.164742817431;5062.848114556565;5090.618203634728;5094;4980.676256043354;4995.550400463958;5013.448520662724;5016.172331565296;5019.397672279322;3746.1758413149064;3861.61383861613;3882.2041481496226;3950;3993.940090898639;3939.5075615548058;3956.6241207085423;3968.246033253687;3978.2242462719637;3986.5415477220054;3922.2547715934024;3927.7446965947124;3929.135590170158;3934.3705007198855;3939.0743175353914;3747.4940882980723;3768.152165762709;3916.784576848272;3920.4511368408444;3938.6258305460933;3461.048211741766;3472.9652703472893;3473.583170019614;3476.600190978045;3486.6861982421706;4733.077049975256;4763.737994410306;4783.3064205690325;4788.162071637485;4788.80844766209;4178.435911151986;4425.734455932622;4433.977830110861;4476.753778542179;4486.730796152208;5255.553277971377;5255.973720131375;5260.105782017066;5261.184516399964;5284.154535274376;3693.279810436966;3695.5380577427823;3699.5930447650735;3702.4446333049987;3721.14413684854;5457.145675115881;5485.396606373296;5492.642978206404;5560.388357280655;5582.581306401996;3764.3600587900123;3777.9244415111543;3779.7921114338424;3788.4696142539515;3797.715171362159;3822.1591249924973;3832.463455116286;3847.9230415391535;3855.4602355670227;3858.3247931611854;4443.600075993176;4448.110377924428;4455.554444555519;4457.442819647544;4462.866114016585;5109.284700141983;5278.516179321706;5303.124984377611;5308.654937429054;5316.1494160934835;1322.8015797630433;1330.8669133086808;1336.6791969927147;1336.8636658839907;1340.3633274194874;847.2078606502939;878.5299864572551;898.2634239923331;906.3338446242007;910.6630546697631;4642.0715856828765;4650;4651.116287905287;4654.627629789608;4668.066386722601;5419.132938729785;5427.782888684408;5434.619576629598;5451.64564303319;5464.43171709304;4465.486469056035;4616.907661846812;4631.166390049823;4643.094596553708;4648.349231107648;2879.4097210071886;2912.9126126216247;2923.8245705257755;2926.1075372011314;2931.5016447204025;5176.818811341585;5180.948190518122;5195.168772996302;5195.636305458582;5200.92198617021;5477.260569823103;5638.887222255532;5652.858678532987;5659.915101273484;5672.574556908248;5170.40540337866;5172.896542069213;5189.532942035159;5196.402413722319;5200.427952925175;5510.91733624004;5537.197106419627;5542.61201715876;5545.085060965057;5554.444555544414;5155.381354237516;5423.511883930308;5431.2667789847865;5435.456454354533;5463.098588732814;5163.66436181647;5165.638405311592;5167.896642067213;5182.844514664566;5216.739163041757;3884.2425726982965;3917.823697933543;3930.390789427643;3942;3950.4469374287046;5212.765425555784;5477.287952566141;5493.285872836505;5499.3675727291875;5510.448955104457;5307.203919412119;5324.227986941794;5336.893262134813;5341.145416733304;5355.009323275207;5230.241614965733;5311.575073993994;5344.412114667306;5346.438623944586;5346.893062138658;5228.503292187236;5265.7367131642495;5276.604254680838;5280.683159010472;5293.841184764463;5133.6919784813035;5190.740462976761;5345.33183352081;5360.0887849064975;5373.140297552372;5201.635885487979;5211.583073354047;5218.895622087461;5220.504052115043;5226.137687281556 05:06:16 INFO - PROCESS | 10697 | |5;yui.html;568.9431056894311;578.3551340255614;608.0484042473529;608.695652173913;614.6066517428843;12080.818787718192;12118.091143164265;12194.390280485984;12498.062645301605;12513.624591262265;11798.94100529496;11873.584424545143;11924.642260732191;11935.283882967027;11940.701482462942;624.6658037949709;641.6503005861794;643.5945354426705;643.7006791841793;753.1414187825883;787.8621241282781;794.6702118620766;794.7019867549669;794.8291117409756;794.9324307433875;823.1685997142899;827.4952279109739;828.3125006244833;828.4490813608973;828.8466633672759;657.5364368120463;810.4367464612097;827.23480780278;827.548985802736;836.0970152235572;608.2518502242223;608.5466327585932;608.8995315772892;609.6007115339415;609.9451049405575;12357.073219508484;12361.443735031946;12393.318367489785;12399.194052386567;12404.875951240463;11715.7071073223;12556.434960426803;12828.102032857703;12962.416691248916;13098.86901130986;9433.386829856037;9564.473953932531;9599.664011759625;9664.226861851106;9711.757206069904;3193.8882139125253;3218.1793642621215;3227.951580726291;3279.8360081996043;3285.638579756249;50129.74935125301;50166.7491662543;50566.74716626394;50767.23849142266;50976.99999999963;8638.352123590756;8853.114688531225;8908.331875109392;9302.302327325342;9361.204297634777;16258.837411625733;16428.17859107064;16468;16491.34034638601;16498.092604906604;6460.612363258219;6513.938448928996;6820.35206655367;6887.2079710832895;7019.89470157948;3628.1111127773866;3645.5078564393466;3656.5794933582447;3662.285854258394;3673;2914.621099257083;2952.808067475607;2958.511845545504;2964.985175074111;2969.035063604337;519.4519781630416;541.9458054194549;547.3404547520229;555.7304707216997;561.0434209672499;482.7936330967445;489.28320011183786;506.2864729369581;533.6931264522915;561.9325680918234;6980.685869135901;7141.464390170758;7272.63636818157;7299.89050164248;7499.887501687479;474.55866044578875;474.89789695215694;497.4975274972232;514.4758404926225;524.1325606121875;3238.125706059398;3409.9659003410143;3421.555197824267;3427.485877118452;3505.509228707983;47725.284120738215;52374;53883;54225.45774542283;54447.45552544424;46635.76682116568;46930;46973.5302646976;47017.52982470131;47848.521514785105;42208.57791422046;42680.57319426766;42912.14175716468;43656.78171609185;44197.337039944425;6940.167179938439;6941.0629565010095;7340.376068034277;7395.630218488946;7410.2219266978345;25560.488790224463;26093;26620.7337926626;27590.172294831187;28456.146315610564;34028.149296267795;35417.291654166256;35969.86346570178;36019.81990090033;36188;8945.23965462917;9211.447313160963;9296.674616388394;9414;9573.377730447499;10257;10293.74265643335;10334.689959301233;10343.534540945526;10456.68629941103;7727.845443090994;8483.409261402892;9481.431114133175;9727.805443891224;9751.414915105117;9795.657151999645;9868.358556693793;9877.110370965958;9918.553665084944;10055.798884022424;9649.662261820802;9768.316217864682;9778.55996480146;9940.502974851084;9953.253505987224;8406;8580.184882436159;8600.698975535826;8926.910730892867;9025.232855207381;8541.316694664536;8635.438696484709;8782.736517904474;8787.780305492413;8946.68686595966 05:06:16 INFO - PROCESS | 10697 | __end_tp_report 05:06:16 INFO - PROCESS | 10697 | __start_cc_report 05:06:16 INFO - PROCESS | 10697 | _x_x_mozilla_cycle_collect,907 05:06:16 INFO - PROCESS | 10697 | __end_cc_report 05:06:16 INFO - PROCESS | 10697 | __startTimestamp1461585976649__endTimestamp 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | ------- Summary: start ------- 05:06:16 INFO - PROCESS | 10697 | Number of tests: 6 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | [#0] dojo.html Cycles:165 Average:4624.25 Median:4767.88 stddev:482.13 (10.1%) stddev-sans-first:456.76 05:06:16 INFO - PROCESS | 10697 | Values: 2601.7 2669.9 2672.0 2682.0 2705.6 4586.7 4657.4 4660.2 4696.6 4698.1 4633.9 4701.3 4720.2 4786.9 4804.6 4267.6 4273.7 4308.9 4337.5 4398.0 4329.9 4352.8 4375.1 4385.9 4430.3 4214.8 4262.7 4321.8 4351.8 4354.1 4245.0 4281.3 4284.4 4328.3 4376.5 4261.6 4278.8 4284.3 4290.4 4323.7 4443.8 4594.6 4615.9 4671.2 4687.2 5012.8 5023.2 5025.6 5032.0 5036.9 5047.8 5056.1 5064.2 5069.2 5094.8 4555.0 4633.5 4711.8 4712.4 4719.0 5148.0 5156.7 5162.0 5162.1 5164.1 4829.7 4945.1 4955.9 4961.4 5001.4 5030.0 5042.1 5061.6 5080.8 5113.3 4916.4 4926.7 4927.5 4932.2 4978.5 4833.0 4912.3 4912.9 4932.8 4951.7 4219.3 4226.7 4244.4 4253.3 4266.9 3664.1 3682.1 3682.9 3709.9 3734.1 4229.9 4272.8 4277.4 4297.9 4317.2 4964.9 4974.1 4984.3 5012.8 5046.6 4238.5 4252.8 4256.4 4270.8 4312.5 4363.0 4421.3 4440.6 4467.8 4485.6 4671.4 4693.4 4695.9 4721.3 4732.4 4982.9 4989.5 4992.4 4999.9 5048.1 4658.0 4694.0 4709.0 4767.9 4772.3 4899.6 4919.5 4929.6 4932.6 4985.9 4973.9 4988.0 4989.8 4990.8 5067.0 4768.5 4873.0 4930.9 4952.0 4961.8 4837.3 4846.2 4868.1 4870.3 4918.2 4645.0 4783.9 4795.3 4801.9 4858.6 4846.5 4916.1 4917.5 4969.0 4969.6 4809.7 4834.6 4846.7 4850.9 4911.3 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | [#1] ext.html Cycles:180 Average:40072.24 Median:34352.57 stddev:66827.67 (194.5%) stddev-sans-first:66949.36 05:06:16 INFO - PROCESS | 10697 | Values: 581.8 592.8 603.0 610.0 635.0 32798.0 34087.0 34097.2 34140.7 34209.7 36376.5 36900.8 37082.8 37097.8 37118.3 7752.5 7949.5 7960.0 7965.9 7966.8 7723.5 7759.4 7834.1 7843.3 7848.1 7817.7 7877.6 7885.9 7888.6 7890.3 7810.8 7852.5 7858.3 7869.2 7870.1 7770.8 7861.6 7873.2 7883.4 7890.6 36939.8 37367.1 37520.2 37528.0 37551.0 2620.1 2810.5 2922.3 2924.9 3294.3 28107.3 28304.4 28306.2 28493.3 28733.8 3301.5 3380.7 3388.5 3393.2 3416.9 239274.8 239508.0 239599.0 240786.0 241188.0 46009.1 46049.1 46169.6 46432.0 49127.3 52501.8 52869.0 52883.2 52951.0 53053.5 12237.7 12932.2 13329.3 13336.5 13341.3 9517.7 9544.0 9568.1 9571.9 9584.6 13353.8 14324.8 14358.5 14411.1 14412.9 5541.8 5564.9 5665.7 5686.9 5692.7 857.2 906.8 912.8 956.8 959.3 26397.0 27528.3 27569.7 27708.7 28214.4 943.4 954.7 972.9 1002.1 1027.3 14179.3 14779.3 14892.3 14896.9 15703.9 161512.0 164158.0 164456.0 164678.0 164987.0 47476.0 48776.0 48951.5 48960.0 49012.5 1145.5 1241.9 1243.6 1249.9 1272.6 26678.9 27685.4 27740.6 28138.1 28452.9 41316.6 41786.2 41831.8 41869.0 41929.0 328462.0 329842.0 332144.0 332641.0 333344.0 21788.7 23739.5 23774.4 24097.3 24105.2 37806.0 37940.0 38078.6 38806.2 38862.0 31772.0 32797.7 33170.5 33251.3 33396.2 32304.4 32802.8 33234.7 34046.0 34679.5 33467.5 34021.8 34320.0 34385.1 34486.7 30190.0 31250.5 34413.0 34565.5 34899.3 23354.8 23373.4 23509.6 23879.0 23972.4 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | [#2] jquery.html Cycles:180 Average:21905.61 Median:4480.31 stddev:52127.98 (1163.5%) stddev-sans-first:52249.16 05:06:16 INFO - PROCESS | 10697 | Values: 378.9 383.3 384.2 388.3 391.4 15494.7 17089.9 17125.2 17128.8 17143.1 11496.8 15251.2 15975.0 16001.2 16032.2 4600.5 4701.1 4757.5 4758.6 4759.9 3502.5 5047.4 5288.0 5309.8 5316.7 5296.1 5335.7 5336.2 5340.3 5366.1 5286.4 5396.5 5397.2 5407.7 5413.2 4999.6 5097.2 5178.5 5181.1 5181.3 12662.0 12737.5 12839.2 12878.9 12880.7 1787.8 1854.7 1904.2 1956.5 1978.7 9007.3 9180.0 9359.3 9425.7 13131.8 1686.2 1688.2 1777.7 1781.6 1829.8 69911.3 74784.3 75193.6 76182.6 76272.6 10309.6 10461.6 10477.9 10561.0 10562.4 14172.4 14318.9 14394.8 14499.6 14557.5 6950.7 6996.4 7027.7 7199.0 7238.5 6546.1 6570.7 6639.9 6684.3 6697.8 4328.8 4419.1 4463.5 4473.0 4487.7 1732.8 1753.2 1781.6 1805.9 1848.0 839.4 847.3 857.7 876.6 896.2 16193.4 16545.4 16622.1 16965.1 17222.8 800.6 805.9 824.4 827.5 916.9 5693.8 5800.7 5911.5 5938.1 9071.3 302153.0 307408.0 310839.0 311490.0 316393.0 78315.6 78785.0 82386.6 83091.0 83236.6 449.8 452.2 459.4 460.4 461.3 14147.4 14697.3 15463.2 15490.3 15896.7 26098.2 36558.5 38701.0 39431.6 40295.0 49700.0 51113.0 51146.5 51407.7 52178.7 7639.2 7768.7 7858.4 8030.9 8186.0 8782.5 10209.6 11272.7 11451.4 11741.5 5594.5 8146.8 8626.8 9822.2 10057.9 10241.0 10560.4 10639.5 10857.3 10905.1 10011.4 10128.9 10150.6 10305.8 10376.7 7636.6 7894.7 7926.2 8060.1 8162.3 10680.4 10775.8 10827.0 10957.8 10988.5 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | [#3] mootools.html Cycles:180 Average:5084.94 Median:5082.45 stddev:2854.69 (56.2%) stddev-sans-first:2847.96 05:06:16 INFO - PROCESS | 10697 | Values: 1224.9 1434.4 1456.8 1577.4 1734.7 7602.8 7927.1 7934.0 7934.6 7963.3 7703.8 7849.7 7850.5 7861.6 7863.5 2242.9 2243.6 2246.3 2269.3 2269.4 2190.9 2207.9 2226.2 2235.3 2243.0 2199.7 2199.8 2202.0 2241.1 2300.1 2149.1 2168.7 2172.1 2176.1 2178.6 2179.9 2186.8 2194.0 2195.2 2203.2 7366.4 7541.3 7851.3 7892.2 7904.1 4614.3 4754.7 4760.0 4761.3 4777.8 2850.4 2874.1 2899.2 2900.5 2902.6 891.2 907.8 927.6 933.2 946.2 10570.9 10683.8 10693.6 10699.6 10727.1 4038.4 4237.8 4305.9 4365.6 4392.6 7927.6 7972.7 8016.8 8024.0 8060.3 4648.4 4654.1 4655.6 4661.9 4665.7 3752.0 3887.7 4084.7 4298.6 4328.5 3384.5 3519.2 3521.4 3528.9 3637.4 1033.8 1044.4 1045.7 1049.2 1050.5 779.2 779.3 782.4 792.7 804.8 5032.7 5132.2 5218.9 5272.4 5338.6 415.5 437.1 440.1 901.6 905.1 3638.1 3674.7 3685.7 3695.5 3753.0 9634.5 9769.4 9910.4 10002.4 10016.7 9732.6 9853.5 9929.1 9957.9 9973.9 7044.9 7122.6 7139.0 7205.4 7256.1 5294.6 5327.4 5332.5 5344.6 5366.6 8672.9 8685.0 8750.1 8758.5 8777.0 8761.5 8888.6 8922.5 8983.4 9047.0 5861.5 6592.8 6633.2 6739.6 6770.7 7204.6 7280.7 7293.4 7294.0 7299.6 6445.7 6587.2 6594.3 6697.8 6723.8 6620.2 6624.3 6651.7 6684.5 6724.4 6076.2 6120.4 6178.9 6194.6 6198.4 4378.8 4379.5 4481.9 4517.5 4521.7 4402.2 4431.0 4459.7 4504.8 4513.4 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | [#4] prototype.html Cycles:180 Average:4394.25 Median:5042.69 stddev:1288.72 (25.6%) stddev-sans-first:1255.22 05:06:16 INFO - PROCESS | 10697 | Values: 302.9 304.5 304.7 311.8 314.4 5023.2 5062.2 5062.8 5090.6 5094.0 4980.7 4995.6 5013.4 5016.2 5019.4 3746.2 3861.6 3882.2 3950.0 3993.9 3939.5 3956.6 3968.2 3978.2 3986.5 3922.3 3927.7 3929.1 3934.4 3939.1 3747.5 3768.2 3916.8 3920.5 3938.6 3461.0 3473.0 3473.6 3476.6 3486.7 4733.1 4763.7 4783.3 4788.2 4788.8 4178.4 4425.7 4434.0 4476.8 4486.7 5255.6 5256.0 5260.1 5261.2 5284.2 3693.3 3695.5 3699.6 3702.4 3721.1 5457.1 5485.4 5492.6 5560.4 5582.6 3764.4 3777.9 3779.8 3788.5 3797.7 3822.2 3832.5 3847.9 3855.5 3858.3 4443.6 4448.1 4455.6 4457.4 4462.9 5109.3 5278.5 5303.1 5308.7 5316.1 1322.8 1330.9 1336.7 1336.9 1340.4 847.2 878.5 898.3 906.3 910.7 4642.1 4650.0 4651.1 4654.6 4668.1 5419.1 5427.8 5434.6 5451.6 5464.4 4465.5 4616.9 4631.2 4643.1 4648.3 2879.4 2912.9 2923.8 2926.1 2931.5 5176.8 5180.9 5195.2 5195.6 5200.9 5477.3 5638.9 5652.9 5659.9 5672.6 5170.4 5172.9 5189.5 5196.4 5200.4 5510.9 5537.2 5542.6 5545.1 5554.4 5155.4 5423.5 5431.3 5435.5 5463.1 5163.7 5165.6 5167.9 5182.8 5216.7 3884.2 3917.8 3930.4 3942.0 3950.4 5212.8 5477.3 5493.3 5499.4 5510.4 5307.2 5324.2 5336.9 5341.1 5355.0 5230.2 5311.6 5344.4 5346.4 5346.9 5228.5 5265.7 5276.6 5280.7 5293.8 5133.7 5190.7 5345.3 5360.1 5373.1 5201.6 5211.6 5218.9 5220.5 5226.1 05:06:16 INFO - PROCESS | 10697 | 05:06:16 INFO - PROCESS | 10697 | [#5] yui.html Cycles:180 Average:12388.20 Median:54336.46 stddev:14689.90 (27.0%) stddev-sans-first:14704.30 05:06:16 INFO - PROCESS | 10697 | Values: 568.9 578.4 608.0 608.7 614.6 12080.8 12118.1 12194.4 12498.1 12513.6 11798.9 11873.6 11924.6 11935.3 11940.7 624.7 641.7 643.6 643.7 753.1 787.9 794.7 794.7 794.8 794.9 823.2 827.5 828.3 828.4 828.8 657.5 810.4 827.2 827.5 836.1 608.3 608.5 608.9 609.6 609.9 12357.1 12361.4 12393.3 12399.2 12404.9 11715.7 12556.4 12828.1 12962.4 13098.9 9433.4 9564.5 9599.7 9664.2 9711.8 3193.9 3218.2 3228.0 3279.8 3285.6 50129.7 50166.7 50566.7 50767.2 50977.0 8638.4 8853.1 8908.3 9302.3 9361.2 16258.8 16428.2 16468.0 16491.3 16498.1 6460.6 6513.9 6820.4 6887.2 7019.9 3628.1 3645.5 3656.6 3662.3 3673.0 2914.6 2952.8 2958.5 2965.0 2969.0 519.5 541.9 547.3 555.7 561.0 482.8 489.3 506.3 533.7 561.9 6980.7 7141.5 7272.6 7299.9 7499.9 474.6 474.9 497.5 514.5 524.1 3238.1 3410.0 3421.6 3427.5 3505.5 47725.3 52374.0 53883.0 54225.5 54447.5 46635.8 46930.0 46973.5 47017.5 47848.5 42208.6 42680.6 42912.1 43656.8 44197.3 6940.2 6941.1 7340.4 7395.6 7410.2 25560.5 26093.0 26620.7 27590.2 28456.1 34028.1 35417.3 35969.9 36019.8 36188.0 8945.2 9211.4 9296.7 9414.0 9573.4 10257.0 10293.7 10334.7 10343.5 10456.7 7727.8 8483.4 9481.4 9727.8 9751.4 9795.7 9868.4 9877.1 9918.6 10055.8 9649.7 9768.3 9778.6 9940.5 9953.3 8406.0 8580.2 8600.7 8926.9 9025.2 8541.3 8635.4 8782.7 8787.8 8946.7 05:06:16 INFO - PROCESS | 10697 | -------- Summary: end -------- 05:06:16 INFO - PROCESS | 10697 | 05:06:17 INFO - TEST-INFO | 10697: exit 0 05:06:17 INFO - TEST-OK | dromaeo_css | took 1118428ms 05:06:17 INFO - TEST-START | kraken 05:06:17 INFO - operating with platform_type : linux_ 05:06:17 INFO - Initialising browser for kraken test... 05:06:17 INFO - TEST-INFO | started process 10871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKlGXA5/profile http://localhost:54714/getInfo.html) 05:06:21 INFO - PROCESS | 10871 | __metrics Screen width/height:1600/1200 05:06:21 INFO - PROCESS | 10871 | colorDepth:24 05:06:21 INFO - PROCESS | 10871 | Browser inner width/height: 1024/697 05:06:21 INFO - PROCESS | 10871 | __metrics 05:06:23 ERROR - PROCESS | 10871 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:06:23 INFO - TEST-INFO | 10871: exit 0 05:06:23 INFO - Browser initialized. 05:06:23 INFO - Running cycle 1/1 for kraken test... 05:06:23 INFO - TEST-INFO | started process 10953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKlGXA5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:06:35 INFO - PROCESS | 10953 | RSS: Main: 155287552 05:06:35 INFO - PROCESS | 10953 | 05:06:38 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-beat-detection) 05:06:39 INFO - PROCESS | 10953 | RSS: Main: 209887232 05:06:39 INFO - PROCESS | 10953 | 05:06:42 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-dft) 05:06:42 INFO - PROCESS | 10953 | RSS: Main: 195448832 05:06:42 INFO - PROCESS | 10953 | 05:06:46 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-fft) 05:06:46 INFO - PROCESS | 10953 | RSS: Main: 267075584 05:06:46 INFO - PROCESS | 10953 | 05:06:48 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54714/tests/kraken/driver.html?testName=audio-oscillator) 05:06:49 INFO - PROCESS | 10953 | RSS: Main: 175136768 05:06:49 INFO - PROCESS | 10953 | 05:06:51 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:06:52 INFO - PROCESS | 10953 | RSS: Main: 179085312 05:06:52 INFO - PROCESS | 10953 | 05:06:55 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54714/tests/kraken/driver.html?testName=imaging-darkroom) 05:06:56 INFO - PROCESS | 10953 | RSS: Main: 214839296 05:06:56 INFO - PROCESS | 10953 | 05:06:59 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54714/tests/kraken/driver.html?testName=imaging-desaturate) 05:07:00 INFO - PROCESS | 10953 | RSS: Main: 215576576 05:07:00 INFO - PROCESS | 10953 | 05:07:03 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54714/tests/kraken/driver.html?testName=json-parse-financial) 05:07:03 INFO - PROCESS | 10953 | RSS: Main: 215601152 05:07:03 INFO - PROCESS | 10953 | 05:07:05 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:07:05 INFO - PROCESS | 10953 | RSS: Main: 200814592 05:07:05 INFO - PROCESS | 10953 | 05:07:07 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:07:08 INFO - PROCESS | 10953 | RSS: Main: 204210176 05:07:08 INFO - PROCESS | 10953 | 05:07:10 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:07:11 INFO - PROCESS | 10953 | RSS: Main: 219713536 05:07:11 INFO - PROCESS | 10953 | 05:07:13 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:07:14 INFO - PROCESS | 10953 | RSS: Main: 225480704 05:07:14 INFO - PROCESS | 10953 | 05:07:17 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:07:18 INFO - PROCESS | 10953 | RSS: Main: 220590080 05:07:18 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | Cycle 1(1): loaded http://localhost:54714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54714/tests/kraken/driver.html?testName=ai-astar) 05:07:20 INFO - PROCESS | 10953 | RSS: Main: 283590656 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | __start_tp_report 05:07:20 INFO - PROCESS | 10953 | _x_x_mozilla_page_load 05:07:20 INFO - PROCESS | 10953 | _x_x_mozilla_page_load_details 05:07:20 INFO - PROCESS | 10953 | |i|pagename|runs| 05:07:20 INFO - PROCESS | 10953 | |0;ai-astar;111;114;107;111;112;113;100;112;113;113 05:07:20 INFO - PROCESS | 10953 | |1;audio-beat-detection;172;134;155;185;133;156;161;133;189;131 05:07:20 INFO - PROCESS | 10953 | |2;audio-dft;165;162;161;163;164;163;166;161;162;163 05:07:20 INFO - PROCESS | 10953 | |3;audio-fft;75;74;112;112;74;73;74;120;102;73 05:07:20 INFO - PROCESS | 10953 | |4;audio-oscillator;94;94;145;93;95;95;148;93;94;149 05:07:20 INFO - PROCESS | 10953 | |5;imaging-gaussian-blur;117;117;116;118;117;117;117;117;117;117 05:07:20 INFO - PROCESS | 10953 | |6;imaging-darkroom;145;146;145;145;146;146;145;145;146;146 05:07:20 INFO - PROCESS | 10953 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;94;95 05:07:20 INFO - PROCESS | 10953 | |8;json-parse-financial;64;65;64;64;64;65;65;85;63;63 05:07:20 INFO - PROCESS | 10953 | |9;json-stringify-tinderbox;63;67;67;64;65;64;64;64;64;64 05:07:20 INFO - PROCESS | 10953 | |10;stanford-crypto-aes;80;78;79;80;90;80;83;82;81;80 05:07:20 INFO - PROCESS | 10953 | |11;stanford-crypto-ccm;140;133;134;130;132;130;132;132;167;144 05:07:20 INFO - PROCESS | 10953 | |12;stanford-crypto-pbkdf2;178;179;175;174;181;174;175;174;182;173 05:07:20 INFO - PROCESS | 10953 | |13;stanford-crypto-sha256-iterative;73;76;72;72;72;72;73;72;70;71 05:07:20 INFO - PROCESS | 10953 | __end_tp_report 05:07:20 INFO - PROCESS | 10953 | __start_cc_report 05:07:20 INFO - PROCESS | 10953 | _x_x_mozilla_cycle_collect,1924 05:07:20 INFO - PROCESS | 10953 | __end_cc_report 05:07:20 INFO - PROCESS | 10953 | __startTimestamp1461586040258__endTimestamp 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | ------- Summary: start ------- 05:07:20 INFO - PROCESS | 10953 | Number of tests: 14 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:4.20 (3.7%) stddev-sans-first:4.45 05:07:20 INFO - PROCESS | 10953 | Values: 111.0 114.0 107.0 111.0 112.0 113.0 100.0 112.0 113.0 113.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:158.50 stddev:22.03 (13.9%) stddev-sans-first:22.48 05:07:20 INFO - PROCESS | 10953 | Values: 172.0 134.0 155.0 185.0 133.0 156.0 161.0 133.0 189.0 131.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.63 (1.0%) stddev-sans-first:1.56 05:07:20 INFO - PROCESS | 10953 | Values: 165.0 162.0 161.0 163.0 164.0 163.0 166.0 161.0 162.0 163.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#3] audio-fft Cycles:10 Average:88.90 Median:73.50 stddev:19.92 (27.1%) stddev-sans-first:20.48 05:07:20 INFO - PROCESS | 10953 | Values: 75.0 74.0 112.0 112.0 74.0 73.0 74.0 120.0 102.0 73.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:94.00 stddev:25.79 (27.4%) stddev-sans-first:26.70 05:07:20 INFO - PROCESS | 10953 | Values: 94.0 94.0 145.0 93.0 95.0 95.0 148.0 93.0 94.0 149.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:07:20 INFO - PROCESS | 10953 | Values: 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:07:20 INFO - PROCESS | 10953 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:07:20 INFO - PROCESS | 10953 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:64.50 stddev:6.65 (10.3%) stddev-sans-first:7.00 05:07:20 INFO - PROCESS | 10953 | Values: 64.0 65.0 64.0 64.0 64.0 65.0 65.0 85.0 63.0 63.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.00 stddev:1.35 (2.1%) stddev-sans-first:1.30 05:07:20 INFO - PROCESS | 10953 | Values: 63.0 67.0 67.0 64.0 65.0 64.0 64.0 64.0 64.0 64.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.50 stddev:3.37 (4.2%) stddev-sans-first:3.54 05:07:20 INFO - PROCESS | 10953 | Values: 80.0 78.0 79.0 80.0 90.0 80.0 83.0 82.0 81.0 80.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:133.50 stddev:11.33 (8.5%) stddev-sans-first:11.97 05:07:20 INFO - PROCESS | 10953 | Values: 140.0 133.0 134.0 130.0 132.0 130.0 132.0 132.0 167.0 144.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:176.50 stddev:3.24 (1.8%) stddev-sans-first:3.39 05:07:20 INFO - PROCESS | 10953 | Values: 178.0 179.0 175.0 174.0 181.0 174.0 175.0 174.0 182.0 173.0 05:07:20 INFO - PROCESS | 10953 | 05:07:20 INFO - PROCESS | 10953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:1.57 (2.2%) stddev-sans-first:1.64 05:07:20 INFO - PROCESS | 10953 | Values: 73.0 76.0 72.0 72.0 72.0 72.0 73.0 72.0 70.0 71.0 05:07:20 INFO - PROCESS | 10953 | -------- Summary: end -------- 05:07:20 INFO - PROCESS | 10953 | 05:07:21 INFO - TEST-INFO | 10953: exit 0 05:07:21 INFO - TEST-OK | kraken | took 63899ms 05:07:21 INFO - SUITE-END | took 1182s 05:07:21 INFO - Completed test suite (00:19:42) 05:07:21 INFO - javascript benchmark 05:07:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.7008044074933, 2669.906553270636, 2672.0426093232786, 2681.9731802681968, 2705.5535836586964, 4586.656000799945, 4657.417822772153, 4660.184467718149, 4696.577308042276, 4698.060387922412, 4633.930491042637, 4701.294805779135, 4720.150372932871, 4786.9042619147685, 4804.639652026103, 4267.573242675739, 4273.679474039444, 4308.913821723564, 4337.544557821415, 4397.978010109945, 4329.913401731964, 4352.782360881959, 4375.14684636496, 4385.934210986838, 4430.335449682558, 4214.768187749688, 4262.680298977589, 4321.848735294249, 4351.782410879475, 4354.107407981356, 4245.0, 4281.272183728774, 4284.421603083606, 4328.329108988112, 4376.474823021226, 4261.637760790337, 4278.807453664593, 4284.271673815459, 4290.420793192941, 4323.6757243206885, 4443.777811109464, 4594.632429405639, 4615.861524154281, 4671.205894997858, 4687.20317546018, 5012.8496145115705, 5023.2214006828635, 5025.597952163818, 5031.974840125813, 5036.874078148039, 5047.848564543069, 5056.115179843513, 5064.18972964324, 5069.188929771219, 5094.821681241176, 4555.04344087742, 4633.467151277646, 4711.764411779466, 4712.410948631421, 4718.95281047192, 5148.0476111919415, 5156.716380599103, 5162.045021670928, 5162.148245539444, 5164.096283150434, 4829.73436460991, 4945.134601444733, 4955.925661115086, 4961.355023846949, 5001.44984051754, 5030.044291584587, 5042.09242336383, 5061.620378471629, 5080.822171223989, 5113.3097031900215, 4916.385451818523, 4926.704397736075, 4927.482614325444, 4932.21084626458, 4978.5270399312, 4832.95167048332, 4912.336834527365, 4912.901741965212, 4932.827351042768, 4951.72765497901, 4219.282721937278, 4226.661867050629, 4244.405783190356, 4253.2769429197115, 4266.914661706748, 3664.0656632558525, 3682.1346983458866, 3682.9447558286647, 3709.870154544578, 3734.141147536082, 4229.936550951738, 4272.764997925144, 4277.379779931893, 4297.892552686208, 4317.158154159909, 4964.925526117111, 4974.054929563371, 4984.252362145708, 5012.8496145115705, 5046.596272298208, 4238.533761286256, 4252.829886804555, 4256.404103425523, 4270.829166833292, 4312.547182545787, 4363.0, 4421.314696222091, 4440.62254708347, 4467.843625473093, 4485.641148708096, 4671.392718946651, 4693.366395536559, 4695.906081878275, 4721.315409265706, 4732.361131247307, 4982.900341993068, 4989.451160372283, 4992.350994370709, 4999.875003124951, 5048.091343558195, 4657.953420465752, 4694.0, 4709.0, 4767.880802979815, 4772.308015337687, 4899.632527560376, 4919.532644398776, 4929.580985616263, 4932.580730637793, 4985.875353116201, 4973.925391119208, 4987.950120498894, 4989.80040798364, 4990.750462476934, 5067.011932673094, 4768.546988036131, 4873.049755297683, 4930.8767280818265, 4951.984843107082, 4961.776720047678, 4837.250226214942, 4846.248831431134, 4868.099401610713, 4870.269459581091, 4918.188498897642, 4645.02454484562, 4783.928241076456, 4795.256735206049, 4801.927971080367, 4858.611311095033, 4846.491118432514, 4916.0905232532095, 4917.459079501181, 4969.0, 4969.6272779542405, 4809.735464549483, 4834.6374021947795, 4846.709197448024, 4850.927236091532, 4911.3369695090705], "value": 4594.028411026753, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.7556626216989, 592.7569696424467, 602.990955135673, 609.953929011745, 635.0, 32798.0, 34087.0, 34097.22638830559, 34140.65859341406, 34209.65790342096, 36376.45435318472, 36900.815495922485, 37082.81458592703, 37097.814510927405, 37118.25763484729, 7752.496087754306, 7949.523028618272, 7960.0, 7965.8805117923275, 7966.760997170094, 7723.459357844953, 7759.41804364672, 7834.0990786059765, 7843.33331666809, 7848.136704962478, 7817.726379576716, 7877.566733829637, 7885.921140788605, 7888.60556972152, 7890.289873911347, 7810.843783124335, 7852.528848269094, 7858.332041776456, 7869.2130786921425, 7870.0949390820215, 7770.844583108363, 7861.606919653995, 7873.212678732139, 7883.448158628841, 7890.64492097857, 36939.81530092332, 37367.06582335436, 37520.24959500795, 37528.0, 37551.0, 2620.1045869113277, 2810.4519618674367, 2922.327864591156, 2924.8976285829895, 3294.258791771856, 28107.29731756702, 28304.43391132166, 28306.15081547557, 28493.287667808472, 28733.784812583002, 3301.5377847101427, 3380.6619338066243, 3388.542546756181, 3393.1686736749652, 3416.931661366784, 239274.8036259825, 239508.0, 239599.0, 240786.0, 241188.0, 46009.07981840344, 46049.07901841944, 46169.61491155271, 46432.0, 49127.26309105366, 52501.84988900678, 52869.0, 52883.20675189875, 52951.0, 53053.46946530485, 12237.694057648452, 12932.159409638343, 13329.266890321125, 13336.466541338432, 13341.332933353293, 9517.714468565953, 9543.952280238555, 9568.138867501819, 9571.856422153673, 9584.568694408768, 13353.799693004612, 14324.785128223086, 14358.497452589108, 14411.135331880121, 14412.855871441361, 5541.833744987657, 5564.916526252109, 5665.716714164275, 5686.886262274731, 5692.743826527816, 857.2028013946964, 906.8141031088611, 912.8448163812168, 956.8325543029941, 959.2709540749081, 26397.0, 27528.311792204953, 27569.724302756716, 27708.722912771016, 28214.43571128566, 943.429225318686, 954.6658669465631, 972.9270304727032, 1002.1181360402799, 1027.342500799489, 14179.346713341954, 14779.26103694811, 14892.255387230594, 14896.851031489763, 15703.921480392753, 161512.0, 164158.0, 164456.0, 164678.0, 164987.0, 47476.0, 48776.0, 48951.51048489541, 48960.0, 49012.509874900796, 1145.5475087340453, 1241.85097788266, 1243.620695687806, 1249.850017997828, 1272.5673271087874, 26678.866605666848, 27685.446291073662, 27740.583891241244, 28138.118343253886, 28452.85773571119, 41316.586834132475, 41786.1642767149, 41831.7908410456, 41869.0, 41929.0, 328462.0, 329842.0, 332144.0, 332641.0, 333344.0, 21788.67316990278, 23739.52520949606, 23774.40563985845, 24097.277081687578, 24105.19211059213, 37806.0, 37940.0, 38078.619213807506, 38806.2238755229, 38862.0, 31772.0, 32797.672023280415, 33170.50244246387, 33251.33497330088, 33396.1650958728, 32304.35391292208, 32802.83598581992, 33234.66765332316, 34046.0, 34679.47980780341, 33467.49798752972, 34021.829890850386, 34320.0, 34385.14037149091, 34486.655133448345, 30190.0, 31250.531242031844, 34413.0, 34565.48151777675, 34899.30201395907, 23354.766452335258, 23373.41566460852, 23509.647355289344, 23879.0, 23972.40068998289], "value": 16374.451605066999, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.888227972748, 383.2717836111388, 384.1951112419481, 388.3475760721986, 391.41092655553405, 15494.706606892632, 17089.914550427246, 17125.22936467862, 17128.82871171288, 17143.142842857855, 11496.770064598702, 15251.237438128104, 15975.0, 16001.19994000301, 16032.198390080508, 4600.539946005398, 4701.059788042405, 4757.452892917324, 4758.643101767364, 4759.928601070987, 3502.5271588335504, 5047.419546752134, 5287.973560132214, 5309.761060752276, 5316.680999140045, 5296.09966305727, 5335.679859208441, 5336.199570064483, 5340.305760251182, 5366.141417373221, 5286.392064912527, 5396.460353964611, 5397.217403476494, 5407.675539467645, 5413.242146099549, 4999.550040496373, 5097.1844504879045, 5178.508041736029, 5181.145111056671, 5181.274621552986, 12662.0, 12737.490500379974, 12839.229646221256, 12878.935605321913, 12880.677983050406, 1787.8480329172037, 1854.7310639957266, 1904.209752952523, 1956.491312258823, 1978.7328710624026, 9007.324450666161, 9180.0, 9359.25125989926, 9425.717228483156, 13131.803022954664, 1686.2496189195813, 1688.2318545061967, 1777.7066783980629, 1781.6080462298273, 1829.7621309229849, 69911.26109236345, 74784.25215747827, 75193.62403188004, 76182.6190869042, 76272.61863690647, 10309.639162629423, 10461.581536738446, 10477.947610262052, 10561.0, 10562.419066951237, 14172.362243699059, 14318.928405357907, 14394.784078238834, 14499.637509062359, 14557.490487832874, 6950.687219075154, 6996.370326670624, 7027.683754231072, 7199.0, 7238.493305468672, 6546.0835483032415, 6570.667413068388, 6639.900401493885, 6684.2981486944145, 6697.832554186087, 4328.8268469260875, 4419.11617676466, 4463.531329210451, 4472.9552704472535, 4487.6634252431195, 1732.8440440360175, 1753.2022929567017, 1781.5747402078543, 1805.9398183287274, 1847.9907600462182, 839.4417712221305, 847.3390755210945, 857.6655104509247, 876.588003638289, 896.188949001155, 16193.433229836899, 16545.420910268083, 16622.085785281924, 16965.13383527811, 17222.827771722372, 800.6477150053958, 805.8912046873597, 824.3611201318906, 827.5365795154732, 916.8991410944791, 5693.775838194808, 5800.6809625471005, 5911.497522710618, 5938.079597662283, 9071.27429805614, 302153.0, 307408.0, 310839.0, 311490.0, 316393.0, 78315.60842195866, 78785.0, 82386.58806705927, 83091.0, 83236.58381708174, 449.8425551057104, 452.1883219620789, 459.37754342864935, 460.35550229678717, 461.25046798951706, 14147.36336864823, 14697.338619761922, 15463.226838658247, 15490.302936368116, 15896.682066358839, 26098.217053488424, 36558.4516232262, 38701.0, 39431.60568394394, 40295.0, 49700.0, 51113.0, 51146.48853511417, 51407.74296128495, 52178.73855137408, 7639.159692433716, 7768.689252429839, 7858.371330293448, 8030.919690803251, 8186.017677878693, 8782.473051616924, 10209.642662506776, 11272.718182045515, 11451.370174640142, 11741.530338786353, 5594.468525490072, 8146.75559733209, 8626.792249085258, 9822.165115964937, 10057.949710251401, 10241.0, 10560.419176945341, 10639.468026598484, 10857.34855908648, 10905.073068789241, 10011.449370284414, 10128.949355253177, 10150.593976240867, 10305.793884122426, 10376.688699339033, 7636.579988100708, 7894.6842126314305, 7926.207379262028, 8060.073091594541, 8162.2653961141405, 10680.359178449318, 10775.838362424727, 10826.971437713404, 10957.780844382909, 10988.505517251902], "value": 7739.127436039706, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.926504409735, 1434.447737621016, 1456.7814827775835, 1577.4084718230663, 1734.6617409605124, 7602.7719168424965, 7927.128015918259, 7934.0, 7934.56359900206, 7963.283304502594, 7703.845923081535, 7849.68601255949, 7850.528968261909, 7861.56761378124, 7863.488873223237, 2242.8990695418665, 2243.573720993006, 2246.292417888368, 2269.31920423873, 2269.3645779181775, 2190.912363505458, 2207.87856667884, 2226.220822712054, 2235.307054813013, 2243.046705150313, 2199.659052846803, 2199.846010779246, 2201.9779802202015, 2241.1035585765662, 2300.148944890393, 2149.1403438624675, 2168.6963825064427, 2172.0660116150048, 2176.064292354287, 2178.56428714257, 2179.8801065941366, 2186.7813218678166, 2194.034624765098, 2195.242641288769, 2203.1848216159965, 7366.373858222058, 7541.283578060075, 7851.332636725885, 7892.171322011221, 7904.130545639975, 4614.284785858197, 4754.690945088558, 4759.952400476021, 4761.333413322138, 4777.784999674988, 2850.4299140171843, 2874.1377586723897, 2899.246195989037, 2900.4779139754837, 2902.5646153076996, 891.2379915172564, 907.795745957161, 927.6150397584994, 933.2440723014312, 946.2288235088449, 10570.894291057068, 10683.83974240387, 10693.625723099733, 10699.572017119306, 10727.088197503144, 4038.414429907647, 4237.766922819274, 4305.870823875289, 4365.628921541641, 4392.5607439256455, 7927.603619818986, 7972.681092756341, 8016.799580010546, 8024.0, 8060.31487323584, 4648.372469716613, 4654.115718013567, 4655.627549796008, 4661.860144195612, 4665.6967297125575, 3751.981240093782, 3887.688984881203, 4084.7344922579937, 4298.613124818781, 4328.523862375137, 3384.5430866833153, 3519.1729943463265, 3521.3837578423672, 3528.8764893228613, 3637.418013117888, 1033.8397548380012, 1044.4203467075845, 1045.743792770776, 1049.228816819637, 1050.5325130316935, 779.2207792207793, 779.3414564692825, 782.4131901074194, 792.7027364738224, 804.7746630943345, 5032.7483625819295, 5132.153194722829, 5218.895622087537, 5272.420033796279, 5338.572914166857, 415.45575296361864, 437.06032031133316, 440.11756428360934, 901.5987885390938, 905.1446383167975, 3638.0904773806546, 3674.6692797647806, 3685.6867166291167, 3695.5380577427823, 3752.981235093807, 9634.470104144199, 9769.364991275545, 9910.405375677483, 10002.449865257335, 10016.699499014896, 9732.610695572239, 9853.50732463374, 9929.113468440974, 9957.850632240523, 9973.850392244121, 7044.859102817915, 7122.643867806589, 7138.964305178441, 7205.423566114699, 7256.092988376558, 5294.602904782234, 5327.413984461628, 5332.5467335276935, 5344.625876188629, 5366.6243362964215, 8672.913270867211, 8685.0, 8750.081241469554, 8758.518281494578, 8777.03452620224, 8761.518116503654, 8888.60001299956, 8922.464652120894, 8983.371164018456, 9046.954765226132, 5861.472467477777, 6592.80221593353, 6633.2040155181685, 6739.629320387229, 6770.747411728846, 7204.56772593646, 7280.745173918887, 7293.416526677747, 7293.9635301823155, 7299.635018249172, 6445.742170313322, 6587.176602924635, 6594.307597702172, 6697.832554186184, 6723.764668236784, 6620.2386725527185, 6624.271330153583, 6651.667416629246, 6684.465242780663, 6724.361185687352, 6076.179715738495, 6120.387961204022, 6178.938210617836, 6194.628322300677, 6198.411150940653, 4378.846740364072, 4379.4525684289465, 4481.932771008373, 4517.480489743722, 4521.728696278234, 4402.207602631557, 4431.003024319502, 4459.6655250855665, 4504.77476126199, 4513.390692256503], "value": 4063.5013772053894, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.8546297777067, 304.4793403280391, 304.71356924490976, 311.8440779610195, 314.4151877507837, 5023.221400682895, 5062.164742817431, 5062.848114556565, 5090.618203634728, 5094.0, 4980.676256043354, 4995.550400463958, 5013.448520662724, 5016.172331565296, 5019.397672279322, 3746.1758413149064, 3861.61383861613, 3882.2041481496226, 3950.0, 3993.940090898639, 3939.5075615548058, 3956.6241207085423, 3968.246033253687, 3978.2242462719637, 3986.5415477220054, 3922.2547715934024, 3927.7446965947124, 3929.135590170158, 3934.3705007198855, 3939.0743175353914, 3747.4940882980723, 3768.152165762709, 3916.784576848272, 3920.4511368408444, 3938.6258305460933, 3461.048211741766, 3472.9652703472893, 3473.583170019614, 3476.600190978045, 3486.6861982421706, 4733.077049975256, 4763.737994410306, 4783.3064205690325, 4788.162071637485, 4788.80844766209, 4178.435911151986, 4425.734455932622, 4433.977830110861, 4476.753778542179, 4486.730796152208, 5255.553277971377, 5255.973720131375, 5260.105782017066, 5261.184516399964, 5284.154535274376, 3693.279810436966, 3695.5380577427823, 3699.5930447650735, 3702.4446333049987, 3721.14413684854, 5457.145675115881, 5485.396606373296, 5492.642978206404, 5560.388357280655, 5582.581306401996, 3764.3600587900123, 3777.9244415111543, 3779.7921114338424, 3788.4696142539515, 3797.715171362159, 3822.1591249924973, 3832.463455116286, 3847.9230415391535, 3855.4602355670227, 3858.3247931611854, 4443.600075993176, 4448.110377924428, 4455.554444555519, 4457.442819647544, 4462.866114016585, 5109.284700141983, 5278.516179321706, 5303.124984377611, 5308.654937429054, 5316.1494160934835, 1322.8015797630433, 1330.8669133086808, 1336.6791969927147, 1336.8636658839907, 1340.3633274194874, 847.2078606502939, 878.5299864572551, 898.2634239923331, 906.3338446242007, 910.6630546697631, 4642.0715856828765, 4650.0, 4651.116287905287, 4654.627629789608, 4668.066386722601, 5419.132938729785, 5427.782888684408, 5434.619576629598, 5451.64564303319, 5464.43171709304, 4465.486469056035, 4616.907661846812, 4631.166390049823, 4643.094596553708, 4648.349231107648, 2879.4097210071886, 2912.9126126216247, 2923.8245705257755, 2926.1075372011314, 2931.5016447204025, 5176.818811341585, 5180.948190518122, 5195.168772996302, 5195.636305458582, 5200.92198617021, 5477.260569823103, 5638.887222255532, 5652.858678532987, 5659.915101273484, 5672.574556908248, 5170.40540337866, 5172.896542069213, 5189.532942035159, 5196.402413722319, 5200.427952925175, 5510.91733624004, 5537.197106419627, 5542.61201715876, 5545.085060965057, 5554.444555544414, 5155.381354237516, 5423.511883930308, 5431.2667789847865, 5435.456454354533, 5463.098588732814, 5163.66436181647, 5165.638405311592, 5167.896642067213, 5182.844514664566, 5216.739163041757, 3884.2425726982965, 3917.823697933543, 3930.390789427643, 3942.0, 3950.4469374287046, 5212.765425555784, 5477.287952566141, 5493.285872836505, 5499.3675727291875, 5510.448955104457, 5307.203919412119, 5324.227986941794, 5336.893262134813, 5341.145416733304, 5355.009323275207, 5230.241614965733, 5311.575073993994, 5344.412114667306, 5346.438623944586, 5346.893062138658, 5228.503292187236, 5265.7367131642495, 5276.604254680838, 5280.683159010472, 5293.841184764463, 5133.6919784813035, 5190.740462976761, 5345.33183352081, 5360.0887849064975, 5373.140297552372, 5201.635885487979, 5211.583073354047, 5218.895622087461, 5220.504052115043, 5226.137687281556], "value": 3982.4016966024064, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.9431056894311, 578.3551340255614, 608.0484042473529, 608.695652173913, 614.6066517428843, 12080.818787718192, 12118.091143164265, 12194.390280485984, 12498.062645301605, 12513.624591262265, 11798.94100529496, 11873.584424545143, 11924.642260732191, 11935.283882967027, 11940.701482462942, 624.6658037949709, 641.6503005861794, 643.5945354426705, 643.7006791841793, 753.1414187825883, 787.8621241282781, 794.6702118620766, 794.7019867549669, 794.8291117409756, 794.9324307433875, 823.1685997142899, 827.4952279109739, 828.3125006244833, 828.4490813608973, 828.8466633672759, 657.5364368120463, 810.4367464612097, 827.23480780278, 827.548985802736, 836.0970152235572, 608.2518502242223, 608.5466327585932, 608.8995315772892, 609.6007115339415, 609.9451049405575, 12357.073219508484, 12361.443735031946, 12393.318367489785, 12399.194052386567, 12404.875951240463, 11715.7071073223, 12556.434960426803, 12828.102032857703, 12962.416691248916, 13098.86901130986, 9433.386829856037, 9564.473953932531, 9599.664011759625, 9664.226861851106, 9711.757206069904, 3193.8882139125253, 3218.1793642621215, 3227.951580726291, 3279.8360081996043, 3285.638579756249, 50129.74935125301, 50166.7491662543, 50566.74716626394, 50767.23849142266, 50976.99999999963, 8638.352123590756, 8853.114688531225, 8908.331875109392, 9302.302327325342, 9361.204297634777, 16258.837411625733, 16428.17859107064, 16468.0, 16491.34034638601, 16498.092604906604, 6460.612363258219, 6513.938448928996, 6820.35206655367, 6887.2079710832895, 7019.89470157948, 3628.1111127773866, 3645.5078564393466, 3656.5794933582447, 3662.285854258394, 3673.0, 2914.621099257083, 2952.808067475607, 2958.511845545504, 2964.985175074111, 2969.035063604337, 519.4519781630416, 541.9458054194549, 547.3404547520229, 555.7304707216997, 561.0434209672499, 482.7936330967445, 489.28320011183786, 506.2864729369581, 533.6931264522915, 561.9325680918234, 6980.685869135901, 7141.464390170758, 7272.63636818157, 7299.89050164248, 7499.887501687479, 474.55866044578875, 474.89789695215694, 497.4975274972232, 514.4758404926225, 524.1325606121875, 3238.125706059398, 3409.9659003410143, 3421.555197824267, 3427.485877118452, 3505.509228707983, 47725.284120738215, 52374.0, 53883.0, 54225.45774542283, 54447.45552544424, 46635.76682116568, 46930.0, 46973.5302646976, 47017.52982470131, 47848.521514785105, 42208.57791422046, 42680.57319426766, 42912.14175716468, 43656.78171609185, 44197.337039944425, 6940.167179938439, 6941.0629565010095, 7340.376068034277, 7395.630218488946, 7410.2219266978345, 25560.488790224463, 26093.0, 26620.7337926626, 27590.172294831187, 28456.146315610564, 34028.149296267795, 35417.291654166256, 35969.86346570178, 36019.81990090033, 36188.0, 8945.23965462917, 9211.447313160963, 9296.674616388394, 9414.0, 9573.377730447499, 10257.0, 10293.74265643335, 10334.689959301233, 10343.534540945526, 10456.68629941103, 7727.845443090994, 8483.409261402892, 9481.431114133175, 9727.805443891224, 9751.414915105117, 9795.657151999645, 9868.358556693793, 9877.110370965958, 9918.553665084944, 10055.798884022424, 9649.662261820802, 9768.316217864682, 9778.55996480146, 9940.502974851084, 9953.253505987224, 8406.0, 8580.184882436159, 8600.698975535826, 8926.910730892867, 9025.232855207381, 8541.316694664536, 8635.438696484709, 8782.736517904474, 8787.780305492413, 8946.68686595966], "value": 5586.227574216207, "unit": "score"}], "name": "dromaeo_css", "value": 6121.76921152026, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 107.0, 111.0, 112.0, 113.0, 100.0, 112.0, 113.0, 113.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 134.0, 155.0, 185.0, 133.0, 156.0, 161.0, 133.0, 189.0, 131.0], "value": 154.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 161.0, 163.0, 164.0, 163.0, 166.0, 161.0, 162.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 112.0, 112.0, 74.0, 73.0, 74.0, 120.0, 102.0, 73.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 145.0, 93.0, 95.0, 95.0, 148.0, 93.0, 94.0, 149.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 85.0, 63.0, 63.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 67.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 80.0, 90.0, 80.0, 83.0, 82.0, 81.0, 80.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 134.0, 130.0, 132.0, 130.0, 132.0, 132.0, 167.0, 144.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 179.0, 175.0, 174.0, 181.0, 174.0, 175.0, 174.0, 182.0, 173.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 72.0, 72.0, 72.0, 72.0, 73.0, 72.0, 70.0, 71.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1582.9999999999998, "alertThreshold": 2.0}]} 05:07:21 INFO - Return code: 0 05:07:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:07:21 ERROR - # TBPL SUCCESS # 05:07:21 INFO - Running post-action listener: _resource_record_post_action 05:07:21 INFO - Running post-run listener: _resource_record_post_run 05:07:22 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 531664896; Read time: 0; Write time: 1367708 05:07:22 INFO - install - Wall time: 17s; CPU: 22.0%; Read bytes: 0; Write bytes: 253575168; Read time: 0; Write time: 1045804 05:07:22 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 278089728; Read time: 0; Write time: 321904 05:07:22 INFO - Running post-run listener: _upload_blobber_files 05:07:22 INFO - Blob upload gear active. 05:07:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:07: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 05:07: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'] 05:07: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 05:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:23 INFO - (blobuploader) - INFO - Done attempting. 05:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:07:24 INFO - (blobuploader) - INFO - Done attempting. 05:07:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:07:24 INFO - Return code: 0 05:07:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:07:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:07:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68c773547f97574ea19af80e32ed3467299ff7419511c4821e7dd9ca070f92405e062733ea7613c0b4a71184560c3289a5284c70f981fcb70ca82a1804f91ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55b5e8ebe3eb3cc223672d70cb022f9536423e145aa70eb47fee15035f0baa96be54c6bbd907f89a8369027beb92552ded52c9ba3e8c1948d45b6444abbf90da"} 05:07:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:07:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:07:24 INFO - Contents: 05:07:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68c773547f97574ea19af80e32ed3467299ff7419511c4821e7dd9ca070f92405e062733ea7613c0b4a71184560c3289a5284c70f981fcb70ca82a1804f91ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55b5e8ebe3eb3cc223672d70cb022f9536423e145aa70eb47fee15035f0baa96be54c6bbd907f89a8369027beb92552ded52c9ba3e8c1948d45b6444abbf90da"} 05:07:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:07:24 INFO - Copying logs to upload dir... 05:07:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:07:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.213078 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-25 05:07:22.491929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.495216) ========= 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=af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482 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/68c773547f97574ea19af80e32ed3467299ff7419511c4821e7dd9ca070f92405e062733ea7613c0b4a71184560c3289a5284c70f981fcb70ca82a1804f91ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55b5e8ebe3eb3cc223672d70cb022f9536423e145aa70eb47fee15035f0baa96be54c6bbd907f89a8369027beb92552ded52c9ba3e8c1948d45b6444abbf90da"} build_url:https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/DxZ-lO9wSayuTkL92QAvgQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68c773547f97574ea19af80e32ed3467299ff7419511c4821e7dd9ca070f92405e062733ea7613c0b4a71184560c3289a5284c70f981fcb70ca82a1804f91ddc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/55b5e8ebe3eb3cc223672d70cb022f9536423e145aa70eb47fee15035f0baa96be54c6bbd907f89a8369027beb92552ded52c9ba3e8c1948d45b6444abbf90da"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.519956) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.520274) ========= 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=af724c981e2a0f424dbabf99000001e7-1461584728.335218-203514482 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004545 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.602426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:22.602737) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:07:22.603323) ========= ========= Total master_lag: 0.16 =========