builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1463835128.26 results: success (0) buildid: 20160521031436 builduid: b14ff78280814770b970e1cef8a91945 revision: ee9ba5e8d935736380d5c657c67cf2791741b501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.255803) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.256230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.256505) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.268327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.268666) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-21 05:52:09-- 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% 91.9M=0s 2016-05-21 05:52:09 (91.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.387771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.388220) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.009545 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.643051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:08.643450) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ee9ba5e8d935736380d5c657c67cf2791741b501 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ee9ba5e8d935736380d5c657c67cf2791741b501 --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=a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-21 05:52:09,434 truncating revision to first 12 chars 2016-05-21 05:52:09,434 Setting DEBUG logging. 2016-05-21 05:52:09,434 attempt 1/10 2016-05-21 05:52:09,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ee9ba5e8d935?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-21 05:52:09,895 unpacking tar archive at: mozilla-beta-ee9ba5e8d935/testing/mozharness/ program finished with exit code 0 elapsedTime=0.743096 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:09.399461) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:09.399807) ========= script_repo_revision: ee9ba5e8d935736380d5c657c67cf2791741b501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:09.400195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:09.400461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-21 05:52:09.406256) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-21 05:52:09.406563) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:10 INFO - MultiFileLogger online at 20160521 05:52:10 in /builds/slave/test 05:52:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:52:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:10 INFO - {'append_to_log': False, 05:52:10 INFO - 'base_work_dir': '/builds/slave/test', 05:52:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:52:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:10 INFO - 'branch': 'Mozilla-Beta', 05:52:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:10 INFO - 'config_files': ('talos/linux_config.py',), 05:52:10 INFO - 'default_actions': ('clobber', 05:52:10 INFO - 'read-buildbot-config', 05:52:10 INFO - 'download-and-extract', 05:52:10 INFO - 'populate-webroot', 05:52:10 INFO - 'create-virtualenv', 05:52:10 INFO - 'install', 05:52:10 INFO - 'run-tests'), 05:52:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:10 INFO - 'download_minidump_stackwalk': True, 05:52:10 INFO - 'download_symbols': 'ondemand', 05:52:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:10 INFO - 'installer_path': 'installer.exe', 05:52:10 INFO - 'log_level': 'info', 05:52:10 INFO - 'log_name': 'talos', 05:52:10 INFO - 'log_to_console': True, 05:52:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:10 INFO - 'opt_config_files': (), 05:52:10 INFO - 'pip_index': False, 05:52:10 INFO - 'sps_profile': False, 05:52:10 INFO - 'sps_profile_interval': 0, 05:52:10 INFO - 'suite': 'dromaeojs', 05:52:10 INFO - 'system_bits': '32', 05:52:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:10 INFO - 'title': 'talos-linux64-ix-002', 05:52:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:10 INFO - 'use_talos_json': True, 05:52:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:10 INFO - 'work_dir': 'build'} 05:52:10 INFO - ##### 05:52:10 INFO - ##### Running clobber step. 05:52:10 INFO - ##### 05:52:10 INFO - Running pre-action listener: _resource_record_pre_action 05:52:10 INFO - Running main action method: clobber 05:52:10 INFO - rmtree: /builds/slave/test/build 05:52:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:10 INFO - Running post-action listener: _resource_record_post_action 05:52:10 INFO - ##### 05:52:10 INFO - ##### Running read-buildbot-config step. 05:52:10 INFO - ##### 05:52:10 INFO - Running pre-action listener: _resource_record_pre_action 05:52:10 INFO - Running main action method: read_buildbot_config 05:52:10 INFO - Using buildbot properties: 05:52:10 INFO - { 05:52:10 INFO - "project": "", 05:52:10 INFO - "product": "firefox", 05:52:10 INFO - "script_repo_revision": "production", 05:52:10 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:52:10 INFO - "repository": "", 05:52:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:52:10 INFO - "buildid": "20160521031436", 05:52:10 INFO - "pgo_build": "True", 05:52:10 INFO - "basedir": "/builds/slave/test", 05:52:10 INFO - "buildnumber": 247, 05:52:10 INFO - "slavename": "talos-linux64-ix-002", 05:52:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:52:10 INFO - "platform": "ubuntu64_hw", 05:52:10 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:52:10 INFO - "branch": "mozilla-beta", 05:52:10 INFO - "repo_path": "releases/mozilla-beta", 05:52:10 INFO - "revision": "ee9ba5e8d935736380d5c657c67cf2791741b501", 05:52:10 INFO - "stage_platform": "linux64-pgo", 05:52:10 INFO - "builduid": "b14ff78280814770b970e1cef8a91945", 05:52:10 INFO - "slavebuilddir": "test" 05:52:10 INFO - } 05:52:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2. 05:52:10 INFO - Running post-action listener: _resource_record_post_action 05:52:10 INFO - ##### 05:52:10 INFO - ##### Running download-and-extract step. 05:52:10 INFO - ##### 05:52:10 INFO - Running pre-action listener: _resource_record_pre_action 05:52:10 INFO - Running main action method: download_and_extract 05:52:10 INFO - mkdir: /builds/slave/test/build/tests 05:52:10 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')]} 05:52:10 INFO - https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:52:11 INFO - Downloaded 1412 bytes. 05:52:11 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.test_packages.json 05:52:11 INFO - Using the following test package requirements: 05:52:11 INFO - {u'common': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:52:11 INFO - u'cppunittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'firefox-47.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:11 INFO - u'gtest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'firefox-47.0.en-US.linux-x86_64.gtest.tests.zip'], 05:52:11 INFO - u'jittest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'jsshell-linux-x86_64.zip'], 05:52:11 INFO - u'mochitest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'firefox-47.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:11 INFO - u'mozbase': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:52:11 INFO - u'reftest': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'firefox-47.0.en-US.linux-x86_64.reftest.tests.zip'], 05:52:11 INFO - u'talos': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'], 05:52:11 INFO - u'web-platform': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'firefox-47.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:11 INFO - u'webapprt': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'], 05:52:11 INFO - u'xpcshell': [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', 05:52:11 INFO - u'firefox-47.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:11 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:11 INFO - https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:52:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:52:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:13 INFO - Downloaded 23365488 bytes. 05:52:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:52:14 INFO - Return code: 0 05:52:14 INFO - Downloading packages: [u'firefox-47.0.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:52: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')]} 05:52:14 INFO - https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:52:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:52:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip 05:52:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:20 INFO - Downloaded 23365488 bytes. 05:52:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:52:21 INFO - Return code: 0 05:52:21 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')]} 05:52:21 INFO - https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:52:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:52:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:52:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip 05:52:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:22 INFO - Downloaded 10845194 bytes. 05:52:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:52:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:52:22 INFO - Return code: 0 05:52: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')]} 05:52:22 INFO - https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:52:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:52:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:52:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:52:24 INFO - Downloaded 53800578 bytes. 05:52:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:52:24 INFO - mkdir: /builds/slave/test/properties 05:52:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:24 INFO - Contents: 05:52:24 INFO - build_url:https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 05:52:25 INFO - Running post-action listener: _resource_record_post_action 05:52:25 INFO - Running post-action listener: set_extra_try_arguments 05:52:25 INFO - ##### 05:52:25 INFO - ##### Running populate-webroot step. 05:52:25 INFO - ##### 05:52:25 INFO - Running pre-action listener: _resource_record_pre_action 05:52:25 INFO - Running main action method: populate_webroot 05:52:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:25 INFO - '--tppagecycles', 05:52:25 INFO - '7'], 05:52:25 INFO - 'tests': ['tsvgm']}}, 05:52:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:52:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:52:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'tests': ['damp', 'tps']}, 05:52:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['damp', 'tps']}, 05:52:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:52:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:25 INFO - 'other': {'tests': ['a11yr', 05:52:25 INFO - 'ts_paint', 05:52:25 INFO - 'tpaint', 05:52:25 INFO - 'sessionrestore', 05:52:25 INFO - 'sessionrestore_no_auto_restore', 05:52:25 INFO - 'tabpaint']}, 05:52:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['a11yr', 05:52:25 INFO - 'ts_paint', 05:52:25 INFO - 'tpaint', 05:52:25 INFO - 'sessionrestore', 05:52:25 INFO - 'sessionrestore_no_auto_restore', 05:52:25 INFO - 'tabpaint']}, 05:52:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['a11yr', 05:52:25 INFO - 'ts_paint', 05:52:25 INFO - 'tpaint', 05:52:25 INFO - 'sessionrestore', 05:52:25 INFO - 'sessionrestore_no_auto_restore', 05:52:25 INFO - 'tabpaint']}, 05:52:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['a11yr', 05:52:25 INFO - 'ts_paint', 05:52:25 INFO - 'tpaint', 05:52:25 INFO - 'sessionrestore', 05:52:25 INFO - 'sessionrestore_no_auto_restore', 05:52:25 INFO - 'tabpaint']}, 05:52:25 INFO - 'other_l64': {'tests': ['a11yr', 05:52:25 INFO - 'ts_paint', 05:52:25 INFO - 'tpaint', 05:52:25 INFO - 'sessionrestore', 05:52:25 INFO - 'sessionrestore_no_auto_restore', 05:52:25 INFO - 'tabpaint']}, 05:52:25 INFO - 'other_nol64': {'tests': ['a11yr', 05:52:25 INFO - 'ts_paint', 05:52:25 INFO - 'tpaint', 05:52:25 INFO - 'sessionrestore', 05:52:25 INFO - 'sessionrestore_no_auto_restore', 05:52:25 INFO - 'tabpaint']}, 05:52:25 INFO - 'svgr': {'tests': ['tsvgx', 05:52:25 INFO - 'tsvgr_opacity', 05:52:25 INFO - 'tart', 05:52:25 INFO - 'tscrollx', 05:52:25 INFO - 'cart']}, 05:52:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['tsvgx', 05:52:25 INFO - 'tsvgr_opacity', 05:52:25 INFO - 'tart', 05:52:25 INFO - 'tscrollx', 05:52:25 INFO - 'cart']}, 05:52:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'tests': ['tp5o']}, 05:52:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'talos_options': ['--e10s'], 05:52:25 INFO - 'tests': ['tp5o']}, 05:52:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'talos_options': ['--xperf_path', 05:52:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:25 INFO - 'tests': ['tp5n']}, 05:52:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:25 INFO - 'talos_options': ['--e10s', 05:52:25 INFO - '--xperf_path', 05:52:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:25 INFO - 'tests': ['tp5n']}}, 05:52:25 INFO - 'talos.zip': {'path': '', 05:52:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:25 INFO - Running post-action listener: _resource_record_post_action 05:52:25 INFO - ##### 05:52:25 INFO - ##### Running create-virtualenv step. 05:52:25 INFO - ##### 05:52:25 INFO - Running pre-action listener: _resource_record_pre_action 05:52:25 INFO - Running main action method: create_virtualenv 05:52:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:25 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 05:52:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:25 INFO - Using real prefix '/usr' 05:52:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:27 INFO - Installing pip.................done. 05:52:27 INFO - Return code: 0 05:52:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:27 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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:27 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 05:52:27 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 05:52:27 INFO - Using env: {'DISPLAY': ':0', 05:52:27 INFO - 'HOME': '/home/cltbld', 05:52:27 INFO - 'LANG': 'en_US.UTF-8', 05:52:27 INFO - 'LANGUAGE': 'en_US:en', 05:52:27 INFO - 'LOGNAME': 'cltbld', 05:52:27 INFO - 'MAIL': '/var/mail/cltbld', 05:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:27 INFO - 'MOZ_NO_REMOTE': '1', 05:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:27 INFO - 'NO_EM_RESTART': '1', 05:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:27 INFO - 'PWD': '/builds/slave/test', 05:52:27 INFO - 'SHELL': '/bin/bash', 05:52:27 INFO - 'SHLVL': '1', 05:52:27 INFO - 'TERM': 'linux', 05:52:27 INFO - 'TMOUT': '86400', 05:52:27 INFO - 'USER': 'cltbld', 05:52:27 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:27 INFO - '_': '/tools/buildbot/bin/python'} 05:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:28 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 05:52:28 INFO - Cleaning up... 05:52:28 INFO - Return code: 0 05:52:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:52:28 INFO - Using env: {'DISPLAY': ':0', 05:52:28 INFO - 'HOME': '/home/cltbld', 05:52:28 INFO - 'LANG': 'en_US.UTF-8', 05:52:28 INFO - 'LANGUAGE': 'en_US:en', 05:52:28 INFO - 'LOGNAME': 'cltbld', 05:52:28 INFO - 'MAIL': '/var/mail/cltbld', 05:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:28 INFO - 'MOZ_NO_REMOTE': '1', 05:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:28 INFO - 'NO_EM_RESTART': '1', 05:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:28 INFO - 'PWD': '/builds/slave/test', 05:52:28 INFO - 'SHELL': '/bin/bash', 05:52:28 INFO - 'SHLVL': '1', 05:52:28 INFO - 'TERM': 'linux', 05:52:28 INFO - 'TMOUT': '86400', 05:52:28 INFO - 'USER': 'cltbld', 05:52:28 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:28 INFO - '_': '/tools/buildbot/bin/python'} 05:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:28 INFO - Downloading/unpacking psutil>=0.7.1 05:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:30 INFO - Installing collected packages: psutil 05:52:30 INFO - Running setup.py install for psutil 05:52:30 INFO - building 'psutil._psutil_linux' extension 05:52:30 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 05:52:30 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 05:52:30 INFO - building 'psutil._psutil_posix' extension 05:52:30 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 05:52:30 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 05:52:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:30 INFO - Successfully installed psutil 05:52:30 INFO - Cleaning up... 05:52:30 INFO - Return code: 0 05:52:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:52:30 INFO - Using env: {'DISPLAY': ':0', 05:52:30 INFO - 'HOME': '/home/cltbld', 05:52:30 INFO - 'LANG': 'en_US.UTF-8', 05:52:30 INFO - 'LANGUAGE': 'en_US:en', 05:52:30 INFO - 'LOGNAME': 'cltbld', 05:52:30 INFO - 'MAIL': '/var/mail/cltbld', 05:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:30 INFO - 'MOZ_NO_REMOTE': '1', 05:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:30 INFO - 'NO_EM_RESTART': '1', 05:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:30 INFO - 'PWD': '/builds/slave/test', 05:52:30 INFO - 'SHELL': '/bin/bash', 05:52:30 INFO - 'SHLVL': '1', 05:52:30 INFO - 'TERM': 'linux', 05:52:30 INFO - 'TMOUT': '86400', 05:52:30 INFO - 'USER': 'cltbld', 05:52:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:30 INFO - '_': '/tools/buildbot/bin/python'} 05:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:52:32 INFO - Installing collected packages: mozsystemmonitor 05:52:32 INFO - Running setup.py install for mozsystemmonitor 05:52:32 INFO - Successfully installed mozsystemmonitor 05:52:32 INFO - Cleaning up... 05:52:33 INFO - Return code: 0 05:52:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:52:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:52:33 INFO - Using env: {'DISPLAY': ':0', 05:52:33 INFO - 'HOME': '/home/cltbld', 05:52:33 INFO - 'LANG': 'en_US.UTF-8', 05:52:33 INFO - 'LANGUAGE': 'en_US:en', 05:52:33 INFO - 'LOGNAME': 'cltbld', 05:52:33 INFO - 'MAIL': '/var/mail/cltbld', 05:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:33 INFO - 'MOZ_NO_REMOTE': '1', 05:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:33 INFO - 'NO_EM_RESTART': '1', 05:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:33 INFO - 'PWD': '/builds/slave/test', 05:52:33 INFO - 'SHELL': '/bin/bash', 05:52:33 INFO - 'SHLVL': '1', 05:52:33 INFO - 'TERM': 'linux', 05:52:33 INFO - 'TMOUT': '86400', 05:52:33 INFO - 'USER': 'cltbld', 05:52:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:33 INFO - '_': '/tools/buildbot/bin/python'} 05:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:35 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:35 INFO - Downloading docopt-0.6.1.tar.gz 05:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:35 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:35 INFO - Running setup.py install for blobuploader 05:52:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:36 INFO - Running setup.py install for requests 05:52:36 INFO - Running setup.py install for docopt 05:52:36 INFO - Successfully installed blobuploader requests docopt 05:52:36 INFO - Cleaning up... 05:52:36 INFO - Return code: 0 05:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:36 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')]} 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 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')]} 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:36 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 05:52:36 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 05:52:36 INFO - Using env: {'DISPLAY': ':0', 05:52:36 INFO - 'HOME': '/home/cltbld', 05:52:36 INFO - 'LANG': 'en_US.UTF-8', 05:52:36 INFO - 'LANGUAGE': 'en_US:en', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MAIL': '/var/mail/cltbld', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SHLVL': '1', 05:52:36 INFO - 'TERM': 'linux', 05:52:36 INFO - 'TMOUT': '86400', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - '_': '/tools/buildbot/bin/python'} 05:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:36 INFO - Running setup.py (path:/tmp/pip-fIBH6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:36 INFO - Running setup.py (path:/tmp/pip-DHiATd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:36 INFO - Running setup.py (path:/tmp/pip-7tzkiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:36 INFO - Running setup.py (path:/tmp/pip-QwEbN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:36 INFO - Running setup.py (path:/tmp/pip-X95UmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:36 INFO - Running setup.py (path:/tmp/pip-9Lorfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:37 INFO - Running setup.py (path:/tmp/pip-FQcTSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:37 INFO - Running setup.py (path:/tmp/pip-sXq5A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:37 INFO - Running setup.py (path:/tmp/pip-u6Keeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:37 INFO - Running setup.py (path:/tmp/pip-LuPRj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:37 INFO - Running setup.py (path:/tmp/pip-tjQe3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:37 INFO - Running setup.py (path:/tmp/pip-_zAXe2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:37 INFO - Running setup.py (path:/tmp/pip-iBDgum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:37 INFO - Running setup.py (path:/tmp/pip-7BST0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:37 INFO - Running setup.py (path:/tmp/pip-UdOmEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:37 INFO - Running setup.py (path:/tmp/pip-u7EbSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:37 INFO - Running setup.py (path:/tmp/pip-HPVt1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:37 INFO - Running setup.py install for manifestparser 05:52:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:37 INFO - Running setup.py install for mozcrash 05:52:37 INFO - Running setup.py install for mozdebug 05:52:37 INFO - Running setup.py install for mozdevice 05:52:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for mozfile 05:52:38 INFO - Running setup.py install for mozhttpd 05:52:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for mozinfo 05:52:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for mozInstall 05:52:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for mozleak 05:52:38 INFO - Running setup.py install for mozlog 05:52:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for moznetwork 05:52:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for mozprocess 05:52:38 INFO - Running setup.py install for mozprofile 05:52:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for mozrunner 05:52:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:38 INFO - Running setup.py install for mozscreenshot 05:52:39 INFO - Running setup.py install for moztest 05:52:39 INFO - Running setup.py install for mozversion 05:52:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:39 INFO - Cleaning up... 05:52:39 INFO - Return code: 0 05:52:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:39 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')]} 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 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')]} 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:39 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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:39 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 05:52:39 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 05:52:39 INFO - Using env: {'DISPLAY': ':0', 05:52:39 INFO - 'HOME': '/home/cltbld', 05:52:39 INFO - 'LANG': 'en_US.UTF-8', 05:52:39 INFO - 'LANGUAGE': 'en_US:en', 05:52:39 INFO - 'LOGNAME': 'cltbld', 05:52:39 INFO - 'MAIL': '/var/mail/cltbld', 05:52:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:39 INFO - 'MOZ_NO_REMOTE': '1', 05:52:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:39 INFO - 'NO_EM_RESTART': '1', 05:52:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:39 INFO - 'PWD': '/builds/slave/test', 05:52:39 INFO - 'SHELL': '/bin/bash', 05:52:39 INFO - 'SHLVL': '1', 05:52:39 INFO - 'TERM': 'linux', 05:52:39 INFO - 'TMOUT': '86400', 05:52:39 INFO - 'USER': 'cltbld', 05:52:39 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:39 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:39 INFO - Running setup.py (path:/tmp/pip-sb2cQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:39 INFO - Running setup.py (path:/tmp/pip-etbRxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:39 INFO - Running setup.py (path:/tmp/pip-Qw4r7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:39 INFO - Running setup.py (path:/tmp/pip-2OKwqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:39 INFO - Running setup.py (path:/tmp/pip-iYapw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:39 INFO - Running setup.py (path:/tmp/pip-gR6zOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:39 INFO - Running setup.py (path:/tmp/pip-9KSwAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:39 INFO - Running setup.py (path:/tmp/pip-Fcf3ZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:39 INFO - Running setup.py (path:/tmp/pip-fJZpwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:39 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)) 05:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:39 INFO - Running setup.py (path:/tmp/pip-K7zPJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:40 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)) 05:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:40 INFO - Running setup.py (path:/tmp/pip-s3UAPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:40 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)) 05:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:40 INFO - Running setup.py (path:/tmp/pip-irm2Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:40 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)) 05:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:40 INFO - Running setup.py (path:/tmp/pip-fhCL2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:40 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)) 05:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:40 INFO - Running setup.py (path:/tmp/pip-IcC_eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:40 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)) 05:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:40 INFO - Running setup.py (path:/tmp/pip-Kej42q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:40 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)) 05:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:40 INFO - Running setup.py (path:/tmp/pip-8HqtwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:40 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)) 05:52:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:40 INFO - Running setup.py (path:/tmp/pip-TauwwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:40 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)) 05:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:40 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)) 05:52:40 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)) 05:52:40 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)) 05:52:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:42 INFO - Downloading blessings-1.6.tar.gz 05:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:42 INFO - Installing collected packages: blessings 05:52:42 INFO - Running setup.py install for blessings 05:52:42 INFO - Successfully installed blessings 05:52:42 INFO - Cleaning up... 05:52:42 INFO - Return code: 0 05:52:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:42 INFO - Reading from file tmpfile_stdout 05:52:42 INFO - Current package versions: 05:52:42 INFO - argparse == 1.2.1 05:52:42 INFO - blessings == 1.6 05:52:42 INFO - blobuploader == 1.2.4 05:52:42 INFO - docopt == 0.6.1 05:52:42 INFO - manifestparser == 1.1 05:52:42 INFO - mozInstall == 1.12 05:52:42 INFO - mozcrash == 0.17 05:52:42 INFO - mozdebug == 0.1 05:52:42 INFO - mozdevice == 0.48 05:52:42 INFO - mozfile == 1.2 05:52:42 INFO - mozhttpd == 0.7 05:52:42 INFO - mozinfo == 0.9 05:52:42 INFO - mozleak == 0.1 05:52:42 INFO - mozlog == 3.1 05:52:42 INFO - moznetwork == 0.27 05:52:42 INFO - mozprocess == 0.22 05:52:42 INFO - mozprofile == 0.28 05:52:42 INFO - mozrunner == 6.11 05:52:42 INFO - mozscreenshot == 0.1 05:52:42 INFO - mozsystemmonitor == 0.0 05:52:42 INFO - moztest == 0.7 05:52:42 INFO - mozversion == 1.4 05:52:42 INFO - psutil == 3.1.1 05:52:42 INFO - requests == 1.2.3 05:52:42 INFO - wsgiref == 0.1.2 05:52:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:42 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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:42 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 05:52:42 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 05:52:42 INFO - Using env: {'DISPLAY': ':0', 05:52:42 INFO - 'HOME': '/home/cltbld', 05:52:42 INFO - 'LANG': 'en_US.UTF-8', 05:52:42 INFO - 'LANGUAGE': 'en_US:en', 05:52:42 INFO - 'LOGNAME': 'cltbld', 05:52:42 INFO - 'MAIL': '/var/mail/cltbld', 05:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:42 INFO - 'MOZ_NO_REMOTE': '1', 05:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:42 INFO - 'NO_EM_RESTART': '1', 05:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:42 INFO - 'PWD': '/builds/slave/test', 05:52:42 INFO - 'SHELL': '/bin/bash', 05:52:42 INFO - 'SHLVL': '1', 05:52:42 INFO - 'TERM': 'linux', 05:52:42 INFO - 'TMOUT': '86400', 05:52:42 INFO - 'USER': 'cltbld', 05:52:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:42 INFO - '_': '/tools/buildbot/bin/python'} 05:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 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)) 05:52:42 INFO - Cleaning up... 05:52:42 INFO - Return code: 0 05:52:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:42 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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:42 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 05:52:42 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 05:52:42 INFO - Using env: {'DISPLAY': ':0', 05:52:42 INFO - 'HOME': '/home/cltbld', 05:52:42 INFO - 'LANG': 'en_US.UTF-8', 05:52:42 INFO - 'LANGUAGE': 'en_US:en', 05:52:42 INFO - 'LOGNAME': 'cltbld', 05:52:42 INFO - 'MAIL': '/var/mail/cltbld', 05:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:42 INFO - 'MOZ_NO_REMOTE': '1', 05:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:42 INFO - 'NO_EM_RESTART': '1', 05:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:42 INFO - 'PWD': '/builds/slave/test', 05:52:42 INFO - 'SHELL': '/bin/bash', 05:52:42 INFO - 'SHLVL': '1', 05:52:42 INFO - 'TERM': 'linux', 05:52:42 INFO - 'TMOUT': '86400', 05:52:42 INFO - 'USER': 'cltbld', 05:52:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:42 INFO - '_': '/tools/buildbot/bin/python'} 05:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:43 INFO - Downloading/unpacking jsonschema 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:44 INFO - Downloading/unpacking functools32 (from jsonschema) 05:52:44 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 05:52:44 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 05:52:44 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 05:52:44 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 05:52:44 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 05:52:44 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 05:52:45 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:45 INFO - warning: no files found matching '*.txt' 05:52:45 INFO - no previously-included directories found matching 'build' 05:52:45 INFO - no previously-included directories found matching 'dist' 05:52:45 INFO - no previously-included directories found matching '.git*' 05:52:45 INFO - Installing collected packages: jsonschema, functools32 05:52:45 INFO - Running setup.py install for functools32 05:52:45 INFO - warning: no files found matching '*.txt' 05:52:45 INFO - no previously-included directories found matching 'build' 05:52:45 INFO - no previously-included directories found matching 'dist' 05:52:45 INFO - no previously-included directories found matching '.git*' 05:52:45 INFO - Successfully installed jsonschema functools32 05:52:45 INFO - Cleaning up... 05:52:45 INFO - Return code: 0 05:52:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:45 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 0x7fa73ef3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2965410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', '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 05:52:45 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 05:52:45 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 05:52:45 INFO - Using env: {'DISPLAY': ':0', 05:52:45 INFO - 'HOME': '/home/cltbld', 05:52:45 INFO - 'LANG': 'en_US.UTF-8', 05:52:45 INFO - 'LANGUAGE': 'en_US:en', 05:52:45 INFO - 'LOGNAME': 'cltbld', 05:52:45 INFO - 'MAIL': '/var/mail/cltbld', 05:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:45 INFO - 'MOZ_NO_REMOTE': '1', 05:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:45 INFO - 'NO_EM_RESTART': '1', 05:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:45 INFO - 'PWD': '/builds/slave/test', 05:52:45 INFO - 'SHELL': '/bin/bash', 05:52:45 INFO - 'SHLVL': '1', 05:52:45 INFO - 'TERM': 'linux', 05:52:45 INFO - 'TMOUT': '86400', 05:52:45 INFO - 'USER': 'cltbld', 05:52:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:45 INFO - '_': '/tools/buildbot/bin/python'} 05:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:45 INFO - Downloading/unpacking flake8 05:52:45 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 05:52:45 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 05:52:45 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 05:52:45 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 05:52:45 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 05:52:45 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 05:52:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:52:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:52:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:47 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 05:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:52:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:48 INFO - no previously-included directories found matching 'docs/_build' 05:52:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:52:48 INFO - Running setup.py install for pep8 05:52:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:48 INFO - no previously-included directories found matching 'docs/_build' 05:52:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:52:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:52:48 INFO - Cleaning up... 05:52:48 INFO - Return code: 0 05:52:48 INFO - Running post-action listener: _resource_record_post_action 05:52:48 INFO - Running post-action listener: _start_resource_monitoring 05:52:48 INFO - Starting resource monitoring. 05:52:48 INFO - ##### 05:52:48 INFO - ##### Running install step. 05:52:48 INFO - ##### 05:52:48 INFO - Running pre-action listener: _resource_record_pre_action 05:52:48 INFO - Running main action method: install 05:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:48 INFO - Reading from file tmpfile_stdout 05:52:48 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:48 INFO - Reading from file tmpfile_stdout 05:52:48 INFO - Output received: 05:52:48 INFO - Usage: mozinstall [options] installer 05:52:48 INFO - Options: 05:52:48 INFO - -h, --help show this help message and exit 05:52:48 INFO - -d DEST, --destination=DEST 05:52:48 INFO - Directory to install application into. [default: 05:52:48 INFO - "/builds/slave/test"] 05:52:48 INFO - --app=APP Application being installed. [default: firefox] 05:52:48 INFO - mkdir: /builds/slave/test/build/application 05:52:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:53:01 INFO - Reading from file tmpfile_stdout 05:53:01 INFO - Output received: 05:53:01 INFO - /builds/slave/test/build/application/firefox/firefox 05:53:01 INFO - Running post-action listener: _resource_record_post_action 05:53:01 INFO - ##### 05:53:01 INFO - ##### Running run-tests step. 05:53:01 INFO - ##### 05:53:01 INFO - Running pre-action listener: _resource_record_pre_action 05:53:01 INFO - Running main action method: run_tests 05:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:01 INFO - Python 2.7.3 05:53:01 INFO - Return code: 0 05:53:01 INFO - grabbing minidump binary from tooltool 05:53: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')]} 05:53:01 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 0x29f4160>, '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 0x29f5060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f54f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:01 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 05:53:01 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 05:53:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:01 INFO - Return code: 0 05:53:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:53:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:53:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:53:02 INFO - Return code: 0 05:53:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 05:53:02 INFO - Using env: {'DISPLAY': ':0', 05:53:02 INFO - 'HOME': '/home/cltbld', 05:53:02 INFO - 'LANG': 'en_US.UTF-8', 05:53:02 INFO - 'LANGUAGE': 'en_US:en', 05:53:02 INFO - 'LOGNAME': 'cltbld', 05:53:02 INFO - 'MAIL': '/var/mail/cltbld', 05:53:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:02 INFO - 'MOZ_NO_REMOTE': '1', 05:53:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:02 INFO - 'NO_EM_RESTART': '1', 05:53:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:02 INFO - 'PWD': '/builds/slave/test', 05:53:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:02 INFO - 'SHELL': '/bin/bash', 05:53:02 INFO - 'SHLVL': '1', 05:53:02 INFO - 'TERM': 'linux', 05:53:02 INFO - 'TMOUT': '86400', 05:53:02 INFO - 'USER': 'cltbld', 05:53:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721', 05:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:02 INFO - '_': '/tools/buildbot/bin/python'} 05:53:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 05:53:02 INFO - mozversion application_buildid: 20160521031436 05:53:02 INFO - mozversion application_changeset: ee9ba5e8d935736380d5c657c67cf2791741b501 05:53:02 INFO - mozversion application_display_name: Firefox 05:53:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:02 INFO - mozversion application_name: Firefox 05:53:02 INFO - mozversion application_remotingname: firefox 05:53:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:53:02 INFO - mozversion application_vendor: Mozilla 05:53:02 INFO - mozversion application_version: 47.0 05:53:02 INFO - mozversion platform_buildid: 20160521031436 05:53:02 INFO - mozversion platform_changeset: ee9ba5e8d935736380d5c657c67cf2791741b501 05:53:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:53:02 INFO - mozversion platform_version: 47.0 05:53:02 INFO - using testdate: 1463835182 05:53:02 INFO - actual date: 1463835182 05:53:02 INFO - starting webserver on 'localhost:59611' 05:53:02 INFO - SUITE-START | Running 2 tests 05:53:02 INFO - TEST-START | dromaeo_css 05:53:02 INFO - operating with platform_type : linux_ 05:53:02 INFO - Initialising browser for dromaeo_css test... 05:53:02 INFO - TEST-INFO | started process 17256 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzC6Jjo/profile http://localhost:59611/getInfo.html) 05:53:06 INFO - PROCESS | 17256 | __metrics Screen width/height:1600/1200 05:53:06 INFO - PROCESS | 17256 | colorDepth:24 05:53:06 INFO - PROCESS | 17256 | Browser inner width/height: 1024/697 05:53:06 INFO - PROCESS | 17256 | __metrics 05:53:07 INFO - PROCESS | 17256 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:07 INFO - TEST-INFO | 17256: exit 0 05:53:07 INFO - Browser initialized. 05:53:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:07 INFO - TEST-INFO | started process 17344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzC6Jjo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:19 INFO - PROCESS | 17344 | RSS: Main: 138342400 05:53:19 INFO - PROCESS | 17344 | 05:54:10 INFO - PROCESS | 17344 | 1463835250155 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] 05:56:18 INFO - PROCESS | 17344 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59611/tests/dromaeo/cssquery-ext.html) 05:56:19 INFO - PROCESS | 17344 | RSS: Main: 257212416 05:56:19 INFO - PROCESS | 17344 | 05:59:21 INFO - PROCESS | 17344 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-ext.html (next: http://localhost:59611/tests/dromaeo/cssquery-jquery.html) 05:59:21 INFO - PROCESS | 17344 | RSS: Main: 220663808 05:59:21 INFO - PROCESS | 17344 | 06:02:23 INFO - PROCESS | 17344 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59611/tests/dromaeo/cssquery-mootools.html) 06:02:24 INFO - PROCESS | 17344 | RSS: Main: 235995136 06:02:24 INFO - PROCESS | 17344 | 06:05:25 INFO - PROCESS | 17344 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59611/tests/dromaeo/cssquery-prototype.html) 06:05:26 INFO - PROCESS | 17344 | RSS: Main: 207466496 06:05:26 INFO - PROCESS | 17344 | 06:08:28 INFO - PROCESS | 17344 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59611/tests/dromaeo/cssquery-yui.html) 06:08:29 INFO - PROCESS | 17344 | RSS: Main: 204349440 06:08:29 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | Cycle 1(1): loaded http://localhost:59611/tests/dromaeo/cssquery-yui.html (next: http://localhost:59611/tests/dromaeo/cssquery-dojo.html) 06:11:31 INFO - PROCESS | 17344 | RSS: Main: 232271872 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | __start_tp_report 06:11:31 INFO - PROCESS | 17344 | _x_x_mozilla_page_load 06:11:31 INFO - PROCESS | 17344 | _x_x_mozilla_page_load_details 06:11:31 INFO - PROCESS | 17344 | |i|pagename|runs| 06:11:31 INFO - PROCESS | 17344 | |0;dojo.html;3286.819224942628;3346.9497957530657;3371.0561042907993;3379.79721216727;3408.6591340865907;5369.328833895763;5401.27082843816;5409.621326507141;5411.729413529322;5457.781688732456;5418.756155972981;5435;5449.155380915954;5454.91817622736;5467.644603100795;4870.123377791996;4928.852134435972;5001.249812528114;5001.549860512553;5062.645614806965;4945.480724523927;5002.874928126789;5044.167712327461;5054.671446355994;5055.696658200502;5026.145555255597;5044.82343117991;5051.949480505203;5054.039732450841;5066.620003499734;4510.548945105464;4850.854474365775;4967.826126085606;4979;5030.245463180516;4936.6050715943;4949.48030456804;4962.727050012248;4964.826231081895;4982.850514484571;5273.709945952971;5282.788688452457;5318.574514038867;5331.306930099101;5342.358916929955;5594.748236329375;5835.562332825013;5869.383714709937;5879.353271140171;5958.672273024982;5832.6500409975115;5880.764769409218;5918.8816223675285;5926.318473375574;5947.197128387699;5496.670199787985;5530.640508366983;5548.195511650828;5552.69460179694;5552.833414997556;5773.740181691834;5957.970210149008;6002.6698531580305;6060;6066.332703402622;5754.625949313281;5756.079027355603;5756.453136951983;5756.539476841926;5771.538276937918;5817.476427121579;5857.179994800731;5868.911966320423;5874.32445268791;5903.911441328383;5666.660000399989;5840;5867.911981320283;5876.324222714357;5890.852728681732;5761.020626493422;5763.625364351387;5821.970890145522;5838.211841401357;5883.117532370179;4300.827966881352;4422.292433210735;4455.1980643484485;4463.910721785611;4478.104379124188;3985.860494882665;4026.791962411265;4043.7169398141846;4058.1680755445063;4088.223237584909;5584.497395234367;5600.187972743929;5616.297962754656;5637.154426836008;5640.097584386478;5692.686902220417;5783.074708046693;5872.972229859757;5883.911741323884;5889.617174883704;5466.262054622654;5530.557555395559;5545.667259964415;5564.638298510584;5569.554435645138;4984.825531106394;4998.000399920031;5002.824901128443;5014.448410674823;5019.347484826949;5895.115732640053;6037;6054.8183554493435;6062.151298818169;6113.749968914014;5865;5873.324567674772;5894.823155305347;5904.291485021825;5924.7926322578505;6015.218021657157;6101.450869421596;6115.938840611537;6116.663583502772;6137.570370074052;5656.095024796013;5799.449052340021;5824.15549745293;5884.94071067212;5907.261592300963;5932.0508718604815;5953.791617293374;5955.047192449188;5985.162077309267;5999.040153575407;5742.28221472316;5764.855878603068;5767.6539407634;5811.593188476766;5816.069428891357;5533.197686335539;5739.569532285179;5788.450097240755;5833.737481813244;5851.093080572518;5623.915641265467;5652.971735141298;5653.858653533694;5655.4344565543115;5656.886862262814;5550.750216240198;5760.740766665594;5776.826695199151;5781.046127388934;5819.563532734977;5416.21464887597;5543.667379957215;5602.831915042555;5642.83071507839;5668.773249069991 06:11:31 INFO - PROCESS | 17344 | |1;ext.html;505.75470896615144;507.90349833531627;531.3490973557392;572.1303618499878;593.057039307501;38175;38951.805240973794;39139.21721565567;39217.21565568687;39273.21453570927;43069.78465107678;43632.56367436325;43673.563264367345;43729;43773;8806.64773409063;8982.910170898305;9008.0541543138;9017.23353514952;9018.909810901905;8795.296376289882;8886.422382545114;8903.109689031078;8912.821743565124;8986.460812351279;8906.376553641248;8932.508712020835;8970.416922900024;8970.923489181307;8981.730548083568;8886.511241881726;9066.138716821892;9133.908660913372;9135.314851386172;9136.63453461864;8962.551872406353;9077.863832042525;9083.45499270046;9150.54247287633;9167.083291670846;42319.57680423218;42322;42323.7883810579;42378.57621423808;42791;3579.838907249154;3655.670989610948;3756.34264003801;4187.539370669224;4269.829206831723;31362;31694.207644808834;31898.840505797554;32198.839005805054;32500.349993000244;4179.080602267496;4194.4337514435465;4207.26372884747;4222.261104306734;4284.828606855722;292650;292880;293016;293946;295298;45133;61905.69047154736;62061.37938620556;62162.37837621656;62430;43801.78099109484;43850;43864.12271754611;43912.12175756467;44187.55812441834;15908.522744317688;16181.352745890032;16230.837691622932;16264.268107935171;16286;11923.701907452383;11938.88061119395;11963.760724785456;11975;12033.097517686208;14644.780328295084;14699.338529766186;14915.328810203568;14995.250237488082;15059.774103388458;5838;5916.467517923407;5961.880762384815;5963.165156878041;5985;986.6152200641756;1043.5773511727612;1061.6337363609543;1089.3572792052728;1104.2380757277454;28974.565381519293;29019.70980290212;29075.418491630047;29749.405011899642;29967.250818729706;1093.8523299354645;1125.9493322800495;1129.7458071933913;1134.013408334754;1222.0834374219335;15147.242637868063;15268.465603703817;15470.071795692294;15543;15721.585057344666;348712;355525;356054;356828;359011;55250;55399;55565.44434555683;55623.16565251524;55727;1230.6923269182705;1380.2615600653603;1406.2476575032308;1414.7807089901082;1420.155007770375;27446.45107097807;28535.36859261082;28815.56776648394;28835.279118022216;28882.27794305159;43830.12339753251;44220.55779442293;44243.77878110589;44429;44793.552064478936;192675;193824;193975;194067;194159;28859;33710.32579348448;34032.829835850665;34291.314173716884;34774;42114.57885421229;42413.78793106015;42541.78729106458;43566.78216608897;43891.56108438875;36082.8195859019;36285.81857090697;36655.633443665225;36681.266374671824;36844.078898027765;35760.463593045606;36154;36531.26937461289;36891;36908.26183476369;36565.81717091398;36613.450798238584;37054;37605;37635.81182094072;31557.36885262236;33036;33180.83409582936;33383.49924751179;33391.49912751359;25496.362590935376;25750.356241094123;25768.742312576633;26001.73998259993;26357.472850542497 06:11:31 INFO - PROCESS | 17344 | |2;jquery.html;352.38157034404634;356.6487010294859;358.0440224600317;361.41992102675204;364.2005797274982;17359.30562777489;17554.561135971606;18902.527436814085;18920.810791892076;18998.810011899895;15974.600634984132;18323.725144122847;18355.898646081212;18406.539836504093;18432;4734;4997.100521906055;5000.324956130912;5008.449070602231;5036.722980236085;3988.282109220339;4962.330085438456;5399.217113518537;5681.659100453986;5698.43015698431;5666.688332141731;5687.6303040302455;5701.258836351269;5710.5717071219615;5715.057015592422;5276.657017293864;5464.3442786865435;5478.616496845222;5480.986017586739;5668.348139963916;5179.974100129513;5230.320058392423;5236.554892834114;5243.318368612094;5623.80316688918;21145.942702864795;21266;21676.566468670695;21843.672344914838;21909.452263693376;2124.3626911926362;2175.3908905506482;2273.488465095357;2695.218386667864;3049.5883055787626;10168.13570846479;10304.433256170907;11268.985791278825;11289.830652540219;13415.664608384868;1890.2533499267713;1917.3576851754679;1932.3236867096543;1945.8151475609795;1956.7162761399659;59730.70134649342;60951.999999999556;62080.689596552176;65610;66671.333286667;9631.325807193569;9828.361156524803;10179.592816287266;10193.133583645325;10234.33476824004;14110.929445352913;14111.647208819862;14157.85842141586;14247.64380890486;14251.928740356232;7973.441859069925;7988.480748751429;8017.198280171936;8040.4773689711155;8107.432479726481;7979.640916158787;7995.200479951958;8046.959765201136;8049;8077.353811695168;4511.526289739596;4581.79381927814;4607.9308810367875;4612.74629895359;4647.37260469839;1656.7514872769182;1759.3314540474537;1787.4280230326171;1821.7176337667418;1874.3158747057225;953.823542644613;1007.1338648762058;1063.8138325792954;1069.1820757120809;1139.7093741096132;16737.748933766004;17097.658046838995;17466.515346195716;17525.123743812757;17808.684870966692;984.6356847966155;1016.4765145949842;1049.679847646475;1057.3814318623538;1119.4682525800342;9671.742673452407;10065.64770233053;10118.645847395454;10152.898471015344;10373.962603739566;476129;476965;485816;486656;507566;75185;79982.6000869992;80479.59760201162;82516;82871.17128828635;1084.1164450972433;1101.438266484099;1105.077260487502;1105.7622611138484;1116.2744216259496;15942.760858587362;15946.282417291482;16020.839791601935;16097.275622597246;16195.59511012187;34801.47797783086;35088.47367289442;35293.82353088321;35785.82107089552;36166.63833361633;50641;52025.479745202065;52380.21429678634;52729.472705272456;53174.734126329124;7476.925230747623;7516.924830751623;7627.466077374531;7733.883991740241;7780.727674531364;10884.61903833362;11242.381669008282;11653.825192621947;12343.814842777545;12417.813732793835;10164;10438.63464778729;10765.354078754986;10847.945760271148;10903.236773425784;9452;9470.621175152917;9624.51877406141;10178.898211017795;10317.27779055489;9432.434053956784;9801;10832.24174307791;10871.239013268996;11115.72210694739;7695.461317707931;7697.268759467842;7715.112762032438;7797.7660670179985;7830.608469576612;10219.386836789816;10955.34267943926;11003.22977391575;11053.613123540637;11055.170862185529 06:11:31 INFO - PROCESS | 17344 | |3;mootools.html;1451.2598574726899;1531.1720698254364;1600.8239093699694;1831.8992455414955;1936.6126774645065;7788.143304236536;8004.239597238267;8039.5176289422525;8052.83894322114;8103;7791.727289544867;7929.405294602899;7944.285014348708;7956.164602716718;7974.561399123046;2344.2264052862556;2392.940176495593;2393.066703985447;2394.7724966128276;2395.089865850974;2403.267003563912;2444.4377793107597;2474.5174690935273;2489.891998060855;2495.089292408267;2421.0436877433403;2435.476372579895;2444.841085329448;2465.100238412975;2468.2348471973655;2446.645236440715;2454.1165180534995;2467.432490527171;2472.2336075816465;2475.1955614425206;2436.1838784007377;2448.669429626995;2454.619533972237;2455.9017639294584;2457.82795204334;8208.876866847002;8249.670013199464;8250.051244106944;8254.174582541698;8256.545889976049;5100.974495127538;5190.32525771651;5208.609354298443;5230.267762513251;5240.737963101829;3186.2512309607223;3193.1857376369107;3271.8364081795817;3285.917852053694;3299.2741596848655;949.852772820214;969.4038166527605;1000.6697789729371;1002.8646132772055;1014.4572653630346;11341.603043893425;11484.36835974021;11490.54037838477;11535.365554894477;11615.186936914419;4708.4349878014855;4723.0789995951145;4808.158572249842;4810.374651295379;4816.54242846929;9906.356086854476;9927.50362481873;9929.453880036523;10002.149817265614;10006.69979900604;5302.628815982845;5346.4118946915805;5356;5369.838904832861;5397.595180361489;4078.8164532596106;4596.517365676623;4673;4724.976375118103;4887.462379138292;3887.1836914248324;3913.96279985804;3948.6446219840354;3978.0651546886456;3996.3406038003986;1208.667616405478;1212.3271584270815;1218.8171774233936;1219.4756254810338;1231.4150778380197;1277.3932382118605;1300.5318085489216;1307.5881097454271;1379.8965077619018;1383.73017261633;7285.890711639329;7294.1247050354295;7445.404367650575;7614.809629759189;7632.274933881273;532.0317023018147;532.6218384946653;540.6431755041654;542.1244689825982;548.7969451303044;5946.524278057745;5948.524118070544;5960.6721630309885;5998.7300571473515;6014.09788531715;9603.279754018336;9858.95070524657;9883.752906177404;10013.79972400548;10040.79918401628;9491.952540237255;9628.855567166498;9793.657221997197;9821.312508124505;9887;7817.960910195413;7987.400944929037;8002.8799568006525;8038.356931445587;8053.798655033671;7778.805529861573;7828.647710853139;7867.527948323119;7883.605819708877;7899.09160446533;9028.819423611621;9097.40866843653;9277.814443711222;9317.953410232905;9499.240060795259;9466.384684995453;9491.762705932408;9600.087991640783;9616.326857119935;9850.162736167505;6206.844828879314;6651.966740166268;6806.8638627228165;6946.479014074066;7046.2249152594195;7635.541867487968;7640.044994375703;7666.923330766621;7689.769306920802;7710.807229819299;6707.396334329934;6870.175578930561;6878.140232470942;6978.511504194861;7049.541779784297;6873.20958089826;6920.9307906920285;6961.582305061713;6970.581765094111;6985.336393042653;6874.243833178246;6994.545354551938;7038.718451261892;7177.246389129066;7231.385332246818;6566.802995909939;6614.801555953329;6624.56940298879;6663.13379260693;6683.365080317362;6631.469482441296;6633.469322454095;6646.501512386687;6649.567778094409;6702.19573651165 06:11:31 INFO - PROCESS | 17344 | |4;prototype.html;339.3399837316419;347.8851978846981;354.632954891687;354.7179991906434;355.9537260156181;5817.854553636162;5862.091375836747;5863.824085277449;5865.58940874139;5877.41225877412;5811.82564523065;5814.732254420779;5845.7953971611005;5861.501772349356;5876.206712093866;4304.440422745039;4451;4515.706479078849;4524.163029839474;4538.954610453886;4514.887127821798;4532.09358128374;4538.727676339414;4551.590356867898;4566;4378.64970802335;4532.09358128374;4544.863654090383;4550.931736023962;4555.74943378114;4431.844885429011;4543.386642803212;4552.772361381951;4568.200564901129;4568.520305367938;4021.959780402217;4032.5765794591734;4034.3545032794905;4034.798260087013;4037.1723796621914;5582.944170558324;5607.102863541813;5610.326760788691;5617.129344951539;5620.522255608278;5275.314209152824;5277.287566178555;5322.547583455411;5326;5326.201069839516;6150.04674275488;6154.753809847601;6198.721057552421;6201.131841542187;6205.937940620581;4214.072903961123;4348.282533381988;4350.412694286262;4365.9126817463475;4496.145732310883;6408.775692850728;6444.484441244689;6444.838879028015;6457.321981192001;6463.806085817386;4416.6908316418185;4432.379466874576;4440.955590444054;4461.353103799996;4478.037221997286;4484.798184081659;4488.035072459437;4497.527759585197;4521.547845215452;4523.253663145544;5183;5188.169892817206;5192.870178245498;5193.350831146106;5202;6022.705118399565;6191.473724733358;6198;6205.689715514206;6228.781992630236;1556.9688606227812;1571.6463795645889;1584.3741722019738;1587.206396801599;1589.8966567173097;992.9156021738233;1049.5906596427399;1056.4823236614156;1069.502681253221;1089.9128069754402;6033.698315084316;6044.879102418015;6049.848753781191;6052.455279024909;6066.059760737093;6341.524385671093;6359.586626869239;6374.362563743682;6393.552451328363;6398.616083035033;5988.880222395528;6013.428724271187;6023.69881505923;6045.818625441244;6055.152278680988;3422.640622734627;3440.6559344065895;3459.325431540876;3465.3242617689307;3469.479578063311;6459.192600924885;6546.0508226307875;6576.112224849584;6587.143671322793;6618.437432818265;6475.222973243241;6479.157709497735;6494.512911531559;6508.414242718178;6515.902261466082;6522.380373864476;6526.738930442729;6535.019747037983;6543.836404089936;6546.9999999999045;6280.676149824594;6287.30839607652;6287.46556542699;6301.747930082745;6302.684865756602;6041.275046994213;6204.875902481835;6205.751769929152;6224.906626400698;6232.719527621359;6491.221053473613;6540.051692504655;6544.6727663615675;6552.57408268461;6573.375529324707;4348.93476597845;4350.238708225985;4362.3674567186945;4370.060437006059;4376.949532112334;6291.150694656346;6293.465055470337;6312.652804095819;6315.936840631719;6327.557071004985;6122.234720659918;6124.877502449837;6125.356837532173;6166.630002199882;6173.104899789595;6072.635641861502;6115.266168059861;6299.338569450142;6303.779367722291;6309.49524038085;6085.148079268817;6092.238470191226;6141.324454309933;6156.78451254204;6160.353162917829;6247.718852651732;6249.50003999688;6251.4061164189325;6256.906146407899;6267.561270711007;5894.791567728691;6002.669853158118;6107.358727333743;6122.448979591858;6133.601315914451 06:11:31 INFO - PROCESS | 17344 | |5;yui.html;697.2330436519827;705.0587465733246;732.1616748822598;818.4230117766975;829.8630725930218;14320.4987825426;14356.928215358908;14565.635859103528;14587.489437869677;14664;11304.434778261075;13363.19820810752;13452.260125693083;13455.663608409795;13467.191968481899;863.2791618998128;885.7696998780299;889.1863944490783;889.3063410539789;892.7500299916002;905.2395987370608;910.2717825739416;915.5696822493418;916.7845556294266;926.6710317837172;786.5988345943553;952.633236204063;956.909093636107;958.6405098088217;959.040959040959;959.5250351076262;962.3936919740588;963.2246041936238;964.0744884910459;968.951552422376;706.5442789400807;707.8796604577183;708.9716411343592;709.5423451873513;711.8932160175963;14089.788653170212;14115.223662698547;14180.290985450789;14225.288735563181;14290.142591444546;13563.186208827403;14125.576232713034;14169.57491275253;14175.574732758034;14302.92848535761;9998.750031249205;10160.847587286196;10163.847542286872;10196.133328667072;10304.690859274233;3791.5829258781514;3798.088458769903;3805.5243094613174;3811.5235595550557;3840;50619;50624;53304;53416.73291633517;53583.73208133973;10084.49577521121;10124.645637402655;10212.795744085077;10225.693229203136;10231.795364092824;19449.805501945084;19574.608507829762;19648;19683.507912302022;19689.113989870202;7492.850142997218;7671.846563068707;7733.072031356273;7934.56359900211;8047.959760201162;4261.27558315081;4298.398224248608;4302.44068271129;4342.131573685276;4371.322445021026;3332.3002169544184;3377.037544299863;3391.576052993376;3392.609849867297;3395.3039626876925;573.9024365857814;619.9008158694587;629.1914889367141;656.5469825820169;658.9176352955881;621.3320680268729;639.6577830860467;641.7304732012566;723.4176487927164;730.9195988441268;8890.377673562918;9100.135487128713;9167.12912273333;9247.72256832296;9287.349885508085;565.3470241870564;584.2638275772472;700.471144286071;702.153904545022;706.9893951590731;3876.2635099331037;3889.8249578769023;4036.4550785643564;4062.7156099073372;4100.5489396166395;60308.69845650831;61252.38747612556;61439.692801535704;61477;61524;51184;52679;53647;53768.462315377124;53862.46137538653;47679;48598;49111.50888491141;49920.50079499158;50215.748921255894;8142.72735441227;8249.257566819015;8272.37957153228;8302.294304983903;8427.941300791206;35834.99999999896;36085.45871811872;36973.63026369702;37226.8138659305;37937.24125517529;43057.784711076245;46305.768471157426;47003.76498117488;47090.058198836516;47604.28593571168;9849.310548261554;11732.94133529327;11916.582919597773;11917.880821191677;12210.02319814395;11533.308001519936;12725.55460558876;12800.935995319964;13133.671658208621;13183.209007459584;11221.551137954717;11358.772824543628;11376.146788990693;11454.484548195185;11758.647240582795;10386.48067596602;10655.413952232702;11257.774844503228;11554.191206615456;11753.412329383667;11639.068874490189;11701.473433695674;11880.34658093813;11934.701632458911;12141.210821296587;9865.161461275586;10120.190384769348;10310.587576496857;10423.322484038514;10590.258681892194;10087.991200879853;10328;10356.585736570452;10379.221558383;10423.739406514898 06:11:31 INFO - PROCESS | 17344 | __end_tp_report 06:11:31 INFO - PROCESS | 17344 | __start_cc_report 06:11:31 INFO - PROCESS | 17344 | _x_x_mozilla_cycle_collect,873 06:11:31 INFO - PROCESS | 17344 | __end_cc_report 06:11:31 INFO - PROCESS | 17344 | __startTimestamp1463836291614__endTimestamp 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | ------- Summary: start ------- 06:11:31 INFO - PROCESS | 17344 | Number of tests: 6 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | [#0] dojo.html Cycles:165 Average:5443.39 Median:5642.83 stddev:603.89 (10.7%) stddev-sans-first:581.56 06:11:31 INFO - PROCESS | 17344 | Values: 3286.8 3346.9 3371.1 3379.8 3408.7 5369.3 5401.3 5409.6 5411.7 5457.8 5418.8 5435.0 5449.2 5454.9 5467.6 4870.1 4928.9 5001.2 5001.5 5062.6 4945.5 5002.9 5044.2 5054.7 5055.7 5026.1 5044.8 5051.9 5054.0 5066.6 4510.5 4850.9 4967.8 4979.0 5030.2 4936.6 4949.5 4962.7 4964.8 4982.9 5273.7 5282.8 5318.6 5331.3 5342.4 5594.7 5835.6 5869.4 5879.4 5958.7 5832.7 5880.8 5918.9 5926.3 5947.2 5496.7 5530.6 5548.2 5552.7 5552.8 5773.7 5958.0 6002.7 6060.0 6066.3 5754.6 5756.1 5756.5 5756.5 5771.5 5817.5 5857.2 5868.9 5874.3 5903.9 5666.7 5840.0 5867.9 5876.3 5890.9 5761.0 5763.6 5822.0 5838.2 5883.1 4300.8 4422.3 4455.2 4463.9 4478.1 3985.9 4026.8 4043.7 4058.2 4088.2 5584.5 5600.2 5616.3 5637.2 5640.1 5692.7 5783.1 5873.0 5883.9 5889.6 5466.3 5530.6 5545.7 5564.6 5569.6 4984.8 4998.0 5002.8 5014.4 5019.3 5895.1 6037.0 6054.8 6062.2 6113.7 5865.0 5873.3 5894.8 5904.3 5924.8 6015.2 6101.5 6115.9 6116.7 6137.6 5656.1 5799.4 5824.2 5884.9 5907.3 5932.1 5953.8 5955.0 5985.2 5999.0 5742.3 5764.9 5767.7 5811.6 5816.1 5533.2 5739.6 5788.5 5833.7 5851.1 5623.9 5653.0 5653.9 5655.4 5656.9 5550.8 5760.7 5776.8 5781.0 5819.6 5416.2 5543.7 5602.8 5642.8 5668.8 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | [#1] ext.html Cycles:180 Average:45171.82 Median:36867.54 stddev:75655.43 (205.2%) stddev-sans-first:75793.33 06:11:31 INFO - PROCESS | 17344 | Values: 505.8 507.9 531.3 572.1 593.1 38175.0 38951.8 39139.2 39217.2 39273.2 43069.8 43632.6 43673.6 43729.0 43773.0 8806.6 8982.9 9008.1 9017.2 9018.9 8795.3 8886.4 8903.1 8912.8 8986.5 8906.4 8932.5 8970.4 8970.9 8981.7 8886.5 9066.1 9133.9 9135.3 9136.6 8962.6 9077.9 9083.5 9150.5 9167.1 42319.6 42322.0 42323.8 42378.6 42791.0 3579.8 3655.7 3756.3 4187.5 4269.8 31362.0 31694.2 31898.8 32198.8 32500.3 4179.1 4194.4 4207.3 4222.3 4284.8 292650.0 292880.0 293016.0 293946.0 295298.0 45133.0 61905.7 62061.4 62162.4 62430.0 43801.8 43850.0 43864.1 43912.1 44187.6 15908.5 16181.4 16230.8 16264.3 16286.0 11923.7 11938.9 11963.8 11975.0 12033.1 14644.8 14699.3 14915.3 14995.3 15059.8 5838.0 5916.5 5961.9 5963.2 5985.0 986.6 1043.6 1061.6 1089.4 1104.2 28974.6 29019.7 29075.4 29749.4 29967.3 1093.9 1125.9 1129.7 1134.0 1222.1 15147.2 15268.5 15470.1 15543.0 15721.6 348712.0 355525.0 356054.0 356828.0 359011.0 55250.0 55399.0 55565.4 55623.2 55727.0 1230.7 1380.3 1406.2 1414.8 1420.2 27446.5 28535.4 28815.6 28835.3 28882.3 43830.1 44220.6 44243.8 44429.0 44793.6 192675.0 193824.0 193975.0 194067.0 194159.0 28859.0 33710.3 34032.8 34291.3 34774.0 42114.6 42413.8 42541.8 43566.8 43891.6 36082.8 36285.8 36655.6 36681.3 36844.1 35760.5 36154.0 36531.3 36891.0 36908.3 36565.8 36613.5 37054.0 37605.0 37635.8 31557.4 33036.0 33180.8 33383.5 33391.5 25496.4 25750.4 25768.7 26001.7 26357.5 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | [#2] jquery.html Cycles:180 Average:27220.19 Median:34944.98 stddev:79781.72 (228.3%) stddev-sans-first:79980.02 06:11:31 INFO - PROCESS | 17344 | Values: 352.4 356.6 358.0 361.4 364.2 17359.3 17554.6 18902.5 18920.8 18998.8 15974.6 18323.7 18355.9 18406.5 18432.0 4734.0 4997.1 5000.3 5008.4 5036.7 3988.3 4962.3 5399.2 5681.7 5698.4 5666.7 5687.6 5701.3 5710.6 5715.1 5276.7 5464.3 5478.6 5481.0 5668.3 5180.0 5230.3 5236.6 5243.3 5623.8 21145.9 21266.0 21676.6 21843.7 21909.5 2124.4 2175.4 2273.5 2695.2 3049.6 10168.1 10304.4 11269.0 11289.8 13415.7 1890.3 1917.4 1932.3 1945.8 1956.7 59730.7 60952.0 62080.7 65610.0 66671.3 9631.3 9828.4 10179.6 10193.1 10234.3 14110.9 14111.6 14157.9 14247.6 14251.9 7973.4 7988.5 8017.2 8040.5 8107.4 7979.6 7995.2 8047.0 8049.0 8077.4 4511.5 4581.8 4607.9 4612.7 4647.4 1656.8 1759.3 1787.4 1821.7 1874.3 953.8 1007.1 1063.8 1069.2 1139.7 16737.7 17097.7 17466.5 17525.1 17808.7 984.6 1016.5 1049.7 1057.4 1119.5 9671.7 10065.6 10118.6 10152.9 10374.0 476129.0 476965.0 485816.0 486656.0 507566.0 75185.0 79982.6 80479.6 82516.0 82871.2 1084.1 1101.4 1105.1 1105.8 1116.3 15942.8 15946.3 16020.8 16097.3 16195.6 34801.5 35088.5 35293.8 35785.8 36166.6 50641.0 52025.5 52380.2 52729.5 53174.7 7476.9 7516.9 7627.5 7733.9 7780.7 10884.6 11242.4 11653.8 12343.8 12417.8 10164.0 10438.6 10765.4 10847.9 10903.2 9452.0 9470.6 9624.5 10178.9 10317.3 9432.4 9801.0 10832.2 10871.2 11115.7 7695.5 7697.3 7715.1 7797.8 7830.6 10219.4 10955.3 11003.2 11053.6 11055.2 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | [#3] mootools.html Cycles:180 Average:5749.04 Median:6006.41 stddev:3006.42 (50.1%) stddev-sans-first:2997.49 06:11:31 INFO - PROCESS | 17344 | Values: 1451.3 1531.2 1600.8 1831.9 1936.6 7788.1 8004.2 8039.5 8052.8 8103.0 7791.7 7929.4 7944.3 7956.2 7974.6 2344.2 2392.9 2393.1 2394.8 2395.1 2403.3 2444.4 2474.5 2489.9 2495.1 2421.0 2435.5 2444.8 2465.1 2468.2 2446.6 2454.1 2467.4 2472.2 2475.2 2436.2 2448.7 2454.6 2455.9 2457.8 8208.9 8249.7 8250.1 8254.2 8256.5 5101.0 5190.3 5208.6 5230.3 5240.7 3186.3 3193.2 3271.8 3285.9 3299.3 949.9 969.4 1000.7 1002.9 1014.5 11341.6 11484.4 11490.5 11535.4 11615.2 4708.4 4723.1 4808.2 4810.4 4816.5 9906.4 9927.5 9929.5 10002.1 10006.7 5302.6 5346.4 5356.0 5369.8 5397.6 4078.8 4596.5 4673.0 4725.0 4887.5 3887.2 3914.0 3948.6 3978.1 3996.3 1208.7 1212.3 1218.8 1219.5 1231.4 1277.4 1300.5 1307.6 1379.9 1383.7 7285.9 7294.1 7445.4 7614.8 7632.3 532.0 532.6 540.6 542.1 548.8 5946.5 5948.5 5960.7 5998.7 6014.1 9603.3 9859.0 9883.8 10013.8 10040.8 9492.0 9628.9 9793.7 9821.3 9887.0 7818.0 7987.4 8002.9 8038.4 8053.8 7778.8 7828.6 7867.5 7883.6 7899.1 9028.8 9097.4 9277.8 9318.0 9499.2 9466.4 9491.8 9600.1 9616.3 9850.2 6206.8 6652.0 6806.9 6946.5 7046.2 7635.5 7640.0 7666.9 7689.8 7710.8 6707.4 6870.2 6878.1 6978.5 7049.5 6873.2 6920.9 6961.6 6970.6 6985.3 6874.2 6994.5 7038.7 7177.2 7231.4 6566.8 6614.8 6624.6 6663.1 6683.4 6631.5 6633.5 6646.5 6649.6 6702.2 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | [#4] prototype.html Cycles:180 Average:5192.67 Median:5995.78 stddev:1541.35 (25.7%) stddev-sans-first:1502.01 06:11:31 INFO - PROCESS | 17344 | Values: 339.3 347.9 354.6 354.7 356.0 5817.9 5862.1 5863.8 5865.6 5877.4 5811.8 5814.7 5845.8 5861.5 5876.2 4304.4 4451.0 4515.7 4524.2 4539.0 4514.9 4532.1 4538.7 4551.6 4566.0 4378.6 4532.1 4544.9 4550.9 4555.7 4431.8 4543.4 4552.8 4568.2 4568.5 4022.0 4032.6 4034.4 4034.8 4037.2 5582.9 5607.1 5610.3 5617.1 5620.5 5275.3 5277.3 5322.5 5326.0 5326.2 6150.0 6154.8 6198.7 6201.1 6205.9 4214.1 4348.3 4350.4 4365.9 4496.1 6408.8 6444.5 6444.8 6457.3 6463.8 4416.7 4432.4 4441.0 4461.4 4478.0 4484.8 4488.0 4497.5 4521.5 4523.3 5183.0 5188.2 5192.9 5193.4 5202.0 6022.7 6191.5 6198.0 6205.7 6228.8 1557.0 1571.6 1584.4 1587.2 1589.9 992.9 1049.6 1056.5 1069.5 1089.9 6033.7 6044.9 6049.8 6052.5 6066.1 6341.5 6359.6 6374.4 6393.6 6398.6 5988.9 6013.4 6023.7 6045.8 6055.2 3422.6 3440.7 3459.3 3465.3 3469.5 6459.2 6546.1 6576.1 6587.1 6618.4 6475.2 6479.2 6494.5 6508.4 6515.9 6522.4 6526.7 6535.0 6543.8 6547.0 6280.7 6287.3 6287.5 6301.7 6302.7 6041.3 6204.9 6205.8 6224.9 6232.7 6491.2 6540.1 6544.7 6552.6 6573.4 4348.9 4350.2 4362.4 4370.1 4376.9 6291.2 6293.5 6312.7 6315.9 6327.6 6122.2 6124.9 6125.4 6166.6 6173.1 6072.6 6115.3 6299.3 6303.8 6309.5 6085.1 6092.2 6141.3 6156.8 6160.4 6247.7 6249.5 6251.4 6256.9 6267.6 5894.8 6002.7 6107.4 6122.4 6133.6 06:11:31 INFO - PROCESS | 17344 | 06:11:31 INFO - PROCESS | 17344 | [#5] yui.html Cycles:180 Average:14482.08 Median:23699.96 stddev:16882.69 (71.2%) stddev-sans-first:16898.31 06:11:31 INFO - PROCESS | 17344 | Values: 697.2 705.1 732.2 818.4 829.9 14320.5 14356.9 14565.6 14587.5 14664.0 11304.4 13363.2 13452.3 13455.7 13467.2 863.3 885.8 889.2 889.3 892.8 905.2 910.3 915.6 916.8 926.7 786.6 952.6 956.9 958.6 959.0 959.5 962.4 963.2 964.1 969.0 706.5 707.9 709.0 709.5 711.9 14089.8 14115.2 14180.3 14225.3 14290.1 13563.2 14125.6 14169.6 14175.6 14302.9 9998.8 10160.8 10163.8 10196.1 10304.7 3791.6 3798.1 3805.5 3811.5 3840.0 50619.0 50624.0 53304.0 53416.7 53583.7 10084.5 10124.6 10212.8 10225.7 10231.8 19449.8 19574.6 19648.0 19683.5 19689.1 7492.9 7671.8 7733.1 7934.6 8048.0 4261.3 4298.4 4302.4 4342.1 4371.3 3332.3 3377.0 3391.6 3392.6 3395.3 573.9 619.9 629.2 656.5 658.9 621.3 639.7 641.7 723.4 730.9 8890.4 9100.1 9167.1 9247.7 9287.3 565.3 584.3 700.5 702.2 707.0 3876.3 3889.8 4036.5 4062.7 4100.5 60308.7 61252.4 61439.7 61477.0 61524.0 51184.0 52679.0 53647.0 53768.5 53862.5 47679.0 48598.0 49111.5 49920.5 50215.7 8142.7 8249.3 8272.4 8302.3 8427.9 35835.0 36085.5 36973.6 37226.8 37937.2 43057.8 46305.8 47003.8 47090.1 47604.3 9849.3 11732.9 11916.6 11917.9 12210.0 11533.3 12725.6 12800.9 13133.7 13183.2 11221.6 11358.8 11376.1 11454.5 11758.6 10386.5 10655.4 11257.8 11554.2 11753.4 11639.1 11701.5 11880.3 11934.7 12141.2 9865.2 10120.2 10310.6 10423.3 10590.3 10088.0 10328.0 10356.6 10379.2 10423.7 06:11:31 INFO - PROCESS | 17344 | -------- Summary: end -------- 06:11:31 INFO - PROCESS | 17344 | 06:11:32 INFO - TEST-INFO | 17344: exit 0 06:11:32 INFO - TEST-OK | dromaeo_css | took 1109549ms 06:11:32 INFO - TEST-START | kraken 06:11:32 INFO - operating with platform_type : linux_ 06:11:32 INFO - Initialising browser for kraken test... 06:11:32 INFO - TEST-INFO | started process 17533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGT2Y1v/profile http://localhost:59611/getInfo.html) 06:11:35 INFO - PROCESS | 17533 | __metrics Screen width/height:1600/1200 06:11:35 INFO - PROCESS | 17533 | colorDepth:24 06:11:35 INFO - PROCESS | 17533 | Browser inner width/height: 1024/697 06:11:35 INFO - PROCESS | 17533 | __metrics 06:11:36 INFO - PROCESS | 17533 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:37 INFO - TEST-INFO | 17533: exit 0 06:11:37 INFO - Browser initialized. 06:11:37 INFO - Running cycle 1/1 for kraken test... 06:11:37 INFO - TEST-INFO | started process 17625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGT2Y1v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:48 INFO - PROCESS | 17625 | RSS: Main: 138244096 06:11:48 INFO - PROCESS | 17625 | 06:11:51 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:51 INFO - PROCESS | 17625 | RSS: Main: 172814336 06:11:51 INFO - PROCESS | 17625 | 06:11:54 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-dft) 06:11:55 INFO - PROCESS | 17625 | RSS: Main: 171593728 06:11:55 INFO - PROCESS | 17625 | 06:11:57 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-fft) 06:11:58 INFO - PROCESS | 17625 | RSS: Main: 169508864 06:11:58 INFO - PROCESS | 17625 | 06:12:00 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59611/tests/kraken/driver.html?testName=audio-oscillator) 06:12:00 INFO - PROCESS | 17625 | RSS: Main: 170696704 06:12:00 INFO - PROCESS | 17625 | 06:12:03 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:03 INFO - PROCESS | 17625 | RSS: Main: 168013824 06:12:03 INFO - PROCESS | 17625 | 06:12:06 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59611/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:07 INFO - PROCESS | 17625 | RSS: Main: 168288256 06:12:07 INFO - PROCESS | 17625 | 06:12:10 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59611/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:11 INFO - PROCESS | 17625 | RSS: Main: 168734720 06:12:11 INFO - PROCESS | 17625 | 06:12:14 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59611/tests/kraken/driver.html?testName=json-parse-financial) 06:12:14 INFO - PROCESS | 17625 | RSS: Main: 168599552 06:12:14 INFO - PROCESS | 17625 | 06:12:16 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:16 INFO - PROCESS | 17625 | RSS: Main: 174575616 06:12:16 INFO - PROCESS | 17625 | 06:12:18 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:18 INFO - PROCESS | 17625 | RSS: Main: 171905024 06:12:18 INFO - PROCESS | 17625 | 06:12:20 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:21 INFO - PROCESS | 17625 | RSS: Main: 178151424 06:12:21 INFO - PROCESS | 17625 | 06:12:23 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:24 INFO - PROCESS | 17625 | RSS: Main: 183472128 06:12:24 INFO - PROCESS | 17625 | 06:12:27 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:27 INFO - PROCESS | 17625 | RSS: Main: 182857728 06:12:27 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | Cycle 1(1): loaded http://localhost:59611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59611/tests/kraken/driver.html?testName=ai-astar) 06:12:29 INFO - PROCESS | 17625 | RSS: Main: 244862976 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | __start_tp_report 06:12:29 INFO - PROCESS | 17625 | _x_x_mozilla_page_load 06:12:29 INFO - PROCESS | 17625 | _x_x_mozilla_page_load_details 06:12:29 INFO - PROCESS | 17625 | |i|pagename|runs| 06:12:29 INFO - PROCESS | 17625 | |0;ai-astar;113;177;107;114;115;113;102;112;113;112 06:12:29 INFO - PROCESS | 17625 | |1;audio-beat-detection;157;132;157;169;133;156;158;132;175;132 06:12:29 INFO - PROCESS | 17625 | |2;audio-dft;162;163;163;164;161;162;162;164;163;163 06:12:29 INFO - PROCESS | 17625 | |3;audio-fft;75;75;78;163;84;76;81;76;162;76 06:12:29 INFO - PROCESS | 17625 | |4;audio-oscillator;94;95;135;94;94;95;141;93;95;137 06:12:29 INFO - PROCESS | 17625 | |5;imaging-gaussian-blur;119;118;119;117;120;119;119;118;121;118 06:12:29 INFO - PROCESS | 17625 | |6;imaging-darkroom;148;148;148;149;148;149;148;149;148;149 06:12:29 INFO - PROCESS | 17625 | |7;imaging-desaturate;98;98;98;97;97;97;96;98;97;96 06:12:29 INFO - PROCESS | 17625 | |8;json-parse-financial;54;55;55;55;55;54;54;56;53;52 06:12:29 INFO - PROCESS | 17625 | |9;json-stringify-tinderbox;72;74;74;73;73;73;73;74;73;73 06:12:29 INFO - PROCESS | 17625 | |10;stanford-crypto-aes;80;82;82;81;83;82;81;88;81;82 06:12:29 INFO - PROCESS | 17625 | |11;stanford-crypto-ccm;122;131;121;119;131;126;126;122;121;132 06:12:29 INFO - PROCESS | 17625 | |12;stanford-crypto-pbkdf2;160;150;150;152;152;140;155;149;150;154 06:12:29 INFO - PROCESS | 17625 | |13;stanford-crypto-sha256-iterative;69;69;69;69;69;67;67;70;67;66 06:12:29 INFO - PROCESS | 17625 | __end_tp_report 06:12:29 INFO - PROCESS | 17625 | __start_cc_report 06:12:29 INFO - PROCESS | 17625 | _x_x_mozilla_cycle_collect,918 06:12:29 INFO - PROCESS | 17625 | __end_cc_report 06:12:29 INFO - PROCESS | 17625 | __startTimestamp1463836349514__endTimestamp 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | ------- Summary: start ------- 06:12:29 INFO - PROCESS | 17625 | Number of tests: 14 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#0] ai-astar Cycles:10 Average:117.80 Median:113.00 stddev:21.16 (18.7%) stddev-sans-first:22.37 06:12:29 INFO - PROCESS | 17625 | Values: 113.0 177.0 107.0 114.0 115.0 113.0 102.0 112.0 113.0 112.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:157.00 stddev:16.48 (10.5%) stddev-sans-first:17.29 06:12:29 INFO - PROCESS | 17625 | Values: 157.0 132.0 157.0 169.0 133.0 156.0 158.0 132.0 175.0 132.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:12:29 INFO - PROCESS | 17625 | Values: 162.0 163.0 163.0 164.0 161.0 162.0 162.0 164.0 163.0 163.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:35.90 (47.2%) stddev-sans-first:37.37 06:12:29 INFO - PROCESS | 17625 | Values: 75.0 75.0 78.0 163.0 84.0 76.0 81.0 76.0 162.0 76.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:21.01 (22.4%) stddev-sans-first:21.73 06:12:29 INFO - PROCESS | 17625 | Values: 94.0 95.0 135.0 94.0 94.0 95.0 141.0 93.0 95.0 137.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:119.00 stddev:1.14 (1.0%) stddev-sans-first:1.20 06:12:29 INFO - PROCESS | 17625 | Values: 119.0 118.0 119.0 117.0 120.0 119.0 119.0 118.0 121.0 118.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 06:12:29 INFO - PROCESS | 17625 | Values: 148.0 148.0 148.0 149.0 148.0 149.0 148.0 149.0 148.0 149.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 06:12:29 INFO - PROCESS | 17625 | Values: 98.0 98.0 98.0 97.0 97.0 97.0 96.0 98.0 97.0 96.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.16 (2.1%) stddev-sans-first:1.22 06:12:29 INFO - PROCESS | 17625 | Values: 54.0 55.0 55.0 55.0 55.0 54.0 54.0 56.0 53.0 52.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#9] json-stringify-tinderbox Cycles:10 Average:73.20 Median:73.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 06:12:29 INFO - PROCESS | 17625 | Values: 72.0 74.0 74.0 73.0 73.0 73.0 73.0 74.0 73.0 73.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:2.20 (2.7%) stddev-sans-first:2.19 06:12:29 INFO - PROCESS | 17625 | Values: 80.0 82.0 82.0 81.0 83.0 82.0 81.0 88.0 81.0 82.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:126.00 stddev:4.82 (3.8%) stddev-sans-first:4.98 06:12:29 INFO - PROCESS | 17625 | Values: 122.0 131.0 121.0 119.0 131.0 126.0 126.0 122.0 121.0 132.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.20 Median:152.00 stddev:5.12 (3.4%) stddev-sans-first:4.32 06:12:29 INFO - PROCESS | 17625 | Values: 160.0 150.0 150.0 152.0 152.0 140.0 155.0 149.0 150.0 154.0 06:12:29 INFO - PROCESS | 17625 | 06:12:29 INFO - PROCESS | 17625 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:1.32 (1.9%) stddev-sans-first:1.36 06:12:29 INFO - PROCESS | 17625 | Values: 69.0 69.0 69.0 69.0 69.0 67.0 67.0 70.0 67.0 66.0 06:12:29 INFO - PROCESS | 17625 | -------- Summary: end -------- 06:12:29 INFO - PROCESS | 17625 | 06:12:30 INFO - TEST-INFO | 17625: exit 0 06:12:30 INFO - TEST-OK | kraken | took 58108ms 06:12:30 INFO - SUITE-END | took 1167s 06:12:30 INFO - Completed test suite (00:19:28) 06:12:30 INFO - javascript benchmark 06:12:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3286.819224942628, 3346.9497957530657, 3371.0561042907993, 3379.79721216727, 3408.6591340865907, 5369.328833895763, 5401.27082843816, 5409.621326507141, 5411.729413529322, 5457.781688732456, 5418.756155972981, 5435.0, 5449.155380915954, 5454.91817622736, 5467.644603100795, 4870.123377791996, 4928.852134435972, 5001.249812528114, 5001.549860512553, 5062.645614806965, 4945.480724523927, 5002.874928126789, 5044.167712327461, 5054.671446355994, 5055.696658200502, 5026.145555255597, 5044.82343117991, 5051.949480505203, 5054.039732450841, 5066.620003499734, 4510.548945105464, 4850.854474365775, 4967.826126085606, 4979.0, 5030.245463180516, 4936.6050715943, 4949.48030456804, 4962.727050012248, 4964.826231081895, 4982.850514484571, 5273.709945952971, 5282.788688452457, 5318.574514038867, 5331.306930099101, 5342.358916929955, 5594.748236329375, 5835.562332825013, 5869.383714709937, 5879.353271140171, 5958.672273024982, 5832.6500409975115, 5880.764769409218, 5918.8816223675285, 5926.318473375574, 5947.197128387699, 5496.670199787985, 5530.640508366983, 5548.195511650828, 5552.69460179694, 5552.833414997556, 5773.740181691834, 5957.970210149008, 6002.6698531580305, 6060.0, 6066.332703402622, 5754.625949313281, 5756.079027355603, 5756.453136951983, 5756.539476841926, 5771.538276937918, 5817.476427121579, 5857.179994800731, 5868.911966320423, 5874.32445268791, 5903.911441328383, 5666.660000399989, 5840.0, 5867.911981320283, 5876.324222714357, 5890.852728681732, 5761.020626493422, 5763.625364351387, 5821.970890145522, 5838.211841401357, 5883.117532370179, 4300.827966881352, 4422.292433210735, 4455.1980643484485, 4463.910721785611, 4478.104379124188, 3985.860494882665, 4026.791962411265, 4043.7169398141846, 4058.1680755445063, 4088.223237584909, 5584.497395234367, 5600.187972743929, 5616.297962754656, 5637.154426836008, 5640.097584386478, 5692.686902220417, 5783.074708046693, 5872.972229859757, 5883.911741323884, 5889.617174883704, 5466.262054622654, 5530.557555395559, 5545.667259964415, 5564.638298510584, 5569.554435645138, 4984.825531106394, 4998.000399920031, 5002.824901128443, 5014.448410674823, 5019.347484826949, 5895.115732640053, 6037.0, 6054.8183554493435, 6062.151298818169, 6113.749968914014, 5865.0, 5873.324567674772, 5894.823155305347, 5904.291485021825, 5924.7926322578505, 6015.218021657157, 6101.450869421596, 6115.938840611537, 6116.663583502772, 6137.570370074052, 5656.095024796013, 5799.449052340021, 5824.15549745293, 5884.94071067212, 5907.261592300963, 5932.0508718604815, 5953.791617293374, 5955.047192449188, 5985.162077309267, 5999.040153575407, 5742.28221472316, 5764.855878603068, 5767.6539407634, 5811.593188476766, 5816.069428891357, 5533.197686335539, 5739.569532285179, 5788.450097240755, 5833.737481813244, 5851.093080572518, 5623.915641265467, 5652.971735141298, 5653.858653533694, 5655.4344565543115, 5656.886862262814, 5550.750216240198, 5760.740766665594, 5776.826695199151, 5781.046127388934, 5819.563532734977, 5416.21464887597, 5543.667379957215, 5602.831915042555, 5642.83071507839, 5668.773249069991], "unit": "score", "name": "dojo.html", "value": 5404.899477261854}, {"lowerIsBetter": false, "replicates": [505.75470896615144, 507.90349833531627, 531.3490973557392, 572.1303618499878, 593.057039307501, 38175.0, 38951.805240973794, 39139.21721565567, 39217.21565568687, 39273.21453570927, 43069.78465107678, 43632.56367436325, 43673.563264367345, 43729.0, 43773.0, 8806.64773409063, 8982.910170898305, 9008.0541543138, 9017.23353514952, 9018.909810901905, 8795.296376289882, 8886.422382545114, 8903.109689031078, 8912.821743565124, 8986.460812351279, 8906.376553641248, 8932.508712020835, 8970.416922900024, 8970.923489181307, 8981.730548083568, 8886.511241881726, 9066.138716821892, 9133.908660913372, 9135.314851386172, 9136.63453461864, 8962.551872406353, 9077.863832042525, 9083.45499270046, 9150.54247287633, 9167.083291670846, 42319.57680423218, 42322.0, 42323.7883810579, 42378.57621423808, 42791.0, 3579.838907249154, 3655.670989610948, 3756.34264003801, 4187.539370669224, 4269.829206831723, 31362.0, 31694.207644808834, 31898.840505797554, 32198.839005805054, 32500.349993000244, 4179.080602267496, 4194.4337514435465, 4207.26372884747, 4222.261104306734, 4284.828606855722, 292650.0, 292880.0, 293016.0, 293946.0, 295298.0, 45133.0, 61905.69047154736, 62061.37938620556, 62162.37837621656, 62430.0, 43801.78099109484, 43850.0, 43864.12271754611, 43912.12175756467, 44187.55812441834, 15908.522744317688, 16181.352745890032, 16230.837691622932, 16264.268107935171, 16286.0, 11923.701907452383, 11938.88061119395, 11963.760724785456, 11975.0, 12033.097517686208, 14644.780328295084, 14699.338529766186, 14915.328810203568, 14995.250237488082, 15059.774103388458, 5838.0, 5916.467517923407, 5961.880762384815, 5963.165156878041, 5985.0, 986.6152200641756, 1043.5773511727612, 1061.6337363609543, 1089.3572792052728, 1104.2380757277454, 28974.565381519293, 29019.70980290212, 29075.418491630047, 29749.405011899642, 29967.250818729706, 1093.8523299354645, 1125.9493322800495, 1129.7458071933913, 1134.013408334754, 1222.0834374219335, 15147.242637868063, 15268.465603703817, 15470.071795692294, 15543.0, 15721.585057344666, 348712.0, 355525.0, 356054.0, 356828.0, 359011.0, 55250.0, 55399.0, 55565.44434555683, 55623.16565251524, 55727.0, 1230.6923269182705, 1380.2615600653603, 1406.2476575032308, 1414.7807089901082, 1420.155007770375, 27446.45107097807, 28535.36859261082, 28815.56776648394, 28835.279118022216, 28882.27794305159, 43830.12339753251, 44220.55779442293, 44243.77878110589, 44429.0, 44793.552064478936, 192675.0, 193824.0, 193975.0, 194067.0, 194159.0, 28859.0, 33710.32579348448, 34032.829835850665, 34291.314173716884, 34774.0, 42114.57885421229, 42413.78793106015, 42541.78729106458, 43566.78216608897, 43891.56108438875, 36082.8195859019, 36285.81857090697, 36655.633443665225, 36681.266374671824, 36844.078898027765, 35760.463593045606, 36154.0, 36531.26937461289, 36891.0, 36908.26183476369, 36565.81717091398, 36613.450798238584, 37054.0, 37605.0, 37635.81182094072, 31557.36885262236, 33036.0, 33180.83409582936, 33383.49924751179, 33391.49912751359, 25496.362590935376, 25750.356241094123, 25768.742312576633, 26001.73998259993, 26357.472850542497], "unit": "score", "name": "ext.html", "value": 18393.886633384805}, {"lowerIsBetter": false, "replicates": [352.38157034404634, 356.6487010294859, 358.0440224600317, 361.41992102675204, 364.2005797274982, 17359.30562777489, 17554.561135971606, 18902.527436814085, 18920.810791892076, 18998.810011899895, 15974.600634984132, 18323.725144122847, 18355.898646081212, 18406.539836504093, 18432.0, 4734.0, 4997.100521906055, 5000.324956130912, 5008.449070602231, 5036.722980236085, 3988.282109220339, 4962.330085438456, 5399.217113518537, 5681.659100453986, 5698.43015698431, 5666.688332141731, 5687.6303040302455, 5701.258836351269, 5710.5717071219615, 5715.057015592422, 5276.657017293864, 5464.3442786865435, 5478.616496845222, 5480.986017586739, 5668.348139963916, 5179.974100129513, 5230.320058392423, 5236.554892834114, 5243.318368612094, 5623.80316688918, 21145.942702864795, 21266.0, 21676.566468670695, 21843.672344914838, 21909.452263693376, 2124.3626911926362, 2175.3908905506482, 2273.488465095357, 2695.218386667864, 3049.5883055787626, 10168.13570846479, 10304.433256170907, 11268.985791278825, 11289.830652540219, 13415.664608384868, 1890.2533499267713, 1917.3576851754679, 1932.3236867096543, 1945.8151475609795, 1956.7162761399659, 59730.70134649342, 60951.999999999556, 62080.689596552176, 65610.0, 66671.333286667, 9631.325807193569, 9828.361156524803, 10179.592816287266, 10193.133583645325, 10234.33476824004, 14110.929445352913, 14111.647208819862, 14157.85842141586, 14247.64380890486, 14251.928740356232, 7973.441859069925, 7988.480748751429, 8017.198280171936, 8040.4773689711155, 8107.432479726481, 7979.640916158787, 7995.200479951958, 8046.959765201136, 8049.0, 8077.353811695168, 4511.526289739596, 4581.79381927814, 4607.9308810367875, 4612.74629895359, 4647.37260469839, 1656.7514872769182, 1759.3314540474537, 1787.4280230326171, 1821.7176337667418, 1874.3158747057225, 953.823542644613, 1007.1338648762058, 1063.8138325792954, 1069.1820757120809, 1139.7093741096132, 16737.748933766004, 17097.658046838995, 17466.515346195716, 17525.123743812757, 17808.684870966692, 984.6356847966155, 1016.4765145949842, 1049.679847646475, 1057.3814318623538, 1119.4682525800342, 9671.742673452407, 10065.64770233053, 10118.645847395454, 10152.898471015344, 10373.962603739566, 476129.0, 476965.0, 485816.0, 486656.0, 507566.0, 75185.0, 79982.6000869992, 80479.59760201162, 82516.0, 82871.17128828635, 1084.1164450972433, 1101.438266484099, 1105.077260487502, 1105.7622611138484, 1116.2744216259496, 15942.760858587362, 15946.282417291482, 16020.839791601935, 16097.275622597246, 16195.59511012187, 34801.47797783086, 35088.47367289442, 35293.82353088321, 35785.82107089552, 36166.63833361633, 50641.0, 52025.479745202065, 52380.21429678634, 52729.472705272456, 53174.734126329124, 7476.925230747623, 7516.924830751623, 7627.466077374531, 7733.883991740241, 7780.727674531364, 10884.61903833362, 11242.381669008282, 11653.825192621947, 12343.814842777545, 12417.813732793835, 10164.0, 10438.63464778729, 10765.354078754986, 10847.945760271148, 10903.236773425784, 9452.0, 9470.621175152917, 9624.51877406141, 10178.898211017795, 10317.27779055489, 9432.434053956784, 9801.0, 10832.24174307791, 10871.239013268996, 11115.72210694739, 7695.461317707931, 7697.268759467842, 7715.112762032438, 7797.7660670179985, 7830.608469576612, 10219.386836789816, 10955.34267943926, 11003.22977391575, 11053.613123540637, 11055.170862185529], "unit": "score", "name": "jquery.html", "value": 8650.239695762668}, {"lowerIsBetter": false, "replicates": [1451.2598574726899, 1531.1720698254364, 1600.8239093699694, 1831.8992455414955, 1936.6126774645065, 7788.143304236536, 8004.239597238267, 8039.5176289422525, 8052.83894322114, 8103.0, 7791.727289544867, 7929.405294602899, 7944.285014348708, 7956.164602716718, 7974.561399123046, 2344.2264052862556, 2392.940176495593, 2393.066703985447, 2394.7724966128276, 2395.089865850974, 2403.267003563912, 2444.4377793107597, 2474.5174690935273, 2489.891998060855, 2495.089292408267, 2421.0436877433403, 2435.476372579895, 2444.841085329448, 2465.100238412975, 2468.2348471973655, 2446.645236440715, 2454.1165180534995, 2467.432490527171, 2472.2336075816465, 2475.1955614425206, 2436.1838784007377, 2448.669429626995, 2454.619533972237, 2455.9017639294584, 2457.82795204334, 8208.876866847002, 8249.670013199464, 8250.051244106944, 8254.174582541698, 8256.545889976049, 5100.974495127538, 5190.32525771651, 5208.609354298443, 5230.267762513251, 5240.737963101829, 3186.2512309607223, 3193.1857376369107, 3271.8364081795817, 3285.917852053694, 3299.2741596848655, 949.852772820214, 969.4038166527605, 1000.6697789729371, 1002.8646132772055, 1014.4572653630346, 11341.603043893425, 11484.36835974021, 11490.54037838477, 11535.365554894477, 11615.186936914419, 4708.4349878014855, 4723.0789995951145, 4808.158572249842, 4810.374651295379, 4816.54242846929, 9906.356086854476, 9927.50362481873, 9929.453880036523, 10002.149817265614, 10006.69979900604, 5302.628815982845, 5346.4118946915805, 5356.0, 5369.838904832861, 5397.595180361489, 4078.8164532596106, 4596.517365676623, 4673.0, 4724.976375118103, 4887.462379138292, 3887.1836914248324, 3913.96279985804, 3948.6446219840354, 3978.0651546886456, 3996.3406038003986, 1208.667616405478, 1212.3271584270815, 1218.8171774233936, 1219.4756254810338, 1231.4150778380197, 1277.3932382118605, 1300.5318085489216, 1307.5881097454271, 1379.8965077619018, 1383.73017261633, 7285.890711639329, 7294.1247050354295, 7445.404367650575, 7614.809629759189, 7632.274933881273, 532.0317023018147, 532.6218384946653, 540.6431755041654, 542.1244689825982, 548.7969451303044, 5946.524278057745, 5948.524118070544, 5960.6721630309885, 5998.7300571473515, 6014.09788531715, 9603.279754018336, 9858.95070524657, 9883.752906177404, 10013.79972400548, 10040.79918401628, 9491.952540237255, 9628.855567166498, 9793.657221997197, 9821.312508124505, 9887.0, 7817.960910195413, 7987.400944929037, 8002.8799568006525, 8038.356931445587, 8053.798655033671, 7778.805529861573, 7828.647710853139, 7867.527948323119, 7883.605819708877, 7899.09160446533, 9028.819423611621, 9097.40866843653, 9277.814443711222, 9317.953410232905, 9499.240060795259, 9466.384684995453, 9491.762705932408, 9600.087991640783, 9616.326857119935, 9850.162736167505, 6206.844828879314, 6651.966740166268, 6806.8638627228165, 6946.479014074066, 7046.2249152594195, 7635.541867487968, 7640.044994375703, 7666.923330766621, 7689.769306920802, 7710.807229819299, 6707.396334329934, 6870.175578930561, 6878.140232470942, 6978.511504194861, 7049.541779784297, 6873.20958089826, 6920.9307906920285, 6961.582305061713, 6970.581765094111, 6985.336393042653, 6874.243833178246, 6994.545354551938, 7038.718451261892, 7177.246389129066, 7231.385332246818, 6566.802995909939, 6614.801555953329, 6624.56940298879, 6663.13379260693, 6683.365080317362, 6631.469482441296, 6633.469322454095, 6646.501512386687, 6649.567778094409, 6702.19573651165], "unit": "score", "name": "mootools.html", "value": 4650.480033184768}, {"lowerIsBetter": false, "replicates": [339.3399837316419, 347.8851978846981, 354.632954891687, 354.7179991906434, 355.9537260156181, 5817.854553636162, 5862.091375836747, 5863.824085277449, 5865.58940874139, 5877.41225877412, 5811.82564523065, 5814.732254420779, 5845.7953971611005, 5861.501772349356, 5876.206712093866, 4304.440422745039, 4451.0, 4515.706479078849, 4524.163029839474, 4538.954610453886, 4514.887127821798, 4532.09358128374, 4538.727676339414, 4551.590356867898, 4566.0, 4378.64970802335, 4532.09358128374, 4544.863654090383, 4550.931736023962, 4555.74943378114, 4431.844885429011, 4543.386642803212, 4552.772361381951, 4568.200564901129, 4568.520305367938, 4021.959780402217, 4032.5765794591734, 4034.3545032794905, 4034.798260087013, 4037.1723796621914, 5582.944170558324, 5607.102863541813, 5610.326760788691, 5617.129344951539, 5620.522255608278, 5275.314209152824, 5277.287566178555, 5322.547583455411, 5326.0, 5326.201069839516, 6150.04674275488, 6154.753809847601, 6198.721057552421, 6201.131841542187, 6205.937940620581, 4214.072903961123, 4348.282533381988, 4350.412694286262, 4365.9126817463475, 4496.145732310883, 6408.775692850728, 6444.484441244689, 6444.838879028015, 6457.321981192001, 6463.806085817386, 4416.6908316418185, 4432.379466874576, 4440.955590444054, 4461.353103799996, 4478.037221997286, 4484.798184081659, 4488.035072459437, 4497.527759585197, 4521.547845215452, 4523.253663145544, 5183.0, 5188.169892817206, 5192.870178245498, 5193.350831146106, 5202.0, 6022.705118399565, 6191.473724733358, 6198.0, 6205.689715514206, 6228.781992630236, 1556.9688606227812, 1571.6463795645889, 1584.3741722019738, 1587.206396801599, 1589.8966567173097, 992.9156021738233, 1049.5906596427399, 1056.4823236614156, 1069.502681253221, 1089.9128069754402, 6033.698315084316, 6044.879102418015, 6049.848753781191, 6052.455279024909, 6066.059760737093, 6341.524385671093, 6359.586626869239, 6374.362563743682, 6393.552451328363, 6398.616083035033, 5988.880222395528, 6013.428724271187, 6023.69881505923, 6045.818625441244, 6055.152278680988, 3422.640622734627, 3440.6559344065895, 3459.325431540876, 3465.3242617689307, 3469.479578063311, 6459.192600924885, 6546.0508226307875, 6576.112224849584, 6587.143671322793, 6618.437432818265, 6475.222973243241, 6479.157709497735, 6494.512911531559, 6508.414242718178, 6515.902261466082, 6522.380373864476, 6526.738930442729, 6535.019747037983, 6543.836404089936, 6546.9999999999045, 6280.676149824594, 6287.30839607652, 6287.46556542699, 6301.747930082745, 6302.684865756602, 6041.275046994213, 6204.875902481835, 6205.751769929152, 6224.906626400698, 6232.719527621359, 6491.221053473613, 6540.051692504655, 6544.6727663615675, 6552.57408268461, 6573.375529324707, 4348.93476597845, 4350.238708225985, 4362.3674567186945, 4370.060437006059, 4376.949532112334, 6291.150694656346, 6293.465055470337, 6312.652804095819, 6315.936840631719, 6327.557071004985, 6122.234720659918, 6124.877502449837, 6125.356837532173, 6166.630002199882, 6173.104899789595, 6072.635641861502, 6115.266168059861, 6299.338569450142, 6303.779367722291, 6309.49524038085, 6085.148079268817, 6092.238470191226, 6141.324454309933, 6156.78451254204, 6160.353162917829, 6247.718852651732, 6249.50003999688, 6251.4061164189325, 6256.906146407899, 6267.561270711007, 5894.791567728691, 6002.669853158118, 6107.358727333743, 6122.448979591858, 6133.601315914451], "unit": "score", "name": "prototype.html", "value": 4696.731269758662}, {"lowerIsBetter": false, "replicates": [697.2330436519827, 705.0587465733246, 732.1616748822598, 818.4230117766975, 829.8630725930218, 14320.4987825426, 14356.928215358908, 14565.635859103528, 14587.489437869677, 14664.0, 11304.434778261075, 13363.19820810752, 13452.260125693083, 13455.663608409795, 13467.191968481899, 863.2791618998128, 885.7696998780299, 889.1863944490783, 889.3063410539789, 892.7500299916002, 905.2395987370608, 910.2717825739416, 915.5696822493418, 916.7845556294266, 926.6710317837172, 786.5988345943553, 952.633236204063, 956.909093636107, 958.6405098088217, 959.040959040959, 959.5250351076262, 962.3936919740588, 963.2246041936238, 964.0744884910459, 968.951552422376, 706.5442789400807, 707.8796604577183, 708.9716411343592, 709.5423451873513, 711.8932160175963, 14089.788653170212, 14115.223662698547, 14180.290985450789, 14225.288735563181, 14290.142591444546, 13563.186208827403, 14125.576232713034, 14169.57491275253, 14175.574732758034, 14302.92848535761, 9998.750031249205, 10160.847587286196, 10163.847542286872, 10196.133328667072, 10304.690859274233, 3791.5829258781514, 3798.088458769903, 3805.5243094613174, 3811.5235595550557, 3840.0, 50619.0, 50624.0, 53304.0, 53416.73291633517, 53583.73208133973, 10084.49577521121, 10124.645637402655, 10212.795744085077, 10225.693229203136, 10231.795364092824, 19449.805501945084, 19574.608507829762, 19648.0, 19683.507912302022, 19689.113989870202, 7492.850142997218, 7671.846563068707, 7733.072031356273, 7934.56359900211, 8047.959760201162, 4261.27558315081, 4298.398224248608, 4302.44068271129, 4342.131573685276, 4371.322445021026, 3332.3002169544184, 3377.037544299863, 3391.576052993376, 3392.609849867297, 3395.3039626876925, 573.9024365857814, 619.9008158694587, 629.1914889367141, 656.5469825820169, 658.9176352955881, 621.3320680268729, 639.6577830860467, 641.7304732012566, 723.4176487927164, 730.9195988441268, 8890.377673562918, 9100.135487128713, 9167.12912273333, 9247.72256832296, 9287.349885508085, 565.3470241870564, 584.2638275772472, 700.471144286071, 702.153904545022, 706.9893951590731, 3876.2635099331037, 3889.8249578769023, 4036.4550785643564, 4062.7156099073372, 4100.5489396166395, 60308.69845650831, 61252.38747612556, 61439.692801535704, 61477.0, 61524.0, 51184.0, 52679.0, 53647.0, 53768.462315377124, 53862.46137538653, 47679.0, 48598.0, 49111.50888491141, 49920.50079499158, 50215.748921255894, 8142.72735441227, 8249.257566819015, 8272.37957153228, 8302.294304983903, 8427.941300791206, 35834.99999999896, 36085.45871811872, 36973.63026369702, 37226.8138659305, 37937.24125517529, 43057.784711076245, 46305.768471157426, 47003.76498117488, 47090.058198836516, 47604.28593571168, 9849.310548261554, 11732.94133529327, 11916.582919597773, 11917.880821191677, 12210.02319814395, 11533.308001519936, 12725.55460558876, 12800.935995319964, 13133.671658208621, 13183.209007459584, 11221.551137954717, 11358.772824543628, 11376.146788990693, 11454.484548195185, 11758.647240582795, 10386.48067596602, 10655.413952232702, 11257.774844503228, 11554.191206615456, 11753.412329383667, 11639.068874490189, 11701.473433695674, 11880.34658093813, 11934.701632458911, 12141.210821296587, 9865.161461275586, 10120.190384769348, 10310.587576496857, 10423.322484038514, 10590.258681892194, 10087.991200879853, 10328.0, 10356.585736570452, 10379.221558383, 10423.739406514898], "unit": "score", "name": "yui.html", "value": 6618.145886318649}], "name": "dromaeo_css", "value": 7064.682500950292}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 177.0, 107.0, 114.0, 115.0, 113.0, 102.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 117.8}, {"lowerIsBetter": true, "replicates": [157.0, 132.0, 157.0, 169.0, 133.0, 156.0, 158.0, 132.0, 175.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 164.0, 161.0, 162.0, 162.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 78.0, 163.0, 84.0, 76.0, 81.0, 76.0, 162.0, 76.0], "unit": "score", "name": "audio-fft", "value": 94.6}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 135.0, 94.0, 94.0, 95.0, 141.0, 93.0, 95.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [119.0, 118.0, 119.0, 117.0, 120.0, 119.0, 119.0, 118.0, 121.0, 118.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 118.8}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 148.4}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 98.0, 97.0, 97.0, 97.0, 96.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 54.0, 56.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 74.0, 73.0, 73.0, 73.0, 73.0, 74.0, 73.0, 73.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.2}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 82.0, 81.0, 83.0, 82.0, 81.0, 88.0, 81.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [122.0, 131.0, 121.0, 119.0, 131.0, 126.0, 126.0, 122.0, 121.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.1}, {"lowerIsBetter": true, "replicates": [160.0, 150.0, 150.0, 152.0, 152.0, 140.0, 155.0, 149.0, 150.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 69.0, 67.0, 67.0, 70.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.2}], "name": "kraken", "value": 1551.1}]} 06:12:30 INFO - Return code: 0 06:12:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:12:30 INFO - # TBPL SUCCESS # 06:12:30 INFO - Running post-action listener: _resource_record_post_action 06:12:30 INFO - Running post-run listener: _resource_record_post_run 06:12:31 INFO - Total resource usage - Wall time: 1182s; CPU: 25.0%; Read bytes: 16384; Write bytes: 462299136; Read time: 28; Write time: 412532 06:12:31 INFO - install - Wall time: 13s; CPU: 27.0%; Read bytes: 0; Write bytes: 231841792; Read time: 0; Write time: 284264 06:12:31 INFO - run-tests - Wall time: 1169s; CPU: 25.0%; Read bytes: 16384; Write bytes: 212463616; Read time: 28; Write time: 125912 06:12:31 INFO - Running post-run listener: _upload_blobber_files 06:12:31 INFO - Blob upload gear active. 06:12:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:31 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 06:12:31 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:12:31 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:12:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:12:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:12:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:33 INFO - (blobuploader) - INFO - Done attempting. 06:12:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:12:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:34 INFO - (blobuploader) - INFO - Done attempting. 06:12:34 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:34 INFO - Return code: 0 06:12:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fef489226d73b9b74d8aef41ce00ceb0b217eef69ea64123b8c402670f3e05aab4bad59755808040d012b153fe03cb8d4ddb5027befb9cf94e9098f5c27fbdc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03f69ecfc8fbe1a031cbc13ee76dcbe58f4d477fb39cd9076fbad08cf044bc63a4e1cc19d32c349f6eccf6a052e37f6b3ad5f39961667aca0fc1d30df88405c9"} 06:12:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:34 INFO - Contents: 06:12:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fef489226d73b9b74d8aef41ce00ceb0b217eef69ea64123b8c402670f3e05aab4bad59755808040d012b153fe03cb8d4ddb5027befb9cf94e9098f5c27fbdc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03f69ecfc8fbe1a031cbc13ee76dcbe58f4d477fb39cd9076fbad08cf044bc63a4e1cc19d32c349f6eccf6a052e37f6b3ad5f39961667aca0fc1d30df88405c9"} 06:12:34 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:34 INFO - Copying logs to upload dir... 06:12:34 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1224.046253 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 24 secs) (at 2016-05-21 06:12:33.497161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 06:12:33.504202) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fef489226d73b9b74d8aef41ce00ceb0b217eef69ea64123b8c402670f3e05aab4bad59755808040d012b153fe03cb8d4ddb5027befb9cf94e9098f5c27fbdc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03f69ecfc8fbe1a031cbc13ee76dcbe58f4d477fb39cd9076fbad08cf044bc63a4e1cc19d32c349f6eccf6a052e37f6b3ad5f39961667aca0fc1d30df88405c9"} build_url:https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.005367 build_url: 'https://queue.taskcluster.net/v1/task/UB6IXC1YTruJ-Z6Wqf2fMA/artifacts/public/build/firefox-47.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fef489226d73b9b74d8aef41ce00ceb0b217eef69ea64123b8c402670f3e05aab4bad59755808040d012b153fe03cb8d4ddb5027befb9cf94e9098f5c27fbdc9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03f69ecfc8fbe1a031cbc13ee76dcbe58f4d477fb39cd9076fbad08cf044bc63a4e1cc19d32c349f6eccf6a052e37f6b3ad5f39961667aca0fc1d30df88405c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-21 06:12:33.525702) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:12:33.526216) ========= 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=a0d2d2de893abaa8702a9954000001a7-1463833923.216038-1316482721 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002095 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-21 06:12:33.600614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 06:12:33.602982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-21 06:12:33.603315) ========= ========= Total master_lag: 0.40 =========