builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1462550640.69 results: success (0) buildid: 20160506083523 builduid: 35bf3c19ede94b34be9dd7778929b627 revision: 91faa576bfe4c441d0b319fc2c76e6141cadd912 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.691404) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.691830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.692100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.755589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.755910) ========= 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=62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 09:04:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 14.6M=0.001s 2016-05-06 09:04:00 (14.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075544 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.859099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.859407) ========= 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=62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014651 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.912128) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:00.913349) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 91faa576bfe4c441d0b319fc2c76e6141cadd912 --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 91faa576bfe4c441d0b319fc2c76e6141cadd912 --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=62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 09:04:01,047 truncating revision to first 12 chars 2016-05-06 09:04:01,047 Setting DEBUG logging. 2016-05-06 09:04:01,047 attempt 1/10 2016-05-06 09:04:01,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/91faa576bfe4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 09:04:01,302 unpacking tar archive at: fx-team-91faa576bfe4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558687 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:01.489869) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:01.490152) ========= script_repo_revision: 91faa576bfe4c441d0b319fc2c76e6141cadd912 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:01.490535) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:01.490799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 09:04:01.503905) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-06 09:04:01.504168) ========= /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=62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:01 INFO - MultiFileLogger online at 20160506 09:04:01 in /builds/slave/test 09:04:01 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 09:04:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:01 INFO - {'append_to_log': False, 09:04:01 INFO - 'base_work_dir': '/builds/slave/test', 09:04:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:04:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:01 INFO - 'branch': 'Fx-Team-Non-PGO', 09:04:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:01 INFO - 'config_files': ('talos/linux_config.py',), 09:04:01 INFO - 'default_actions': ('clobber', 09:04:01 INFO - 'read-buildbot-config', 09:04:01 INFO - 'download-and-extract', 09:04:01 INFO - 'populate-webroot', 09:04:01 INFO - 'create-virtualenv', 09:04:01 INFO - 'install', 09:04:01 INFO - 'run-tests'), 09:04:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:01 INFO - 'download_minidump_stackwalk': True, 09:04:01 INFO - 'download_symbols': 'ondemand', 09:04:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:01 INFO - 'installer_path': 'installer.exe', 09:04:01 INFO - 'log_level': 'info', 09:04:01 INFO - 'log_name': 'talos', 09:04:01 INFO - 'log_to_console': True, 09:04:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:01 INFO - 'opt_config_files': (), 09:04:01 INFO - 'pip_index': False, 09:04:01 INFO - 'sps_profile': False, 09:04:01 INFO - 'sps_profile_interval': 0, 09:04:01 INFO - 'suite': 'dromaeojs', 09:04:01 INFO - 'system_bits': '32', 09:04:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:01 INFO - 'title': 'talos-linux64-ix-018', 09:04:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:01 INFO - 'use_talos_json': True, 09:04:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:01 INFO - 'work_dir': 'build'} 09:04:01 INFO - ##### 09:04:01 INFO - ##### Running clobber step. 09:04:01 INFO - ##### 09:04:01 INFO - Running pre-action listener: _resource_record_pre_action 09:04:01 INFO - Running main action method: clobber 09:04:01 INFO - rmtree: /builds/slave/test/build 09:04:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:02 INFO - Running post-action listener: _resource_record_post_action 09:04:02 INFO - ##### 09:04:02 INFO - ##### Finished clobber step (success) 09:04:02 INFO - ##### 09:04:02 INFO - ##### 09:04:02 INFO - ##### Running read-buildbot-config step. 09:04:02 INFO - ##### 09:04:02 INFO - Running pre-action listener: _resource_record_pre_action 09:04:02 INFO - Running main action method: read_buildbot_config 09:04:02 INFO - Using buildbot properties: 09:04:02 INFO - { 09:04:02 INFO - "project": "", 09:04:02 INFO - "product": "firefox", 09:04:02 INFO - "script_repo_revision": "production", 09:04:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:04:02 INFO - "repository": "", 09:04:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:04:02 INFO - "buildid": "20160506083523", 09:04:02 INFO - "pgo_build": "False", 09:04:02 INFO - "basedir": "/builds/slave/test", 09:04:02 INFO - "buildnumber": 1659, 09:04:02 INFO - "slavename": "talos-linux64-ix-018", 09:04:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:04:02 INFO - "platform": "ubuntu64_hw", 09:04:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:04:02 INFO - "branch": "fx-team", 09:04:02 INFO - "repo_path": "integration/fx-team", 09:04:02 INFO - "revision": "91faa576bfe4c441d0b319fc2c76e6141cadd912", 09:04:02 INFO - "stage_platform": "linux64", 09:04:02 INFO - "builduid": "35bf3c19ede94b34be9dd7778929b627", 09:04:02 INFO - "slavebuilddir": "test" 09:04:02 INFO - } 09:04:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 09:04:02 INFO - Running post-action listener: _resource_record_post_action 09:04:02 INFO - ##### 09:04:02 INFO - ##### Finished read-buildbot-config step (success) 09:04:02 INFO - ##### 09:04:02 INFO - ##### 09:04:02 INFO - ##### Running download-and-extract step. 09:04:02 INFO - ##### 09:04:02 INFO - Running pre-action listener: _resource_record_pre_action 09:04:02 INFO - Running main action method: download_and_extract 09:04:02 INFO - mkdir: /builds/slave/test/build/tests 09:04: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')]} 09:04:02 INFO - https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:04:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:04:09 INFO - Downloaded 1361 bytes. 09:04:09 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 09:04:09 INFO - Using the following test package requirements: 09:04:09 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:09 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:04:09 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:04:09 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'jsshell-linux-x86_64.zip'], 09:04:09 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:04:09 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 09:04:09 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:04:09 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:04:09 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:04:09 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 09:04:09 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:04:09 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:04:09 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')]} 09:04:09 INFO - https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:04:14 INFO - Downloaded 22321395 bytes. 09:04:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:04:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:04:15 INFO - Return code: 0 09:04:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:04: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')]} 09:04:15 INFO - https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:04:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 09:04:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:04:22 INFO - Downloaded 22321395 bytes. 09:04:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:04:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:04:23 INFO - Return code: 0 09:04:23 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')]} 09:04:23 INFO - https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:04:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 09:04:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:04:25 INFO - Downloaded 10840152 bytes. 09:04:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:04:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:04:25 INFO - Return code: 0 09:04:25 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')]} 09:04:25 INFO - https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:04:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:04:26 INFO - Downloaded 54841151 bytes. 09:04:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:26 INFO - mkdir: /builds/slave/test/properties 09:04:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:26 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:26 INFO - Contents: 09:04:26 INFO - build_url:https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 09:04:27 INFO - Running post-action listener: _resource_record_post_action 09:04:27 INFO - Running post-action listener: set_extra_try_arguments 09:04:27 INFO - ##### 09:04:27 INFO - ##### Finished download-and-extract step (success) 09:04:27 INFO - ##### 09:04:27 INFO - ##### 09:04:27 INFO - ##### Running populate-webroot step. 09:04:27 INFO - ##### 09:04:27 INFO - Running pre-action listener: _resource_record_pre_action 09:04:27 INFO - Running main action method: populate_webroot 09:04:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:27 INFO - '--tppagecycles', 09:04:27 INFO - '7'], 09:04:27 INFO - 'tests': ['tsvgm']}}, 09:04:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['damp', 'tps']}, 09:04:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'tests': ['damp', 'tps']}, 09:04:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['dromaeo_dom']}, 09:04:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['a11yr', 09:04:27 INFO - 'ts_paint', 09:04:27 INFO - 'tpaint', 09:04:27 INFO - 'sessionrestore', 09:04:27 INFO - 'sessionrestore_no_auto_restore', 09:04:27 INFO - 'tabpaint']}, 09:04:27 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:27 INFO - 'ts_paint', 09:04:27 INFO - 'tpaint', 09:04:27 INFO - 'sessionrestore', 09:04:27 INFO - 'sessionrestore_no_auto_restore', 09:04:27 INFO - 'tabpaint']}, 09:04:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:27 INFO - 'ts_paint', 09:04:27 INFO - 'tpaint', 09:04:27 INFO - 'sessionrestore', 09:04:27 INFO - 'sessionrestore_no_auto_restore', 09:04:27 INFO - 'tabpaint']}, 09:04:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:27 INFO - 'ts_paint', 09:04:27 INFO - 'tpaint', 09:04:27 INFO - 'sessionrestore', 09:04:27 INFO - 'sessionrestore_no_auto_restore', 09:04:27 INFO - 'tabpaint']}, 09:04:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['a11yr', 09:04:27 INFO - 'ts_paint', 09:04:27 INFO - 'tpaint', 09:04:27 INFO - 'sessionrestore', 09:04:27 INFO - 'sessionrestore_no_auto_restore', 09:04:27 INFO - 'tabpaint']}, 09:04:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['a11yr', 09:04:27 INFO - 'ts_paint', 09:04:27 INFO - 'tpaint', 09:04:27 INFO - 'sessionrestore', 09:04:27 INFO - 'sessionrestore_no_auto_restore', 09:04:27 INFO - 'tabpaint']}, 09:04:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['tsvgx', 09:04:27 INFO - 'tsvgr_opacity', 09:04:27 INFO - 'tart', 09:04:27 INFO - 'tscrollx', 09:04:27 INFO - 'cart']}, 09:04:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:27 INFO - 'tsvgr_opacity', 09:04:27 INFO - 'tart', 09:04:27 INFO - 'tscrollx', 09:04:27 INFO - 'cart']}, 09:04:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'talos_options': ['--disable-e10s'], 09:04:27 INFO - 'tests': ['tp5o']}, 09:04:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'tests': ['tp5o']}, 09:04:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'talos_options': ['--disable-e10s', 09:04:27 INFO - '--xperf_path', 09:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:27 INFO - 'tests': ['tp5n']}, 09:04:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:04:27 INFO - 'talos_options': ['--xperf_path', 09:04:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:27 INFO - 'tests': ['tp5n']}}, 09:04:27 INFO - 'talos.zip': {'path': '', 09:04:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:27 INFO - Running post-action listener: _resource_record_post_action 09:04:27 INFO - ##### 09:04:27 INFO - ##### Finished populate-webroot step (success) 09:04:27 INFO - ##### 09:04:27 INFO - ##### 09:04:27 INFO - ##### Running create-virtualenv step. 09:04:27 INFO - ##### 09:04:27 INFO - Running pre-action listener: _resource_record_pre_action 09:04:27 INFO - Running main action method: create_virtualenv 09:04:27 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:27 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 09:04:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:27 INFO - Using real prefix '/usr' 09:04:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:28 INFO - Installing distribute.............................................................................................................................................................................................done. 09:04:30 INFO - Installing pip.................done. 09:04:30 INFO - Return code: 0 09:04:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:30 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:30 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 09:04:30 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 09:04:30 INFO - Using env: {'DISPLAY': ':0', 09:04:30 INFO - 'HOME': '/home/cltbld', 09:04:30 INFO - 'LANG': 'en_US.UTF-8', 09:04:30 INFO - 'LANGUAGE': 'en_US:en', 09:04:30 INFO - 'LOGNAME': 'cltbld', 09:04:30 INFO - 'MAIL': '/var/mail/cltbld', 09:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:30 INFO - 'MOZ_NO_REMOTE': '1', 09:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:30 INFO - 'NO_EM_RESTART': '1', 09:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:30 INFO - 'PWD': '/builds/slave/test', 09:04:30 INFO - 'SHELL': '/bin/bash', 09:04:30 INFO - 'SHLVL': '1', 09:04:30 INFO - 'TERM': 'linux', 09:04:30 INFO - 'TMOUT': '86400', 09:04:30 INFO - 'USER': 'cltbld', 09:04:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:30 INFO - '_': '/tools/buildbot/bin/python'} 09:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:30 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 09:04:30 INFO - Cleaning up... 09:04:30 INFO - Return code: 0 09:04:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:30 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:30 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 09:04:30 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 09:04:30 INFO - Using env: {'DISPLAY': ':0', 09:04:30 INFO - 'HOME': '/home/cltbld', 09:04:30 INFO - 'LANG': 'en_US.UTF-8', 09:04:30 INFO - 'LANGUAGE': 'en_US:en', 09:04:30 INFO - 'LOGNAME': 'cltbld', 09:04:30 INFO - 'MAIL': '/var/mail/cltbld', 09:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:30 INFO - 'MOZ_NO_REMOTE': '1', 09:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:30 INFO - 'NO_EM_RESTART': '1', 09:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:30 INFO - 'PWD': '/builds/slave/test', 09:04:30 INFO - 'SHELL': '/bin/bash', 09:04:30 INFO - 'SHLVL': '1', 09:04:30 INFO - 'TERM': 'linux', 09:04:30 INFO - 'TMOUT': '86400', 09:04:30 INFO - 'USER': 'cltbld', 09:04:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:30 INFO - '_': '/tools/buildbot/bin/python'} 09:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:30 INFO - Downloading/unpacking psutil>=0.7.1 09:04:30 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 09:04:30 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 09:04:30 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 09:04:30 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 09:04:30 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 09:04:30 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 09:04:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:32 INFO - Installing collected packages: psutil 09:04:32 INFO - Running setup.py install for psutil 09:04:32 INFO - building 'psutil._psutil_linux' extension 09:04:32 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 09:04:32 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 09:04:32 INFO - building 'psutil._psutil_posix' extension 09:04:32 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 09:04:32 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 09:04:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:04:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:04:33 INFO - Successfully installed psutil 09:04:33 INFO - Cleaning up... 09:04:33 INFO - Return code: 0 09:04:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:04:33 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')]} 09:04:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:33 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')]} 09:04:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:33 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:33 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 09:04:33 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 09:04:33 INFO - Using env: {'DISPLAY': ':0', 09:04:33 INFO - 'HOME': '/home/cltbld', 09:04:33 INFO - 'LANG': 'en_US.UTF-8', 09:04:33 INFO - 'LANGUAGE': 'en_US:en', 09:04:33 INFO - 'LOGNAME': 'cltbld', 09:04:33 INFO - 'MAIL': '/var/mail/cltbld', 09:04:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:33 INFO - 'MOZ_NO_REMOTE': '1', 09:04:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:33 INFO - 'NO_EM_RESTART': '1', 09:04:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:33 INFO - 'PWD': '/builds/slave/test', 09:04:33 INFO - 'SHELL': '/bin/bash', 09:04:33 INFO - 'SHLVL': '1', 09:04:33 INFO - 'TERM': 'linux', 09:04:33 INFO - 'TMOUT': '86400', 09:04:33 INFO - 'USER': 'cltbld', 09:04:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:33 INFO - '_': '/tools/buildbot/bin/python'} 09:04:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:04:33 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 09:04:33 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 09:04:33 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 09:04:33 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 09:04:33 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 09:04:33 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 09:04:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:04:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:04:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:04:35 INFO - Installing collected packages: mozsystemmonitor 09:04:35 INFO - Running setup.py install for mozsystemmonitor 09:04:35 INFO - Successfully installed mozsystemmonitor 09:04:35 INFO - Cleaning up... 09:04:35 INFO - Return code: 0 09:04:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:35 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:35 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 09:04:35 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 09:04:35 INFO - Using env: {'DISPLAY': ':0', 09:04:35 INFO - 'HOME': '/home/cltbld', 09:04:35 INFO - 'LANG': 'en_US.UTF-8', 09:04:35 INFO - 'LANGUAGE': 'en_US:en', 09:04:35 INFO - 'LOGNAME': 'cltbld', 09:04:35 INFO - 'MAIL': '/var/mail/cltbld', 09:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:35 INFO - 'MOZ_NO_REMOTE': '1', 09:04:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:35 INFO - 'NO_EM_RESTART': '1', 09:04:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:35 INFO - 'PWD': '/builds/slave/test', 09:04:35 INFO - 'SHELL': '/bin/bash', 09:04:35 INFO - 'SHLVL': '1', 09:04:35 INFO - 'TERM': 'linux', 09:04:35 INFO - 'TMOUT': '86400', 09:04:35 INFO - 'USER': 'cltbld', 09:04:35 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:35 INFO - '_': '/tools/buildbot/bin/python'} 09:04:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:04:35 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 09:04:35 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 09:04:35 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 09:04:35 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 09:04:35 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 09:04:35 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 09:04:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:04:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:04:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:38 INFO - Downloading docopt-0.6.1.tar.gz 09:04:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:04:38 INFO - Installing collected packages: blobuploader, requests, docopt 09:04:38 INFO - Running setup.py install for blobuploader 09:04:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:04:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:04:38 INFO - Running setup.py install for requests 09:04:38 INFO - Running setup.py install for docopt 09:04:38 INFO - Successfully installed blobuploader requests docopt 09:04:38 INFO - Cleaning up... 09:04:38 INFO - Return code: 0 09:04:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:38 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:38 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 09:04:38 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 09:04:38 INFO - Using env: {'DISPLAY': ':0', 09:04:38 INFO - 'HOME': '/home/cltbld', 09:04:38 INFO - 'LANG': 'en_US.UTF-8', 09:04:38 INFO - 'LANGUAGE': 'en_US:en', 09:04:38 INFO - 'LOGNAME': 'cltbld', 09:04:38 INFO - 'MAIL': '/var/mail/cltbld', 09:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:38 INFO - 'MOZ_NO_REMOTE': '1', 09:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:38 INFO - 'NO_EM_RESTART': '1', 09:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:38 INFO - 'PWD': '/builds/slave/test', 09:04:38 INFO - 'SHELL': '/bin/bash', 09:04:38 INFO - 'SHLVL': '1', 09:04:38 INFO - 'TERM': 'linux', 09:04:38 INFO - 'TMOUT': '86400', 09:04:38 INFO - 'USER': 'cltbld', 09:04:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:38 INFO - '_': '/tools/buildbot/bin/python'} 09:04:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:39 INFO - Running setup.py (path:/tmp/pip-Rix28J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:39 INFO - Running setup.py (path:/tmp/pip-9ZL2jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:39 INFO - Running setup.py (path:/tmp/pip-lUCuuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:39 INFO - Running setup.py (path:/tmp/pip-FaVaYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:39 INFO - Running setup.py (path:/tmp/pip-lHRBcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:39 INFO - Running setup.py (path:/tmp/pip-4UL3XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:39 INFO - Running setup.py (path:/tmp/pip-OrPm9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:39 INFO - Running setup.py (path:/tmp/pip-0ZQSI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:39 INFO - Running setup.py (path:/tmp/pip-tMXtas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:39 INFO - Running setup.py (path:/tmp/pip-dOr44I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:39 INFO - Running setup.py (path:/tmp/pip-k3ksol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:39 INFO - Running setup.py (path:/tmp/pip-IoILSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:39 INFO - Running setup.py (path:/tmp/pip-Sal6Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:40 INFO - Running setup.py (path:/tmp/pip-YeMeQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:40 INFO - Running setup.py (path:/tmp/pip-Pw1P9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:40 INFO - Running setup.py (path:/tmp/pip-_DGFsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:40 INFO - Running setup.py (path:/tmp/pip-p1Up4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:04:40 INFO - Running setup.py install for manifestparser 09:04:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:04:40 INFO - Running setup.py install for mozcrash 09:04:40 INFO - Running setup.py install for mozdebug 09:04:40 INFO - Running setup.py install for mozdevice 09:04:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:04:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:04:40 INFO - Running setup.py install for mozfile 09:04:40 INFO - Running setup.py install for mozhttpd 09:04:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:04:40 INFO - Running setup.py install for mozinfo 09:04:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:04:40 INFO - Running setup.py install for mozInstall 09:04:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Running setup.py install for mozleak 09:04:41 INFO - Running setup.py install for mozlog 09:04:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Running setup.py install for moznetwork 09:04:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Running setup.py install for mozprocess 09:04:41 INFO - Running setup.py install for mozprofile 09:04:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Running setup.py install for mozrunner 09:04:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:04:41 INFO - Running setup.py install for mozscreenshot 09:04:41 INFO - Running setup.py install for moztest 09:04:41 INFO - Running setup.py install for mozversion 09:04:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:04:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:04:42 INFO - Cleaning up... 09:04:42 INFO - Return code: 0 09:04:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:04:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:42 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:42 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 09:04:42 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 09:04:42 INFO - Using env: {'DISPLAY': ':0', 09:04:42 INFO - 'HOME': '/home/cltbld', 09:04:42 INFO - 'LANG': 'en_US.UTF-8', 09:04:42 INFO - 'LANGUAGE': 'en_US:en', 09:04:42 INFO - 'LOGNAME': 'cltbld', 09:04:42 INFO - 'MAIL': '/var/mail/cltbld', 09:04:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:42 INFO - 'MOZ_NO_REMOTE': '1', 09:04:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:42 INFO - 'NO_EM_RESTART': '1', 09:04:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:42 INFO - 'PWD': '/builds/slave/test', 09:04:42 INFO - 'SHELL': '/bin/bash', 09:04:42 INFO - 'SHLVL': '1', 09:04:42 INFO - 'TERM': 'linux', 09:04:42 INFO - 'TMOUT': '86400', 09:04:42 INFO - 'USER': 'cltbld', 09:04:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:42 INFO - '_': '/tools/buildbot/bin/python'} 09:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:04:42 INFO - Running setup.py (path:/tmp/pip-Q_ABJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:04:42 INFO - Running setup.py (path:/tmp/pip-kltQC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:04:42 INFO - Running setup.py (path:/tmp/pip-4fPldz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:04:42 INFO - Running setup.py (path:/tmp/pip-nqnmFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:04:42 INFO - Running setup.py (path:/tmp/pip-A3UR4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:04:42 INFO - Running setup.py (path:/tmp/pip-yxr7RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:04:42 INFO - Running setup.py (path:/tmp/pip-IUKshH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:04:42 INFO - Running setup.py (path:/tmp/pip-byQ0_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:04:42 INFO - Running setup.py (path:/tmp/pip-rvcYy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:04:42 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)) 09:04:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:04:42 INFO - Running setup.py (path:/tmp/pip-qoiFX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:04:43 INFO - Running setup.py (path:/tmp/pip-gNmkpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:04:43 INFO - Running setup.py (path:/tmp/pip-RXScJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:04:43 INFO - Running setup.py (path:/tmp/pip-Nekpqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:04:43 INFO - Running setup.py (path:/tmp/pip-ehDYsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:43 INFO - Running setup.py (path:/tmp/pip-UEQkXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:04:43 INFO - Running setup.py (path:/tmp/pip-eIBly3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:04:43 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)) 09:04:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:04:43 INFO - Running setup.py (path:/tmp/pip-PAvT5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:04:43 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)) 09:04:43 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)) 09:04:43 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)) 09:04:43 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)) 09:04:43 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)) 09:04:43 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)) 09:04:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:45 INFO - Downloading blessings-1.6.tar.gz 09:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:04:45 INFO - Installing collected packages: blessings 09:04:45 INFO - Running setup.py install for blessings 09:04:45 INFO - Successfully installed blessings 09:04:45 INFO - Cleaning up... 09:04:45 INFO - Return code: 0 09:04:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:04:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:45 INFO - Reading from file tmpfile_stdout 09:04:45 INFO - Current package versions: 09:04:45 INFO - argparse == 1.2.1 09:04:45 INFO - blessings == 1.6 09:04:45 INFO - blobuploader == 1.2.4 09:04:45 INFO - docopt == 0.6.1 09:04:45 INFO - manifestparser == 1.1 09:04:45 INFO - mozInstall == 1.12 09:04:45 INFO - mozcrash == 0.17 09:04:45 INFO - mozdebug == 0.1 09:04:45 INFO - mozdevice == 0.48 09:04:45 INFO - mozfile == 1.2 09:04:45 INFO - mozhttpd == 0.7 09:04:45 INFO - mozinfo == 0.9 09:04:45 INFO - mozleak == 0.1 09:04:45 INFO - mozlog == 3.1 09:04:45 INFO - moznetwork == 0.27 09:04:45 INFO - mozprocess == 0.22 09:04:45 INFO - mozprofile == 0.28 09:04:45 INFO - mozrunner == 6.11 09:04:45 INFO - mozscreenshot == 0.1 09:04:45 INFO - mozsystemmonitor == 0.0 09:04:45 INFO - moztest == 0.7 09:04:45 INFO - mozversion == 1.4 09:04:45 INFO - psutil == 3.1.1 09:04:45 INFO - requests == 1.2.3 09:04:45 INFO - wsgiref == 0.1.2 09:04:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:45 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:45 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 09:04:45 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 09:04:45 INFO - Using env: {'DISPLAY': ':0', 09:04:45 INFO - 'HOME': '/home/cltbld', 09:04:45 INFO - 'LANG': 'en_US.UTF-8', 09:04:45 INFO - 'LANGUAGE': 'en_US:en', 09:04:45 INFO - 'LOGNAME': 'cltbld', 09:04:45 INFO - 'MAIL': '/var/mail/cltbld', 09:04:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:45 INFO - 'MOZ_NO_REMOTE': '1', 09:04:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:45 INFO - 'NO_EM_RESTART': '1', 09:04:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:45 INFO - 'PWD': '/builds/slave/test', 09:04:45 INFO - 'SHELL': '/bin/bash', 09:04:45 INFO - 'SHLVL': '1', 09:04:45 INFO - 'TERM': 'linux', 09:04:45 INFO - 'TMOUT': '86400', 09:04:45 INFO - 'USER': 'cltbld', 09:04:45 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:45 INFO - '_': '/tools/buildbot/bin/python'} 09:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 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)) 09:04:46 INFO - Cleaning up... 09:04:46 INFO - Return code: 0 09:04:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:04:46 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')]} 09:04:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:46 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')]} 09:04:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:46 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:46 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 09:04:46 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 09:04:46 INFO - Using env: {'DISPLAY': ':0', 09:04:46 INFO - 'HOME': '/home/cltbld', 09:04:46 INFO - 'LANG': 'en_US.UTF-8', 09:04:46 INFO - 'LANGUAGE': 'en_US:en', 09:04:46 INFO - 'LOGNAME': 'cltbld', 09:04:46 INFO - 'MAIL': '/var/mail/cltbld', 09:04:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:46 INFO - 'MOZ_NO_REMOTE': '1', 09:04:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:46 INFO - 'NO_EM_RESTART': '1', 09:04:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:46 INFO - 'PWD': '/builds/slave/test', 09:04:46 INFO - 'SHELL': '/bin/bash', 09:04:46 INFO - 'SHLVL': '1', 09:04:46 INFO - 'TERM': 'linux', 09:04:46 INFO - 'TMOUT': '86400', 09:04:46 INFO - 'USER': 'cltbld', 09:04:46 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:46 INFO - '_': '/tools/buildbot/bin/python'} 09:04:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:46 INFO - Downloading/unpacking jsonschema 09:04:46 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 09:04:46 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 09:04:46 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 09:04:46 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 09:04:46 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 09:04:46 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 09:04:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:04:48 INFO - Downloading/unpacking functools32 (from jsonschema) 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 INFO - Downloading functools32-3.2.3-2.tar.gz 09:04:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:04:48 INFO - warning: no files found matching '*.txt' 09:04:48 INFO - no previously-included directories found matching 'build' 09:04:48 INFO - no previously-included directories found matching 'dist' 09:04:48 INFO - no previously-included directories found matching '.git*' 09:04:48 INFO - Installing collected packages: jsonschema, functools32 09:04:48 INFO - Running setup.py install for functools32 09:04:48 INFO - warning: no files found matching '*.txt' 09:04:48 INFO - no previously-included directories found matching 'build' 09:04:48 INFO - no previously-included directories found matching 'dist' 09:04:48 INFO - no previously-included directories found matching '.git*' 09:04:48 INFO - Successfully installed jsonschema functools32 09:04:48 INFO - Cleaning up... 09:04:48 INFO - Return code: 0 09:04:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:04: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')]} 09:04:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04: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')]} 09:04:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:04:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:04:48 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 0x7fd83276df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13885a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, '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': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', '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 09:04:48 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 09:04:48 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 09:04:48 INFO - Using env: {'DISPLAY': ':0', 09:04:48 INFO - 'HOME': '/home/cltbld', 09:04:48 INFO - 'LANG': 'en_US.UTF-8', 09:04:48 INFO - 'LANGUAGE': 'en_US:en', 09:04:48 INFO - 'LOGNAME': 'cltbld', 09:04:48 INFO - 'MAIL': '/var/mail/cltbld', 09:04:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:48 INFO - 'MOZ_NO_REMOTE': '1', 09:04:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:48 INFO - 'NO_EM_RESTART': '1', 09:04:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:48 INFO - 'PWD': '/builds/slave/test', 09:04:48 INFO - 'SHELL': '/bin/bash', 09:04:48 INFO - 'SHLVL': '1', 09:04:48 INFO - 'TERM': 'linux', 09:04:48 INFO - 'TMOUT': '86400', 09:04:48 INFO - 'USER': 'cltbld', 09:04:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:04:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:48 INFO - '_': '/tools/buildbot/bin/python'} 09:04:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:04:48 INFO - Downloading/unpacking flake8 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:48 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 09:04:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:04:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:04:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:04:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:04:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 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 09:04:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:51 INFO - no previously-included directories found matching 'docs/_build' 09:04:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:04:51 INFO - Running setup.py install for pep8 09:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:04:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:04:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:04:51 INFO - no previously-included directories found matching 'docs/_build' 09:04:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:04:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:04:51 INFO - Cleaning up... 09:04:51 INFO - Return code: 0 09:04:51 INFO - Running post-action listener: _resource_record_post_action 09:04:51 INFO - Running post-action listener: _start_resource_monitoring 09:04:51 INFO - Starting resource monitoring. 09:04:51 INFO - ##### 09:04:51 INFO - ##### Finished create-virtualenv step (success) 09:04:51 INFO - ##### 09:04:51 INFO - ##### 09:04:51 INFO - ##### Running install step. 09:04:51 INFO - ##### 09:04:51 INFO - Running pre-action listener: _resource_record_pre_action 09:04:51 INFO - Running main action method: install 09:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:04:51 INFO - Reading from file tmpfile_stdout 09:04:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:04:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:04:52 INFO - Reading from file tmpfile_stdout 09:04:52 INFO - Output received: 09:04:52 INFO - Usage: mozinstall [options] installer 09:04:52 INFO - Options: 09:04:52 INFO - -h, --help show this help message and exit 09:04:52 INFO - -d DEST, --destination=DEST 09:04:52 INFO - Directory to install application into. [default: 09:04:52 INFO - "/builds/slave/test"] 09:04:52 INFO - --app=APP Application being installed. [default: firefox] 09:04:52 INFO - mkdir: /builds/slave/test/build/application 09:04:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:04:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:05:07 INFO - Reading from file tmpfile_stdout 09:05:07 INFO - Output received: 09:05:07 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:07 INFO - Running post-action listener: _resource_record_post_action 09:05:07 INFO - ##### 09:05:07 INFO - ##### Finished install step (success) 09:05:07 INFO - ##### 09:05:07 INFO - ##### 09:05:07 INFO - ##### Running run-tests step. 09:05:07 INFO - ##### 09:05:07 INFO - Running pre-action listener: _resource_record_pre_action 09:05:07 INFO - Running main action method: run_tests 09:05:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:07 INFO - Python 2.7.3 09:05:07 INFO - Return code: 0 09:05:07 INFO - grabbing minidump binary from tooltool 09:05: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')]} 09:05:07 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 0x1417410>, '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 0x1418310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14187a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:07 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 09:05:07 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 09:05:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:07 INFO - Return code: 0 09:05:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:05:08 INFO - Return code: 0 09:05:08 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/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 09:05:08 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/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 09:05:08 INFO - Using env: {'DISPLAY': ':0', 09:05:08 INFO - 'HOME': '/home/cltbld', 09:05:08 INFO - 'LANG': 'en_US.UTF-8', 09:05:08 INFO - 'LANGUAGE': 'en_US:en', 09:05:08 INFO - 'LOGNAME': 'cltbld', 09:05:08 INFO - 'MAIL': '/var/mail/cltbld', 09:05:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:08 INFO - 'MOZ_NO_REMOTE': '1', 09:05:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:08 INFO - 'NO_EM_RESTART': '1', 09:05:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:08 INFO - 'PWD': '/builds/slave/test', 09:05:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:08 INFO - 'SHELL': '/bin/bash', 09:05:08 INFO - 'SHLVL': '1', 09:05:08 INFO - 'TERM': 'linux', 09:05:08 INFO - 'TMOUT': '86400', 09:05:08 INFO - 'USER': 'cltbld', 09:05:08 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218', 09:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:08 INFO - '_': '/tools/buildbot/bin/python'} 09:05:08 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/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 09:05:09 INFO - mozversion application_buildid: 20160506083523 09:05:09 INFO - mozversion application_changeset: 91faa576bfe4c441d0b319fc2c76e6141cadd912 09:05:09 INFO - mozversion application_display_name: Nightly 09:05:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:09 INFO - mozversion application_name: Firefox 09:05:09 INFO - mozversion application_remotingname: firefox 09:05:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:05:09 INFO - mozversion application_vendor: Mozilla 09:05:09 INFO - mozversion application_version: 49.0a1 09:05:09 INFO - mozversion platform_buildid: 20160506083523 09:05:09 INFO - mozversion platform_changeset: 91faa576bfe4c441d0b319fc2c76e6141cadd912 09:05:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:05:09 INFO - mozversion platform_version: 49.0a1 09:05:09 INFO - using testdate: 1462550709 09:05:09 INFO - actual date: 1462550709 09:05:09 INFO - starting webserver on 'localhost:34315' 09:05:09 INFO - SUITE-START | Running 2 tests 09:05:09 INFO - TEST-START | dromaeo_css 09:05:09 INFO - operating with platform_type : linux_ 09:05:09 INFO - Initialising browser for dromaeo_css test... 09:05:09 INFO - TEST-INFO | started process 9475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV3E8YB/profile http://localhost:34315/getInfo.html) 09:05:13 INFO - PROCESS | 9475 | __metrics Screen width/height:1600/1200 09:05:13 INFO - PROCESS | 9475 | colorDepth:24 09:05:13 INFO - PROCESS | 9475 | Browser inner width/height: 1024/697 09:05:13 INFO - PROCESS | 9475 | __metrics 09:05:14 ERROR - PROCESS | 9475 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:05:15 INFO - TEST-INFO | 9475: exit 0 09:05:15 INFO - Browser initialized. 09:05:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:15 INFO - TEST-INFO | started process 9555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV3E8YB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:27 INFO - PROCESS | 9555 | RSS: Main: 154746880 09:05:27 INFO - PROCESS | 9555 | 09:06:18 INFO - PROCESS | 9555 | 1462550778756 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] 09:08:30 INFO - PROCESS | 9555 | Cycle 1(1): loaded http://localhost:34315/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34315/tests/dromaeo/cssquery-ext.html) 09:08:31 INFO - PROCESS | 9555 | RSS: Main: 232931328 09:08:31 INFO - PROCESS | 9555 | 09:11:33 INFO - PROCESS | 9555 | Cycle 1(1): loaded http://localhost:34315/tests/dromaeo/cssquery-ext.html (next: http://localhost:34315/tests/dromaeo/cssquery-jquery.html) 09:11:34 INFO - PROCESS | 9555 | RSS: Main: 237637632 09:11:34 INFO - PROCESS | 9555 | 09:14:36 INFO - PROCESS | 9555 | Cycle 1(1): loaded http://localhost:34315/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34315/tests/dromaeo/cssquery-mootools.html) 09:14:37 INFO - PROCESS | 9555 | RSS: Main: 236941312 09:14:37 INFO - PROCESS | 9555 | 09:17:39 INFO - PROCESS | 9555 | Cycle 1(1): loaded http://localhost:34315/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34315/tests/dromaeo/cssquery-prototype.html) 09:17:39 INFO - PROCESS | 9555 | RSS: Main: 229224448 09:17:39 INFO - PROCESS | 9555 | 09:20:42 INFO - PROCESS | 9555 | Cycle 1(1): loaded http://localhost:34315/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34315/tests/dromaeo/cssquery-yui.html) 09:20:43 INFO - PROCESS | 9555 | RSS: Main: 219430912 09:20:43 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | Cycle 1(1): loaded http://localhost:34315/tests/dromaeo/cssquery-yui.html (next: http://localhost:34315/tests/dromaeo/cssquery-dojo.html) 09:23:46 INFO - PROCESS | 9555 | RSS: Main: 277938176 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | __start_tp_report 09:23:46 INFO - PROCESS | 9555 | _x_x_mozilla_page_load 09:23:46 INFO - PROCESS | 9555 | _x_x_mozilla_page_load_details 09:23:46 INFO - PROCESS | 9555 | |i|pagename|runs| 09:23:46 INFO - PROCESS | 9555 | |0;dojo.html;2626.080871694907;2647.1661426650617;2677.9062732804355;2699.2172270041688;2701.9324516887077;4630.305454181875;4677.74272415017;4678.064387122572;4767.261074533449;4824.493428190042;4691.319758634996;4702.788374523147;4705.482396936334;4732.2428411454175;4762.071396077767;4273.273543497605;4308.655307575402;4363.869083927471;4397.1205758848355;4536.206163921317;4437.423134992447;4466.508684044752;4489.820407183709;4495.460544734637;4519.977400113011;4203.978980105096;4235.152969406131;4333.501647310537;4371.715838470521;4375.321825117112;4293.377460268275;4307.590778876001;4309.267424537836;4352.912941741148;4381.671374646914;4351.9782401088105;4364.672649551265;4372.27857403528;4375.124975005012;4416.1609294233995;4546.568076032771;4559;4603.056373443436;4604.930926036112;4695.3661255730385;5014.323066386028;5017.046761115376;5047.823326183603;5065.544101030888;5068;5065.696058236481;5097.821576244851;5110.335656364686;5111.4121875984365;5126.256692779526;4639.628829693616;4748.643851711066;4778.116048531033;4795.736234507066;4862.95137048625;5279.736013199325;5296.973515132399;5338.092524270884;5339.679619222859;5345.1714984177515;4817;5050.6464547482055;5084.3644544431945;5096.872578185575;5097.64316497849;4983.476734942851;5060.266261392151;5064.645474816727;5101.311322971425;5135.794568217229;5048.545630893163;5052.9242061369105;5053.67151135175;5058.342415485963;5101.464346243665;4884.877878053077;4945.159322915113;5038.974805126024;5042.142835717937;5049.798008079636;4263.893402664896;4299.1831552005015;4319.935200971988;4323;4348.695591308578;3783.05423644089;3806.904827379338;3816.160444702161;3832.425136229532;3832.9041773955873;4265.658747300208;4285.335772955197;4369.781510924441;4379.605835474823;4422.425084738963;4978.726170060609;5030.597552195889;5030.698158110525;5049.697018178921;5092.6435149539175;4308.138372325548;4311.439512863308;4313.352997050405;4328.242557552416;4366.912661746747;4495.280755079171;4568.200564901195;4571.7427707380075;4577.404937358122;4610.446746390455;4743.146233677971;4744.027474367677;4749.691270067435;4773.188557945088;4782.736949467743;5070.974645126751;5093.898122037464;5094;5095.643304968617;5095.796168153232;4560.817567297271;4680.7659617018335;4708.858734237979;4726.858194254178;4764.071006153767;5006.224035274538;5022.648414610942;5026.698398096126;5030.346055012825;5066.03745288394;5066.9239961401345;5074.720890351066;5084.339035925306;5084.491550844886;5087.821926232564;4738.36032135671;4857.368542089505;4895.902081958412;4913.091078150554;4948.505149485023;4898.191798353232;4931.087748766489;4932.062908047603;4933.309336692938;4987.750612469435;4894.486078961658;4916.262560615936;4917.729524876023;4965.652404331662;4971.552560269593;4781.067691800205;4967.379077615298;5024.422191447884;5031.622628302819;5057.974710126426;4888.780004899859;4916.803327866845;4922.556969872729;4925.335079764186;4967.40391153064 09:23:46 INFO - PROCESS | 9555 | |1;ext.html;571.9142128680697;608.7564974010397;611.5688439650047;616.5375968023983;635.6503922842436;28678.713212867864;29358.559621605695;31362.05913822586;41601.37597936026;43879.78060109703;41739.16521669565;44003;44031.559684403146;44091.338629920574;48154.51845481544;7902.20977902211;8003.719869804558;8033.317168040694;8039.5176289422525;8044.276015158634;7625.618719064052;7969.163237860028;9936.453495057769;10188.59245630174;10189.54147063384;10238.7440313992;10309.690709278697;10334.948325258363;10364.585416583366;10383.740406489822;10236.283460157792;10294.639687610972;10297.794044119075;10299.536520856505;10305.124064454456;10121.645742399054;10170.898291017069;10185.439800810953;10191;10195.184385249237;39806.40290395646;40365.59634403677;40365.79817100925;40386;40441.39337909934;3323.285493618859;3424.6061702903985;3474.3572439098593;3503.91240218994;3571.357155711971;29880.252993675116;30552.2361940951;30694.232644183852;30710;31381.215469613213;3041.194083567856;3160.7313378362865;3217.3404452087266;3221.4040402525607;3229.7416206703406;265509;267343;268245;269098;269469;59960.70019649961;60252.698736506034;60294.39705602888;60341.69829150914;60412.395876041555;63173.368266317666;63189.36810631927;63223.683881581215;63351.68324158442;63448;15792.36830526789;16330.591735206715;16341;16342.918285408497;16369.91815040941;9743.9025609743;11838.408079595985;12243.938780306042;12318.568850090203;12338.876611233773;18752.906235469007;19052.333168339042;19080.33218837334;19162.425127246206;19199.904000480186;7224.241454647292;7325.853482930418;7361.779146625609;7373.446991475661;7540.461316434715;927.4388994658269;986.8026394721085;990.7275499237767;1022.2792930983638;1044.8537204791335;28370.43259134847;28532;28573.714262857105;28664.283392915346;28736.281592960342;1020.0669730860127;1028.8662473878348;1085.8598471604782;1118.340179294204;1132.5696235430485;15247.771283430757;15397.461088862061;15542.844571554366;15583.612265360283;15725.292361843745;309576;313270;313319;313516;314155;48520.5147948516;49863.252051219264;49889.501104988485;49962.250566241535;49967;1146.48408216303;1281.8910392616733;1300.3693208793727;1305.2951406240525;1336.0981337597277;28981.27546811262;30181.849090754407;30490.390192195588;30619.846900765355;31044.68955310418;37933.620663794114;38279.043023923514;38376.80811595924;38416.23167536689;38456.03859903413;274231;280556;280748;281008;281760;23094.307170784905;25297.114600989615;26253.474930501667;26448.074317398798;28273.717262827107;43008;43246.567534324255;44063.33904991492;44105;44411;36817.26365472622;38041.61958380381;38130.237395252494;38187.42718859275;38318.425223622224;37687;39867;39915.80042099771;42364.152716946104;43142.78428607837;37640.247195055395;38142.61857381391;38622.6137738619;38648.80675596604;38656;31713.682863171074;33449.331013380084;34004.48993265053;34147.31705365929;34216.31567368589;26169;26409.33976650522;26471.470570588095;26569;26724.331891702863 09:23:46 INFO - PROCESS | 9555 | |2;jquery.html;369.74302859512613;375.7313520832605;379.3778203745857;381.42214544964366;394.69214013069796;16136;16612;17277.74987443493;17435.128243587835;17481.300747970065;10627.256092073558;11455.312681239131;11455.828162577547;11468.655940321803;11474.368909709963;4620.561046700558;4673.953260467386;5283.418823929364;5289.920651190216;5301.125314323132;5244.842654720364;5245.973770131163;5246.50158234969;5265.921011184835;5287.867803304929;4619.214733495297;4833.734144622044;4837.371141751585;4953.504649535053;5232.398274198478;4726.574608285254;4741.976290118562;4783.7129772213775;4788.904221915577;4799.280107983813;4585.358049873021;4618.021376212358;4662.0675864826835;4725.621950243973;4735.834245801415;12574.371281435891;12610.68473288166;12657;12691.936540317332;18359.816401835946;1921.2411097616364;1979.9703004454946;2006;2007.7992200779952;2048.528838367169;8937.955310223408;9333.486658233795;9512.14390704833;9514.571844266955;9581.952090239574;1749.2303386510023;1751.1856986501211;1780.7150855863129;1848.4639454558162;1850.1027001904065;70221;71583.28416715818;72018.85745978921;73185.63407182983;73906.26093739047;10221.080102790784;10245.385276883411;10311.690649280534;10316.793664126675;10464.581416743396;14316;14421.062630929166;14430.42278308856;14441.133531987904;14445.566633001026;7206.963965180141;7800;7818.14000459949;7941.205879412013;7946.086200086948;7548.245175482518;7566.205548417337;7666.731664391831;7683.423743219169;7687.500312479671;4378.233809083397;4418.403515525427;4445.310976798602;4502.887427814331;4541.296099104644;1830.6613276543883;1873.7470441490498;1877.5966762543965;1906.8569857260484;1921.34674210769;805.564994902746;848.6605357856783;871.285545852395;909.486140330711;930.2279108340061;16175.43385981485;16528.6694266114;16807.83192168087;17064.402745903833;17302.826971730123;871.7951281448854;871.9084496127942;875.6453636277317;881.7787364500214;922.7047344849584;7269.927300727031;9706.514674266258;9747.658831940847;9758.658446954323;9814.65648702292;305872;311760;406674;408013;416749;71440.64279678569;78618;81144;81161;86025;425.08818584136856;443.5232125465138;448.65005295869275;450.0436572283897;452.19734970427754;9297.907020929704;9744.269179811401;9756.951215243878;10104.191664666661;10136.898631013595;25638.359041024123;32707;34845.825770870986;35262.294754105285;35300.76447324331;42135.7893210532;43769.12461750811;44168.55831441644;49480.50519494903;49728.25407618816;7524.134724506752;7663.540187588763;7968.521888686466;8040.115587285511;8040.798980025312;7266.491345605757;9914.652987145415;10920.453977301262;10961.945190273998;11810.114241431755;10380;10628.787424251626;10744.086752626114;10866.348019118877;10902.781944361226;10536.209784266057;10591.682249532527;10714.73213169677;10820.02619764225;11093.833592496281;10666.36001839892;10691.679249622524;11103.833442498531;11165.832512512481;11277.32336059839;7462.514936529108;7807.726729564438;7849.686012559434;7908.327792137503;7951.165127661744;10551;11001.669949901516;11010.559577616805;11014.559417623526;11045.226834121535 09:23:46 INFO - PROCESS | 9555 | |3;mootools.html;1310.6199202231353;1503.6767095074556;1503.736846051941;1698.9490315290545;1876.474587115608;6556.737730490775;7399.889001664979;7662.693492260303;7668.923310766883;7814.960925195381;7608.77173684789;7741.690332386712;7750;7764.417668674843;7773.611319434034;2229.732432108149;2258.4918393361527;2258.8531745436494;2260.1185537640335;2260.152442833937;2162.7512836023902;2195.4182141732454;2226.699395581592;2238.328501449567;2238.630625946725;2187.0923566719794;2189.926935801454;2199.7800219977953;2200.7579166291694;2243.517643706603;2151.6880052392316;2175.6627722703006;2178.901949412272;2181.432827464863;2182.639864422368;2155.4503601581655;2156.33153722345;2158.676198570227;2160.459885028743;2161.567686462714;7509.436792240604;7673.117591476996;7731.536107833548;7732.729354472623;7748.457607967444;4549.567791059844;4637.420322459692;4667.6732628716;4670.602998745111;4670.953290467086;2768.543190373606;2787.818791778528;2810.4519618674367;2816.6479190101236;2857.7713782897317;841.1714461255658;844.8986121665439;851.9020312664061;869.847776639092;872.7730789994647;10127.696169114939;10194.23543234253;10208.48957552127;10224.130948869355;10224.59101635941;3957.5053118360206;3985;4068.877933661995;4077.327241005201;4105.835766569364;8142.348612111017;8207.794805129919;8260.05009423924;8267.214614611723;8267.875981860278;4394.209042372404;4442.466903971479;4443.311286750559;4462.709923854939;4466.798994045275;3661.0847288177956;4042.7372220805555;4044.373122166069;4133.937990930139;4205.432266644025;3497.45789402643;3511;3555.7866528008403;3594.9101272468397;3603.243318903007;1062.7130674717782;1092.1644941619668;1096.6764804382726;1098.9010989011028;1112.3759311405438;761.8095476130967;807.8707406814881;849.8682704180862;903.661127077346;937.9906200937903;5037.546620804145;5234.685918844882;5312.335958005249;5342.492463215988;5403.13549832025;412.91328820947336;418.080223508283;421.41423421444216;426.1668438203305;431.52532214564354;3667.7249206309634;3718.1262403335195;3758.1544152565452;3763.9649096498683;3799.981000094982;9022.954885225532;9267.907320926839;9390.34267601275;9401.482918439415;9464.763380915532;9269.397489163182;9310.115539023782;9312.906870931203;9374.250059995184;9388;7220.097487814023;7322.853542929218;7334.4499162563025;7334.486585938933;7339.633018349168;5265.1049321614655;5322.600804939722;5346.97326513365;5359.437259087896;5455.208994695826;8337.916620833714;8475.618597163266;8698.608562614823;8714;8747.343949203709;8533.786655333666;8815.911840881508;8823.29413646894;8833.425827321204;8926.86609700842;5623.409541998031;5830.125481177857;5839.620424672383;6297.496200304056;6379.106925030406;6932.549384290005;7271.8909216360735;7500.174980752222;7510.39916806665;7703.807404814925;6764.323567643196;6885.449164066963;6886.276940921131;6949.61777102244;6988.860222795617;6670.433013193933;6671.232808227116;6744.426723728538;6786;6810.080639113657;5926.555508336805;6462.741490340334;6486.351364863476;6519.608823470607;6537.640429776408;4367.344898265285;4401.647868170603;4472.463304403493;4484.68607197493;4524.864254072383;4581;4594.747288899142;4643.883902902455;4698.459677137036;4723.574878260973 09:23:46 INFO - PROCESS | 9555 | |4;prototype.html;299.232468717739;311.56381066506896;315.94944808830576;318.1997276848724;320.1420193880401;4843;4886.364772579568;4890.926636100457;4895.779689913949;4915.976674345278;4577.610903073243;4595.3107033944925;4658.138244424784;4745.57289843914;4831.202851529493;3767.1523907120954;3779.7165212609025;3790.5072340595684;3803.4484999675033;3817.48463957365;3800.2399520095955;3814.4659747635355;3824.29250588642;3828.138668799512;3831.8924591474715;3512.4028915084496;3532.629073947237;3661.5972243053243;3678.558572971234;3729.440583912408;3729.272791805599;3767.775472971268;3775.2449510097817;3775.754575952554;3779.697624190072;3311.205310725433;3316.7844090134063;3335.4163021471386;3349.916252093717;3356.311956049004;4461.754603496806;4546.090781843612;4637.837675681335;4638.1187574360765;4655.2784318430695;4237.724547904377;4247.660187185018;4293.656507479394;4296.892577685551;4298.312270036779;4949.133901567247;4971.6271279654175;4975.203967365204;4979.684446732287;4998.675086119427;3637.8181090945614;3656.305301992613;3663.6993867177034;3673.6142705016123;3700.9259814803822;5028.4971502849785;5238.926020165857;5243.292155559027;5246.7638956247065;5249.86875328116;3720.8511659533856;3725.18046029873;3727.5154229949935;3731.552213734315;3754.981225093857;3790.6967442604528;3800.0049973763994;3800.4489349044234;3810.9809450952566;3815.809209539512;4171.687123465692;4203.159289061129;4273.1240095780295;4286.721363111388;4289.1850548395705;4942.492539775403;4971.37857767779;4974.950250497449;4976.776045077981;5010.223415370623;1204.3135412814786;1268.8199974024062;1273.178799674205;1280.788669869461;1284.2808027504627;848.893888263967;862.1852349529635;864.6714248585623;871.5990644303564;873.2882700598991;4280.229558679468;4286.2284788738325;4295.484541854998;4307.827686892552;4350.282203436461;4960.454350021495;4965.4289756678445;5009.073321435473;5023.949760502348;5039.974800125976;4111.342185250345;4270.807813648331;4304.354346847936;4318.985038515946;4328.177646247203;2643.841369517835;2668.8924096500123;2672.4387878545335;2681.8122731409003;2692.6634170728657;4588.036512332381;4649.325847752057;4665.580097791215;4670.579647831712;4672.252439609646;4764.595009424169;5030.698158110525;5045.84862454127;5100.821471248489;5111.718855462986;4618.552167351309;4658.1848176568965;4658.627309815139;4683.344331793483;4687.296905464208;5018.723970181675;5033.489953014155;5067.9239811403595;5073.137566613611;5074.467180945948;4690.648201384842;4873.415190177201;4890.559849613552;4942.456329803791;4952.678075925053;4651.4650165446;4654.394928659252;4679.953200467951;4696.201645720167;4709.599684026896;3683.465897444909;3704.666580007812;3711.1278849469813;3712.424574191005;3719.274741425504;4820.734859582757;4878.000009997871;4949.752512374295;4967.60259179272;5015.498450154955;4892.877678058077;4895.73073480962;4897.3878265216845;4916.237983112624;4923.803047878045;4886.315915771866;4895.290182923527;4921.9507804921495;4925.901481970269;4926.901461970812;4554.476235232991;4789.44921334051;4841.782119804688;4848.321235027029;4851.9514804852915;4827.589654879374;4846.903061938812;4885.975570122127;4898.510148985073;4921.277552856472;4682.508336624605;4709.293605959134;4735.502772208868;4745.481445937405;4762.904741905212 09:23:46 INFO - PROCESS | 9555 | |5;yui.html;681.6898311268372;741.603242265388;792.8493586218622;793.8174219929416;811.7240138352962;11915.165938384316;12665.303408312551;12934.417951192196;13138.343082845868;13177.868221317784;12317.815232771516;12329.938350308259;12376.195547289442;12379.50481980722;12384.318862462562;674.1472037872096;832.7418500264907;841.5119230846094;847.5507980770202;851.5061264466625;829.4608504472111;836.4145098431092;837.7863644770575;837.924586787189;837.9329653627725;721.7942886277413;902.0213068820337;904.3624244907325;904.4121321141278;905.0180554098778;879.8812160358366;881.7883707910055;883.5802993578031;883.6377085395021;884.3367474394204;654.1104098426136;655.9540832141752;655.9901601475982;656.4354654996699;657.1128975882568;11983.281003139753;12016.399180041051;12024.819627705592;12079.456424460921;12119.515219391214;11567.42162891852;11881.524739010429;12173.939130304381;12270.81593776094;12880.227186368847;11069;11553.422328883606;11650.242734222249;11940.104492163036;12204.755904881942;4118.094019315746;4242.342436922282;4263.737356164712;4294.484661840568;4389.4513185851765;45842;47456.28815567769;47487.52512474865;47537.524624753656;47783;9497.240220782322;9717.12545870875;9984.750381240527;10070.74823129413;10273;16161.757573636405;16275.430359937345;16278.43025494102;16287.348506059861;16305.755413668805;6312.936870631235;6366.808995730043;6413.518986076063;6475.870482590321;6572.375624315682;3697.131174174067;3737.4020156774786;3754.9249015019545;3784.413415920537;3790.1093243087853;2898.811577247472;2988.850557472161;2989.9551506727416;2990.8504574771173;2991.132571554225;537.5081800152894;549.8178915332068;552.9668219906819;569.5443645083999;605.231356177652;536.351015271518;589.9233099697097;610.3133974278936;635.5836926812945;651.9576227545194;8391.202835730717;8432.873506897278;8680;8824.51465169409;8900.198982091642;570.7973669347405;653.242239002764;674.7570874485182;682.8054004608663;695.4332219241302;3918.6277303656107;3920.843166273317;3927.9018024549046;3951.6245956634075;3951.7628942263555;49289.75355123202;49821;50112.74943625258;50156.498435015914;51279;44723.10553788971;45567.08865822665;46250.30624540635;46663.5333646666;47212.76393618079;43080.3537946931;43420.04323871975;43560;44212;44249.55750442519;7452.813679658052;7647.426443016685;7740.7677769667;7744.767656970074;7972.960135199287;28511.42977140487;28825.135245942656;29151.854240728662;29334;29485.85257073701;34693;37728.245435091696;37780;38012.76891464256;38126;9967.700968970943;10047.296689231684;10105.696829095139;10297.9485102574;10343.120834729132;11132;11251.774964500828;11288.887111129112;11307.095432365555;11489.080873530265;9983.500824958868;10039.397636141855;10045.246606504688;10102.494875256061;10260.435676037889;10487.108595769445;11029.779404412027;11196.496157672762;11254.268472549258;11314.886851131712;10656.360618362924;10946.835797463204;11140.554377825121;11244.156688248579;11527.8270825936;9444;9620.278479113955;9656.662016829378;9729.805403891742;9866.851997219905;9691.854622180814;9982.35114717541;10012.749681257736;10031.799364012824;10313.896861031593 09:23:46 INFO - PROCESS | 9555 | __end_tp_report 09:23:46 INFO - PROCESS | 9555 | __start_cc_report 09:23:46 INFO - PROCESS | 9555 | _x_x_mozilla_cycle_collect,1061 09:23:46 INFO - PROCESS | 9555 | __end_cc_report 09:23:46 INFO - PROCESS | 9555 | __startTimestamp1462551826533__endTimestamp 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | ------- Summary: start ------- 09:23:46 INFO - PROCESS | 9555 | Number of tests: 6 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | [#0] dojo.html Cycles:165 Average:4685.97 Median:4781.07 stddev:490.56 (10.3%) stddev-sans-first:464.68 09:23:46 INFO - PROCESS | 9555 | Values: 2626.1 2647.2 2677.9 2699.2 2701.9 4630.3 4677.7 4678.1 4767.3 4824.5 4691.3 4702.8 4705.5 4732.2 4762.1 4273.3 4308.7 4363.9 4397.1 4536.2 4437.4 4466.5 4489.8 4495.5 4520.0 4204.0 4235.2 4333.5 4371.7 4375.3 4293.4 4307.6 4309.3 4352.9 4381.7 4352.0 4364.7 4372.3 4375.1 4416.2 4546.6 4559.0 4603.1 4604.9 4695.4 5014.3 5017.0 5047.8 5065.5 5068.0 5065.7 5097.8 5110.3 5111.4 5126.3 4639.6 4748.6 4778.1 4795.7 4863.0 5279.7 5297.0 5338.1 5339.7 5345.2 4817.0 5050.6 5084.4 5096.9 5097.6 4983.5 5060.3 5064.6 5101.3 5135.8 5048.5 5052.9 5053.7 5058.3 5101.5 4884.9 4945.2 5039.0 5042.1 5049.8 4263.9 4299.2 4319.9 4323.0 4348.7 3783.1 3806.9 3816.2 3832.4 3832.9 4265.7 4285.3 4369.8 4379.6 4422.4 4978.7 5030.6 5030.7 5049.7 5092.6 4308.1 4311.4 4313.4 4328.2 4366.9 4495.3 4568.2 4571.7 4577.4 4610.4 4743.1 4744.0 4749.7 4773.2 4782.7 5071.0 5093.9 5094.0 5095.6 5095.8 4560.8 4680.8 4708.9 4726.9 4764.1 5006.2 5022.6 5026.7 5030.3 5066.0 5066.9 5074.7 5084.3 5084.5 5087.8 4738.4 4857.4 4895.9 4913.1 4948.5 4898.2 4931.1 4932.1 4933.3 4987.8 4894.5 4916.3 4917.7 4965.7 4971.6 4781.1 4967.4 5024.4 5031.6 5058.0 4888.8 4916.8 4922.6 4925.3 4967.4 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | [#1] ext.html Cycles:180 Average:45994.91 Median:172768.11 stddev:74985.35 (43.4%) stddev-sans-first:75118.14 09:23:46 INFO - PROCESS | 9555 | Values: 571.9 608.8 611.6 616.5 635.7 28678.7 29358.6 31362.1 41601.4 43879.8 41739.2 44003.0 44031.6 44091.3 48154.5 7902.2 8003.7 8033.3 8039.5 8044.3 7625.6 7969.2 9936.5 10188.6 10189.5 10238.7 10309.7 10334.9 10364.6 10383.7 10236.3 10294.6 10297.8 10299.5 10305.1 10121.6 10170.9 10185.4 10191.0 10195.2 39806.4 40365.6 40365.8 40386.0 40441.4 3323.3 3424.6 3474.4 3503.9 3571.4 29880.3 30552.2 30694.2 30710.0 31381.2 3041.2 3160.7 3217.3 3221.4 3229.7 265509.0 267343.0 268245.0 269098.0 269469.0 59960.7 60252.7 60294.4 60341.7 60412.4 63173.4 63189.4 63223.7 63351.7 63448.0 15792.4 16330.6 16341.0 16342.9 16369.9 9743.9 11838.4 12243.9 12318.6 12338.9 18752.9 19052.3 19080.3 19162.4 19199.9 7224.2 7325.9 7361.8 7373.4 7540.5 927.4 986.8 990.7 1022.3 1044.9 28370.4 28532.0 28573.7 28664.3 28736.3 1020.1 1028.9 1085.9 1118.3 1132.6 15247.8 15397.5 15542.8 15583.6 15725.3 309576.0 313270.0 313319.0 313516.0 314155.0 48520.5 49863.3 49889.5 49962.3 49967.0 1146.5 1281.9 1300.4 1305.3 1336.1 28981.3 30181.8 30490.4 30619.8 31044.7 37933.6 38279.0 38376.8 38416.2 38456.0 274231.0 280556.0 280748.0 281008.0 281760.0 23094.3 25297.1 26253.5 26448.1 28273.7 43008.0 43246.6 44063.3 44105.0 44411.0 36817.3 38041.6 38130.2 38187.4 38318.4 37687.0 39867.0 39915.8 42364.2 43142.8 37640.2 38142.6 38622.6 38648.8 38656.0 31713.7 33449.3 34004.5 34147.3 34216.3 26169.0 26409.3 26471.5 26569.0 26724.3 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | [#2] jquery.html Cycles:180 Average:23171.39 Median:2430.96 stddev:61897.51 (2546.2%) stddev-sans-first:62047.47 09:23:46 INFO - PROCESS | 9555 | Values: 369.7 375.7 379.4 381.4 394.7 16136.0 16612.0 17277.7 17435.1 17481.3 10627.3 11455.3 11455.8 11468.7 11474.4 4620.6 4674.0 5283.4 5289.9 5301.1 5244.8 5246.0 5246.5 5265.9 5287.9 4619.2 4833.7 4837.4 4953.5 5232.4 4726.6 4742.0 4783.7 4788.9 4799.3 4585.4 4618.0 4662.1 4725.6 4735.8 12574.4 12610.7 12657.0 12691.9 18359.8 1921.2 1980.0 2006.0 2007.8 2048.5 8938.0 9333.5 9512.1 9514.6 9582.0 1749.2 1751.2 1780.7 1848.5 1850.1 70221.0 71583.3 72018.9 73185.6 73906.3 10221.1 10245.4 10311.7 10316.8 10464.6 14316.0 14421.1 14430.4 14441.1 14445.6 7207.0 7800.0 7818.1 7941.2 7946.1 7548.2 7566.2 7666.7 7683.4 7687.5 4378.2 4418.4 4445.3 4502.9 4541.3 1830.7 1873.7 1877.6 1906.9 1921.3 805.6 848.7 871.3 909.5 930.2 16175.4 16528.7 16807.8 17064.4 17302.8 871.8 871.9 875.6 881.8 922.7 7269.9 9706.5 9747.7 9758.7 9814.7 305872.0 311760.0 406674.0 408013.0 416749.0 71440.6 78618.0 81144.0 81161.0 86025.0 425.1 443.5 448.7 450.0 452.2 9297.9 9744.3 9757.0 10104.2 10136.9 25638.4 32707.0 34845.8 35262.3 35300.8 42135.8 43769.1 44168.6 49480.5 49728.3 7524.1 7663.5 7968.5 8040.1 8040.8 7266.5 9914.7 10920.5 10961.9 11810.1 10380.0 10628.8 10744.1 10866.3 10902.8 10536.2 10591.7 10714.7 10820.0 11093.8 10666.4 10691.7 11103.8 11165.8 11277.3 7462.5 7807.7 7849.7 7908.3 7951.2 10551.0 11001.7 11010.6 11014.6 11045.2 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | [#3] mootools.html Cycles:180 Average:5020.52 Median:5136.12 stddev:2779.45 (54.1%) stddev-sans-first:2773.26 09:23:46 INFO - PROCESS | 9555 | Values: 1310.6 1503.7 1503.7 1698.9 1876.5 6556.7 7399.9 7662.7 7668.9 7815.0 7608.8 7741.7 7750.0 7764.4 7773.6 2229.7 2258.5 2258.9 2260.1 2260.2 2162.8 2195.4 2226.7 2238.3 2238.6 2187.1 2189.9 2199.8 2200.8 2243.5 2151.7 2175.7 2178.9 2181.4 2182.6 2155.5 2156.3 2158.7 2160.5 2161.6 7509.4 7673.1 7731.5 7732.7 7748.5 4549.6 4637.4 4667.7 4670.6 4671.0 2768.5 2787.8 2810.5 2816.6 2857.8 841.2 844.9 851.9 869.8 872.8 10127.7 10194.2 10208.5 10224.1 10224.6 3957.5 3985.0 4068.9 4077.3 4105.8 8142.3 8207.8 8260.1 8267.2 8267.9 4394.2 4442.5 4443.3 4462.7 4466.8 3661.1 4042.7 4044.4 4133.9 4205.4 3497.5 3511.0 3555.8 3594.9 3603.2 1062.7 1092.2 1096.7 1098.9 1112.4 761.8 807.9 849.9 903.7 938.0 5037.5 5234.7 5312.3 5342.5 5403.1 412.9 418.1 421.4 426.2 431.5 3667.7 3718.1 3758.2 3764.0 3800.0 9023.0 9267.9 9390.3 9401.5 9464.8 9269.4 9310.1 9312.9 9374.3 9388.0 7220.1 7322.9 7334.4 7334.5 7339.6 5265.1 5322.6 5347.0 5359.4 5455.2 8337.9 8475.6 8698.6 8714.0 8747.3 8533.8 8815.9 8823.3 8833.4 8926.9 5623.4 5830.1 5839.6 6297.5 6379.1 6932.5 7271.9 7500.2 7510.4 7703.8 6764.3 6885.4 6886.3 6949.6 6988.9 6670.4 6671.2 6744.4 6786.0 6810.1 5926.6 6462.7 6486.4 6519.6 6537.6 4367.3 4401.6 4472.5 4484.7 4524.9 4581.0 4594.7 4643.9 4698.5 4723.6 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | [#4] prototype.html Cycles:180 Average:4105.47 Median:4652.93 stddev:1161.02 (25.0%) stddev-sans-first:1128.58 09:23:46 INFO - PROCESS | 9555 | Values: 299.2 311.6 315.9 318.2 320.1 4843.0 4886.4 4890.9 4895.8 4916.0 4577.6 4595.3 4658.1 4745.6 4831.2 3767.2 3779.7 3790.5 3803.4 3817.5 3800.2 3814.5 3824.3 3828.1 3831.9 3512.4 3532.6 3661.6 3678.6 3729.4 3729.3 3767.8 3775.2 3775.8 3779.7 3311.2 3316.8 3335.4 3349.9 3356.3 4461.8 4546.1 4637.8 4638.1 4655.3 4237.7 4247.7 4293.7 4296.9 4298.3 4949.1 4971.6 4975.2 4979.7 4998.7 3637.8 3656.3 3663.7 3673.6 3700.9 5028.5 5238.9 5243.3 5246.8 5249.9 3720.9 3725.2 3727.5 3731.6 3755.0 3790.7 3800.0 3800.4 3811.0 3815.8 4171.7 4203.2 4273.1 4286.7 4289.2 4942.5 4971.4 4975.0 4976.8 5010.2 1204.3 1268.8 1273.2 1280.8 1284.3 848.9 862.2 864.7 871.6 873.3 4280.2 4286.2 4295.5 4307.8 4350.3 4960.5 4965.4 5009.1 5023.9 5040.0 4111.3 4270.8 4304.4 4319.0 4328.2 2643.8 2668.9 2672.4 2681.8 2692.7 4588.0 4649.3 4665.6 4670.6 4672.3 4764.6 5030.7 5045.8 5100.8 5111.7 4618.6 4658.2 4658.6 4683.3 4687.3 5018.7 5033.5 5067.9 5073.1 5074.5 4690.6 4873.4 4890.6 4942.5 4952.7 4651.5 4654.4 4680.0 4696.2 4709.6 3683.5 3704.7 3711.1 3712.4 3719.3 4820.7 4878.0 4949.8 4967.6 5015.5 4892.9 4895.7 4897.4 4916.2 4923.8 4886.3 4895.3 4922.0 4925.9 4926.9 4554.5 4789.4 4841.8 4848.3 4852.0 4827.6 4846.9 4886.0 4898.5 4921.3 4682.5 4709.3 4735.5 4745.5 4762.9 09:23:46 INFO - PROCESS | 9555 | 09:23:46 INFO - PROCESS | 9555 | [#5] yui.html Cycles:180 Average:12732.08 Median:24300.73 stddev:14275.12 (58.7%) stddev-sans-first:14286.48 09:23:46 INFO - PROCESS | 9555 | Values: 681.7 741.6 792.8 793.8 811.7 11915.2 12665.3 12934.4 13138.3 13177.9 12317.8 12329.9 12376.2 12379.5 12384.3 674.1 832.7 841.5 847.6 851.5 829.5 836.4 837.8 837.9 837.9 721.8 902.0 904.4 904.4 905.0 879.9 881.8 883.6 883.6 884.3 654.1 656.0 656.0 656.4 657.1 11983.3 12016.4 12024.8 12079.5 12119.5 11567.4 11881.5 12173.9 12270.8 12880.2 11069.0 11553.4 11650.2 11940.1 12204.8 4118.1 4242.3 4263.7 4294.5 4389.5 45842.0 47456.3 47487.5 47537.5 47783.0 9497.2 9717.1 9984.8 10070.7 10273.0 16161.8 16275.4 16278.4 16287.3 16305.8 6312.9 6366.8 6413.5 6475.9 6572.4 3697.1 3737.4 3754.9 3784.4 3790.1 2898.8 2988.9 2990.0 2990.9 2991.1 537.5 549.8 553.0 569.5 605.2 536.4 589.9 610.3 635.6 652.0 8391.2 8432.9 8680.0 8824.5 8900.2 570.8 653.2 674.8 682.8 695.4 3918.6 3920.8 3927.9 3951.6 3951.8 49289.8 49821.0 50112.7 50156.5 51279.0 44723.1 45567.1 46250.3 46663.5 47212.8 43080.4 43420.0 43560.0 44212.0 44249.6 7452.8 7647.4 7740.8 7744.8 7973.0 28511.4 28825.1 29151.9 29334.0 29485.9 34693.0 37728.2 37780.0 38012.8 38126.0 9967.7 10047.3 10105.7 10297.9 10343.1 11132.0 11251.8 11288.9 11307.1 11489.1 9983.5 10039.4 10045.2 10102.5 10260.4 10487.1 11029.8 11196.5 11254.3 11314.9 10656.4 10946.8 11140.6 11244.2 11527.8 9444.0 9620.3 9656.7 9729.8 9866.9 9691.9 9982.4 10012.7 10031.8 10313.9 09:23:46 INFO - PROCESS | 9555 | -------- Summary: end -------- 09:23:46 INFO - PROCESS | 9555 | 09:23:47 INFO - TEST-INFO | 9555: exit 0 09:23:47 INFO - TEST-OK | dromaeo_css | took 1118273ms 09:23:47 INFO - TEST-START | kraken 09:23:47 INFO - operating with platform_type : linux_ 09:23:47 INFO - Initialising browser for kraken test... 09:23:47 INFO - TEST-INFO | started process 9738 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO09E12/profile http://localhost:34315/getInfo.html) 09:23:51 INFO - PROCESS | 9738 | __metrics Screen width/height:1600/1200 09:23:51 INFO - PROCESS | 9738 | colorDepth:24 09:23:51 INFO - PROCESS | 9738 | Browser inner width/height: 1024/697 09:23:51 INFO - PROCESS | 9738 | __metrics 09:23:52 ERROR - PROCESS | 9738 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:23:53 INFO - TEST-INFO | 9738: exit 0 09:23:53 INFO - Browser initialized. 09:23:53 INFO - Running cycle 1/1 for kraken test... 09:23:53 INFO - TEST-INFO | started process 9817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO09E12/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:05 INFO - PROCESS | 9817 | RSS: Main: 154357760 09:24:05 INFO - PROCESS | 9817 | 09:24:07 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34315/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:08 INFO - PROCESS | 9817 | RSS: Main: 210264064 09:24:08 INFO - PROCESS | 9817 | 09:24:11 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34315/tests/kraken/driver.html?testName=audio-dft) 09:24:12 INFO - PROCESS | 9817 | RSS: Main: 198582272 09:24:12 INFO - PROCESS | 9817 | 09:24:15 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34315/tests/kraken/driver.html?testName=audio-fft) 09:24:15 INFO - PROCESS | 9817 | RSS: Main: 266809344 09:24:15 INFO - PROCESS | 9817 | 09:24:18 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34315/tests/kraken/driver.html?testName=audio-oscillator) 09:24:18 INFO - PROCESS | 9817 | RSS: Main: 176300032 09:24:18 INFO - PROCESS | 9817 | 09:24:20 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34315/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:21 INFO - PROCESS | 9817 | RSS: Main: 180568064 09:24:21 INFO - PROCESS | 9817 | 09:24:24 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34315/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:25 INFO - PROCESS | 9817 | RSS: Main: 216727552 09:24:25 INFO - PROCESS | 9817 | 09:24:28 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34315/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:29 INFO - PROCESS | 9817 | RSS: Main: 217006080 09:24:29 INFO - PROCESS | 9817 | 09:24:32 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34315/tests/kraken/driver.html?testName=json-parse-financial) 09:24:32 INFO - PROCESS | 9817 | RSS: Main: 216973312 09:24:32 INFO - PROCESS | 9817 | 09:24:34 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34315/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:35 INFO - PROCESS | 9817 | RSS: Main: 204734464 09:24:35 INFO - PROCESS | 9817 | 09:24:36 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:37 INFO - PROCESS | 9817 | RSS: Main: 208498688 09:24:37 INFO - PROCESS | 9817 | 09:24:39 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:40 INFO - PROCESS | 9817 | RSS: Main: 218939392 09:24:40 INFO - PROCESS | 9817 | 09:24:43 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:43 INFO - PROCESS | 9817 | RSS: Main: 225820672 09:24:43 INFO - PROCESS | 9817 | 09:24:46 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:47 INFO - PROCESS | 9817 | RSS: Main: 220151808 09:24:47 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:34315/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34315/tests/kraken/driver.html?testName=ai-astar) 09:24:49 INFO - PROCESS | 9817 | RSS: Main: 265478144 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | __start_tp_report 09:24:49 INFO - PROCESS | 9817 | _x_x_mozilla_page_load 09:24:49 INFO - PROCESS | 9817 | _x_x_mozilla_page_load_details 09:24:49 INFO - PROCESS | 9817 | |i|pagename|runs| 09:24:49 INFO - PROCESS | 9817 | |0;ai-astar;114;110;110;112;113;115;113;113;113;115 09:24:49 INFO - PROCESS | 9817 | |1;audio-beat-detection;162;140;159;197;132;157;158;131;188;130 09:24:49 INFO - PROCESS | 9817 | |2;audio-dft;160;161;161;160;162;162;164;161;161;160 09:24:49 INFO - PROCESS | 9817 | |3;audio-fft;75;77;85;129;76;76;77;76;126;75 09:24:49 INFO - PROCESS | 9817 | |4;audio-oscillator;92;94;120;92;94;94;125;92;92;125 09:24:49 INFO - PROCESS | 9817 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;116 09:24:49 INFO - PROCESS | 9817 | |6;imaging-darkroom;146;146;146;146;145;145;145;146;146;146 09:24:49 INFO - PROCESS | 9817 | |7;imaging-desaturate;96;95;95;95;94;95;94;95;95;94 09:24:49 INFO - PROCESS | 9817 | |8;json-parse-financial;66;66;76;65;66;66;66;83;63;64 09:24:49 INFO - PROCESS | 9817 | |9;json-stringify-tinderbox;65;64;63;64;64;64;64;66;65;64 09:24:49 INFO - PROCESS | 9817 | |10;stanford-crypto-aes;82;80;81;80;84;82;83;88;87;83 09:24:49 INFO - PROCESS | 9817 | |11;stanford-crypto-ccm;144;138;146;138;128;128;133;131;192;142 09:24:49 INFO - PROCESS | 9817 | |12;stanford-crypto-pbkdf2;174;169;170;172;172;176;174;172;169;170 09:24:49 INFO - PROCESS | 9817 | |13;stanford-crypto-sha256-iterative;70;68;70;68;67;72;67;67;66;67 09:24:49 INFO - PROCESS | 9817 | __end_tp_report 09:24:49 INFO - PROCESS | 9817 | __start_cc_report 09:24:49 INFO - PROCESS | 9817 | _x_x_mozilla_cycle_collect,1862 09:24:49 INFO - PROCESS | 9817 | __end_cc_report 09:24:49 INFO - PROCESS | 9817 | __startTimestamp1462551889340__endTimestamp 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | ------- Summary: start ------- 09:24:49 INFO - PROCESS | 9817 | Number of tests: 14 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.75 (1.5%) stddev-sans-first:1.80 09:24:49 INFO - PROCESS | 9817 | Values: 114.0 110.0 110.0 112.0 113.0 115.0 113.0 113.0 113.0 115.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:158.50 stddev:23.30 (14.7%) stddev-sans-first:24.59 09:24:49 INFO - PROCESS | 9817 | Values: 162.0 140.0 159.0 197.0 132.0 157.0 158.0 131.0 188.0 130.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 09:24:49 INFO - PROCESS | 9817 | Values: 160.0 161.0 161.0 160.0 162.0 162.0 164.0 161.0 161.0 160.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#3] audio-fft Cycles:10 Average:87.20 Median:76.00 stddev:21.45 (28.2%) stddev-sans-first:22.29 09:24:49 INFO - PROCESS | 9817 | Values: 75.0 77.0 85.0 129.0 76.0 76.0 77.0 76.0 126.0 75.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:92.00 stddev:14.81 (16.1%) stddev-sans-first:15.26 09:24:49 INFO - PROCESS | 9817 | Values: 92.0 94.0 120.0 92.0 94.0 94.0 125.0 92.0 92.0 125.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:24:49 INFO - PROCESS | 9817 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:24:49 INFO - PROCESS | 9817 | Values: 146.0 146.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 09:24:49 INFO - PROCESS | 9817 | Values: 96.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:66.00 stddev:6.31 (9.6%) stddev-sans-first:6.65 09:24:49 INFO - PROCESS | 9817 | Values: 66.0 66.0 76.0 65.0 66.0 66.0 66.0 83.0 63.0 64.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 09:24:49 INFO - PROCESS | 9817 | Values: 65.0 64.0 63.0 64.0 64.0 64.0 64.0 66.0 65.0 64.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:2.71 (3.3%) stddev-sans-first:2.85 09:24:49 INFO - PROCESS | 9817 | Values: 82.0 80.0 81.0 80.0 84.0 82.0 83.0 88.0 87.0 83.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:140.00 stddev:18.70 (13.4%) stddev-sans-first:19.82 09:24:49 INFO - PROCESS | 9817 | Values: 144.0 138.0 146.0 138.0 128.0 128.0 133.0 131.0 192.0 142.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:2.35 (1.4%) stddev-sans-first:2.35 09:24:49 INFO - PROCESS | 9817 | Values: 174.0 169.0 170.0 172.0 172.0 176.0 174.0 172.0 169.0 170.0 09:24:49 INFO - PROCESS | 9817 | 09:24:49 INFO - PROCESS | 9817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.87 09:24:49 INFO - PROCESS | 9817 | Values: 70.0 68.0 70.0 68.0 67.0 72.0 67.0 67.0 66.0 67.0 09:24:49 INFO - PROCESS | 9817 | -------- Summary: end -------- 09:24:49 INFO - PROCESS | 9817 | 09:24:50 INFO - TEST-INFO | 9817: exit 0 09:24:50 INFO - TEST-OK | kraken | took 63127ms 09:24:50 INFO - SUITE-END | took 1181s 09:24:50 INFO - Completed test suite (00:19:41) 09:24:50 INFO - javascript benchmark 09:24:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.080871694907, 2647.1661426650617, 2677.9062732804355, 2699.2172270041688, 2701.9324516887077, 4630.305454181875, 4677.74272415017, 4678.064387122572, 4767.261074533449, 4824.493428190042, 4691.319758634996, 4702.788374523147, 4705.482396936334, 4732.2428411454175, 4762.071396077767, 4273.273543497605, 4308.655307575402, 4363.869083927471, 4397.1205758848355, 4536.206163921317, 4437.423134992447, 4466.508684044752, 4489.820407183709, 4495.460544734637, 4519.977400113011, 4203.978980105096, 4235.152969406131, 4333.501647310537, 4371.715838470521, 4375.321825117112, 4293.377460268275, 4307.590778876001, 4309.267424537836, 4352.912941741148, 4381.671374646914, 4351.9782401088105, 4364.672649551265, 4372.27857403528, 4375.124975005012, 4416.1609294233995, 4546.568076032771, 4559.0, 4603.056373443436, 4604.930926036112, 4695.3661255730385, 5014.323066386028, 5017.046761115376, 5047.823326183603, 5065.544101030888, 5068.0, 5065.696058236481, 5097.821576244851, 5110.335656364686, 5111.4121875984365, 5126.256692779526, 4639.628829693616, 4748.643851711066, 4778.116048531033, 4795.736234507066, 4862.95137048625, 5279.736013199325, 5296.973515132399, 5338.092524270884, 5339.679619222859, 5345.1714984177515, 4817.0, 5050.6464547482055, 5084.3644544431945, 5096.872578185575, 5097.64316497849, 4983.476734942851, 5060.266261392151, 5064.645474816727, 5101.311322971425, 5135.794568217229, 5048.545630893163, 5052.9242061369105, 5053.67151135175, 5058.342415485963, 5101.464346243665, 4884.877878053077, 4945.159322915113, 5038.974805126024, 5042.142835717937, 5049.798008079636, 4263.893402664896, 4299.1831552005015, 4319.935200971988, 4323.0, 4348.695591308578, 3783.05423644089, 3806.904827379338, 3816.160444702161, 3832.425136229532, 3832.9041773955873, 4265.658747300208, 4285.335772955197, 4369.781510924441, 4379.605835474823, 4422.425084738963, 4978.726170060609, 5030.597552195889, 5030.698158110525, 5049.697018178921, 5092.6435149539175, 4308.138372325548, 4311.439512863308, 4313.352997050405, 4328.242557552416, 4366.912661746747, 4495.280755079171, 4568.200564901195, 4571.7427707380075, 4577.404937358122, 4610.446746390455, 4743.146233677971, 4744.027474367677, 4749.691270067435, 4773.188557945088, 4782.736949467743, 5070.974645126751, 5093.898122037464, 5094.0, 5095.643304968617, 5095.796168153232, 4560.817567297271, 4680.7659617018335, 4708.858734237979, 4726.858194254178, 4764.071006153767, 5006.224035274538, 5022.648414610942, 5026.698398096126, 5030.346055012825, 5066.03745288394, 5066.9239961401345, 5074.720890351066, 5084.339035925306, 5084.491550844886, 5087.821926232564, 4738.36032135671, 4857.368542089505, 4895.902081958412, 4913.091078150554, 4948.505149485023, 4898.191798353232, 4931.087748766489, 4932.062908047603, 4933.309336692938, 4987.750612469435, 4894.486078961658, 4916.262560615936, 4917.729524876023, 4965.652404331662, 4971.552560269593, 4781.067691800205, 4967.379077615298, 5024.422191447884, 5031.622628302819, 5057.974710126426, 4888.780004899859, 4916.803327866845, 4922.556969872729, 4925.335079764186, 4967.40391153064], "value": 4655.038026813762, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.9142128680697, 608.7564974010397, 611.5688439650047, 616.5375968023983, 635.6503922842436, 28678.713212867864, 29358.559621605695, 31362.05913822586, 41601.37597936026, 43879.78060109703, 41739.16521669565, 44003.0, 44031.559684403146, 44091.338629920574, 48154.51845481544, 7902.20977902211, 8003.719869804558, 8033.317168040694, 8039.5176289422525, 8044.276015158634, 7625.618719064052, 7969.163237860028, 9936.453495057769, 10188.59245630174, 10189.54147063384, 10238.7440313992, 10309.690709278697, 10334.948325258363, 10364.585416583366, 10383.740406489822, 10236.283460157792, 10294.639687610972, 10297.794044119075, 10299.536520856505, 10305.124064454456, 10121.645742399054, 10170.898291017069, 10185.439800810953, 10191.0, 10195.184385249237, 39806.40290395646, 40365.59634403677, 40365.79817100925, 40386.0, 40441.39337909934, 3323.285493618859, 3424.6061702903985, 3474.3572439098593, 3503.91240218994, 3571.357155711971, 29880.252993675116, 30552.2361940951, 30694.232644183852, 30710.0, 31381.215469613213, 3041.194083567856, 3160.7313378362865, 3217.3404452087266, 3221.4040402525607, 3229.7416206703406, 265509.0, 267343.0, 268245.0, 269098.0, 269469.0, 59960.70019649961, 60252.698736506034, 60294.39705602888, 60341.69829150914, 60412.395876041555, 63173.368266317666, 63189.36810631927, 63223.683881581215, 63351.68324158442, 63448.0, 15792.36830526789, 16330.591735206715, 16341.0, 16342.918285408497, 16369.91815040941, 9743.9025609743, 11838.408079595985, 12243.938780306042, 12318.568850090203, 12338.876611233773, 18752.906235469007, 19052.333168339042, 19080.33218837334, 19162.425127246206, 19199.904000480186, 7224.241454647292, 7325.853482930418, 7361.779146625609, 7373.446991475661, 7540.461316434715, 927.4388994658269, 986.8026394721085, 990.7275499237767, 1022.2792930983638, 1044.8537204791335, 28370.43259134847, 28532.0, 28573.714262857105, 28664.283392915346, 28736.281592960342, 1020.0669730860127, 1028.8662473878348, 1085.8598471604782, 1118.340179294204, 1132.5696235430485, 15247.771283430757, 15397.461088862061, 15542.844571554366, 15583.612265360283, 15725.292361843745, 309576.0, 313270.0, 313319.0, 313516.0, 314155.0, 48520.5147948516, 49863.252051219264, 49889.501104988485, 49962.250566241535, 49967.0, 1146.48408216303, 1281.8910392616733, 1300.3693208793727, 1305.2951406240525, 1336.0981337597277, 28981.27546811262, 30181.849090754407, 30490.390192195588, 30619.846900765355, 31044.68955310418, 37933.620663794114, 38279.043023923514, 38376.80811595924, 38416.23167536689, 38456.03859903413, 274231.0, 280556.0, 280748.0, 281008.0, 281760.0, 23094.307170784905, 25297.114600989615, 26253.474930501667, 26448.074317398798, 28273.717262827107, 43008.0, 43246.567534324255, 44063.33904991492, 44105.0, 44411.0, 36817.26365472622, 38041.61958380381, 38130.237395252494, 38187.42718859275, 38318.425223622224, 37687.0, 39867.0, 39915.80042099771, 42364.152716946104, 43142.78428607837, 37640.247195055395, 38142.61857381391, 38622.6137738619, 38648.80675596604, 38656.0, 31713.682863171074, 33449.331013380084, 34004.48993265053, 34147.31705365929, 34216.31567368589, 26169.0, 26409.33976650522, 26471.470570588095, 26569.0, 26724.331891702863], "value": 18597.17915107172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.74302859512613, 375.7313520832605, 379.3778203745857, 381.42214544964366, 394.69214013069796, 16136.0, 16612.0, 17277.74987443493, 17435.128243587835, 17481.300747970065, 10627.256092073558, 11455.312681239131, 11455.828162577547, 11468.655940321803, 11474.368909709963, 4620.561046700558, 4673.953260467386, 5283.418823929364, 5289.920651190216, 5301.125314323132, 5244.842654720364, 5245.973770131163, 5246.50158234969, 5265.921011184835, 5287.867803304929, 4619.214733495297, 4833.734144622044, 4837.371141751585, 4953.504649535053, 5232.398274198478, 4726.574608285254, 4741.976290118562, 4783.7129772213775, 4788.904221915577, 4799.280107983813, 4585.358049873021, 4618.021376212358, 4662.0675864826835, 4725.621950243973, 4735.834245801415, 12574.371281435891, 12610.68473288166, 12657.0, 12691.936540317332, 18359.816401835946, 1921.2411097616364, 1979.9703004454946, 2006.0, 2007.7992200779952, 2048.528838367169, 8937.955310223408, 9333.486658233795, 9512.14390704833, 9514.571844266955, 9581.952090239574, 1749.2303386510023, 1751.1856986501211, 1780.7150855863129, 1848.4639454558162, 1850.1027001904065, 70221.0, 71583.28416715818, 72018.85745978921, 73185.63407182983, 73906.26093739047, 10221.080102790784, 10245.385276883411, 10311.690649280534, 10316.793664126675, 10464.581416743396, 14316.0, 14421.062630929166, 14430.42278308856, 14441.133531987904, 14445.566633001026, 7206.963965180141, 7800.0, 7818.14000459949, 7941.205879412013, 7946.086200086948, 7548.245175482518, 7566.205548417337, 7666.731664391831, 7683.423743219169, 7687.500312479671, 4378.233809083397, 4418.403515525427, 4445.310976798602, 4502.887427814331, 4541.296099104644, 1830.6613276543883, 1873.7470441490498, 1877.5966762543965, 1906.8569857260484, 1921.34674210769, 805.564994902746, 848.6605357856783, 871.285545852395, 909.486140330711, 930.2279108340061, 16175.43385981485, 16528.6694266114, 16807.83192168087, 17064.402745903833, 17302.826971730123, 871.7951281448854, 871.9084496127942, 875.6453636277317, 881.7787364500214, 922.7047344849584, 7269.927300727031, 9706.514674266258, 9747.658831940847, 9758.658446954323, 9814.65648702292, 305872.0, 311760.0, 406674.0, 408013.0, 416749.0, 71440.64279678569, 78618.0, 81144.0, 81161.0, 86025.0, 425.08818584136856, 443.5232125465138, 448.65005295869275, 450.0436572283897, 452.19734970427754, 9297.907020929704, 9744.269179811401, 9756.951215243878, 10104.191664666661, 10136.898631013595, 25638.359041024123, 32707.0, 34845.825770870986, 35262.294754105285, 35300.76447324331, 42135.7893210532, 43769.12461750811, 44168.55831441644, 49480.50519494903, 49728.25407618816, 7524.134724506752, 7663.540187588763, 7968.521888686466, 8040.115587285511, 8040.798980025312, 7266.491345605757, 9914.652987145415, 10920.453977301262, 10961.945190273998, 11810.114241431755, 10380.0, 10628.787424251626, 10744.086752626114, 10866.348019118877, 10902.781944361226, 10536.209784266057, 10591.682249532527, 10714.73213169677, 10820.02619764225, 11093.833592496281, 10666.36001839892, 10691.679249622524, 11103.833442498531, 11165.832512512481, 11277.32336059839, 7462.514936529108, 7807.726729564438, 7849.686012559434, 7908.327792137503, 7951.165127661744, 10551.0, 11001.669949901516, 11010.559577616805, 11014.559417623526, 11045.226834121535], "value": 7749.884581874144, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1310.6199202231353, 1503.6767095074556, 1503.736846051941, 1698.9490315290545, 1876.474587115608, 6556.737730490775, 7399.889001664979, 7662.693492260303, 7668.923310766883, 7814.960925195381, 7608.77173684789, 7741.690332386712, 7750.0, 7764.417668674843, 7773.611319434034, 2229.732432108149, 2258.4918393361527, 2258.8531745436494, 2260.1185537640335, 2260.152442833937, 2162.7512836023902, 2195.4182141732454, 2226.699395581592, 2238.328501449567, 2238.630625946725, 2187.0923566719794, 2189.926935801454, 2199.7800219977953, 2200.7579166291694, 2243.517643706603, 2151.6880052392316, 2175.6627722703006, 2178.901949412272, 2181.432827464863, 2182.639864422368, 2155.4503601581655, 2156.33153722345, 2158.676198570227, 2160.459885028743, 2161.567686462714, 7509.436792240604, 7673.117591476996, 7731.536107833548, 7732.729354472623, 7748.457607967444, 4549.567791059844, 4637.420322459692, 4667.6732628716, 4670.602998745111, 4670.953290467086, 2768.543190373606, 2787.818791778528, 2810.4519618674367, 2816.6479190101236, 2857.7713782897317, 841.1714461255658, 844.8986121665439, 851.9020312664061, 869.847776639092, 872.7730789994647, 10127.696169114939, 10194.23543234253, 10208.48957552127, 10224.130948869355, 10224.59101635941, 3957.5053118360206, 3985.0, 4068.877933661995, 4077.327241005201, 4105.835766569364, 8142.348612111017, 8207.794805129919, 8260.05009423924, 8267.214614611723, 8267.875981860278, 4394.209042372404, 4442.466903971479, 4443.311286750559, 4462.709923854939, 4466.798994045275, 3661.0847288177956, 4042.7372220805555, 4044.373122166069, 4133.937990930139, 4205.432266644025, 3497.45789402643, 3511.0, 3555.7866528008403, 3594.9101272468397, 3603.243318903007, 1062.7130674717782, 1092.1644941619668, 1096.6764804382726, 1098.9010989011028, 1112.3759311405438, 761.8095476130967, 807.8707406814881, 849.8682704180862, 903.661127077346, 937.9906200937903, 5037.546620804145, 5234.685918844882, 5312.335958005249, 5342.492463215988, 5403.13549832025, 412.91328820947336, 418.080223508283, 421.41423421444216, 426.1668438203305, 431.52532214564354, 3667.7249206309634, 3718.1262403335195, 3758.1544152565452, 3763.9649096498683, 3799.981000094982, 9022.954885225532, 9267.907320926839, 9390.34267601275, 9401.482918439415, 9464.763380915532, 9269.397489163182, 9310.115539023782, 9312.906870931203, 9374.250059995184, 9388.0, 7220.097487814023, 7322.853542929218, 7334.4499162563025, 7334.486585938933, 7339.633018349168, 5265.1049321614655, 5322.600804939722, 5346.97326513365, 5359.437259087896, 5455.208994695826, 8337.916620833714, 8475.618597163266, 8698.608562614823, 8714.0, 8747.343949203709, 8533.786655333666, 8815.911840881508, 8823.29413646894, 8833.425827321204, 8926.86609700842, 5623.409541998031, 5830.125481177857, 5839.620424672383, 6297.496200304056, 6379.106925030406, 6932.549384290005, 7271.8909216360735, 7500.174980752222, 7510.39916806665, 7703.807404814925, 6764.323567643196, 6885.449164066963, 6886.276940921131, 6949.61777102244, 6988.860222795617, 6670.433013193933, 6671.232808227116, 6744.426723728538, 6786.0, 6810.080639113657, 5926.555508336805, 6462.741490340334, 6486.351364863476, 6519.608823470607, 6537.640429776408, 4367.344898265285, 4401.647868170603, 4472.463304403493, 4484.68607197493, 4524.864254072383, 4581.0, 4594.747288899142, 4643.883902902455, 4698.459677137036, 4723.574878260973], "value": 3998.360222975392, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.232468717739, 311.56381066506896, 315.94944808830576, 318.1997276848724, 320.1420193880401, 4843.0, 4886.364772579568, 4890.926636100457, 4895.779689913949, 4915.976674345278, 4577.610903073243, 4595.3107033944925, 4658.138244424784, 4745.57289843914, 4831.202851529493, 3767.1523907120954, 3779.7165212609025, 3790.5072340595684, 3803.4484999675033, 3817.48463957365, 3800.2399520095955, 3814.4659747635355, 3824.29250588642, 3828.138668799512, 3831.8924591474715, 3512.4028915084496, 3532.629073947237, 3661.5972243053243, 3678.558572971234, 3729.440583912408, 3729.272791805599, 3767.775472971268, 3775.2449510097817, 3775.754575952554, 3779.697624190072, 3311.205310725433, 3316.7844090134063, 3335.4163021471386, 3349.916252093717, 3356.311956049004, 4461.754603496806, 4546.090781843612, 4637.837675681335, 4638.1187574360765, 4655.2784318430695, 4237.724547904377, 4247.660187185018, 4293.656507479394, 4296.892577685551, 4298.312270036779, 4949.133901567247, 4971.6271279654175, 4975.203967365204, 4979.684446732287, 4998.675086119427, 3637.8181090945614, 3656.305301992613, 3663.6993867177034, 3673.6142705016123, 3700.9259814803822, 5028.4971502849785, 5238.926020165857, 5243.292155559027, 5246.7638956247065, 5249.86875328116, 3720.8511659533856, 3725.18046029873, 3727.5154229949935, 3731.552213734315, 3754.981225093857, 3790.6967442604528, 3800.0049973763994, 3800.4489349044234, 3810.9809450952566, 3815.809209539512, 4171.687123465692, 4203.159289061129, 4273.1240095780295, 4286.721363111388, 4289.1850548395705, 4942.492539775403, 4971.37857767779, 4974.950250497449, 4976.776045077981, 5010.223415370623, 1204.3135412814786, 1268.8199974024062, 1273.178799674205, 1280.788669869461, 1284.2808027504627, 848.893888263967, 862.1852349529635, 864.6714248585623, 871.5990644303564, 873.2882700598991, 4280.229558679468, 4286.2284788738325, 4295.484541854998, 4307.827686892552, 4350.282203436461, 4960.454350021495, 4965.4289756678445, 5009.073321435473, 5023.949760502348, 5039.974800125976, 4111.342185250345, 4270.807813648331, 4304.354346847936, 4318.985038515946, 4328.177646247203, 2643.841369517835, 2668.8924096500123, 2672.4387878545335, 2681.8122731409003, 2692.6634170728657, 4588.036512332381, 4649.325847752057, 4665.580097791215, 4670.579647831712, 4672.252439609646, 4764.595009424169, 5030.698158110525, 5045.84862454127, 5100.821471248489, 5111.718855462986, 4618.552167351309, 4658.1848176568965, 4658.627309815139, 4683.344331793483, 4687.296905464208, 5018.723970181675, 5033.489953014155, 5067.9239811403595, 5073.137566613611, 5074.467180945948, 4690.648201384842, 4873.415190177201, 4890.559849613552, 4942.456329803791, 4952.678075925053, 4651.4650165446, 4654.394928659252, 4679.953200467951, 4696.201645720167, 4709.599684026896, 3683.465897444909, 3704.666580007812, 3711.1278849469813, 3712.424574191005, 3719.274741425504, 4820.734859582757, 4878.000009997871, 4949.752512374295, 4967.60259179272, 5015.498450154955, 4892.877678058077, 4895.73073480962, 4897.3878265216845, 4916.237983112624, 4923.803047878045, 4886.315915771866, 4895.290182923527, 4921.9507804921495, 4925.901481970269, 4926.901461970812, 4554.476235232991, 4789.44921334051, 4841.782119804688, 4848.321235027029, 4851.9514804852915, 4827.589654879374, 4846.903061938812, 4885.975570122127, 4898.510148985073, 4921.277552856472, 4682.508336624605, 4709.293605959134, 4735.502772208868, 4745.481445937405, 4762.904741905212], "value": 3741.8550692027784, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.6898311268372, 741.603242265388, 792.8493586218622, 793.8174219929416, 811.7240138352962, 11915.165938384316, 12665.303408312551, 12934.417951192196, 13138.343082845868, 13177.868221317784, 12317.815232771516, 12329.938350308259, 12376.195547289442, 12379.50481980722, 12384.318862462562, 674.1472037872096, 832.7418500264907, 841.5119230846094, 847.5507980770202, 851.5061264466625, 829.4608504472111, 836.4145098431092, 837.7863644770575, 837.924586787189, 837.9329653627725, 721.7942886277413, 902.0213068820337, 904.3624244907325, 904.4121321141278, 905.0180554098778, 879.8812160358366, 881.7883707910055, 883.5802993578031, 883.6377085395021, 884.3367474394204, 654.1104098426136, 655.9540832141752, 655.9901601475982, 656.4354654996699, 657.1128975882568, 11983.281003139753, 12016.399180041051, 12024.819627705592, 12079.456424460921, 12119.515219391214, 11567.42162891852, 11881.524739010429, 12173.939130304381, 12270.81593776094, 12880.227186368847, 11069.0, 11553.422328883606, 11650.242734222249, 11940.104492163036, 12204.755904881942, 4118.094019315746, 4242.342436922282, 4263.737356164712, 4294.484661840568, 4389.4513185851765, 45842.0, 47456.28815567769, 47487.52512474865, 47537.524624753656, 47783.0, 9497.240220782322, 9717.12545870875, 9984.750381240527, 10070.74823129413, 10273.0, 16161.757573636405, 16275.430359937345, 16278.43025494102, 16287.348506059861, 16305.755413668805, 6312.936870631235, 6366.808995730043, 6413.518986076063, 6475.870482590321, 6572.375624315682, 3697.131174174067, 3737.4020156774786, 3754.9249015019545, 3784.413415920537, 3790.1093243087853, 2898.811577247472, 2988.850557472161, 2989.9551506727416, 2990.8504574771173, 2991.132571554225, 537.5081800152894, 549.8178915332068, 552.9668219906819, 569.5443645083999, 605.231356177652, 536.351015271518, 589.9233099697097, 610.3133974278936, 635.5836926812945, 651.9576227545194, 8391.202835730717, 8432.873506897278, 8680.0, 8824.51465169409, 8900.198982091642, 570.7973669347405, 653.242239002764, 674.7570874485182, 682.8054004608663, 695.4332219241302, 3918.6277303656107, 3920.843166273317, 3927.9018024549046, 3951.6245956634075, 3951.7628942263555, 49289.75355123202, 49821.0, 50112.74943625258, 50156.498435015914, 51279.0, 44723.10553788971, 45567.08865822665, 46250.30624540635, 46663.5333646666, 47212.76393618079, 43080.3537946931, 43420.04323871975, 43560.0, 44212.0, 44249.55750442519, 7452.813679658052, 7647.426443016685, 7740.7677769667, 7744.767656970074, 7972.960135199287, 28511.42977140487, 28825.135245942656, 29151.854240728662, 29334.0, 29485.85257073701, 34693.0, 37728.245435091696, 37780.0, 38012.76891464256, 38126.0, 9967.700968970943, 10047.296689231684, 10105.696829095139, 10297.9485102574, 10343.120834729132, 11132.0, 11251.774964500828, 11288.887111129112, 11307.095432365555, 11489.080873530265, 9983.500824958868, 10039.397636141855, 10045.246606504688, 10102.494875256061, 10260.435676037889, 10487.108595769445, 11029.779404412027, 11196.496157672762, 11254.268472549258, 11314.886851131712, 10656.360618362924, 10946.835797463204, 11140.554377825121, 11244.156688248579, 11527.8270825936, 9444.0, 9620.278479113955, 9656.662016829378, 9729.805403891742, 9866.851997219905, 9691.854622180814, 9982.35114717541, 10012.749681257736, 10031.799364012824, 10313.896861031593], "value": 6056.538743644296, "unit": "score"}], "name": "dromaeo_css", "value": 6270.739213644858, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 110.0, 112.0, 113.0, 115.0, 113.0, 113.0, 113.0, 115.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 140.0, 159.0, 197.0, 132.0, 157.0, 158.0, 131.0, 188.0, 130.0], "value": 155.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 162.0, 162.0, 164.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 85.0, 129.0, 76.0, 76.0, 77.0, 76.0, 126.0, 75.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 120.0, 92.0, 94.0, 94.0, 125.0, 92.0, 92.0, 125.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 76.0, 65.0, 66.0, 66.0, 66.0, 83.0, 63.0, 64.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 66.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 81.0, 80.0, 84.0, 82.0, 83.0, 88.0, 87.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 138.0, 146.0, 138.0, 128.0, 128.0, 133.0, 131.0, 192.0, 142.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 169.0, 170.0, 172.0, 172.0, 176.0, 174.0, 172.0, 169.0, 170.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 70.0, 68.0, 67.0, 72.0, 67.0, 67.0, 66.0, 67.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1573.4999999999998, "alertThreshold": 2.0}]} 09:24:50 INFO - Return code: 0 09:24:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:24:50 ERROR - # TBPL SUCCESS # 09:24:50 INFO - Running post-action listener: _resource_record_post_action 09:24:50 INFO - ##### 09:24:50 INFO - ##### Finished run-tests step (success) 09:24:50 INFO - ##### 09:24:50 INFO - Running post-run listener: _resource_record_post_run 09:24:51 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 519606272; Read time: 0; Write time: 554824 09:24:51 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235008000; Read time: 0; Write time: 322452 09:24:51 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 284598272; Read time: 0; Write time: 232372 09:24:51 INFO - Running post-run listener: _upload_blobber_files 09:24:51 INFO - Blob upload gear active. 09:24:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:24:51 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 09:24:51 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'] 09:24:51 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 09:24:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:24:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:52 INFO - (blobuploader) - INFO - Done attempting. 09:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:53 INFO - (blobuploader) - INFO - Done attempting. 09:24:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:53 INFO - Return code: 0 09:24:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea67a5bbccd0ed7ba00f067a0eaa837c61defa7b9a7a9b909285d2e785b153de6a5082cabad78f4265891ce77fb3de0bc426e8e8fc9cbc395ed1d41c22884a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765cae4b308ca4b136e9ddcbaad24171740568f5b9dc77f3fb436b5cd61105b20829aadf132246fdc0e2437b4695ca329c454f1922e1a97b564bfb24e788d852"} 09:24:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:53 INFO - Contents: 09:24:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea67a5bbccd0ed7ba00f067a0eaa837c61defa7b9a7a9b909285d2e785b153de6a5082cabad78f4265891ce77fb3de0bc426e8e8fc9cbc395ed1d41c22884a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765cae4b308ca4b136e9ddcbaad24171740568f5b9dc77f3fb436b5cd61105b20829aadf132246fdc0e2437b4695ca329c454f1922e1a97b564bfb24e788d852"} 09:24:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:53 INFO - Copying logs to upload dir... 09:24:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.241229 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-05-06 09:24:53.763861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:24:53.767852) ========= 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=62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218 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/ea67a5bbccd0ed7ba00f067a0eaa837c61defa7b9a7a9b909285d2e785b153de6a5082cabad78f4265891ce77fb3de0bc426e8e8fc9cbc395ed1d41c22884a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765cae4b308ca4b136e9ddcbaad24171740568f5b9dc77f3fb436b5cd61105b20829aadf132246fdc0e2437b4695ca329c454f1922e1a97b564bfb24e788d852"} build_url:https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/AKyk2WwwRP-anW3FNeLY0Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea67a5bbccd0ed7ba00f067a0eaa837c61defa7b9a7a9b909285d2e785b153de6a5082cabad78f4265891ce77fb3de0bc426e8e8fc9cbc395ed1d41c22884a2e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765cae4b308ca4b136e9ddcbaad24171740568f5b9dc77f3fb436b5cd61105b20829aadf132246fdc0e2437b4695ca329c454f1922e1a97b564bfb24e788d852"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 09:24:53.792504) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:24:53.792815) ========= 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=62c568580acbfdaac3eec7be000001dc-1462549906.900655-878458218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 09:24:53.878927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:24:53.879367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 09:24:53.879672) ========= ========= Total master_lag: 0.20 =========