builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1456747739.09 results: success (0) buildid: 20160229024416 builduid: 4ec87d55798d4599b156e7b231f1063f revision: 9da51cb4974e03cdd8fa45a34086fe1033abfeaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.094294) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.094738) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.095063) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006500 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.128078) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.131438) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.572510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.572818) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004343 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.622411) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.622710) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.623086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.625484) ========= 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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 04:09:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-02-29 04:09:00 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.805951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.809246) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014480 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.859751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:08:59.860078) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9da51cb4974e03cdd8fa45a34086fe1033abfeaf --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 9da51cb4974e03cdd8fa45a34086fe1033abfeaf --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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 04:09:00,488 truncating revision to first 12 chars 2016-02-29 04:09:00,488 Setting DEBUG logging. 2016-02-29 04:09:00,488 attempt 1/10 2016-02-29 04:09:00,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9da51cb4974e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 04:09:00,946 unpacking tar archive at: fx-team-9da51cb4974e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:09:00.663812) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 04:09:00.664112) ========= echo 9da51cb4974e03cdd8fa45a34086fe1033abfeaf in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9da51cb4974e03cdd8fa45a34086fe1033abfeaf'] 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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9da51cb4974e03cdd8fa45a34086fe1033abfeaf program finished with exit code 0 elapsedTime=0.003448 script_repo_revision: '9da51cb4974e03cdd8fa45a34086fe1033abfeaf' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 04:09:00.711355) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 04:09:00.711620) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 04:09:00.721107) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-29 04:09:00.721459) ========= /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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:09:01 INFO - MultiFileLogger online at 20160229 04:09:01 in /builds/slave/test 04:09:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:09:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:01 INFO - {'append_to_log': False, 04:09:01 INFO - 'base_work_dir': '/builds/slave/test', 04:09:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:09:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:01 INFO - 'branch': 'Fx-Team-Non-PGO', 04:09:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:01 INFO - 'config_files': ('talos/linux_config.py',), 04:09:01 INFO - 'default_actions': ('clobber', 04:09:01 INFO - 'read-buildbot-config', 04:09:01 INFO - 'download-and-extract', 04:09:01 INFO - 'populate-webroot', 04:09:01 INFO - 'create-virtualenv', 04:09:01 INFO - 'install', 04:09:01 INFO - 'run-tests'), 04:09:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:01 INFO - 'download_minidump_stackwalk': True, 04:09:01 INFO - 'download_symbols': 'ondemand', 04:09:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:01 INFO - 'installer_path': 'installer.exe', 04:09:01 INFO - 'log_level': 'info', 04:09:01 INFO - 'log_name': 'talos', 04:09:01 INFO - 'log_to_console': True, 04:09:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:09:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:09:01 INFO - 'opt_config_files': (), 04:09:01 INFO - 'pip_index': False, 04:09:01 INFO - 'sps_profile': False, 04:09:01 INFO - 'sps_profile_interval': 0, 04:09:01 INFO - 'suite': 'dromaeojs', 04:09:01 INFO - 'system_bits': '32', 04:09:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:01 INFO - 'title': 'talos-linux64-ix-021', 04:09:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:01 INFO - 'use_talos_json': True, 04:09:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:01 INFO - 'work_dir': 'build'} 04:09:01 INFO - ##### 04:09:01 INFO - ##### Running clobber step. 04:09:01 INFO - ##### 04:09:01 INFO - Running pre-action listener: _resource_record_pre_action 04:09:01 INFO - Running main action method: clobber 04:09:01 INFO - rmtree: /builds/slave/test/build 04:09:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:01 INFO - Running post-action listener: _resource_record_post_action 04:09:01 INFO - ##### 04:09:01 INFO - ##### Running read-buildbot-config step. 04:09:01 INFO - ##### 04:09:01 INFO - Running pre-action listener: _resource_record_pre_action 04:09:01 INFO - Running main action method: read_buildbot_config 04:09:01 INFO - Using buildbot properties: 04:09:01 INFO - { 04:09:01 INFO - "project": "", 04:09:01 INFO - "product": "firefox", 04:09:01 INFO - "script_repo_revision": "production", 04:09:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:09:01 INFO - "repository": "", 04:09:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:09:01 INFO - "buildid": "20160229024416", 04:09:01 INFO - "pgo_build": "False", 04:09:01 INFO - "basedir": "/builds/slave/test", 04:09:01 INFO - "buildnumber": 1473, 04:09:01 INFO - "slavename": "talos-linux64-ix-021", 04:09:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:09:01 INFO - "platform": "ubuntu64_hw", 04:09:01 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:09:01 INFO - "branch": "fx-team", 04:09:01 INFO - "repo_path": "integration/fx-team", 04:09:01 INFO - "revision": "9da51cb4974e03cdd8fa45a34086fe1033abfeaf", 04:09:01 INFO - "stage_platform": "linux64", 04:09:01 INFO - "builduid": "4ec87d55798d4599b156e7b231f1063f", 04:09:01 INFO - "slavebuilddir": "test" 04:09:01 INFO - } 04:09:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 04:09:01 INFO - Running post-action listener: _resource_record_post_action 04:09:01 INFO - ##### 04:09:01 INFO - ##### Running download-and-extract step. 04:09:01 INFO - ##### 04:09:01 INFO - Running pre-action listener: _resource_record_pre_action 04:09:01 INFO - Running main action method: download_and_extract 04:09:01 INFO - mkdir: /builds/slave/test/build/tests 04:09: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')]} 04:09:01 INFO - https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:09:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/test_packages.json 04:09:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/test_packages.json 04:09:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:09:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:09:02 INFO - Downloaded 1448 bytes. 04:09:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:09:02 INFO - Using the following test package requirements: 04:09:02 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:09:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:09:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'jsshell-linux-x86_64.zip'], 04:09:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:09:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:09:02 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:09:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:09:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 04:09:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 04:09:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:09:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:02 INFO - https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:09:06 INFO - Downloaded 22057460 bytes. 04:09:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:09:08 INFO - Return code: 0 04:09:08 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:08 INFO - https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:09:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:09:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:09:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 04:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:09:11 INFO - Downloaded 22057460 bytes. 04:09:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:09:12 INFO - Return code: 0 04:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:12 INFO - https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 04:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:09:14 INFO - Downloaded 10713410 bytes. 04:09:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:09:14 INFO - Return code: 0 04:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:14 INFO - https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:09:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:09:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:09:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:09:16 INFO - Downloaded 54837983 bytes. 04:09:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:09:16 INFO - mkdir: /builds/slave/test/properties 04:09:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:16 INFO - Contents: 04:09:16 INFO - build_url:https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 04:09:17 INFO - Running post-action listener: _resource_record_post_action 04:09:17 INFO - Running post-action listener: set_extra_try_arguments 04:09:17 INFO - ##### 04:09:17 INFO - ##### Running populate-webroot step. 04:09:17 INFO - ##### 04:09:17 INFO - Running pre-action listener: _resource_record_pre_action 04:09:17 INFO - Running main action method: populate_webroot 04:09:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:17 INFO - '--tppagecycles', 04:09:17 INFO - '7'], 04:09:17 INFO - 'tests': ['tsvgm']}}, 04:09:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:09:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:09:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'tests': ['damp', 'tps']}, 04:09:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['damp', 'tps']}, 04:09:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:09:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:17 INFO - 'other': {'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore']}, 04:09:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore']}, 04:09:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore']}, 04:09:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore']}, 04:09:17 INFO - 'other_l64': {'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore']}, 04:09:17 INFO - 'other_nol64': {'tests': ['a11yr', 04:09:17 INFO - 'ts_paint', 04:09:17 INFO - 'tpaint', 04:09:17 INFO - 'sessionrestore', 04:09:17 INFO - 'sessionrestore_no_auto_restore']}, 04:09:17 INFO - 'svgr': {'tests': ['tsvgx', 04:09:17 INFO - 'tsvgr_opacity', 04:09:17 INFO - 'tart', 04:09:17 INFO - 'tscrollx', 04:09:17 INFO - 'cart']}, 04:09:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['tsvgx', 04:09:17 INFO - 'tsvgr_opacity', 04:09:17 INFO - 'tart', 04:09:17 INFO - 'tscrollx', 04:09:17 INFO - 'cart']}, 04:09:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'tests': ['tp5o']}, 04:09:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--e10s'], 04:09:17 INFO - 'tests': ['tp5o']}, 04:09:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--xperf_path', 04:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:17 INFO - 'tests': ['tp5n']}, 04:09:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:17 INFO - 'talos_options': ['--e10s', 04:09:17 INFO - '--xperf_path', 04:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:17 INFO - 'tests': ['tp5n']}}, 04:09:17 INFO - 'talos.zip': {'path': '', 04:09:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:17 INFO - Running post-action listener: _resource_record_post_action 04:09:17 INFO - ##### 04:09:17 INFO - ##### Running create-virtualenv step. 04:09:17 INFO - ##### 04:09:17 INFO - Running pre-action listener: _resource_record_pre_action 04:09:17 INFO - Running main action method: create_virtualenv 04:09:17 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:09:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:17 INFO - Using real prefix '/usr' 04:09:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:19 INFO - Installing pip.................done. 04:09:19 INFO - Return code: 0 04:09:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:09:19 INFO - Using env: {'DISPLAY': ':0', 04:09:19 INFO - 'HOME': '/home/cltbld', 04:09:19 INFO - 'LANG': 'en_US.UTF-8', 04:09:19 INFO - 'LANGUAGE': 'en_US:en', 04:09:19 INFO - 'LOGNAME': 'cltbld', 04:09:19 INFO - 'MAIL': '/var/mail/cltbld', 04:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:19 INFO - 'MOZ_NO_REMOTE': '1', 04:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:19 INFO - 'NO_EM_RESTART': '1', 04:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:19 INFO - 'PWD': '/builds/slave/test', 04:09:19 INFO - 'SHELL': '/bin/bash', 04:09:19 INFO - 'SHLVL': '1', 04:09:19 INFO - 'TERM': 'linux', 04:09:19 INFO - 'TMOUT': '86400', 04:09:19 INFO - 'USER': 'cltbld', 04:09:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:19 INFO - '_': '/tools/buildbot/bin/python'} 04:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:09:19 INFO - Cleaning up... 04:09:19 INFO - Return code: 0 04:09:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:09:19 INFO - Using env: {'DISPLAY': ':0', 04:09:19 INFO - 'HOME': '/home/cltbld', 04:09:19 INFO - 'LANG': 'en_US.UTF-8', 04:09:19 INFO - 'LANGUAGE': 'en_US:en', 04:09:19 INFO - 'LOGNAME': 'cltbld', 04:09:19 INFO - 'MAIL': '/var/mail/cltbld', 04:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:19 INFO - 'MOZ_NO_REMOTE': '1', 04:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:19 INFO - 'NO_EM_RESTART': '1', 04:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:19 INFO - 'PWD': '/builds/slave/test', 04:09:19 INFO - 'SHELL': '/bin/bash', 04:09:19 INFO - 'SHLVL': '1', 04:09:19 INFO - 'TERM': 'linux', 04:09:19 INFO - 'TMOUT': '86400', 04:09:19 INFO - 'USER': 'cltbld', 04:09:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:19 INFO - '_': '/tools/buildbot/bin/python'} 04:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:20 INFO - Downloading/unpacking psutil>=0.7.1 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:21 INFO - Installing collected packages: psutil 04:09:21 INFO - Running setup.py install for psutil 04:09:22 INFO - building 'psutil._psutil_linux' extension 04:09:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:09:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:09:22 INFO - building 'psutil._psutil_posix' extension 04:09:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:09:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:09:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:22 INFO - Successfully installed psutil 04:09:22 INFO - Cleaning up... 04:09:22 INFO - Return code: 0 04:09:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:22 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:09:22 INFO - Using env: {'DISPLAY': ':0', 04:09:22 INFO - 'HOME': '/home/cltbld', 04:09:22 INFO - 'LANG': 'en_US.UTF-8', 04:09:22 INFO - 'LANGUAGE': 'en_US:en', 04:09:22 INFO - 'LOGNAME': 'cltbld', 04:09:22 INFO - 'MAIL': '/var/mail/cltbld', 04:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:22 INFO - 'MOZ_NO_REMOTE': '1', 04:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:22 INFO - 'NO_EM_RESTART': '1', 04:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:22 INFO - 'PWD': '/builds/slave/test', 04:09:22 INFO - 'SHELL': '/bin/bash', 04:09:22 INFO - 'SHLVL': '1', 04:09:22 INFO - 'TERM': 'linux', 04:09:22 INFO - 'TMOUT': '86400', 04:09:22 INFO - 'USER': 'cltbld', 04:09:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:22 INFO - '_': '/tools/buildbot/bin/python'} 04:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:24 INFO - Installing collected packages: mozsystemmonitor 04:09:24 INFO - Running setup.py install for mozsystemmonitor 04:09:24 INFO - Successfully installed mozsystemmonitor 04:09:24 INFO - Cleaning up... 04:09:24 INFO - Return code: 0 04:09:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:24 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:09:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:09:24 INFO - Using env: {'DISPLAY': ':0', 04:09:24 INFO - 'HOME': '/home/cltbld', 04:09:24 INFO - 'LANG': 'en_US.UTF-8', 04:09:24 INFO - 'LANGUAGE': 'en_US:en', 04:09:24 INFO - 'LOGNAME': 'cltbld', 04:09:24 INFO - 'MAIL': '/var/mail/cltbld', 04:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:24 INFO - 'MOZ_NO_REMOTE': '1', 04:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:24 INFO - 'NO_EM_RESTART': '1', 04:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:24 INFO - 'PWD': '/builds/slave/test', 04:09:24 INFO - 'SHELL': '/bin/bash', 04:09:24 INFO - 'SHLVL': '1', 04:09:24 INFO - 'TERM': 'linux', 04:09:24 INFO - 'TMOUT': '86400', 04:09:24 INFO - 'USER': 'cltbld', 04:09:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:24 INFO - '_': '/tools/buildbot/bin/python'} 04:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:24 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:27 INFO - Downloading docopt-0.6.1.tar.gz 04:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:27 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:27 INFO - Running setup.py install for blobuploader 04:09:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:27 INFO - Running setup.py install for requests 04:09:27 INFO - Running setup.py install for docopt 04:09:28 INFO - Successfully installed blobuploader requests docopt 04:09:28 INFO - Cleaning up... 04:09:28 INFO - Return code: 0 04:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:28 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:09:28 INFO - Using env: {'DISPLAY': ':0', 04:09:28 INFO - 'HOME': '/home/cltbld', 04:09:28 INFO - 'LANG': 'en_US.UTF-8', 04:09:28 INFO - 'LANGUAGE': 'en_US:en', 04:09:28 INFO - 'LOGNAME': 'cltbld', 04:09:28 INFO - 'MAIL': '/var/mail/cltbld', 04:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:28 INFO - 'MOZ_NO_REMOTE': '1', 04:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:28 INFO - 'NO_EM_RESTART': '1', 04:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:28 INFO - 'PWD': '/builds/slave/test', 04:09:28 INFO - 'SHELL': '/bin/bash', 04:09:28 INFO - 'SHLVL': '1', 04:09:28 INFO - 'TERM': 'linux', 04:09:28 INFO - 'TMOUT': '86400', 04:09:28 INFO - 'USER': 'cltbld', 04:09:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:28 INFO - '_': '/tools/buildbot/bin/python'} 04:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:28 INFO - Running setup.py (path:/tmp/pip-v0Ol5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:28 INFO - Running setup.py (path:/tmp/pip-MoStvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:28 INFO - Running setup.py (path:/tmp/pip-EznzlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:28 INFO - Running setup.py (path:/tmp/pip-sYIDQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:28 INFO - Running setup.py (path:/tmp/pip-M2qwUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:28 INFO - Running setup.py (path:/tmp/pip-Tkj21s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:28 INFO - Running setup.py (path:/tmp/pip-uUbpqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:28 INFO - Running setup.py (path:/tmp/pip-OHH0Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:28 INFO - Running setup.py (path:/tmp/pip-GNfGxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:28 INFO - Running setup.py (path:/tmp/pip-Q7ZlO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:28 INFO - Running setup.py (path:/tmp/pip-RQHPb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:29 INFO - Running setup.py (path:/tmp/pip-jHkuEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:29 INFO - Running setup.py (path:/tmp/pip-FV2aMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:29 INFO - Running setup.py (path:/tmp/pip-rRYSX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:29 INFO - Running setup.py (path:/tmp/pip-wL_Anm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:29 INFO - Running setup.py (path:/tmp/pip-WOYt0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:29 INFO - Running setup.py (path:/tmp/pip-N8aiWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:29 INFO - Running setup.py install for manifestparser 04:09:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:29 INFO - Running setup.py install for mozcrash 04:09:29 INFO - Running setup.py install for mozdebug 04:09:29 INFO - Running setup.py install for mozdevice 04:09:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:29 INFO - Running setup.py install for mozfile 04:09:30 INFO - Running setup.py install for mozhttpd 04:09:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Running setup.py install for mozinfo 04:09:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Running setup.py install for mozInstall 04:09:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Running setup.py install for mozleak 04:09:30 INFO - Running setup.py install for mozlog 04:09:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Running setup.py install for moznetwork 04:09:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Running setup.py install for mozprocess 04:09:30 INFO - Running setup.py install for mozprofile 04:09:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Running setup.py install for mozrunner 04:09:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:30 INFO - Running setup.py install for mozscreenshot 04:09:31 INFO - Running setup.py install for moztest 04:09:31 INFO - Running setup.py install for mozversion 04:09:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:31 INFO - Cleaning up... 04:09:31 INFO - Return code: 0 04:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:31 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:09:31 INFO - Using env: {'DISPLAY': ':0', 04:09:31 INFO - 'HOME': '/home/cltbld', 04:09:31 INFO - 'LANG': 'en_US.UTF-8', 04:09:31 INFO - 'LANGUAGE': 'en_US:en', 04:09:31 INFO - 'LOGNAME': 'cltbld', 04:09:31 INFO - 'MAIL': '/var/mail/cltbld', 04:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:31 INFO - 'MOZ_NO_REMOTE': '1', 04:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:31 INFO - 'NO_EM_RESTART': '1', 04:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:31 INFO - 'PWD': '/builds/slave/test', 04:09:31 INFO - 'SHELL': '/bin/bash', 04:09:31 INFO - 'SHLVL': '1', 04:09:31 INFO - 'TERM': 'linux', 04:09:31 INFO - 'TMOUT': '86400', 04:09:31 INFO - 'USER': 'cltbld', 04:09:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:31 INFO - '_': '/tools/buildbot/bin/python'} 04:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:31 INFO - Running setup.py (path:/tmp/pip-v3yLYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:31 INFO - Running setup.py (path:/tmp/pip-FzbJ_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:31 INFO - Running setup.py (path:/tmp/pip-95F77t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:31 INFO - Running setup.py (path:/tmp/pip-X2SiMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:31 INFO - Running setup.py (path:/tmp/pip-HJ0nlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:31 INFO - Running setup.py (path:/tmp/pip-hyil0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:31 INFO - Running setup.py (path:/tmp/pip-i6LPpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:32 INFO - Running setup.py (path:/tmp/pip-rH46nP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:32 INFO - Running setup.py (path:/tmp/pip-44wWiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:32 INFO - Running setup.py (path:/tmp/pip-sbPLF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:32 INFO - Running setup.py (path:/tmp/pip-HGV4O2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:32 INFO - Running setup.py (path:/tmp/pip-15pjXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:32 INFO - Running setup.py (path:/tmp/pip-Ulkzl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:32 INFO - Running setup.py (path:/tmp/pip-dJK8Iq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:32 INFO - Running setup.py (path:/tmp/pip-EQuzUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:32 INFO - Running setup.py (path:/tmp/pip-VQytH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:32 INFO - Running setup.py (path:/tmp/pip-0hy6hl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:09:32 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:32 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:09:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:34 INFO - Downloading blessings-1.6.tar.gz 04:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:34 INFO - Installing collected packages: blessings 04:09:34 INFO - Running setup.py install for blessings 04:09:35 INFO - Successfully installed blessings 04:09:35 INFO - Cleaning up... 04:09:35 INFO - Return code: 0 04:09:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:35 INFO - Reading from file tmpfile_stdout 04:09:35 INFO - Current package versions: 04:09:35 INFO - argparse == 1.2.1 04:09:35 INFO - blessings == 1.6 04:09:35 INFO - blobuploader == 1.2.4 04:09:35 INFO - docopt == 0.6.1 04:09:35 INFO - manifestparser == 1.1 04:09:35 INFO - mozInstall == 1.12 04:09:35 INFO - mozcrash == 0.16 04:09:35 INFO - mozdebug == 0.1 04:09:35 INFO - mozdevice == 0.48 04:09:35 INFO - mozfile == 1.2 04:09:35 INFO - mozhttpd == 0.7 04:09:35 INFO - mozinfo == 0.9 04:09:35 INFO - mozleak == 0.1 04:09:35 INFO - mozlog == 3.1 04:09:35 INFO - moznetwork == 0.27 04:09:35 INFO - mozprocess == 0.22 04:09:35 INFO - mozprofile == 0.28 04:09:35 INFO - mozrunner == 6.11 04:09:35 INFO - mozscreenshot == 0.1 04:09:35 INFO - mozsystemmonitor == 0.0 04:09:35 INFO - moztest == 0.7 04:09:35 INFO - mozversion == 1.4 04:09:35 INFO - psutil == 3.1.1 04:09:35 INFO - requests == 1.2.3 04:09:35 INFO - wsgiref == 0.1.2 04:09:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:35 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:09:35 INFO - Using env: {'DISPLAY': ':0', 04:09:35 INFO - 'HOME': '/home/cltbld', 04:09:35 INFO - 'LANG': 'en_US.UTF-8', 04:09:35 INFO - 'LANGUAGE': 'en_US:en', 04:09:35 INFO - 'LOGNAME': 'cltbld', 04:09:35 INFO - 'MAIL': '/var/mail/cltbld', 04:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:35 INFO - 'MOZ_NO_REMOTE': '1', 04:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:35 INFO - 'NO_EM_RESTART': '1', 04:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:35 INFO - 'PWD': '/builds/slave/test', 04:09:35 INFO - 'SHELL': '/bin/bash', 04:09:35 INFO - 'SHLVL': '1', 04:09:35 INFO - 'TERM': 'linux', 04:09:35 INFO - 'TMOUT': '86400', 04:09:35 INFO - 'USER': 'cltbld', 04:09:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:35 INFO - '_': '/tools/buildbot/bin/python'} 04:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:09:35 INFO - Cleaning up... 04:09:35 INFO - Return code: 0 04:09:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:09:35 INFO - Using env: {'DISPLAY': ':0', 04:09:35 INFO - 'HOME': '/home/cltbld', 04:09:35 INFO - 'LANG': 'en_US.UTF-8', 04:09:35 INFO - 'LANGUAGE': 'en_US:en', 04:09:35 INFO - 'LOGNAME': 'cltbld', 04:09:35 INFO - 'MAIL': '/var/mail/cltbld', 04:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:35 INFO - 'MOZ_NO_REMOTE': '1', 04:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:35 INFO - 'NO_EM_RESTART': '1', 04:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:35 INFO - 'PWD': '/builds/slave/test', 04:09:35 INFO - 'SHELL': '/bin/bash', 04:09:35 INFO - 'SHLVL': '1', 04:09:35 INFO - 'TERM': 'linux', 04:09:35 INFO - 'TMOUT': '86400', 04:09:35 INFO - 'USER': 'cltbld', 04:09:35 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:35 INFO - '_': '/tools/buildbot/bin/python'} 04:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:35 INFO - Downloading/unpacking jsonschema 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:37 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:37 INFO - warning: no files found matching '*.txt' 04:09:37 INFO - no previously-included directories found matching 'build' 04:09:37 INFO - no previously-included directories found matching 'dist' 04:09:37 INFO - no previously-included directories found matching '.git*' 04:09:37 INFO - Installing collected packages: jsonschema, functools32 04:09:37 INFO - Running setup.py install for functools32 04:09:38 INFO - warning: no files found matching '*.txt' 04:09:38 INFO - no previously-included directories found matching 'build' 04:09:38 INFO - no previously-included directories found matching 'dist' 04:09:38 INFO - no previously-included directories found matching '.git*' 04:09:38 INFO - Successfully installed jsonschema functools32 04:09:38 INFO - Cleaning up... 04:09:38 INFO - Return code: 0 04:09:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:38 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 0x7f14287eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29463b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, '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': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:09:38 INFO - Using env: {'DISPLAY': ':0', 04:09:38 INFO - 'HOME': '/home/cltbld', 04:09:38 INFO - 'LANG': 'en_US.UTF-8', 04:09:38 INFO - 'LANGUAGE': 'en_US:en', 04:09:38 INFO - 'LOGNAME': 'cltbld', 04:09:38 INFO - 'MAIL': '/var/mail/cltbld', 04:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:38 INFO - 'MOZ_NO_REMOTE': '1', 04:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:38 INFO - 'NO_EM_RESTART': '1', 04:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:38 INFO - 'PWD': '/builds/slave/test', 04:09:38 INFO - 'SHELL': '/bin/bash', 04:09:38 INFO - 'SHLVL': '1', 04:09:38 INFO - 'TERM': 'linux', 04:09:38 INFO - 'TMOUT': '86400', 04:09:38 INFO - 'USER': 'cltbld', 04:09:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:38 INFO - '_': '/tools/buildbot/bin/python'} 04:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:38 INFO - Downloading/unpacking flake8 04:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:40 INFO - no previously-included directories found matching 'docs/_build' 04:09:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:40 INFO - Running setup.py install for pep8 04:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:40 INFO - no previously-included directories found matching 'docs/_build' 04:09:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:41 INFO - Cleaning up... 04:09:41 INFO - Return code: 0 04:09:41 INFO - Running post-action listener: _resource_record_post_action 04:09:41 INFO - Running post-action listener: _start_resource_monitoring 04:09:41 INFO - Starting resource monitoring. 04:09:41 INFO - ##### 04:09:41 INFO - ##### Running install step. 04:09:41 INFO - ##### 04:09:41 INFO - Running pre-action listener: _resource_record_pre_action 04:09:41 INFO - Running main action method: install 04:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:41 INFO - Reading from file tmpfile_stdout 04:09:41 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:41 INFO - Reading from file tmpfile_stdout 04:09:41 INFO - Output received: 04:09:41 INFO - Usage: mozinstall [options] installer 04:09:41 INFO - Options: 04:09:41 INFO - -h, --help show this help message and exit 04:09:41 INFO - -d DEST, --destination=DEST 04:09:41 INFO - Directory to install application into. [default: 04:09:41 INFO - "/builds/slave/test"] 04:09:41 INFO - --app=APP Application being installed. [default: firefox] 04:09:41 INFO - mkdir: /builds/slave/test/build/application 04:09:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:09:59 INFO - Reading from file tmpfile_stdout 04:09:59 INFO - Output received: 04:09:59 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:59 INFO - Running post-action listener: _resource_record_post_action 04:09:59 INFO - ##### 04:09:59 INFO - ##### Running run-tests step. 04:09:59 INFO - ##### 04:09:59 INFO - Running pre-action listener: _resource_record_pre_action 04:09:59 INFO - Running main action method: run_tests 04:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:59 INFO - Python 2.7.3 04:09:59 INFO - Return code: 0 04:09:59 INFO - grabbing minidump binary from tooltool 04:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:59 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 0x29d5100>, '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 0x29d6000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29d6490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:09:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:09:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:59 INFO - Return code: 0 04:09:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:10:00 INFO - Return code: 0 04:10:00 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/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:10:00 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/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:10:00 INFO - Using env: {'DISPLAY': ':0', 04:10:00 INFO - 'HOME': '/home/cltbld', 04:10:00 INFO - 'LANG': 'en_US.UTF-8', 04:10:00 INFO - 'LANGUAGE': 'en_US:en', 04:10:00 INFO - 'LOGNAME': 'cltbld', 04:10:00 INFO - 'MAIL': '/var/mail/cltbld', 04:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:00 INFO - 'MOZ_NO_REMOTE': '1', 04:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:10:00 INFO - 'NO_EM_RESTART': '1', 04:10:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:00 INFO - 'PWD': '/builds/slave/test', 04:10:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:00 INFO - 'SHELL': '/bin/bash', 04:10:00 INFO - 'SHLVL': '1', 04:10:00 INFO - 'TERM': 'linux', 04:10:00 INFO - 'TMOUT': '86400', 04:10:00 INFO - 'USER': 'cltbld', 04:10:00 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344', 04:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:00 INFO - '_': '/tools/buildbot/bin/python'} 04:10:00 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/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:10:00 INFO - mozversion application_buildid: 20160229024416 04:10:00 INFO - mozversion application_changeset: 9da51cb4974e03cdd8fa45a34086fe1033abfeaf 04:10:00 INFO - mozversion application_display_name: Nightly 04:10:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:00 INFO - mozversion application_name: Firefox 04:10:00 INFO - mozversion application_remotingname: firefox 04:10:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:10:00 INFO - mozversion application_vendor: Mozilla 04:10:00 INFO - mozversion application_version: 47.0a1 04:10:00 INFO - mozversion platform_buildid: 20160229024416 04:10:00 INFO - mozversion platform_changeset: 9da51cb4974e03cdd8fa45a34086fe1033abfeaf 04:10:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:10:00 INFO - mozversion platform_version: 47.0a1 04:10:00 INFO - using testdate: 1456747800 04:10:00 INFO - actual date: 1456747800 04:10:00 INFO - starting webserver on 'localhost:60270' 04:10:00 INFO - SUITE-START | Running 2 tests 04:10:00 INFO - TEST-START | dromaeo_css 04:10:00 INFO - operating with platform_type : linux_ 04:10:00 INFO - Initialising browser for dromaeo_css test... 04:10:00 INFO - TEST-INFO | started process 22736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphXXJx6/profile http://localhost:60270/getInfo.html) 04:10:05 INFO - PROCESS | 22736 | __metrics Screen width/height:1600/1200 04:10:05 INFO - PROCESS | 22736 | colorDepth:24 04:10:05 INFO - PROCESS | 22736 | Browser inner width/height: 1024/697 04:10:05 INFO - PROCESS | 22736 | __metrics 04:10:06 INFO - PROCESS | 22736 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:10:06 INFO - PROCESS | 22736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:10:06 INFO - PROCESS | 22736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:10:06 INFO - PROCESS | 22736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:10:06 INFO - PROCESS | 22736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:10:06 INFO - PROCESS | 22736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:10:06 INFO - PROCESS | 22736 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:10:07 INFO - PROCESS | 22736 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:10:07 INFO - TEST-INFO | 22736: exit 0 04:10:07 INFO - Browser initialized. 04:10:07 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:07 INFO - TEST-INFO | started process 22830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphXXJx6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:19 INFO - PROCESS | 22830 | RSS: Main: 153387008 04:10:19 INFO - PROCESS | 22830 | 04:11:11 INFO - PROCESS | 22830 | 1456747871104 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:13:22 INFO - PROCESS | 22830 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60270/tests/dromaeo/cssquery-ext.html) 04:13:23 INFO - PROCESS | 22830 | RSS: Main: 242561024 04:13:23 INFO - PROCESS | 22830 | 04:16:25 INFO - PROCESS | 22830 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-ext.html (next: http://localhost:60270/tests/dromaeo/cssquery-jquery.html) 04:16:26 INFO - PROCESS | 22830 | RSS: Main: 231034880 04:16:26 INFO - PROCESS | 22830 | 04:19:28 INFO - PROCESS | 22830 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60270/tests/dromaeo/cssquery-mootools.html) 04:19:29 INFO - PROCESS | 22830 | RSS: Main: 235085824 04:19:29 INFO - PROCESS | 22830 | 04:22:31 INFO - PROCESS | 22830 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60270/tests/dromaeo/cssquery-prototype.html) 04:22:31 INFO - PROCESS | 22830 | RSS: Main: 220672000 04:22:31 INFO - PROCESS | 22830 | 04:25:34 INFO - PROCESS | 22830 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60270/tests/dromaeo/cssquery-yui.html) 04:25:34 INFO - PROCESS | 22830 | RSS: Main: 219303936 04:25:34 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | Cycle 1(1): loaded http://localhost:60270/tests/dromaeo/cssquery-yui.html (next: http://localhost:60270/tests/dromaeo/cssquery-dojo.html) 04:28:37 INFO - PROCESS | 22830 | RSS: Main: 291278848 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | __start_tp_report 04:28:37 INFO - PROCESS | 22830 | _x_x_mozilla_page_load 04:28:37 INFO - PROCESS | 22830 | _x_x_mozilla_page_load_details 04:28:37 INFO - PROCESS | 22830 | |i|pagename|runs| 04:28:37 INFO - PROCESS | 22830 | |0;dojo.html;2574.579894898795;2662.534056540105;2679.3435608275963;2679.464107178565;2702.9459410811783;4323.265044942359;4405.03089320349;4499;4510.684252102355;4543.545645435459;4497.437820272466;4510.616597589209;4547.840825571106;4554.79503422346;4602.401687780583;4134.917301653965;4168.103857670592;4168.6039826216465;4178.582141785828;4312.633426158764;4009.5389030261454;4245.108527209274;4274.935875961863;4287.035417031174;4304.1606886656955;4096.91806163878;4147.04617937876;4152.83388664453;4176.1230141669985;4197.076643138505;4117.670586353084;4129.752214867088;4138.110306284133;4138.441310423084;4162.021924847659;4044.5550989391145;4122.670186385082;4124.4019617155645;4129.876103716893;4158.792060396968;4376.803043863002;4442.755648439334;4447.132809102226;4470.038941627533;4485.1254005468945;4769.928451073237;4771.212749896263;4786.688865223749;4790.185668436374;4794.688345257547;4591.885202869921;4797.088553174885;4821.349117869113;4858.514148585114;4874.7562621868765;4421.439868318654;4438.822447102079;4439.267520859086;4443.888902777457;4479.148961697267;4856.39295088114;4864.148773964542;4864.975675121673;4869.756512174377;4917.729524876095;4578.427696537933;4623.768811559408;4708.4820669726305;4722;4722.456917454468;4753.04939012199;4754.833580824655;4757.14371413142;4777.641676874179;4810.855674329776;4718.3158442025715;4738.289256611467;4741.715497070187;4743.430788305425;4782.0914026334885;4609.884752881205;4722.386089808303;4770.045990801854;4800.207965685692;4813.205821039489;4023.3361495353524;4027.8187481562813;4029.234445455354;4043.636072753466;4064.248114098842;3485.5294535237417;3563.0914116900026;3563.750537462353;3589.8743543975834;3594.281143771256;4070.4708387909973;4097.078157414618;4128.896777580524;4170.332746760504;4172.374143878443;4753.5959443447;4755.310479980383;4761.857144285677;4765.451973023078;4816.662833601685;3981.581933896899;4094.979525102415;4096.774677392772;4123.628873401408;4131.731437456556;4327.956720432819;4362.738235705868;4365.367021781887;4384.736915784999;4405.449318835145;4465.531119232433;4481.282994720829;4503.774811259358;4517.909641807211;4537.863864084083;4653.069386122721;4747.952520474751;4755.500672429345;4778.617710583076;4789.521047895182;4576.244919588231;4595.690228285056;4598.241290187082;4599.149157405891;4639.536046395334;4774.307725379731;4786.353842231254;4793.5685788279225;4798.5441383068555;4814.518548145157;4618.353430519797;4738.668293219442;4800;4857.198562237191;4874.756262186947;4635.745034023161;4654.627629789541;4655.371524844103;4678.438587369537;4707.223308154116;4642.303654451859;4648;4651.348811166372;4653.930191047205;4696.483386827515;4448.332750087513;4520.118576877478;4549.499555049008;4598.26427771555;4600.102979918884;4629.699069560468;4641.094986477605;4641.303804429363;4663.300504924288;4679.321498382647;4573.656975726901;4576.061907308927;4580.931286030645;4615.699979501322;4633.536646335339 04:28:37 INFO - PROCESS | 22830 | |1;ext.html;479.28107838242613;497.8357142143093;506.38980029064976;528.5507318779038;533.5891363649991;24940.25179244621;25347.873260633693;33138.1715457114;33409.498857517094;33443.49834752481;38013.61986380135;38636.420453693216;38660;38660.420093698616;38682.61317386825;6768.323167683241;7657.655405506752;7858.332041776456;7869.567173805438;9427.48148851813;9705.078017588317;9851.65519206828;9853.211743060574;9858.014198580157;9867.358621689604;9831.508424578742;9965.701028969142;9967.601295948154;9980.451075190862;9983.101520863122;9795.363301385423;9844.3601165924;9854.113129818315;9890.06044425782;9894.950525247328;9709.805803883954;9775.120239178508;9862.605495780232;9869.950650246774;9990.80018399628;35501.82249088764;35757.46363804545;35822;35862.10344741376;35866.82066589651;2820.3936153727045;2867.584200290967;2880.567914812774;2895.826250424981;2944;28573.42853142946;28648.14055578336;28654.283642908886;29251.853740731374;29414.558781618292;2703.3376822678374;2765.9170224893287;2789.2608458758446;2790.483760504313;2832.985835070832;229985;231374;231909;232153;232529;38849.80575097106;55424.44575554193;55541.72229138829;55956.72021639866;55987.44012559822;37452.25095498075;37608.435873461916;37661.43507847384;37667.62332376696;37689;10821.458927053616;10923.180761442924;10957.83563246552;10964;10988.340699558052;7839.3728501719725;9211.309151813506;9331.673391431403;9338;9366.718998430058;12934.547290844775;12964.870351296555;13053.216806991612;13412.530561430303;13455.394507247198;5386.973065134649;5523.260173045478;5543.168524721244;5571.1086226203615;5571.66570005801;792.5324058805218;817.1542453560536;864.4251572704208;909.3861643390685;983.498415807943;24908.377290567518;25097.749022509906;25693.74306256951;25769.48461030769;25865.612015819777;942.5098948546718;948.2935213266161;965.9855102173473;977.9706608801747;992.0525897767615;13370.46518139283;13440.596782096552;13624;13714.794278085838;13782.65543361404;254547;258133;258661;258703;259245;45249.321260181125;45509.54490455053;45565.544344556794;45988.5401145991;46119;1079.8542196803487;1188.5661733467396;1198.5026214121217;1214.2775048845922;1214.7449035702602;24476.877615611807;25785.226443206735;26342.86828565845;26432.603510947734;26693.733062669126;36015.81992090023;36295.27409451743;36302.8184859074;36365.63634363622;36420.635793641726;146176;149269.25365373102;149908;149916;150223;24328.75671243336;28954.42091158207;29026.854865725538;29268.7073129266;29710.554341685325;33323;33444;34133.48799767956;34209;34241.48637770485;28975;29119.126426207247;29240.853795730884;29332.41335173242;29649;35226.47735226457;36569.08577285589;36725.265494689425;37168.44247336238;37347.81326093352;31371.843140785062;31579;31868.84065579657;36451.27097458089;37079;27459.450810984068;29782.404351913272;30556.541651874795;30557.847210764692;30570.235744106576;23835.404114897265;24023.75976240215;24031;24310.756892431556;24353.269401917973 04:28:37 INFO - PROCESS | 22830 | |2;jquery.html;333.92152844081636;339.9677030682086;344.1705489769655;349.20207326259504;351.29214632515504;14521.564353069412;15120.092794432341;15600.921995390036;15618.453354132607;15662.295196716146;14824.258787060631;14875.181864997421;15099.396024159021;15398.538043858702;15405.460808871692;4894.339264199332;5112.284280200774;5115.130427827278;5122.513361230677;5135.075686376451;4781.976090119562;5039.899202015958;5050.88880446303;5064.898702025957;5065.468125846788;5007.399112106552;5016.899662006757;5022.221555658879;5025;5029.647924645276;4836;4988.152014157602;4992.500749925015;5008.474110218429;5019.598432125421;4819.5180481951875;4828.782704778293;4829.985703002374;4844.2733589961435;4867.318575399447;10558.260921735482;11130.443477826157;11157.163212759075;11158.330500170016;11195.160362972729;1708.6753516831761;1723.8103808581045;1726.249081649474;1769.78762548495;1914.4352416037302;8077.151899050574;8531.146885311482;8885.155910188587;8998.775030624221;9028.187463128284;1708.6545338949386;1723.1298194411868;1749.08173209065;1795.8742887997846;1800.9819901800945;50310;52990.47009529894;53380.54122617327;54702.17946730762;55215.447845521434;9098.59056342453;9324.580393882292;9460.8580871287;9476.336656434121;9622.615095396246;11782.293062416282;11852.70368240801;11862.169648124722;11892.702682433008;11900;6287.14529213883;6365.649889256043;6384.904226436607;6449.774257900951;6454.160959075384;5661.830145095653;5718.313802343745;5791.82624521265;5837.182794408786;5966.313873904556;3985.202959408072;3999.4000899865255;4039.6768258539832;4073.1853629274265;4114.698335024176;1571.277212482271;1663.0305434351544;1686.1653481526478;1693.2041940288045;1700.5068530126125;787.4487858499074;840.9453385529921;841.7348535211511;864.2524216552637;924.713338864954;14857.405703771945;15427.5371738848;15470;15482.84517154814;15503.922480387526;816.7917181118777;819.4100247821559;835.6573804740027;855.2089317381398;870.9303255739652;8619.138086191457;8696.869546956801;8742.082081381363;8771.298296136294;9004.909950900537;362036;372816;378878;379266;379486;39004.60995390067;46405.5359446408;56085;60318.69840650768;61201.38798612046;860.7675927499665;865.6840253307497;890.3500444675424;892.8839250897472;895.3106108296575;13589.184648921097;13776;13960.2321872298;14277;14290.214038227998;28158.43683126285;28788.712112878602;29697.554536681535;29773.851130745075;30269.091927242218;38657.42013869738;40782.388264176654;42353.364699530146;42452.5754742461;42668.57331426646;6874.587524748531;6919.100516932766;6927.411170050401;6987.406070484066;7152;8566.82866342682;10605.946970265099;10746.24776265654;10994.28537145083;11312.886871131182;8246.01047874259;8543.743687689379;8869.512176830336;9171.587278572346;9551.235901128031;8410.6215220314;9419.952900235729;9538.23694104484;9560.569774360032;9592.76018099553;8935.821283574422;9133.178013978773;9223.44659320443;9279.304052196247;9911.801763964824;7009.228984811564;7202.639868006683;7286.96356518214;7395.778126656209;7443.292887175709;9343.859842102238;9395.342326037111;9469.66856160031;9605.502569331884;9643.517824108907 04:28:37 INFO - PROCESS | 22830 | |3;mootools.html;1170.934449650818;1321.6365499487642;1323.6029191242624;1425.8859291256701;1695.3049249807573;6740.69666864991;6861.725530978755;6881.621510816897;6887.896681549768;6916.96541517293;6898.517103802736;7023.824404389893;7037.964810175942;7038.401735852446;7039.366457018868;1652.446430445796;2060.206820374152;2061.1137210999264;2090.550531635698;2109.2090466075224;2061.051916118587;2068.451860257033;2070.6893965905083;2071.4924843413387;2073.3468957278483;2050.3233932802214;2053.7638171610306;2109.3355592988237;2111.324376199617;2114.7779483154277;2050.3131450963947;2050.6001329740707;2057.40335302762;2063.0819285417997;2100.24391219161;2032.5426778974613;2034.6642803937332;2035.4911272181955;2035.908384122718;2040.5306779440664;7229.457790665721;7290.125184977836;7303.525270857377;7303.598302093383;7306.269373062704;4119.691023173274;4221.472315960505;4253.319468884994;4253.617174454314;4259.382389553497;2488.726240113586;2632.802539809522;2636;2639.28739240404;2662.6671666041743;788.5702292250737;816.7263966571206;831.3847752663046;836.5315423362936;851.3529717414748;9686.564104615309;9693.41839489633;9695.127438530495;9702.27232957524;9713.02869713023;3771.26460340231;3876.1278712290073;3950.9604903951167;3957.109650328653;3962.6037396260144;8301.252887240178;8304.584770761438;8338.291245244101;8340.916590834015;8341.332693384515;3375;4276.87169384919;4281.978590107092;4283.5502272260965;4283.764392958417;3749.268892565978;3793.374093274634;3803.8098095095133;3826.942595861064;3834.789086600208;3380.492926061061;3428.9828550857087;3436.8453419596176;3457.3431048101284;3478.443449048191;1059.3802625464036;1060.6476742153816;1067.1676092647747;1073.0771536478621;1078.800421921947;1130.2596799096605;1152.4929031226234;1152.7118220444888;1160.2458402038742;1167.4629670351733;6688.4649228061635;6690.531662783558;6763.053172555846;6784.592924424452;6799.694013769392;963.7638778499313;965.6041023180462;969.9030096990244;980.2843923935567;981.8527220916919;5327.467253274642;5350.277712508761;5398.62209645321;5398.73006349681;5404.621676482687;8415.410921235578;8522.957385213034;8711.738647840448;8869.379143460024;8882.86675699865;8707.39048266628;8738.825223495494;8740.519271440131;8768.167024132825;8790;6676.132102826698;6731.158605174353;6805.489588280899;6897.310268973062;6900.275471075565;6475.611463312216;6489.772857949949;6525.2169739631545;6530.151080359523;6539.509536784665;7530.171681115183;7636.121845987783;7692.8461430772195;7699.153093159636;7723.111842138226;7802.570858602604;7999.880001799861;8001.5999200038605;8083.434159609006;8092.069412017458;4742.454617719007;5561.833145005657;5652.576056795675;5862.149988251595;5950.166976623363;6609.173853268341;6612.8346791330605;6629.933700663125;6658.300878407891;6661.600303981777;5881.382454842351;5886.6173698709445;6017.789377371771;6058.697065146637;6080.452759251689;5805.506531944832;5825.883482330245;5881.206037185097;6114.847128821815;6115.541334400027;6202.81391558254;6296.653684047421;6297.433231009231;6318.684065796784;6351.936480635134;5451.863703407446;5452.591055670761;5455.699936503531;5458.235846981346;5459.153831156177;5810.273715785527;5863.17915491823;5919.378465261086;5962.07587823888;5963.671998039976 04:28:37 INFO - PROCESS | 22830 | |4;prototype.html;280.7304987212276;285.2341463171385;286.23717792084096;291.91680371094236;295.0381755477144;5293.31186945697;5297.549708274796;5349;5360.91958620621;5367.141257398817;5281.524662780349;5293.232481290221;5299.470052994699;5308.203769434586;5315.415304316522;3798.335291324014;3942.5860284670125;4058.8376464941366;4097.815598298083;4103.9794801025955;4068;4084.121913788535;4089.5092588889374;4095.5699651536606;4096.303628383167;3765.359888818907;4050.0482386639264;4057;4058.3100872851537;4063.349864021757;3930.842766289345;4008.7394319369146;4021.195760847842;4045.7977101144825;4057.2088442753675;3526.1008442847165;3526.453399723047;3530.6822385985383;3535.381308271068;3536.2220311531423;5099.847004589868;5100.056489549445;5101.311322971388;5102;5103.872403189913;4632.976835115836;4642.419697537808;4643.8374656886845;4647.23320652092;4653.557911998355;5522.502974732253;5534.0315444797;5535.889282214373;5540.556755459554;5541.27963364764;3846.8461261549505;3849.1339448623835;3856.749311294785;3857.729958902878;3862.517185351831;5585.413531579207;5828.912566311508;5847.970760146172;5851.122331650244;5856;3810.2189051244427;3860.401637746154;3866.6133386661672;3866.709996750255;3868.3423817951016;3916.1580260244186;3917.9020524486546;3921.8235179416993;3924.175923056133;3930.21395720857;4549.727016379028;4556.749378784199;4564.475085365226;4572.199865023607;4578.473475550354;5563.443655634485;5574.940761255349;5575.581831362664;5576.247206627054;5589.413111623221;1357.2942070123481;1372.2246930484243;1378.152436251698;1378.5933149720856;1380.3305396882504;902.255639097747;913.3743385780762;913.8583519554479;927.5176908007799;931.6133804471204;4742;4753;4760.45254795696;4766.546203407925;4767.213409787346;5660.745266463019;5662.688552129673;5667.008273552112;5669.716514174274;5672.432756724377;4778.235482322812;4782.736949467812;4787.138315103315;4789.185838407479;4793.808247670124;3022.803517771382;3055.908322750321;3059.0516939748304;3059.6787337329706;3074.4773388524004;5352.116900711417;5358.30342055538;5359.5712343012465;5359.946400536022;5361.919571206435;5638.774449022075;5837.387074357216;5838.095095260242;5866.472017518444;5896.410358964069;5332.9733351333;5347.545458635982;5348.4116747157;5349.3580770307035;5349.4650534946195;5670.206171136127;5674.205611214351;5677.091665333527;5677.403872593483;5685.715714214355;5539.362973257966;5545.306836645419;5546.750396232099;5546.861328466821;5560.2493663356545;5348.411674715856;5352.223927530564;5355.491228333302;5359.651622644516;5361.946380536145;3751.662350388478;3820.5988371221733;3846.0384903774057;3854.8843534694006;3863.55569109556;5547.445255474582;5701.600887937804;5706.087026075808;5711.086226203787;5723.399043100415;5430.538404235526;5508.338999320107;5510.090835012178;5515.751791169327;5546.084895992116;5517.503424691797;5534.91697624544;5537.750801213874;5620.18507316445;5623.437656234508;5490.890182196414;5502.0921547945745;5505.862353441035;5506.504414602705;5509.347195841312;5606.523445507178;5621.606487545996;5650.971745141248;5654.717264136859;5664.773409063591;5277.973610131925;5457.918131228114;5486.451354864482;5489.752961116839;5525.364583072998 04:28:37 INFO - PROCESS | 22830 | |5;yui.html;545.3428618514689;607.7113371148702;617.8331850400391;626.4744949545012;642.8971364581668;11058.778824423507;11486.253393529414;11494.195406321562;11501.1374146939;11507.021903138244;12831.230126192411;13090.21458712478;13111.54109606164;13133.343332833345;13160.407781649825;753.8077790163514;765.9463837531375;768.6003278295283;768.6387397922967;769.2576663519702;589.3311091910691;753.3031945450464;770.3105720380285;774.7017398301666;775.0196002057402;796.5459687977855;799.1129845871078;799.4084377560622;800.2477670989281;801.6993627389729;617.9258488981307;790.4387884601939;790.517784151667;790.6165509727778;791.2878409431529;580.532671199684;584.1617279204355;589.3016775121451;589.8318979090939;589.932157801854;10593;10670.78658426835;10682.305650132717;10712.78574428507;10731.356118632906;10540.262181647287;10919.181061420426;11094.500747466383;11246.268992515461;11453.942730286295;8525.232729054414;8795.296376289945;9175.357724959256;9176.81646367069;9356.064393560657;2996.131121974625;3046.2384403899027;3061.3418115105137;3066.4480393529157;3129.9687003129907;36238.45642315367;37014.25971480582;37385;37394.06514837151;37483.81258093719;8350.164983501601;8520.701775437954;8534.445261058012;8607.956960215159;8626.396152269406;15890;15995.040297581949;16085.276162572713;16090.597735056483;16094.11482368481;5958.731857066442;5997.850053748692;6017.187679663277;6094.756209751649;6155.322914479404;3159.352332771776;3195.4887218045;3395.864165433355;3406.812625305632;3426.0749597608506;2438.2807071913826;2494.550980823469;2494.6133349330885;2497.27579002091;2497.7876880465;431.84885290148827;438.55924795580876;450.5719566411922;450.988725281864;454.4637327952981;427.3909678707829;535.6304150136393;537.1539824775915;544.2652419234081;568.6815383385235;7830.2952734254195;7948.324392426593;7953.801154971056;8157.95921020403;8174.550399727953;465.7461683382497;570.0622476026913;573.5125143627882;591.1457943271931;607.4563265877015;3538.7522873398616;3581.1047238190454;3608.061903904951;3633.854645814191;3636.781793092423;46826.531734682896;47828.52171478241;50253;50319;50595.49404505908;42931.35602965958;43570.346444803356;43918.12163756707;44162.11675766467;44258.55741442609;40148.397774033416;40453.595464045575;40505.797471012454;40812.38781418341;41312.58687413148;8053.637586308748;8067.878981815395;8128.918710812816;8190.783254221743;8313.750587482386;30407.69592304137;30765.384692306478;30927.226819329695;31914;31914.68085319117;35345.18065669812;35532;35540.46689299611;38722.61277387303;39210.411843822934;9652.806943861224;9787.755306117404;9947.154491867983;10024.699259022242;10621;10582.312149710244;11029.724256893642;11097.278676885977;11200.887991119984;11222.10223182127;9997.950010250193;10066.892641809249;10179.745506362104;10302.175825933757;10476.947615261875;10009;10059;10256.230782691178;10307;10309.07218350352;9566.856497152408;10275.537600807833;10305.381677099398;10310.948445257725;10313.535890884777;8562.578066450162;8997.955010224907;9135.817283654422;9675.854862177213;9746.80506389854;8260.001294827203;8349.37379696513;8643.654253830027;8767.60545775429;8786.384953053224 04:28:37 INFO - PROCESS | 22830 | __end_tp_report 04:28:37 INFO - PROCESS | 22830 | __start_cc_report 04:28:37 INFO - PROCESS | 22830 | _x_x_mozilla_cycle_collect,839 04:28:37 INFO - PROCESS | 22830 | __end_cc_report 04:28:37 INFO - PROCESS | 22830 | __startTimestamp1456748917810__endTimestamp 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | ------- Summary: start ------- 04:28:37 INFO - PROCESS | 22830 | Number of tests: 6 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | [#0] dojo.html Cycles:165 Average:4431.26 Median:4573.66 stddev:435.82 (9.5%) stddev-sans-first:412.10 04:28:37 INFO - PROCESS | 22830 | Values: 2574.6 2662.5 2679.3 2679.5 2702.9 4323.3 4405.0 4499.0 4510.7 4543.5 4497.4 4510.6 4547.8 4554.8 4602.4 4134.9 4168.1 4168.6 4178.6 4312.6 4009.5 4245.1 4274.9 4287.0 4304.2 4096.9 4147.0 4152.8 4176.1 4197.1 4117.7 4129.8 4138.1 4138.4 4162.0 4044.6 4122.7 4124.4 4129.9 4158.8 4376.8 4442.8 4447.1 4470.0 4485.1 4769.9 4771.2 4786.7 4790.2 4794.7 4591.9 4797.1 4821.3 4858.5 4874.8 4421.4 4438.8 4439.3 4443.9 4479.1 4856.4 4864.1 4865.0 4869.8 4917.7 4578.4 4623.8 4708.5 4722.0 4722.5 4753.0 4754.8 4757.1 4777.6 4810.9 4718.3 4738.3 4741.7 4743.4 4782.1 4609.9 4722.4 4770.0 4800.2 4813.2 4023.3 4027.8 4029.2 4043.6 4064.2 3485.5 3563.1 3563.8 3589.9 3594.3 4070.5 4097.1 4128.9 4170.3 4172.4 4753.6 4755.3 4761.9 4765.5 4816.7 3981.6 4095.0 4096.8 4123.6 4131.7 4328.0 4362.7 4365.4 4384.7 4405.4 4465.5 4481.3 4503.8 4517.9 4537.9 4653.1 4748.0 4755.5 4778.6 4789.5 4576.2 4595.7 4598.2 4599.1 4639.5 4774.3 4786.4 4793.6 4798.5 4814.5 4618.4 4738.7 4800.0 4857.2 4874.8 4635.7 4654.6 4655.4 4678.4 4707.2 4642.3 4648.0 4651.3 4653.9 4696.5 4448.3 4520.1 4549.5 4598.3 4600.1 4629.7 4641.1 4641.3 4663.3 4679.3 4573.7 4576.1 4580.9 4615.7 4633.5 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | [#1] ext.html Cycles:180 Average:36652.93 Median:34171.24 stddev:56741.66 (166.1%) stddev-sans-first:56835.82 04:28:37 INFO - PROCESS | 22830 | Values: 479.3 497.8 506.4 528.6 533.6 24940.3 25347.9 33138.2 33409.5 33443.5 38013.6 38636.4 38660.0 38660.4 38682.6 6768.3 7657.7 7858.3 7869.6 9427.5 9705.1 9851.7 9853.2 9858.0 9867.4 9831.5 9965.7 9967.6 9980.5 9983.1 9795.4 9844.4 9854.1 9890.1 9895.0 9709.8 9775.1 9862.6 9870.0 9990.8 35501.8 35757.5 35822.0 35862.1 35866.8 2820.4 2867.6 2880.6 2895.8 2944.0 28573.4 28648.1 28654.3 29251.9 29414.6 2703.3 2765.9 2789.3 2790.5 2833.0 229985.0 231374.0 231909.0 232153.0 232529.0 38849.8 55424.4 55541.7 55956.7 55987.4 37452.3 37608.4 37661.4 37667.6 37689.0 10821.5 10923.2 10957.8 10964.0 10988.3 7839.4 9211.3 9331.7 9338.0 9366.7 12934.5 12964.9 13053.2 13412.5 13455.4 5387.0 5523.3 5543.2 5571.1 5571.7 792.5 817.2 864.4 909.4 983.5 24908.4 25097.7 25693.7 25769.5 25865.6 942.5 948.3 966.0 978.0 992.1 13370.5 13440.6 13624.0 13714.8 13782.7 254547.0 258133.0 258661.0 258703.0 259245.0 45249.3 45509.5 45565.5 45988.5 46119.0 1079.9 1188.6 1198.5 1214.3 1214.7 24476.9 25785.2 26342.9 26432.6 26693.7 36015.8 36295.3 36302.8 36365.6 36420.6 146176.0 149269.3 149908.0 149916.0 150223.0 24328.8 28954.4 29026.9 29268.7 29710.6 33323.0 33444.0 34133.5 34209.0 34241.5 28975.0 29119.1 29240.9 29332.4 29649.0 35226.5 36569.1 36725.3 37168.4 37347.8 31371.8 31579.0 31868.8 36451.3 37079.0 27459.5 29782.4 30556.5 30557.8 30570.2 23835.4 24023.8 24031.0 24310.8 24353.3 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | [#2] jquery.html Cycles:180 Average:21431.77 Median:5023.61 stddev:61225.35 (1218.8%) stddev-sans-first:61376.61 04:28:37 INFO - PROCESS | 22830 | Values: 333.9 340.0 344.2 349.2 351.3 14521.6 15120.1 15600.9 15618.5 15662.3 14824.3 14875.2 15099.4 15398.5 15405.5 4894.3 5112.3 5115.1 5122.5 5135.1 4782.0 5039.9 5050.9 5064.9 5065.5 5007.4 5016.9 5022.2 5025.0 5029.6 4836.0 4988.2 4992.5 5008.5 5019.6 4819.5 4828.8 4830.0 4844.3 4867.3 10558.3 11130.4 11157.2 11158.3 11195.2 1708.7 1723.8 1726.2 1769.8 1914.4 8077.2 8531.1 8885.2 8998.8 9028.2 1708.7 1723.1 1749.1 1795.9 1801.0 50310.0 52990.5 53380.5 54702.2 55215.4 9098.6 9324.6 9460.9 9476.3 9622.6 11782.3 11852.7 11862.2 11892.7 11900.0 6287.1 6365.6 6384.9 6449.8 6454.2 5661.8 5718.3 5791.8 5837.2 5966.3 3985.2 3999.4 4039.7 4073.2 4114.7 1571.3 1663.0 1686.2 1693.2 1700.5 787.4 840.9 841.7 864.3 924.7 14857.4 15427.5 15470.0 15482.8 15503.9 816.8 819.4 835.7 855.2 870.9 8619.1 8696.9 8742.1 8771.3 9004.9 362036.0 372816.0 378878.0 379266.0 379486.0 39004.6 46405.5 56085.0 60318.7 61201.4 860.8 865.7 890.4 892.9 895.3 13589.2 13776.0 13960.2 14277.0 14290.2 28158.4 28788.7 29697.6 29773.9 30269.1 38657.4 40782.4 42353.4 42452.6 42668.6 6874.6 6919.1 6927.4 6987.4 7152.0 8566.8 10605.9 10746.2 10994.3 11312.9 8246.0 8543.7 8869.5 9171.6 9551.2 8410.6 9420.0 9538.2 9560.6 9592.8 8935.8 9133.2 9223.4 9279.3 9911.8 7009.2 7202.6 7287.0 7395.8 7443.3 9343.9 9395.3 9469.7 9605.5 9643.5 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | [#3] mootools.html Cycles:180 Average:4922.20 Median:5903.00 stddev:2582.13 (43.7%) stddev-sans-first:2573.98 04:28:37 INFO - PROCESS | 22830 | Values: 1170.9 1321.6 1323.6 1425.9 1695.3 6740.7 6861.7 6881.6 6887.9 6917.0 6898.5 7023.8 7038.0 7038.4 7039.4 1652.4 2060.2 2061.1 2090.6 2109.2 2061.1 2068.5 2070.7 2071.5 2073.3 2050.3 2053.8 2109.3 2111.3 2114.8 2050.3 2050.6 2057.4 2063.1 2100.2 2032.5 2034.7 2035.5 2035.9 2040.5 7229.5 7290.1 7303.5 7303.6 7306.3 4119.7 4221.5 4253.3 4253.6 4259.4 2488.7 2632.8 2636.0 2639.3 2662.7 788.6 816.7 831.4 836.5 851.4 9686.6 9693.4 9695.1 9702.3 9713.0 3771.3 3876.1 3951.0 3957.1 3962.6 8301.3 8304.6 8338.3 8340.9 8341.3 3375.0 4276.9 4282.0 4283.6 4283.8 3749.3 3793.4 3803.8 3826.9 3834.8 3380.5 3429.0 3436.8 3457.3 3478.4 1059.4 1060.6 1067.2 1073.1 1078.8 1130.3 1152.5 1152.7 1160.2 1167.5 6688.5 6690.5 6763.1 6784.6 6799.7 963.8 965.6 969.9 980.3 981.9 5327.5 5350.3 5398.6 5398.7 5404.6 8415.4 8523.0 8711.7 8869.4 8882.9 8707.4 8738.8 8740.5 8768.2 8790.0 6676.1 6731.2 6805.5 6897.3 6900.3 6475.6 6489.8 6525.2 6530.2 6539.5 7530.2 7636.1 7692.8 7699.2 7723.1 7802.6 7999.9 8001.6 8083.4 8092.1 4742.5 5561.8 5652.6 5862.1 5950.2 6609.2 6612.8 6629.9 6658.3 6661.6 5881.4 5886.6 6017.8 6058.7 6080.5 5805.5 5825.9 5881.2 6114.8 6115.5 6202.8 6296.7 6297.4 6318.7 6351.9 5451.9 5452.6 5455.7 5458.2 5459.2 5810.3 5863.2 5919.4 5962.1 5963.7 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | [#4] prototype.html Cycles:180 Average:4561.55 Median:5303.84 stddev:1358.85 (25.6%) stddev-sans-first:1324.13 04:28:37 INFO - PROCESS | 22830 | Values: 280.7 285.2 286.2 291.9 295.0 5293.3 5297.5 5349.0 5360.9 5367.1 5281.5 5293.2 5299.5 5308.2 5315.4 3798.3 3942.6 4058.8 4097.8 4104.0 4068.0 4084.1 4089.5 4095.6 4096.3 3765.4 4050.0 4057.0 4058.3 4063.3 3930.8 4008.7 4021.2 4045.8 4057.2 3526.1 3526.5 3530.7 3535.4 3536.2 5099.8 5100.1 5101.3 5102.0 5103.9 4633.0 4642.4 4643.8 4647.2 4653.6 5522.5 5534.0 5535.9 5540.6 5541.3 3846.8 3849.1 3856.7 3857.7 3862.5 5585.4 5828.9 5848.0 5851.1 5856.0 3810.2 3860.4 3866.6 3866.7 3868.3 3916.2 3917.9 3921.8 3924.2 3930.2 4549.7 4556.7 4564.5 4572.2 4578.5 5563.4 5574.9 5575.6 5576.2 5589.4 1357.3 1372.2 1378.2 1378.6 1380.3 902.3 913.4 913.9 927.5 931.6 4742.0 4753.0 4760.5 4766.5 4767.2 5660.7 5662.7 5667.0 5669.7 5672.4 4778.2 4782.7 4787.1 4789.2 4793.8 3022.8 3055.9 3059.1 3059.7 3074.5 5352.1 5358.3 5359.6 5359.9 5361.9 5638.8 5837.4 5838.1 5866.5 5896.4 5333.0 5347.5 5348.4 5349.4 5349.5 5670.2 5674.2 5677.1 5677.4 5685.7 5539.4 5545.3 5546.8 5546.9 5560.2 5348.4 5352.2 5355.5 5359.7 5361.9 3751.7 3820.6 3846.0 3854.9 3863.6 5547.4 5701.6 5706.1 5711.1 5723.4 5430.5 5508.3 5510.1 5515.8 5546.1 5517.5 5534.9 5537.8 5620.2 5623.4 5490.9 5502.1 5505.9 5506.5 5509.3 5606.5 5621.6 5651.0 5654.7 5664.8 5278.0 5457.9 5486.5 5489.8 5525.4 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | [#5] yui.html Cycles:180 Average:11897.77 Median:44040.12 stddev:13426.97 (30.5%) stddev-sans-first:13437.57 04:28:37 INFO - PROCESS | 22830 | Values: 545.3 607.7 617.8 626.5 642.9 11058.8 11486.3 11494.2 11501.1 11507.0 12831.2 13090.2 13111.5 13133.3 13160.4 753.8 765.9 768.6 768.6 769.3 589.3 753.3 770.3 774.7 775.0 796.5 799.1 799.4 800.2 801.7 617.9 790.4 790.5 790.6 791.3 580.5 584.2 589.3 589.8 589.9 10593.0 10670.8 10682.3 10712.8 10731.4 10540.3 10919.2 11094.5 11246.3 11453.9 8525.2 8795.3 9175.4 9176.8 9356.1 2996.1 3046.2 3061.3 3066.4 3130.0 36238.5 37014.3 37385.0 37394.1 37483.8 8350.2 8520.7 8534.4 8608.0 8626.4 15890.0 15995.0 16085.3 16090.6 16094.1 5958.7 5997.9 6017.2 6094.8 6155.3 3159.4 3195.5 3395.9 3406.8 3426.1 2438.3 2494.6 2494.6 2497.3 2497.8 431.8 438.6 450.6 451.0 454.5 427.4 535.6 537.2 544.3 568.7 7830.3 7948.3 7953.8 8158.0 8174.6 465.7 570.1 573.5 591.1 607.5 3538.8 3581.1 3608.1 3633.9 3636.8 46826.5 47828.5 50253.0 50319.0 50595.5 42931.4 43570.3 43918.1 44162.1 44258.6 40148.4 40453.6 40505.8 40812.4 41312.6 8053.6 8067.9 8128.9 8190.8 8313.8 30407.7 30765.4 30927.2 31914.0 31914.7 35345.2 35532.0 35540.5 38722.6 39210.4 9652.8 9787.8 9947.2 10024.7 10621.0 10582.3 11029.7 11097.3 11200.9 11222.1 9998.0 10066.9 10179.7 10302.2 10476.9 10009.0 10059.0 10256.2 10307.0 10309.1 9566.9 10275.5 10305.4 10310.9 10313.5 8562.6 8998.0 9135.8 9675.9 9746.8 8260.0 8349.4 8643.7 8767.6 8786.4 04:28:37 INFO - PROCESS | 22830 | -------- Summary: end -------- 04:28:37 INFO - PROCESS | 22830 | 04:28:37 INFO - PROCESS | 22830 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:37 INFO - PROCESS | 22830 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:37 INFO - PROCESS | 22830 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:37 INFO - PROCESS | 22830 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:37 INFO - PROCESS | 22830 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:37 INFO - PROCESS | 22830 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:37 INFO - PROCESS | 22830 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:38 INFO - TEST-INFO | 22830: exit 0 04:28:38 INFO - TEST-OK | dromaeo_css | took 1118225ms 04:28:38 INFO - TEST-START | kraken 04:28:38 INFO - operating with platform_type : linux_ 04:28:38 INFO - Initialising browser for kraken test... 04:28:38 INFO - TEST-INFO | started process 23016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiu5SA9/profile http://localhost:60270/getInfo.html) 04:28:43 INFO - PROCESS | 23016 | __metrics Screen width/height:1600/1200 04:28:43 INFO - PROCESS | 23016 | colorDepth:24 04:28:43 INFO - PROCESS | 23016 | Browser inner width/height: 1024/697 04:28:43 INFO - PROCESS | 23016 | __metrics 04:28:44 INFO - PROCESS | 23016 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:44 INFO - PROCESS | 23016 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:44 INFO - PROCESS | 23016 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:44 INFO - PROCESS | 23016 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:44 INFO - PROCESS | 23016 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:44 INFO - PROCESS | 23016 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:44 INFO - PROCESS | 23016 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:28:45 INFO - TEST-INFO | 23016: exit 0 04:28:45 INFO - Browser initialized. 04:28:45 INFO - Running cycle 1/1 for kraken test... 04:28:45 INFO - TEST-INFO | started process 23098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiu5SA9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:57 INFO - PROCESS | 23098 | RSS: Main: 154349568 04:28:57 INFO - PROCESS | 23098 | 04:29:00 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:00 INFO - PROCESS | 23098 | RSS: Main: 198115328 04:29:00 INFO - PROCESS | 23098 | 04:29:03 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-dft) 04:29:04 INFO - PROCESS | 23098 | RSS: Main: 187920384 04:29:04 INFO - PROCESS | 23098 | 04:29:07 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-fft) 04:29:07 INFO - PROCESS | 23098 | RSS: Main: 174141440 04:29:07 INFO - PROCESS | 23098 | 04:29:09 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60270/tests/kraken/driver.html?testName=audio-oscillator) 04:29:10 INFO - PROCESS | 23098 | RSS: Main: 174944256 04:29:10 INFO - PROCESS | 23098 | 04:29:12 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:13 INFO - PROCESS | 23098 | RSS: Main: 174379008 04:29:13 INFO - PROCESS | 23098 | 04:29:16 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60270/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:17 INFO - PROCESS | 23098 | RSS: Main: 175419392 04:29:17 INFO - PROCESS | 23098 | 04:29:20 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60270/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:21 INFO - PROCESS | 23098 | RSS: Main: 176799744 04:29:21 INFO - PROCESS | 23098 | 04:29:23 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60270/tests/kraken/driver.html?testName=json-parse-financial) 04:29:24 INFO - PROCESS | 23098 | RSS: Main: 176721920 04:29:24 INFO - PROCESS | 23098 | 04:29:26 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:26 INFO - PROCESS | 23098 | RSS: Main: 188407808 04:29:26 INFO - PROCESS | 23098 | 04:29:28 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:29 INFO - PROCESS | 23098 | RSS: Main: 184553472 04:29:29 INFO - PROCESS | 23098 | 04:29:31 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:32 INFO - PROCESS | 23098 | RSS: Main: 196169728 04:29:32 INFO - PROCESS | 23098 | 04:29:34 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:35 INFO - PROCESS | 23098 | RSS: Main: 201011200 04:29:35 INFO - PROCESS | 23098 | 04:29:37 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:38 INFO - PROCESS | 23098 | RSS: Main: 197885952 04:29:38 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | Cycle 1(1): loaded http://localhost:60270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60270/tests/kraken/driver.html?testName=ai-astar) 04:29:40 INFO - PROCESS | 23098 | RSS: Main: 258281472 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | __start_tp_report 04:29:40 INFO - PROCESS | 23098 | _x_x_mozilla_page_load 04:29:40 INFO - PROCESS | 23098 | _x_x_mozilla_page_load_details 04:29:40 INFO - PROCESS | 23098 | |i|pagename|runs| 04:29:40 INFO - PROCESS | 23098 | |0;ai-astar;115;113;108;113;116;115;106;113;113;114 04:29:40 INFO - PROCESS | 23098 | |1;audio-beat-detection;164;135;153;173;134;163;158;139;174;132 04:29:40 INFO - PROCESS | 23098 | |2;audio-dft;161;162;161;160;162;160;162;161;161;161 04:29:40 INFO - PROCESS | 23098 | |3;audio-fft;75;75;74;149;74;74;75;74;151;75 04:29:40 INFO - PROCESS | 23098 | |4;audio-oscillator;98;98;142;97;97;97;137;97;98;134 04:29:40 INFO - PROCESS | 23098 | |5;imaging-gaussian-blur;119;115;116;115;115;115;114;115;115;115 04:29:40 INFO - PROCESS | 23098 | |6;imaging-darkroom;149;147;147;147;147;147;146;146;146;147 04:29:40 INFO - PROCESS | 23098 | |7;imaging-desaturate;96;96;96;95;96;95;97;96;96;95 04:29:40 INFO - PROCESS | 23098 | |8;json-parse-financial;68;67;67;68;67;68;68;76;65;66 04:29:40 INFO - PROCESS | 23098 | |9;json-stringify-tinderbox;69;71;71;72;72;71;70;72;72;72 04:29:40 INFO - PROCESS | 23098 | |10;stanford-crypto-aes;83;83;84;88;82;83;83;84;85;83 04:29:40 INFO - PROCESS | 23098 | |11;stanford-crypto-ccm;132;121;127;125;136;121;131;122;121;120 04:29:40 INFO - PROCESS | 23098 | |12;stanford-crypto-pbkdf2;149;138;150;151;160;139;150;148;148;146 04:29:40 INFO - PROCESS | 23098 | |13;stanford-crypto-sha256-iterative;71;70;72;74;70;71;71;70;69;69 04:29:40 INFO - PROCESS | 23098 | __end_tp_report 04:29:40 INFO - PROCESS | 23098 | __start_cc_report 04:29:40 INFO - PROCESS | 23098 | _x_x_mozilla_cycle_collect,1160 04:29:40 INFO - PROCESS | 23098 | __end_cc_report 04:29:40 INFO - PROCESS | 23098 | __startTimestamp1456748980514__endTimestamp 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | ------- Summary: start ------- 04:29:40 INFO - PROCESS | 23098 | Number of tests: 14 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:3.17 (2.8%) stddev-sans-first:3.24 04:29:40 INFO - PROCESS | 23098 | Values: 115.0 113.0 108.0 113.0 116.0 115.0 106.0 113.0 113.0 114.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:160.50 stddev:16.35 (10.2%) stddev-sans-first:16.81 04:29:40 INFO - PROCESS | 23098 | Values: 164.0 135.0 153.0 173.0 134.0 163.0 158.0 139.0 174.0 132.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:29:40 INFO - PROCESS | 23098 | Values: 161.0 162.0 161.0 160.0 162.0 160.0 162.0 161.0 161.0 161.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#3] audio-fft Cycles:10 Average:89.60 Median:74.50 stddev:31.84 (42.7%) stddev-sans-first:33.33 04:29:40 INFO - PROCESS | 23098 | Values: 75.0 75.0 74.0 149.0 74.0 74.0 75.0 74.0 151.0 75.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:97.00 stddev:19.53 (20.1%) stddev-sans-first:20.27 04:29:40 INFO - PROCESS | 23098 | Values: 98.0 98.0 142.0 97.0 97.0 97.0 137.0 97.0 98.0 134.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 04:29:40 INFO - PROCESS | 23098 | Values: 119.0 115.0 116.0 115.0 115.0 115.0 114.0 115.0 115.0 115.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.50 04:29:40 INFO - PROCESS | 23098 | Values: 149.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:29:40 INFO - PROCESS | 23098 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 95.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:2.98 (4.4%) stddev-sans-first:3.16 04:29:40 INFO - PROCESS | 23098 | Values: 68.0 67.0 67.0 68.0 67.0 68.0 68.0 76.0 65.0 66.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:72.00 stddev:1.03 (1.4%) stddev-sans-first:0.73 04:29:40 INFO - PROCESS | 23098 | Values: 69.0 71.0 71.0 72.0 72.0 71.0 70.0 72.0 72.0 72.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:1.69 (2.0%) stddev-sans-first:1.76 04:29:40 INFO - PROCESS | 23098 | Values: 83.0 83.0 84.0 88.0 82.0 83.0 83.0 84.0 85.0 83.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:126.00 stddev:5.66 (4.5%) stddev-sans-first:5.51 04:29:40 INFO - PROCESS | 23098 | Values: 132.0 121.0 127.0 125.0 136.0 121.0 131.0 122.0 121.0 120.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:149.50 stddev:6.21 (4.2%) stddev-sans-first:6.57 04:29:40 INFO - PROCESS | 23098 | Values: 149.0 138.0 150.0 151.0 160.0 139.0 150.0 148.0 148.0 146.0 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.49 (2.1%) stddev-sans-first:1.58 04:29:40 INFO - PROCESS | 23098 | Values: 71.0 70.0 72.0 74.0 70.0 71.0 71.0 70.0 69.0 69.0 04:29:40 INFO - PROCESS | 23098 | -------- Summary: end -------- 04:29:40 INFO - PROCESS | 23098 | 04:29:40 INFO - PROCESS | 23098 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:29:40 INFO - PROCESS | 23098 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:29:40 INFO - PROCESS | 23098 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:29:40 INFO - PROCESS | 23098 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:29:40 INFO - PROCESS | 23098 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:29:40 INFO - PROCESS | 23098 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:29:40 INFO - PROCESS | 23098 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 04:29:41 INFO - TEST-INFO | 23098: exit 0 04:29:41 INFO - TEST-OK | kraken | took 62985ms 04:29:41 INFO - SUITE-END | took 1181s 04:29:41 INFO - Completed test suite (00:19:41) 04:29:41 INFO - Working with test: dromaeo_css 04:29:41 INFO - Generating results file: dromaeo_css 04:29:41 INFO - Working with test: kraken 04:29:41 INFO - Generating results file: kraken 04:29:41 INFO - javascript benchmark 04:29:41 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 04:29:41 INFO - process_Request line: dromaeo_css 5998.22 graph.html#tests=[[72,132,35]] 04:29:41 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:41 INFO - process_Request line: kraken 1550.60 graph.html#tests=[[232,132,35]] 04:29:41 INFO - RETURN: dromaeo_css: 5998.22 04:29:41 INFO - RETURN: kraken: 1550.60 04:29:41 INFO - javascript benchmark 04:29:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2574.579894898795, 2662.534056540105, 2679.3435608275963, 2679.464107178565, 2702.9459410811783, 4323.265044942359, 4405.03089320349, 4499.0, 4510.684252102355, 4543.545645435459, 4497.437820272466, 4510.616597589209, 4547.840825571106, 4554.79503422346, 4602.401687780583, 4134.917301653965, 4168.103857670592, 4168.6039826216465, 4178.582141785828, 4312.633426158764, 4009.5389030261454, 4245.108527209274, 4274.935875961863, 4287.035417031174, 4304.1606886656955, 4096.91806163878, 4147.04617937876, 4152.83388664453, 4176.1230141669985, 4197.076643138505, 4117.670586353084, 4129.752214867088, 4138.110306284133, 4138.441310423084, 4162.021924847659, 4044.5550989391145, 4122.670186385082, 4124.4019617155645, 4129.876103716893, 4158.792060396968, 4376.803043863002, 4442.755648439334, 4447.132809102226, 4470.038941627533, 4485.1254005468945, 4769.928451073237, 4771.212749896263, 4786.688865223749, 4790.185668436374, 4794.688345257547, 4591.885202869921, 4797.088553174885, 4821.349117869113, 4858.514148585114, 4874.7562621868765, 4421.439868318654, 4438.822447102079, 4439.267520859086, 4443.888902777457, 4479.148961697267, 4856.39295088114, 4864.148773964542, 4864.975675121673, 4869.756512174377, 4917.729524876095, 4578.427696537933, 4623.768811559408, 4708.4820669726305, 4722.0, 4722.456917454468, 4753.04939012199, 4754.833580824655, 4757.14371413142, 4777.641676874179, 4810.855674329776, 4718.3158442025715, 4738.289256611467, 4741.715497070187, 4743.430788305425, 4782.0914026334885, 4609.884752881205, 4722.386089808303, 4770.045990801854, 4800.207965685692, 4813.205821039489, 4023.3361495353524, 4027.8187481562813, 4029.234445455354, 4043.636072753466, 4064.248114098842, 3485.5294535237417, 3563.0914116900026, 3563.750537462353, 3589.8743543975834, 3594.281143771256, 4070.4708387909973, 4097.078157414618, 4128.896777580524, 4170.332746760504, 4172.374143878443, 4753.5959443447, 4755.310479980383, 4761.857144285677, 4765.451973023078, 4816.662833601685, 3981.581933896899, 4094.979525102415, 4096.774677392772, 4123.628873401408, 4131.731437456556, 4327.956720432819, 4362.738235705868, 4365.367021781887, 4384.736915784999, 4405.449318835145, 4465.531119232433, 4481.282994720829, 4503.774811259358, 4517.909641807211, 4537.863864084083, 4653.069386122721, 4747.952520474751, 4755.500672429345, 4778.617710583076, 4789.521047895182, 4576.244919588231, 4595.690228285056, 4598.241290187082, 4599.149157405891, 4639.536046395334, 4774.307725379731, 4786.353842231254, 4793.5685788279225, 4798.5441383068555, 4814.518548145157, 4618.353430519797, 4738.668293219442, 4800.0, 4857.198562237191, 4874.756262186947, 4635.745034023161, 4654.627629789541, 4655.371524844103, 4678.438587369537, 4707.223308154116, 4642.303654451859, 4648.0, 4651.348811166372, 4653.930191047205, 4696.483386827515, 4448.332750087513, 4520.118576877478, 4549.499555049008, 4598.26427771555, 4600.102979918884, 4629.699069560468, 4641.094986477605, 4641.303804429363, 4663.300504924288, 4679.321498382647, 4573.656975726901, 4576.061907308927, 4580.931286030645, 4615.699979501322, 4633.536646335339], "unit": "score", "name": "dojo.html", "value": 4405.880348403394}, {"lowerIsBetter": false, "replicates": [479.28107838242613, 497.8357142143093, 506.38980029064976, 528.5507318779038, 533.5891363649991, 24940.25179244621, 25347.873260633693, 33138.1715457114, 33409.498857517094, 33443.49834752481, 38013.61986380135, 38636.420453693216, 38660.0, 38660.420093698616, 38682.61317386825, 6768.323167683241, 7657.655405506752, 7858.332041776456, 7869.567173805438, 9427.48148851813, 9705.078017588317, 9851.65519206828, 9853.211743060574, 9858.014198580157, 9867.358621689604, 9831.508424578742, 9965.701028969142, 9967.601295948154, 9980.451075190862, 9983.101520863122, 9795.363301385423, 9844.3601165924, 9854.113129818315, 9890.06044425782, 9894.950525247328, 9709.805803883954, 9775.120239178508, 9862.605495780232, 9869.950650246774, 9990.80018399628, 35501.82249088764, 35757.46363804545, 35822.0, 35862.10344741376, 35866.82066589651, 2820.3936153727045, 2867.584200290967, 2880.567914812774, 2895.826250424981, 2944.0, 28573.42853142946, 28648.14055578336, 28654.283642908886, 29251.853740731374, 29414.558781618292, 2703.3376822678374, 2765.9170224893287, 2789.2608458758446, 2790.483760504313, 2832.985835070832, 229985.0, 231374.0, 231909.0, 232153.0, 232529.0, 38849.80575097106, 55424.44575554193, 55541.72229138829, 55956.72021639866, 55987.44012559822, 37452.25095498075, 37608.435873461916, 37661.43507847384, 37667.62332376696, 37689.0, 10821.458927053616, 10923.180761442924, 10957.83563246552, 10964.0, 10988.340699558052, 7839.3728501719725, 9211.309151813506, 9331.673391431403, 9338.0, 9366.718998430058, 12934.547290844775, 12964.870351296555, 13053.216806991612, 13412.530561430303, 13455.394507247198, 5386.973065134649, 5523.260173045478, 5543.168524721244, 5571.1086226203615, 5571.66570005801, 792.5324058805218, 817.1542453560536, 864.4251572704208, 909.3861643390685, 983.498415807943, 24908.377290567518, 25097.749022509906, 25693.74306256951, 25769.48461030769, 25865.612015819777, 942.5098948546718, 948.2935213266161, 965.9855102173473, 977.9706608801747, 992.0525897767615, 13370.46518139283, 13440.596782096552, 13624.0, 13714.794278085838, 13782.65543361404, 254547.0, 258133.0, 258661.0, 258703.0, 259245.0, 45249.321260181125, 45509.54490455053, 45565.544344556794, 45988.5401145991, 46119.0, 1079.8542196803487, 1188.5661733467396, 1198.5026214121217, 1214.2775048845922, 1214.7449035702602, 24476.877615611807, 25785.226443206735, 26342.86828565845, 26432.603510947734, 26693.733062669126, 36015.81992090023, 36295.27409451743, 36302.8184859074, 36365.63634363622, 36420.635793641726, 146176.0, 149269.25365373102, 149908.0, 149916.0, 150223.0, 24328.75671243336, 28954.42091158207, 29026.854865725538, 29268.7073129266, 29710.554341685325, 33323.0, 33444.0, 34133.48799767956, 34209.0, 34241.48637770485, 28975.0, 29119.126426207247, 29240.853795730884, 29332.41335173242, 29649.0, 35226.47735226457, 36569.08577285589, 36725.265494689425, 37168.44247336238, 37347.81326093352, 31371.843140785062, 31579.0, 31868.84065579657, 36451.27097458089, 37079.0, 27459.450810984068, 29782.404351913272, 30556.541651874795, 30557.847210764692, 30570.235744106576, 23835.404114897265, 24023.75976240215, 24031.0, 24310.756892431556, 24353.269401917973], "unit": "score", "name": "ext.html", "value": 15878.311891054358}, {"lowerIsBetter": false, "replicates": [333.92152844081636, 339.9677030682086, 344.1705489769655, 349.20207326259504, 351.29214632515504, 14521.564353069412, 15120.092794432341, 15600.921995390036, 15618.453354132607, 15662.295196716146, 14824.258787060631, 14875.181864997421, 15099.396024159021, 15398.538043858702, 15405.460808871692, 4894.339264199332, 5112.284280200774, 5115.130427827278, 5122.513361230677, 5135.075686376451, 4781.976090119562, 5039.899202015958, 5050.88880446303, 5064.898702025957, 5065.468125846788, 5007.399112106552, 5016.899662006757, 5022.221555658879, 5025.0, 5029.647924645276, 4836.0, 4988.152014157602, 4992.500749925015, 5008.474110218429, 5019.598432125421, 4819.5180481951875, 4828.782704778293, 4829.985703002374, 4844.2733589961435, 4867.318575399447, 10558.260921735482, 11130.443477826157, 11157.163212759075, 11158.330500170016, 11195.160362972729, 1708.6753516831761, 1723.8103808581045, 1726.249081649474, 1769.78762548495, 1914.4352416037302, 8077.151899050574, 8531.146885311482, 8885.155910188587, 8998.775030624221, 9028.187463128284, 1708.6545338949386, 1723.1298194411868, 1749.08173209065, 1795.8742887997846, 1800.9819901800945, 50310.0, 52990.47009529894, 53380.54122617327, 54702.17946730762, 55215.447845521434, 9098.59056342453, 9324.580393882292, 9460.8580871287, 9476.336656434121, 9622.615095396246, 11782.293062416282, 11852.70368240801, 11862.169648124722, 11892.702682433008, 11900.0, 6287.14529213883, 6365.649889256043, 6384.904226436607, 6449.774257900951, 6454.160959075384, 5661.830145095653, 5718.313802343745, 5791.82624521265, 5837.182794408786, 5966.313873904556, 3985.202959408072, 3999.4000899865255, 4039.6768258539832, 4073.1853629274265, 4114.698335024176, 1571.277212482271, 1663.0305434351544, 1686.1653481526478, 1693.2041940288045, 1700.5068530126125, 787.4487858499074, 840.9453385529921, 841.7348535211511, 864.2524216552637, 924.713338864954, 14857.405703771945, 15427.5371738848, 15470.0, 15482.84517154814, 15503.922480387526, 816.7917181118777, 819.4100247821559, 835.6573804740027, 855.2089317381398, 870.9303255739652, 8619.138086191457, 8696.869546956801, 8742.082081381363, 8771.298296136294, 9004.909950900537, 362036.0, 372816.0, 378878.0, 379266.0, 379486.0, 39004.60995390067, 46405.5359446408, 56085.0, 60318.69840650768, 61201.38798612046, 860.7675927499665, 865.6840253307497, 890.3500444675424, 892.8839250897472, 895.3106108296575, 13589.184648921097, 13776.0, 13960.2321872298, 14277.0, 14290.214038227998, 28158.43683126285, 28788.712112878602, 29697.554536681535, 29773.851130745075, 30269.091927242218, 38657.42013869738, 40782.388264176654, 42353.364699530146, 42452.5754742461, 42668.57331426646, 6874.587524748531, 6919.100516932766, 6927.411170050401, 6987.406070484066, 7152.0, 8566.82866342682, 10605.946970265099, 10746.24776265654, 10994.28537145083, 11312.886871131182, 8246.01047874259, 8543.743687689379, 8869.512176830336, 9171.587278572346, 9551.235901128031, 8410.6215220314, 9419.952900235729, 9538.23694104484, 9560.569774360032, 9592.76018099553, 8935.821283574422, 9133.178013978773, 9223.44659320443, 9279.304052196247, 9911.801763964824, 7009.228984811564, 7202.639868006683, 7286.96356518214, 7395.778126656209, 7443.292887175709, 9343.859842102238, 9395.342326037111, 9469.66856160031, 9605.502569331884, 9643.517824108907], "unit": "score", "name": "jquery.html", "value": 7296.838332780876}, {"lowerIsBetter": false, "replicates": [1170.934449650818, 1321.6365499487642, 1323.6029191242624, 1425.8859291256701, 1695.3049249807573, 6740.69666864991, 6861.725530978755, 6881.621510816897, 6887.896681549768, 6916.96541517293, 6898.517103802736, 7023.824404389893, 7037.964810175942, 7038.401735852446, 7039.366457018868, 1652.446430445796, 2060.206820374152, 2061.1137210999264, 2090.550531635698, 2109.2090466075224, 2061.051916118587, 2068.451860257033, 2070.6893965905083, 2071.4924843413387, 2073.3468957278483, 2050.3233932802214, 2053.7638171610306, 2109.3355592988237, 2111.324376199617, 2114.7779483154277, 2050.3131450963947, 2050.6001329740707, 2057.40335302762, 2063.0819285417997, 2100.24391219161, 2032.5426778974613, 2034.6642803937332, 2035.4911272181955, 2035.908384122718, 2040.5306779440664, 7229.457790665721, 7290.125184977836, 7303.525270857377, 7303.598302093383, 7306.269373062704, 4119.691023173274, 4221.472315960505, 4253.319468884994, 4253.617174454314, 4259.382389553497, 2488.726240113586, 2632.802539809522, 2636.0, 2639.28739240404, 2662.6671666041743, 788.5702292250737, 816.7263966571206, 831.3847752663046, 836.5315423362936, 851.3529717414748, 9686.564104615309, 9693.41839489633, 9695.127438530495, 9702.27232957524, 9713.02869713023, 3771.26460340231, 3876.1278712290073, 3950.9604903951167, 3957.109650328653, 3962.6037396260144, 8301.252887240178, 8304.584770761438, 8338.291245244101, 8340.916590834015, 8341.332693384515, 3375.0, 4276.87169384919, 4281.978590107092, 4283.5502272260965, 4283.764392958417, 3749.268892565978, 3793.374093274634, 3803.8098095095133, 3826.942595861064, 3834.789086600208, 3380.492926061061, 3428.9828550857087, 3436.8453419596176, 3457.3431048101284, 3478.443449048191, 1059.3802625464036, 1060.6476742153816, 1067.1676092647747, 1073.0771536478621, 1078.800421921947, 1130.2596799096605, 1152.4929031226234, 1152.7118220444888, 1160.2458402038742, 1167.4629670351733, 6688.4649228061635, 6690.531662783558, 6763.053172555846, 6784.592924424452, 6799.694013769392, 963.7638778499313, 965.6041023180462, 969.9030096990244, 980.2843923935567, 981.8527220916919, 5327.467253274642, 5350.277712508761, 5398.62209645321, 5398.73006349681, 5404.621676482687, 8415.410921235578, 8522.957385213034, 8711.738647840448, 8869.379143460024, 8882.86675699865, 8707.39048266628, 8738.825223495494, 8740.519271440131, 8768.167024132825, 8790.0, 6676.132102826698, 6731.158605174353, 6805.489588280899, 6897.310268973062, 6900.275471075565, 6475.611463312216, 6489.772857949949, 6525.2169739631545, 6530.151080359523, 6539.509536784665, 7530.171681115183, 7636.121845987783, 7692.8461430772195, 7699.153093159636, 7723.111842138226, 7802.570858602604, 7999.880001799861, 8001.5999200038605, 8083.434159609006, 8092.069412017458, 4742.454617719007, 5561.833145005657, 5652.576056795675, 5862.149988251595, 5950.166976623363, 6609.173853268341, 6612.8346791330605, 6629.933700663125, 6658.300878407891, 6661.600303981777, 5881.382454842351, 5886.6173698709445, 6017.789377371771, 6058.697065146637, 6080.452759251689, 5805.506531944832, 5825.883482330245, 5881.206037185097, 6114.847128821815, 6115.541334400027, 6202.81391558254, 6296.653684047421, 6297.433231009231, 6318.684065796784, 6351.936480635134, 5451.863703407446, 5452.591055670761, 5455.699936503531, 5458.235846981346, 5459.153831156177, 5810.273715785527, 5863.17915491823, 5919.378465261086, 5962.07587823888, 5963.671998039976], "unit": "score", "name": "mootools.html", "value": 4034.5965518498083}, {"lowerIsBetter": false, "replicates": [280.7304987212276, 285.2341463171385, 286.23717792084096, 291.91680371094236, 295.0381755477144, 5293.31186945697, 5297.549708274796, 5349.0, 5360.91958620621, 5367.141257398817, 5281.524662780349, 5293.232481290221, 5299.470052994699, 5308.203769434586, 5315.415304316522, 3798.335291324014, 3942.5860284670125, 4058.8376464941366, 4097.815598298083, 4103.9794801025955, 4068.0, 4084.121913788535, 4089.5092588889374, 4095.5699651536606, 4096.303628383167, 3765.359888818907, 4050.0482386639264, 4057.0, 4058.3100872851537, 4063.349864021757, 3930.842766289345, 4008.7394319369146, 4021.195760847842, 4045.7977101144825, 4057.2088442753675, 3526.1008442847165, 3526.453399723047, 3530.6822385985383, 3535.381308271068, 3536.2220311531423, 5099.847004589868, 5100.056489549445, 5101.311322971388, 5102.0, 5103.872403189913, 4632.976835115836, 4642.419697537808, 4643.8374656886845, 4647.23320652092, 4653.557911998355, 5522.502974732253, 5534.0315444797, 5535.889282214373, 5540.556755459554, 5541.27963364764, 3846.8461261549505, 3849.1339448623835, 3856.749311294785, 3857.729958902878, 3862.517185351831, 5585.413531579207, 5828.912566311508, 5847.970760146172, 5851.122331650244, 5856.0, 3810.2189051244427, 3860.401637746154, 3866.6133386661672, 3866.709996750255, 3868.3423817951016, 3916.1580260244186, 3917.9020524486546, 3921.8235179416993, 3924.175923056133, 3930.21395720857, 4549.727016379028, 4556.749378784199, 4564.475085365226, 4572.199865023607, 4578.473475550354, 5563.443655634485, 5574.940761255349, 5575.581831362664, 5576.247206627054, 5589.413111623221, 1357.2942070123481, 1372.2246930484243, 1378.152436251698, 1378.5933149720856, 1380.3305396882504, 902.255639097747, 913.3743385780762, 913.8583519554479, 927.5176908007799, 931.6133804471204, 4742.0, 4753.0, 4760.45254795696, 4766.546203407925, 4767.213409787346, 5660.745266463019, 5662.688552129673, 5667.008273552112, 5669.716514174274, 5672.432756724377, 4778.235482322812, 4782.736949467812, 4787.138315103315, 4789.185838407479, 4793.808247670124, 3022.803517771382, 3055.908322750321, 3059.0516939748304, 3059.6787337329706, 3074.4773388524004, 5352.116900711417, 5358.30342055538, 5359.5712343012465, 5359.946400536022, 5361.919571206435, 5638.774449022075, 5837.387074357216, 5838.095095260242, 5866.472017518444, 5896.410358964069, 5332.9733351333, 5347.545458635982, 5348.4116747157, 5349.3580770307035, 5349.4650534946195, 5670.206171136127, 5674.205611214351, 5677.091665333527, 5677.403872593483, 5685.715714214355, 5539.362973257966, 5545.306836645419, 5546.750396232099, 5546.861328466821, 5560.2493663356545, 5348.411674715856, 5352.223927530564, 5355.491228333302, 5359.651622644516, 5361.946380536145, 3751.662350388478, 3820.5988371221733, 3846.0384903774057, 3854.8843534694006, 3863.55569109556, 5547.445255474582, 5701.600887937804, 5706.087026075808, 5711.086226203787, 5723.399043100415, 5430.538404235526, 5508.338999320107, 5510.090835012178, 5515.751791169327, 5546.084895992116, 5517.503424691797, 5534.91697624544, 5537.750801213874, 5620.18507316445, 5623.437656234508, 5490.890182196414, 5502.0921547945745, 5505.862353441035, 5506.504414602705, 5509.347195841312, 5606.523445507178, 5621.606487545996, 5650.971745141248, 5654.717264136859, 5664.773409063591, 5277.973610131925, 5457.918131228114, 5486.451354864482, 5489.752961116839, 5525.364583072998], "unit": "score", "name": "prototype.html", "value": 4117.415717608363}, {"lowerIsBetter": false, "replicates": [545.3428618514689, 607.7113371148702, 617.8331850400391, 626.4744949545012, 642.8971364581668, 11058.778824423507, 11486.253393529414, 11494.195406321562, 11501.1374146939, 11507.021903138244, 12831.230126192411, 13090.21458712478, 13111.54109606164, 13133.343332833345, 13160.407781649825, 753.8077790163514, 765.9463837531375, 768.6003278295283, 768.6387397922967, 769.2576663519702, 589.3311091910691, 753.3031945450464, 770.3105720380285, 774.7017398301666, 775.0196002057402, 796.5459687977855, 799.1129845871078, 799.4084377560622, 800.2477670989281, 801.6993627389729, 617.9258488981307, 790.4387884601939, 790.517784151667, 790.6165509727778, 791.2878409431529, 580.532671199684, 584.1617279204355, 589.3016775121451, 589.8318979090939, 589.932157801854, 10593.0, 10670.78658426835, 10682.305650132717, 10712.78574428507, 10731.356118632906, 10540.262181647287, 10919.181061420426, 11094.500747466383, 11246.268992515461, 11453.942730286295, 8525.232729054414, 8795.296376289945, 9175.357724959256, 9176.81646367069, 9356.064393560657, 2996.131121974625, 3046.2384403899027, 3061.3418115105137, 3066.4480393529157, 3129.9687003129907, 36238.45642315367, 37014.25971480582, 37385.0, 37394.06514837151, 37483.81258093719, 8350.164983501601, 8520.701775437954, 8534.445261058012, 8607.956960215159, 8626.396152269406, 15890.0, 15995.040297581949, 16085.276162572713, 16090.597735056483, 16094.11482368481, 5958.731857066442, 5997.850053748692, 6017.187679663277, 6094.756209751649, 6155.322914479404, 3159.352332771776, 3195.4887218045, 3395.864165433355, 3406.812625305632, 3426.0749597608506, 2438.2807071913826, 2494.550980823469, 2494.6133349330885, 2497.27579002091, 2497.7876880465, 431.84885290148827, 438.55924795580876, 450.5719566411922, 450.988725281864, 454.4637327952981, 427.3909678707829, 535.6304150136393, 537.1539824775915, 544.2652419234081, 568.6815383385235, 7830.2952734254195, 7948.324392426593, 7953.801154971056, 8157.95921020403, 8174.550399727953, 465.7461683382497, 570.0622476026913, 573.5125143627882, 591.1457943271931, 607.4563265877015, 3538.7522873398616, 3581.1047238190454, 3608.061903904951, 3633.854645814191, 3636.781793092423, 46826.531734682896, 47828.52171478241, 50253.0, 50319.0, 50595.49404505908, 42931.35602965958, 43570.346444803356, 43918.12163756707, 44162.11675766467, 44258.55741442609, 40148.397774033416, 40453.595464045575, 40505.797471012454, 40812.38781418341, 41312.58687413148, 8053.637586308748, 8067.878981815395, 8128.918710812816, 8190.783254221743, 8313.750587482386, 30407.69592304137, 30765.384692306478, 30927.226819329695, 31914.0, 31914.68085319117, 35345.18065669812, 35532.0, 35540.46689299611, 38722.61277387303, 39210.411843822934, 9652.806943861224, 9787.755306117404, 9947.154491867983, 10024.699259022242, 10621.0, 10582.312149710244, 11029.724256893642, 11097.278676885977, 11200.887991119984, 11222.10223182127, 9997.950010250193, 10066.892641809249, 10179.745506362104, 10302.175825933757, 10476.947615261875, 10009.0, 10059.0, 10256.230782691178, 10307.0, 10309.07218350352, 9566.856497152408, 10275.537600807833, 10305.381677099398, 10310.948445257725, 10313.535890884777, 8562.578066450162, 8997.955010224907, 9135.817283654422, 9675.854862177213, 9746.80506389854, 8260.001294827203, 8349.37379696513, 8643.654253830027, 8767.60545775429, 8786.384953053224], "unit": "score", "name": "yui.html", "value": 5491.557259230543}], "name": "dromaeo_css", "value": 5998.2222189502145}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 113.0, 108.0, 113.0, 116.0, 115.0, 106.0, 113.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [164.0, 135.0, 153.0, 173.0, 134.0, 163.0, 158.0, 139.0, 174.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 160.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 74.0, 149.0, 74.0, 74.0, 75.0, 74.0, 151.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 142.0, 97.0, 97.0, 97.0, 137.0, 97.0, 98.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 116.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 76.0, 65.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.0}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 72.0, 72.0, 71.0, 70.0, 72.0, 72.0, 72.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.2}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 88.0, 82.0, 83.0, 83.0, 84.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [132.0, 121.0, 127.0, 125.0, 136.0, 121.0, 131.0, 122.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [149.0, 138.0, 150.0, 151.0, 160.0, 139.0, 150.0, 148.0, 148.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 72.0, 74.0, 70.0, 71.0, 71.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1550.6000000000001}]} 04:29:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1550.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5998.22"}}} 04:29:41 INFO - Return code: 0 04:29:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:41 INFO - # TBPL SUCCESS # 04:29:41 INFO - Running post-action listener: _resource_record_post_action 04:29:41 INFO - Running post-run listener: _resource_record_post_run 04:29:42 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525475840; Read time: 8; Write time: 1324776 04:29:42 INFO - install - Wall time: 18s; CPU: 18.0%; Read bytes: 0; Write bytes: 233562112; Read time: 0; Write time: 875136 04:29:43 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291913728; Read time: 8; Write time: 449640 04:29:43 INFO - Running post-run listener: _upload_blobber_files 04:29:43 INFO - Blob upload gear active. 04:29:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:43 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 04:29:43 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'] 04:29:43 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 04:29:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:44 INFO - (blobuploader) - INFO - Done attempting. 04:29:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:29:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:29:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:44 INFO - (blobuploader) - INFO - Done attempting. 04:29:44 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:44 INFO - Return code: 0 04:29:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94f016e73f86ea566f2227baa1c29c023a018e4ec506eb0c8d5528b6a6d85184147dbcb3dd1fb323bf4ce58330c288506b0abba9e779d6b702811060bdc14e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e084f9fc4c0ae4ef6163110b1b89acdeda95779902b300f6cafcd02098f2fad5be5d97a4bc723d870521cee2f6d89d1d4711be45819eea0b61b80e367162fc62"} 04:29:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:44 INFO - Contents: 04:29:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/94f016e73f86ea566f2227baa1c29c023a018e4ec506eb0c8d5528b6a6d85184147dbcb3dd1fb323bf4ce58330c288506b0abba9e779d6b702811060bdc14e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e084f9fc4c0ae4ef6163110b1b89acdeda95779902b300f6cafcd02098f2fad5be5d97a4bc723d870521cee2f6d89d1d4711be45819eea0b61b80e367162fc62"} 04:29:44 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:44 INFO - Copying logs to upload dir... 04:29:44 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.654925 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-29 04:29:44.396453) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 04:29:44.399685) ========= 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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 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/94f016e73f86ea566f2227baa1c29c023a018e4ec506eb0c8d5528b6a6d85184147dbcb3dd1fb323bf4ce58330c288506b0abba9e779d6b702811060bdc14e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e084f9fc4c0ae4ef6163110b1b89acdeda95779902b300f6cafcd02098f2fad5be5d97a4bc723d870521cee2f6d89d1d4711be45819eea0b61b80e367162fc62"} build_url:https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011424 build_url: 'https://queue.taskcluster.net/v1/task/bHdkN5qqQqyecLoRmma-kA/artifacts/public/build/firefox-47.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/94f016e73f86ea566f2227baa1c29c023a018e4ec506eb0c8d5528b6a6d85184147dbcb3dd1fb323bf4ce58330c288506b0abba9e779d6b702811060bdc14e64", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e084f9fc4c0ae4ef6163110b1b89acdeda95779902b300f6cafcd02098f2fad5be5d97a4bc723d870521cee2f6d89d1d4711be45819eea0b61b80e367162fc62"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 04:29:44.426844) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:29:44.427172) ========= 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=df17445c3590ff7897617a0e00000225-1456747702.280166-1882571344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 04:29:44.512315) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 04:29:44.512670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 04:29:44.513004) ========= ========= Total master_lag: 0.30 =========