builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1462797245.39 results: success (0) buildid: 20160509005049 builduid: 41dbd660830c4270b4520649f25740b3 revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.388950) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.389415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.389777) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.425397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.425666) ========= 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=574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 05:34:05-- 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% 223M=0s 2016-05-09 05:34:06 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.573926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.574214) ========= 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=574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018419 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.624054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:05.624366) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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-aurora --rev 307b5eca8726f6a72a1d69ba76630a6dbf402477 --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=574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 05:34:06,149 truncating revision to first 12 chars 2016-05-09 05:34:06,149 Setting DEBUG logging. 2016-05-09 05:34:06,149 attempt 1/10 2016-05-09 05:34:06,149 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/307b5eca8726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:34:06,602 unpacking tar archive at: mozilla-aurora-307b5eca8726/testing/mozharness/ program finished with exit code 0 elapsedTime=0.741256 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:06.379714) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:06.380024) ========= script_repo_revision: 307b5eca8726f6a72a1d69ba76630a6dbf402477 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:06.380432) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:06.380738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:34:06.390919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-09 05:34:06.391375) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:34:06 INFO - MultiFileLogger online at 20160509 05:34:06 in /builds/slave/test 05:34:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:34:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:34:07 INFO - {'append_to_log': False, 05:34:07 INFO - 'base_work_dir': '/builds/slave/test', 05:34:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:34:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:34:07 INFO - 'branch': 'Mozilla-Aurora', 05:34:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:07 INFO - 'config_files': ('talos/linux_config.py',), 05:34:07 INFO - 'default_actions': ('clobber', 05:34:07 INFO - 'read-buildbot-config', 05:34:07 INFO - 'download-and-extract', 05:34:07 INFO - 'populate-webroot', 05:34:07 INFO - 'create-virtualenv', 05:34:07 INFO - 'install', 05:34:07 INFO - 'run-tests'), 05:34:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:07 INFO - 'download_minidump_stackwalk': True, 05:34:07 INFO - 'download_symbols': 'ondemand', 05:34:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:07 INFO - 'installer_path': 'installer.exe', 05:34:07 INFO - 'log_level': 'info', 05:34:07 INFO - 'log_name': 'talos', 05:34:07 INFO - 'log_to_console': True, 05:34:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:34:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:34:07 INFO - 'opt_config_files': (), 05:34:07 INFO - 'pip_index': False, 05:34:07 INFO - 'sps_profile': False, 05:34:07 INFO - 'sps_profile_interval': 0, 05:34:07 INFO - 'suite': 'dromaeojs', 05:34:07 INFO - 'system_bits': '32', 05:34:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:07 INFO - 'title': 'talos-linux64-ix-044', 05:34:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:07 INFO - 'use_talos_json': True, 05:34:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:34:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:07 INFO - 'work_dir': 'build'} 05:34:07 INFO - ##### 05:34:07 INFO - ##### Running clobber step. 05:34:07 INFO - ##### 05:34:07 INFO - Running pre-action listener: _resource_record_pre_action 05:34:07 INFO - Running main action method: clobber 05:34:07 INFO - rmtree: /builds/slave/test/build 05:34:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:34:07 INFO - Running post-action listener: _resource_record_post_action 05:34:07 INFO - ##### 05:34:07 INFO - ##### Running read-buildbot-config step. 05:34:07 INFO - ##### 05:34:07 INFO - Running pre-action listener: _resource_record_pre_action 05:34:07 INFO - Running main action method: read_buildbot_config 05:34:07 INFO - Using buildbot properties: 05:34:07 INFO - { 05:34:07 INFO - "project": "", 05:34:07 INFO - "product": "firefox", 05:34:07 INFO - "script_repo_revision": "production", 05:34:07 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:34:07 INFO - "repository": "", 05:34:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:34:07 INFO - "buildid": "20160509005049", 05:34:07 INFO - "pgo_build": "True", 05:34:07 INFO - "basedir": "/builds/slave/test", 05:34:07 INFO - "buildnumber": 226, 05:34:07 INFO - "slavename": "talos-linux64-ix-044", 05:34:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:34:07 INFO - "platform": "ubuntu64_hw", 05:34:07 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:34:07 INFO - "branch": "mozilla-aurora", 05:34:07 INFO - "repo_path": "releases/mozilla-aurora", 05:34:07 INFO - "revision": "307b5eca8726f6a72a1d69ba76630a6dbf402477", 05:34:07 INFO - "stage_platform": "linux64-pgo", 05:34:07 INFO - "builduid": "41dbd660830c4270b4520649f25740b3", 05:34:07 INFO - "slavebuilddir": "test" 05:34:07 INFO - } 05:34:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 05:34:07 INFO - Running post-action listener: _resource_record_post_action 05:34:07 INFO - ##### 05:34:07 INFO - ##### Running download-and-extract step. 05:34:07 INFO - ##### 05:34:07 INFO - Running pre-action listener: _resource_record_pre_action 05:34:07 INFO - Running main action method: download_and_extract 05:34:07 INFO - mkdir: /builds/slave/test/build/tests 05:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:07 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:34:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:34:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:34:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:34:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:34:18 INFO - Downloaded 1361 bytes. 05:34:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 05:34:18 INFO - Using the following test package requirements: 05:34:18 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:34:18 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:34:18 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:34:18 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'jsshell-linux-x86_64.zip'], 05:34:18 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:34:18 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 05:34:18 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:34:18 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:34:18 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:34:18 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 05:34:18 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:34:18 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:34:18 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:34:18 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:34:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:34:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:34:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:34:21 INFO - Downloaded 23798585 bytes. 05:34:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:34:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:34:22 INFO - Return code: 0 05:34:22 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:34: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:34:22 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 05:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:34:32 INFO - Downloaded 23798585 bytes. 05:34:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:34:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:34:33 INFO - Return code: 0 05:34: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:34:33 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 05:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:34:34 INFO - Downloaded 10840145 bytes. 05:34:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:34:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:34:35 INFO - Return code: 0 05:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:35 INFO - https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:34:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:34:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:34:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:34:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:34:36 INFO - Downloaded 62704189 bytes. 05:34:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:34:36 INFO - mkdir: /builds/slave/test/properties 05:34:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:34:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:34:36 INFO - Contents: 05:34:36 INFO - build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 05:34:37 INFO - Running post-action listener: _resource_record_post_action 05:34:37 INFO - Running post-action listener: set_extra_try_arguments 05:34:37 INFO - ##### 05:34:37 INFO - ##### Running populate-webroot step. 05:34:37 INFO - ##### 05:34:37 INFO - Running pre-action listener: _resource_record_pre_action 05:34:37 INFO - Running main action method: populate_webroot 05:34:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:34:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:34:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:34:37 INFO - '--tppagecycles', 05:34:37 INFO - '7'], 05:34:37 INFO - 'tests': ['tsvgm']}}, 05:34:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:34:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:34:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:34:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:34:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['damp', 'tps']}, 05:34:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'tests': ['damp', 'tps']}, 05:34:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['dromaeo_dom']}, 05:34:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:34:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['a11yr', 05:34:37 INFO - 'ts_paint', 05:34:37 INFO - 'tpaint', 05:34:37 INFO - 'sessionrestore', 05:34:37 INFO - 'sessionrestore_no_auto_restore', 05:34:37 INFO - 'tabpaint']}, 05:34:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:34:37 INFO - 'ts_paint', 05:34:37 INFO - 'tpaint', 05:34:37 INFO - 'sessionrestore', 05:34:37 INFO - 'sessionrestore_no_auto_restore', 05:34:37 INFO - 'tabpaint']}, 05:34:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:34:37 INFO - 'ts_paint', 05:34:37 INFO - 'tpaint', 05:34:37 INFO - 'sessionrestore', 05:34:37 INFO - 'sessionrestore_no_auto_restore', 05:34:37 INFO - 'tabpaint']}, 05:34:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:34:37 INFO - 'ts_paint', 05:34:37 INFO - 'tpaint', 05:34:37 INFO - 'sessionrestore', 05:34:37 INFO - 'sessionrestore_no_auto_restore', 05:34:37 INFO - 'tabpaint']}, 05:34:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['a11yr', 05:34:37 INFO - 'ts_paint', 05:34:37 INFO - 'tpaint', 05:34:37 INFO - 'sessionrestore', 05:34:37 INFO - 'sessionrestore_no_auto_restore', 05:34:37 INFO - 'tabpaint']}, 05:34:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['a11yr', 05:34:37 INFO - 'ts_paint', 05:34:37 INFO - 'tpaint', 05:34:37 INFO - 'sessionrestore', 05:34:37 INFO - 'sessionrestore_no_auto_restore', 05:34:37 INFO - 'tabpaint']}, 05:34:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['tsvgx', 05:34:37 INFO - 'tsvgr_opacity', 05:34:37 INFO - 'tart', 05:34:37 INFO - 'tscrollx', 05:34:37 INFO - 'cart']}, 05:34:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:34:37 INFO - 'tsvgr_opacity', 05:34:37 INFO - 'tart', 05:34:37 INFO - 'tscrollx', 05:34:37 INFO - 'cart']}, 05:34:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'talos_options': ['--disable-e10s'], 05:34:37 INFO - 'tests': ['tp5o']}, 05:34:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'tests': ['tp5o']}, 05:34:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'talos_options': ['--disable-e10s', 05:34:37 INFO - '--xperf_path', 05:34:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:37 INFO - 'tests': ['tp5n']}, 05:34:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:37 INFO - 'talos_options': ['--xperf_path', 05:34:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:37 INFO - 'tests': ['tp5n']}}, 05:34:37 INFO - 'talos.zip': {'path': '', 05:34:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:34:37 INFO - Running post-action listener: _resource_record_post_action 05:34:37 INFO - ##### 05:34:37 INFO - ##### Running create-virtualenv step. 05:34:37 INFO - ##### 05:34:37 INFO - Running pre-action listener: _resource_record_pre_action 05:34:37 INFO - Running main action method: create_virtualenv 05:34:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:34:37 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:34:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:34:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:34:37 INFO - Using real prefix '/usr' 05:34:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:34:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:34:39 INFO - Installing pip.................done. 05:34:39 INFO - Return code: 0 05:34:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:34: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:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:39 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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34:39 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:34:39 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:34:39 INFO - Using env: {'DISPLAY': ':0', 05:34:39 INFO - 'HOME': '/home/cltbld', 05:34:39 INFO - 'LANG': 'en_US.UTF-8', 05:34:39 INFO - 'LANGUAGE': 'en_US:en', 05:34:39 INFO - 'LOGNAME': 'cltbld', 05:34:39 INFO - 'MAIL': '/var/mail/cltbld', 05:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:39 INFO - 'MOZ_NO_REMOTE': '1', 05:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:39 INFO - 'NO_EM_RESTART': '1', 05:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:39 INFO - 'PWD': '/builds/slave/test', 05:34:39 INFO - 'SHELL': '/bin/bash', 05:34:39 INFO - 'SHLVL': '1', 05:34:39 INFO - 'TERM': 'linux', 05:34:39 INFO - 'TMOUT': '86400', 05:34:39 INFO - 'USER': 'cltbld', 05:34:39 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:39 INFO - '_': '/tools/buildbot/bin/python'} 05:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:40 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:34:40 INFO - Cleaning up... 05:34:40 INFO - Return code: 0 05:34:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:34:40 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:34:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:40 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:34:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:40 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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34:40 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:34:40 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:34:40 INFO - Using env: {'DISPLAY': ':0', 05:34:40 INFO - 'HOME': '/home/cltbld', 05:34:40 INFO - 'LANG': 'en_US.UTF-8', 05:34:40 INFO - 'LANGUAGE': 'en_US:en', 05:34:40 INFO - 'LOGNAME': 'cltbld', 05:34:40 INFO - 'MAIL': '/var/mail/cltbld', 05:34:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:40 INFO - 'MOZ_NO_REMOTE': '1', 05:34:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:40 INFO - 'NO_EM_RESTART': '1', 05:34:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:40 INFO - 'PWD': '/builds/slave/test', 05:34:40 INFO - 'SHELL': '/bin/bash', 05:34:40 INFO - 'SHLVL': '1', 05:34:40 INFO - 'TERM': 'linux', 05:34:40 INFO - 'TMOUT': '86400', 05:34:40 INFO - 'USER': 'cltbld', 05:34:40 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:40 INFO - '_': '/tools/buildbot/bin/python'} 05:34:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:40 INFO - Downloading/unpacking psutil>=0.7.1 05:34: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:34: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:34: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:34: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:34: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:34: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:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:42 INFO - Installing collected packages: psutil 05:34:42 INFO - Running setup.py install for psutil 05:34:42 INFO - building 'psutil._psutil_linux' extension 05:34:42 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:34:42 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:34:42 INFO - building 'psutil._psutil_posix' extension 05:34:42 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:34:42 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:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:42 INFO - Successfully installed psutil 05:34:42 INFO - Cleaning up... 05:34:42 INFO - Return code: 0 05:34:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:34: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:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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', '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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:34: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 mozsystemmonitor==0.0.0 05:34:42 INFO - Using env: {'DISPLAY': ':0', 05:34:42 INFO - 'HOME': '/home/cltbld', 05:34:42 INFO - 'LANG': 'en_US.UTF-8', 05:34:42 INFO - 'LANGUAGE': 'en_US:en', 05:34:42 INFO - 'LOGNAME': 'cltbld', 05:34:42 INFO - 'MAIL': '/var/mail/cltbld', 05:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:42 INFO - 'MOZ_NO_REMOTE': '1', 05:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:42 INFO - 'NO_EM_RESTART': '1', 05:34:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:42 INFO - 'PWD': '/builds/slave/test', 05:34:42 INFO - 'SHELL': '/bin/bash', 05:34:42 INFO - 'SHLVL': '1', 05:34:42 INFO - 'TERM': 'linux', 05:34:42 INFO - 'TMOUT': '86400', 05:34:42 INFO - 'USER': 'cltbld', 05:34:42 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:42 INFO - '_': '/tools/buildbot/bin/python'} 05:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:34:42 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:34:42 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:34:42 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:34:42 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:34:42 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:34:42 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:34:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:34:45 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:34:45 INFO - Installing collected packages: mozsystemmonitor 05:34:45 INFO - Running setup.py install for mozsystemmonitor 05:34:45 INFO - Successfully installed mozsystemmonitor 05:34:45 INFO - Cleaning up... 05:34:45 INFO - Return code: 0 05:34:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:34: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:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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', '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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:34: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 blobuploader==1.2.4 05:34:45 INFO - Using env: {'DISPLAY': ':0', 05:34:45 INFO - 'HOME': '/home/cltbld', 05:34:45 INFO - 'LANG': 'en_US.UTF-8', 05:34:45 INFO - 'LANGUAGE': 'en_US:en', 05:34:45 INFO - 'LOGNAME': 'cltbld', 05:34:45 INFO - 'MAIL': '/var/mail/cltbld', 05:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:45 INFO - 'MOZ_NO_REMOTE': '1', 05:34:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:45 INFO - 'NO_EM_RESTART': '1', 05:34:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:45 INFO - 'PWD': '/builds/slave/test', 05:34:45 INFO - 'SHELL': '/bin/bash', 05:34:45 INFO - 'SHLVL': '1', 05:34:45 INFO - 'TERM': 'linux', 05:34:45 INFO - 'TMOUT': '86400', 05:34:45 INFO - 'USER': 'cltbld', 05:34:45 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:45 INFO - '_': '/tools/buildbot/bin/python'} 05:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:34: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:34: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:34: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:34: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:34: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:34: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:34:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:34:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:34: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:34: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:34: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:34: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:34: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:34: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:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:34:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:34: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:34: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:34: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:34: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:34: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:34: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:34:47 INFO - Downloading docopt-0.6.1.tar.gz 05:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:34:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:34:48 INFO - Running setup.py install for blobuploader 05:34:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:34:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:34:48 INFO - Running setup.py install for requests 05:34:48 INFO - Running setup.py install for docopt 05:34:48 INFO - Successfully installed blobuploader requests docopt 05:34:48 INFO - Cleaning up... 05:34:48 INFO - Return code: 0 05:34:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:48 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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34:48 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:34:48 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:34:48 INFO - Using env: {'DISPLAY': ':0', 05:34:48 INFO - 'HOME': '/home/cltbld', 05:34:48 INFO - 'LANG': 'en_US.UTF-8', 05:34:48 INFO - 'LANGUAGE': 'en_US:en', 05:34:48 INFO - 'LOGNAME': 'cltbld', 05:34:48 INFO - 'MAIL': '/var/mail/cltbld', 05:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:48 INFO - 'MOZ_NO_REMOTE': '1', 05:34:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:48 INFO - 'NO_EM_RESTART': '1', 05:34:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:48 INFO - 'PWD': '/builds/slave/test', 05:34:48 INFO - 'SHELL': '/bin/bash', 05:34:48 INFO - 'SHLVL': '1', 05:34:48 INFO - 'TERM': 'linux', 05:34:48 INFO - 'TMOUT': '86400', 05:34:48 INFO - 'USER': 'cltbld', 05:34:48 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:48 INFO - '_': '/tools/buildbot/bin/python'} 05:34:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:48 INFO - Running setup.py (path:/tmp/pip-199PS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:48 INFO - Running setup.py (path:/tmp/pip-A0Eih6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:48 INFO - Running setup.py (path:/tmp/pip-kAoru8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:49 INFO - Running setup.py (path:/tmp/pip-g4GgNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:49 INFO - Running setup.py (path:/tmp/pip-AV8uMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:49 INFO - Running setup.py (path:/tmp/pip-i90s6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:49 INFO - Running setup.py (path:/tmp/pip-EAZ651-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:49 INFO - Running setup.py (path:/tmp/pip-R80Ha3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:49 INFO - Running setup.py (path:/tmp/pip-0hqOyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:49 INFO - Running setup.py (path:/tmp/pip-P5rcxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:49 INFO - Running setup.py (path:/tmp/pip-nadyrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:49 INFO - Running setup.py (path:/tmp/pip-oTWzI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:49 INFO - Running setup.py (path:/tmp/pip-JrqNDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:49 INFO - Running setup.py (path:/tmp/pip-GY1x17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:49 INFO - Running setup.py (path:/tmp/pip-PFsFu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:49 INFO - Running setup.py (path:/tmp/pip-deq7Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:49 INFO - Running setup.py (path:/tmp/pip-Re5eDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:34:50 INFO - Running setup.py install for manifestparser 05:34:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Running setup.py install for mozcrash 05:34:50 INFO - Running setup.py install for mozdebug 05:34:50 INFO - Running setup.py install for mozdevice 05:34:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Running setup.py install for mozfile 05:34:50 INFO - Running setup.py install for mozhttpd 05:34:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Running setup.py install for mozinfo 05:34:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Running setup.py install for mozInstall 05:34:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:34:50 INFO - Running setup.py install for mozleak 05:34:50 INFO - Running setup.py install for mozlog 05:34:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:34:51 INFO - Running setup.py install for moznetwork 05:34:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:34:51 INFO - Running setup.py install for mozprocess 05:34:51 INFO - Running setup.py install for mozprofile 05:34:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:34:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:34:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:34:51 INFO - Running setup.py install for mozrunner 05:34:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:34:51 INFO - Running setup.py install for mozscreenshot 05:34:51 INFO - Running setup.py install for moztest 05:34:51 INFO - Running setup.py install for mozversion 05:34:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:34:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:34:51 INFO - Cleaning up... 05:34:51 INFO - Return code: 0 05:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:51 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:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:51 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:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:51 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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34:51 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:34:51 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:34:51 INFO - Using env: {'DISPLAY': ':0', 05:34:51 INFO - 'HOME': '/home/cltbld', 05:34:51 INFO - 'LANG': 'en_US.UTF-8', 05:34:51 INFO - 'LANGUAGE': 'en_US:en', 05:34:51 INFO - 'LOGNAME': 'cltbld', 05:34:51 INFO - 'MAIL': '/var/mail/cltbld', 05:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:51 INFO - 'MOZ_NO_REMOTE': '1', 05:34:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:51 INFO - 'NO_EM_RESTART': '1', 05:34:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:51 INFO - 'PWD': '/builds/slave/test', 05:34:51 INFO - 'SHELL': '/bin/bash', 05:34:51 INFO - 'SHLVL': '1', 05:34:51 INFO - 'TERM': 'linux', 05:34:51 INFO - 'TMOUT': '86400', 05:34:51 INFO - 'USER': 'cltbld', 05:34:51 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:51 INFO - '_': '/tools/buildbot/bin/python'} 05:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:52 INFO - Running setup.py (path:/tmp/pip-OgBJD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:52 INFO - Running setup.py (path:/tmp/pip-KCodb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:52 INFO - Running setup.py (path:/tmp/pip-KjtuYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:52 INFO - Running setup.py (path:/tmp/pip-GGx4n0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:52 INFO - Running setup.py (path:/tmp/pip-W0jIRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:52 INFO - Running setup.py (path:/tmp/pip-ZnQz1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:52 INFO - Running setup.py (path:/tmp/pip-NevAe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:52 INFO - Running setup.py (path:/tmp/pip-Z_w4vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:52 INFO - Running setup.py (path:/tmp/pip-vqSJeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:52 INFO - Running setup.py (path:/tmp/pip-2eO_Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:52 INFO - Running setup.py (path:/tmp/pip-LVMfm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:52 INFO - Running setup.py (path:/tmp/pip-iuVCod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:52 INFO - Running setup.py (path:/tmp/pip-eG1DF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:52 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:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:52 INFO - Running setup.py (path:/tmp/pip-SySHJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:53 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:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:53 INFO - Running setup.py (path:/tmp/pip-6LNy8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:53 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:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:53 INFO - Running setup.py (path:/tmp/pip-ax5bHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:53 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:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:53 INFO - Running setup.py (path:/tmp/pip-0uzZ9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:53 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:34:53 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:34:53 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:34:53 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:34:53 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:34:53 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:34:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:34:53 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:34:53 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:34:53 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:34:53 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:34:53 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:34:53 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:34:55 INFO - Downloading blessings-1.6.tar.gz 05:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:34:55 INFO - Installing collected packages: blessings 05:34:55 INFO - Running setup.py install for blessings 05:34:55 INFO - Successfully installed blessings 05:34:55 INFO - Cleaning up... 05:34:55 INFO - Return code: 0 05:34:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:34:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:55 INFO - Reading from file tmpfile_stdout 05:34:55 INFO - Current package versions: 05:34:55 INFO - argparse == 1.2.1 05:34:55 INFO - blessings == 1.6 05:34:55 INFO - blobuploader == 1.2.4 05:34:55 INFO - docopt == 0.6.1 05:34:55 INFO - manifestparser == 1.1 05:34:55 INFO - mozInstall == 1.12 05:34:55 INFO - mozcrash == 0.17 05:34:55 INFO - mozdebug == 0.1 05:34:55 INFO - mozdevice == 0.48 05:34:55 INFO - mozfile == 1.2 05:34:55 INFO - mozhttpd == 0.7 05:34:55 INFO - mozinfo == 0.9 05:34:55 INFO - mozleak == 0.1 05:34:55 INFO - mozlog == 3.1 05:34:55 INFO - moznetwork == 0.27 05:34:55 INFO - mozprocess == 0.22 05:34:55 INFO - mozprofile == 0.28 05:34:55 INFO - mozrunner == 6.11 05:34:55 INFO - mozscreenshot == 0.1 05:34:55 INFO - mozsystemmonitor == 0.0 05:34:55 INFO - moztest == 0.7 05:34:55 INFO - mozversion == 1.4 05:34:55 INFO - psutil == 3.1.1 05:34:55 INFO - requests == 1.2.3 05:34:55 INFO - wsgiref == 0.1.2 05:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:55 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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34:55 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:34:55 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:34:55 INFO - Using env: {'DISPLAY': ':0', 05:34:55 INFO - 'HOME': '/home/cltbld', 05:34:55 INFO - 'LANG': 'en_US.UTF-8', 05:34:55 INFO - 'LANGUAGE': 'en_US:en', 05:34:55 INFO - 'LOGNAME': 'cltbld', 05:34:55 INFO - 'MAIL': '/var/mail/cltbld', 05:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:55 INFO - 'MOZ_NO_REMOTE': '1', 05:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:55 INFO - 'NO_EM_RESTART': '1', 05:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:55 INFO - 'PWD': '/builds/slave/test', 05:34:55 INFO - 'SHELL': '/bin/bash', 05:34:55 INFO - 'SHLVL': '1', 05:34:55 INFO - 'TERM': 'linux', 05:34:55 INFO - 'TMOUT': '86400', 05:34:55 INFO - 'USER': 'cltbld', 05:34:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:55 INFO - '_': '/tools/buildbot/bin/python'} 05:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 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:34:55 INFO - Cleaning up... 05:34:55 INFO - Return code: 0 05:34:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:55 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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34:55 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:34:55 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:34:55 INFO - Using env: {'DISPLAY': ':0', 05:34:55 INFO - 'HOME': '/home/cltbld', 05:34:55 INFO - 'LANG': 'en_US.UTF-8', 05:34:55 INFO - 'LANGUAGE': 'en_US:en', 05:34:55 INFO - 'LOGNAME': 'cltbld', 05:34:55 INFO - 'MAIL': '/var/mail/cltbld', 05:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:55 INFO - 'MOZ_NO_REMOTE': '1', 05:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:55 INFO - 'NO_EM_RESTART': '1', 05:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:55 INFO - 'PWD': '/builds/slave/test', 05:34:55 INFO - 'SHELL': '/bin/bash', 05:34:55 INFO - 'SHLVL': '1', 05:34:55 INFO - 'TERM': 'linux', 05:34:55 INFO - 'TMOUT': '86400', 05:34:55 INFO - 'USER': 'cltbld', 05:34:55 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:55 INFO - '_': '/tools/buildbot/bin/python'} 05:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:56 INFO - Downloading/unpacking jsonschema 05:34:56 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:34:56 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:34:56 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:34:56 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:34:56 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:34:56 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:34:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:34:57 INFO - Downloading/unpacking functools32 (from jsonschema) 05:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:34:58 INFO - warning: no files found matching '*.txt' 05:34:58 INFO - no previously-included directories found matching 'build' 05:34:58 INFO - no previously-included directories found matching 'dist' 05:34:58 INFO - no previously-included directories found matching '.git*' 05:34:58 INFO - Installing collected packages: jsonschema, functools32 05:34:58 INFO - Running setup.py install for functools32 05:34:58 INFO - warning: no files found matching '*.txt' 05:34:58 INFO - no previously-included directories found matching 'build' 05:34:58 INFO - no previously-included directories found matching 'dist' 05:34:58 INFO - no previously-included directories found matching '.git*' 05:34:58 INFO - Successfully installed jsonschema functools32 05:34:58 INFO - Cleaning up... 05:34:58 INFO - Return code: 0 05:34:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:58 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 0x7feb775b4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3f7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, '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': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', '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:34:58 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:34:58 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:34:58 INFO - Using env: {'DISPLAY': ':0', 05:34:58 INFO - 'HOME': '/home/cltbld', 05:34:58 INFO - 'LANG': 'en_US.UTF-8', 05:34:58 INFO - 'LANGUAGE': 'en_US:en', 05:34:58 INFO - 'LOGNAME': 'cltbld', 05:34:58 INFO - 'MAIL': '/var/mail/cltbld', 05:34:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:58 INFO - 'MOZ_NO_REMOTE': '1', 05:34:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:34:58 INFO - 'NO_EM_RESTART': '1', 05:34:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:34:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:58 INFO - 'PWD': '/builds/slave/test', 05:34:58 INFO - 'SHELL': '/bin/bash', 05:34:58 INFO - 'SHLVL': '1', 05:34:58 INFO - 'TERM': 'linux', 05:34:58 INFO - 'TMOUT': '86400', 05:34:58 INFO - 'USER': 'cltbld', 05:34:58 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:34:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:58 INFO - '_': '/tools/buildbot/bin/python'} 05:34:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:58 INFO - Downloading/unpacking flake8 05:34:58 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:34:58 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:34:58 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:34:58 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:34:58 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:34:58 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:35:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:35:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:35:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:00 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:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:35:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:35:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:35:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:35:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:35:01 INFO - no previously-included directories found matching 'docs/_build' 05:35:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:35:01 INFO - Running setup.py install for pep8 05:35:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:35:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:35:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:35:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:35:01 INFO - no previously-included directories found matching 'docs/_build' 05:35:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:35:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:35:01 INFO - Cleaning up... 05:35:01 INFO - Return code: 0 05:35:01 INFO - Running post-action listener: _resource_record_post_action 05:35:01 INFO - Running post-action listener: _start_resource_monitoring 05:35:01 INFO - Starting resource monitoring. 05:35:01 INFO - ##### 05:35:01 INFO - ##### Running install step. 05:35:01 INFO - ##### 05:35:01 INFO - Running pre-action listener: _resource_record_pre_action 05:35:01 INFO - Running main action method: install 05:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:01 INFO - Reading from file tmpfile_stdout 05:35:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:35:01 INFO - Reading from file tmpfile_stdout 05:35:01 INFO - Output received: 05:35:01 INFO - Usage: mozinstall [options] installer 05:35:01 INFO - Options: 05:35:01 INFO - -h, --help show this help message and exit 05:35:01 INFO - -d DEST, --destination=DEST 05:35:01 INFO - Directory to install application into. [default: 05:35:01 INFO - "/builds/slave/test"] 05:35:01 INFO - --app=APP Application being installed. [default: firefox] 05:35:01 INFO - mkdir: /builds/slave/test/build/application 05:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:35:17 INFO - Reading from file tmpfile_stdout 05:35:17 INFO - Output received: 05:35:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:35:17 INFO - Running post-action listener: _resource_record_post_action 05:35:17 INFO - ##### 05:35:17 INFO - ##### Running run-tests step. 05:35:17 INFO - ##### 05:35:17 INFO - Running pre-action listener: _resource_record_pre_action 05:35:17 INFO - Running main action method: run_tests 05:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:35:17 INFO - Python 2.7.3 05:35:17 INFO - Return code: 0 05:35:17 INFO - grabbing minidump binary from tooltool 05:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:17 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 0x2ace640>, '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 0x2acf540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acf9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:35:17 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:35:17 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:35:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:35:17 INFO - Return code: 0 05:35:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:35:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:35:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:35:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:35:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:35:18 INFO - Return code: 0 05:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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:35:18 INFO - Using env: {'DISPLAY': ':0', 05:35:18 INFO - 'HOME': '/home/cltbld', 05:35:18 INFO - 'LANG': 'en_US.UTF-8', 05:35:18 INFO - 'LANGUAGE': 'en_US:en', 05:35:18 INFO - 'LOGNAME': 'cltbld', 05:35:18 INFO - 'MAIL': '/var/mail/cltbld', 05:35:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:35:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:18 INFO - 'MOZ_NO_REMOTE': '1', 05:35:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:35:18 INFO - 'NO_EM_RESTART': '1', 05:35:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:18 INFO - 'PWD': '/builds/slave/test', 05:35:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:35:18 INFO - 'SHELL': '/bin/bash', 05:35:18 INFO - 'SHLVL': '1', 05:35:18 INFO - 'TERM': 'linux', 05:35:18 INFO - 'TMOUT': '86400', 05:35:18 INFO - 'USER': 'cltbld', 05:35:18 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157', 05:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:18 INFO - '_': '/tools/buildbot/bin/python'} 05:35:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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:35:18 INFO - mozversion application_buildid: 20160509005049 05:35:18 INFO - mozversion application_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:35:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:35:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:35:18 INFO - mozversion application_name: Firefox 05:35:18 INFO - mozversion application_remotingname: firefox-dev 05:35:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:35:18 INFO - mozversion application_vendor: Mozilla 05:35:18 INFO - mozversion application_version: 48.0a2 05:35:18 INFO - mozversion platform_buildid: 20160509005049 05:35:18 INFO - mozversion platform_changeset: 307b5eca8726f6a72a1d69ba76630a6dbf402477 05:35:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:35:18 INFO - mozversion platform_version: 48.0a2 05:35:18 INFO - using testdate: 1462797318 05:35:18 INFO - actual date: 1462797318 05:35:18 INFO - starting webserver on 'localhost:38337' 05:35:18 INFO - SUITE-START | Running 2 tests 05:35:18 INFO - TEST-START | dromaeo_css 05:35:18 INFO - operating with platform_type : linux_ 05:35:18 INFO - Initialising browser for dromaeo_css test... 05:35:18 INFO - TEST-INFO | started process 15625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj7c5oJ/profile http://localhost:38337/getInfo.html) 05:35:22 INFO - PROCESS | 15625 | __metrics Screen width/height:1600/1200 05:35:22 INFO - PROCESS | 15625 | colorDepth:24 05:35:22 INFO - PROCESS | 15625 | Browser inner width/height: 1024/697 05:35:22 INFO - PROCESS | 15625 | __metrics 05:35:23 ERROR - PROCESS | 15625 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:35:24 INFO - TEST-INFO | 15625: exit 0 05:35:24 INFO - Browser initialized. 05:35:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:35:24 INFO - TEST-INFO | started process 15716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpj7c5oJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:36 INFO - PROCESS | 15716 | RSS: Main: 142381056 05:35:36 INFO - PROCESS | 15716 | 05:36:27 INFO - PROCESS | 15716 | 1462797387601 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:38:35 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:38337/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38337/tests/dromaeo/cssquery-ext.html) 05:38:36 INFO - PROCESS | 15716 | RSS: Main: 251260928 05:38:36 INFO - PROCESS | 15716 | 05:41:38 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:38337/tests/dromaeo/cssquery-ext.html (next: http://localhost:38337/tests/dromaeo/cssquery-jquery.html) 05:41:39 INFO - PROCESS | 15716 | RSS: Main: 221335552 05:41:39 INFO - PROCESS | 15716 | 05:44:40 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:38337/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38337/tests/dromaeo/cssquery-mootools.html) 05:44:41 INFO - PROCESS | 15716 | RSS: Main: 223805440 05:44:41 INFO - PROCESS | 15716 | 05:47:43 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:38337/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38337/tests/dromaeo/cssquery-prototype.html) 05:47:44 INFO - PROCESS | 15716 | RSS: Main: 217214976 05:47:44 INFO - PROCESS | 15716 | 05:50:46 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:38337/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38337/tests/dromaeo/cssquery-yui.html) 05:50:47 INFO - PROCESS | 15716 | RSS: Main: 211361792 05:50:47 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | Cycle 1(1): loaded http://localhost:38337/tests/dromaeo/cssquery-yui.html (next: http://localhost:38337/tests/dromaeo/cssquery-dojo.html) 05:53:49 INFO - PROCESS | 15716 | RSS: Main: 259510272 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | __start_tp_report 05:53:49 INFO - PROCESS | 15716 | _x_x_mozilla_page_load 05:53:49 INFO - PROCESS | 15716 | _x_x_mozilla_page_load_details 05:53:49 INFO - PROCESS | 15716 | |i|pagename|runs| 05:53:49 INFO - PROCESS | 15716 | |0;dojo.html;3325.634180240174;3400.0309911675176;3416.6241713411528;3430.656934306571;3431.725461963043;5590.4409559044125;5599.720013999299;5620.353659329178;5637.887242255152;5639.7180140993;5594.888102237953;5626.2967129108865;5628.099504079348;5630.774769009245;5637.492625663689;4954.331165292693;5006.69959802413;5191.558717509007;5194.92207616886;5248.370195576517;5090.440051594322;5100.030994111125;5121.4110377306715;5124.5131712487255;5125.871853203681;4991.376077990251;5065.341505604266;5077.238414237875;5089.770960306795;5118.07874582575;5200.739963001834;5215.1655735082395;5216.6869987800665;5218.452062533417;5222.216667499905;4976.651634385558;5020.221865610836;5105.974470127626;5120.103981803207;5123.410807757081;5425.565954723652;5435.239066530688;5474.562035037187;5477.972610136924;5484.945150548523;5870.911936320958;5880.26496687914;5892.587518873681;5895;5912.17229587858;5846.649201047951;5939.762409503614;5993.580449368546;6004.0693692477735;6013.308469526017;5499.312585926759;5522.751476183541;5564.888702225973;5594.24477695514;5597.048501754671;5971.761129554856;6029.216201893726;6036.6679832609625;6098.420650038239;6123.203983482119;5767.452092051249;5869.882602347929;5871.031279838864;5872.735726892215;5877.500412464903;5996.190514280516;5996.550258730613;5998.820035398945;6003.459688628044;6005.129256257906;5807.68057756819;5903.970480147572;5972.910406343908;5977;5981.401859814071;6025;6026.638401695912;6032.577719559677;6033.276006879202;6077.3314935357075;4566.771661416916;4574.725516469022;4575.130725162208;4576.839810606612;4608.861734147981;3974.463447434617;3978.3236849735613;4035.071933455263;4090.3250963591267;4132;5718.79984200551;5733.512651424676;5737.08206686928;5737.942620573741;5741.8277451675685;6034.24571928509;6047.425494578008;6049.062395328731;6052.54605904559;6053.424924632153;5616.943830561642;5641.717914104278;5665.065264231438;5730.971345143247;5751.338596061423;5162.74186290684;5170.663906846043;5173.663711858717;5174.482551744871;5175.275461435402;6235.719392627343;6237.189165408558;6243.37566243372;6246.593971391845;6251.9687401563615;5908.675022873697;6008.429199226067;6106.755729770937;6121.724522396414;6125.111858780541;6174.629522228681;6241.906371404341;6244;6245;6245.063240513778;5917.644941303535;5917.91123133162;5936.470225699273;5937.376575459514;5971.970140149445;5814.970925145347;5937.287525496968;6019.729112189874;6033.456988871023;6058.394160583906;5853.473187413153;5856.3558008618165;5878.735456904535;5890.204822348928;5919.822405327847;5654.915176272441;5763.567732420001;5832.854178645568;5836.678982655825;5837.29952405714;5684.488396044376;5799.420057994167;5817.185594016756;5823.7379317929945;5859.091840764689;5834.737436815269;5884.029135192645;5902.911456328245;5907.881842363215;5917.1715959766525;5554.361248456479;5691.7438715257085;5732.828015159552;5745.885082298247;5776.277965254343 05:53:49 INFO - PROCESS | 15716 | |1;ext.html;658.8550518885844;662.5726406467828;676.3675962974619;685.184630289955;756.1644382956829;32694.509582356255;40228.195436091264;40767;40778.18443631129;40847.591524084826;42653.7867310663;43162.568374316244;43166;43227.78386108065;43265;8194.22154895287;8825.646974121044;9013.008569057398;10412.42731649759;10603.204759643058;10524;10628.681139565826;10656.520456579434;10657.573697052108;10660.09389201915;10615.84076238857;10624.734381640443;10690.251682382237;10694.679159625224;10700.090492308123;8580.999999999969;10478.947605261925;10567.15462762977;10662.893371066268;10666.893331066667;10726.410047447387;10823.83764243537;10834;10854.67435976922;10858.891411085868;41439.79280103611;41824.79087604542;42003.1599368014;42076.368854467204;42077.57922420767;3872.9806350968065;3953.7034722395647;4027.7784721840285;4110.630043296118;4359.825606975717;32781;33982.660173398195;34700.82649586761;34833;35178.648213517794;4330.761808100553;4428.844990425352;4498.437695288089;4527.049319642879;4537.2059889519205;351262.2436887825;352483;354623;356426;356893;40779.7961010193;69085;69963.3003669967;70208.64895675489;70419;39466.2106757869;39483.80258098749;39492;39511.60488395137;39513.604863951565;17305.39431119905;17518.29926802939;17524.299028038735;17530.29878804859;17568.736468952975;13805.17168969865;14243.928780356031;14344.282785860665;14389.78415323771;14513.854861451251;9399.530023498797;9428.15146636806;9435.528223588793;9475.715728528156;9504.714858554255;2938.76489880809;2950.734433900959;2986.6266716660416;3012.9548056778726;3043.8325892075704;1134.2513940799033;1139.8461207737016;1204.3015051270243;1211.7576484703095;1237.6101528018646;33412.83293583516;33824.15439614029;34197.48703769445;34566.48150277748;34756.47865282023;1253.4108968784656;1257.9685507862193;1280.2510531339271;1297.3707751740399;1319.1755153029358;17804.55488612795;17923.462296131136;17994.91002544979;18081.186346614435;18090.63818723618;510875;842805;854724;865255;865571;60336.69831650814;60773;60967.69516152391;60980.39019609836;61036.69481652652;1502.9023113497587;1547.6208328959476;1551.4259723902003;1564.389887943703;1643.8684905207554;31067.223319417197;32425.67574324321;32749.17470321782;33336.83331583327;33804;50303.49696503134;51048;51071.489285106676;51094.23358649698;51123.48876511336;381137;385737;386353;386630;386768;27741.861290693418;30533.847330763205;30849.228769280948;31468.842655786575;31523;45925;46708.299375510076;46898.53101469078;47198.76400617975;47974.28038579354;38955;39649.2070158601;39863.2027359457;39870.202595948496;40058.799706001286;38827;39357.80321098376;39416.80291598524;39668.2066358677;40413.79793101016;40883.59116408917;40890.79554602208;41311.586884130775;43840.780796095816;44747;32549.674503254664;36167.457488137174;37008.25983480369;38030.239395211385;38293.234135317696;26790.732092679602;27177.45645087127;28853.42293154083;29106.7089329104;29136.27159320949 05:53:49 INFO - PROCESS | 15716 | |2;jquery.html;413.96688264938825;414.5108771649456;420.39882967356687;427.0796433685407;427.6899248045167;13842.653933651663;18511.907440462797;19139.33012344568;19164.329248476308;21317.57364852702;15895.125768082751;18391.54021149472;19465.708014379794;20318.492037699067;20438.591228175428;5568.693721845297;5739.799107031255;5752.971235143839;5765.7981970631035;5772.971135144318;5651.576131790132;5716.256886604736;5722;5748.19525266463;5755.25181726375;4271.978640106795;6113.908291375633;6391.360863913595;6393.520485963571;6400.935990640104;6136.8772624547255;6326.0510923361635;6348.904766428507;6355.269144048424;6380.202474690664;5595.468430499096;5599;5632.802851900205;5650.124230744241;5653.349864765563;22651.09395624173;23433.76566234333;24317.148899788423;24596.385090372703;24613.87693061523;2596.7533084356955;2616.0582190411437;2636.36727185476;2736.179146256135;3018.170003249124;14724;15278.618034549114;15364;15560.61098472536;15694.058356498646;2063.0819285417997;2073.2639912830878;2150.5913876363443;2229.7730924793586;2286.7713228677167;77912.22087779106;80730.38539229182;81076;81299.5935020327;82816;11262.774744505228;11356.943215284036;11373.94313028446;11471.655850324503;11481.253718508271;15656.37374505007;15822.52532424029;15874.92062539703;15876.682466350609;15921.363145474283;8225.917740822635;8411.45325553837;8714.477131372138;8890.822183556293;8938.41900276493;7874.763757087297;7949.602519874099;8538.658453661908;8659.307255419551;8691.652333906699;4466.3747075409465;4585;4831.613470922318;4917.877053073702;4922;1922.08700867087;1970.9014549272479;1983.8710483818506;2019.9091040903195;2038.7043878637514;1098.5441041967495;1105.5854054729477;1122.680036189682;1126.3748619516248;1149.3793351590048;19273.22907083701;19443.513912152026;19763.30828421027;19771.604567908562;20021.699674504893;1039.6309310194922;1047.9580816767243;1096.3257596578046;1105.1103861391496;1115.3753897817248;10911.399873006902;11295.322280663186;11310.377929213972;11317.207795454404;11325.71685707864;401827;411377;419934;532917;535334;93451.53274233585;99970;100822.49588752157;101304;102618;1104.9613263535737;1137.9871913996549;1139.2936379444632;1154.7459558897028;1169.1114752787773;17506.387276445264;17976.730349045036;18072;18136.909315453337;18438.907805461422;35077;36307.818460907525;36401.453978190875;36788;39966.80016599898;53222.73388633032;56180;57089.42910570841;57717.71141144267;57888.13167802402;8844.867326990228;8861.51261680588;8889.64441422336;9152.444084505516;9250.121238482334;8407.495550267004;13456.5290214842;13627.046106772827;13633.454661813417;13681;11607.36159511235;12038.699032524257;12068.094892882893;12086.335251560897;12356.505739770308;11602.70993225176;12246.632601021984;12278.75442491163;12342.629721108382;12794.552190673654;12300.507979680713;12404.317762523147;12594.433250503933;12688.429020693906;12733.681657958625;8839.867401989104;8904.109589041043;8923.41997770143;8939.687110951085;9060.773480662772;9088.772780680536;11867.881321186678;12304.569340073054;12389.75220495603;12431.191972521758 05:53:49 INFO - PROCESS | 15716 | |3;mootools.html;1413.5971248194267;1566.4439124110943;1584.255399962018;1761.2162587648502;1905.180772267925;7599.354054905333;8274.172582741723;8500.404971651988;8512.361572882028;8516.829663406728;8224.712135075273;8413.326933845294;8415.957920210405;8425.199606037431;8427.70503032394;2137.593857167133;2397.9040838366445;2452.448199155194;2456.2876765737915;2481.7146028206807;2433.1848830641757;2450.0934654177977;2453.2149712092137;2455.594826853567;2455.815813813962;2357.49313897512;2429.259075981825;2430.86630235337;2431.914882979096;2432.5013372258645;2097.265956915083;2373.95252094958;2432.3189506938083;2435.0138194031356;2441.511697660475;2353.470469144446;2356.3991182248587;2362.0315670574983;2362.9721071334025;2423.5274121546304;8391.874121888177;8410;8440.28257598105;8441.366897482714;8453.492790432532;5144.56271216947;5248.8687782805355;5249.711265880375;5250.6324557281005;5337.985782701313;3544.149404143013;3546.716262698978;3618.6200448952745;3698.6116457771814;3733.5519737631384;1236.876312368765;1251.8184863194786;1278.328877339395;1279.2516377918928;2227.187076717003;11364.090872730245;11522.596709115141;11531.481083351186;11542.480588373459;11547.422628868522;4470.195364834361;4476.753778542146;4509.526499717548;4541.795619197144;4594.840425000245;9431.292653051049;9433.386829856037;9445.433274003582;9450.196733277611;9453.38552994067;4726.314684370747;5317.1226747586215;5322.600804939568;5326.44072372403;5326.600504962066;4403.3174857897075;4411.382406463098;4467.486239082547;4863.829765958175;4901.730404827768;4100.856470023535;4110.380553895246;4171.582841715865;4191.538930717618;4192.57452466163;1308.483149156097;1310.4168644953095;1323.6227675112548;1329.6210579984659;1333.9333033348294;1045.5190612318418;1066.221658189526;1080.800570838356;1082.3181395720646;1102.8400881872083;5943.970280148572;5990.520758339322;5992.34084250732;6005.939940600538;6147.784827531015;467.7661169415292;482.67419491842867;482.95653391194963;486.48918635432653;488.8337965091886;4142.233686767958;4241.893952651209;4311.698181127291;4325.307950727868;4344.044310251739;10150.289479736348;10446.112080473245;10540.736481587868;10552.41961692099;10559.577616895393;9933.453660048766;9990.650327238513;10016.248781341428;10025.147862431775;10057.245706572035;7699.576523291161;7875.291223789886;7932.325752311118;7935.365170786324;7938.364930805522;5815.94184058171;5827.504662103599;5886.470217680429;5916.674582897982;5987.251593550806;8912.420692654956;9052.728418147466;9086.45481271126;9087.591058402255;9170.908290917272;9101;9140.725778226664;9226.446413215228;9399.483028433502;9434.198093162158;6788;7342.8898566520475;7538.509996850187;7546.207648196861;7550.395968322631;8114.229148230908;8157.877631835646;8167.79580510492;8187.099419063779;8203.753887383387;7107.111611048619;7237;7294.489385742947;7354.448416368687;7437.405007599487;7335.7432489862595;7433.8884916727375;7545.245475452411;7587.203343648837;7625;6939.618320992192;6949.200841903245;6962.060121883481;6990.580565166107;7002.089728335488;5276.81531146408;5292.9470705294;5413.052715774802;5416.75624596902;5463.31708536433;5336.866578335573;5347.385050719217;5403.0544654686055;5429.837104886859;5449.727513624223 05:53:49 INFO - PROCESS | 15716 | |4;prototype.html;357.8711663801031;360.1967612224739;361.51195885554495;364.25509832392754;364.74832365667686;6366.108744775735;6379.585326953745;6440.774572889944;6472.352764723537;6515.967420162904;6365.649889256089;6366.681665916709;6385.297617262097;6392.936070639293;6409.647469389181;4642.442906851183;4744.833930812422;4879.878003049935;4889.168841296988;4897.04507621014;4860.732659703733;4890.046440944017;4898.583620392271;4906.435759887623;4909.214525675892;4650.395448591678;4841.757912104398;4855.247436647308;4860.902781944359;4862.294967229767;4793.760311984404;4859.271109333628;4879;4888.364512613373;4893.437254715717;4277.123189746126;4285.400043993844;4292.420523229386;4295.033617436052;4297.828086876521;6128.264608246995;6134.171886795315;6134.355892631299;6134.570580059398;6143.139960405547;5706.514946229576;5710.229119068914;5711;5713.714314284269;5713.914291285634;6496.090547323379;6735.663216839139;6737.898931516032;6741.662916854138;6744.494162937799;4614.169449499089;4635.049814787961;4640.69835460694;4643.442786865598;4647.326137710013;6996.965015174943;7032.367086962198;7062.929370706279;7072.398846098036;7073.434125269966;4743.739094349775;4747.905041899143;4757.286407038971;4757.500462451462;4757.881052973634;4798.616110711135;4798.928016079762;4805.735684537384;4816.95183048172;4819.759012049383;5533.584981126432;5566.053770858964;5591.9720401397735;5592.552595792326;5600.103983362643;6633.6019838809825;6802.285759995229;6827.965860170767;6828.9317106829285;6835.14560679915;1673.2219517924223;1703.429351167348;1706.854917332016;1707.598714302138;1708.2227586448137;1016.0905989139678;1109.6393672056613;1126.9605563805228;1161.309021132425;1199.2444759801444;6497.837554061091;6537.5750576212395;6555.737770489127;6566.638834864033;6634.203895532471;6934.375906168469;6937.895931561031;6955.82610434733;6975.51171418006;6980.860382792316;6545.116409284686;6562.67186640666;6565.048068030109;6566.8358291043105;6571.80284591463;3681.5385298514543;3724.1434470072036;3763.7741735495956;3764.0778009387877;3771.1891943232336;7118.572885626879;7173.390261827803;7181.820454488679;7206.747763828241;7218.819529511804;7026.894596581055;7028.437724981989;7034.120734908137;7047.048648432396;7051.083359163276;7173.246809085075;7227.385672217815;7239.529430586995;7273.527220730635;7284.089488813898;6937.82655433598;6950.165980082423;6951.2353641098425;6954.478414119062;6963.199232088172;6723.899141512783;6912.654367281716;6944.270851560514;6953.269906659728;6970.407515361251;7276.96361518189;7306.525075870051;7306.707731690885;7313.341799238094;7316.780496585111;4774.259989701602;4795.160846851857;4807.302941073594;4808.302796094476;4810.95189048105;7026.2271150174465;7028.472864535078;7035.613041282779;7038.401735852305;7039.894401583878;6732.225794033749;6814.591124532544;6878.621675807879;6888.276730943179;6891.138607674041;6795.864082718417;6828.7268509259075;6834.487413443912;6835.69239384219;6836.316368363124;6710.798676039727;6711.664416779044;6712.362325579063;6715.56348837324;6725.092112564741;6859.588424694534;6877.484188685969;6877.830768769221;6878.931210688029;6881;6541.247756508063;6608.207015158212;6662.467002639681;6796.694148763218;6870.725170993104 05:53:49 INFO - PROCESS | 15716 | |5;yui.html;923.8244733500634;926.3376685669747;939.8346050896881;940.4733349324379;956.6938579654509;14822.481213157542;15132.924335378322;15142.697146057086;15144.621384465394;15173.468928587501;13098.738025239514;13122.147060441064;13129.60611181666;13165.736685266289;13186.934065329684;726.89460028296;747.8878168274775;747.9102507699083;748.3638906929122;874.5714599846061;893.0756666849812;896.5651658945407;896.757875373652;896.9820603587957;897.7845317123908;930.5440334236209;943.8820147481565;945.2296378451574;947.2422062350126;947.981040379192;763.9847203055936;927.3554879358849;942.7548837302282;945.347710080046;946.2524605561598;695.5791745993652;696.084648686975;696.6621188723465;697.0102454514602;697.27483417246;13886.166829990232;13895.16629002253;13954.930225348808;13990.580282591538;14002.159870407808;14211.78682319766;14784.63038424048;14913.986611807375;15059.322330495153;15522.146281954489;12341.876581234163;12367.814482782765;12413.317267550281;12464.43910024042;12670.239785612892;4044.413560033808;4060.1473690525027;4090;4107.958920410788;4141.337386018253;57087.42912570863;57439.712801436144;59560.40439595635;60153.99999999956;60162.69918650422;11705.707357316136;11714.941425292818;11852.762944741056;11911.225770324902;11977.880221197851;20903.58192836135;21104.47238819011;21112.366629001153;21117.68323475149;21168.78831211668;8767.342449316327;9071.682491112779;9239.907600923905;9265.675701350421;9299.256059515223;5088.77100530477;5118.385793704705;5130.769115389817;5246;5257.526822585985;3521.9119522011642;3624.0758606555687;3634.036980200249;3657.487951686766;3749.4750734897134;669.4242951062083;681.7204945972128;686.2759788423161;689.396777819408;691.640347019547;691.8650863081751;727.959962202084;758.2341834746945;771;779.8635238833182;8906.688265910792;9725.951370243103;9975.551100200508;10077.949610251902;10152.746181345525;746.1531162130912;768.2701433638066;774.4656187230905;786.5752493653478;793.4683761879554;4517.887052823706;4605.217113090783;4643.442786865598;4689.296605509133;4761.738104404291;62022;67024.6648766753;67471.30114795451;67838.66080669565;68225.3177468219;56468.717656411456;56958.7152064237;57179.42820571824;57313.42686573164;57665.711671442215;51987;52065.7396713014;53072.46927530752;53334.93330133375;53889.1916621251;10202.13377308036;10430.16558675289;10434.478276086316;10436.843447348449;10504.947475262576;38144.42783358196;38247.61752382552;39029.2194156121;39083.2183356337;40895.795521022206;48253.27620085772;48654;50168;50342.2448663263;51980;12955.287459189834;13150.868491314965;13178.736425271632;13192.472301107848;13403.597892063253;14502.419903203754;15367.923160384127;15422.383104675688;15442;15691.215439228221;13240.602781916557;13624.86375136236;13969.720605588034;14347.56957291283;14619.780703289673;13703.275222404052;13704.451821927012;13828.861711382757;13882.514112006435;14180.858191417954;13843;14158.575242742734;14546.636334091732;14616.41534338657;14628.780568291697;11818.704532386415;12028.518859245532;12162.75674486523;12237.755244894874;12585.181963172365;11284.32294062359;11811.350375729417;12003.63989080329;12232.388380581113;12241.755164896475 05:53:49 INFO - PROCESS | 15716 | __end_tp_report 05:53:49 INFO - PROCESS | 15716 | __start_cc_report 05:53:49 INFO - PROCESS | 15716 | _x_x_mozilla_cycle_collect,838 05:53:49 INFO - PROCESS | 15716 | __end_cc_report 05:53:49 INFO - PROCESS | 15716 | __startTimestamp1462798429905__endTimestamp 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | ------- Summary: start ------- 05:53:49 INFO - PROCESS | 15716 | Number of tests: 6 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | [#0] dojo.html Cycles:165 Average:5566.84 Median:5767.45 stddev:615.11 (10.7%) stddev-sans-first:591.34 05:53:49 INFO - PROCESS | 15716 | Values: 3325.6 3400.0 3416.6 3430.7 3431.7 5590.4 5599.7 5620.4 5637.9 5639.7 5594.9 5626.3 5628.1 5630.8 5637.5 4954.3 5006.7 5191.6 5194.9 5248.4 5090.4 5100.0 5121.4 5124.5 5125.9 4991.4 5065.3 5077.2 5089.8 5118.1 5200.7 5215.2 5216.7 5218.5 5222.2 4976.7 5020.2 5106.0 5120.1 5123.4 5425.6 5435.2 5474.6 5478.0 5484.9 5870.9 5880.3 5892.6 5895.0 5912.2 5846.6 5939.8 5993.6 6004.1 6013.3 5499.3 5522.8 5564.9 5594.2 5597.0 5971.8 6029.2 6036.7 6098.4 6123.2 5767.5 5869.9 5871.0 5872.7 5877.5 5996.2 5996.6 5998.8 6003.5 6005.1 5807.7 5904.0 5972.9 5977.0 5981.4 6025.0 6026.6 6032.6 6033.3 6077.3 4566.8 4574.7 4575.1 4576.8 4608.9 3974.5 3978.3 4035.1 4090.3 4132.0 5718.8 5733.5 5737.1 5737.9 5741.8 6034.2 6047.4 6049.1 6052.5 6053.4 5616.9 5641.7 5665.1 5731.0 5751.3 5162.7 5170.7 5173.7 5174.5 5175.3 6235.7 6237.2 6243.4 6246.6 6252.0 5908.7 6008.4 6106.8 6121.7 6125.1 6174.6 6241.9 6244.0 6245.0 6245.1 5917.6 5917.9 5936.5 5937.4 5972.0 5815.0 5937.3 6019.7 6033.5 6058.4 5853.5 5856.4 5878.7 5890.2 5919.8 5654.9 5763.6 5832.9 5836.7 5837.3 5684.5 5799.4 5817.2 5823.7 5859.1 5834.7 5884.0 5902.9 5907.9 5917.2 5554.4 5691.7 5732.8 5745.9 5776.3 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | [#1] ext.html Cycles:180 Average:65518.45 Median:209583.62 stddev:148719.96 (71.0%) stddev-sans-first:149057.43 05:53:49 INFO - PROCESS | 15716 | Values: 658.9 662.6 676.4 685.2 756.2 32694.5 40228.2 40767.0 40778.2 40847.6 42653.8 43162.6 43166.0 43227.8 43265.0 8194.2 8825.6 9013.0 10412.4 10603.2 10524.0 10628.7 10656.5 10657.6 10660.1 10615.8 10624.7 10690.3 10694.7 10700.1 8581.0 10478.9 10567.2 10662.9 10666.9 10726.4 10823.8 10834.0 10854.7 10858.9 41439.8 41824.8 42003.2 42076.4 42077.6 3873.0 3953.7 4027.8 4110.6 4359.8 32781.0 33982.7 34700.8 34833.0 35178.6 4330.8 4428.8 4498.4 4527.0 4537.2 351262.2 352483.0 354623.0 356426.0 356893.0 40779.8 69085.0 69963.3 70208.6 70419.0 39466.2 39483.8 39492.0 39511.6 39513.6 17305.4 17518.3 17524.3 17530.3 17568.7 13805.2 14243.9 14344.3 14389.8 14513.9 9399.5 9428.2 9435.5 9475.7 9504.7 2938.8 2950.7 2986.6 3013.0 3043.8 1134.3 1139.8 1204.3 1211.8 1237.6 33412.8 33824.2 34197.5 34566.5 34756.5 1253.4 1258.0 1280.3 1297.4 1319.2 17804.6 17923.5 17994.9 18081.2 18090.6 510875.0 842805.0 854724.0 865255.0 865571.0 60336.7 60773.0 60967.7 60980.4 61036.7 1502.9 1547.6 1551.4 1564.4 1643.9 31067.2 32425.7 32749.2 33336.8 33804.0 50303.5 51048.0 51071.5 51094.2 51123.5 381137.0 385737.0 386353.0 386630.0 386768.0 27741.9 30533.8 30849.2 31468.8 31523.0 45925.0 46708.3 46898.5 47198.8 47974.3 38955.0 39649.2 39863.2 39870.2 40058.8 38827.0 39357.8 39416.8 39668.2 40413.8 40883.6 40890.8 41311.6 43840.8 44747.0 32549.7 36167.5 37008.3 38030.2 38293.2 26790.7 27177.5 28853.4 29106.7 29136.3 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | [#2] jquery.html Cycles:180 Average:28535.16 Median:12468.93 stddev:76812.75 (616.0%) stddev-sans-first:76999.21 05:53:49 INFO - PROCESS | 15716 | Values: 414.0 414.5 420.4 427.1 427.7 13842.7 18511.9 19139.3 19164.3 21317.6 15895.1 18391.5 19465.7 20318.5 20438.6 5568.7 5739.8 5753.0 5765.8 5773.0 5651.6 5716.3 5722.0 5748.2 5755.3 4272.0 6113.9 6391.4 6393.5 6400.9 6136.9 6326.1 6348.9 6355.3 6380.2 5595.5 5599.0 5632.8 5650.1 5653.3 22651.1 23433.8 24317.1 24596.4 24613.9 2596.8 2616.1 2636.4 2736.2 3018.2 14724.0 15278.6 15364.0 15560.6 15694.1 2063.1 2073.3 2150.6 2229.8 2286.8 77912.2 80730.4 81076.0 81299.6 82816.0 11262.8 11356.9 11373.9 11471.7 11481.3 15656.4 15822.5 15874.9 15876.7 15921.4 8225.9 8411.5 8714.5 8890.8 8938.4 7874.8 7949.6 8538.7 8659.3 8691.7 4466.4 4585.0 4831.6 4917.9 4922.0 1922.1 1970.9 1983.9 2019.9 2038.7 1098.5 1105.6 1122.7 1126.4 1149.4 19273.2 19443.5 19763.3 19771.6 20021.7 1039.6 1048.0 1096.3 1105.1 1115.4 10911.4 11295.3 11310.4 11317.2 11325.7 401827.0 411377.0 419934.0 532917.0 535334.0 93451.5 99970.0 100822.5 101304.0 102618.0 1105.0 1138.0 1139.3 1154.7 1169.1 17506.4 17976.7 18072.0 18136.9 18438.9 35077.0 36307.8 36401.5 36788.0 39966.8 53222.7 56180.0 57089.4 57717.7 57888.1 8844.9 8861.5 8889.6 9152.4 9250.1 8407.5 13456.5 13627.0 13633.5 13681.0 11607.4 12038.7 12068.1 12086.3 12356.5 11602.7 12246.6 12278.8 12342.6 12794.6 12300.5 12404.3 12594.4 12688.4 12733.7 8839.9 8904.1 8923.4 8939.7 9060.8 9088.8 11867.9 12304.6 12389.8 12431.2 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | [#3] mootools.html Cycles:180 Average:5617.40 Median:5249.29 stddev:3009.81 (57.3%) stddev-sans-first:3001.67 05:53:49 INFO - PROCESS | 15716 | Values: 1413.6 1566.4 1584.3 1761.2 1905.2 7599.4 8274.2 8500.4 8512.4 8516.8 8224.7 8413.3 8416.0 8425.2 8427.7 2137.6 2397.9 2452.4 2456.3 2481.7 2433.2 2450.1 2453.2 2455.6 2455.8 2357.5 2429.3 2430.9 2431.9 2432.5 2097.3 2374.0 2432.3 2435.0 2441.5 2353.5 2356.4 2362.0 2363.0 2423.5 8391.9 8410.0 8440.3 8441.4 8453.5 5144.6 5248.9 5249.7 5250.6 5338.0 3544.1 3546.7 3618.6 3698.6 3733.6 1236.9 1251.8 1278.3 1279.3 2227.2 11364.1 11522.6 11531.5 11542.5 11547.4 4470.2 4476.8 4509.5 4541.8 4594.8 9431.3 9433.4 9445.4 9450.2 9453.4 4726.3 5317.1 5322.6 5326.4 5326.6 4403.3 4411.4 4467.5 4863.8 4901.7 4100.9 4110.4 4171.6 4191.5 4192.6 1308.5 1310.4 1323.6 1329.6 1333.9 1045.5 1066.2 1080.8 1082.3 1102.8 5944.0 5990.5 5992.3 6005.9 6147.8 467.8 482.7 483.0 486.5 488.8 4142.2 4241.9 4311.7 4325.3 4344.0 10150.3 10446.1 10540.7 10552.4 10559.6 9933.5 9990.7 10016.2 10025.1 10057.2 7699.6 7875.3 7932.3 7935.4 7938.4 5815.9 5827.5 5886.5 5916.7 5987.3 8912.4 9052.7 9086.5 9087.6 9170.9 9101.0 9140.7 9226.4 9399.5 9434.2 6788.0 7342.9 7538.5 7546.2 7550.4 8114.2 8157.9 8167.8 8187.1 8203.8 7107.1 7237.0 7294.5 7354.4 7437.4 7335.7 7433.9 7545.2 7587.2 7625.0 6939.6 6949.2 6962.1 6990.6 7002.1 5276.8 5292.9 5413.1 5416.8 5463.3 5336.9 5347.4 5403.1 5429.8 5449.7 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | [#4] prototype.html Cycles:180 Average:5667.65 Median:6506.90 stddev:1719.20 (26.4%) stddev-sans-first:1677.20 05:53:49 INFO - PROCESS | 15716 | Values: 357.9 360.2 361.5 364.3 364.7 6366.1 6379.6 6440.8 6472.4 6516.0 6365.6 6366.7 6385.3 6392.9 6409.6 4642.4 4744.8 4879.9 4889.2 4897.0 4860.7 4890.0 4898.6 4906.4 4909.2 4650.4 4841.8 4855.2 4860.9 4862.3 4793.8 4859.3 4879.0 4888.4 4893.4 4277.1 4285.4 4292.4 4295.0 4297.8 6128.3 6134.2 6134.4 6134.6 6143.1 5706.5 5710.2 5711.0 5713.7 5713.9 6496.1 6735.7 6737.9 6741.7 6744.5 4614.2 4635.0 4640.7 4643.4 4647.3 6997.0 7032.4 7062.9 7072.4 7073.4 4743.7 4747.9 4757.3 4757.5 4757.9 4798.6 4798.9 4805.7 4817.0 4819.8 5533.6 5566.1 5592.0 5592.6 5600.1 6633.6 6802.3 6828.0 6828.9 6835.1 1673.2 1703.4 1706.9 1707.6 1708.2 1016.1 1109.6 1127.0 1161.3 1199.2 6497.8 6537.6 6555.7 6566.6 6634.2 6934.4 6937.9 6955.8 6975.5 6980.9 6545.1 6562.7 6565.0 6566.8 6571.8 3681.5 3724.1 3763.8 3764.1 3771.2 7118.6 7173.4 7181.8 7206.7 7218.8 7026.9 7028.4 7034.1 7047.0 7051.1 7173.2 7227.4 7239.5 7273.5 7284.1 6937.8 6950.2 6951.2 6954.5 6963.2 6723.9 6912.7 6944.3 6953.3 6970.4 7277.0 7306.5 7306.7 7313.3 7316.8 4774.3 4795.2 4807.3 4808.3 4811.0 7026.2 7028.5 7035.6 7038.4 7039.9 6732.2 6814.6 6878.6 6888.3 6891.1 6795.9 6828.7 6834.5 6835.7 6836.3 6710.8 6711.7 6712.4 6715.6 6725.1 6859.6 6877.5 6877.8 6878.9 6881.0 6541.2 6608.2 6662.5 6796.7 6870.7 05:53:49 INFO - PROCESS | 15716 | 05:53:49 INFO - PROCESS | 15716 | [#5] yui.html Cycles:180 Average:15991.28 Median:4124.65 stddev:18298.97 (443.6%) stddev-sans-first:18315.32 05:53:49 INFO - PROCESS | 15716 | Values: 923.8 926.3 939.8 940.5 956.7 14822.5 15132.9 15142.7 15144.6 15173.5 13098.7 13122.1 13129.6 13165.7 13186.9 726.9 747.9 747.9 748.4 874.6 893.1 896.6 896.8 897.0 897.8 930.5 943.9 945.2 947.2 948.0 764.0 927.4 942.8 945.3 946.3 695.6 696.1 696.7 697.0 697.3 13886.2 13895.2 13954.9 13990.6 14002.2 14211.8 14784.6 14914.0 15059.3 15522.1 12341.9 12367.8 12413.3 12464.4 12670.2 4044.4 4060.1 4090.0 4108.0 4141.3 57087.4 57439.7 59560.4 60154.0 60162.7 11705.7 11714.9 11852.8 11911.2 11977.9 20903.6 21104.5 21112.4 21117.7 21168.8 8767.3 9071.7 9239.9 9265.7 9299.3 5088.8 5118.4 5130.8 5246.0 5257.5 3521.9 3624.1 3634.0 3657.5 3749.5 669.4 681.7 686.3 689.4 691.6 691.9 728.0 758.2 771.0 779.9 8906.7 9726.0 9975.6 10077.9 10152.7 746.2 768.3 774.5 786.6 793.5 4517.9 4605.2 4643.4 4689.3 4761.7 62022.0 67024.7 67471.3 67838.7 68225.3 56468.7 56958.7 57179.4 57313.4 57665.7 51987.0 52065.7 53072.5 53334.9 53889.2 10202.1 10430.2 10434.5 10436.8 10504.9 38144.4 38247.6 39029.2 39083.2 40895.8 48253.3 48654.0 50168.0 50342.2 51980.0 12955.3 13150.9 13178.7 13192.5 13403.6 14502.4 15367.9 15422.4 15442.0 15691.2 13240.6 13624.9 13969.7 14347.6 14619.8 13703.3 13704.5 13828.9 13882.5 14180.9 13843.0 14158.6 14546.6 14616.4 14628.8 11818.7 12028.5 12162.8 12237.8 12585.2 11284.3 11811.4 12003.6 12232.4 12241.8 05:53:49 INFO - PROCESS | 15716 | -------- Summary: end -------- 05:53:49 INFO - PROCESS | 15716 | 05:53:50 INFO - TEST-INFO | 15716: exit 0 05:53:50 INFO - TEST-OK | dromaeo_css | took 1111838ms 05:53:50 INFO - TEST-START | kraken 05:53:50 INFO - operating with platform_type : linux_ 05:53:50 INFO - Initialising browser for kraken test... 05:53:50 INFO - TEST-INFO | started process 15916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptkGFzD/profile http://localhost:38337/getInfo.html) 05:53:54 INFO - PROCESS | 15916 | __metrics Screen width/height:1600/1200 05:53:54 INFO - PROCESS | 15916 | colorDepth:24 05:53:54 INFO - PROCESS | 15916 | Browser inner width/height: 1024/697 05:53:54 INFO - PROCESS | 15916 | __metrics 05:53:55 ERROR - PROCESS | 15916 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:53:56 INFO - TEST-INFO | 15916: exit 0 05:53:56 INFO - Browser initialized. 05:53:56 INFO - Running cycle 1/1 for kraken test... 05:53:56 INFO - TEST-INFO | started process 16008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptkGFzD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:08 INFO - PROCESS | 16008 | RSS: Main: 142073856 05:54:08 INFO - PROCESS | 16008 | 05:54:10 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38337/tests/kraken/driver.html?testName=audio-beat-detection) 05:54:11 INFO - PROCESS | 16008 | RSS: Main: 196743168 05:54:11 INFO - PROCESS | 16008 | 05:54:14 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38337/tests/kraken/driver.html?testName=audio-dft) 05:54:14 INFO - PROCESS | 16008 | RSS: Main: 182628352 05:54:14 INFO - PROCESS | 16008 | 05:54:17 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38337/tests/kraken/driver.html?testName=audio-fft) 05:54:18 INFO - PROCESS | 16008 | RSS: Main: 272826368 05:54:18 INFO - PROCESS | 16008 | 05:54:20 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38337/tests/kraken/driver.html?testName=audio-oscillator) 05:54:20 INFO - PROCESS | 16008 | RSS: Main: 179097600 05:54:20 INFO - PROCESS | 16008 | 05:54:23 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38337/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:54:23 INFO - PROCESS | 16008 | RSS: Main: 177778688 05:54:23 INFO - PROCESS | 16008 | 05:54:26 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38337/tests/kraken/driver.html?testName=imaging-darkroom) 05:54:27 INFO - PROCESS | 16008 | RSS: Main: 212668416 05:54:27 INFO - PROCESS | 16008 | 05:54:30 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38337/tests/kraken/driver.html?testName=imaging-desaturate) 05:54:31 INFO - PROCESS | 16008 | RSS: Main: 213356544 05:54:31 INFO - PROCESS | 16008 | 05:54:33 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38337/tests/kraken/driver.html?testName=json-parse-financial) 05:54:34 INFO - PROCESS | 16008 | RSS: Main: 212488192 05:54:34 INFO - PROCESS | 16008 | 05:54:35 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38337/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:54:36 INFO - PROCESS | 16008 | RSS: Main: 192831488 05:54:36 INFO - PROCESS | 16008 | 05:54:38 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:54:38 INFO - PROCESS | 16008 | RSS: Main: 198512640 05:54:38 INFO - PROCESS | 16008 | 05:54:40 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:54:41 INFO - PROCESS | 16008 | RSS: Main: 210935808 05:54:41 INFO - PROCESS | 16008 | 05:54:43 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:54:44 INFO - PROCESS | 16008 | RSS: Main: 213348352 05:54:44 INFO - PROCESS | 16008 | 05:54:47 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:54:47 INFO - PROCESS | 16008 | RSS: Main: 209620992 05:54:47 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | Cycle 1(1): loaded http://localhost:38337/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38337/tests/kraken/driver.html?testName=ai-astar) 05:54:49 INFO - PROCESS | 16008 | RSS: Main: 274059264 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | __start_tp_report 05:54:49 INFO - PROCESS | 16008 | _x_x_mozilla_page_load 05:54:49 INFO - PROCESS | 16008 | _x_x_mozilla_page_load_details 05:54:49 INFO - PROCESS | 16008 | |i|pagename|runs| 05:54:49 INFO - PROCESS | 16008 | |0;ai-astar;112;112;111;110;111;112;105;111;110;111 05:54:49 INFO - PROCESS | 16008 | |1;audio-beat-detection;161;127;152;182;128;159;160;129;180;127 05:54:49 INFO - PROCESS | 16008 | |2;audio-dft;163;163;161;161;162;163;161;160;159;161 05:54:49 INFO - PROCESS | 16008 | |3;audio-fft;75;75;76;188;75;78;73;78;166;75 05:54:49 INFO - PROCESS | 16008 | |4;audio-oscillator;92;92;152;92;92;93;153;92;92;146 05:54:49 INFO - PROCESS | 16008 | |5;imaging-gaussian-blur;117;116;116;117;117;116;117;116;116;117 05:54:49 INFO - PROCESS | 16008 | |6;imaging-darkroom;147;146;147;146;146;148;146;146;147;146 05:54:49 INFO - PROCESS | 16008 | |7;imaging-desaturate;94;94;95;95;94;94;94;95;94;94 05:54:49 INFO - PROCESS | 16008 | |8;json-parse-financial;52;54;53;54;53;54;55;77;54;52 05:54:49 INFO - PROCESS | 16008 | |9;json-stringify-tinderbox;57;58;57;57;58;57;58;56;57;57 05:54:49 INFO - PROCESS | 16008 | |10;stanford-crypto-aes;74;71;80;71;72;73;82;73;72;74 05:54:49 INFO - PROCESS | 16008 | |11;stanford-crypto-ccm;114;117;115;114;110;114;115;113;127;116 05:54:49 INFO - PROCESS | 16008 | |12;stanford-crypto-pbkdf2;160;158;159;160;161;167;162;158;157;162 05:54:49 INFO - PROCESS | 16008 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;67;68;67;67;65 05:54:49 INFO - PROCESS | 16008 | __end_tp_report 05:54:49 INFO - PROCESS | 16008 | __start_cc_report 05:54:49 INFO - PROCESS | 16008 | _x_x_mozilla_cycle_collect,1617 05:54:49 INFO - PROCESS | 16008 | __end_cc_report 05:54:49 INFO - PROCESS | 16008 | __startTimestamp1462798489695__endTimestamp 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | ------- Summary: start ------- 05:54:49 INFO - PROCESS | 16008 | Number of tests: 14 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:2.12 05:54:49 INFO - PROCESS | 16008 | Values: 112.0 112.0 111.0 110.0 111.0 112.0 105.0 111.0 110.0 111.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:159.50 stddev:21.63 (13.6%) stddev-sans-first:22.61 05:54:49 INFO - PROCESS | 16008 | Values: 161.0 127.0 152.0 182.0 128.0 159.0 160.0 129.0 180.0 127.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.30 05:54:49 INFO - PROCESS | 16008 | Values: 163.0 163.0 161.0 161.0 162.0 163.0 161.0 160.0 159.0 161.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#3] audio-fft Cycles:10 Average:95.90 Median:75.00 stddev:43.08 (57.4%) stddev-sans-first:45.03 05:54:49 INFO - PROCESS | 16008 | Values: 75.0 75.0 76.0 188.0 75.0 78.0 73.0 78.0 166.0 75.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:92.00 stddev:28.17 (30.6%) stddev-sans-first:29.15 05:54:49 INFO - PROCESS | 16008 | Values: 92.0 92.0 152.0 92.0 92.0 93.0 153.0 92.0 92.0 146.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:54:49 INFO - PROCESS | 16008 | Values: 117.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 05:54:49 INFO - PROCESS | 16008 | Values: 147.0 146.0 147.0 146.0 146.0 148.0 146.0 146.0 147.0 146.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:54:49 INFO - PROCESS | 16008 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.00 stddev:7.51 (13.9%) stddev-sans-first:7.84 05:54:49 INFO - PROCESS | 16008 | Values: 52.0 54.0 53.0 54.0 53.0 54.0 55.0 77.0 54.0 52.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 05:54:49 INFO - PROCESS | 16008 | Values: 57.0 58.0 57.0 57.0 58.0 57.0 58.0 56.0 57.0 57.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:73.50 stddev:3.77 (5.1%) stddev-sans-first:3.99 05:54:49 INFO - PROCESS | 16008 | Values: 74.0 71.0 80.0 71.0 72.0 73.0 82.0 73.0 72.0 74.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#11] stanford-crypto-ccm Cycles:10 Average:115.50 Median:115.00 stddev:4.45 (3.9%) stddev-sans-first:4.69 05:54:49 INFO - PROCESS | 16008 | Values: 114.0 117.0 115.0 114.0 110.0 114.0 115.0 113.0 127.0 116.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:160.50 stddev:2.88 (1.8%) stddev-sans-first:3.05 05:54:49 INFO - PROCESS | 16008 | Values: 160.0 158.0 159.0 160.0 161.0 167.0 162.0 158.0 157.0 162.0 05:54:49 INFO - PROCESS | 16008 | 05:54:49 INFO - PROCESS | 16008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 05:54:49 INFO - PROCESS | 16008 | Values: 67.0 68.0 67.0 68.0 67.0 67.0 68.0 67.0 67.0 65.0 05:54:49 INFO - PROCESS | 16008 | -------- Summary: end -------- 05:54:49 INFO - PROCESS | 16008 | 05:54:50 INFO - TEST-INFO | 16008: exit 0 05:54:50 INFO - TEST-OK | kraken | took 60143ms 05:54:50 INFO - SUITE-END | took 1171s 05:54:50 INFO - Completed test suite (00:19:32) 05:54:50 INFO - javascript benchmark 05:54:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.634180240174, 3400.0309911675176, 3416.6241713411528, 3430.656934306571, 3431.725461963043, 5590.4409559044125, 5599.720013999299, 5620.353659329178, 5637.887242255152, 5639.7180140993, 5594.888102237953, 5626.2967129108865, 5628.099504079348, 5630.774769009245, 5637.492625663689, 4954.331165292693, 5006.69959802413, 5191.558717509007, 5194.92207616886, 5248.370195576517, 5090.440051594322, 5100.030994111125, 5121.4110377306715, 5124.5131712487255, 5125.871853203681, 4991.376077990251, 5065.341505604266, 5077.238414237875, 5089.770960306795, 5118.07874582575, 5200.739963001834, 5215.1655735082395, 5216.6869987800665, 5218.452062533417, 5222.216667499905, 4976.651634385558, 5020.221865610836, 5105.974470127626, 5120.103981803207, 5123.410807757081, 5425.565954723652, 5435.239066530688, 5474.562035037187, 5477.972610136924, 5484.945150548523, 5870.911936320958, 5880.26496687914, 5892.587518873681, 5895.0, 5912.17229587858, 5846.649201047951, 5939.762409503614, 5993.580449368546, 6004.0693692477735, 6013.308469526017, 5499.312585926759, 5522.751476183541, 5564.888702225973, 5594.24477695514, 5597.048501754671, 5971.761129554856, 6029.216201893726, 6036.6679832609625, 6098.420650038239, 6123.203983482119, 5767.452092051249, 5869.882602347929, 5871.031279838864, 5872.735726892215, 5877.500412464903, 5996.190514280516, 5996.550258730613, 5998.820035398945, 6003.459688628044, 6005.129256257906, 5807.68057756819, 5903.970480147572, 5972.910406343908, 5977.0, 5981.401859814071, 6025.0, 6026.638401695912, 6032.577719559677, 6033.276006879202, 6077.3314935357075, 4566.771661416916, 4574.725516469022, 4575.130725162208, 4576.839810606612, 4608.861734147981, 3974.463447434617, 3978.3236849735613, 4035.071933455263, 4090.3250963591267, 4132.0, 5718.79984200551, 5733.512651424676, 5737.08206686928, 5737.942620573741, 5741.8277451675685, 6034.24571928509, 6047.425494578008, 6049.062395328731, 6052.54605904559, 6053.424924632153, 5616.943830561642, 5641.717914104278, 5665.065264231438, 5730.971345143247, 5751.338596061423, 5162.74186290684, 5170.663906846043, 5173.663711858717, 5174.482551744871, 5175.275461435402, 6235.719392627343, 6237.189165408558, 6243.37566243372, 6246.593971391845, 6251.9687401563615, 5908.675022873697, 6008.429199226067, 6106.755729770937, 6121.724522396414, 6125.111858780541, 6174.629522228681, 6241.906371404341, 6244.0, 6245.0, 6245.063240513778, 5917.644941303535, 5917.91123133162, 5936.470225699273, 5937.376575459514, 5971.970140149445, 5814.970925145347, 5937.287525496968, 6019.729112189874, 6033.456988871023, 6058.394160583906, 5853.473187413153, 5856.3558008618165, 5878.735456904535, 5890.204822348928, 5919.822405327847, 5654.915176272441, 5763.567732420001, 5832.854178645568, 5836.678982655825, 5837.29952405714, 5684.488396044376, 5799.420057994167, 5817.185594016756, 5823.7379317929945, 5859.091840764689, 5834.737436815269, 5884.029135192645, 5902.911456328245, 5907.881842363215, 5917.1715959766525, 5554.361248456479, 5691.7438715257085, 5732.828015159552, 5745.885082298247, 5776.277965254343], "value": 5527.146022207673, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.8550518885844, 662.5726406467828, 676.3675962974619, 685.184630289955, 756.1644382956829, 32694.509582356255, 40228.195436091264, 40767.0, 40778.18443631129, 40847.591524084826, 42653.7867310663, 43162.568374316244, 43166.0, 43227.78386108065, 43265.0, 8194.22154895287, 8825.646974121044, 9013.008569057398, 10412.42731649759, 10603.204759643058, 10524.0, 10628.681139565826, 10656.520456579434, 10657.573697052108, 10660.09389201915, 10615.84076238857, 10624.734381640443, 10690.251682382237, 10694.679159625224, 10700.090492308123, 8580.999999999969, 10478.947605261925, 10567.15462762977, 10662.893371066268, 10666.893331066667, 10726.410047447387, 10823.83764243537, 10834.0, 10854.67435976922, 10858.891411085868, 41439.79280103611, 41824.79087604542, 42003.1599368014, 42076.368854467204, 42077.57922420767, 3872.9806350968065, 3953.7034722395647, 4027.7784721840285, 4110.630043296118, 4359.825606975717, 32781.0, 33982.660173398195, 34700.82649586761, 34833.0, 35178.648213517794, 4330.761808100553, 4428.844990425352, 4498.437695288089, 4527.049319642879, 4537.2059889519205, 351262.2436887825, 352483.0, 354623.0, 356426.0, 356893.0, 40779.7961010193, 69085.0, 69963.3003669967, 70208.64895675489, 70419.0, 39466.2106757869, 39483.80258098749, 39492.0, 39511.60488395137, 39513.604863951565, 17305.39431119905, 17518.29926802939, 17524.299028038735, 17530.29878804859, 17568.736468952975, 13805.17168969865, 14243.928780356031, 14344.282785860665, 14389.78415323771, 14513.854861451251, 9399.530023498797, 9428.15146636806, 9435.528223588793, 9475.715728528156, 9504.714858554255, 2938.76489880809, 2950.734433900959, 2986.6266716660416, 3012.9548056778726, 3043.8325892075704, 1134.2513940799033, 1139.8461207737016, 1204.3015051270243, 1211.7576484703095, 1237.6101528018646, 33412.83293583516, 33824.15439614029, 34197.48703769445, 34566.48150277748, 34756.47865282023, 1253.4108968784656, 1257.9685507862193, 1280.2510531339271, 1297.3707751740399, 1319.1755153029358, 17804.55488612795, 17923.462296131136, 17994.91002544979, 18081.186346614435, 18090.63818723618, 510875.0, 842805.0, 854724.0, 865255.0, 865571.0, 60336.69831650814, 60773.0, 60967.69516152391, 60980.39019609836, 61036.69481652652, 1502.9023113497587, 1547.6208328959476, 1551.4259723902003, 1564.389887943703, 1643.8684905207554, 31067.223319417197, 32425.67574324321, 32749.17470321782, 33336.83331583327, 33804.0, 50303.49696503134, 51048.0, 51071.489285106676, 51094.23358649698, 51123.48876511336, 381137.0, 385737.0, 386353.0, 386630.0, 386768.0, 27741.861290693418, 30533.847330763205, 30849.228769280948, 31468.842655786575, 31523.0, 45925.0, 46708.299375510076, 46898.53101469078, 47198.76400617975, 47974.28038579354, 38955.0, 39649.2070158601, 39863.2027359457, 39870.202595948496, 40058.799706001286, 38827.0, 39357.80321098376, 39416.80291598524, 39668.2066358677, 40413.79793101016, 40883.59116408917, 40890.79554602208, 41311.586884130775, 43840.780796095816, 44747.0, 32549.674503254664, 36167.457488137174, 37008.25983480369, 38030.239395211385, 38293.234135317696, 26790.732092679602, 27177.45645087127, 28853.42293154083, 29106.7089329104, 29136.27159320949], "value": 20198.81902464778, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.96688264938825, 414.5108771649456, 420.39882967356687, 427.0796433685407, 427.6899248045167, 13842.653933651663, 18511.907440462797, 19139.33012344568, 19164.329248476308, 21317.57364852702, 15895.125768082751, 18391.54021149472, 19465.708014379794, 20318.492037699067, 20438.591228175428, 5568.693721845297, 5739.799107031255, 5752.971235143839, 5765.7981970631035, 5772.971135144318, 5651.576131790132, 5716.256886604736, 5722.0, 5748.19525266463, 5755.25181726375, 4271.978640106795, 6113.908291375633, 6391.360863913595, 6393.520485963571, 6400.935990640104, 6136.8772624547255, 6326.0510923361635, 6348.904766428507, 6355.269144048424, 6380.202474690664, 5595.468430499096, 5599.0, 5632.802851900205, 5650.124230744241, 5653.349864765563, 22651.09395624173, 23433.76566234333, 24317.148899788423, 24596.385090372703, 24613.87693061523, 2596.7533084356955, 2616.0582190411437, 2636.36727185476, 2736.179146256135, 3018.170003249124, 14724.0, 15278.618034549114, 15364.0, 15560.61098472536, 15694.058356498646, 2063.0819285417997, 2073.2639912830878, 2150.5913876363443, 2229.7730924793586, 2286.7713228677167, 77912.22087779106, 80730.38539229182, 81076.0, 81299.5935020327, 82816.0, 11262.774744505228, 11356.943215284036, 11373.94313028446, 11471.655850324503, 11481.253718508271, 15656.37374505007, 15822.52532424029, 15874.92062539703, 15876.682466350609, 15921.363145474283, 8225.917740822635, 8411.45325553837, 8714.477131372138, 8890.822183556293, 8938.41900276493, 7874.763757087297, 7949.602519874099, 8538.658453661908, 8659.307255419551, 8691.652333906699, 4466.3747075409465, 4585.0, 4831.613470922318, 4917.877053073702, 4922.0, 1922.08700867087, 1970.9014549272479, 1983.8710483818506, 2019.9091040903195, 2038.7043878637514, 1098.5441041967495, 1105.5854054729477, 1122.680036189682, 1126.3748619516248, 1149.3793351590048, 19273.22907083701, 19443.513912152026, 19763.30828421027, 19771.604567908562, 20021.699674504893, 1039.6309310194922, 1047.9580816767243, 1096.3257596578046, 1105.1103861391496, 1115.3753897817248, 10911.399873006902, 11295.322280663186, 11310.377929213972, 11317.207795454404, 11325.71685707864, 401827.0, 411377.0, 419934.0, 532917.0, 535334.0, 93451.53274233585, 99970.0, 100822.49588752157, 101304.0, 102618.0, 1104.9613263535737, 1137.9871913996549, 1139.2936379444632, 1154.7459558897028, 1169.1114752787773, 17506.387276445264, 17976.730349045036, 18072.0, 18136.909315453337, 18438.907805461422, 35077.0, 36307.818460907525, 36401.453978190875, 36788.0, 39966.80016599898, 53222.73388633032, 56180.0, 57089.42910570841, 57717.71141144267, 57888.13167802402, 8844.867326990228, 8861.51261680588, 8889.64441422336, 9152.444084505516, 9250.121238482334, 8407.495550267004, 13456.5290214842, 13627.046106772827, 13633.454661813417, 13681.0, 11607.36159511235, 12038.699032524257, 12068.094892882893, 12086.335251560897, 12356.505739770308, 11602.70993225176, 12246.632601021984, 12278.75442491163, 12342.629721108382, 12794.552190673654, 12300.507979680713, 12404.317762523147, 12594.433250503933, 12688.429020693906, 12733.681657958625, 8839.867401989104, 8904.109589041043, 8923.41997770143, 8939.687110951085, 9060.773480662772, 9088.772780680536, 11867.881321186678, 12304.569340073054, 12389.75220495603, 12431.191972521758], "value": 9617.195668817389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.5971248194267, 1566.4439124110943, 1584.255399962018, 1761.2162587648502, 1905.180772267925, 7599.354054905333, 8274.172582741723, 8500.404971651988, 8512.361572882028, 8516.829663406728, 8224.712135075273, 8413.326933845294, 8415.957920210405, 8425.199606037431, 8427.70503032394, 2137.593857167133, 2397.9040838366445, 2452.448199155194, 2456.2876765737915, 2481.7146028206807, 2433.1848830641757, 2450.0934654177977, 2453.2149712092137, 2455.594826853567, 2455.815813813962, 2357.49313897512, 2429.259075981825, 2430.86630235337, 2431.914882979096, 2432.5013372258645, 2097.265956915083, 2373.95252094958, 2432.3189506938083, 2435.0138194031356, 2441.511697660475, 2353.470469144446, 2356.3991182248587, 2362.0315670574983, 2362.9721071334025, 2423.5274121546304, 8391.874121888177, 8410.0, 8440.28257598105, 8441.366897482714, 8453.492790432532, 5144.56271216947, 5248.8687782805355, 5249.711265880375, 5250.6324557281005, 5337.985782701313, 3544.149404143013, 3546.716262698978, 3618.6200448952745, 3698.6116457771814, 3733.5519737631384, 1236.876312368765, 1251.8184863194786, 1278.328877339395, 1279.2516377918928, 2227.187076717003, 11364.090872730245, 11522.596709115141, 11531.481083351186, 11542.480588373459, 11547.422628868522, 4470.195364834361, 4476.753778542146, 4509.526499717548, 4541.795619197144, 4594.840425000245, 9431.292653051049, 9433.386829856037, 9445.433274003582, 9450.196733277611, 9453.38552994067, 4726.314684370747, 5317.1226747586215, 5322.600804939568, 5326.44072372403, 5326.600504962066, 4403.3174857897075, 4411.382406463098, 4467.486239082547, 4863.829765958175, 4901.730404827768, 4100.856470023535, 4110.380553895246, 4171.582841715865, 4191.538930717618, 4192.57452466163, 1308.483149156097, 1310.4168644953095, 1323.6227675112548, 1329.6210579984659, 1333.9333033348294, 1045.5190612318418, 1066.221658189526, 1080.800570838356, 1082.3181395720646, 1102.8400881872083, 5943.970280148572, 5990.520758339322, 5992.34084250732, 6005.939940600538, 6147.784827531015, 467.7661169415292, 482.67419491842867, 482.95653391194963, 486.48918635432653, 488.8337965091886, 4142.233686767958, 4241.893952651209, 4311.698181127291, 4325.307950727868, 4344.044310251739, 10150.289479736348, 10446.112080473245, 10540.736481587868, 10552.41961692099, 10559.577616895393, 9933.453660048766, 9990.650327238513, 10016.248781341428, 10025.147862431775, 10057.245706572035, 7699.576523291161, 7875.291223789886, 7932.325752311118, 7935.365170786324, 7938.364930805522, 5815.94184058171, 5827.504662103599, 5886.470217680429, 5916.674582897982, 5987.251593550806, 8912.420692654956, 9052.728418147466, 9086.45481271126, 9087.591058402255, 9170.908290917272, 9101.0, 9140.725778226664, 9226.446413215228, 9399.483028433502, 9434.198093162158, 6788.0, 7342.8898566520475, 7538.509996850187, 7546.207648196861, 7550.395968322631, 8114.229148230908, 8157.877631835646, 8167.79580510492, 8187.099419063779, 8203.753887383387, 7107.111611048619, 7237.0, 7294.489385742947, 7354.448416368687, 7437.405007599487, 7335.7432489862595, 7433.8884916727375, 7545.245475452411, 7587.203343648837, 7625.0, 6939.618320992192, 6949.200841903245, 6962.060121883481, 6990.580565166107, 7002.089728335488, 5276.81531146408, 5292.9470705294, 5413.052715774802, 5416.75624596902, 5463.31708536433, 5336.866578335573, 5347.385050719217, 5403.0544654686055, 5429.837104886859, 5449.727513624223], "value": 4550.44545707939, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.8711663801031, 360.1967612224739, 361.51195885554495, 364.25509832392754, 364.74832365667686, 6366.108744775735, 6379.585326953745, 6440.774572889944, 6472.352764723537, 6515.967420162904, 6365.649889256089, 6366.681665916709, 6385.297617262097, 6392.936070639293, 6409.647469389181, 4642.442906851183, 4744.833930812422, 4879.878003049935, 4889.168841296988, 4897.04507621014, 4860.732659703733, 4890.046440944017, 4898.583620392271, 4906.435759887623, 4909.214525675892, 4650.395448591678, 4841.757912104398, 4855.247436647308, 4860.902781944359, 4862.294967229767, 4793.760311984404, 4859.271109333628, 4879.0, 4888.364512613373, 4893.437254715717, 4277.123189746126, 4285.400043993844, 4292.420523229386, 4295.033617436052, 4297.828086876521, 6128.264608246995, 6134.171886795315, 6134.355892631299, 6134.570580059398, 6143.139960405547, 5706.514946229576, 5710.229119068914, 5711.0, 5713.714314284269, 5713.914291285634, 6496.090547323379, 6735.663216839139, 6737.898931516032, 6741.662916854138, 6744.494162937799, 4614.169449499089, 4635.049814787961, 4640.69835460694, 4643.442786865598, 4647.326137710013, 6996.965015174943, 7032.367086962198, 7062.929370706279, 7072.398846098036, 7073.434125269966, 4743.739094349775, 4747.905041899143, 4757.286407038971, 4757.500462451462, 4757.881052973634, 4798.616110711135, 4798.928016079762, 4805.735684537384, 4816.95183048172, 4819.759012049383, 5533.584981126432, 5566.053770858964, 5591.9720401397735, 5592.552595792326, 5600.103983362643, 6633.6019838809825, 6802.285759995229, 6827.965860170767, 6828.9317106829285, 6835.14560679915, 1673.2219517924223, 1703.429351167348, 1706.854917332016, 1707.598714302138, 1708.2227586448137, 1016.0905989139678, 1109.6393672056613, 1126.9605563805228, 1161.309021132425, 1199.2444759801444, 6497.837554061091, 6537.5750576212395, 6555.737770489127, 6566.638834864033, 6634.203895532471, 6934.375906168469, 6937.895931561031, 6955.82610434733, 6975.51171418006, 6980.860382792316, 6545.116409284686, 6562.67186640666, 6565.048068030109, 6566.8358291043105, 6571.80284591463, 3681.5385298514543, 3724.1434470072036, 3763.7741735495956, 3764.0778009387877, 3771.1891943232336, 7118.572885626879, 7173.390261827803, 7181.820454488679, 7206.747763828241, 7218.819529511804, 7026.894596581055, 7028.437724981989, 7034.120734908137, 7047.048648432396, 7051.083359163276, 7173.246809085075, 7227.385672217815, 7239.529430586995, 7273.527220730635, 7284.089488813898, 6937.82655433598, 6950.165980082423, 6951.2353641098425, 6954.478414119062, 6963.199232088172, 6723.899141512783, 6912.654367281716, 6944.270851560514, 6953.269906659728, 6970.407515361251, 7276.96361518189, 7306.525075870051, 7306.707731690885, 7313.341799238094, 7316.780496585111, 4774.259989701602, 4795.160846851857, 4807.302941073594, 4808.302796094476, 4810.95189048105, 7026.2271150174465, 7028.472864535078, 7035.613041282779, 7038.401735852305, 7039.894401583878, 6732.225794033749, 6814.591124532544, 6878.621675807879, 6888.276730943179, 6891.138607674041, 6795.864082718417, 6828.7268509259075, 6834.487413443912, 6835.69239384219, 6836.316368363124, 6710.798676039727, 6711.664416779044, 6712.362325579063, 6715.56348837324, 6725.092112564741, 6859.588424694534, 6877.484188685969, 6877.830768769221, 6878.931210688029, 6881.0, 6541.247756508063, 6608.207015158212, 6662.467002639681, 6796.694148763218, 6870.725170993104], "value": 5106.820451482878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.8244733500634, 926.3376685669747, 939.8346050896881, 940.4733349324379, 956.6938579654509, 14822.481213157542, 15132.924335378322, 15142.697146057086, 15144.621384465394, 15173.468928587501, 13098.738025239514, 13122.147060441064, 13129.60611181666, 13165.736685266289, 13186.934065329684, 726.89460028296, 747.8878168274775, 747.9102507699083, 748.3638906929122, 874.5714599846061, 893.0756666849812, 896.5651658945407, 896.757875373652, 896.9820603587957, 897.7845317123908, 930.5440334236209, 943.8820147481565, 945.2296378451574, 947.2422062350126, 947.981040379192, 763.9847203055936, 927.3554879358849, 942.7548837302282, 945.347710080046, 946.2524605561598, 695.5791745993652, 696.084648686975, 696.6621188723465, 697.0102454514602, 697.27483417246, 13886.166829990232, 13895.16629002253, 13954.930225348808, 13990.580282591538, 14002.159870407808, 14211.78682319766, 14784.63038424048, 14913.986611807375, 15059.322330495153, 15522.146281954489, 12341.876581234163, 12367.814482782765, 12413.317267550281, 12464.43910024042, 12670.239785612892, 4044.413560033808, 4060.1473690525027, 4090.0, 4107.958920410788, 4141.337386018253, 57087.42912570863, 57439.712801436144, 59560.40439595635, 60153.99999999956, 60162.69918650422, 11705.707357316136, 11714.941425292818, 11852.762944741056, 11911.225770324902, 11977.880221197851, 20903.58192836135, 21104.47238819011, 21112.366629001153, 21117.68323475149, 21168.78831211668, 8767.342449316327, 9071.682491112779, 9239.907600923905, 9265.675701350421, 9299.256059515223, 5088.77100530477, 5118.385793704705, 5130.769115389817, 5246.0, 5257.526822585985, 3521.9119522011642, 3624.0758606555687, 3634.036980200249, 3657.487951686766, 3749.4750734897134, 669.4242951062083, 681.7204945972128, 686.2759788423161, 689.396777819408, 691.640347019547, 691.8650863081751, 727.959962202084, 758.2341834746945, 771.0, 779.8635238833182, 8906.688265910792, 9725.951370243103, 9975.551100200508, 10077.949610251902, 10152.746181345525, 746.1531162130912, 768.2701433638066, 774.4656187230905, 786.5752493653478, 793.4683761879554, 4517.887052823706, 4605.217113090783, 4643.442786865598, 4689.296605509133, 4761.738104404291, 62022.0, 67024.6648766753, 67471.30114795451, 67838.66080669565, 68225.3177468219, 56468.717656411456, 56958.7152064237, 57179.42820571824, 57313.42686573164, 57665.711671442215, 51987.0, 52065.7396713014, 53072.46927530752, 53334.93330133375, 53889.1916621251, 10202.13377308036, 10430.16558675289, 10434.478276086316, 10436.843447348449, 10504.947475262576, 38144.42783358196, 38247.61752382552, 39029.2194156121, 39083.2183356337, 40895.795521022206, 48253.27620085772, 48654.0, 50168.0, 50342.2448663263, 51980.0, 12955.287459189834, 13150.868491314965, 13178.736425271632, 13192.472301107848, 13403.597892063253, 14502.419903203754, 15367.923160384127, 15422.383104675688, 15442.0, 15691.215439228221, 13240.602781916557, 13624.86375136236, 13969.720605588034, 14347.56957291283, 14619.780703289673, 13703.275222404052, 13704.451821927012, 13828.861711382757, 13882.514112006435, 14180.858191417954, 13843.0, 14158.575242742734, 14546.636334091732, 14616.41534338657, 14628.780568291697, 11818.704532386415, 12028.518859245532, 12162.75674486523, 12237.755244894874, 12585.181963172365, 11284.32294062359, 11811.350375729417, 12003.63989080329, 12232.388380581113, 12241.755164896475], "value": 7301.563126627834, "unit": "score"}], "name": "dromaeo_css", "value": 7529.320827976004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 111.0, 110.0, 111.0, 112.0, 105.0, 111.0, 110.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 127.0, 152.0, 182.0, 128.0, 159.0, 160.0, 129.0, 180.0, 127.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 162.0, 163.0, 161.0, 160.0, 159.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 188.0, 75.0, 78.0, 73.0, 78.0, 166.0, 75.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 152.0, 92.0, 92.0, 93.0, 153.0, 92.0, 92.0, 146.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 53.0, 54.0, 53.0, 54.0, 55.0, 77.0, 54.0, 52.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 57.0, 57.0, 58.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 80.0, 71.0, 72.0, 73.0, 82.0, 73.0, 72.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 115.0, 114.0, 110.0, 114.0, 115.0, 113.0, 127.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 159.0, 160.0, 161.0, 167.0, 162.0, 158.0, 157.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1515.4, "alertThreshold": 2.0}]} 05:54:50 INFO - Return code: 0 05:54:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:54:51 ERROR - # TBPL SUCCESS # 05:54:51 INFO - Running post-action listener: _resource_record_post_action 05:54:51 INFO - Running post-run listener: _resource_record_post_run 05:54:52 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 499572736; Read time: 0; Write time: 373416 05:54:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 248225792; Read time: 0; Write time: 239004 05:54:52 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 244842496; Read time: 0; Write time: 133604 05:54:52 INFO - Running post-run listener: _upload_blobber_files 05:54:52 INFO - Blob upload gear active. 05:54:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:54:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:54:52 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:54:52 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:54:52 INFO - (blobuploader) - INFO - Open directory for files ... 05:54:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:54:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:53 INFO - (blobuploader) - INFO - Done attempting. 05:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:54:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:54 INFO - (blobuploader) - INFO - Done attempting. 05:54:54 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:54 INFO - Return code: 0 05:54:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:54:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21f592dbe15f8fc22fbd96ad31513529d2534fee2bfcf8235289b3b94d6ca5e08af82bb449accf7c87094b1ce20a7f37d0ddeed876fcc1206df1a0bf7e766c3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9826f585e2d658948f0eedb0d0ef987cb65b08de534eacf9a23e51fcd71664d6264876ce9f8728e61e948365bb4d1497b448564a897a74a139330d977ecc96"} 05:54:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:54:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:54:54 INFO - Contents: 05:54:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21f592dbe15f8fc22fbd96ad31513529d2534fee2bfcf8235289b3b94d6ca5e08af82bb449accf7c87094b1ce20a7f37d0ddeed876fcc1206df1a0bf7e766c3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9826f585e2d658948f0eedb0d0ef987cb65b08de534eacf9a23e51fcd71664d6264876ce9f8728e61e948365bb4d1497b448564a897a74a139330d977ecc96"} 05:54:54 INFO - Running post-run listener: copy_logs_to_upload_dir 05:54:54 INFO - Copying logs to upload dir... 05:54:54 INFO - mkdir: /builds/slave/test/build/upload/logs 05:54:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.558660 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-05-09 05:54:53.956223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:53.959854) ========= 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=574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157 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-Aurora/sha512/21f592dbe15f8fc22fbd96ad31513529d2534fee2bfcf8235289b3b94d6ca5e08af82bb449accf7c87094b1ce20a7f37d0ddeed876fcc1206df1a0bf7e766c3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9826f585e2d658948f0eedb0d0ef987cb65b08de534eacf9a23e51fcd71664d6264876ce9f8728e61e948365bb4d1497b448564a897a74a139330d977ecc96"} build_url:https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/BP1mL_OYTQCbaWp54eCgfQ/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21f592dbe15f8fc22fbd96ad31513529d2534fee2bfcf8235289b3b94d6ca5e08af82bb449accf7c87094b1ce20a7f37d0ddeed876fcc1206df1a0bf7e766c3e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f9826f585e2d658948f0eedb0d0ef987cb65b08de534eacf9a23e51fcd71664d6264876ce9f8728e61e948365bb4d1497b448564a897a74a139330d977ecc96"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:53.983878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:53.984161) ========= 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=574dc5aafe09851ec43d388c000001b6-1462796018.262353-3500157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:54:54.066363) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:54:54.066684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:54:54.066983) ========= ========= Total master_lag: 0.16 =========