builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-031 starttime: 1467113332.11 results: success (0) buildid: 20160628015111 builduid: e696099f82a842cd89f1f09181473898 revision: fb650a44de9ebb79104dd29b9534827398bf40de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.108472) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.108956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.109245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.124597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.124943) ========= 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=db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 04:28:52-- 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% 10.7M=0.001s 2016-06-28 04:28:52 (10.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126813 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.267554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.267933) ========= 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=db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021490 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:52.320692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 04:28:52.321346) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fb650a44de9ebb79104dd29b9534827398bf40de --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 fb650a44de9ebb79104dd29b9534827398bf40de --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=db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 04:28:52,689 truncating revision to first 12 chars 2016-06-28 04:28:52,689 Setting DEBUG logging. 2016-06-28 04:28:52,689 attempt 1/10 2016-06-28 04:28:52,689 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fb650a44de9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 04:28:53,603 unpacking tar archive at: mozilla-aurora-fb650a44de9e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.300831 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 04:28:53.636671) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:53.636991) ========= script_repo_revision: fb650a44de9ebb79104dd29b9534827398bf40de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:53.637394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:53.637667) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:28:53.647077) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-28 04:28:53.647433) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:28:54 INFO - MultiFileLogger online at 20160628 04:28:54 in /builds/slave/test 04:28:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:28:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:28:54 INFO - {'append_to_log': False, 04:28:54 INFO - 'base_work_dir': '/builds/slave/test', 04:28:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:28:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:28:54 INFO - 'branch': 'Mozilla-Aurora', 04:28:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:28:54 INFO - 'config_files': ('talos/linux_config.py',), 04:28:54 INFO - 'default_actions': ('clobber', 04:28:54 INFO - 'read-buildbot-config', 04:28:54 INFO - 'download-and-extract', 04:28:54 INFO - 'populate-webroot', 04:28:54 INFO - 'create-virtualenv', 04:28:54 INFO - 'install', 04:28:54 INFO - 'run-tests'), 04:28:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:28:54 INFO - 'download_minidump_stackwalk': True, 04:28:54 INFO - 'download_symbols': 'ondemand', 04:28:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:28:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:28:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:28:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:28:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:28:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:28:54 INFO - 'installer_path': 'installer.exe', 04:28:54 INFO - 'log_level': 'info', 04:28:54 INFO - 'log_name': 'talos', 04:28:54 INFO - 'log_to_console': True, 04:28:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:28:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:28:54 INFO - 'opt_config_files': (), 04:28:54 INFO - 'pip_index': False, 04:28:54 INFO - 'sps_profile': False, 04:28:54 INFO - 'sps_profile_interval': 0, 04:28:54 INFO - 'suite': 'dromaeojs-e10s', 04:28:54 INFO - 'system_bits': '32', 04:28:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:28:54 INFO - 'title': 'talos-linux64-ix-031', 04:28:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:28:54 INFO - 'use_talos_json': True, 04:28:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:28:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:28:54 INFO - 'work_dir': 'build'} 04:28:54 INFO - ##### 04:28:54 INFO - ##### Running clobber step. 04:28:54 INFO - ##### 04:28:54 INFO - Running pre-action listener: _resource_record_pre_action 04:28:54 INFO - Running main action method: clobber 04:28:54 INFO - rmtree: /builds/slave/test/build 04:28:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:28:54 INFO - Running post-action listener: _resource_record_post_action 04:28:54 INFO - ##### 04:28:54 INFO - ##### Finished clobber step (success) 04:28:54 INFO - ##### 04:28:54 INFO - ##### 04:28:54 INFO - ##### Running read-buildbot-config step. 04:28:54 INFO - ##### 04:28:54 INFO - Running pre-action listener: _resource_record_pre_action 04:28:54 INFO - Running main action method: read_buildbot_config 04:28:54 INFO - Using buildbot properties: 04:28:54 INFO - { 04:28:54 INFO - "project": "", 04:28:54 INFO - "product": "firefox", 04:28:54 INFO - "script_repo_revision": "production", 04:28:54 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:28:54 INFO - "repository": "", 04:28:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:28:54 INFO - "buildid": "20160628015111", 04:28:54 INFO - "pgo_build": "True", 04:28:54 INFO - "basedir": "/builds/slave/test", 04:28:54 INFO - "buildnumber": 422, 04:28:54 INFO - "slavename": "talos-linux64-ix-031", 04:28:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:28:54 INFO - "platform": "ubuntu64_hw", 04:28:54 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:28:54 INFO - "branch": "mozilla-aurora", 04:28:54 INFO - "repo_path": "releases/mozilla-aurora", 04:28:54 INFO - "revision": "fb650a44de9ebb79104dd29b9534827398bf40de", 04:28:54 INFO - "stage_platform": "linux64-pgo", 04:28:54 INFO - "builduid": "e696099f82a842cd89f1f09181473898", 04:28:54 INFO - "slavebuilddir": "test" 04:28:54 INFO - } 04:28:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 04:28:54 INFO - Running post-action listener: _resource_record_post_action 04:28:54 INFO - ##### 04:28:54 INFO - ##### Finished read-buildbot-config step (success) 04:28:54 INFO - ##### 04:28:54 INFO - ##### 04:28:54 INFO - ##### Running download-and-extract step. 04:28:54 INFO - ##### 04:28:54 INFO - Running pre-action listener: _resource_record_pre_action 04:28:54 INFO - Running main action method: download_and_extract 04:28:54 INFO - mkdir: /builds/slave/test/build/tests 04:28:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:54 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:28:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:28:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:28:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:28:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:28:55 INFO - Downloaded 1361 bytes. 04:28:55 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 04:28:55 INFO - Using the following test package requirements: 04:28:55 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:28:55 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:28:55 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:28:55 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'jsshell-linux-x86_64.zip'], 04:28:55 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:28:55 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 04:28:55 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:28:55 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:28:55 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:28:55 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 04:28:55 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:28:55 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:55 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:28:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:28:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:28:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:28:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:28:56 INFO - Downloaded 24422297 bytes. 04:28:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:28:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:28:57 INFO - Return code: 0 04:28:57 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:57 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:28:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:28:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:28:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 04:28:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:28:59 INFO - Downloaded 24422297 bytes. 04:28:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:28:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:29:00 INFO - Return code: 0 04:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:00 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:29:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:29:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:29:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 04:29:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:29:02 INFO - Downloaded 10833369 bytes. 04:29:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:29:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:29:02 INFO - Return code: 0 04:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:02 INFO - https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:29:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:29:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:29:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:29:04 INFO - Downloaded 62813800 bytes. 04:29:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:29:04 INFO - mkdir: /builds/slave/test/properties 04:29:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:29:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:29:04 INFO - Contents: 04:29:04 INFO - build_url:https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 04:29:05 INFO - Running post-action listener: _resource_record_post_action 04:29:05 INFO - Running post-action listener: set_extra_try_arguments 04:29:05 INFO - ##### 04:29:05 INFO - ##### Finished download-and-extract step (success) 04:29:05 INFO - ##### 04:29:05 INFO - ##### 04:29:05 INFO - ##### Running populate-webroot step. 04:29:05 INFO - ##### 04:29:05 INFO - Running pre-action listener: _resource_record_pre_action 04:29:05 INFO - Running main action method: populate_webroot 04:29:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:05 INFO - '--tppagecycles', 04:29:05 INFO - '7'], 04:29:05 INFO - 'tests': ['tsvgm']}}, 04:29:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:29:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:29:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:29:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['damp', 'tps']}, 04:29:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'tests': ['damp', 'tps']}, 04:29:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['dromaeo_dom']}, 04:29:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['a11yr', 04:29:05 INFO - 'ts_paint', 04:29:05 INFO - 'tpaint', 04:29:05 INFO - 'sessionrestore', 04:29:05 INFO - 'sessionrestore_no_auto_restore', 04:29:05 INFO - 'tabpaint']}, 04:29:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:29:05 INFO - 'ts_paint', 04:29:05 INFO - 'tpaint', 04:29:05 INFO - 'sessionrestore', 04:29:05 INFO - 'sessionrestore_no_auto_restore', 04:29:05 INFO - 'tabpaint']}, 04:29:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:29:05 INFO - 'ts_paint', 04:29:05 INFO - 'tpaint', 04:29:05 INFO - 'sessionrestore', 04:29:05 INFO - 'sessionrestore_no_auto_restore', 04:29:05 INFO - 'tabpaint']}, 04:29:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:29:05 INFO - 'ts_paint', 04:29:05 INFO - 'tpaint', 04:29:05 INFO - 'sessionrestore', 04:29:05 INFO - 'sessionrestore_no_auto_restore', 04:29:05 INFO - 'tabpaint']}, 04:29:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['a11yr', 04:29:05 INFO - 'ts_paint', 04:29:05 INFO - 'tpaint', 04:29:05 INFO - 'sessionrestore', 04:29:05 INFO - 'sessionrestore_no_auto_restore', 04:29:05 INFO - 'tabpaint']}, 04:29:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['a11yr', 04:29:05 INFO - 'ts_paint', 04:29:05 INFO - 'tpaint', 04:29:05 INFO - 'sessionrestore', 04:29:05 INFO - 'sessionrestore_no_auto_restore', 04:29:05 INFO - 'tabpaint']}, 04:29:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['tsvgx', 04:29:05 INFO - 'tsvgr_opacity', 04:29:05 INFO - 'tart', 04:29:05 INFO - 'tscrollx', 04:29:05 INFO - 'cart']}, 04:29:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:29:05 INFO - 'tsvgr_opacity', 04:29:05 INFO - 'tart', 04:29:05 INFO - 'tscrollx', 04:29:05 INFO - 'cart']}, 04:29:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'talos_options': ['--disable-e10s'], 04:29:05 INFO - 'tests': ['tp5o']}, 04:29:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'tests': ['tp5o']}, 04:29:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'talos_options': ['--disable-e10s', 04:29:05 INFO - '--xperf_path', 04:29:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:05 INFO - 'tests': ['tp5n']}, 04:29:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:05 INFO - 'talos_options': ['--xperf_path', 04:29:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:05 INFO - 'tests': ['tp5n']}}, 04:29:05 INFO - 'talos.zip': {'path': '', 04:29:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:05 INFO - Running post-action listener: _resource_record_post_action 04:29:05 INFO - ##### 04:29:05 INFO - ##### Finished populate-webroot step (success) 04:29:05 INFO - ##### 04:29:05 INFO - ##### 04:29:05 INFO - ##### Running create-virtualenv step. 04:29:05 INFO - ##### 04:29:05 INFO - Running pre-action listener: _resource_record_pre_action 04:29:05 INFO - Running main action method: create_virtualenv 04:29:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:29:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:05 INFO - Using real prefix '/usr' 04:29:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:08 INFO - Installing pip.................done. 04:29:08 INFO - Return code: 0 04:29:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:08 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 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:29:08 INFO - Using env: {'DISPLAY': ':0', 04:29:08 INFO - 'HOME': '/home/cltbld', 04:29:08 INFO - 'LANG': 'en_US.UTF-8', 04:29:08 INFO - 'LANGUAGE': 'en_US:en', 04:29:08 INFO - 'LOGNAME': 'cltbld', 04:29:08 INFO - 'MAIL': '/var/mail/cltbld', 04:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:08 INFO - 'MOZ_NO_REMOTE': '1', 04:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:08 INFO - 'NO_EM_RESTART': '1', 04:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:08 INFO - 'PWD': '/builds/slave/test', 04:29:08 INFO - 'SHELL': '/bin/bash', 04:29:08 INFO - 'SHLVL': '1', 04:29:08 INFO - 'TERM': 'linux', 04:29:08 INFO - 'TMOUT': '86400', 04:29:08 INFO - 'USER': 'cltbld', 04:29:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:08 INFO - '_': '/tools/buildbot/bin/python'} 04:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:29:08 INFO - Cleaning up... 04:29:08 INFO - Return code: 0 04:29:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:08 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:08 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>=3.1.1'] in /builds/slave/test/build 04:29:08 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>=3.1.1 04:29:08 INFO - Using env: {'DISPLAY': ':0', 04:29:08 INFO - 'HOME': '/home/cltbld', 04:29:08 INFO - 'LANG': 'en_US.UTF-8', 04:29:08 INFO - 'LANGUAGE': 'en_US:en', 04:29:08 INFO - 'LOGNAME': 'cltbld', 04:29:08 INFO - 'MAIL': '/var/mail/cltbld', 04:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:08 INFO - 'MOZ_NO_REMOTE': '1', 04:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:08 INFO - 'NO_EM_RESTART': '1', 04:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:08 INFO - 'PWD': '/builds/slave/test', 04:29:08 INFO - 'SHELL': '/bin/bash', 04:29:08 INFO - 'SHLVL': '1', 04:29:08 INFO - 'TERM': 'linux', 04:29:08 INFO - 'TMOUT': '86400', 04:29:08 INFO - 'USER': 'cltbld', 04:29:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:08 INFO - '_': '/tools/buildbot/bin/python'} 04:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:08 INFO - Downloading/unpacking psutil>=3.1.1 04:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:10 INFO - Installing collected packages: psutil 04:29:10 INFO - Running setup.py install for psutil 04:29:10 INFO - building 'psutil._psutil_linux' extension 04:29:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:29:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:29:10 INFO - building 'psutil._psutil_posix' extension 04:29:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:29:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:29:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:11 INFO - Successfully installed psutil 04:29:11 INFO - Cleaning up... 04:29:11 INFO - Return code: 0 04:29:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:29:11 INFO - Using env: {'DISPLAY': ':0', 04:29:11 INFO - 'HOME': '/home/cltbld', 04:29:11 INFO - 'LANG': 'en_US.UTF-8', 04:29:11 INFO - 'LANGUAGE': 'en_US:en', 04:29:11 INFO - 'LOGNAME': 'cltbld', 04:29:11 INFO - 'MAIL': '/var/mail/cltbld', 04:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:11 INFO - 'MOZ_NO_REMOTE': '1', 04:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:11 INFO - 'NO_EM_RESTART': '1', 04:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:11 INFO - 'PWD': '/builds/slave/test', 04:29:11 INFO - 'SHELL': '/bin/bash', 04:29:11 INFO - 'SHLVL': '1', 04:29:11 INFO - 'TERM': 'linux', 04:29:11 INFO - 'TMOUT': '86400', 04:29:11 INFO - 'USER': 'cltbld', 04:29:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:11 INFO - '_': '/tools/buildbot/bin/python'} 04:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:29:13 INFO - Installing collected packages: mozsystemmonitor 04:29:13 INFO - Running setup.py install for mozsystemmonitor 04:29:13 INFO - Successfully installed mozsystemmonitor 04:29:13 INFO - Cleaning up... 04:29:13 INFO - Return code: 0 04:29:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:13 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:13 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==2.5.1'] in /builds/slave/test/build 04:29:13 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==2.5.1 04:29:13 INFO - Using env: {'DISPLAY': ':0', 04:29:13 INFO - 'HOME': '/home/cltbld', 04:29:13 INFO - 'LANG': 'en_US.UTF-8', 04:29:13 INFO - 'LANGUAGE': 'en_US:en', 04:29:13 INFO - 'LOGNAME': 'cltbld', 04:29:13 INFO - 'MAIL': '/var/mail/cltbld', 04:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:13 INFO - 'MOZ_NO_REMOTE': '1', 04:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:13 INFO - 'NO_EM_RESTART': '1', 04:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:13 INFO - 'PWD': '/builds/slave/test', 04:29:13 INFO - 'SHELL': '/bin/bash', 04:29:13 INFO - 'SHLVL': '1', 04:29:13 INFO - 'TERM': 'linux', 04:29:13 INFO - 'TMOUT': '86400', 04:29:13 INFO - 'USER': 'cltbld', 04:29:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:13 INFO - '_': '/tools/buildbot/bin/python'} 04:29:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:13 INFO - Downloading/unpacking jsonschema==2.5.1 04:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:15 INFO - warning: no files found matching '*.txt' 04:29:15 INFO - no previously-included directories found matching 'build' 04:29:15 INFO - no previously-included directories found matching 'dist' 04:29:15 INFO - no previously-included directories found matching '.git*' 04:29:15 INFO - Installing collected packages: jsonschema, functools32 04:29:15 INFO - Running setup.py install for functools32 04:29:15 INFO - warning: no files found matching '*.txt' 04:29:15 INFO - no previously-included directories found matching 'build' 04:29:15 INFO - no previously-included directories found matching 'dist' 04:29:15 INFO - no previously-included directories found matching '.git*' 04:29:15 INFO - Successfully installed jsonschema functools32 04:29:15 INFO - Cleaning up... 04:29:16 INFO - Return code: 0 04:29:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:16 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 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:29:16 INFO - Using env: {'DISPLAY': ':0', 04:29:16 INFO - 'HOME': '/home/cltbld', 04:29:16 INFO - 'LANG': 'en_US.UTF-8', 04:29:16 INFO - 'LANGUAGE': 'en_US:en', 04:29:16 INFO - 'LOGNAME': 'cltbld', 04:29:16 INFO - 'MAIL': '/var/mail/cltbld', 04:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:16 INFO - 'MOZ_NO_REMOTE': '1', 04:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:16 INFO - 'NO_EM_RESTART': '1', 04:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:16 INFO - 'PWD': '/builds/slave/test', 04:29:16 INFO - 'SHELL': '/bin/bash', 04:29:16 INFO - 'SHLVL': '1', 04:29:16 INFO - 'TERM': 'linux', 04:29:16 INFO - 'TMOUT': '86400', 04:29:16 INFO - 'USER': 'cltbld', 04:29:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:16 INFO - '_': '/tools/buildbot/bin/python'} 04:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:18 INFO - Downloading docopt-0.6.1.tar.gz 04:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:18 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:18 INFO - Running setup.py install for blobuploader 04:29:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:19 INFO - Running setup.py install for requests 04:29:19 INFO - Running setup.py install for docopt 04:29:19 INFO - Successfully installed blobuploader requests docopt 04:29:19 INFO - Cleaning up... 04:29:19 INFO - Return code: 0 04:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:19 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 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:19 INFO - Using env: {'DISPLAY': ':0', 04:29:19 INFO - 'HOME': '/home/cltbld', 04:29:19 INFO - 'LANG': 'en_US.UTF-8', 04:29:19 INFO - 'LANGUAGE': 'en_US:en', 04:29:19 INFO - 'LOGNAME': 'cltbld', 04:29:19 INFO - 'MAIL': '/var/mail/cltbld', 04:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:19 INFO - 'MOZ_NO_REMOTE': '1', 04:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:19 INFO - 'NO_EM_RESTART': '1', 04:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:19 INFO - 'PWD': '/builds/slave/test', 04:29:19 INFO - 'SHELL': '/bin/bash', 04:29:19 INFO - 'SHLVL': '1', 04:29:19 INFO - 'TERM': 'linux', 04:29:19 INFO - 'TMOUT': '86400', 04:29:19 INFO - 'USER': 'cltbld', 04:29:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:19 INFO - '_': '/tools/buildbot/bin/python'} 04:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:19 INFO - Running setup.py (path:/tmp/pip-znQLp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:19 INFO - Running setup.py (path:/tmp/pip-n538QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:19 INFO - Running setup.py (path:/tmp/pip-TdzH8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:19 INFO - Running setup.py (path:/tmp/pip-Zn32Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:20 INFO - Running setup.py (path:/tmp/pip-S12U5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:20 INFO - Running setup.py (path:/tmp/pip-kJm1f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:20 INFO - Running setup.py (path:/tmp/pip-Q3KBTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:20 INFO - Running setup.py (path:/tmp/pip-L3kZ41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:20 INFO - Running setup.py (path:/tmp/pip-_2Y_w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:20 INFO - Running setup.py (path:/tmp/pip-OFBhu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:20 INFO - Running setup.py (path:/tmp/pip-1nSWNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:20 INFO - Running setup.py (path:/tmp/pip-zth8t0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:20 INFO - Running setup.py (path:/tmp/pip-daWZcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:20 INFO - Running setup.py (path:/tmp/pip-VJJWMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:20 INFO - Running setup.py (path:/tmp/pip-YH1emI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:20 INFO - Running setup.py (path:/tmp/pip-H_LY1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:20 INFO - Running setup.py (path:/tmp/pip-cq6SHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:29:20 INFO - Running setup.py install for manifestparser 04:29:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Running setup.py install for mozcrash 04:29:21 INFO - Running setup.py install for mozdebug 04:29:21 INFO - Running setup.py install for mozdevice 04:29:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Running setup.py install for mozfile 04:29:21 INFO - Running setup.py install for mozhttpd 04:29:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Running setup.py install for mozinfo 04:29:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Running setup.py install for mozInstall 04:29:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:29:21 INFO - Running setup.py install for mozleak 04:29:21 INFO - Running setup.py install for mozlog 04:29:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:29:22 INFO - Running setup.py install for moznetwork 04:29:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:29:22 INFO - Running setup.py install for mozprocess 04:29:22 INFO - Running setup.py install for mozprofile 04:29:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:29:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:29:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:29:22 INFO - Running setup.py install for mozrunner 04:29:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:29:22 INFO - Running setup.py install for mozscreenshot 04:29:22 INFO - Running setup.py install for moztest 04:29:22 INFO - Running setup.py install for mozversion 04:29:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:29:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:29:22 INFO - Cleaning up... 04:29:22 INFO - Return code: 0 04:29:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:22 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 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:29:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:22 INFO - Using env: {'DISPLAY': ':0', 04:29:22 INFO - 'HOME': '/home/cltbld', 04:29:22 INFO - 'LANG': 'en_US.UTF-8', 04:29:22 INFO - 'LANGUAGE': 'en_US:en', 04:29:22 INFO - 'LOGNAME': 'cltbld', 04:29:22 INFO - 'MAIL': '/var/mail/cltbld', 04:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:22 INFO - 'MOZ_NO_REMOTE': '1', 04:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:22 INFO - 'NO_EM_RESTART': '1', 04:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:22 INFO - 'PWD': '/builds/slave/test', 04:29:22 INFO - 'SHELL': '/bin/bash', 04:29:22 INFO - 'SHLVL': '1', 04:29:22 INFO - 'TERM': 'linux', 04:29:22 INFO - 'TMOUT': '86400', 04:29:22 INFO - 'USER': 'cltbld', 04:29:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:22 INFO - '_': '/tools/buildbot/bin/python'} 04:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:22 INFO - Running setup.py (path:/tmp/pip-UAPsCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:23 INFO - Running setup.py (path:/tmp/pip-JOwgV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:23 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)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:23 INFO - Running setup.py (path:/tmp/pip-7MpoYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:23 INFO - Running setup.py (path:/tmp/pip-CGjjr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:23 INFO - Running setup.py (path:/tmp/pip-3OpK0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:23 INFO - Running setup.py (path:/tmp/pip-OnOENI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:23 INFO - Running setup.py (path:/tmp/pip-I8lpYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:23 INFO - Running setup.py (path:/tmp/pip-BBxAAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:23 INFO - Running setup.py (path:/tmp/pip-LF3csl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:23 INFO - Running setup.py (path:/tmp/pip-rJxZbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:23 INFO - Running setup.py (path:/tmp/pip-o99nwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:23 INFO - Running setup.py (path:/tmp/pip-Pn3Jyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:23 INFO - Running setup.py (path:/tmp/pip-pyPvmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:23 INFO - Running setup.py (path:/tmp/pip-dlLziu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:24 INFO - Running setup.py (path:/tmp/pip-V5BFjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:24 INFO - Running setup.py (path:/tmp/pip-1c9xvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:29:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:24 INFO - Running setup.py (path:/tmp/pip-0HQAVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:29:24 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)) 04:29:24 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)) 04:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:26 INFO - Downloading blessings-1.6.tar.gz 04:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:29:26 INFO - Installing collected packages: blessings 04:29:26 INFO - Running setup.py install for blessings 04:29:26 INFO - Successfully installed blessings 04:29:26 INFO - Cleaning up... 04:29:26 INFO - Return code: 0 04:29:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:29:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:26 INFO - Reading from file tmpfile_stdout 04:29:26 INFO - Current package versions: 04:29:26 INFO - argparse == 1.2.1 04:29:26 INFO - blessings == 1.6 04:29:26 INFO - blobuploader == 1.2.4 04:29:26 INFO - docopt == 0.6.1 04:29:26 INFO - functools32 == 3.2.3-2 04:29:26 INFO - jsonschema == 2.5.1 04:29:26 INFO - manifestparser == 1.1 04:29:26 INFO - mozInstall == 1.12 04:29:26 INFO - mozcrash == 0.17 04:29:26 INFO - mozdebug == 0.1 04:29:26 INFO - mozdevice == 0.48 04:29:26 INFO - mozfile == 1.2 04:29:26 INFO - mozhttpd == 0.7 04:29:26 INFO - mozinfo == 0.9 04:29:26 INFO - mozleak == 0.1 04:29:26 INFO - mozlog == 3.2 04:29:26 INFO - moznetwork == 0.27 04:29:26 INFO - mozprocess == 0.22 04:29:26 INFO - mozprofile == 0.28 04:29:26 INFO - mozrunner == 6.11 04:29:26 INFO - mozscreenshot == 0.1 04:29:26 INFO - mozsystemmonitor == 0.3 04:29:26 INFO - moztest == 0.7 04:29:26 INFO - mozversion == 1.4 04:29:26 INFO - psutil == 3.1.1 04:29:26 INFO - requests == 1.2.3 04:29:26 INFO - wsgiref == 0.1.2 04:29:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:26 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 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:29:26 INFO - Using env: {'DISPLAY': ':0', 04:29:26 INFO - 'HOME': '/home/cltbld', 04:29:26 INFO - 'LANG': 'en_US.UTF-8', 04:29:26 INFO - 'LANGUAGE': 'en_US:en', 04:29:26 INFO - 'LOGNAME': 'cltbld', 04:29:26 INFO - 'MAIL': '/var/mail/cltbld', 04:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:26 INFO - 'MOZ_NO_REMOTE': '1', 04:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:26 INFO - 'NO_EM_RESTART': '1', 04:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:26 INFO - 'PWD': '/builds/slave/test', 04:29:26 INFO - 'SHELL': '/bin/bash', 04:29:26 INFO - 'SHLVL': '1', 04:29:26 INFO - 'TERM': 'linux', 04:29:26 INFO - 'TMOUT': '86400', 04:29:26 INFO - 'USER': 'cltbld', 04:29:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:26 INFO - '_': '/tools/buildbot/bin/python'} 04:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:29:26 INFO - Cleaning up... 04:29:26 INFO - Return code: 0 04:29:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:26 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 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:29:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:29:26 INFO - Using env: {'DISPLAY': ':0', 04:29:26 INFO - 'HOME': '/home/cltbld', 04:29:26 INFO - 'LANG': 'en_US.UTF-8', 04:29:26 INFO - 'LANGUAGE': 'en_US:en', 04:29:26 INFO - 'LOGNAME': 'cltbld', 04:29:26 INFO - 'MAIL': '/var/mail/cltbld', 04:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:26 INFO - 'MOZ_NO_REMOTE': '1', 04:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:26 INFO - 'NO_EM_RESTART': '1', 04:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:26 INFO - 'PWD': '/builds/slave/test', 04:29:26 INFO - 'SHELL': '/bin/bash', 04:29:26 INFO - 'SHLVL': '1', 04:29:26 INFO - 'TERM': 'linux', 04:29:26 INFO - 'TMOUT': '86400', 04:29:26 INFO - 'USER': 'cltbld', 04:29:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:26 INFO - '_': '/tools/buildbot/bin/python'} 04:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:29:27 INFO - Cleaning up... 04:29:27 INFO - Return code: 0 04:29:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb3deff2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, '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': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:29:27 INFO - Using env: {'DISPLAY': ':0', 04:29:27 INFO - 'HOME': '/home/cltbld', 04:29:27 INFO - 'LANG': 'en_US.UTF-8', 04:29:27 INFO - 'LANGUAGE': 'en_US:en', 04:29:27 INFO - 'LOGNAME': 'cltbld', 04:29:27 INFO - 'MAIL': '/var/mail/cltbld', 04:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:27 INFO - 'MOZ_NO_REMOTE': '1', 04:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:27 INFO - 'NO_EM_RESTART': '1', 04:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:27 INFO - 'PWD': '/builds/slave/test', 04:29:27 INFO - 'SHELL': '/bin/bash', 04:29:27 INFO - 'SHLVL': '1', 04:29:27 INFO - 'TERM': 'linux', 04:29:27 INFO - 'TMOUT': '86400', 04:29:27 INFO - 'USER': 'cltbld', 04:29:27 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:27 INFO - '_': '/tools/buildbot/bin/python'} 04:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:27 INFO - Downloading/unpacking flake8 04:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:29:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:29:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:29 INFO - no previously-included directories found matching 'docs/_build' 04:29:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:29:29 INFO - Running setup.py install for pep8 04:29:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:29:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:29:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:29:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:29:30 INFO - no previously-included directories found matching 'docs/_build' 04:29:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:29:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:29:30 INFO - Cleaning up... 04:29:30 INFO - Return code: 0 04:29:30 INFO - Running post-action listener: _resource_record_post_action 04:29:30 INFO - Running post-action listener: _start_resource_monitoring 04:29:30 INFO - Starting resource monitoring. 04:29:30 INFO - ##### 04:29:30 INFO - ##### Finished create-virtualenv step (success) 04:29:30 INFO - ##### 04:29:30 INFO - ##### 04:29:30 INFO - ##### Running install step. 04:29:30 INFO - ##### 04:29:30 INFO - Running pre-action listener: _resource_record_pre_action 04:29:30 INFO - Running main action method: install 04:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:30 INFO - Reading from file tmpfile_stdout 04:29:30 INFO - Detecting whether we're running mozinstall >=1.0... 04:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:29:30 INFO - Reading from file tmpfile_stdout 04:29:30 INFO - Output received: 04:29:30 INFO - Usage: mozinstall [options] installer 04:29:30 INFO - Options: 04:29:30 INFO - -h, --help show this help message and exit 04:29:30 INFO - -d DEST, --destination=DEST 04:29:30 INFO - Directory to install application into. [default: 04:29:30 INFO - "/builds/slave/test"] 04:29:30 INFO - --app=APP Application being installed. [default: firefox] 04:29:30 INFO - mkdir: /builds/slave/test/build/application 04:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:29:46 INFO - Reading from file tmpfile_stdout 04:29:46 INFO - Output received: 04:29:46 INFO - /builds/slave/test/build/application/firefox/firefox 04:29:46 INFO - Running post-action listener: _resource_record_post_action 04:29:46 INFO - ##### 04:29:46 INFO - ##### Finished install step (success) 04:29:46 INFO - ##### 04:29:46 INFO - ##### 04:29:46 INFO - ##### Running run-tests step. 04:29:46 INFO - ##### 04:29:46 INFO - Running pre-action listener: _resource_record_pre_action 04:29:46 INFO - Running main action method: run_tests 04:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:29:46 INFO - Python 2.7.3 04:29:46 INFO - Return code: 0 04:29:46 INFO - grabbing minidump binary from tooltool 04:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:46 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17702e0>, '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 0x16dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16dc5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:29:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:29:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:29:46 INFO - Calling ['/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'] with output_timeout 600 04:29:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:29:46 INFO - Return code: 0 04:29:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:29:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:29:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:29:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:29:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:29:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:29:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:29:47 INFO - Return code: 0 04:29:47 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:29:47 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:29:47 INFO - Using env: {'DISPLAY': ':0', 04:29:47 INFO - 'HOME': '/home/cltbld', 04:29:47 INFO - 'LANG': 'en_US.UTF-8', 04:29:47 INFO - 'LANGUAGE': 'en_US:en', 04:29:47 INFO - 'LOGNAME': 'cltbld', 04:29:47 INFO - 'MAIL': '/var/mail/cltbld', 04:29:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:29:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:29:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:47 INFO - 'MOZ_NO_REMOTE': '1', 04:29:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:29:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:47 INFO - 'NO_EM_RESTART': '1', 04:29:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:47 INFO - 'PWD': '/builds/slave/test', 04:29:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:29:47 INFO - 'SHELL': '/bin/bash', 04:29:47 INFO - 'SHLVL': '1', 04:29:47 INFO - 'TERM': 'linux', 04:29:47 INFO - 'TMOUT': '86400', 04:29:47 INFO - 'USER': 'cltbld', 04:29:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055', 04:29:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:47 INFO - '_': '/tools/buildbot/bin/python'} 04:29:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:29:47 INFO - mozversion application_buildid: 20160628015111 04:29:47 INFO - mozversion application_changeset: fb650a44de9ebb79104dd29b9534827398bf40de 04:29:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:29:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:29:47 INFO - mozversion application_name: Firefox 04:29:47 INFO - mozversion application_remotingname: firefox-dev 04:29:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:29:47 INFO - mozversion application_vendor: Mozilla 04:29:47 INFO - mozversion application_version: 49.0a2 04:29:47 INFO - mozversion platform_buildid: 20160628015111 04:29:47 INFO - mozversion platform_changeset: fb650a44de9ebb79104dd29b9534827398bf40de 04:29:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:29:47 INFO - mozversion platform_version: 49.0a2 04:29:47 INFO - using testdate: 1467113387 04:29:47 INFO - actual date: 1467113387 04:29:47 INFO - starting webserver on 'localhost:47000' 04:29:47 INFO - SUITE-START | Running 2 tests 04:29:47 INFO - TEST-START | dromaeo_css 04:29:47 INFO - operating with platform_type : linux_ 04:29:47 INFO - Initialising browser for dromaeo_css test... 04:29:47 INFO - TEST-INFO | started process 874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp998QyR/profile http://localhost:47000/getInfo.html) 04:29:51 INFO - PROCESS | 874 | __metrics Screen width/height:1600/1200 04:29:51 INFO - PROCESS | 874 | colorDepth:24 04:29:51 INFO - PROCESS | 874 | Browser inner width/height: 1024/697 04:29:51 INFO - PROCESS | 874 | __metrics 04:29:52 ERROR - PROCESS | 874 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:29:53 INFO - TEST-INFO | 874: exit 0 04:29:53 INFO - Browser initialized. 04:29:53 INFO - Running cycle 1/1 for dromaeo_css test... 04:29:53 INFO - TEST-INFO | started process 1002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp998QyR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:05 INFO - PROCESS | 1002 | RSS: Main: 156872704 04:30:05 INFO - PROCESS | 1002 | 04:30:54 INFO - PROCESS | 1002 | 1467113454662 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:33:01 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47000/tests/dromaeo/cssquery-ext.html) 04:33:02 INFO - PROCESS | 1002 | RSS: Main: 160378880 04:33:02 INFO - PROCESS | 1002 | 04:36:04 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-ext.html (next: http://localhost:47000/tests/dromaeo/cssquery-jquery.html) 04:36:05 INFO - PROCESS | 1002 | RSS: Main: 158121984 04:36:05 INFO - PROCESS | 1002 | 04:39:07 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47000/tests/dromaeo/cssquery-mootools.html) 04:39:07 INFO - PROCESS | 1002 | RSS: Main: 157224960 04:39:07 INFO - PROCESS | 1002 | 04:42:09 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47000/tests/dromaeo/cssquery-prototype.html) 04:42:10 INFO - PROCESS | 1002 | RSS: Main: 157413376 04:42:10 INFO - PROCESS | 1002 | 04:45:12 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47000/tests/dromaeo/cssquery-yui.html) 04:45:13 INFO - PROCESS | 1002 | RSS: Main: 159207424 04:45:13 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | Cycle 1(1): loaded http://localhost:47000/tests/dromaeo/cssquery-yui.html (next: http://localhost:47000/tests/dromaeo/cssquery-dojo.html) 04:48:15 INFO - PROCESS | 1002 | RSS: Main: 159510528 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | __start_tp_report 04:48:15 INFO - PROCESS | 1002 | _x_x_mozilla_page_load 04:48:15 INFO - PROCESS | 1002 | _x_x_mozilla_page_load_details 04:48:15 INFO - PROCESS | 1002 | |i|pagename|runs| 04:48:15 INFO - PROCESS | 1002 | |0;dojo.html;3216.5979252593424;3248.3665685191395;3261.5107733839923;3270.0516850113468;3274.1814546363426;5079.4412614612365;5083.18669012958;5091.083604951112;5095.7197354145555;5168.043911876305;5150.922736158961;5167.199084141955;5169.767360468779;5170;5180.6891586504835;4632.4441067072;4737.928931066037;4740.620750339982;4775.689580177294;4776.283557466373;4612.723236605798;4618.399608050949;4731.858044258678;4754.762261886909;4781.211100168468;4704.553067458603;4708.034852855157;4720.787564559603;4734.834280800173;4757.548032936866;4713.410823647044;4778.641601879838;4778.928316075262;4780.952190478086;4815.085133824562;4565.0641618468135;4682.859514214579;4709.081729062834;4715.64632652549;4778.546038126373;4988.900221995576;5022.773975171126;5069.340985671839;5085.1355269604255;5101.081805275049;5544.889102217973;5564.415736347706;5568.554515638739;5569.526590239834;5577.442255774431;5309.920351194735;5311.362636483608;5588.804391846266;5611.831645050655;5624.690642014688;5126.6667666601925;5170.069387510247;5175.482451754794;5185.325907632021;5236;5595.888082238333;5601.327840659065;5631.070873305941;5634.23937768396;5657.688827114466;5311.309529761106;5359.196120581944;5367.463253674601;5443.673379597237;5456.372517160498;5533.363663178706;5554.333479982428;5560.304961879765;5560.499555039985;5562.082256427725;5506.063969125258;5508.531774799107;5510.614257002052;5515.61390702647;5532.917006244909;5283.286756287852;5444.945550544444;5504.779808807683;5516.365617953907;5532.6680399176175;4304.763238021939;4315.0722594641675;4320.589543993316;4321.178975994551;4333.804978775963;3889.4554762333296;3912.3349030664854;3919.7452165609143;3924.5879182685976;3931.233409485123;5079.9238011429115;5179.818706345335;5271.736413179326;5292.497212764782;5297.099493086108;5309.867253318698;5361.678299302054;5376.946230537723;5387.353517577916;5388.865278368072;5235.267062611238;5246.31797866275;5253.44838791929;5259.789608415621;5289.074411977888;4563.498015218323;4669.766511674471;4682.85951421451;4704.129735998851;4734.19518681825;5614.775408983676;5681.630694004876;5688.203651488795;5692.032354499662;5699.401562835843;5362.088444964444;5476.91784623231;5478.863028424321;5481.3970463248215;5509.834704958857;5578.358488773681;5587.99416105105;5603;5664.830055098354;5702.657840529581;5364.436734142859;5378.757955891916;5404.59465540094;5406.216098665593;5406.459354064562;5289.862679523921;5436.293281873332;5440.945590544202;5448.618596698351;5486.149646804752;5306.336707911511;5401.1088170453;5410.540104091197;5424.755885985219;5427.972860135674;5348.171033489815;5364.839054828361;5370.382406023357;5371.892562148813;5402.946425447;5166.2508936203285;5264.10510213257;5305.973470132624;5314.760835762478;5331.1470164773455;5404.270423492778;5412.539934105645;5438.728063596884;5458.836234912959;5489.478499542537;5321.281626980308;5334.359876814807;5335.866603334947;5349.545288650508;5375.354957405137 04:48:15 INFO - PROCESS | 1002 | |1;ext.html;603.3574243430746;651.7197605029837;656;662.9602223866568;668.8561959178777;45910;47644.52355476444;47734.52265477353;47794.2830857537;50497.495025049735;47866.0426791464;48241.27638085432;48405;48494;48541;9152.947411047748;9231.538423078819;9282.489463079528;9348.158665720084;9367.578458969328;9141.72574822753;9172.724818255463;9192.218661413788;9213.677521286756;9251.213646840026;9246.815063698721;9262.536873156316;9299.535023248844;9339.719808405758;9340.953295233514;9180.908190918071;9241.537923103851;9247.537623118817;9262.305327100426;9264.675736349229;9042.773930651721;9121.635134594675;9176.632934682604;9196;9201.171894529525;44925.32612010823;45310.77344613256;45323.320150197775;45673.54326456759;45725.31412028789;3649.6897763690117;3833.8658146965;3835.712321575865;3890.1441682830014;4010.4184893190322;34884.6511534884;35383.4692479613;35485;35702.64297357045;35727.4640880387;4377.146456440995;4457.465104187519;4490.236659767847;4569.794359253809;4575.748333841638;371830;372095;373284.99999999726;373328;373880;38188;66298.33701663018;66527.66736166288;66661.66669166624;66783.66608167025;39584.802075989435;41133.794331028155;41323;41488.1702365951;41508;16951.067691277098;17162.914185428992;17181.398651047402;17283.567910802332;17318.913405433144;14358;14419.279036048365;14488.058276212012;14498.202598857164;14534.127952322682;9268.165865072042;9322.207612353026;9355.719328420158;9361.297902657192;9387.436753794795;3506.1760486285702;3547.2018795770746;3559.288142371536;3617.511635929116;3622.166901612644;1087.5649740104022;1144.513581727779;1179.9646010619695;1200.5197920831738;1202.5971299614553;33699.32601348008;34140.829295853364;34172.48741268883;34285.314293713986;34859.65140348615;1204.6626944455566;1213.9393030348447;1216.3492531495608;1222.3949145173196;1252.7619752247044;17228.022903334346;17277.65444691099;17513.299468021138;17687.38094166698;17842.840215385957;164711;167785;582495;614194;628787;56789.43210567842;61923.6903815487;62011.37988620147;62014;62383.6880815593;1443.1557538839686;1445.1184777285848;1450.833154187282;1451.8602896726231;1460.547230358571;31684.841575791972;32245.193870152496;32388.83805580957;32948.1762955928;33110.33779324352;51734;52278.693032674484;52319.215211772615;52558.211626824865;52692.7365363186;436942;437782;438707;440994;442092;30072.84963575256;30730.846345769023;30986;31039.379212415173;31146.377072458876;47561;48380.516194837604;49396.75301623469;49510.257346140555;50218;40913.59086409217;41609.58390416057;41685;41703.374449382674;42421.15157696767;41006.76979690614;41133.1773364537;41346;42066;42624.786876065424;41497.1700565993;42354.152916942105;42629.57370426256;42767;42906.1418771629;35687.16327707136;35864.82067589645;36568.26863462769;36631;37052.62947370492;28368.264591207444;28485.43029139447;28612.856935715186;28670.99651512187;28685.713142868302 04:48:15 INFO - PROCESS | 1002 | |2;jquery.html;427.8694998025601;432.8485030239416;435.29047652326705;436.17918872644566;443.73375974415353;17986.910065449672;19160.233590656375;19600.607987840252;20418.69371959422;20431.38705838827;18252.08739563023;18505.907470462662;18579.349722759707;19162;19430.902845485754;4945.40655121385;5228.241904923784;5243.030039442715;5287.41838397776;5302;5103;5199.714015729133;5244.370675518943;5358.410574836765;5361.329833770778;5322.680639161644;5327.760250788704;5339.70631615261;5361.544268737162;5377.946220537784;5323.920141197885;5346.6524675896135;7351.485396022281;7764;7773.455858089936;7246.565206087599;7536.585487798169;7578.0906291244855;7611.65747541362;7636.236376362375;25256.621150682753;25761.61357579638;25900.481990360277;26251.212463625932;27291.727082729118;2534.0750626021554;2579.9613005804927;2598.2075466982565;2736.7400096990755;2799.9720002799913;15862.682746345008;16640.750388744178;16713.49859504217;16746.83253167465;16989.320427182898;2115.6086124067097;2176.738791345049;2177.8911054447212;2208.8343374246833;2216.357256395643;76666;77923;79397;79480.20519794786;95708.52145739227;16948.406805761984;18561.628767424576;18593.16330765119;18707.34524291643;18970.525736856413;34087.31825363479;34216.65783342135;34275.143121421665;34495.31009379798;34530.48204276938;10563.683089507327;10681.679549613524;10684.237100878268;10715.196360272856;10716.678499645022;9222.584983675752;9247.815043699224;9271.119243671841;9325.766855828659;9455.196308313733;9323.673671421468;9352.205062569621;9376.765580860532;9423;9579.233661307078;3611.494390785292;3795.525559305087;3817.9427308590393;3849.4995650565806;3852.171783066654;1013.5033833421718;1070.3363914372983;1118.8657361116555;1141.452102990569;1184.224333061846;19161.712574311397;19265.422037338623;19615.411537653894;19698.70451943222;19711.90144049299;1024.0169437340237;1079.5735684404617;1095.2278643556274;1155.4684844971407;1171.8125099984131;10926.781464370668;11230.382328971822;11269.605563805228;11402.486888090056;11434.828477572843;429449;512860;533538;535066;540246;64621.67689161524;64914.35085649083;106294;109766.45116774365;113873.4306328463;981.8478135888948;1056.1867362131115;1117.9273347232404;1125.3697929159696;1132.094324540381;18358.449246522625;18388.264469421072;18513.722294165327;18610;18864.33974810875;41646;42618.786906065274;42775;44007;44031.339529906436;59184;60179;61374.386256136866;61488;61565.69217153885;7772.300492955661;8138.3489320853005;8293.83412331762;8875.73372798817;9263.76840578964;10088.89911100909;13047.869521304665;13618.795718064039;13628.31858407056;13950.79073813914;11163.218574700019;11472.139589530652;11612.954834064974;12075.094367922617;12087.39563021863;10770.623028193975;11264.66206013821;11441.199116061796;11732.237404568676;11766.058715302584;11146.219764616399;11527.135464840003;11541.307521548733;11552.595659152226;11938.22401543897;7861.606919654108;8117.959410202911;8325.83348333042;8793.516356600192;9179;11160.441977901235;11291.604793832177;11894.167408281337;11993.460294286953;12066.577669781516 04:48:15 INFO - PROCESS | 1002 | |3;mootools.html;1527.7555591105424;1579.5419328394767;1718.5531761741943;1843.1705732420414;1860.1443336065402;8226.917730822704;8849.07084756101;9093.818123637531;9745.0742179493;9779.119879210879;8979.551022448868;9171.358004939657;9279.48962807047;9401.905980940188;9448.66929657462;2455.9263222103364;2500.762427569387;2504.8497090174556;2509.899604015837;2519.6220566914926;2417.407735104893;2485.8632775197357;2489.8132640051977;2495.1641200197955;2495.900163993447;2473.802095832329;2502.0367158643962;2522.495500899818;2527.19129878439;2535.8732063396847;2463.5072985402903;2482.937926551833;2484.043643197382;2489.278109348296;2523.2430270918744;2402.483466054789;2422.1159276863996;2424.1878970544713;2424.6484259782233;2442.1086303499274;9217.677381291689;9267.629294828199;9309.208717259042;9349.252059835266;9417.811643767154;5336.706481143536;5427.755750991215;5467.343918729738;5468.125099983983;5468.26178465906;3408.199073217792;3506.929861402783;3548.503209550665;3553.4847447120283;3562.4300111982216;1150.1029197226178;1150.9079273658087;1160.96517104487;1172.4958267944864;1187.5665382135544;13393.866061339457;13416.597502074954;13559.186448813103;13670.52153174634;13700.177989320673;4723.721231702948;4783;4828.227483602606;4870.9770948101295;4887.682300650446;11330.886691133148;11375.089992800557;11390.715232119263;11393.772124557463;11407.714807129722;5351.545118664957;5370.301860758076;5373.086575282211;5378.569714422837;5381.677099373972;4453.643708503312;4805.37530121082;4919.188333924933;4925.335079764258;5022.89954200914;4214.157168566299;4307.827686892552;4343.67422443318;4344.022594916119;4373;1290.7224946636518;1336.4520546575857;1340.1423089222906;1356.3015047250674;1374.7181827725292;1023.2888142740873;1030.685640879524;1031.28841099641;1040.0327695243345;1055.076807793181;6089.086637004396;6252.155958945576;6271.78048768291;6317.557770955989;6355.650439225887;461.8245066874633;462.04356981048903;466.7666166916542;468.1923681649196;472.21612123874206;4247.830086796555;4314.546972567898;4325.43769309994;4331.263685173465;4357.4988876279;11560.42197890119;11915.940420297842;11966.880331196751;11980.041596672245;12042.759144817055;11776;11823.763524729457;11850.11124165691;11852.525898964117;11865.050795936304;8376.49741015541;8753.64985400577;8814.162654547808;8866.069062748318;8966.820663586692;6156.199694039746;6206.782762603287;6246.063090536456;6263.812085637438;6392.4246817786625;10536.894631053592;10808.837867431837;10867.673969780919;11068.446577671246;11087.667369978913;10909.34543927367;11084.334939903632;11115.166362522681;11167.609133680282;11286.379249141377;7631.3131818136635;8387;8420.4947703138;8515;8670.436421632574;9239;9290.396124251902;9291.48896810682;9325.720228393158;9397.154256116983;7851.960740196491;7859.882101768364;7962.203779621991;7977.48146370484;8122.55325957078;7958.641861116148;7961.761147165595;7975.800604984922;8091.514509129471;8181.100078991187;7491.887621685788;7555.471117021756;7592.544447333178;7677.731279405194;7683.193264707125;5227.895442091213;5286.577073834161;5309.65487243328;5394.541463975606;5431.538319242909;4953.455119936876;5046.293518907282;5069.8732531687;5105.387353517602;5259.8422047338645 04:48:15 INFO - PROCESS | 1002 | |4;prototype.html;332.29055965513635;345.43521342604834;349.33800448150754;352.4976907906233;355.1689047628549;5047.990401919613;5100.515451032146;5179.274901513786;5207.27098206251;5231.372235331756;5126.256692779554;5150.278960945461;5151.587872970163;5178.948210517894;5192.831612887098;4172.539611136093;4187.22536330779;4191.874243772691;4210.789335598804;4215.59951804578;3893.7079719021044;4096.91806163878;4173.686973476986;4222.1766755482695;4222.852200172994;4046.4132700758373;4057.573954734755;4063.2076745034583;4066.6340029397347;4097.364908439196;4077.5922407759285;4080;4083.1629515949157;4084.407760874686;4110.8972275693195;3525.189206482498;3621.402468592705;3626.9093272668392;3634.56385233771;3639.162992511711;4952.950470495321;4991.750412479398;4998.6750861193905;5031.647784655075;5047.47001564834;4588.49526552079;4644.238167084673;4682.836100736458;4700.952990470086;4709.882252943669;5277;5339.439358867302;5366.677999320014;5400.946815371004;5459.890802183934;3949.861754838567;3950.2692001979726;3977.3835055566433;3977.622125898035;3990.7206495545324;5583.6928968906695;5601.467860553241;5601.579881508862;5627.5779316551425;5638.605297629168;3926.764394136361;4062.695297852673;4065.634092931591;4078.8164532596106;4096.26267271888;4101.85643502482;4105.9119333376675;4107.260693075275;4118.19695159447;4144.79276036197;4630.236011058205;4649.395578574764;4669.2062349400685;4682.672212945061;4690;5285.973570132125;5456.781728730806;5474.151506516497;5491.341039075336;5514.862128446741;1380.7859781733848;1398.4406237504877;1416.6600015996087;1419.3116338575783;1431.5848403962734;890.8485557455248;911.9361644684941;922.7773200509351;936.3024546712606;944.8850356579302;4622.722636641813;4708;4712.410948631421;4763.356946812136;4765.380500534978;4973.577245934064;4982.302477653131;4984.352034235526;4994.600431965434;5014.974925125351;4774.761261936889;4790.269546358542;4794.832180873723;4808.735519546459;4947.356843610308;2931.1646180838356;2956.674765775763;2962.822230666167;2982.2693440106877;2994.2364697002126;5782;5802.274715660543;5818.156367326714;5835.708214589338;5855.4730074292665;5515.992220402189;5623;5664.716764161775;5688.971555142198;5725.482747072029;5738.426157384311;5800.564957628195;5800.9129863052085;5817.7382017809305;5828.388019257917;5290.7354632269;5485.424030476743;5546.223528705904;5553;5563.833085007456;5509.5041446270025;5516.200150978166;5534.142207957773;5550.972245138749;5572.693501857275;5577.8047768327915;5798.971005144947;5812.157237200498;5849.298084229749;5852.209951656642;3971.8411263550292;4006.5776649290246;4007.519097708294;4037.475128233311;4042.676585873064;5466.125419932791;5494.351694491556;5521.503064724194;5521.668699878021;5537.307836520435;5234.2933703949475;5339.25250464943;5385.353757548963;5386.515213630635;5399.379071406838;5276.788928442819;5334.1732031535175;5361.437049109787;5378.19327100938;5393.83818485446;5214.6702590839095;5278.498542638443;5313.521783039545;5316.219066612728;5321.467853214647;5196.792128314825;5377.300950876361;5387.057264978692;5407.83776486706;5418.810341638024;5228.163493840967;5259.184826351921;5264.341957255343;5272.525472707474;5306.787728490817 04:48:15 INFO - PROCESS | 1002 | |5;yui.html;778.5951305321237;794.3645083932856;805.5972013993004;811.7767613906175;850.230541360069;15893.84106158938;16869.662606747872;17271.74092388615;17288.827111728893;17344;15467.458638947639;15512.767308490382;15593.142377169252;15597.610059748513;15711.45009924653;697.0450482838519;821.7699044267615;838.928691061259;847.546562589015;854.4787679515522;857.4640849469082;861.8922634670666;862.2713806833216;865.074370423647;866.969656062038;906.1391677905983;906.229704750963;906.5014242166815;907.1880666803207;909.6179604566065;893.0489029183964;899.1547944931743;900.0639335091497;900.8693739407782;901.779064129286;655.2824657000576;658.0524045374646;659.2550418027646;659.281383292209;660.0066899316546;15410.152441615706;15459.381624734997;15481.767773483407;15492.45776397832;15532;13896.93051534746;14387.424503019867;14429.71140577193;14436.566902992821;15925.442609508727;13373.598792036255;13618.931905340509;13645.454181832714;13698.726025479435;13834.654133646638;4703.247480403119;4723.740194289313;4822.083804077214;4933.580645645125;4949.183384741514;82084.17915820825;82922.58538707328;82987;83107.5844620773;83212.58393708053;10765.892341076646;10832.783344333227;10841.83737243942;11015.559377624966;11358.091352691765;20545.075471603814;20910.268140615004;21004.894975525025;21047.68428473574;21073.473163171042;7647.464677472635;7903.051633803865;8003;8081.838363232702;8161.755147345589;4710.081534100886;4740.810367585327;4809.398825146856;4914.33656456381;4981.277714731416;3715.758475699071;3861.6524512793985;3864.420336949424;3869.2068126034096;3888.6889048876023;645.9224893012774;659.5119611487464;675.2909445082644;686.6360828760764;707.5436343558376;687.2817905288985;742.9561466140082;750.6697053296641;765.5559775330295;796.1520980156231;10413.16694664425;10542.367457952547;10764.085052770446;10764.946175269073;10826.079783218514;789.5933594198992;810.9026916770025;827;829.5934991853948;836.0761358698672;4924.679895806761;5037.571806396498;5054.82308119214;5058.620603454682;5081.517255860687;75498.24501755022;76067.61966190244;122090;122875;124864;66879.66560167167;71437;80471;92587.99999999865;92908.53545732364;58919.41080589225;79936.60031699804;87882.45410550774;90096;90934;9796.706098817047;10101.393916364748;10246.436445995541;10601.787964240826;10612.787744245226;46041.30938035999;46908.29637555507;47002.29496557486;50031;50572.49427505678;73209.6339518299;73688;75356.62321688357;75757.6212118936;76070.61964690141;13526.120802147829;13658.112222705493;13797;13950.441982321;14145.694571850427;14869.628259293604;15283.465078722636;15307.46423875159;15475.071495710294;15613;13541.1198272112;13757.724845503235;13812.654683632989;14049.648758781112;14480.525948799765;13807.240601767;13827.322534777086;13834.30828458553;13926;14265.215413152377;13288.40202190923;14117.858821411655;14365.64085897861;14463.85536144625;14545.636359091108;11170.888291116984;11252.156088293574;11283.717907052061;11466.713332166762;11542.94228528852;11122.944385278346;11601.535938562363;11731.941340293586;11737.119716021503;12104.092193085378 04:48:15 INFO - PROCESS | 1002 | __end_tp_report 04:48:15 INFO - PROCESS | 1002 | __start_cc_report 04:48:15 INFO - PROCESS | 1002 | _x_x_mozilla_cycle_collect,348 04:48:15 INFO - PROCESS | 1002 | __end_cc_report 04:48:15 INFO - PROCESS | 1002 | __startTimestamp1467114495748__endTimestamp 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | ------- Summary: start ------- 04:48:15 INFO - PROCESS | 1002 | Number of tests: 6 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | [#0] dojo.html Cycles:165 Average:5124.98 Median:5309.92 stddev:524.52 (9.9%) stddev-sans-first:504.32 04:48:15 INFO - PROCESS | 1002 | Values: 3216.6 3248.4 3261.5 3270.1 3274.2 5079.4 5083.2 5091.1 5095.7 5168.0 5150.9 5167.2 5169.8 5170.0 5180.7 4632.4 4737.9 4740.6 4775.7 4776.3 4612.7 4618.4 4731.9 4754.8 4781.2 4704.6 4708.0 4720.8 4734.8 4757.5 4713.4 4778.6 4778.9 4781.0 4815.1 4565.1 4682.9 4709.1 4715.6 4778.5 4988.9 5022.8 5069.3 5085.1 5101.1 5544.9 5564.4 5568.6 5569.5 5577.4 5309.9 5311.4 5588.8 5611.8 5624.7 5126.7 5170.1 5175.5 5185.3 5236.0 5595.9 5601.3 5631.1 5634.2 5657.7 5311.3 5359.2 5367.5 5443.7 5456.4 5533.4 5554.3 5560.3 5560.5 5562.1 5506.1 5508.5 5510.6 5515.6 5532.9 5283.3 5444.9 5504.8 5516.4 5532.7 4304.8 4315.1 4320.6 4321.2 4333.8 3889.5 3912.3 3919.7 3924.6 3931.2 5079.9 5179.8 5271.7 5292.5 5297.1 5309.9 5361.7 5376.9 5387.4 5388.9 5235.3 5246.3 5253.4 5259.8 5289.1 4563.5 4669.8 4682.9 4704.1 4734.2 5614.8 5681.6 5688.2 5692.0 5699.4 5362.1 5476.9 5478.9 5481.4 5509.8 5578.4 5588.0 5603.0 5664.8 5702.7 5364.4 5378.8 5404.6 5406.2 5406.5 5289.9 5436.3 5440.9 5448.6 5486.1 5306.3 5401.1 5410.5 5424.8 5428.0 5348.2 5364.8 5370.4 5371.9 5402.9 5166.3 5264.1 5306.0 5314.8 5331.1 5404.3 5412.5 5438.7 5458.8 5489.5 5321.3 5334.4 5335.9 5349.5 5375.4 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | [#1] ext.html Cycles:180 Average:58174.60 Median:41884.69 stddev:115542.86 (275.9%) stddev-sans-first:115786.14 04:48:15 INFO - PROCESS | 1002 | Values: 603.4 651.7 656.0 663.0 668.9 45910.0 47644.5 47734.5 47794.3 50497.5 47866.0 48241.3 48405.0 48494.0 48541.0 9152.9 9231.5 9282.5 9348.2 9367.6 9141.7 9172.7 9192.2 9213.7 9251.2 9246.8 9262.5 9299.5 9339.7 9341.0 9180.9 9241.5 9247.5 9262.3 9264.7 9042.8 9121.6 9176.6 9196.0 9201.2 44925.3 45310.8 45323.3 45673.5 45725.3 3649.7 3833.9 3835.7 3890.1 4010.4 34884.7 35383.5 35485.0 35702.6 35727.5 4377.1 4457.5 4490.2 4569.8 4575.7 371830.0 372095.0 373285.0 373328.0 373880.0 38188.0 66298.3 66527.7 66661.7 66783.7 39584.8 41133.8 41323.0 41488.2 41508.0 16951.1 17162.9 17181.4 17283.6 17318.9 14358.0 14419.3 14488.1 14498.2 14534.1 9268.2 9322.2 9355.7 9361.3 9387.4 3506.2 3547.2 3559.3 3617.5 3622.2 1087.6 1144.5 1180.0 1200.5 1202.6 33699.3 34140.8 34172.5 34285.3 34859.7 1204.7 1213.9 1216.3 1222.4 1252.8 17228.0 17277.7 17513.3 17687.4 17842.8 164711.0 167785.0 582495.0 614194.0 628787.0 56789.4 61923.7 62011.4 62014.0 62383.7 1443.2 1445.1 1450.8 1451.9 1460.5 31684.8 32245.2 32388.8 32948.2 33110.3 51734.0 52278.7 52319.2 52558.2 52692.7 436942.0 437782.0 438707.0 440994.0 442092.0 30072.8 30730.8 30986.0 31039.4 31146.4 47561.0 48380.5 49396.8 49510.3 50218.0 40913.6 41609.6 41685.0 41703.4 42421.2 41006.8 41133.2 41346.0 42066.0 42624.8 41497.2 42354.2 42629.6 42767.0 42906.1 35687.2 35864.8 36568.3 36631.0 37052.6 28368.3 28485.4 28612.9 28671.0 28685.7 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | [#2] jquery.html Cycles:180 Average:31070.74 Median:14240.22 stddev:84222.09 (591.4%) stddev-sans-first:84426.92 04:48:15 INFO - PROCESS | 1002 | Values: 427.9 432.8 435.3 436.2 443.7 17986.9 19160.2 19600.6 20418.7 20431.4 18252.1 18505.9 18579.3 19162.0 19430.9 4945.4 5228.2 5243.0 5287.4 5302.0 5103.0 5199.7 5244.4 5358.4 5361.3 5322.7 5327.8 5339.7 5361.5 5377.9 5323.9 5346.7 7351.5 7764.0 7773.5 7246.6 7536.6 7578.1 7611.7 7636.2 25256.6 25761.6 25900.5 26251.2 27291.7 2534.1 2580.0 2598.2 2736.7 2800.0 15862.7 16640.8 16713.5 16746.8 16989.3 2115.6 2176.7 2177.9 2208.8 2216.4 76666.0 77923.0 79397.0 79480.2 95708.5 16948.4 18561.6 18593.2 18707.3 18970.5 34087.3 34216.7 34275.1 34495.3 34530.5 10563.7 10681.7 10684.2 10715.2 10716.7 9222.6 9247.8 9271.1 9325.8 9455.2 9323.7 9352.2 9376.8 9423.0 9579.2 3611.5 3795.5 3817.9 3849.5 3852.2 1013.5 1070.3 1118.9 1141.5 1184.2 19161.7 19265.4 19615.4 19698.7 19711.9 1024.0 1079.6 1095.2 1155.5 1171.8 10926.8 11230.4 11269.6 11402.5 11434.8 429449.0 512860.0 533538.0 535066.0 540246.0 64621.7 64914.4 106294.0 109766.5 113873.4 981.8 1056.2 1117.9 1125.4 1132.1 18358.4 18388.3 18513.7 18610.0 18864.3 41646.0 42618.8 42775.0 44007.0 44031.3 59184.0 60179.0 61374.4 61488.0 61565.7 7772.3 8138.3 8293.8 8875.7 9263.8 10088.9 13047.9 13618.8 13628.3 13950.8 11163.2 11472.1 11613.0 12075.1 12087.4 10770.6 11264.7 11441.2 11732.2 11766.1 11146.2 11527.1 11541.3 11552.6 11938.2 7861.6 8118.0 8325.8 8793.5 9179.0 11160.4 11291.6 11894.2 11993.5 12066.6 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | [#3] mootools.html Cycles:180 Average:6165.58 Median:2457.73 stddev:3614.68 (147.1%) stddev-sans-first:3608.02 04:48:15 INFO - PROCESS | 1002 | Values: 1527.8 1579.5 1718.6 1843.2 1860.1 8226.9 8849.1 9093.8 9745.1 9779.1 8979.6 9171.4 9279.5 9401.9 9448.7 2455.9 2500.8 2504.8 2509.9 2519.6 2417.4 2485.9 2489.8 2495.2 2495.9 2473.8 2502.0 2522.5 2527.2 2535.9 2463.5 2482.9 2484.0 2489.3 2523.2 2402.5 2422.1 2424.2 2424.6 2442.1 9217.7 9267.6 9309.2 9349.3 9417.8 5336.7 5427.8 5467.3 5468.1 5468.3 3408.2 3506.9 3548.5 3553.5 3562.4 1150.1 1150.9 1161.0 1172.5 1187.6 13393.9 13416.6 13559.2 13670.5 13700.2 4723.7 4783.0 4828.2 4871.0 4887.7 11330.9 11375.1 11390.7 11393.8 11407.7 5351.5 5370.3 5373.1 5378.6 5381.7 4453.6 4805.4 4919.2 4925.3 5022.9 4214.2 4307.8 4343.7 4344.0 4373.0 1290.7 1336.5 1340.1 1356.3 1374.7 1023.3 1030.7 1031.3 1040.0 1055.1 6089.1 6252.2 6271.8 6317.6 6355.7 461.8 462.0 466.8 468.2 472.2 4247.8 4314.5 4325.4 4331.3 4357.5 11560.4 11915.9 11966.9 11980.0 12042.8 11776.0 11823.8 11850.1 11852.5 11865.1 8376.5 8753.6 8814.2 8866.1 8966.8 6156.2 6206.8 6246.1 6263.8 6392.4 10536.9 10808.8 10867.7 11068.4 11087.7 10909.3 11084.3 11115.2 11167.6 11286.4 7631.3 8387.0 8420.5 8515.0 8670.4 9239.0 9290.4 9291.5 9325.7 9397.2 7852.0 7859.9 7962.2 7977.5 8122.6 7958.6 7961.8 7975.8 8091.5 8181.1 7491.9 7555.5 7592.5 7677.7 7683.2 5227.9 5286.6 5309.7 5394.5 5431.5 4953.5 5046.3 5069.9 5105.4 5259.8 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | [#4] prototype.html Cycles:180 Average:4545.76 Median:5074.25 stddev:1310.66 (25.8%) stddev-sans-first:1275.61 04:48:15 INFO - PROCESS | 1002 | Values: 332.3 345.4 349.3 352.5 355.2 5048.0 5100.5 5179.3 5207.3 5231.4 5126.3 5150.3 5151.6 5178.9 5192.8 4172.5 4187.2 4191.9 4210.8 4215.6 3893.7 4096.9 4173.7 4222.2 4222.9 4046.4 4057.6 4063.2 4066.6 4097.4 4077.6 4080.0 4083.2 4084.4 4110.9 3525.2 3621.4 3626.9 3634.6 3639.2 4953.0 4991.8 4998.7 5031.6 5047.5 4588.5 4644.2 4682.8 4701.0 4709.9 5277.0 5339.4 5366.7 5400.9 5459.9 3949.9 3950.3 3977.4 3977.6 3990.7 5583.7 5601.5 5601.6 5627.6 5638.6 3926.8 4062.7 4065.6 4078.8 4096.3 4101.9 4105.9 4107.3 4118.2 4144.8 4630.2 4649.4 4669.2 4682.7 4690.0 5286.0 5456.8 5474.2 5491.3 5514.9 1380.8 1398.4 1416.7 1419.3 1431.6 890.8 911.9 922.8 936.3 944.9 4622.7 4708.0 4712.4 4763.4 4765.4 4973.6 4982.3 4984.4 4994.6 5015.0 4774.8 4790.3 4794.8 4808.7 4947.4 2931.2 2956.7 2962.8 2982.3 2994.2 5782.0 5802.3 5818.2 5835.7 5855.5 5516.0 5623.0 5664.7 5689.0 5725.5 5738.4 5800.6 5800.9 5817.7 5828.4 5290.7 5485.4 5546.2 5553.0 5563.8 5509.5 5516.2 5534.1 5551.0 5572.7 5577.8 5799.0 5812.2 5849.3 5852.2 3971.8 4006.6 4007.5 4037.5 4042.7 5466.1 5494.4 5521.5 5521.7 5537.3 5234.3 5339.3 5385.4 5386.5 5399.4 5276.8 5334.2 5361.4 5378.2 5393.8 5214.7 5278.5 5313.5 5316.2 5321.5 5196.8 5377.3 5387.1 5407.8 5418.8 5228.2 5259.2 5264.3 5272.5 5306.8 04:48:15 INFO - PROCESS | 1002 | 04:48:15 INFO - PROCESS | 1002 | [#5] yui.html Cycles:180 Average:20259.73 Median:4706.66 stddev:28090.86 (596.8%) stddev-sans-first:28131.57 04:48:15 INFO - PROCESS | 1002 | Values: 778.6 794.4 805.6 811.8 850.2 15893.8 16869.7 17271.7 17288.8 17344.0 15467.5 15512.8 15593.1 15597.6 15711.5 697.0 821.8 838.9 847.5 854.5 857.5 861.9 862.3 865.1 867.0 906.1 906.2 906.5 907.2 909.6 893.0 899.2 900.1 900.9 901.8 655.3 658.1 659.3 659.3 660.0 15410.2 15459.4 15481.8 15492.5 15532.0 13896.9 14387.4 14429.7 14436.6 15925.4 13373.6 13618.9 13645.5 13698.7 13834.7 4703.2 4723.7 4822.1 4933.6 4949.2 82084.2 82922.6 82987.0 83107.6 83212.6 10765.9 10832.8 10841.8 11015.6 11358.1 20545.1 20910.3 21004.9 21047.7 21073.5 7647.5 7903.1 8003.0 8081.8 8161.8 4710.1 4740.8 4809.4 4914.3 4981.3 3715.8 3861.7 3864.4 3869.2 3888.7 645.9 659.5 675.3 686.6 707.5 687.3 743.0 750.7 765.6 796.2 10413.2 10542.4 10764.1 10764.9 10826.1 789.6 810.9 827.0 829.6 836.1 4924.7 5037.6 5054.8 5058.6 5081.5 75498.2 76067.6 122090.0 122875.0 124864.0 66879.7 71437.0 80471.0 92588.0 92908.5 58919.4 79936.6 87882.5 90096.0 90934.0 9796.7 10101.4 10246.4 10601.8 10612.8 46041.3 46908.3 47002.3 50031.0 50572.5 73209.6 73688.0 75356.6 75757.6 76070.6 13526.1 13658.1 13797.0 13950.4 14145.7 14869.6 15283.5 15307.5 15475.1 15613.0 13541.1 13757.7 13812.7 14049.6 14480.5 13807.2 13827.3 13834.3 13926.0 14265.2 13288.4 14117.9 14365.6 14463.9 14545.6 11170.9 11252.2 11283.7 11466.7 11542.9 11122.9 11601.5 11731.9 11737.1 12104.1 04:48:15 INFO - PROCESS | 1002 | -------- Summary: end -------- 04:48:15 INFO - PROCESS | 1002 | 04:48:16 INFO - TEST-INFO | 1002: exit 0 04:48:16 INFO - TEST-OK | dromaeo_css | took 1109113ms 04:48:16 INFO - TEST-START | kraken 04:48:16 INFO - operating with platform_type : linux_ 04:48:16 INFO - Initialising browser for kraken test... 04:48:16 INFO - TEST-INFO | started process 1329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKp6zqF/profile http://localhost:47000/getInfo.html) 04:48:20 INFO - PROCESS | 1329 | __metrics Screen width/height:1600/1200 04:48:20 INFO - PROCESS | 1329 | colorDepth:24 04:48:20 INFO - PROCESS | 1329 | Browser inner width/height: 1024/697 04:48:20 INFO - PROCESS | 1329 | __metrics 04:48:21 ERROR - PROCESS | 1329 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:48:22 INFO - TEST-INFO | 1329: exit 0 04:48:22 INFO - Browser initialized. 04:48:22 INFO - Running cycle 1/1 for kraken test... 04:48:22 INFO - TEST-INFO | started process 1459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKp6zqF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:48:34 INFO - PROCESS | 1459 | RSS: Main: 156319744 04:48:34 INFO - PROCESS | 1459 | 04:48:36 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-beat-detection) 04:48:37 INFO - PROCESS | 1459 | RSS: Main: 161710080 04:48:37 INFO - PROCESS | 1459 | 04:48:40 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-dft) 04:48:40 INFO - PROCESS | 1459 | RSS: Main: 160903168 04:48:40 INFO - PROCESS | 1459 | 04:48:43 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-fft) 04:48:44 INFO - PROCESS | 1459 | RSS: Main: 161955840 04:48:44 INFO - PROCESS | 1459 | 04:48:46 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47000/tests/kraken/driver.html?testName=audio-oscillator) 04:48:47 INFO - PROCESS | 1459 | RSS: Main: 161677312 04:48:47 INFO - PROCESS | 1459 | 04:48:49 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47000/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:48:49 INFO - PROCESS | 1459 | RSS: Main: 161624064 04:48:49 INFO - PROCESS | 1459 | 04:48:52 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47000/tests/kraken/driver.html?testName=imaging-darkroom) 04:48:53 INFO - PROCESS | 1459 | RSS: Main: 161890304 04:48:53 INFO - PROCESS | 1459 | 04:48:57 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47000/tests/kraken/driver.html?testName=imaging-desaturate) 04:48:57 INFO - PROCESS | 1459 | RSS: Main: 157978624 04:48:57 INFO - PROCESS | 1459 | 04:49:00 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47000/tests/kraken/driver.html?testName=json-parse-financial) 04:49:01 INFO - PROCESS | 1459 | RSS: Main: 159825920 04:49:01 INFO - PROCESS | 1459 | 04:49:02 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47000/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:03 INFO - PROCESS | 1459 | RSS: Main: 160423936 04:49:03 INFO - PROCESS | 1459 | 04:49:05 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:05 INFO - PROCESS | 1459 | RSS: Main: 160432128 04:49:05 INFO - PROCESS | 1459 | 04:49:07 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:08 INFO - PROCESS | 1459 | RSS: Main: 161083392 04:49:08 INFO - PROCESS | 1459 | 04:49:11 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:49:11 INFO - PROCESS | 1459 | RSS: Main: 161320960 04:49:11 INFO - PROCESS | 1459 | 04:49:14 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:49:15 INFO - PROCESS | 1459 | RSS: Main: 160739328 04:49:15 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | Cycle 1(1): loaded http://localhost:47000/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47000/tests/kraken/driver.html?testName=ai-astar) 04:49:16 INFO - PROCESS | 1459 | RSS: Main: 161566720 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | __start_tp_report 04:49:16 INFO - PROCESS | 1459 | _x_x_mozilla_page_load 04:49:16 INFO - PROCESS | 1459 | _x_x_mozilla_page_load_details 04:49:16 INFO - PROCESS | 1459 | |i|pagename|runs| 04:49:16 INFO - PROCESS | 1459 | |0;ai-astar;111;104;110;110;111;111;109;110;111;110 04:49:16 INFO - PROCESS | 1459 | |1;audio-beat-detection;165;127;148;169;127;156;154;133;177;127 04:49:16 INFO - PROCESS | 1459 | |2;audio-dft;165;165;162;162;163;164;162;163;168;163 04:49:16 INFO - PROCESS | 1459 | |3;audio-fft;76;76;76;170;77;76;74;75;170;75 04:49:16 INFO - PROCESS | 1459 | |4;audio-oscillator;84;84;152;84;84;85;138;85;84;150 04:49:16 INFO - PROCESS | 1459 | |5;imaging-gaussian-blur;118;118;118;118;118;117;117;118;118;117 04:49:16 INFO - PROCESS | 1459 | |6;imaging-darkroom;147;147;147;148;149;148;147;148;147;149 04:49:16 INFO - PROCESS | 1459 | |7;imaging-desaturate;96;97;96;96;95;95;95;96;95;96 04:49:16 INFO - PROCESS | 1459 | |8;json-parse-financial;60;57;57;56;57;57;58;58;62;58 04:49:16 INFO - PROCESS | 1459 | |9;json-stringify-tinderbox;58;58;58;57;59;58;58;58;60;58 04:49:16 INFO - PROCESS | 1459 | |10;stanford-crypto-aes;77;79;79;78;79;77;86;85;108;85 04:49:16 INFO - PROCESS | 1459 | |11;stanford-crypto-ccm;126;130;123;118;124;119;130;123;134;122 04:49:16 INFO - PROCESS | 1459 | |12;stanford-crypto-pbkdf2;157;158;159;155;156;155;157;158;161;153 04:49:16 INFO - PROCESS | 1459 | |13;stanford-crypto-sha256-iterative;61;63;61;61;61;60;66;60;60;60 04:49:16 INFO - PROCESS | 1459 | __end_tp_report 04:49:16 INFO - PROCESS | 1459 | __start_cc_report 04:49:16 INFO - PROCESS | 1459 | _x_x_mozilla_cycle_collect,908 04:49:16 INFO - PROCESS | 1459 | __end_cc_report 04:49:16 INFO - PROCESS | 1459 | __startTimestamp1467114556903__endTimestamp 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | ------- Summary: start ------- 04:49:16 INFO - PROCESS | 1459 | Number of tests: 14 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.11 (1.9%) stddev-sans-first:2.19 04:49:16 INFO - PROCESS | 1459 | Values: 111.0 104.0 110.0 110.0 111.0 111.0 109.0 110.0 111.0 110.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:155.00 stddev:18.91 (12.2%) stddev-sans-first:19.07 04:49:16 INFO - PROCESS | 1459 | Values: 165.0 127.0 148.0 169.0 127.0 156.0 154.0 133.0 177.0 127.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.89 (1.2%) stddev-sans-first:1.94 04:49:16 INFO - PROCESS | 1459 | Values: 165.0 165.0 162.0 162.0 163.0 164.0 162.0 163.0 168.0 163.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:39.80 (52.4%) stddev-sans-first:41.65 04:49:16 INFO - PROCESS | 1459 | Values: 76.0 76.0 76.0 170.0 77.0 76.0 74.0 75.0 170.0 75.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:84.00 stddev:30.35 (36.1%) stddev-sans-first:31.40 04:49:16 INFO - PROCESS | 1459 | Values: 84.0 84.0 152.0 84.0 84.0 85.0 138.0 85.0 84.0 150.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:49:16 INFO - PROCESS | 1459 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 04:49:16 INFO - PROCESS | 1459 | Values: 147.0 147.0 147.0 148.0 149.0 148.0 147.0 148.0 147.0 149.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:49:16 INFO - PROCESS | 1459 | Values: 96.0 97.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 96.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:1.76 (3.0%) stddev-sans-first:1.72 04:49:16 INFO - PROCESS | 1459 | Values: 60.0 57.0 57.0 56.0 57.0 57.0 58.0 58.0 62.0 58.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 04:49:16 INFO - PROCESS | 1459 | Values: 58.0 58.0 58.0 57.0 59.0 58.0 58.0 58.0 60.0 58.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:79.00 stddev:9.35 (11.8%) stddev-sans-first:9.63 04:49:16 INFO - PROCESS | 1459 | Values: 77.0 79.0 79.0 78.0 79.0 77.0 86.0 85.0 108.0 85.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.00 stddev:5.11 (4.1%) stddev-sans-first:5.40 04:49:16 INFO - PROCESS | 1459 | Values: 126.0 130.0 123.0 118.0 124.0 119.0 130.0 123.0 134.0 122.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.50 stddev:2.28 (1.4%) stddev-sans-first:2.42 04:49:16 INFO - PROCESS | 1459 | Values: 157.0 158.0 159.0 155.0 156.0 155.0 157.0 158.0 161.0 153.0 04:49:16 INFO - PROCESS | 1459 | 04:49:16 INFO - PROCESS | 1459 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:1.89 (3.1%) stddev-sans-first:2.00 04:49:16 INFO - PROCESS | 1459 | Values: 61.0 63.0 61.0 61.0 61.0 60.0 66.0 60.0 60.0 60.0 04:49:16 INFO - PROCESS | 1459 | -------- Summary: end -------- 04:49:16 INFO - PROCESS | 1459 | 04:49:17 INFO - TEST-INFO | 1459: exit 0 04:49:17 INFO - TEST-OK | kraken | took 61308ms 04:49:17 INFO - SUITE-END | took 1170s 04:49:18 INFO - Completed test suite (00:19:30) 04:49:18 INFO - javascript benchmark 04:49:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7416.0396120571, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3216.5979252593424, 3248.3665685191395, 3261.5107733839923, 3270.0516850113468, 3274.1814546363426, 5079.4412614612365, 5083.18669012958, 5091.083604951112, 5095.7197354145555, 5168.043911876305, 5150.922736158961, 5167.199084141955, 5169.767360468779, 5170.0, 5180.6891586504835, 4632.4441067072, 4737.928931066037, 4740.620750339982, 4775.689580177294, 4776.283557466373, 4612.723236605798, 4618.399608050949, 4731.858044258678, 4754.762261886909, 4781.211100168468, 4704.553067458603, 4708.034852855157, 4720.787564559603, 4734.834280800173, 4757.548032936866, 4713.410823647044, 4778.641601879838, 4778.928316075262, 4780.952190478086, 4815.085133824562, 4565.0641618468135, 4682.859514214579, 4709.081729062834, 4715.64632652549, 4778.546038126373, 4988.900221995576, 5022.773975171126, 5069.340985671839, 5085.1355269604255, 5101.081805275049, 5544.889102217973, 5564.415736347706, 5568.554515638739, 5569.526590239834, 5577.442255774431, 5309.920351194735, 5311.362636483608, 5588.804391846266, 5611.831645050655, 5624.690642014688, 5126.6667666601925, 5170.069387510247, 5175.482451754794, 5185.325907632021, 5236.0, 5595.888082238333, 5601.327840659065, 5631.070873305941, 5634.23937768396, 5657.688827114466, 5311.309529761106, 5359.196120581944, 5367.463253674601, 5443.673379597237, 5456.372517160498, 5533.363663178706, 5554.333479982428, 5560.304961879765, 5560.499555039985, 5562.082256427725, 5506.063969125258, 5508.531774799107, 5510.614257002052, 5515.61390702647, 5532.917006244909, 5283.286756287852, 5444.945550544444, 5504.779808807683, 5516.365617953907, 5532.6680399176175, 4304.763238021939, 4315.0722594641675, 4320.589543993316, 4321.178975994551, 4333.804978775963, 3889.4554762333296, 3912.3349030664854, 3919.7452165609143, 3924.5879182685976, 3931.233409485123, 5079.9238011429115, 5179.818706345335, 5271.736413179326, 5292.497212764782, 5297.099493086108, 5309.867253318698, 5361.678299302054, 5376.946230537723, 5387.353517577916, 5388.865278368072, 5235.267062611238, 5246.31797866275, 5253.44838791929, 5259.789608415621, 5289.074411977888, 4563.498015218323, 4669.766511674471, 4682.85951421451, 4704.129735998851, 4734.19518681825, 5614.775408983676, 5681.630694004876, 5688.203651488795, 5692.032354499662, 5699.401562835843, 5362.088444964444, 5476.91784623231, 5478.863028424321, 5481.3970463248215, 5509.834704958857, 5578.358488773681, 5587.99416105105, 5603.0, 5664.830055098354, 5702.657840529581, 5364.436734142859, 5378.757955891916, 5404.59465540094, 5406.216098665593, 5406.459354064562, 5289.862679523921, 5436.293281873332, 5440.945590544202, 5448.618596698351, 5486.149646804752, 5306.336707911511, 5401.1088170453, 5410.540104091197, 5424.755885985219, 5427.972860135674, 5348.171033489815, 5364.839054828361, 5370.382406023357, 5371.892562148813, 5402.946425447, 5166.2508936203285, 5264.10510213257, 5305.973470132624, 5314.760835762478, 5331.1470164773455, 5404.270423492778, 5412.539934105645, 5438.728063596884, 5458.836234912959, 5489.478499542537, 5321.281626980308, 5334.359876814807, 5335.866603334947, 5349.545288650508, 5375.354957405137], "value": 5094.25191670514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.3574243430746, 651.7197605029837, 656.0, 662.9602223866568, 668.8561959178777, 45910.0, 47644.52355476444, 47734.52265477353, 47794.2830857537, 50497.495025049735, 47866.0426791464, 48241.27638085432, 48405.0, 48494.0, 48541.0, 9152.947411047748, 9231.538423078819, 9282.489463079528, 9348.158665720084, 9367.578458969328, 9141.72574822753, 9172.724818255463, 9192.218661413788, 9213.677521286756, 9251.213646840026, 9246.815063698721, 9262.536873156316, 9299.535023248844, 9339.719808405758, 9340.953295233514, 9180.908190918071, 9241.537923103851, 9247.537623118817, 9262.305327100426, 9264.675736349229, 9042.773930651721, 9121.635134594675, 9176.632934682604, 9196.0, 9201.171894529525, 44925.32612010823, 45310.77344613256, 45323.320150197775, 45673.54326456759, 45725.31412028789, 3649.6897763690117, 3833.8658146965, 3835.712321575865, 3890.1441682830014, 4010.4184893190322, 34884.6511534884, 35383.4692479613, 35485.0, 35702.64297357045, 35727.4640880387, 4377.146456440995, 4457.465104187519, 4490.236659767847, 4569.794359253809, 4575.748333841638, 371830.0, 372095.0, 373284.99999999726, 373328.0, 373880.0, 38188.0, 66298.33701663018, 66527.66736166288, 66661.66669166624, 66783.66608167025, 39584.802075989435, 41133.794331028155, 41323.0, 41488.1702365951, 41508.0, 16951.067691277098, 17162.914185428992, 17181.398651047402, 17283.567910802332, 17318.913405433144, 14358.0, 14419.279036048365, 14488.058276212012, 14498.202598857164, 14534.127952322682, 9268.165865072042, 9322.207612353026, 9355.719328420158, 9361.297902657192, 9387.436753794795, 3506.1760486285702, 3547.2018795770746, 3559.288142371536, 3617.511635929116, 3622.166901612644, 1087.5649740104022, 1144.513581727779, 1179.9646010619695, 1200.5197920831738, 1202.5971299614553, 33699.32601348008, 34140.829295853364, 34172.48741268883, 34285.314293713986, 34859.65140348615, 1204.6626944455566, 1213.9393030348447, 1216.3492531495608, 1222.3949145173196, 1252.7619752247044, 17228.022903334346, 17277.65444691099, 17513.299468021138, 17687.38094166698, 17842.840215385957, 164711.0, 167785.0, 582495.0, 614194.0, 628787.0, 56789.43210567842, 61923.6903815487, 62011.37988620147, 62014.0, 62383.6880815593, 1443.1557538839686, 1445.1184777285848, 1450.833154187282, 1451.8602896726231, 1460.547230358571, 31684.841575791972, 32245.193870152496, 32388.83805580957, 32948.1762955928, 33110.33779324352, 51734.0, 52278.693032674484, 52319.215211772615, 52558.211626824865, 52692.7365363186, 436942.0, 437782.0, 438707.0, 440994.0, 442092.0, 30072.84963575256, 30730.846345769023, 30986.0, 31039.379212415173, 31146.377072458876, 47561.0, 48380.516194837604, 49396.75301623469, 49510.257346140555, 50218.0, 40913.59086409217, 41609.58390416057, 41685.0, 41703.374449382674, 42421.15157696767, 41006.76979690614, 41133.1773364537, 41346.0, 42066.0, 42624.786876065424, 41497.1700565993, 42354.152916942105, 42629.57370426256, 42767.0, 42906.1418771629, 35687.16327707136, 35864.82067589645, 36568.26863462769, 36631.0, 37052.62947370492, 28368.264591207444, 28485.43029139447, 28612.856935715186, 28670.99651512187, 28685.713142868302], "value": 19931.080635450104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.8694998025601, 432.8485030239416, 435.29047652326705, 436.17918872644566, 443.73375974415353, 17986.910065449672, 19160.233590656375, 19600.607987840252, 20418.69371959422, 20431.38705838827, 18252.08739563023, 18505.907470462662, 18579.349722759707, 19162.0, 19430.902845485754, 4945.40655121385, 5228.241904923784, 5243.030039442715, 5287.41838397776, 5302.0, 5103.0, 5199.714015729133, 5244.370675518943, 5358.410574836765, 5361.329833770778, 5322.680639161644, 5327.760250788704, 5339.70631615261, 5361.544268737162, 5377.946220537784, 5323.920141197885, 5346.6524675896135, 7351.485396022281, 7764.0, 7773.455858089936, 7246.565206087599, 7536.585487798169, 7578.0906291244855, 7611.65747541362, 7636.236376362375, 25256.621150682753, 25761.61357579638, 25900.481990360277, 26251.212463625932, 27291.727082729118, 2534.0750626021554, 2579.9613005804927, 2598.2075466982565, 2736.7400096990755, 2799.9720002799913, 15862.682746345008, 16640.750388744178, 16713.49859504217, 16746.83253167465, 16989.320427182898, 2115.6086124067097, 2176.738791345049, 2177.8911054447212, 2208.8343374246833, 2216.357256395643, 76666.0, 77923.0, 79397.0, 79480.20519794786, 95708.52145739227, 16948.406805761984, 18561.628767424576, 18593.16330765119, 18707.34524291643, 18970.525736856413, 34087.31825363479, 34216.65783342135, 34275.143121421665, 34495.31009379798, 34530.48204276938, 10563.683089507327, 10681.679549613524, 10684.237100878268, 10715.196360272856, 10716.678499645022, 9222.584983675752, 9247.815043699224, 9271.119243671841, 9325.766855828659, 9455.196308313733, 9323.673671421468, 9352.205062569621, 9376.765580860532, 9423.0, 9579.233661307078, 3611.494390785292, 3795.525559305087, 3817.9427308590393, 3849.4995650565806, 3852.171783066654, 1013.5033833421718, 1070.3363914372983, 1118.8657361116555, 1141.452102990569, 1184.224333061846, 19161.712574311397, 19265.422037338623, 19615.411537653894, 19698.70451943222, 19711.90144049299, 1024.0169437340237, 1079.5735684404617, 1095.2278643556274, 1155.4684844971407, 1171.8125099984131, 10926.781464370668, 11230.382328971822, 11269.605563805228, 11402.486888090056, 11434.828477572843, 429449.0, 512860.0, 533538.0, 535066.0, 540246.0, 64621.67689161524, 64914.35085649083, 106294.0, 109766.45116774365, 113873.4306328463, 981.8478135888948, 1056.1867362131115, 1117.9273347232404, 1125.3697929159696, 1132.094324540381, 18358.449246522625, 18388.264469421072, 18513.722294165327, 18610.0, 18864.33974810875, 41646.0, 42618.786906065274, 42775.0, 44007.0, 44031.339529906436, 59184.0, 60179.0, 61374.386256136866, 61488.0, 61565.69217153885, 7772.300492955661, 8138.3489320853005, 8293.83412331762, 8875.73372798817, 9263.76840578964, 10088.89911100909, 13047.869521304665, 13618.795718064039, 13628.31858407056, 13950.79073813914, 11163.218574700019, 11472.139589530652, 11612.954834064974, 12075.094367922617, 12087.39563021863, 10770.623028193975, 11264.66206013821, 11441.199116061796, 11732.237404568676, 11766.058715302584, 11146.219764616399, 11527.135464840003, 11541.307521548733, 11552.595659152226, 11938.22401543897, 7861.606919654108, 8117.959410202911, 8325.83348333042, 8793.516356600192, 9179.0, 11160.441977901235, 11291.604793832177, 11894.167408281337, 11993.460294286953, 12066.577669781516], "value": 10504.411380951913, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1527.7555591105424, 1579.5419328394767, 1718.5531761741943, 1843.1705732420414, 1860.1443336065402, 8226.917730822704, 8849.07084756101, 9093.818123637531, 9745.0742179493, 9779.119879210879, 8979.551022448868, 9171.358004939657, 9279.48962807047, 9401.905980940188, 9448.66929657462, 2455.9263222103364, 2500.762427569387, 2504.8497090174556, 2509.899604015837, 2519.6220566914926, 2417.407735104893, 2485.8632775197357, 2489.8132640051977, 2495.1641200197955, 2495.900163993447, 2473.802095832329, 2502.0367158643962, 2522.495500899818, 2527.19129878439, 2535.8732063396847, 2463.5072985402903, 2482.937926551833, 2484.043643197382, 2489.278109348296, 2523.2430270918744, 2402.483466054789, 2422.1159276863996, 2424.1878970544713, 2424.6484259782233, 2442.1086303499274, 9217.677381291689, 9267.629294828199, 9309.208717259042, 9349.252059835266, 9417.811643767154, 5336.706481143536, 5427.755750991215, 5467.343918729738, 5468.125099983983, 5468.26178465906, 3408.199073217792, 3506.929861402783, 3548.503209550665, 3553.4847447120283, 3562.4300111982216, 1150.1029197226178, 1150.9079273658087, 1160.96517104487, 1172.4958267944864, 1187.5665382135544, 13393.866061339457, 13416.597502074954, 13559.186448813103, 13670.52153174634, 13700.177989320673, 4723.721231702948, 4783.0, 4828.227483602606, 4870.9770948101295, 4887.682300650446, 11330.886691133148, 11375.089992800557, 11390.715232119263, 11393.772124557463, 11407.714807129722, 5351.545118664957, 5370.301860758076, 5373.086575282211, 5378.569714422837, 5381.677099373972, 4453.643708503312, 4805.37530121082, 4919.188333924933, 4925.335079764258, 5022.89954200914, 4214.157168566299, 4307.827686892552, 4343.67422443318, 4344.022594916119, 4373.0, 1290.7224946636518, 1336.4520546575857, 1340.1423089222906, 1356.3015047250674, 1374.7181827725292, 1023.2888142740873, 1030.685640879524, 1031.28841099641, 1040.0327695243345, 1055.076807793181, 6089.086637004396, 6252.155958945576, 6271.78048768291, 6317.557770955989, 6355.650439225887, 461.8245066874633, 462.04356981048903, 466.7666166916542, 468.1923681649196, 472.21612123874206, 4247.830086796555, 4314.546972567898, 4325.43769309994, 4331.263685173465, 4357.4988876279, 11560.42197890119, 11915.940420297842, 11966.880331196751, 11980.041596672245, 12042.759144817055, 11776.0, 11823.763524729457, 11850.11124165691, 11852.525898964117, 11865.050795936304, 8376.49741015541, 8753.64985400577, 8814.162654547808, 8866.069062748318, 8966.820663586692, 6156.199694039746, 6206.782762603287, 6246.063090536456, 6263.812085637438, 6392.4246817786625, 10536.894631053592, 10808.837867431837, 10867.673969780919, 11068.446577671246, 11087.667369978913, 10909.34543927367, 11084.334939903632, 11115.166362522681, 11167.609133680282, 11286.379249141377, 7631.3131818136635, 8387.0, 8420.4947703138, 8515.0, 8670.436421632574, 9239.0, 9290.396124251902, 9291.48896810682, 9325.720228393158, 9397.154256116983, 7851.960740196491, 7859.882101768364, 7962.203779621991, 7977.48146370484, 8122.55325957078, 7958.641861116148, 7961.761147165595, 7975.800604984922, 8091.514509129471, 8181.100078991187, 7491.887621685788, 7555.471117021756, 7592.544447333178, 7677.731279405194, 7683.193264707125, 5227.895442091213, 5286.577073834161, 5309.65487243328, 5394.541463975606, 5431.538319242909, 4953.455119936876, 5046.293518907282, 5069.8732531687, 5105.387353517602, 5259.8422047338645], "value": 4819.750369127993, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.29055965513635, 345.43521342604834, 349.33800448150754, 352.4976907906233, 355.1689047628549, 5047.990401919613, 5100.515451032146, 5179.274901513786, 5207.27098206251, 5231.372235331756, 5126.256692779554, 5150.278960945461, 5151.587872970163, 5178.948210517894, 5192.831612887098, 4172.539611136093, 4187.22536330779, 4191.874243772691, 4210.789335598804, 4215.59951804578, 3893.7079719021044, 4096.91806163878, 4173.686973476986, 4222.1766755482695, 4222.852200172994, 4046.4132700758373, 4057.573954734755, 4063.2076745034583, 4066.6340029397347, 4097.364908439196, 4077.5922407759285, 4080.0, 4083.1629515949157, 4084.407760874686, 4110.8972275693195, 3525.189206482498, 3621.402468592705, 3626.9093272668392, 3634.56385233771, 3639.162992511711, 4952.950470495321, 4991.750412479398, 4998.6750861193905, 5031.647784655075, 5047.47001564834, 4588.49526552079, 4644.238167084673, 4682.836100736458, 4700.952990470086, 4709.882252943669, 5277.0, 5339.439358867302, 5366.677999320014, 5400.946815371004, 5459.890802183934, 3949.861754838567, 3950.2692001979726, 3977.3835055566433, 3977.622125898035, 3990.7206495545324, 5583.6928968906695, 5601.467860553241, 5601.579881508862, 5627.5779316551425, 5638.605297629168, 3926.764394136361, 4062.695297852673, 4065.634092931591, 4078.8164532596106, 4096.26267271888, 4101.85643502482, 4105.9119333376675, 4107.260693075275, 4118.19695159447, 4144.79276036197, 4630.236011058205, 4649.395578574764, 4669.2062349400685, 4682.672212945061, 4690.0, 5285.973570132125, 5456.781728730806, 5474.151506516497, 5491.341039075336, 5514.862128446741, 1380.7859781733848, 1398.4406237504877, 1416.6600015996087, 1419.3116338575783, 1431.5848403962734, 890.8485557455248, 911.9361644684941, 922.7773200509351, 936.3024546712606, 944.8850356579302, 4622.722636641813, 4708.0, 4712.410948631421, 4763.356946812136, 4765.380500534978, 4973.577245934064, 4982.302477653131, 4984.352034235526, 4994.600431965434, 5014.974925125351, 4774.761261936889, 4790.269546358542, 4794.832180873723, 4808.735519546459, 4947.356843610308, 2931.1646180838356, 2956.674765775763, 2962.822230666167, 2982.2693440106877, 2994.2364697002126, 5782.0, 5802.274715660543, 5818.156367326714, 5835.708214589338, 5855.4730074292665, 5515.992220402189, 5623.0, 5664.716764161775, 5688.971555142198, 5725.482747072029, 5738.426157384311, 5800.564957628195, 5800.9129863052085, 5817.7382017809305, 5828.388019257917, 5290.7354632269, 5485.424030476743, 5546.223528705904, 5553.0, 5563.833085007456, 5509.5041446270025, 5516.200150978166, 5534.142207957773, 5550.972245138749, 5572.693501857275, 5577.8047768327915, 5798.971005144947, 5812.157237200498, 5849.298084229749, 5852.209951656642, 3971.8411263550292, 4006.5776649290246, 4007.519097708294, 4037.475128233311, 4042.676585873064, 5466.125419932791, 5494.351694491556, 5521.503064724194, 5521.668699878021, 5537.307836520435, 5234.2933703949475, 5339.25250464943, 5385.353757548963, 5386.515213630635, 5399.379071406838, 5276.788928442819, 5334.1732031535175, 5361.437049109787, 5378.19327100938, 5393.83818485446, 5214.6702590839095, 5278.498542638443, 5313.521783039545, 5316.219066612728, 5321.467853214647, 5196.792128314825, 5377.300950876361, 5387.057264978692, 5407.83776486706, 5418.810341638024, 5228.163493840967, 5259.184826351921, 5264.341957255343, 5272.525472707474, 5306.787728490817], "value": 4135.111462815479, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.5951305321237, 794.3645083932856, 805.5972013993004, 811.7767613906175, 850.230541360069, 15893.84106158938, 16869.662606747872, 17271.74092388615, 17288.827111728893, 17344.0, 15467.458638947639, 15512.767308490382, 15593.142377169252, 15597.610059748513, 15711.45009924653, 697.0450482838519, 821.7699044267615, 838.928691061259, 847.546562589015, 854.4787679515522, 857.4640849469082, 861.8922634670666, 862.2713806833216, 865.074370423647, 866.969656062038, 906.1391677905983, 906.229704750963, 906.5014242166815, 907.1880666803207, 909.6179604566065, 893.0489029183964, 899.1547944931743, 900.0639335091497, 900.8693739407782, 901.779064129286, 655.2824657000576, 658.0524045374646, 659.2550418027646, 659.281383292209, 660.0066899316546, 15410.152441615706, 15459.381624734997, 15481.767773483407, 15492.45776397832, 15532.0, 13896.93051534746, 14387.424503019867, 14429.71140577193, 14436.566902992821, 15925.442609508727, 13373.598792036255, 13618.931905340509, 13645.454181832714, 13698.726025479435, 13834.654133646638, 4703.247480403119, 4723.740194289313, 4822.083804077214, 4933.580645645125, 4949.183384741514, 82084.17915820825, 82922.58538707328, 82987.0, 83107.5844620773, 83212.58393708053, 10765.892341076646, 10832.783344333227, 10841.83737243942, 11015.559377624966, 11358.091352691765, 20545.075471603814, 20910.268140615004, 21004.894975525025, 21047.68428473574, 21073.473163171042, 7647.464677472635, 7903.051633803865, 8003.0, 8081.838363232702, 8161.755147345589, 4710.081534100886, 4740.810367585327, 4809.398825146856, 4914.33656456381, 4981.277714731416, 3715.758475699071, 3861.6524512793985, 3864.420336949424, 3869.2068126034096, 3888.6889048876023, 645.9224893012774, 659.5119611487464, 675.2909445082644, 686.6360828760764, 707.5436343558376, 687.2817905288985, 742.9561466140082, 750.6697053296641, 765.5559775330295, 796.1520980156231, 10413.16694664425, 10542.367457952547, 10764.085052770446, 10764.946175269073, 10826.079783218514, 789.5933594198992, 810.9026916770025, 827.0, 829.5934991853948, 836.0761358698672, 4924.679895806761, 5037.571806396498, 5054.82308119214, 5058.620603454682, 5081.517255860687, 75498.24501755022, 76067.61966190244, 122090.0, 122875.0, 124864.0, 66879.66560167167, 71437.0, 80471.0, 92587.99999999865, 92908.53545732364, 58919.41080589225, 79936.60031699804, 87882.45410550774, 90096.0, 90934.0, 9796.706098817047, 10101.393916364748, 10246.436445995541, 10601.787964240826, 10612.787744245226, 46041.30938035999, 46908.29637555507, 47002.29496557486, 50031.0, 50572.49427505678, 73209.6339518299, 73688.0, 75356.62321688357, 75757.6212118936, 76070.61964690141, 13526.120802147829, 13658.112222705493, 13797.0, 13950.441982321, 14145.694571850427, 14869.628259293604, 15283.465078722636, 15307.46423875159, 15475.071495710294, 15613.0, 13541.1198272112, 13757.724845503235, 13812.654683632989, 14049.648758781112, 14480.525948799765, 13807.240601767, 13827.322534777086, 13834.30828458553, 13926.0, 14265.215413152377, 13288.40202190923, 14117.858821411655, 14365.64085897861, 14463.85536144625, 14545.636359091108, 11170.888291116984, 11252.156088293574, 11283.717907052061, 11466.713332166762, 11542.94228528852, 11122.944385278346, 11601.535938562363, 11731.941340293586, 11737.119716021503, 12104.092193085378], "value": 7825.099290256955, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1522.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 110.0, 111.0, 111.0, 109.0, 110.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 127.0, 148.0, 169.0, 127.0, 156.0, 154.0, 133.0, 177.0, 127.0], "value": 148.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 162.0, 162.0, 163.0, 164.0, 162.0, 163.0, 168.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 170.0, 77.0, 76.0, 74.0, 75.0, 170.0, 75.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 152.0, 84.0, 84.0, 85.0, 138.0, 85.0, 84.0, 150.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 147.0, 149.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 57.0, 56.0, 57.0, 57.0, 58.0, 58.0, 62.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 57.0, 59.0, 58.0, 58.0, 58.0, 60.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 79.0, 78.0, 79.0, 77.0, 86.0, 85.0, 108.0, 85.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 130.0, 123.0, 118.0, 124.0, 119.0, 130.0, 123.0, 134.0, 122.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 159.0, 155.0, 156.0, 155.0, 157.0, 158.0, 161.0, 153.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 61.0, 60.0, 66.0, 60.0, 60.0, 60.0], "value": 61.3, "unit": "score"}]}]} 04:49:18 INFO - Return code: 0 04:49:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:49:18 ERROR - # TBPL SUCCESS # 04:49:18 INFO - Running post-action listener: _resource_record_post_action 04:49:18 INFO - ##### 04:49:18 INFO - ##### Finished run-tests step (success) 04:49:18 INFO - ##### 04:49:18 INFO - Running post-run listener: _resource_record_post_run 04:49:18 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 508698624; Read time: 12; Write time: 697940 04:49:18 INFO - TinderboxPrint: CPU usage
13.4% 04:49:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:49:18 INFO - TinderboxPrint: I/O write bytes / time
508,698,624 / 697,940 04:49:18 INFO - TinderboxPrint: CPU idle
8,208.5 (86.6%) 04:49:18 INFO - TinderboxPrint: CPU user
1,210.2 (12.8%) 04:49:18 INFO - TinderboxPrint: Swap in / out
0 / 0 04:49:18 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 257785856; Read time: 0; Write time: 555072 04:49:18 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250327040; Read time: 12; Write time: 142856 04:49:18 INFO - Running post-run listener: _upload_blobber_files 04:49:18 INFO - Blob upload gear active. 04:49:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:49:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:49:18 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'] 04:49:18 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 04:49:19 INFO - (blobuploader) - INFO - Open directory for files ... 04:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:49:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:49:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:19 INFO - (blobuploader) - INFO - Done attempting. 04:49:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:49:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:23 INFO - (blobuploader) - INFO - Done attempting. 04:49:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:49:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:24 INFO - (blobuploader) - INFO - Done attempting. 04:49:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:49:24 INFO - Return code: 0 04:49:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:49:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:49:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c579b56e57047558e145cdc3ed4663945140d39f26662583df29c7d3d922d2786b71348d32cfccff615059e4a7febca487e0bee6bc98710c3aed5c655e3193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cd79228e00d29c95e86af08b60844b09681f1a2c31ed689ed9076cced7a807df8a443d358b670856023f0ff182d11380cd8b7845106aeba9355c252df525e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816be743dabbbd6c8ad1bd57d2a727b5df7c684a1e78de639351ac8fd0c9e3cbc9f0469cde25c098773f93d03e13c5c8ed64418eda51b364592f9a6d607bbf0b"} 04:49:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:49:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:49:24 INFO - Contents: 04:49:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c579b56e57047558e145cdc3ed4663945140d39f26662583df29c7d3d922d2786b71348d32cfccff615059e4a7febca487e0bee6bc98710c3aed5c655e3193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cd79228e00d29c95e86af08b60844b09681f1a2c31ed689ed9076cced7a807df8a443d358b670856023f0ff182d11380cd8b7845106aeba9355c252df525e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816be743dabbbd6c8ad1bd57d2a727b5df7c684a1e78de639351ac8fd0c9e3cbc9f0469cde25c098773f93d03e13c5c8ed64418eda51b364592f9a6d607bbf0b"} 04:49:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:49:24 INFO - Copying logs to upload dir... 04:49:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:49:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.312847 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-28 04:49:23.984289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:23.987483) ========= 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=db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c579b56e57047558e145cdc3ed4663945140d39f26662583df29c7d3d922d2786b71348d32cfccff615059e4a7febca487e0bee6bc98710c3aed5c655e3193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cd79228e00d29c95e86af08b60844b09681f1a2c31ed689ed9076cced7a807df8a443d358b670856023f0ff182d11380cd8b7845106aeba9355c252df525e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816be743dabbbd6c8ad1bd57d2a727b5df7c684a1e78de639351ac8fd0c9e3cbc9f0469cde25c098773f93d03e13c5c8ed64418eda51b364592f9a6d607bbf0b"} build_url:https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/VFVviIdwSaeJUZHf1nglkw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4c579b56e57047558e145cdc3ed4663945140d39f26662583df29c7d3d922d2786b71348d32cfccff615059e4a7febca487e0bee6bc98710c3aed5c655e3193f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7cd79228e00d29c95e86af08b60844b09681f1a2c31ed689ed9076cced7a807df8a443d358b670856023f0ff182d11380cd8b7845106aeba9355c252df525e2d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816be743dabbbd6c8ad1bd57d2a727b5df7c684a1e78de639351ac8fd0c9e3cbc9f0469cde25c098773f93d03e13c5c8ed64418eda51b364592f9a6d607bbf0b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:24.013543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:24.013909) ========= 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=db0483c52d987ecb441a263b000001ad-1467113331.560792-442932055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:24.099602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:49:24.099963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:49:24.100318) ========= ========= Total master_lag: 0.18 =========