builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1462876133.7 results: success (0) buildid: 20160510024009 builduid: 03b897821c6b4ffca2dba3e961ddb355 revision: e4260b4769a02960afa8ffe89cf1824fa0580a30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.698188) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.698605) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.698892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.725290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.725625) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 03:28:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-05-10 03:28:54 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.897808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.898254) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013898 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.949537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:53.949897) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4260b4769a02960afa8ffe89cf1824fa0580a30 --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 e4260b4769a02960afa8ffe89cf1824fa0580a30 --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=2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 03:28:54,119 truncating revision to first 12 chars 2016-05-10 03:28:54,119 Setting DEBUG logging. 2016-05-10 03:28:54,119 attempt 1/10 2016-05-10 03:28:54,119 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4260b4769a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 03:28:54,389 unpacking tar archive at: fx-team-e4260b4769a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.581440 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:54.546277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:54.546578) ========= script_repo_revision: e4260b4769a02960afa8ffe89cf1824fa0580a30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:54.546969) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:54.547230) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 03:28:54.559854) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-10 03:28:54.560149) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:54 INFO - MultiFileLogger online at 20160510 03:28:54 in /builds/slave/test 03:28:54 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 03:28:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:54 INFO - {'append_to_log': False, 03:28:54 INFO - 'base_work_dir': '/builds/slave/test', 03:28:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:28:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:54 INFO - 'branch': 'Fx-Team-Non-PGO', 03:28:54 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:54 INFO - 'config_files': ('talos/linux_config.py',), 03:28:54 INFO - 'default_actions': ('clobber', 03:28:54 INFO - 'read-buildbot-config', 03:28:54 INFO - 'download-and-extract', 03:28:54 INFO - 'populate-webroot', 03:28:54 INFO - 'create-virtualenv', 03:28:54 INFO - 'install', 03:28:54 INFO - 'run-tests'), 03:28:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:54 INFO - 'download_minidump_stackwalk': True, 03:28:54 INFO - 'download_symbols': 'ondemand', 03:28:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:54 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:54 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:54 INFO - 'installer_path': 'installer.exe', 03:28:54 INFO - 'log_level': 'info', 03:28:54 INFO - 'log_name': 'talos', 03:28:54 INFO - 'log_to_console': True, 03:28:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:54 INFO - 'opt_config_files': (), 03:28:54 INFO - 'pip_index': False, 03:28:54 INFO - 'sps_profile': False, 03:28:54 INFO - 'sps_profile_interval': 0, 03:28:54 INFO - 'suite': 'dromaeojs', 03:28:54 INFO - 'system_bits': '32', 03:28:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:54 INFO - 'title': 'talos-linux64-ix-012', 03:28:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:54 INFO - 'use_talos_json': True, 03:28:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:54 INFO - 'work_dir': 'build'} 03:28:54 INFO - ##### 03:28:54 INFO - ##### Running clobber step. 03:28:54 INFO - ##### 03:28:54 INFO - Running pre-action listener: _resource_record_pre_action 03:28:54 INFO - Running main action method: clobber 03:28:54 INFO - rmtree: /builds/slave/test/build 03:28:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:55 INFO - Running post-action listener: _resource_record_post_action 03:28:55 INFO - ##### 03:28:55 INFO - ##### Finished clobber step (success) 03:28:55 INFO - ##### 03:28:55 INFO - ##### 03:28:55 INFO - ##### Running read-buildbot-config step. 03:28:55 INFO - ##### 03:28:55 INFO - Running pre-action listener: _resource_record_pre_action 03:28:55 INFO - Running main action method: read_buildbot_config 03:28:55 INFO - Using buildbot properties: 03:28:55 INFO - { 03:28:55 INFO - "project": "", 03:28:55 INFO - "product": "firefox", 03:28:55 INFO - "script_repo_revision": "production", 03:28:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:28:55 INFO - "repository": "", 03:28:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:28:55 INFO - "buildid": "20160510024009", 03:28:55 INFO - "pgo_build": "False", 03:28:55 INFO - "basedir": "/builds/slave/test", 03:28:55 INFO - "buildnumber": 2947, 03:28:55 INFO - "slavename": "talos-linux64-ix-012", 03:28:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:28:55 INFO - "platform": "ubuntu64_hw", 03:28:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:28:55 INFO - "branch": "fx-team", 03:28:55 INFO - "repo_path": "integration/fx-team", 03:28:55 INFO - "revision": "e4260b4769a02960afa8ffe89cf1824fa0580a30", 03:28:55 INFO - "stage_platform": "linux64", 03:28:55 INFO - "builduid": "03b897821c6b4ffca2dba3e961ddb355", 03:28:55 INFO - "slavebuilddir": "test" 03:28:55 INFO - } 03:28:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:28:55 INFO - Running post-action listener: _resource_record_post_action 03:28:55 INFO - ##### 03:28:55 INFO - ##### Finished read-buildbot-config step (success) 03:28:55 INFO - ##### 03:28:55 INFO - ##### 03:28:55 INFO - ##### Running download-and-extract step. 03:28:55 INFO - ##### 03:28:55 INFO - Running pre-action listener: _resource_record_pre_action 03:28:55 INFO - Running main action method: download_and_extract 03:28:55 INFO - mkdir: /builds/slave/test/build/tests 03:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:55 INFO - https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:28:56 INFO - Downloaded 1361 bytes. 03:28:56 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:28:56 INFO - Using the following test package requirements: 03:28:56 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:56 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:28:56 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:28:56 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'jsshell-linux-x86_64.zip'], 03:28:56 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:28:56 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:28:56 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:28:56 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:28:56 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:28:56 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:28:56 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:28:56 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:28:56 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')]} 03:28:56 INFO - https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:28:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:28:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:28:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:28:57 INFO - Downloaded 22322863 bytes. 03:28:57 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'] 03:28:57 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 03:28:58 INFO - Return code: 0 03:28:58 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 03:28:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:28:58 INFO - https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:28:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:28:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:28:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:29:00 INFO - Downloaded 22322863 bytes. 03:29:00 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'] 03:29:00 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 03:29:01 INFO - Return code: 0 03:29:01 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')]} 03:29:01 INFO - https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:29:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:29:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:29:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:29:02 INFO - Downloaded 10840152 bytes. 03:29:02 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'] 03:29:02 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 03:29:02 INFO - Return code: 0 03:29: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')]} 03:29:02 INFO - https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TLhL812eR1eLkzlzkgxzHQ/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 03:29:06 INFO - Downloaded 54860782 bytes. 03:29:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:29:06 INFO - mkdir: /builds/slave/test/properties 03:29:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:06 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:06 INFO - Contents: 03:29:06 INFO - build_url:https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:29:06 INFO - Running post-action listener: _resource_record_post_action 03:29:06 INFO - Running post-action listener: set_extra_try_arguments 03:29:06 INFO - ##### 03:29:06 INFO - ##### Finished download-and-extract step (success) 03:29:06 INFO - ##### 03:29:06 INFO - ##### 03:29:06 INFO - ##### Running populate-webroot step. 03:29:06 INFO - ##### 03:29:06 INFO - Running pre-action listener: _resource_record_pre_action 03:29:06 INFO - Running main action method: populate_webroot 03:29:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:29:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:29:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:29:06 INFO - '--tppagecycles', 03:29:06 INFO - '7'], 03:29:06 INFO - 'tests': ['tsvgm']}}, 03:29:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:29:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:29:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['damp', 'tps']}, 03:29:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'tests': ['damp', 'tps']}, 03:29:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['dromaeo_dom']}, 03:29:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['a11yr', 03:29:06 INFO - 'ts_paint', 03:29:06 INFO - 'tpaint', 03:29:06 INFO - 'sessionrestore', 03:29:06 INFO - 'sessionrestore_no_auto_restore', 03:29:06 INFO - 'tabpaint']}, 03:29:06 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:06 INFO - 'ts_paint', 03:29:06 INFO - 'tpaint', 03:29:06 INFO - 'sessionrestore', 03:29:06 INFO - 'sessionrestore_no_auto_restore', 03:29:06 INFO - 'tabpaint']}, 03:29:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:29:06 INFO - 'ts_paint', 03:29:06 INFO - 'tpaint', 03:29:06 INFO - 'sessionrestore', 03:29:06 INFO - 'sessionrestore_no_auto_restore', 03:29:06 INFO - 'tabpaint']}, 03:29:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:29:06 INFO - 'ts_paint', 03:29:06 INFO - 'tpaint', 03:29:06 INFO - 'sessionrestore', 03:29:06 INFO - 'sessionrestore_no_auto_restore', 03:29:06 INFO - 'tabpaint']}, 03:29:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['a11yr', 03:29:06 INFO - 'ts_paint', 03:29:06 INFO - 'tpaint', 03:29:06 INFO - 'sessionrestore', 03:29:06 INFO - 'sessionrestore_no_auto_restore', 03:29:06 INFO - 'tabpaint']}, 03:29:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['a11yr', 03:29:06 INFO - 'ts_paint', 03:29:06 INFO - 'tpaint', 03:29:06 INFO - 'sessionrestore', 03:29:06 INFO - 'sessionrestore_no_auto_restore', 03:29:06 INFO - 'tabpaint']}, 03:29:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['tsvgx', 03:29:06 INFO - 'tsvgr_opacity', 03:29:06 INFO - 'tart', 03:29:06 INFO - 'tscrollx', 03:29:06 INFO - 'cart']}, 03:29:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:06 INFO - 'tsvgr_opacity', 03:29:06 INFO - 'tart', 03:29:06 INFO - 'tscrollx', 03:29:06 INFO - 'cart']}, 03:29:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'talos_options': ['--disable-e10s'], 03:29:06 INFO - 'tests': ['tp5o']}, 03:29:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'tests': ['tp5o']}, 03:29:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'talos_options': ['--disable-e10s', 03:29:06 INFO - '--xperf_path', 03:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:06 INFO - 'tests': ['tp5n']}, 03:29:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:29:06 INFO - 'talos_options': ['--xperf_path', 03:29:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:06 INFO - 'tests': ['tp5n']}}, 03:29:06 INFO - 'talos.zip': {'path': '', 03:29:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:29:06 INFO - Running post-action listener: _resource_record_post_action 03:29:06 INFO - ##### 03:29:06 INFO - ##### Finished populate-webroot step (success) 03:29:06 INFO - ##### 03:29:06 INFO - ##### 03:29:06 INFO - ##### Running create-virtualenv step. 03:29:06 INFO - ##### 03:29:06 INFO - Running pre-action listener: _resource_record_pre_action 03:29:06 INFO - Running main action method: create_virtualenv 03:29:06 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:06 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 03:29:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:07 INFO - Using real prefix '/usr' 03:29:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:09 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:11 INFO - Installing pip.................done. 03:29:11 INFO - Return code: 0 03:29:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:11 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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:11 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 03:29:11 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 03:29:11 INFO - Using env: {'DISPLAY': ':0', 03:29:11 INFO - 'HOME': '/home/cltbld', 03:29:11 INFO - 'LANG': 'en_US.UTF-8', 03:29:11 INFO - 'LANGUAGE': 'en_US:en', 03:29:11 INFO - 'LOGNAME': 'cltbld', 03:29:11 INFO - 'MAIL': '/var/mail/cltbld', 03:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:11 INFO - 'MOZ_NO_REMOTE': '1', 03:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:11 INFO - 'NO_EM_RESTART': '1', 03:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:11 INFO - 'PWD': '/builds/slave/test', 03:29:11 INFO - 'SHELL': '/bin/bash', 03:29:11 INFO - 'SHLVL': '1', 03:29:11 INFO - 'TERM': 'linux', 03:29:11 INFO - 'TMOUT': '86400', 03:29:11 INFO - 'USER': 'cltbld', 03:29:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:11 INFO - '_': '/tools/buildbot/bin/python'} 03:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:11 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 03:29:11 INFO - Cleaning up... 03:29:11 INFO - Return code: 0 03:29:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:11 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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:11 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 03:29:11 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 03:29:11 INFO - Using env: {'DISPLAY': ':0', 03:29:11 INFO - 'HOME': '/home/cltbld', 03:29:11 INFO - 'LANG': 'en_US.UTF-8', 03:29:11 INFO - 'LANGUAGE': 'en_US:en', 03:29:11 INFO - 'LOGNAME': 'cltbld', 03:29:11 INFO - 'MAIL': '/var/mail/cltbld', 03:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:11 INFO - 'MOZ_NO_REMOTE': '1', 03:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:11 INFO - 'NO_EM_RESTART': '1', 03:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:11 INFO - 'PWD': '/builds/slave/test', 03:29:11 INFO - 'SHELL': '/bin/bash', 03:29:11 INFO - 'SHLVL': '1', 03:29:11 INFO - 'TERM': 'linux', 03:29:11 INFO - 'TMOUT': '86400', 03:29:11 INFO - 'USER': 'cltbld', 03:29:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:11 INFO - '_': '/tools/buildbot/bin/python'} 03:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:11 INFO - Downloading/unpacking psutil>=0.7.1 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:13 INFO - Installing collected packages: psutil 03:29:13 INFO - Running setup.py install for psutil 03:29:13 INFO - building 'psutil._psutil_linux' extension 03:29:13 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 03:29:14 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 03:29:14 INFO - building 'psutil._psutil_posix' extension 03:29:14 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 03:29:14 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 03:29:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:14 INFO - Successfully installed psutil 03:29:14 INFO - Cleaning up... 03:29:15 INFO - Return code: 0 03:29:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:29:15 INFO - Using env: {'DISPLAY': ':0', 03:29:15 INFO - 'HOME': '/home/cltbld', 03:29:15 INFO - 'LANG': 'en_US.UTF-8', 03:29:15 INFO - 'LANGUAGE': 'en_US:en', 03:29:15 INFO - 'LOGNAME': 'cltbld', 03:29:15 INFO - 'MAIL': '/var/mail/cltbld', 03:29:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:15 INFO - 'MOZ_NO_REMOTE': '1', 03:29:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:15 INFO - 'NO_EM_RESTART': '1', 03:29:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:15 INFO - 'PWD': '/builds/slave/test', 03:29:15 INFO - 'SHELL': '/bin/bash', 03:29:15 INFO - 'SHLVL': '1', 03:29:15 INFO - 'TERM': 'linux', 03:29:15 INFO - 'TMOUT': '86400', 03:29:15 INFO - 'USER': 'cltbld', 03:29:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:15 INFO - '_': '/tools/buildbot/bin/python'} 03:29:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:29:17 INFO - Installing collected packages: mozsystemmonitor 03:29:17 INFO - Running setup.py install for mozsystemmonitor 03:29:17 INFO - Successfully installed mozsystemmonitor 03:29:17 INFO - Cleaning up... 03:29:17 INFO - Return code: 0 03:29:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:17 INFO - Using env: {'DISPLAY': ':0', 03:29:17 INFO - 'HOME': '/home/cltbld', 03:29:17 INFO - 'LANG': 'en_US.UTF-8', 03:29:17 INFO - 'LANGUAGE': 'en_US:en', 03:29:17 INFO - 'LOGNAME': 'cltbld', 03:29:17 INFO - 'MAIL': '/var/mail/cltbld', 03:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:17 INFO - 'MOZ_NO_REMOTE': '1', 03:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:17 INFO - 'NO_EM_RESTART': '1', 03:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:17 INFO - 'PWD': '/builds/slave/test', 03:29:17 INFO - 'SHELL': '/bin/bash', 03:29:17 INFO - 'SHLVL': '1', 03:29:17 INFO - 'TERM': 'linux', 03:29:17 INFO - 'TMOUT': '86400', 03:29:17 INFO - 'USER': 'cltbld', 03:29:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:17 INFO - '_': '/tools/buildbot/bin/python'} 03:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:19 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 03:29:19 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 03:29:19 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 03:29:19 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 03:29:19 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 03:29:19 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 03:29:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:19 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 03:29:19 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 03:29:19 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 03:29:19 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 03:29:19 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 03:29:19 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 03:29:20 INFO - Downloading docopt-0.6.1.tar.gz 03:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:20 INFO - Running setup.py install for blobuploader 03:29:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:20 INFO - Running setup.py install for requests 03:29:20 INFO - Running setup.py install for docopt 03:29:20 INFO - Successfully installed blobuploader requests docopt 03:29:20 INFO - Cleaning up... 03:29:20 INFO - Return code: 0 03:29:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:20 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')]} 03:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:20 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')]} 03:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:20 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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:20 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 03:29:20 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 03:29:20 INFO - Using env: {'DISPLAY': ':0', 03:29:20 INFO - 'HOME': '/home/cltbld', 03:29:20 INFO - 'LANG': 'en_US.UTF-8', 03:29:20 INFO - 'LANGUAGE': 'en_US:en', 03:29:20 INFO - 'LOGNAME': 'cltbld', 03:29:20 INFO - 'MAIL': '/var/mail/cltbld', 03:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:20 INFO - 'MOZ_NO_REMOTE': '1', 03:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:20 INFO - 'NO_EM_RESTART': '1', 03:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:20 INFO - 'PWD': '/builds/slave/test', 03:29:20 INFO - 'SHELL': '/bin/bash', 03:29:20 INFO - 'SHLVL': '1', 03:29:20 INFO - 'TERM': 'linux', 03:29:20 INFO - 'TMOUT': '86400', 03:29:20 INFO - 'USER': 'cltbld', 03:29:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:20 INFO - '_': '/tools/buildbot/bin/python'} 03:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:21 INFO - Running setup.py (path:/tmp/pip-JBR8Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:21 INFO - Running setup.py (path:/tmp/pip-pxYhvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:21 INFO - Running setup.py (path:/tmp/pip-Q5uJKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:21 INFO - Running setup.py (path:/tmp/pip-UWWNfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:21 INFO - Running setup.py (path:/tmp/pip-mwo7kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:21 INFO - Running setup.py (path:/tmp/pip-qw0Yfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:21 INFO - Running setup.py (path:/tmp/pip-AIRSpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:21 INFO - Running setup.py (path:/tmp/pip-btJRbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:21 INFO - Running setup.py (path:/tmp/pip-oWSMIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:21 INFO - Running setup.py (path:/tmp/pip-jYxFfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:21 INFO - Running setup.py (path:/tmp/pip-rFDHpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:21 INFO - Running setup.py (path:/tmp/pip-UO6nXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:21 INFO - Running setup.py (path:/tmp/pip-AEXDeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:21 INFO - Running setup.py (path:/tmp/pip-A0qXHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:22 INFO - Running setup.py (path:/tmp/pip-0nElLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:22 INFO - Running setup.py (path:/tmp/pip-j3fE3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:22 INFO - Running setup.py (path:/tmp/pip-Eavljy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:22 INFO - Running setup.py install for manifestparser 03:29:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:22 INFO - Running setup.py install for mozcrash 03:29:22 INFO - Running setup.py install for mozdebug 03:29:22 INFO - Running setup.py install for mozdevice 03:29:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:29:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:22 INFO - Running setup.py install for mozfile 03:29:22 INFO - Running setup.py install for mozhttpd 03:29:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:22 INFO - Running setup.py install for mozinfo 03:29:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:22 INFO - Running setup.py install for mozInstall 03:29:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Running setup.py install for mozleak 03:29:23 INFO - Running setup.py install for mozlog 03:29:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Running setup.py install for moznetwork 03:29:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Running setup.py install for mozprocess 03:29:23 INFO - Running setup.py install for mozprofile 03:29:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Running setup.py install for mozrunner 03:29:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:23 INFO - Running setup.py install for mozscreenshot 03:29:23 INFO - Running setup.py install for moztest 03:29:23 INFO - Running setup.py install for mozversion 03:29:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:24 INFO - Cleaning up... 03:29:24 INFO - Return code: 0 03:29:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:24 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')]} 03:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:24 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')]} 03:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:24 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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:24 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 03:29:24 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 03:29:24 INFO - Using env: {'DISPLAY': ':0', 03:29:24 INFO - 'HOME': '/home/cltbld', 03:29:24 INFO - 'LANG': 'en_US.UTF-8', 03:29:24 INFO - 'LANGUAGE': 'en_US:en', 03:29:24 INFO - 'LOGNAME': 'cltbld', 03:29:24 INFO - 'MAIL': '/var/mail/cltbld', 03:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:24 INFO - 'MOZ_NO_REMOTE': '1', 03:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:24 INFO - 'NO_EM_RESTART': '1', 03:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:24 INFO - 'PWD': '/builds/slave/test', 03:29:24 INFO - 'SHELL': '/bin/bash', 03:29:24 INFO - 'SHLVL': '1', 03:29:24 INFO - 'TERM': 'linux', 03:29:24 INFO - 'TMOUT': '86400', 03:29:24 INFO - 'USER': 'cltbld', 03:29:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:24 INFO - '_': '/tools/buildbot/bin/python'} 03:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:24 INFO - Running setup.py (path:/tmp/pip-XJCt19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:24 INFO - Running setup.py (path:/tmp/pip-CDpONo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:24 INFO - Running setup.py (path:/tmp/pip-f3RKHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:24 INFO - Running setup.py (path:/tmp/pip-gFahd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:24 INFO - Running setup.py (path:/tmp/pip-u_Gz5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:24 INFO - Running setup.py (path:/tmp/pip-pGNiIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:24 INFO - Running setup.py (path:/tmp/pip-bu3vP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:24 INFO - Running setup.py (path:/tmp/pip-3b0IQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:24 INFO - Running setup.py (path:/tmp/pip-BQGqK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:24 INFO - Running setup.py (path:/tmp/pip-EqQ2KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:24 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)) 03:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:24 INFO - Running setup.py (path:/tmp/pip-d9AyzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:25 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)) 03:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:25 INFO - Running setup.py (path:/tmp/pip-STM2fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:25 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)) 03:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:25 INFO - Running setup.py (path:/tmp/pip-M32H75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:25 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)) 03:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:25 INFO - Running setup.py (path:/tmp/pip-vJ2Ous-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:25 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)) 03:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:25 INFO - Running setup.py (path:/tmp/pip-yJJBPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:25 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)) 03:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:25 INFO - Running setup.py (path:/tmp/pip-V6awCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:25 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)) 03:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:25 INFO - Running setup.py (path:/tmp/pip-7NL66J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:25 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)) 03:29:25 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)) 03:29:25 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)) 03:29:25 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)) 03:29:25 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)) 03:29:25 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)) 03:29:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:25 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 03:29:25 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 03:29:25 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 03:29:25 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 03:29:25 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 03:29:25 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 03:29:27 INFO - Downloading blessings-1.6.tar.gz 03:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:27 INFO - Installing collected packages: blessings 03:29:27 INFO - Running setup.py install for blessings 03:29:27 INFO - Successfully installed blessings 03:29:27 INFO - Cleaning up... 03:29:27 INFO - Return code: 0 03:29:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:27 INFO - Reading from file tmpfile_stdout 03:29:27 INFO - Current package versions: 03:29:27 INFO - argparse == 1.2.1 03:29:27 INFO - blessings == 1.6 03:29:27 INFO - blobuploader == 1.2.4 03:29:27 INFO - docopt == 0.6.1 03:29:27 INFO - manifestparser == 1.1 03:29:27 INFO - mozInstall == 1.12 03:29:27 INFO - mozcrash == 0.17 03:29:27 INFO - mozdebug == 0.1 03:29:27 INFO - mozdevice == 0.48 03:29:27 INFO - mozfile == 1.2 03:29:27 INFO - mozhttpd == 0.7 03:29:27 INFO - mozinfo == 0.9 03:29:27 INFO - mozleak == 0.1 03:29:27 INFO - mozlog == 3.1 03:29:27 INFO - moznetwork == 0.27 03:29:27 INFO - mozprocess == 0.22 03:29:27 INFO - mozprofile == 0.28 03:29:27 INFO - mozrunner == 6.11 03:29:27 INFO - mozscreenshot == 0.1 03:29:27 INFO - mozsystemmonitor == 0.0 03:29:27 INFO - moztest == 0.7 03:29:27 INFO - mozversion == 1.4 03:29:27 INFO - psutil == 3.1.1 03:29:27 INFO - requests == 1.2.3 03:29:27 INFO - wsgiref == 0.1.2 03:29:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:27 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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:27 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 03:29:27 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 03:29:27 INFO - Using env: {'DISPLAY': ':0', 03:29:27 INFO - 'HOME': '/home/cltbld', 03:29:27 INFO - 'LANG': 'en_US.UTF-8', 03:29:27 INFO - 'LANGUAGE': 'en_US:en', 03:29:27 INFO - 'LOGNAME': 'cltbld', 03:29:27 INFO - 'MAIL': '/var/mail/cltbld', 03:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:27 INFO - 'MOZ_NO_REMOTE': '1', 03:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:27 INFO - 'NO_EM_RESTART': '1', 03:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:27 INFO - 'PWD': '/builds/slave/test', 03:29:27 INFO - 'SHELL': '/bin/bash', 03:29:27 INFO - 'SHLVL': '1', 03:29:27 INFO - 'TERM': 'linux', 03:29:27 INFO - 'TMOUT': '86400', 03:29:27 INFO - 'USER': 'cltbld', 03:29:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:27 INFO - '_': '/tools/buildbot/bin/python'} 03:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 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)) 03:29:28 INFO - Cleaning up... 03:29:28 INFO - Return code: 0 03:29:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:28 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')]} 03:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:28 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')]} 03:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29:28 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 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29:28 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 03:29:28 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 03:29:28 INFO - Using env: {'DISPLAY': ':0', 03:29:28 INFO - 'HOME': '/home/cltbld', 03:29:28 INFO - 'LANG': 'en_US.UTF-8', 03:29:28 INFO - 'LANGUAGE': 'en_US:en', 03:29:28 INFO - 'LOGNAME': 'cltbld', 03:29:28 INFO - 'MAIL': '/var/mail/cltbld', 03:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:28 INFO - 'MOZ_NO_REMOTE': '1', 03:29:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:28 INFO - 'NO_EM_RESTART': '1', 03:29:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:28 INFO - 'PWD': '/builds/slave/test', 03:29:28 INFO - 'SHELL': '/bin/bash', 03:29:28 INFO - 'SHLVL': '1', 03:29:28 INFO - 'TERM': 'linux', 03:29:28 INFO - 'TMOUT': '86400', 03:29:28 INFO - 'USER': 'cltbld', 03:29:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:28 INFO - '_': '/tools/buildbot/bin/python'} 03:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:28 INFO - Downloading/unpacking jsonschema 03:29:28 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 03:29:28 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 03:29:28 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 03:29:28 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 03:29:28 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 03:29:28 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 03:29:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:30 INFO - Downloading/unpacking functools32 (from jsonschema) 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:30 INFO - warning: no files found matching '*.txt' 03:29:30 INFO - no previously-included directories found matching 'build' 03:29:30 INFO - no previously-included directories found matching 'dist' 03:29:30 INFO - no previously-included directories found matching '.git*' 03:29:30 INFO - Installing collected packages: jsonschema, functools32 03:29:30 INFO - Running setup.py install for functools32 03:29:30 INFO - warning: no files found matching '*.txt' 03:29:30 INFO - no previously-included directories found matching 'build' 03:29:30 INFO - no previously-included directories found matching 'dist' 03:29:30 INFO - no previously-included directories found matching '.git*' 03:29:30 INFO - Successfully installed jsonschema functools32 03:29:30 INFO - Cleaning up... 03:29:30 INFO - Return code: 0 03:29:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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')]} 03:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:29: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4ed847f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254c8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', '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 03:29: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', 'flake8'] in /builds/slave/test/build 03:29: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 flake8 03:29:30 INFO - Using env: {'DISPLAY': ':0', 03:29:30 INFO - 'HOME': '/home/cltbld', 03:29:30 INFO - 'LANG': 'en_US.UTF-8', 03:29:30 INFO - 'LANGUAGE': 'en_US:en', 03:29:30 INFO - 'LOGNAME': 'cltbld', 03:29:30 INFO - 'MAIL': '/var/mail/cltbld', 03:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:30 INFO - 'MOZ_NO_REMOTE': '1', 03:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:30 INFO - 'NO_EM_RESTART': '1', 03:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:30 INFO - 'PWD': '/builds/slave/test', 03:29:30 INFO - 'SHELL': '/bin/bash', 03:29:30 INFO - 'SHLVL': '1', 03:29:30 INFO - 'TERM': 'linux', 03:29:30 INFO - 'TMOUT': '86400', 03:29:30 INFO - 'USER': 'cltbld', 03:29:30 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:30 INFO - '_': '/tools/buildbot/bin/python'} 03:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:30 INFO - Downloading/unpacking flake8 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:29:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:29:32 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 03:29:32 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 03:29:32 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 03:29:32 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 03:29:32 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 03:29:32 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 03:29:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:29:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29: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 03:29:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:29:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:33 INFO - no previously-included directories found matching 'docs/_build' 03:29:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:29:33 INFO - Running setup.py install for pep8 03:29:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:29:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:29:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:29:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:29:33 INFO - no previously-included directories found matching 'docs/_build' 03:29:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:29:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:29:33 INFO - Cleaning up... 03:29:33 INFO - Return code: 0 03:29:33 INFO - Running post-action listener: _resource_record_post_action 03:29:33 INFO - Running post-action listener: _start_resource_monitoring 03:29:33 INFO - Starting resource monitoring. 03:29:33 INFO - ##### 03:29:33 INFO - ##### Finished create-virtualenv step (success) 03:29:33 INFO - ##### 03:29:33 INFO - ##### 03:29:33 INFO - ##### Running install step. 03:29:33 INFO - ##### 03:29:33 INFO - Running pre-action listener: _resource_record_pre_action 03:29:33 INFO - Running main action method: install 03:29:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:34 INFO - Reading from file tmpfile_stdout 03:29:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:34 INFO - Reading from file tmpfile_stdout 03:29:34 INFO - Output received: 03:29:34 INFO - Usage: mozinstall [options] installer 03:29:34 INFO - Options: 03:29:34 INFO - -h, --help show this help message and exit 03:29:34 INFO - -d DEST, --destination=DEST 03:29:34 INFO - Directory to install application into. [default: 03:29:34 INFO - "/builds/slave/test"] 03:29:34 INFO - --app=APP Application being installed. [default: firefox] 03:29:34 INFO - mkdir: /builds/slave/test/build/application 03:29:34 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'] 03:29:34 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 03:29:49 INFO - Reading from file tmpfile_stdout 03:29:49 INFO - Output received: 03:29:49 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:49 INFO - Running post-action listener: _resource_record_post_action 03:29:49 INFO - ##### 03:29:49 INFO - ##### Finished install step (success) 03:29:49 INFO - ##### 03:29:49 INFO - ##### 03:29:49 INFO - ##### Running run-tests step. 03:29:49 INFO - ##### 03:29:49 INFO - Running pre-action listener: _resource_record_pre_action 03:29:49 INFO - Running main action method: run_tests 03:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:49 INFO - Python 2.7.3 03:29:49 INFO - Return code: 0 03:29:49 INFO - grabbing minidump binary from tooltool 03:29:49 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')]} 03:29:49 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 0x25dbb20>, '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 0x25dca20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25dceb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:49 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 03:29:49 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 03:29:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:49 INFO - Return code: 0 03:29:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:29:50 INFO - Return code: 0 03:29:50 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/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:29:50 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/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 03:29:50 INFO - Using env: {'DISPLAY': ':0', 03:29:50 INFO - 'HOME': '/home/cltbld', 03:29:50 INFO - 'LANG': 'en_US.UTF-8', 03:29:50 INFO - 'LANGUAGE': 'en_US:en', 03:29:50 INFO - 'LOGNAME': 'cltbld', 03:29:50 INFO - 'MAIL': '/var/mail/cltbld', 03:29:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:50 INFO - 'MOZ_NO_REMOTE': '1', 03:29:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:50 INFO - 'NO_EM_RESTART': '1', 03:29:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:50 INFO - 'PWD': '/builds/slave/test', 03:29:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:50 INFO - 'SHELL': '/bin/bash', 03:29:50 INFO - 'SHLVL': '1', 03:29:50 INFO - 'TERM': 'linux', 03:29:50 INFO - 'TMOUT': '86400', 03:29:50 INFO - 'USER': 'cltbld', 03:29:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453', 03:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:50 INFO - '_': '/tools/buildbot/bin/python'} 03:29:50 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/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:29:51 INFO - mozversion application_buildid: 20160510024009 03:29:51 INFO - mozversion application_changeset: e4260b4769a02960afa8ffe89cf1824fa0580a30 03:29:51 INFO - mozversion application_display_name: Nightly 03:29:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:51 INFO - mozversion application_name: Firefox 03:29:51 INFO - mozversion application_remotingname: firefox 03:29:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:29:51 INFO - mozversion application_vendor: Mozilla 03:29:51 INFO - mozversion application_version: 49.0a1 03:29:51 INFO - mozversion platform_buildid: 20160510024009 03:29:51 INFO - mozversion platform_changeset: e4260b4769a02960afa8ffe89cf1824fa0580a30 03:29:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:29:51 INFO - mozversion platform_version: 49.0a1 03:29:51 INFO - using testdate: 1462876191 03:29:51 INFO - actual date: 1462876191 03:29:51 INFO - starting webserver on 'localhost:43283' 03:29:51 INFO - SUITE-START | Running 2 tests 03:29:51 INFO - TEST-START | dromaeo_css 03:29:51 INFO - operating with platform_type : linux_ 03:29:51 INFO - Initialising browser for dromaeo_css test... 03:29:51 INFO - TEST-INFO | started process 3275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPjJdy8/profile http://localhost:43283/getInfo.html) 03:29:56 INFO - PROCESS | 3275 | __metrics Screen width/height:1600/1200 03:29:56 INFO - PROCESS | 3275 | colorDepth:24 03:29:56 INFO - PROCESS | 3275 | Browser inner width/height: 1024/697 03:29:56 INFO - PROCESS | 3275 | __metrics 03:29:56 ERROR - PROCESS | 3275 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:29:57 INFO - TEST-INFO | 3275: exit 0 03:29:57 INFO - Browser initialized. 03:29:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:57 INFO - TEST-INFO | started process 3354 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPjJdy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:09 INFO - PROCESS | 3354 | RSS: Main: 153681920 03:30:09 INFO - PROCESS | 3354 | 03:31:01 INFO - PROCESS | 3354 | 1462876261301 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] 03:33:13 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43283/tests/dromaeo/cssquery-ext.html) 03:33:14 INFO - PROCESS | 3354 | RSS: Main: 268189696 03:33:14 INFO - PROCESS | 3354 | 03:36:17 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43283/tests/dromaeo/cssquery-ext.html (next: http://localhost:43283/tests/dromaeo/cssquery-jquery.html) 03:36:17 INFO - PROCESS | 3354 | RSS: Main: 235913216 03:36:17 INFO - PROCESS | 3354 | 03:39:19 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43283/tests/dromaeo/cssquery-mootools.html) 03:39:20 INFO - PROCESS | 3354 | RSS: Main: 233967616 03:39:20 INFO - PROCESS | 3354 | 03:42:22 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43283/tests/dromaeo/cssquery-prototype.html) 03:42:23 INFO - PROCESS | 3354 | RSS: Main: 230469632 03:42:23 INFO - PROCESS | 3354 | 03:45:26 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43283/tests/dromaeo/cssquery-yui.html) 03:45:26 INFO - PROCESS | 3354 | RSS: Main: 211783680 03:45:26 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | Cycle 1(1): loaded http://localhost:43283/tests/dromaeo/cssquery-yui.html (next: http://localhost:43283/tests/dromaeo/cssquery-dojo.html) 03:48:29 INFO - PROCESS | 3354 | RSS: Main: 275640320 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | __start_tp_report 03:48:29 INFO - PROCESS | 3354 | _x_x_mozilla_page_load 03:48:29 INFO - PROCESS | 3354 | _x_x_mozilla_page_load_details 03:48:29 INFO - PROCESS | 3354 | |i|pagename|runs| 03:48:29 INFO - PROCESS | 3354 | |0;dojo.html;2645.907393241236;2657.136430660036;2681.1956413076073;2695.6899956504985;2707.67507899052;4561.270196768518;4625.791839367228;4633.443986721594;4709.2936059591075;4730.668853180275;4595.3107033944925;4627.8380256691025;4640.767961601915;4704.553067458594;4790.185668436366;4231.851885184019;4293.742375457467;4309.224339618867;4363.694541382112;4423.690341676084;4325.675574331937;4383.232934236512;4425.09285596452;4455.665825063117;4467.821287148527;4202;4364.781760911942;4394.8901277468;4402.889927751799;4424.823007079729;4226;4270.572942705705;4274.187904298205;4281.357796330544;4368.956310436918;4278.165757677254;4294.119705460374;4310.137972405531;4337.132573485315;4343.087951530182;4602.723836569783;4629.86110416688;4642.164410406125;4643.396358473411;4645.233536466479;4826.01066781309;5040.521150490697;5094.566961808214;5111.974440127776;5172.146595811687;5131.281620573122;5141.126008578551;5171.7672704728375;5182.041322355376;5193.766280517348;4549.886252843706;4849.660523763373;4849.684770489906;4864.221724524059;4867.34290870735;5165.535101840777;5207.6875387476875;5228.451012643618;5287.154055351202;5313.814016509404;5023.447420783711;5053.9241911371355;5081.491850814963;5082.33929589151;5087.898242035212;4921.9507804922205;4941.332920055818;4968.254761785761;4972.154733695208;4999.275105109738;4990.126727822617;5028.396592408934;5044.722540260321;5051.671641343374;5086.338775959176;5011.248312753043;5016.974915125401;5018.749062546931;5029.572486338702;5065.924011139762;4164.9583504165175;4198.9370159447635;4239.830406783756;4305.117450922553;4382.890427739332;3712.1090938175184;3734.9439758403646;3740.0649837540614;3780.0360907968843;3806.885793426202;4214.388913607571;4214.768187749703;4224.87325380233;4262.87211383659;4263.850765223202;4895.755212239374;4977.9751101244265;5019.397672279277;5034.270030845581;5046.545810876965;4293.248681480728;4324.762138082373;4326.697131200849;4359.564043595615;4361.978190109093;4586.151561960981;4597.333386658983;4598.057398233354;4600.401947746838;4645.837395691135;4647.024124933801;4791.952080479151;4793.664443488922;4827.493113223201;4844.079624871263;5084.2627818966785;5094.847154585368;5100.2349647553165;5100.6429549931145;5152.433232344364;4771.785269662943;4804.06320767447;4805;4807.134715751198;4840.394950631171;4784.4497882742535;4903.803847846046;4963.751812409293;4974.9751251243515;5031.069252188357;5026.874328141826;5056.367954005749;5064.189729643387;5066.03745288394;5108.61685373591;4894.412670479565;4913.459519452786;4926.852194434029;4929.088118697909;4942.629302802232;4765.166095933128;4942.851714448572;4972.3038774572315;4992.80028798844;4993.500649934977;4928.310036594808;4933.235348520985;4939.308496810378;4978.975105124451;4986.202207646904;4793.49668284839;5033.270175824412;5037.924431133462;5051.898962020812;5087.720175390389;4773.66584339093;4776.450708168605;4783.976080119577;4784.976075119741;4795.880102997453 03:48:29 INFO - PROCESS | 3354 | |1;ext.html;567.1492760858712;597.8027251007168;600.5285850607271;604.8397174748691;614.5083932853718;26959.326016849565;42429.78785106074;43092.78453607736;43134.56865431349;43183.56816431835;43402.782986085105;43990;44028.3395749064;44054.55945440545;44101.33847992275;7522.623868806565;7804.726834560805;7960.761177164694;10034.799304013915;10234.692959211236;10017.799644007115;10117.544710488046;10124.443155626437;10131.392116472998;10132.594696212143;10079.596816127347;10098.646547370843;10100;10102.141317987944;10140.746481337988;7546.509476884013;9909.058639429279;10080.798384032278;10084.596616135346;10475.84286235707;9985.101340879282;10056.497175141214;10061.346012509164;10063.69808905734;10065.899341006569;38849.80575097106;39077.804610977044;39121.21757564861;39141.60858391436;39154;3333.0834020644274;3352.513885486615;3420.3501334746566;3440.776349537272;3600.6039335673054;29219.269518262;29268.268293292836;29408.411831763246;29466.410671786445;29998.400031999237;3109.9844500777576;3150.1494596459056;3202.711755941976;3227.7579181561478;3273.3126043530647;248757;248813;249144;249629.7518512414;249821;48660.756696217;48938.51061489339;48963;49084;49122;35269.11827204289;36390;36416.453753193724;37624;37725.24549508994;13125.081244312998;13562.118462299919;13609.863901361057;13624.04631675793;13629.659258518617;11293.435328233556;11445.25605835618;11454.713632159262;11710.531578736925;11714.062874969983;19194.232230710895;19362.8063719361;19367.903160484388;19429.125689344015;19433.319833806032;7267.491275610657;7427.405807535384;7447.510497900334;7460.85078298431;7560.697572097164;855.3499340501139;938.4369378373058;947.3652652722692;1034.7464871106627;1037.092544023979;28676.856615716788;29681;29907.85046074799;30434.84782576073;30477.23806904845;999.1257649556638;1033.1631378583372;1034.5551412892528;1071.924965252425;1115.5649296774266;14589.343479543446;14922.179280139479;14934.477293294682;14970.70058598822;15099.39602415913;376443;379624;379757;380159;382603;49882.50117498851;51172;51248.23127653088;51323.48676513187;51325.48674513282;1174.8707642159357;1291.9806202906964;1293.5472584595316;1305.2299143505188;1342.0873805812141;27957.72042279551;28928.42143157167;29371;29988.4002319948;30089.548656770603;43342.56657433511;43688;43957.340639889786;43998.560014399445;44034.55965440305;300046;303962;304209;304492;305969;23007.654885176402;23712.170074047324;25428.618570721083;26214.082507112158;26381.20856374312;42516.14967700567;42555;42571.3614295792;42573.57426425696;43449;36186;36506.26987460289;36610.8169459151;36925.815370922974;37181.44227836639;35912.281754364245;36271.63728362683;36671;36774;37365.626343737305;35319.82340088283;35331.11672208215;36045.81977090098;36385;36451.63548364482;31352.216194594406;32184.678153218167;32603;32696;32998.67001330052;25211.99152033898;25313.749000798918;25362;25511.617325739757;25573.23280301594 03:48:29 INFO - PROCESS | 3354 | |2;jquery.html;352.5188118218632;364.30236097872574;365.7183968344375;376.8549108593191;381.3669308947148;15949.043057416564;17389.826101738978;17422.73865892011;17847.73228401575;17909.731354029685;16305.673886522292;16670;17499.300027998866;17527.73708394375;17542.473725788215;5161;5327.946720532803;5336.43967383423;5355.866103347428;5358.517733403993;3670.504481894937;5223.817166399177;5843.5033022193165;6133.386661333876;6160.229971253593;5963.731632076567;6169.7532098716;6193.0710393440895;6198.535109866755;6208.472279856218;6146.262448506163;6161.075838624198;6231.844203894893;6255.530835187356;6262.185915830958;3294.225856923621;5046.44489106198;5353.116735738598;5387.838364849061;5404.567634589223;19719.40841774749;20480.69278960817;20532.281370151974;20630.896845515825;20636.5872682547;2013.7180794688754;2044.570640165567;2047.2322878920404;2099.464636517678;2117.3965419855267;12987.220766754024;13111.737765244641;13284.800727989088;13352.198868067948;13707.314634268347;1757.0775342945055;1803.8196180381988;1816.5821860971919;1819.5360183153343;1833.8716289859715;66438.66780666113;68492.65753671249;68550.65724671345;68657;69432;8502.489850608983;8647.654093836176;9574.686049242737;9734.172595329477;9880.950595246977;13324.333783310796;13486.93256533711;13499.932500337633;13506;13517.729645407037;7037;7145.857082858313;7617.428692848059;7692.653830577638;7697.384209263358;7086.822829429202;7304.196538380774;7345.669444874993;7445.664945077485;7446.925530744732;6122.479589234965;6209.844753881189;6246.875062498724;6299.244090709052;6490.545661803723;1595.7420250345863;1596.7066675992482;1611.7904672392515;1646.0864220357578;1696.4316953820362;949.2738055387634;993.4933184076028;1025.369397820335;1036.8548403223556;1065.6909496246158;16165.838341616669;16936.491905242863;17062.146892655317;17184;17711.645767084585;881.9118088191129;901.7520181949885;925.2320573923762;976.2385339435252;995.1740055753708;9065.68270110543;9516.571754271074;9536.809263814823;9555.522223888778;9561.808763824823;406335;410542;410761;419558;420591;80682.19317806864;80794.19205807867;83620.58189709134;83841;84588;1031.5203430404897;1040.2926010312908;1074.3070719385953;1078.8921107889305;1099.1866019145775;14687.192204428859;14855.851441485447;14891;14938.178400187659;14993.77509337339;25064.624030639192;26083.869580651975;32090;32175.51736723904;35322.823385882904;49278.50721492739;51986.740066299426;52564.73717631387;52765;53718;7656.119546252029;7886.132525422085;7889.64496597643;7921.366290696616;8056.677732890619;8386.748397548083;10483;11274.210805243882;11481.82777258325;11702.180847340604;9489.335746497678;9981.700548983543;10105.090541851268;10140.239482039024;10386.376817390981;9561.952190239004;9879.851802223116;9906.950465247628;9928.900710992797;10030.849537256801;9937.900620993698;10072.496375181358;10093.041161089684;10163.644272450429;10292.330998485075;6973.721051157897;7409.222031686595;7581.583012934341;7702.499337543042;7888.329491993245;9810.215182785218;10235.23235757336;10636.41499717523;10739.946300268448;10746.946265268936 03:48:29 INFO - PROCESS | 3354 | |3;mootools.html;1284.3578210894552;1463.6926245488446;1501.8723408510275;1661.6261341198233;1839.3930003098988;6887.621180835058;7197.2802719728;7202.063731714877;7381.114266288039;7392.11294644642;7171.713131474735;7323.414126869851;7341.486095973284;7355.485116041879;7369.668364923578;2181.040342249405;2199.25225423356;2205.602991461544;2205.9558808823813;2207.4481379655085;2214.9778502215013;2241.047554789216;2250.639897616382;2255.12050300383;2256.199049337486;2199.3292045925987;2202.273249827561;2228.699125618045;2230.0856648774006;2235.675827005083;2126.8830214338204;2135.4020874155262;2148.817350525207;2155.1271734947372;2157.5145592241856;2155.277981876073;2161.1031421960024;2162.945926351838;2166.068590506082;2167.349795061491;7218.4225261979445;7220;7257.45569082321;7293.5988520631345;7405.5926924019695;4317.201317756225;4458.1306645204195;4459.509453960061;4467.508574056884;4470.307102399133;2854.100958198161;2919.9124026279032;2920.313726274324;2931.311141881656;2964.2293003818945;944.7260294514651;947.2847999760137;962.1917589225014;970.7233438470073;979.8383266760976;9634;9696.854547181798;9703.17523010545;9714.90285097147;9748.805023899553;3864.516935383077;3968.980155099206;4020.115574573589;4025.3156963316305;4042.3734321180264;7818.8827167592535;7885.44801863864;7892.644830982619;7897;7905.446618736748;4361.760103194291;4422.7346359218545;4435.800388982439;4441.20058389493;4444.377787109807;3413.9658603414146;3934.1934903344745;4093.7339072960162;4096.303628383182;4101.200265948171;3009.5184770436626;3055.6333240010895;3066.5553494743135;3175.6189257289275;3188.713015828587;979.4123525884555;1047.1884289675563;1050.4695128959827;1050.8318669012922;1065.9520321585546;786.8741001439856;796.1719811396199;805.3557154276673;847.9533625650648;895.3150839607705;4946.530079642428;5055.418626857959;5219.086659834514;5231.790728370823;5253.711045892513;407.04141746187304;410.68172166571145;415.84198004758605;418.03434067304624;419.1135747893245;3574.0350105471375;3590.3716849551224;3652.4521321801412;3675.852965881388;3707.14735610811;8276.08963014068;8675.913240867636;8679.349048821363;8687.174718401868;8766.474011559327;8307.958460207661;8680.479171249744;8705.825883482295;8707.956460217658;8726.781830454163;6670.232923213893;6698.39714425704;6739.359760822714;6769.627670478171;6790.287019862843;4955.925661115014;4997.475265097112;5031.899362012812;5078.822241221539;5085.084684756779;8057.959710201411;8091.716789912325;8138.023437187576;8210.261076503144;8266.297364724065;7955.24425179607;8217.424780265324;8221.424500284922;8284.83430331402;8539.060703322753;5866.3547009828035;6266.655333956676;6327.240731112296;6399.712012959335;6419.679016049272;7026.683799229149;7239.819004524929;7247.673854676657;7251.637418128967;7256.2743725627015;6415.422611964946;6466.191726034246;6519.054737063194;6554.31179726141;6616.106825578678;6334.1765570475545;6477.352264773485;6507.089007539043;6537.28089910119;6646.102776125162;6228.159198508143;6246.968765156145;6279.560430769985;6285.402886725754;6289.49684025286;4313.7843107843855;4392.604665580113;4416.498390547229;4449.532799056053;4476.239039363251;4413.22768515515;4420.823167073281;4511.323301504669;4532.229520981507;4557.567031132037 03:48:29 INFO - PROCESS | 3354 | |4;prototype.html;310.2197972100168;312.6701330096748;317.42545991754923;319.1860755074562;320.07338754306284;4838.491958344376;4850.6847054941445;4873.926891096637;4897.877553061171;4902.142125128106;4821.855344339667;4824.903501929959;4846.975765121169;4862.416510018803;4871.634627402941;3651.3427583035045;3774.622537746231;3776.7356285060055;3867.7872717000555;3872.5740168581433;3812.0850995760957;3843.1545060086737;3849.7690138591634;3850.249201405727;3869.961300387002;3673.742838001341;3837.846486140551;3847.941816000608;3848.2495913296916;3854.2291541691634;3718.9442158367647;3779.8866034019024;3786.6970642348547;3786.769299977491;3835.616438356184;3366.562346894888;3377.8142202179115;3381.628020917697;3381.7970921744527;3393.151712071982;4566.10960862632;4577.061702351043;4581.587657110876;4583.922778147133;4588.564086411786;4207.873763787091;4328.480582330109;4344.435223420966;4359.387026800073;4367;4996.600951733521;5010.574101201402;5024.221245706921;5034.798608055673;5039.370078740158;3708.1100535871465;3709.1283548366114;3720.4605332226947;3729.850805967758;3732.7387082904206;5009.799608015675;5303.912697896922;5313.1764576490705;5324.334458192726;5343.305370301836;3641.617630148849;3662.560492740888;3678.786000619789;3680.7239457040296;3680.9509289852263;3733.663970242637;3756.38019726742;3757.6242375762754;3768.437462525509;3768.660820526166;4274.572542745701;4282.614564689193;4321.222180007629;4324.718893271927;4333.848315308949;5022.648414610942;5074.213496907985;5093.381944683291;5108.438071812097;5109.642325037212;1232.778099942019;1239.5661518468464;1242.2298175131477;1242.5837344489696;1242.8570714367784;807.4751411582401;836.2431999040878;862.9956850215709;869.3175856952262;871.9972032163063;4280.914381712349;4288.335308027198;4306.82772689089;4311.784410779511;4325.286327755948;5031;5055.595552355876;5074;5090.720010399389;5107.591392688576;4108.055147316134;4222.809973551198;4251.766152861623;4291.2275790358035;4293.69944103916;2683.9463210735676;2705.91882243533;2708.7832973362083;2717.4972630063503;2718.143784707811;4705.576498115186;4753.241300718756;4782.354382158364;4783.306420568998;4783.976080119577;4859.837372369262;5162.380514338303;5193.428722840485;5198.402183748917;5214.139666954986;4758.287775967665;4767.284907263938;4770.115804257299;4773.64197685175;4797.496262892416;4954.455009948831;4981.277714731416;5008.295520418933;5009.323741295024;5034.672746271481;4861.51384861511;4918.926216106833;4942.703437793743;4985.82833034244;5211.270422140828;4970.353853998957;4976.2038073908;4977.303177555217;4989.575886049582;4990.476000019946;3698.1863989922176;3699.427743209179;3702.333579955634;3729;3739.682127019234;5124.9743751281;5294.814681486129;5307.256984022163;5316.627836051439;5332.786688532416;5080.187170052774;5080.212567052113;5102.2346648003095;5115.232715092766;5124.692518448905;5081.983603279285;5103.515166059218;5110.514501122388;5117.8464646060675;5137.409197942285;4745;5012.3233363495465;5017.724025178651;5025.673331233458;5044.520770526794;4916.631252655993;4969.900601988013;5036.622253330942;5143.936290330597;5159.845204643867;5027.874303142451;5038.496150384932;5051.292819005269;5056.064628043824;5062.645614807076 03:48:29 INFO - PROCESS | 3354 | |5;yui.html;700.9193942696589;767.2442643995665;774.1484367196082;792.8493586218615;800.951942883427;10851.403172825492;11619.941900290507;11628.767424651502;11654.533818647255;11678.299302041873;12303.200291981015;12326.63020109396;12433.254004759721;12466.688332791662;12526.123171378007;661.5501459007872;843.5992903370911;858.7552547523957;859.4843094143527;860.27736701171;851.7529916324258;872.9170728780756;873.1137895036543;878.8462019146656;881.422668152358;912.8813254276968;915.2860768600502;918.1415376622846;918.2699753695795;918.4168053286178;699.6431819771902;721.3003386714878;908.9000209976897;910.6676063236904;910.6994691751772;527.4646234072419;528.3976267055559;652.0284775684196;667;667.9532432729711;12156.51373945041;12199.207051541622;12202.084843636674;12223.08326875479;12227.082968777288;11213.439328033566;12182.147249692525;12193.817092743617;12213.877861221452;12754.936225318814;10649.148068154529;10671.83992240117;11252.887471125267;11299.548018079267;11321.433928303633;4040.393940908858;4094.754314741125;4122.464079669624;4137.379393091061;4164.646005089571;40926.38610420846;41208.38187427191;41231.38152927708;41292.79353603213;41316.38025429621;9835.557399917021;10031.347962382422;10052.045055719695;10621.256512044083;10650.627228046982;17280.913595431943;17348.39280625172;17361.7395739064;17409.738853917203;17562.912185438992;6464.838379040468;6497.382748638872;6577.440917521969;6615.933840661628;6628.5360024798765;3461.2039230977016;3561.679448849616;3615.7649752765988;3677.0807298175455;3679;2634.73652634735;2734.53512902807;2739.767104802847;2740.0135951057605;2742.602322663203;505.3329604921468;512.3851378345926;513.9922901156485;534.5242733966772;537.3846945247748;520.4587229281581;534.6337758635348;542.4954792043359;551.2530521143873;568.1619611073634;7337.70649174027;7394.667239974214;7414.369778568775;7546.5094768840945;7609.581473019037;528.2472476720658;564.8898464799324;605.1950905295946;610.3804638292137;610.8106486989047;3397.1507123219194;3542.8405721742583;3563.982180089083;3571.714262858965;3680.190358121209;48598;50241.748791255806;50323.24515132276;50516;50692.74653626782;43857.56142438599;46259.53740462619;46847.76576117097;47059.294110588366;47684.52315476801;38992.6100738989;40262.79868600638;42087.78956105261;43930.56069439265;45558.31662524999;7972.960135199287;8012.158723333966;8102.311303539265;8197.590120493833;8252.46358986664;27872.721272787825;28543.857280714295;28609.14172574826;28727.425451490435;29232.41535169327;32538.511922321657;35989.46015809713;36779;37174.814125929195;37581.24837503289;9727.221822254343;10477.161827053666;10478.738031548968;10596.470176491299;10613.416262105658;10348.53431595595;10613.628523001658;11096.722581935515;11373.033292170257;11465.770684586094;8089.2315230053055;10652.360858348524;10762.300450470695;10918.454077296263;11603.593874214363;10612.522436490222;10671.199660025373;10969.780604387708;11025.83461248098;11706.473208705458;10224.446345782831;10348.482575871025;10429.582816687247;10662.466876656292;10933.398663073607;9103.453792772454;9380.906190938003;9632.229421646392;9666.903330966881;9672.468014259282;10015.899841001497;10038.899611003797;10058.748531286483;10187.592496300065;10188 03:48:29 INFO - PROCESS | 3354 | __end_tp_report 03:48:29 INFO - PROCESS | 3354 | __start_cc_report 03:48:29 INFO - PROCESS | 3354 | _x_x_mozilla_cycle_collect,1031 03:48:29 INFO - PROCESS | 3354 | __end_cc_report 03:48:29 INFO - PROCESS | 3354 | __startTimestamp1462877309733__endTimestamp 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | ------- Summary: start ------- 03:48:29 INFO - PROCESS | 3354 | Number of tests: 6 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | [#0] dojo.html Cycles:165 Average:4670.70 Median:4795.88 stddev:496.09 (10.3%) stddev-sans-first:471.49 03:48:29 INFO - PROCESS | 3354 | Values: 2645.9 2657.1 2681.2 2695.7 2707.7 4561.3 4625.8 4633.4 4709.3 4730.7 4595.3 4627.8 4640.8 4704.6 4790.2 4231.9 4293.7 4309.2 4363.7 4423.7 4325.7 4383.2 4425.1 4455.7 4467.8 4202.0 4364.8 4394.9 4402.9 4424.8 4226.0 4270.6 4274.2 4281.4 4369.0 4278.2 4294.1 4310.1 4337.1 4343.1 4602.7 4629.9 4642.2 4643.4 4645.2 4826.0 5040.5 5094.6 5112.0 5172.1 5131.3 5141.1 5171.8 5182.0 5193.8 4549.9 4849.7 4849.7 4864.2 4867.3 5165.5 5207.7 5228.5 5287.2 5313.8 5023.4 5053.9 5081.5 5082.3 5087.9 4922.0 4941.3 4968.3 4972.2 4999.3 4990.1 5028.4 5044.7 5051.7 5086.3 5011.2 5017.0 5018.7 5029.6 5065.9 4165.0 4198.9 4239.8 4305.1 4382.9 3712.1 3734.9 3740.1 3780.0 3806.9 4214.4 4214.8 4224.9 4262.9 4263.9 4895.8 4978.0 5019.4 5034.3 5046.5 4293.2 4324.8 4326.7 4359.6 4362.0 4586.2 4597.3 4598.1 4600.4 4645.8 4647.0 4792.0 4793.7 4827.5 4844.1 5084.3 5094.8 5100.2 5100.6 5152.4 4771.8 4804.1 4805.0 4807.1 4840.4 4784.4 4903.8 4963.8 4975.0 5031.1 5026.9 5056.4 5064.2 5066.0 5108.6 4894.4 4913.5 4926.9 4929.1 4942.6 4765.2 4942.9 4972.3 4992.8 4993.5 4928.3 4933.2 4939.3 4979.0 4986.2 4793.5 5033.3 5037.9 5051.9 5087.7 4773.7 4776.5 4784.0 4785.0 4795.9 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | [#1] ext.html Cycles:180 Average:46802.68 Median:17706.22 stddev:82768.32 (467.5%) stddev-sans-first:82927.70 03:48:29 INFO - PROCESS | 3354 | Values: 567.1 597.8 600.5 604.8 614.5 26959.3 42429.8 43092.8 43134.6 43183.6 43402.8 43990.0 44028.3 44054.6 44101.3 7522.6 7804.7 7960.8 10034.8 10234.7 10017.8 10117.5 10124.4 10131.4 10132.6 10079.6 10098.6 10100.0 10102.1 10140.7 7546.5 9909.1 10080.8 10084.6 10475.8 9985.1 10056.5 10061.3 10063.7 10065.9 38849.8 39077.8 39121.2 39141.6 39154.0 3333.1 3352.5 3420.4 3440.8 3600.6 29219.3 29268.3 29408.4 29466.4 29998.4 3110.0 3150.1 3202.7 3227.8 3273.3 248757.0 248813.0 249144.0 249629.8 249821.0 48660.8 48938.5 48963.0 49084.0 49122.0 35269.1 36390.0 36416.5 37624.0 37725.2 13125.1 13562.1 13609.9 13624.0 13629.7 11293.4 11445.3 11454.7 11710.5 11714.1 19194.2 19362.8 19367.9 19429.1 19433.3 7267.5 7427.4 7447.5 7460.9 7560.7 855.3 938.4 947.4 1034.7 1037.1 28676.9 29681.0 29907.9 30434.8 30477.2 999.1 1033.2 1034.6 1071.9 1115.6 14589.3 14922.2 14934.5 14970.7 15099.4 376443.0 379624.0 379757.0 380159.0 382603.0 49882.5 51172.0 51248.2 51323.5 51325.5 1174.9 1292.0 1293.5 1305.2 1342.1 27957.7 28928.4 29371.0 29988.4 30089.5 43342.6 43688.0 43957.3 43998.6 44034.6 300046.0 303962.0 304209.0 304492.0 305969.0 23007.7 23712.2 25428.6 26214.1 26381.2 42516.1 42555.0 42571.4 42573.6 43449.0 36186.0 36506.3 36610.8 36925.8 37181.4 35912.3 36271.6 36671.0 36774.0 37365.6 35319.8 35331.1 36045.8 36385.0 36451.6 31352.2 32184.7 32603.0 32696.0 32998.7 25212.0 25313.7 25362.0 25511.6 25573.2 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | [#2] jquery.html Cycles:180 Average:25092.58 Median:234934.75 stddev:68209.14 (29.0%) stddev-sans-first:68375.19 03:48:29 INFO - PROCESS | 3354 | Values: 352.5 364.3 365.7 376.9 381.4 15949.0 17389.8 17422.7 17847.7 17909.7 16305.7 16670.0 17499.3 17527.7 17542.5 5161.0 5327.9 5336.4 5355.9 5358.5 3670.5 5223.8 5843.5 6133.4 6160.2 5963.7 6169.8 6193.1 6198.5 6208.5 6146.3 6161.1 6231.8 6255.5 6262.2 3294.2 5046.4 5353.1 5387.8 5404.6 19719.4 20480.7 20532.3 20630.9 20636.6 2013.7 2044.6 2047.2 2099.5 2117.4 12987.2 13111.7 13284.8 13352.2 13707.3 1757.1 1803.8 1816.6 1819.5 1833.9 66438.7 68492.7 68550.7 68657.0 69432.0 8502.5 8647.7 9574.7 9734.2 9881.0 13324.3 13486.9 13499.9 13506.0 13517.7 7037.0 7145.9 7617.4 7692.7 7697.4 7086.8 7304.2 7345.7 7445.7 7446.9 6122.5 6209.8 6246.9 6299.2 6490.5 1595.7 1596.7 1611.8 1646.1 1696.4 949.3 993.5 1025.4 1036.9 1065.7 16165.8 16936.5 17062.1 17184.0 17711.6 881.9 901.8 925.2 976.2 995.2 9065.7 9516.6 9536.8 9555.5 9561.8 406335.0 410542.0 410761.0 419558.0 420591.0 80682.2 80794.2 83620.6 83841.0 84588.0 1031.5 1040.3 1074.3 1078.9 1099.2 14687.2 14855.9 14891.0 14938.2 14993.8 25064.6 26083.9 32090.0 32175.5 35322.8 49278.5 51986.7 52564.7 52765.0 53718.0 7656.1 7886.1 7889.6 7921.4 8056.7 8386.7 10483.0 11274.2 11481.8 11702.2 9489.3 9981.7 10105.1 10140.2 10386.4 9562.0 9879.9 9907.0 9928.9 10030.8 9937.9 10072.5 10093.0 10163.6 10292.3 6973.7 7409.2 7581.6 7702.5 7888.3 9810.2 10235.2 10636.4 10739.9 10746.9 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | [#3] mootools.html Cycles:180 Average:4826.38 Median:5152.09 stddev:2601.90 (50.5%) stddev-sans-first:2595.58 03:48:29 INFO - PROCESS | 3354 | Values: 1284.4 1463.7 1501.9 1661.6 1839.4 6887.6 7197.3 7202.1 7381.1 7392.1 7171.7 7323.4 7341.5 7355.5 7369.7 2181.0 2199.3 2205.6 2206.0 2207.4 2215.0 2241.0 2250.6 2255.1 2256.2 2199.3 2202.3 2228.7 2230.1 2235.7 2126.9 2135.4 2148.8 2155.1 2157.5 2155.3 2161.1 2162.9 2166.1 2167.3 7218.4 7220.0 7257.5 7293.6 7405.6 4317.2 4458.1 4459.5 4467.5 4470.3 2854.1 2919.9 2920.3 2931.3 2964.2 944.7 947.3 962.2 970.7 979.8 9634.0 9696.9 9703.2 9714.9 9748.8 3864.5 3969.0 4020.1 4025.3 4042.4 7818.9 7885.4 7892.6 7897.0 7905.4 4361.8 4422.7 4435.8 4441.2 4444.4 3414.0 3934.2 4093.7 4096.3 4101.2 3009.5 3055.6 3066.6 3175.6 3188.7 979.4 1047.2 1050.5 1050.8 1066.0 786.9 796.2 805.4 848.0 895.3 4946.5 5055.4 5219.1 5231.8 5253.7 407.0 410.7 415.8 418.0 419.1 3574.0 3590.4 3652.5 3675.9 3707.1 8276.1 8675.9 8679.3 8687.2 8766.5 8308.0 8680.5 8705.8 8708.0 8726.8 6670.2 6698.4 6739.4 6769.6 6790.3 4955.9 4997.5 5031.9 5078.8 5085.1 8058.0 8091.7 8138.0 8210.3 8266.3 7955.2 8217.4 8221.4 8284.8 8539.1 5866.4 6266.7 6327.2 6399.7 6419.7 7026.7 7239.8 7247.7 7251.6 7256.3 6415.4 6466.2 6519.1 6554.3 6616.1 6334.2 6477.4 6507.1 6537.3 6646.1 6228.2 6247.0 6279.6 6285.4 6289.5 4313.8 4392.6 4416.5 4449.5 4476.2 4413.2 4420.8 4511.3 4532.2 4557.6 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | [#4] prototype.html Cycles:180 Average:4184.63 Median:4771.88 stddev:1207.54 (25.3%) stddev-sans-first:1175.39 03:48:29 INFO - PROCESS | 3354 | Values: 310.2 312.7 317.4 319.2 320.1 4838.5 4850.7 4873.9 4897.9 4902.1 4821.9 4824.9 4847.0 4862.4 4871.6 3651.3 3774.6 3776.7 3867.8 3872.6 3812.1 3843.2 3849.8 3850.2 3870.0 3673.7 3837.8 3847.9 3848.2 3854.2 3718.9 3779.9 3786.7 3786.8 3835.6 3366.6 3377.8 3381.6 3381.8 3393.2 4566.1 4577.1 4581.6 4583.9 4588.6 4207.9 4328.5 4344.4 4359.4 4367.0 4996.6 5010.6 5024.2 5034.8 5039.4 3708.1 3709.1 3720.5 3729.9 3732.7 5009.8 5303.9 5313.2 5324.3 5343.3 3641.6 3662.6 3678.8 3680.7 3681.0 3733.7 3756.4 3757.6 3768.4 3768.7 4274.6 4282.6 4321.2 4324.7 4333.8 5022.6 5074.2 5093.4 5108.4 5109.6 1232.8 1239.6 1242.2 1242.6 1242.9 807.5 836.2 863.0 869.3 872.0 4280.9 4288.3 4306.8 4311.8 4325.3 5031.0 5055.6 5074.0 5090.7 5107.6 4108.1 4222.8 4251.8 4291.2 4293.7 2683.9 2705.9 2708.8 2717.5 2718.1 4705.6 4753.2 4782.4 4783.3 4784.0 4859.8 5162.4 5193.4 5198.4 5214.1 4758.3 4767.3 4770.1 4773.6 4797.5 4954.5 4981.3 5008.3 5009.3 5034.7 4861.5 4918.9 4942.7 4985.8 5211.3 4970.4 4976.2 4977.3 4989.6 4990.5 3698.2 3699.4 3702.3 3729.0 3739.7 5125.0 5294.8 5307.3 5316.6 5332.8 5080.2 5080.2 5102.2 5115.2 5124.7 5082.0 5103.5 5110.5 5117.8 5137.4 4745.0 5012.3 5017.7 5025.7 5044.5 4916.6 4969.9 5036.6 5143.9 5159.8 5027.9 5038.5 5051.3 5056.1 5062.6 03:48:29 INFO - PROCESS | 3354 | 03:48:29 INFO - PROCESS | 3354 | [#5] yui.html Cycles:180 Average:12408.38 Median:22510.57 stddev:13788.13 (61.3%) stddev-sans-first:13798.78 03:48:29 INFO - PROCESS | 3354 | Values: 700.9 767.2 774.1 792.8 801.0 10851.4 11619.9 11628.8 11654.5 11678.3 12303.2 12326.6 12433.3 12466.7 12526.1 661.6 843.6 858.8 859.5 860.3 851.8 872.9 873.1 878.8 881.4 912.9 915.3 918.1 918.3 918.4 699.6 721.3 908.9 910.7 910.7 527.5 528.4 652.0 667.0 668.0 12156.5 12199.2 12202.1 12223.1 12227.1 11213.4 12182.1 12193.8 12213.9 12754.9 10649.1 10671.8 11252.9 11299.5 11321.4 4040.4 4094.8 4122.5 4137.4 4164.6 40926.4 41208.4 41231.4 41292.8 41316.4 9835.6 10031.3 10052.0 10621.3 10650.6 17280.9 17348.4 17361.7 17409.7 17562.9 6464.8 6497.4 6577.4 6615.9 6628.5 3461.2 3561.7 3615.8 3677.1 3679.0 2634.7 2734.5 2739.8 2740.0 2742.6 505.3 512.4 514.0 534.5 537.4 520.5 534.6 542.5 551.3 568.2 7337.7 7394.7 7414.4 7546.5 7609.6 528.2 564.9 605.2 610.4 610.8 3397.2 3542.8 3564.0 3571.7 3680.2 48598.0 50241.7 50323.2 50516.0 50692.7 43857.6 46259.5 46847.8 47059.3 47684.5 38992.6 40262.8 42087.8 43930.6 45558.3 7973.0 8012.2 8102.3 8197.6 8252.5 27872.7 28543.9 28609.1 28727.4 29232.4 32538.5 35989.5 36779.0 37174.8 37581.2 9727.2 10477.2 10478.7 10596.5 10613.4 10348.5 10613.6 11096.7 11373.0 11465.8 8089.2 10652.4 10762.3 10918.5 11603.6 10612.5 10671.2 10969.8 11025.8 11706.5 10224.4 10348.5 10429.6 10662.5 10933.4 9103.5 9380.9 9632.2 9666.9 9672.5 10015.9 10038.9 10058.7 10187.6 10188.0 03:48:29 INFO - PROCESS | 3354 | -------- Summary: end -------- 03:48:29 INFO - PROCESS | 3354 | 03:48:30 INFO - TEST-INFO | 3354: exit 0 03:48:30 INFO - TEST-OK | dromaeo_css | took 1119397ms 03:48:30 INFO - TEST-START | kraken 03:48:30 INFO - operating with platform_type : linux_ 03:48:30 INFO - Initialising browser for kraken test... 03:48:30 INFO - TEST-INFO | started process 3561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuew9KO/profile http://localhost:43283/getInfo.html) 03:48:34 INFO - PROCESS | 3561 | __metrics Screen width/height:1600/1200 03:48:34 INFO - PROCESS | 3561 | colorDepth:24 03:48:34 INFO - PROCESS | 3561 | Browser inner width/height: 1024/697 03:48:34 INFO - PROCESS | 3561 | __metrics 03:48:35 ERROR - PROCESS | 3561 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:48:36 INFO - TEST-INFO | 3561: exit 0 03:48:36 INFO - Browser initialized. 03:48:36 INFO - Running cycle 1/1 for kraken test... 03:48:36 INFO - TEST-INFO | started process 3640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuew9KO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:48 INFO - PROCESS | 3640 | RSS: Main: 154218496 03:48:48 INFO - PROCESS | 3640 | 03:48:51 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43283/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:51 INFO - PROCESS | 3640 | RSS: Main: 209559552 03:48:51 INFO - PROCESS | 3640 | 03:48:54 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43283/tests/kraken/driver.html?testName=audio-dft) 03:48:55 INFO - PROCESS | 3640 | RSS: Main: 197324800 03:48:55 INFO - PROCESS | 3640 | 03:48:58 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43283/tests/kraken/driver.html?testName=audio-fft) 03:48:59 INFO - PROCESS | 3640 | RSS: Main: 266702848 03:48:59 INFO - PROCESS | 3640 | 03:49:01 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43283/tests/kraken/driver.html?testName=audio-oscillator) 03:49:02 INFO - PROCESS | 3640 | RSS: Main: 174919680 03:49:02 INFO - PROCESS | 3640 | 03:49:04 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:05 INFO - PROCESS | 3640 | RSS: Main: 179073024 03:49:05 INFO - PROCESS | 3640 | 03:49:08 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43283/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:09 INFO - PROCESS | 3640 | RSS: Main: 215519232 03:49:09 INFO - PROCESS | 3640 | 03:49:12 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43283/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:13 INFO - PROCESS | 3640 | RSS: Main: 214499328 03:49:13 INFO - PROCESS | 3640 | 03:49:16 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43283/tests/kraken/driver.html?testName=json-parse-financial) 03:49:17 INFO - PROCESS | 3640 | RSS: Main: 214740992 03:49:17 INFO - PROCESS | 3640 | 03:49:18 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:19 INFO - PROCESS | 3640 | RSS: Main: 207245312 03:49:20 INFO - PROCESS | 3640 | 03:49:21 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:22 INFO - PROCESS | 3640 | RSS: Main: 206663680 03:49:22 INFO - PROCESS | 3640 | 03:49:24 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:25 INFO - PROCESS | 3640 | RSS: Main: 211701760 03:49:25 INFO - PROCESS | 3640 | 03:49:27 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:28 INFO - PROCESS | 3640 | RSS: Main: 217104384 03:49:28 INFO - PROCESS | 3640 | 03:49:31 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:32 INFO - PROCESS | 3640 | RSS: Main: 216330240 03:49:32 INFO - PROCESS | 3640 | 03:49:33 INFO - PROCESS | 3640 | Cycle 1(1): loaded http://localhost:43283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43283/tests/kraken/driver.html?testName=ai-astar) 03:49:34 INFO - PROCESS | 3640 | RSS: Main: 262885376 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | __start_tp_report 03:49:34 INFO - PROCESS | 3640 | _x_x_mozilla_page_load 03:49:34 INFO - PROCESS | 3640 | _x_x_mozilla_page_load_details 03:49:34 INFO - PROCESS | 3640 | |i|pagename|runs| 03:49:34 INFO - PROCESS | 3640 | |0;ai-astar;114;109;116;115;116;115;115;115;115;114 03:49:34 INFO - PROCESS | 3640 | |1;audio-beat-detection;158;130;152;226;136;154;166;138;183;129 03:49:34 INFO - PROCESS | 3640 | |2;audio-dft;160;160;160;161;160;160;161;160;161;160 03:49:34 INFO - PROCESS | 3640 | |3;audio-fft;75;75;75;157;77;76;77;76;130;76 03:49:34 INFO - PROCESS | 3640 | |4;audio-oscillator;92;92;159;92;93;92;124;92;92;128 03:49:34 INFO - PROCESS | 3640 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;117;117;117 03:49:34 INFO - PROCESS | 3640 | |6;imaging-darkroom;146;148;146;145;145;146;146;145;146;146 03:49:34 INFO - PROCESS | 3640 | |7;imaging-desaturate;95;95;96;95;95;94;95;94;94;95 03:49:34 INFO - PROCESS | 3640 | |8;json-parse-financial;66;68;65;65;67;67;68;66;66;67 03:49:34 INFO - PROCESS | 3640 | |9;json-stringify-tinderbox;64;63;64;64;65;64;64;64;63;64 03:49:34 INFO - PROCESS | 3640 | |10;stanford-crypto-aes;88;81;81;81;83;82;82;84;145;82 03:49:34 INFO - PROCESS | 3640 | |11;stanford-crypto-ccm;140;131;141;128;128;134;132;134;156;133 03:49:34 INFO - PROCESS | 3640 | |12;stanford-crypto-pbkdf2;177;172;178;173;179;175;177;176;173;177 03:49:34 INFO - PROCESS | 3640 | |13;stanford-crypto-sha256-iterative;68;71;70;67;69;68;68;67;70;66 03:49:34 INFO - PROCESS | 3640 | __end_tp_report 03:49:34 INFO - PROCESS | 3640 | __start_cc_report 03:49:34 INFO - PROCESS | 3640 | _x_x_mozilla_cycle_collect,2072 03:49:34 INFO - PROCESS | 3640 | __end_cc_report 03:49:34 INFO - PROCESS | 3640 | __startTimestamp1462877374209__endTimestamp 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | ------- Summary: start ------- 03:49:34 INFO - PROCESS | 3640 | Number of tests: 14 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.01 (1.7%) stddev-sans-first:2.13 03:49:34 INFO - PROCESS | 3640 | Values: 114.0 109.0 116.0 115.0 116.0 115.0 115.0 115.0 115.0 114.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#1] audio-beat-detection Cycles:10 Average:157.20 Median:156.00 stddev:29.57 (19.0%) stddev-sans-first:31.36 03:49:34 INFO - PROCESS | 3640 | Values: 158.0 130.0 152.0 226.0 136.0 154.0 166.0 138.0 183.0 129.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 03:49:34 INFO - PROCESS | 3640 | Values: 160.0 160.0 160.0 161.0 160.0 160.0 161.0 160.0 161.0 160.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#3] audio-fft Cycles:10 Average:89.40 Median:76.00 stddev:29.22 (38.5%) stddev-sans-first:30.53 03:49:34 INFO - PROCESS | 3640 | Values: 75.0 75.0 75.0 157.0 77.0 76.0 77.0 76.0 130.0 76.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:92.00 stddev:23.48 (25.5%) stddev-sans-first:24.38 03:49:34 INFO - PROCESS | 3640 | Values: 92.0 92.0 159.0 92.0 93.0 92.0 124.0 92.0 92.0 128.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:49:34 INFO - PROCESS | 3640 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 03:49:34 INFO - PROCESS | 3640 | Values: 146.0 148.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:49:34 INFO - PROCESS | 3640 | Values: 95.0 95.0 96.0 95.0 95.0 94.0 95.0 94.0 94.0 95.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:67.00 stddev:1.08 (1.6%) stddev-sans-first:1.13 03:49:34 INFO - PROCESS | 3640 | Values: 66.0 68.0 65.0 65.0 67.0 67.0 68.0 66.0 66.0 67.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 03:49:34 INFO - PROCESS | 3640 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 64.0 64.0 63.0 64.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:82.00 stddev:19.82 (24.2%) stddev-sans-first:21.02 03:49:34 INFO - PROCESS | 3640 | Values: 88.0 81.0 81.0 81.0 83.0 82.0 82.0 84.0 145.0 82.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:134.00 stddev:8.34 (6.2%) stddev-sans-first:8.70 03:49:34 INFO - PROCESS | 3640 | Values: 140.0 131.0 141.0 128.0 128.0 134.0 132.0 134.0 156.0 133.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:177.00 stddev:2.36 (1.3%) stddev-sans-first:2.46 03:49:34 INFO - PROCESS | 3640 | Values: 177.0 172.0 178.0 173.0 179.0 175.0 177.0 176.0 173.0 177.0 03:49:34 INFO - PROCESS | 3640 | 03:49:34 INFO - PROCESS | 3640 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.58 (2.3%) stddev-sans-first:1.67 03:49:34 INFO - PROCESS | 3640 | Values: 68.0 71.0 70.0 67.0 69.0 68.0 68.0 67.0 70.0 66.0 03:49:34 INFO - PROCESS | 3640 | -------- Summary: end -------- 03:49:34 INFO - PROCESS | 3640 | 03:49:35 INFO - TEST-INFO | 3640: exit 0 03:49:35 INFO - TEST-OK | kraken | took 64686ms 03:49:35 INFO - SUITE-END | took 1184s 03:49:35 INFO - Completed test suite (00:19:44) 03:49:35 INFO - javascript benchmark 03:49:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2645.907393241236, 2657.136430660036, 2681.1956413076073, 2695.6899956504985, 2707.67507899052, 4561.270196768518, 4625.791839367228, 4633.443986721594, 4709.2936059591075, 4730.668853180275, 4595.3107033944925, 4627.8380256691025, 4640.767961601915, 4704.553067458594, 4790.185668436366, 4231.851885184019, 4293.742375457467, 4309.224339618867, 4363.694541382112, 4423.690341676084, 4325.675574331937, 4383.232934236512, 4425.09285596452, 4455.665825063117, 4467.821287148527, 4202.0, 4364.781760911942, 4394.8901277468, 4402.889927751799, 4424.823007079729, 4226.0, 4270.572942705705, 4274.187904298205, 4281.357796330544, 4368.956310436918, 4278.165757677254, 4294.119705460374, 4310.137972405531, 4337.132573485315, 4343.087951530182, 4602.723836569783, 4629.86110416688, 4642.164410406125, 4643.396358473411, 4645.233536466479, 4826.01066781309, 5040.521150490697, 5094.566961808214, 5111.974440127776, 5172.146595811687, 5131.281620573122, 5141.126008578551, 5171.7672704728375, 5182.041322355376, 5193.766280517348, 4549.886252843706, 4849.660523763373, 4849.684770489906, 4864.221724524059, 4867.34290870735, 5165.535101840777, 5207.6875387476875, 5228.451012643618, 5287.154055351202, 5313.814016509404, 5023.447420783711, 5053.9241911371355, 5081.491850814963, 5082.33929589151, 5087.898242035212, 4921.9507804922205, 4941.332920055818, 4968.254761785761, 4972.154733695208, 4999.275105109738, 4990.126727822617, 5028.396592408934, 5044.722540260321, 5051.671641343374, 5086.338775959176, 5011.248312753043, 5016.974915125401, 5018.749062546931, 5029.572486338702, 5065.924011139762, 4164.9583504165175, 4198.9370159447635, 4239.830406783756, 4305.117450922553, 4382.890427739332, 3712.1090938175184, 3734.9439758403646, 3740.0649837540614, 3780.0360907968843, 3806.885793426202, 4214.388913607571, 4214.768187749703, 4224.87325380233, 4262.87211383659, 4263.850765223202, 4895.755212239374, 4977.9751101244265, 5019.397672279277, 5034.270030845581, 5046.545810876965, 4293.248681480728, 4324.762138082373, 4326.697131200849, 4359.564043595615, 4361.978190109093, 4586.151561960981, 4597.333386658983, 4598.057398233354, 4600.401947746838, 4645.837395691135, 4647.024124933801, 4791.952080479151, 4793.664443488922, 4827.493113223201, 4844.079624871263, 5084.2627818966785, 5094.847154585368, 5100.2349647553165, 5100.6429549931145, 5152.433232344364, 4771.785269662943, 4804.06320767447, 4805.0, 4807.134715751198, 4840.394950631171, 4784.4497882742535, 4903.803847846046, 4963.751812409293, 4974.9751251243515, 5031.069252188357, 5026.874328141826, 5056.367954005749, 5064.189729643387, 5066.03745288394, 5108.61685373591, 4894.412670479565, 4913.459519452786, 4926.852194434029, 4929.088118697909, 4942.629302802232, 4765.166095933128, 4942.851714448572, 4972.3038774572315, 4992.80028798844, 4993.500649934977, 4928.310036594808, 4933.235348520985, 4939.308496810378, 4978.975105124451, 4986.202207646904, 4793.49668284839, 5033.270175824412, 5037.924431133462, 5051.898962020812, 5087.720175390389, 4773.66584339093, 4776.450708168605, 4783.976080119577, 4784.976075119741, 4795.880102997453], "value": 4639.260922085386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.1492760858712, 597.8027251007168, 600.5285850607271, 604.8397174748691, 614.5083932853718, 26959.326016849565, 42429.78785106074, 43092.78453607736, 43134.56865431349, 43183.56816431835, 43402.782986085105, 43990.0, 44028.3395749064, 44054.55945440545, 44101.33847992275, 7522.623868806565, 7804.726834560805, 7960.761177164694, 10034.799304013915, 10234.692959211236, 10017.799644007115, 10117.544710488046, 10124.443155626437, 10131.392116472998, 10132.594696212143, 10079.596816127347, 10098.646547370843, 10100.0, 10102.141317987944, 10140.746481337988, 7546.509476884013, 9909.058639429279, 10080.798384032278, 10084.596616135346, 10475.84286235707, 9985.101340879282, 10056.497175141214, 10061.346012509164, 10063.69808905734, 10065.899341006569, 38849.80575097106, 39077.804610977044, 39121.21757564861, 39141.60858391436, 39154.0, 3333.0834020644274, 3352.513885486615, 3420.3501334746566, 3440.776349537272, 3600.6039335673054, 29219.269518262, 29268.268293292836, 29408.411831763246, 29466.410671786445, 29998.400031999237, 3109.9844500777576, 3150.1494596459056, 3202.711755941976, 3227.7579181561478, 3273.3126043530647, 248757.0, 248813.0, 249144.0, 249629.7518512414, 249821.0, 48660.756696217, 48938.51061489339, 48963.0, 49084.0, 49122.0, 35269.11827204289, 36390.0, 36416.453753193724, 37624.0, 37725.24549508994, 13125.081244312998, 13562.118462299919, 13609.863901361057, 13624.04631675793, 13629.659258518617, 11293.435328233556, 11445.25605835618, 11454.713632159262, 11710.531578736925, 11714.062874969983, 19194.232230710895, 19362.8063719361, 19367.903160484388, 19429.125689344015, 19433.319833806032, 7267.491275610657, 7427.405807535384, 7447.510497900334, 7460.85078298431, 7560.697572097164, 855.3499340501139, 938.4369378373058, 947.3652652722692, 1034.7464871106627, 1037.092544023979, 28676.856615716788, 29681.0, 29907.85046074799, 30434.84782576073, 30477.23806904845, 999.1257649556638, 1033.1631378583372, 1034.5551412892528, 1071.924965252425, 1115.5649296774266, 14589.343479543446, 14922.179280139479, 14934.477293294682, 14970.70058598822, 15099.39602415913, 376443.0, 379624.0, 379757.0, 380159.0, 382603.0, 49882.50117498851, 51172.0, 51248.23127653088, 51323.48676513187, 51325.48674513282, 1174.8707642159357, 1291.9806202906964, 1293.5472584595316, 1305.2299143505188, 1342.0873805812141, 27957.72042279551, 28928.42143157167, 29371.0, 29988.4002319948, 30089.548656770603, 43342.56657433511, 43688.0, 43957.340639889786, 43998.560014399445, 44034.55965440305, 300046.0, 303962.0, 304209.0, 304492.0, 305969.0, 23007.654885176402, 23712.170074047324, 25428.618570721083, 26214.082507112158, 26381.20856374312, 42516.14967700567, 42555.0, 42571.3614295792, 42573.57426425696, 43449.0, 36186.0, 36506.26987460289, 36610.8169459151, 36925.815370922974, 37181.44227836639, 35912.281754364245, 36271.63728362683, 36671.0, 36774.0, 37365.626343737305, 35319.82340088283, 35331.11672208215, 36045.81977090098, 36385.0, 36451.63548364482, 31352.216194594406, 32184.678153218167, 32603.0, 32696.0, 32998.67001330052, 25211.99152033898, 25313.749000798918, 25362.0, 25511.617325739757, 25573.23280301594], "value": 18150.3277928004, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.5188118218632, 364.30236097872574, 365.7183968344375, 376.8549108593191, 381.3669308947148, 15949.043057416564, 17389.826101738978, 17422.73865892011, 17847.73228401575, 17909.731354029685, 16305.673886522292, 16670.0, 17499.300027998866, 17527.73708394375, 17542.473725788215, 5161.0, 5327.946720532803, 5336.43967383423, 5355.866103347428, 5358.517733403993, 3670.504481894937, 5223.817166399177, 5843.5033022193165, 6133.386661333876, 6160.229971253593, 5963.731632076567, 6169.7532098716, 6193.0710393440895, 6198.535109866755, 6208.472279856218, 6146.262448506163, 6161.075838624198, 6231.844203894893, 6255.530835187356, 6262.185915830958, 3294.225856923621, 5046.44489106198, 5353.116735738598, 5387.838364849061, 5404.567634589223, 19719.40841774749, 20480.69278960817, 20532.281370151974, 20630.896845515825, 20636.5872682547, 2013.7180794688754, 2044.570640165567, 2047.2322878920404, 2099.464636517678, 2117.3965419855267, 12987.220766754024, 13111.737765244641, 13284.800727989088, 13352.198868067948, 13707.314634268347, 1757.0775342945055, 1803.8196180381988, 1816.5821860971919, 1819.5360183153343, 1833.8716289859715, 66438.66780666113, 68492.65753671249, 68550.65724671345, 68657.0, 69432.0, 8502.489850608983, 8647.654093836176, 9574.686049242737, 9734.172595329477, 9880.950595246977, 13324.333783310796, 13486.93256533711, 13499.932500337633, 13506.0, 13517.729645407037, 7037.0, 7145.857082858313, 7617.428692848059, 7692.653830577638, 7697.384209263358, 7086.822829429202, 7304.196538380774, 7345.669444874993, 7445.664945077485, 7446.925530744732, 6122.479589234965, 6209.844753881189, 6246.875062498724, 6299.244090709052, 6490.545661803723, 1595.7420250345863, 1596.7066675992482, 1611.7904672392515, 1646.0864220357578, 1696.4316953820362, 949.2738055387634, 993.4933184076028, 1025.369397820335, 1036.8548403223556, 1065.6909496246158, 16165.838341616669, 16936.491905242863, 17062.146892655317, 17184.0, 17711.645767084585, 881.9118088191129, 901.7520181949885, 925.2320573923762, 976.2385339435252, 995.1740055753708, 9065.68270110543, 9516.571754271074, 9536.809263814823, 9555.522223888778, 9561.808763824823, 406335.0, 410542.0, 410761.0, 419558.0, 420591.0, 80682.19317806864, 80794.19205807867, 83620.58189709134, 83841.0, 84588.0, 1031.5203430404897, 1040.2926010312908, 1074.3070719385953, 1078.8921107889305, 1099.1866019145775, 14687.192204428859, 14855.851441485447, 14891.0, 14938.178400187659, 14993.77509337339, 25064.624030639192, 26083.869580651975, 32090.0, 32175.51736723904, 35322.823385882904, 49278.50721492739, 51986.740066299426, 52564.73717631387, 52765.0, 53718.0, 7656.119546252029, 7886.132525422085, 7889.64496597643, 7921.366290696616, 8056.677732890619, 8386.748397548083, 10483.0, 11274.210805243882, 11481.82777258325, 11702.180847340604, 9489.335746497678, 9981.700548983543, 10105.090541851268, 10140.239482039024, 10386.376817390981, 9561.952190239004, 9879.851802223116, 9906.950465247628, 9928.900710992797, 10030.849537256801, 9937.900620993698, 10072.496375181358, 10093.041161089684, 10163.644272450429, 10292.330998485075, 6973.721051157897, 7409.222031686595, 7581.583012934341, 7702.499337543042, 7888.329491993245, 9810.215182785218, 10235.23235757336, 10636.41499717523, 10739.946300268448, 10746.946265268936], "value": 8458.369432057378, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.3578210894552, 1463.6926245488446, 1501.8723408510275, 1661.6261341198233, 1839.3930003098988, 6887.621180835058, 7197.2802719728, 7202.063731714877, 7381.114266288039, 7392.11294644642, 7171.713131474735, 7323.414126869851, 7341.486095973284, 7355.485116041879, 7369.668364923578, 2181.040342249405, 2199.25225423356, 2205.602991461544, 2205.9558808823813, 2207.4481379655085, 2214.9778502215013, 2241.047554789216, 2250.639897616382, 2255.12050300383, 2256.199049337486, 2199.3292045925987, 2202.273249827561, 2228.699125618045, 2230.0856648774006, 2235.675827005083, 2126.8830214338204, 2135.4020874155262, 2148.817350525207, 2155.1271734947372, 2157.5145592241856, 2155.277981876073, 2161.1031421960024, 2162.945926351838, 2166.068590506082, 2167.349795061491, 7218.4225261979445, 7220.0, 7257.45569082321, 7293.5988520631345, 7405.5926924019695, 4317.201317756225, 4458.1306645204195, 4459.509453960061, 4467.508574056884, 4470.307102399133, 2854.100958198161, 2919.9124026279032, 2920.313726274324, 2931.311141881656, 2964.2293003818945, 944.7260294514651, 947.2847999760137, 962.1917589225014, 970.7233438470073, 979.8383266760976, 9634.0, 9696.854547181798, 9703.17523010545, 9714.90285097147, 9748.805023899553, 3864.516935383077, 3968.980155099206, 4020.115574573589, 4025.3156963316305, 4042.3734321180264, 7818.8827167592535, 7885.44801863864, 7892.644830982619, 7897.0, 7905.446618736748, 4361.760103194291, 4422.7346359218545, 4435.800388982439, 4441.20058389493, 4444.377787109807, 3413.9658603414146, 3934.1934903344745, 4093.7339072960162, 4096.303628383182, 4101.200265948171, 3009.5184770436626, 3055.6333240010895, 3066.5553494743135, 3175.6189257289275, 3188.713015828587, 979.4123525884555, 1047.1884289675563, 1050.4695128959827, 1050.8318669012922, 1065.9520321585546, 786.8741001439856, 796.1719811396199, 805.3557154276673, 847.9533625650648, 895.3150839607705, 4946.530079642428, 5055.418626857959, 5219.086659834514, 5231.790728370823, 5253.711045892513, 407.04141746187304, 410.68172166571145, 415.84198004758605, 418.03434067304624, 419.1135747893245, 3574.0350105471375, 3590.3716849551224, 3652.4521321801412, 3675.852965881388, 3707.14735610811, 8276.08963014068, 8675.913240867636, 8679.349048821363, 8687.174718401868, 8766.474011559327, 8307.958460207661, 8680.479171249744, 8705.825883482295, 8707.956460217658, 8726.781830454163, 6670.232923213893, 6698.39714425704, 6739.359760822714, 6769.627670478171, 6790.287019862843, 4955.925661115014, 4997.475265097112, 5031.899362012812, 5078.822241221539, 5085.084684756779, 8057.959710201411, 8091.716789912325, 8138.023437187576, 8210.261076503144, 8266.297364724065, 7955.24425179607, 8217.424780265324, 8221.424500284922, 8284.83430331402, 8539.060703322753, 5866.3547009828035, 6266.655333956676, 6327.240731112296, 6399.712012959335, 6419.679016049272, 7026.683799229149, 7239.819004524929, 7247.673854676657, 7251.637418128967, 7256.2743725627015, 6415.422611964946, 6466.191726034246, 6519.054737063194, 6554.31179726141, 6616.106825578678, 6334.1765570475545, 6477.352264773485, 6507.089007539043, 6537.28089910119, 6646.102776125162, 6228.159198508143, 6246.968765156145, 6279.560430769985, 6285.402886725754, 6289.49684025286, 4313.7843107843855, 4392.604665580113, 4416.498390547229, 4449.532799056053, 4476.239039363251, 4413.22768515515, 4420.823167073281, 4511.323301504669, 4532.229520981507, 4557.567031132037], "value": 3884.6924726826383, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.2197972100168, 312.6701330096748, 317.42545991754923, 319.1860755074562, 320.07338754306284, 4838.491958344376, 4850.6847054941445, 4873.926891096637, 4897.877553061171, 4902.142125128106, 4821.855344339667, 4824.903501929959, 4846.975765121169, 4862.416510018803, 4871.634627402941, 3651.3427583035045, 3774.622537746231, 3776.7356285060055, 3867.7872717000555, 3872.5740168581433, 3812.0850995760957, 3843.1545060086737, 3849.7690138591634, 3850.249201405727, 3869.961300387002, 3673.742838001341, 3837.846486140551, 3847.941816000608, 3848.2495913296916, 3854.2291541691634, 3718.9442158367647, 3779.8866034019024, 3786.6970642348547, 3786.769299977491, 3835.616438356184, 3366.562346894888, 3377.8142202179115, 3381.628020917697, 3381.7970921744527, 3393.151712071982, 4566.10960862632, 4577.061702351043, 4581.587657110876, 4583.922778147133, 4588.564086411786, 4207.873763787091, 4328.480582330109, 4344.435223420966, 4359.387026800073, 4367.0, 4996.600951733521, 5010.574101201402, 5024.221245706921, 5034.798608055673, 5039.370078740158, 3708.1100535871465, 3709.1283548366114, 3720.4605332226947, 3729.850805967758, 3732.7387082904206, 5009.799608015675, 5303.912697896922, 5313.1764576490705, 5324.334458192726, 5343.305370301836, 3641.617630148849, 3662.560492740888, 3678.786000619789, 3680.7239457040296, 3680.9509289852263, 3733.663970242637, 3756.38019726742, 3757.6242375762754, 3768.437462525509, 3768.660820526166, 4274.572542745701, 4282.614564689193, 4321.222180007629, 4324.718893271927, 4333.848315308949, 5022.648414610942, 5074.213496907985, 5093.381944683291, 5108.438071812097, 5109.642325037212, 1232.778099942019, 1239.5661518468464, 1242.2298175131477, 1242.5837344489696, 1242.8570714367784, 807.4751411582401, 836.2431999040878, 862.9956850215709, 869.3175856952262, 871.9972032163063, 4280.914381712349, 4288.335308027198, 4306.82772689089, 4311.784410779511, 4325.286327755948, 5031.0, 5055.595552355876, 5074.0, 5090.720010399389, 5107.591392688576, 4108.055147316134, 4222.809973551198, 4251.766152861623, 4291.2275790358035, 4293.69944103916, 2683.9463210735676, 2705.91882243533, 2708.7832973362083, 2717.4972630063503, 2718.143784707811, 4705.576498115186, 4753.241300718756, 4782.354382158364, 4783.306420568998, 4783.976080119577, 4859.837372369262, 5162.380514338303, 5193.428722840485, 5198.402183748917, 5214.139666954986, 4758.287775967665, 4767.284907263938, 4770.115804257299, 4773.64197685175, 4797.496262892416, 4954.455009948831, 4981.277714731416, 5008.295520418933, 5009.323741295024, 5034.672746271481, 4861.51384861511, 4918.926216106833, 4942.703437793743, 4985.82833034244, 5211.270422140828, 4970.353853998957, 4976.2038073908, 4977.303177555217, 4989.575886049582, 4990.476000019946, 3698.1863989922176, 3699.427743209179, 3702.333579955634, 3729.0, 3739.682127019234, 5124.9743751281, 5294.814681486129, 5307.256984022163, 5316.627836051439, 5332.786688532416, 5080.187170052774, 5080.212567052113, 5102.2346648003095, 5115.232715092766, 5124.692518448905, 5081.983603279285, 5103.515166059218, 5110.514501122388, 5117.8464646060675, 5137.409197942285, 4745.0, 5012.3233363495465, 5017.724025178651, 5025.673331233458, 5044.520770526794, 4916.631252655993, 4969.900601988013, 5036.622253330942, 5143.936290330597, 5159.845204643867, 5027.874303142451, 5038.496150384932, 5051.292819005269, 5056.064628043824, 5062.645614807076], "value": 3803.0034204247836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9193942696589, 767.2442643995665, 774.1484367196082, 792.8493586218615, 800.951942883427, 10851.403172825492, 11619.941900290507, 11628.767424651502, 11654.533818647255, 11678.299302041873, 12303.200291981015, 12326.63020109396, 12433.254004759721, 12466.688332791662, 12526.123171378007, 661.5501459007872, 843.5992903370911, 858.7552547523957, 859.4843094143527, 860.27736701171, 851.7529916324258, 872.9170728780756, 873.1137895036543, 878.8462019146656, 881.422668152358, 912.8813254276968, 915.2860768600502, 918.1415376622846, 918.2699753695795, 918.4168053286178, 699.6431819771902, 721.3003386714878, 908.9000209976897, 910.6676063236904, 910.6994691751772, 527.4646234072419, 528.3976267055559, 652.0284775684196, 667.0, 667.9532432729711, 12156.51373945041, 12199.207051541622, 12202.084843636674, 12223.08326875479, 12227.082968777288, 11213.439328033566, 12182.147249692525, 12193.817092743617, 12213.877861221452, 12754.936225318814, 10649.148068154529, 10671.83992240117, 11252.887471125267, 11299.548018079267, 11321.433928303633, 4040.393940908858, 4094.754314741125, 4122.464079669624, 4137.379393091061, 4164.646005089571, 40926.38610420846, 41208.38187427191, 41231.38152927708, 41292.79353603213, 41316.38025429621, 9835.557399917021, 10031.347962382422, 10052.045055719695, 10621.256512044083, 10650.627228046982, 17280.913595431943, 17348.39280625172, 17361.7395739064, 17409.738853917203, 17562.912185438992, 6464.838379040468, 6497.382748638872, 6577.440917521969, 6615.933840661628, 6628.5360024798765, 3461.2039230977016, 3561.679448849616, 3615.7649752765988, 3677.0807298175455, 3679.0, 2634.73652634735, 2734.53512902807, 2739.767104802847, 2740.0135951057605, 2742.602322663203, 505.3329604921468, 512.3851378345926, 513.9922901156485, 534.5242733966772, 537.3846945247748, 520.4587229281581, 534.6337758635348, 542.4954792043359, 551.2530521143873, 568.1619611073634, 7337.70649174027, 7394.667239974214, 7414.369778568775, 7546.5094768840945, 7609.581473019037, 528.2472476720658, 564.8898464799324, 605.1950905295946, 610.3804638292137, 610.8106486989047, 3397.1507123219194, 3542.8405721742583, 3563.982180089083, 3571.714262858965, 3680.190358121209, 48598.0, 50241.748791255806, 50323.24515132276, 50516.0, 50692.74653626782, 43857.56142438599, 46259.53740462619, 46847.76576117097, 47059.294110588366, 47684.52315476801, 38992.6100738989, 40262.79868600638, 42087.78956105261, 43930.56069439265, 45558.31662524999, 7972.960135199287, 8012.158723333966, 8102.311303539265, 8197.590120493833, 8252.46358986664, 27872.721272787825, 28543.857280714295, 28609.14172574826, 28727.425451490435, 29232.41535169327, 32538.511922321657, 35989.46015809713, 36779.0, 37174.814125929195, 37581.24837503289, 9727.221822254343, 10477.161827053666, 10478.738031548968, 10596.470176491299, 10613.416262105658, 10348.53431595595, 10613.628523001658, 11096.722581935515, 11373.033292170257, 11465.770684586094, 8089.2315230053055, 10652.360858348524, 10762.300450470695, 10918.454077296263, 11603.593874214363, 10612.522436490222, 10671.199660025373, 10969.780604387708, 11025.83461248098, 11706.473208705458, 10224.446345782831, 10348.482575871025, 10429.582816687247, 10662.466876656292, 10933.398663073607, 9103.453792772454, 9380.906190938003, 9632.229421646392, 9666.903330966881, 9672.468014259282, 10015.899841001497, 10038.899611003797, 10058.748531286483, 10187.592496300065, 10188.0], "value": 5893.252252174506, "unit": "score"}], "name": "dromaeo_css", "value": 6291.4697918218435, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 152.0, 226.0, 136.0, 154.0, 166.0, 138.0, 183.0, 129.0], "value": 157.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 160.0, 161.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 157.0, 77.0, 76.0, 77.0, 76.0, 130.0, 76.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 159.0, 92.0, 93.0, 92.0, 124.0, 92.0, 92.0, 128.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 65.0, 67.0, 67.0, 68.0, 66.0, 66.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 81.0, 81.0, 83.0, 82.0, 82.0, 84.0, 145.0, 82.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 131.0, 141.0, 128.0, 128.0, 134.0, 132.0, 134.0, 156.0, 133.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 172.0, 178.0, 173.0, 179.0, 175.0, 177.0, 176.0, 173.0, 177.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 70.0, 67.0, 69.0, 68.0, 68.0, 67.0, 70.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1583.4000000000005, "alertThreshold": 2.0}]} 03:49:35 INFO - Return code: 0 03:49:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:49:35 ERROR - # TBPL SUCCESS # 03:49:35 INFO - Running post-action listener: _resource_record_post_action 03:49:35 INFO - ##### 03:49:35 INFO - ##### Finished run-tests step (success) 03:49:35 INFO - ##### 03:49:35 INFO - Running post-run listener: _resource_record_post_run 03:49:36 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 10526720; Write bytes: 426856448; Read time: 2428; Write time: 271320 03:49:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 143867904; Read time: 16; Write time: 95900 03:49:36 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8761344; Write bytes: 282988544; Read time: 2364; Write time: 175420 03:49:36 INFO - Running post-run listener: _upload_blobber_files 03:49:36 INFO - Blob upload gear active. 03:49:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:36 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 03:49:36 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'] 03:49:36 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 03:49:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:49:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:49:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:37 INFO - (blobuploader) - INFO - Done attempting. 03:49:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:49:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:49:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:38 INFO - (blobuploader) - INFO - Done attempting. 03:49:38 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:38 INFO - Return code: 0 03:49:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cde6bda3ccd1e58fa3164f2e456d28667bac3d557aab2be3a2187e4ea9f464b5bd0af4b7c08f9997b0040c0728fb38b3e667d321ec97ba8f73444b7eb2d22cd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70ce5c056dd367a097ac473b28b2cb8207c13cc25516a709ef5d23b8a98d7727f1a64312f02228ac783dc5bfd5063984cbba1fa8b8fc4354bfe93e79c493d1f"} 03:49:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:38 INFO - Contents: 03:49:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cde6bda3ccd1e58fa3164f2e456d28667bac3d557aab2be3a2187e4ea9f464b5bd0af4b7c08f9997b0040c0728fb38b3e667d321ec97ba8f73444b7eb2d22cd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70ce5c056dd367a097ac473b28b2cb8207c13cc25516a709ef5d23b8a98d7727f1a64312f02228ac783dc5bfd5063984cbba1fa8b8fc4354bfe93e79c493d1f"} 03:49:38 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:38 INFO - Copying logs to upload dir... 03:49:38 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.870238 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-05-10 03:49:38.626029) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:49:38.629105) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453 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/cde6bda3ccd1e58fa3164f2e456d28667bac3d557aab2be3a2187e4ea9f464b5bd0af4b7c08f9997b0040c0728fb38b3e667d321ec97ba8f73444b7eb2d22cd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70ce5c056dd367a097ac473b28b2cb8207c13cc25516a709ef5d23b8a98d7727f1a64312f02228ac783dc5bfd5063984cbba1fa8b8fc4354bfe93e79c493d1f"} build_url:https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011072 build_url: 'https://queue.taskcluster.net/v1/task/TLhL812eR1eLkzlzkgxzHQ/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/cde6bda3ccd1e58fa3164f2e456d28667bac3d557aab2be3a2187e4ea9f464b5bd0af4b7c08f9997b0040c0728fb38b3e667d321ec97ba8f73444b7eb2d22cd9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70ce5c056dd367a097ac473b28b2cb8207c13cc25516a709ef5d23b8a98d7727f1a64312f02228ac783dc5bfd5063984cbba1fa8b8fc4354bfe93e79c493d1f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 03:49:38.653876) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:49:38.654212) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462876132.335896-1961453 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004520 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 03:49:38.736788) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:49:38.737147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 03:49:38.737471) ========= ========= Total master_lag: 0.36 =========