builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1468503301.0 results: success (0) buildid: 20160714034243 builduid: f3f14e78405846c8b1ad1ed7c65026fc revision: 8c83d8aaa9c0f6fa7216c264db831be36d2b82c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.000866) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.001333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.002038) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.018598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.018956) ========= 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=db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 06:35:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-07-14 06:35:01 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.115531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.115809) ========= 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=db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013670 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:01.166247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:35:01.166601) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8c83d8aaa9c0f6fa7216c264db831be36d2b82c2 --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 8c83d8aaa9c0f6fa7216c264db831be36d2b82c2 --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=db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 06:35:01,366 truncating revision to first 12 chars 2016-07-14 06:35:01,366 Setting DEBUG logging. 2016-07-14 06:35:01,366 attempt 1/10 2016-07-14 06:35:01,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8c83d8aaa9c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:35:02,312 unpacking tar archive at: mozilla-aurora-8c83d8aaa9c0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.293665 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:35:02.474159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:02.474540) ========= script_repo_revision: 8c83d8aaa9c0f6fa7216c264db831be36d2b82c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:02.474988) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:02.475264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:35:02.485729) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-14 06:35:02.486149) ========= /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=db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:35:02 INFO - MultiFileLogger online at 20160714 06:35:02 in /builds/slave/test 06:35:02 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 06:35:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:35:02 INFO - {'append_to_log': False, 06:35:02 INFO - 'base_work_dir': '/builds/slave/test', 06:35:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 06:35:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:35:02 INFO - 'branch': 'Mozilla-Aurora', 06:35:02 INFO - 'buildbot_json_path': 'buildprops.json', 06:35:02 INFO - 'config_files': ('talos/linux_config.py',), 06:35:02 INFO - 'default_actions': ('clobber', 06:35:02 INFO - 'read-buildbot-config', 06:35:02 INFO - 'download-and-extract', 06:35:02 INFO - 'populate-webroot', 06:35:02 INFO - 'create-virtualenv', 06:35:02 INFO - 'install', 06:35:02 INFO - 'run-tests'), 06:35:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:35:02 INFO - 'download_minidump_stackwalk': True, 06:35:02 INFO - 'download_symbols': 'ondemand', 06:35:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:35:02 INFO - 'tooltool.py': '/tools/tooltool.py', 06:35:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:35:02 INFO - '/tools/misc-python/virtualenv.py')}, 06:35:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:35:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:35:02 INFO - 'installer_path': 'installer.exe', 06:35:02 INFO - 'log_level': 'info', 06:35:02 INFO - 'log_name': 'talos', 06:35:02 INFO - 'log_to_console': True, 06:35:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:35:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:35:02 INFO - 'opt_config_files': (), 06:35:02 INFO - 'pip_index': False, 06:35:02 INFO - 'sps_profile': False, 06:35:02 INFO - 'sps_profile_interval': 0, 06:35:02 INFO - 'suite': 'dromaeojs-e10s', 06:35:02 INFO - 'system_bits': '32', 06:35:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:35:02 INFO - 'title': 'talos-linux64-ix-049', 06:35:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:35:02 INFO - 'use_talos_json': True, 06:35:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:35:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:35:02 INFO - 'work_dir': 'build'} 06:35:02 INFO - ##### 06:35:02 INFO - ##### Running clobber step. 06:35:02 INFO - ##### 06:35:02 INFO - Running pre-action listener: _resource_record_pre_action 06:35:02 INFO - Running main action method: clobber 06:35:02 INFO - rmtree: /builds/slave/test/build 06:35:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:35:03 INFO - Running post-action listener: _resource_record_post_action 06:35:03 INFO - ##### 06:35:03 INFO - ##### Finished clobber step (success) 06:35:03 INFO - ##### 06:35:03 INFO - ##### 06:35:03 INFO - ##### Running read-buildbot-config step. 06:35:03 INFO - ##### 06:35:03 INFO - Running pre-action listener: _resource_record_pre_action 06:35:03 INFO - Running main action method: read_buildbot_config 06:35:03 INFO - Using buildbot properties: 06:35:03 INFO - { 06:35:03 INFO - "project": "", 06:35:03 INFO - "product": "firefox", 06:35:03 INFO - "script_repo_revision": "production", 06:35:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 06:35:03 INFO - "repository": "", 06:35:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 06:35:03 INFO - "buildid": "20160714034243", 06:35:03 INFO - "pgo_build": "True", 06:35:03 INFO - "basedir": "/builds/slave/test", 06:35:03 INFO - "buildnumber": 421, 06:35:03 INFO - "slavename": "talos-linux64-ix-049", 06:35:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:35:03 INFO - "platform": "ubuntu64_hw", 06:35:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 06:35:03 INFO - "branch": "mozilla-aurora", 06:35:03 INFO - "repo_path": "releases/mozilla-aurora", 06:35:03 INFO - "revision": "8c83d8aaa9c0f6fa7216c264db831be36d2b82c2", 06:35:03 INFO - "stage_platform": "linux64-pgo", 06:35:03 INFO - "builduid": "f3f14e78405846c8b1ad1ed7c65026fc", 06:35:03 INFO - "slavebuilddir": "test" 06:35:03 INFO - } 06:35:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 06:35:03 INFO - Running post-action listener: _resource_record_post_action 06:35:03 INFO - ##### 06:35:03 INFO - ##### Finished read-buildbot-config step (success) 06:35:03 INFO - ##### 06:35:03 INFO - ##### 06:35:03 INFO - ##### Running download-and-extract step. 06:35:03 INFO - ##### 06:35:03 INFO - Running pre-action listener: _resource_record_pre_action 06:35:03 INFO - Running main action method: download_and_extract 06:35:03 INFO - mkdir: /builds/slave/test/build/tests 06:35:03 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')]} 06:35:03 INFO - https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:35:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:35:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:35:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:05 INFO - Downloaded 1361 bytes. 06:35:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 06:35:05 INFO - Using the following test package requirements: 06:35:05 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:35:05 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 06:35:05 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 06:35:05 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'jsshell-linux-x86_64.zip'], 06:35:05 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 06:35:05 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 06:35:05 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 06:35:05 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 06:35:05 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 06:35:05 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 06:35:05 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 06:35:05 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:35:05 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')]} 06:35:05 INFO - https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:35:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:35:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:07 INFO - Downloaded 24490845 bytes. 06:35:07 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'] 06:35:07 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 06:35:08 INFO - Return code: 0 06:35:08 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 06:35: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')]} 06:35:08 INFO - https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:35:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:35:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 06:35:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:10 INFO - Downloaded 24490845 bytes. 06:35:10 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'] 06:35:10 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 06:35:11 INFO - Return code: 0 06:35: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')]} 06:35:11 INFO - https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:35:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:35:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 06:35:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:12 INFO - Downloaded 10833369 bytes. 06:35:12 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'] 06:35:12 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 06:35:12 INFO - Return code: 0 06:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:12 INFO - https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:35:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:35:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:35:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X4Xk-JlqSGWS2APglzQPXg/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 06:35:14 INFO - Downloaded 63642276 bytes. 06:35:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:35:14 INFO - mkdir: /builds/slave/test/properties 06:35:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:14 INFO - Contents: 06:35:14 INFO - build_url:https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 06:35:15 INFO - Running post-action listener: _resource_record_post_action 06:35:15 INFO - Running post-action listener: set_extra_try_arguments 06:35:15 INFO - ##### 06:35:15 INFO - ##### Finished download-and-extract step (success) 06:35:15 INFO - ##### 06:35:15 INFO - ##### 06:35:15 INFO - ##### Running populate-webroot step. 06:35:15 INFO - ##### 06:35:15 INFO - Running pre-action listener: _resource_record_pre_action 06:35:15 INFO - Running main action method: populate_webroot 06:35:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:15 INFO - '--tppagecycles', 06:35:15 INFO - '7'], 06:35:15 INFO - 'tests': ['tsvgm']}}, 06:35:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:35:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:35:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:35:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['damp', 'tps']}, 06:35:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'tests': ['damp', 'tps']}, 06:35:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['dromaeo_dom']}, 06:35:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['a11yr', 06:35:15 INFO - 'ts_paint', 06:35:15 INFO - 'tpaint', 06:35:15 INFO - 'sessionrestore', 06:35:15 INFO - 'sessionrestore_no_auto_restore', 06:35:15 INFO - 'tabpaint']}, 06:35:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:35:15 INFO - 'ts_paint', 06:35:15 INFO - 'tpaint', 06:35:15 INFO - 'sessionrestore', 06:35:15 INFO - 'sessionrestore_no_auto_restore', 06:35:15 INFO - 'tabpaint']}, 06:35:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:35:15 INFO - 'ts_paint', 06:35:15 INFO - 'tpaint', 06:35:15 INFO - 'sessionrestore', 06:35:15 INFO - 'sessionrestore_no_auto_restore', 06:35:15 INFO - 'tabpaint']}, 06:35:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:35:15 INFO - 'ts_paint', 06:35:15 INFO - 'tpaint', 06:35:15 INFO - 'sessionrestore', 06:35:15 INFO - 'sessionrestore_no_auto_restore', 06:35:15 INFO - 'tabpaint']}, 06:35:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['a11yr', 06:35:15 INFO - 'ts_paint', 06:35:15 INFO - 'tpaint', 06:35:15 INFO - 'sessionrestore', 06:35:15 INFO - 'sessionrestore_no_auto_restore', 06:35:15 INFO - 'tabpaint']}, 06:35:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['a11yr', 06:35:15 INFO - 'ts_paint', 06:35:15 INFO - 'tpaint', 06:35:15 INFO - 'sessionrestore', 06:35:15 INFO - 'sessionrestore_no_auto_restore', 06:35:15 INFO - 'tabpaint']}, 06:35:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['tsvgx', 06:35:15 INFO - 'tsvgr_opacity', 06:35:15 INFO - 'tart', 06:35:15 INFO - 'tscrollx', 06:35:15 INFO - 'cart']}, 06:35:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:35:15 INFO - 'tsvgr_opacity', 06:35:15 INFO - 'tart', 06:35:15 INFO - 'tscrollx', 06:35:15 INFO - 'cart']}, 06:35:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'talos_options': ['--disable-e10s'], 06:35:15 INFO - 'tests': ['tp5o']}, 06:35:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'tests': ['tp5o']}, 06:35:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'talos_options': ['--disable-e10s', 06:35:15 INFO - '--xperf_path', 06:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:15 INFO - 'tests': ['tp5n']}, 06:35:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:35:15 INFO - 'talos_options': ['--xperf_path', 06:35:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:15 INFO - 'tests': ['tp5n']}}, 06:35:15 INFO - 'talos.zip': {'path': '', 06:35:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:15 INFO - Running post-action listener: _resource_record_post_action 06:35:15 INFO - ##### 06:35:15 INFO - ##### Finished populate-webroot step (success) 06:35:15 INFO - ##### 06:35:15 INFO - ##### 06:35:15 INFO - ##### Running create-virtualenv step. 06:35:15 INFO - ##### 06:35:15 INFO - Running pre-action listener: _resource_record_pre_action 06:35:15 INFO - Running main action method: create_virtualenv 06:35:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:15 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 06:35:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:15 INFO - Using real prefix '/usr' 06:35:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:17 INFO - Installing pip.................done. 06:35:17 INFO - Return code: 0 06:35:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:35:17 INFO - Using env: {'DISPLAY': ':0', 06:35:17 INFO - 'HOME': '/home/cltbld', 06:35:17 INFO - 'LANG': 'en_US.UTF-8', 06:35:17 INFO - 'LANGUAGE': 'en_US:en', 06:35:17 INFO - 'LOGNAME': 'cltbld', 06:35:17 INFO - 'MAIL': '/var/mail/cltbld', 06:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:17 INFO - 'MOZ_NO_REMOTE': '1', 06:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:17 INFO - 'NO_EM_RESTART': '1', 06:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:17 INFO - 'PWD': '/builds/slave/test', 06:35:17 INFO - 'SHELL': '/bin/bash', 06:35:17 INFO - 'SHLVL': '1', 06:35:17 INFO - 'TERM': 'linux', 06:35:17 INFO - 'TMOUT': '86400', 06:35:17 INFO - 'USER': 'cltbld', 06:35:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:17 INFO - '_': '/tools/buildbot/bin/python'} 06:35:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:17 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 06:35:17 INFO - Cleaning up... 06:35:17 INFO - Return code: 0 06:35:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:35:17 INFO - Using env: {'DISPLAY': ':0', 06:35:17 INFO - 'HOME': '/home/cltbld', 06:35:17 INFO - 'LANG': 'en_US.UTF-8', 06:35:17 INFO - 'LANGUAGE': 'en_US:en', 06:35:17 INFO - 'LOGNAME': 'cltbld', 06:35:17 INFO - 'MAIL': '/var/mail/cltbld', 06:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:17 INFO - 'MOZ_NO_REMOTE': '1', 06:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:17 INFO - 'NO_EM_RESTART': '1', 06:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:17 INFO - 'PWD': '/builds/slave/test', 06:35:17 INFO - 'SHELL': '/bin/bash', 06:35:17 INFO - 'SHLVL': '1', 06:35:17 INFO - 'TERM': 'linux', 06:35:17 INFO - 'TMOUT': '86400', 06:35:17 INFO - 'USER': 'cltbld', 06:35:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:17 INFO - '_': '/tools/buildbot/bin/python'} 06:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:18 INFO - Downloading/unpacking psutil>=3.1.1 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:20 INFO - Installing collected packages: psutil 06:35:20 INFO - Running setup.py install for psutil 06:35:20 INFO - building 'psutil._psutil_linux' extension 06:35:20 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 06:35:20 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 06:35:20 INFO - building 'psutil._psutil_posix' extension 06:35:20 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 06:35:20 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 06:35:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:20 INFO - Successfully installed psutil 06:35:20 INFO - Cleaning up... 06:35:20 INFO - Return code: 0 06:35:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:20 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:20 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 06:35:20 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 06:35:20 INFO - Using env: {'DISPLAY': ':0', 06:35:20 INFO - 'HOME': '/home/cltbld', 06:35:20 INFO - 'LANG': 'en_US.UTF-8', 06:35:20 INFO - 'LANGUAGE': 'en_US:en', 06:35:20 INFO - 'LOGNAME': 'cltbld', 06:35:20 INFO - 'MAIL': '/var/mail/cltbld', 06:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:20 INFO - 'MOZ_NO_REMOTE': '1', 06:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:20 INFO - 'NO_EM_RESTART': '1', 06:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:20 INFO - 'PWD': '/builds/slave/test', 06:35:20 INFO - 'SHELL': '/bin/bash', 06:35:20 INFO - 'SHLVL': '1', 06:35:20 INFO - 'TERM': 'linux', 06:35:20 INFO - 'TMOUT': '86400', 06:35:20 INFO - 'USER': 'cltbld', 06:35:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:20 INFO - '_': '/tools/buildbot/bin/python'} 06:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:35:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:35:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:35:22 INFO - Installing collected packages: mozsystemmonitor 06:35:22 INFO - Running setup.py install for mozsystemmonitor 06:35:22 INFO - Successfully installed mozsystemmonitor 06:35:22 INFO - Cleaning up... 06:35:23 INFO - Return code: 0 06:35:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:35:23 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')]} 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:23 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')]} 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:23 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:23 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 06:35:23 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 06:35:23 INFO - Using env: {'DISPLAY': ':0', 06:35:23 INFO - 'HOME': '/home/cltbld', 06:35:23 INFO - 'LANG': 'en_US.UTF-8', 06:35:23 INFO - 'LANGUAGE': 'en_US:en', 06:35:23 INFO - 'LOGNAME': 'cltbld', 06:35:23 INFO - 'MAIL': '/var/mail/cltbld', 06:35:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:23 INFO - 'MOZ_NO_REMOTE': '1', 06:35:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:23 INFO - 'NO_EM_RESTART': '1', 06:35:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:23 INFO - 'PWD': '/builds/slave/test', 06:35:23 INFO - 'SHELL': '/bin/bash', 06:35:23 INFO - 'SHLVL': '1', 06:35:23 INFO - 'TERM': 'linux', 06:35:23 INFO - 'TMOUT': '86400', 06:35:23 INFO - 'USER': 'cltbld', 06:35:23 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:23 INFO - '_': '/tools/buildbot/bin/python'} 06:35:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:23 INFO - Downloading/unpacking jsonschema==2.5.1 06:35:23 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 06:35:23 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 06:35:23 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 06:35:23 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 06:35:23 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 06:35:23 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 06:35:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:35:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:25 INFO - Downloading functools32-3.2.3-2.tar.gz 06:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:35:25 INFO - warning: no files found matching '*.txt' 06:35:25 INFO - no previously-included directories found matching 'build' 06:35:25 INFO - no previously-included directories found matching 'dist' 06:35:25 INFO - no previously-included directories found matching '.git*' 06:35:25 INFO - Installing collected packages: jsonschema, functools32 06:35:25 INFO - Running setup.py install for functools32 06:35:25 INFO - warning: no files found matching '*.txt' 06:35:25 INFO - no previously-included directories found matching 'build' 06:35:25 INFO - no previously-included directories found matching 'dist' 06:35:25 INFO - no previously-included directories found matching '.git*' 06:35:25 INFO - Successfully installed jsonschema functools32 06:35:25 INFO - Cleaning up... 06:35:25 INFO - Return code: 0 06:35:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:35:25 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')]} 06:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:25 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')]} 06:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:25 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:25 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 06:35:25 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 06:35:25 INFO - Using env: {'DISPLAY': ':0', 06:35:25 INFO - 'HOME': '/home/cltbld', 06:35:25 INFO - 'LANG': 'en_US.UTF-8', 06:35:25 INFO - 'LANGUAGE': 'en_US:en', 06:35:25 INFO - 'LOGNAME': 'cltbld', 06:35:25 INFO - 'MAIL': '/var/mail/cltbld', 06:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:25 INFO - 'MOZ_NO_REMOTE': '1', 06:35:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:25 INFO - 'NO_EM_RESTART': '1', 06:35:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:25 INFO - 'PWD': '/builds/slave/test', 06:35:25 INFO - 'SHELL': '/bin/bash', 06:35:25 INFO - 'SHLVL': '1', 06:35:25 INFO - 'TERM': 'linux', 06:35:25 INFO - 'TMOUT': '86400', 06:35:25 INFO - 'USER': 'cltbld', 06:35:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:25 INFO - '_': '/tools/buildbot/bin/python'} 06:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:25 INFO - Downloading/unpacking blobuploader==1.2.4 06:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:27 INFO - Downloading blobuploader-1.2.4.tar.gz 06:35:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:35:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35: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 06:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:35:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:28 INFO - Downloading docopt-0.6.1.tar.gz 06:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:35:28 INFO - Installing collected packages: blobuploader, requests, docopt 06:35:28 INFO - Running setup.py install for blobuploader 06:35:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:35:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:35:28 INFO - Running setup.py install for requests 06:35:29 INFO - Running setup.py install for docopt 06:35:29 INFO - Successfully installed blobuploader requests docopt 06:35:29 INFO - Cleaning up... 06:35:29 INFO - Return code: 0 06:35:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:29 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')]} 06:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:29 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')]} 06:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:29 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:29 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 06:35:29 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 06:35:29 INFO - Using env: {'DISPLAY': ':0', 06:35:29 INFO - 'HOME': '/home/cltbld', 06:35:29 INFO - 'LANG': 'en_US.UTF-8', 06:35:29 INFO - 'LANGUAGE': 'en_US:en', 06:35:29 INFO - 'LOGNAME': 'cltbld', 06:35:29 INFO - 'MAIL': '/var/mail/cltbld', 06:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:29 INFO - 'MOZ_NO_REMOTE': '1', 06:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:29 INFO - 'NO_EM_RESTART': '1', 06:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:29 INFO - 'PWD': '/builds/slave/test', 06:35:29 INFO - 'SHELL': '/bin/bash', 06:35:29 INFO - 'SHLVL': '1', 06:35:29 INFO - 'TERM': 'linux', 06:35:29 INFO - 'TMOUT': '86400', 06:35:29 INFO - 'USER': 'cltbld', 06:35:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:29 INFO - '_': '/tools/buildbot/bin/python'} 06:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:29 INFO - Running setup.py (path:/tmp/pip-_uEEXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:29 INFO - Running setup.py (path:/tmp/pip-1VyCrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:29 INFO - Running setup.py (path:/tmp/pip-vmjiL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:29 INFO - Running setup.py (path:/tmp/pip-pGJYTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:29 INFO - Running setup.py (path:/tmp/pip-elN25n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:29 INFO - Running setup.py (path:/tmp/pip-mG4sAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:29 INFO - Running setup.py (path:/tmp/pip-09JHPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:29 INFO - Running setup.py (path:/tmp/pip-Vj0P4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:30 INFO - Running setup.py (path:/tmp/pip-8qhTEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:30 INFO - Running setup.py (path:/tmp/pip-JbfOfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:30 INFO - Running setup.py (path:/tmp/pip-4reiLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:30 INFO - Running setup.py (path:/tmp/pip-LWdlKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:30 INFO - Running setup.py (path:/tmp/pip-LsoQuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:30 INFO - Running setup.py (path:/tmp/pip-sbZpNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:30 INFO - Running setup.py (path:/tmp/pip-FCyL8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:30 INFO - Running setup.py (path:/tmp/pip-N_K7n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:30 INFO - Running setup.py (path:/tmp/pip-krHZUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:35:30 INFO - Running setup.py install for manifestparser 06:35:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:35:30 INFO - Running setup.py install for mozcrash 06:35:30 INFO - Running setup.py install for mozdebug 06:35:31 INFO - Running setup.py install for mozdevice 06:35:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Running setup.py install for mozfile 06:35:31 INFO - Running setup.py install for mozhttpd 06:35:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Running setup.py install for mozinfo 06:35:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Running setup.py install for mozInstall 06:35:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Running setup.py install for mozleak 06:35:31 INFO - Running setup.py install for mozlog 06:35:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Running setup.py install for moznetwork 06:35:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:35:31 INFO - Running setup.py install for mozprocess 06:35:31 INFO - Running setup.py install for mozprofile 06:35:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:35:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:35:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:35:32 INFO - Running setup.py install for mozrunner 06:35:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:35:32 INFO - Running setup.py install for mozscreenshot 06:35:32 INFO - Running setup.py install for moztest 06:35:32 INFO - Running setup.py install for mozversion 06:35:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:35:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:35:32 INFO - Cleaning up... 06:35:32 INFO - Return code: 0 06:35:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:32 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')]} 06:35:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:32 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')]} 06:35:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:32 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:32 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 06:35:32 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 06:35:32 INFO - Using env: {'DISPLAY': ':0', 06:35:32 INFO - 'HOME': '/home/cltbld', 06:35:32 INFO - 'LANG': 'en_US.UTF-8', 06:35:32 INFO - 'LANGUAGE': 'en_US:en', 06:35:32 INFO - 'LOGNAME': 'cltbld', 06:35:32 INFO - 'MAIL': '/var/mail/cltbld', 06:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:32 INFO - 'MOZ_NO_REMOTE': '1', 06:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:32 INFO - 'NO_EM_RESTART': '1', 06:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:32 INFO - 'PWD': '/builds/slave/test', 06:35:32 INFO - 'SHELL': '/bin/bash', 06:35:32 INFO - 'SHLVL': '1', 06:35:32 INFO - 'TERM': 'linux', 06:35:32 INFO - 'TMOUT': '86400', 06:35:32 INFO - 'USER': 'cltbld', 06:35:32 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:32 INFO - '_': '/tools/buildbot/bin/python'} 06:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:32 INFO - Running setup.py (path:/tmp/pip-6J44h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:32 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)) 06:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:32 INFO - Running setup.py (path:/tmp/pip-4Ts3Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:32 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)) 06:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:32 INFO - Running setup.py (path:/tmp/pip-53s9jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:32 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)) 06:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:32 INFO - Running setup.py (path:/tmp/pip-OtO2tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:33 INFO - Running setup.py (path:/tmp/pip-xr1Qjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:33 INFO - Running setup.py (path:/tmp/pip-hMQSvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:33 INFO - Running setup.py (path:/tmp/pip-LHhwBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:33 INFO - Running setup.py (path:/tmp/pip-MpAug4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:33 INFO - Running setup.py (path:/tmp/pip-XnEQrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:33 INFO - Running setup.py (path:/tmp/pip-GqFvZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:33 INFO - Running setup.py (path:/tmp/pip-kq9sxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:33 INFO - Running setup.py (path:/tmp/pip-CjlcKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:33 INFO - Running setup.py (path:/tmp/pip-X63fJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:33 INFO - Running setup.py (path:/tmp/pip-mcXTC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:33 INFO - Running setup.py (path:/tmp/pip-9Bcxw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:33 INFO - Running setup.py (path:/tmp/pip-vcimg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:33 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)) 06:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:33 INFO - Running setup.py (path:/tmp/pip-goxP6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:34 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)) 06:35:34 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)) 06:35:34 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)) 06:35:34 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)) 06:35:34 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)) 06:35:34 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)) 06:35:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:35:34 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 06:35:34 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 06:35:34 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 06:35:34 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 06:35:34 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 06:35:34 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 06:35:35 INFO - Downloading blessings-1.6.tar.gz 06:35:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:35:36 INFO - Installing collected packages: blessings 06:35:36 INFO - Running setup.py install for blessings 06:35:36 INFO - Successfully installed blessings 06:35:36 INFO - Cleaning up... 06:35:36 INFO - Return code: 0 06:35:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:35:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:36 INFO - Reading from file tmpfile_stdout 06:35:36 INFO - Current package versions: 06:35:36 INFO - argparse == 1.2.1 06:35:36 INFO - blessings == 1.6 06:35:36 INFO - blobuploader == 1.2.4 06:35:36 INFO - docopt == 0.6.1 06:35:36 INFO - functools32 == 3.2.3-2 06:35:36 INFO - jsonschema == 2.5.1 06:35:36 INFO - manifestparser == 1.1 06:35:36 INFO - mozInstall == 1.12 06:35:36 INFO - mozcrash == 0.17 06:35:36 INFO - mozdebug == 0.1 06:35:36 INFO - mozdevice == 0.48 06:35:36 INFO - mozfile == 1.2 06:35:36 INFO - mozhttpd == 0.7 06:35:36 INFO - mozinfo == 0.9 06:35:36 INFO - mozleak == 0.1 06:35:36 INFO - mozlog == 3.2 06:35:36 INFO - moznetwork == 0.27 06:35:36 INFO - mozprocess == 0.23 06:35:36 INFO - mozprofile == 0.28 06:35:36 INFO - mozrunner == 6.12 06:35:36 INFO - mozscreenshot == 0.1 06:35:36 INFO - mozsystemmonitor == 0.3 06:35:36 INFO - moztest == 0.7 06:35:36 INFO - mozversion == 1.4 06:35:36 INFO - psutil == 3.1.1 06:35:36 INFO - requests == 1.2.3 06:35:36 INFO - wsgiref == 0.1.2 06:35:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:36 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:36 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 06:35:36 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 06:35:36 INFO - Using env: {'DISPLAY': ':0', 06:35:36 INFO - 'HOME': '/home/cltbld', 06:35:36 INFO - 'LANG': 'en_US.UTF-8', 06:35:36 INFO - 'LANGUAGE': 'en_US:en', 06:35:36 INFO - 'LOGNAME': 'cltbld', 06:35:36 INFO - 'MAIL': '/var/mail/cltbld', 06:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:36 INFO - 'MOZ_NO_REMOTE': '1', 06:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:36 INFO - 'NO_EM_RESTART': '1', 06:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:36 INFO - 'PWD': '/builds/slave/test', 06:35:36 INFO - 'SHELL': '/bin/bash', 06:35:36 INFO - 'SHLVL': '1', 06:35:36 INFO - 'TERM': 'linux', 06:35:36 INFO - 'TMOUT': '86400', 06:35:36 INFO - 'USER': 'cltbld', 06:35:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:36 INFO - '_': '/tools/buildbot/bin/python'} 06:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 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)) 06:35:36 INFO - Cleaning up... 06:35:36 INFO - Return code: 0 06:35:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:36 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:36 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 06:35:36 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 06:35:36 INFO - Using env: {'DISPLAY': ':0', 06:35:36 INFO - 'HOME': '/home/cltbld', 06:35:36 INFO - 'LANG': 'en_US.UTF-8', 06:35:36 INFO - 'LANGUAGE': 'en_US:en', 06:35:36 INFO - 'LOGNAME': 'cltbld', 06:35:36 INFO - 'MAIL': '/var/mail/cltbld', 06:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:36 INFO - 'MOZ_NO_REMOTE': '1', 06:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:36 INFO - 'NO_EM_RESTART': '1', 06:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:36 INFO - 'PWD': '/builds/slave/test', 06:35:36 INFO - 'SHELL': '/bin/bash', 06:35:36 INFO - 'SHLVL': '1', 06:35:36 INFO - 'TERM': 'linux', 06:35:36 INFO - 'TMOUT': '86400', 06:35:36 INFO - 'USER': 'cltbld', 06:35:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:36 INFO - '_': '/tools/buildbot/bin/python'} 06:35:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:35:36 INFO - Cleaning up... 06:35:36 INFO - Return code: 0 06:35:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:35:36 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 0x7fbe17e5af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1971350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, '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': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', '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 06:35:36 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 06:35:36 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 06:35:36 INFO - Using env: {'DISPLAY': ':0', 06:35:36 INFO - 'HOME': '/home/cltbld', 06:35:36 INFO - 'LANG': 'en_US.UTF-8', 06:35:36 INFO - 'LANGUAGE': 'en_US:en', 06:35:36 INFO - 'LOGNAME': 'cltbld', 06:35:36 INFO - 'MAIL': '/var/mail/cltbld', 06:35:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:36 INFO - 'MOZ_NO_REMOTE': '1', 06:35:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:36 INFO - 'NO_EM_RESTART': '1', 06:35:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:36 INFO - 'PWD': '/builds/slave/test', 06:35:36 INFO - 'SHELL': '/bin/bash', 06:35:36 INFO - 'SHLVL': '1', 06:35:36 INFO - 'TERM': 'linux', 06:35:36 INFO - 'TMOUT': '86400', 06:35:36 INFO - 'USER': 'cltbld', 06:35:36 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:36 INFO - '_': '/tools/buildbot/bin/python'} 06:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:37 INFO - Downloading/unpacking flake8 06:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:35:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:35:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 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 06:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:35:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:35:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:35:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:35:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:35:39 INFO - no previously-included directories found matching 'docs/_build' 06:35:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:35:39 INFO - Running setup.py install for pep8 06:35:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:35:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:35:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:35:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:35:39 INFO - no previously-included directories found matching 'docs/_build' 06:35:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:35:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:35:39 INFO - Cleaning up... 06:35:40 INFO - Return code: 0 06:35:40 INFO - Running post-action listener: _resource_record_post_action 06:35:40 INFO - Running post-action listener: _start_resource_monitoring 06:35:40 INFO - Starting resource monitoring. 06:35:40 INFO - ##### 06:35:40 INFO - ##### Finished create-virtualenv step (success) 06:35:40 INFO - ##### 06:35:40 INFO - ##### 06:35:40 INFO - ##### Running install step. 06:35:40 INFO - ##### 06:35:40 INFO - Running pre-action listener: _resource_record_pre_action 06:35:40 INFO - Running main action method: install 06:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:40 INFO - Reading from file tmpfile_stdout 06:35:40 INFO - Detecting whether we're running mozinstall >=1.0... 06:35:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:35:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:35:40 INFO - Reading from file tmpfile_stdout 06:35:40 INFO - Output received: 06:35:40 INFO - Usage: mozinstall [options] installer 06:35:40 INFO - Options: 06:35:40 INFO - -h, --help show this help message and exit 06:35:40 INFO - -d DEST, --destination=DEST 06:35:40 INFO - Directory to install application into. [default: 06:35:40 INFO - "/builds/slave/test"] 06:35:40 INFO - --app=APP Application being installed. [default: firefox] 06:35:40 INFO - mkdir: /builds/slave/test/build/application 06:35:40 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'] 06:35:40 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 06:35:56 INFO - Reading from file tmpfile_stdout 06:35:56 INFO - Output received: 06:35:56 INFO - /builds/slave/test/build/application/firefox/firefox 06:35:56 INFO - Running post-action listener: _resource_record_post_action 06:35:56 INFO - ##### 06:35:56 INFO - ##### Finished install step (success) 06:35:56 INFO - ##### 06:35:56 INFO - ##### 06:35:56 INFO - ##### Running run-tests step. 06:35:56 INFO - ##### 06:35:56 INFO - Running pre-action listener: _resource_record_pre_action 06:35:56 INFO - Running main action method: run_tests 06:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:35:56 INFO - Python 2.7.3 06:35:56 INFO - Return code: 0 06:35:56 INFO - grabbing minidump binary from tooltool 06:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:35:56 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 0x1a001c0>, '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 0x1a010c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a01550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:35:56 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 06:35:56 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 06:35:56 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 06:35:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:35:56 INFO - Return code: 0 06:35:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:35:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:35:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:35:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:35:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:35:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:35:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:35:57 INFO - Return code: 0 06:35:57 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/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 06:35:57 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/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 06:35:57 INFO - Using env: {'DISPLAY': ':0', 06:35:57 INFO - 'HOME': '/home/cltbld', 06:35:57 INFO - 'LANG': 'en_US.UTF-8', 06:35:57 INFO - 'LANGUAGE': 'en_US:en', 06:35:57 INFO - 'LOGNAME': 'cltbld', 06:35:57 INFO - 'MAIL': '/var/mail/cltbld', 06:35:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:35:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:57 INFO - 'MOZ_NO_REMOTE': '1', 06:35:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:35:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:57 INFO - 'NO_EM_RESTART': '1', 06:35:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:57 INFO - 'PWD': '/builds/slave/test', 06:35:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:35:57 INFO - 'SHELL': '/bin/bash', 06:35:57 INFO - 'SHLVL': '1', 06:35:57 INFO - 'TERM': 'linux', 06:35:57 INFO - 'TMOUT': '86400', 06:35:57 INFO - 'USER': 'cltbld', 06:35:57 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845', 06:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:57 INFO - '_': '/tools/buildbot/bin/python'} 06:35:57 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/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 06:35:57 INFO - mozversion application_buildid: 20160714034243 06:35:57 INFO - mozversion application_changeset: 8c83d8aaa9c0f6fa7216c264db831be36d2b82c2 06:35:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:35:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:35:57 INFO - mozversion application_name: Firefox 06:35:57 INFO - mozversion application_remotingname: firefox-dev 06:35:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:35:57 INFO - mozversion application_vendor: Mozilla 06:35:57 INFO - mozversion application_version: 49.0a2 06:35:57 INFO - mozversion platform_buildid: 20160714034243 06:35:57 INFO - mozversion platform_changeset: 8c83d8aaa9c0f6fa7216c264db831be36d2b82c2 06:35:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:35:57 INFO - mozversion platform_version: 49.0a2 06:35:57 INFO - using testdate: 1468503357 06:35:57 INFO - actual date: 1468503357 06:35:57 INFO - starting webserver on 'localhost:42465' 06:35:57 INFO - SUITE-START | Running 2 tests 06:35:57 INFO - TEST-START | dromaeo_css 06:35:57 INFO - operating with platform_type : linux_ 06:35:57 INFO - Initialising browser for dromaeo_css test... 06:35:57 INFO - TEST-INFO | started process 14149 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwPROTI/profile http://localhost:42465/getInfo.html) 06:36:01 INFO - PROCESS | 14149 | __metrics Screen width/height:1600/1200 06:36:01 INFO - PROCESS | 14149 | colorDepth:24 06:36:01 INFO - PROCESS | 14149 | Browser inner width/height: 1024/697 06:36:01 INFO - PROCESS | 14149 | __metrics 06:36:02 ERROR - PROCESS | 14149 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:36:03 INFO - TEST-INFO | 14149: exit 0 06:36:03 INFO - Browser initialized. 06:36:03 INFO - Running cycle 1/1 for dromaeo_css test... 06:36:03 INFO - TEST-INFO | started process 14277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwPROTI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:15 INFO - PROCESS | 14277 | RSS: Main: 155668480 06:36:15 INFO - PROCESS | 14277 | 06:37:04 INFO - PROCESS | 14277 | 1468503424952 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] 06:39:12 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:42465/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42465/tests/dromaeo/cssquery-ext.html) 06:39:14 INFO - PROCESS | 14277 | RSS: Main: 159604736 06:39:14 INFO - PROCESS | 14277 | 06:42:16 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:42465/tests/dromaeo/cssquery-ext.html (next: http://localhost:42465/tests/dromaeo/cssquery-jquery.html) 06:42:16 INFO - PROCESS | 14277 | RSS: Main: 157188096 06:42:16 INFO - PROCESS | 14277 | 06:45:18 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:42465/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42465/tests/dromaeo/cssquery-mootools.html) 06:45:19 INFO - PROCESS | 14277 | RSS: Main: 157655040 06:45:19 INFO - PROCESS | 14277 | 06:48:20 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:42465/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42465/tests/dromaeo/cssquery-prototype.html) 06:48:21 INFO - PROCESS | 14277 | RSS: Main: 156319744 06:48:21 INFO - PROCESS | 14277 | 06:51:23 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:42465/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42465/tests/dromaeo/cssquery-yui.html) 06:51:24 INFO - PROCESS | 14277 | RSS: Main: 158326784 06:51:24 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | Cycle 1(1): loaded http://localhost:42465/tests/dromaeo/cssquery-yui.html (next: http://localhost:42465/tests/dromaeo/cssquery-dojo.html) 06:54:26 INFO - PROCESS | 14277 | RSS: Main: 158969856 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | __start_tp_report 06:54:26 INFO - PROCESS | 14277 | _x_x_mozilla_page_load 06:54:26 INFO - PROCESS | 14277 | _x_x_mozilla_page_load_details 06:54:26 INFO - PROCESS | 14277 | |i|pagename|runs| 06:54:26 INFO - PROCESS | 14277 | |0;dojo.html;3412.4881267809824;3424.178197232665;3442.431998720211;3444.7588668793187;3454.775439596426;5635;5671.206031155636;5712.314522257325;5718.428157184279;5782.855428614287;5727.083666613343;5780.855478613037;5788.971055144729;5806.767729290834;5819.156222347768;5218.243354713573;5244.659097158691;5288.947110528903;5300.946990530084;5327.174287985368;5156.226566015109;5170.870728231786;5222.63441559091;5313.681179129265;5342.465753424646;5208.010478009185;5217.947820521803;5265.76304066318;5304.469553044684;5309.203619457093;5303.761330740107;5329.120695085307;5338.679679219259;5362.329708786402;5417.187421886709;5176.508231718019;5294.947050529484;5303.787848486095;5317;5376.354837419534;5525.668459892419;5544.417836127189;5576.302962129734;5746.626469279525;5759;6104.664243466607;6112.368493048456;6117.736059405574;6182.598131121463;6202.534809889231;6170.660613666247;6186.783462578833;6189.81430557084;6197.845053873644;6237.7816776413065;5658.971705141489;5698.487136157766;5758.818377259329;5763.682997435139;5832.883342333172;6205.689715514297;6331.841703957438;6352.587081839758;6360.9045864312075;6375.075614035939;6080.665563393967;6090.056041313604;6095.817125486243;6096.207493025879;6097.298810636745;5941.435563621449;6003.879922401527;6039.275286965592;6139.324674285825;6192.380761923771;6114.327782088734;6116.841224961158;6123.374584456806;6144.477719393813;6144.617461071312;6115.392460733998;6115.541219922516;6119.775452159067;6120.416658368064;6125.11336343068;4578.153041687298;4662.417197850269;4670.136024835417;4678.321643361762;4705.129551033001;4171.311733563989;4217.5782421758195;4228.154369126187;4234.597713217239;4250.341197114452;5985.16207730918;6019.157317975487;6031.668258245751;6033.879322413527;6057.8485537861025;6089.786857459968;6150.446459818638;6162.630242185393;6216.44052035319;6305.873882522324;5901.085331773582;5905;5984.311804142492;6014.609050411709;6019.939800602026;5157.432682404932;5272.103742363807;5275;5277;5279.656822306538;6336.746530138743;6425.485961123099;6443.967780161163;6562.278149403562;6574.882270014109;6098.207233059763;6181.598196117238;6186.5360097993735;6213.068039794067;6219.595726277777;6244.781432649836;6314.968425158028;6399.296077431386;6406.583572067801;6421.646809425526;6030.276366836008;6134.4978165938865;6137.386261374006;6139.723712432862;6141.907871382022;6176.969115154396;6216.974199257072;6217.347178546188;6218.315985241529;6235.719392627252;5892.616979896293;5979.4618484336615;6037.607555508878;6040.244969378828;6053.727582258721;6110.969445152746;6117.218487018656;6120.18155276438;6124.411449640054;6132.972589815595;5999.400059993965;6040.063790112539;6051.788187413419;6052.061930400795;6066.211392518944;5957.76168953237;6029.8191054268445;6108.786192483241;6136.325004249618;6192.938070619236;6040.124181993674;6054.9091763624465;6056.6971651418135;6059.545534084873;6063.090536419572 06:54:26 INFO - PROCESS | 14277 | |1;ext.html;573.7590212110913;612.6630353305682;637.3753721353075;640.0591131037377;665.766981556455;41633.375499367496;45698.771506142504;45806.08387832245;45927.77036114815;46003;46273;46910.296345554845;46931.53068469314;47023;47161.52838471614;8895.377323587352;8992.595333210022;9010.144036316573;9027.729168124966;9053.50205738684;8849.33629977751;8974.775630609254;8977.236934860544;8979.730608081769;8986.595603197838;9013.54932253388;9045.547722613876;9053.547322633842;9062.093790620918;9065.22945549629;8989.460632362046;9012.8648070279;9027.909720902806;9030.909690903138;9099.454032757989;8857.689980850704;8936.687215947475;8944.10558944107;8952.328575356874;8960.148785865333;43109.78445107755;43121.56878431207;43231;43409.56590434119;43447;3964.226975739732;4062.2281766464275;4170.72890262132;4423.778811059434;4718.197906355894;35018.47472287892;35264;35501;35934.281314373824;36551.26897462036;4677.181493238703;4711.693739906929;4719.457262414832;4720.47084899588;4787.6648634595595;365666.9999999973;367507;368874;369253;369402;38446.23107537834;65040.67479662666;65424.67287663531;65465.01802472967;65790.67104664446;39028.41457378142;40463.393049104285;40667.7966610165;40676.79661601673;40706.964651767295;17524.47426577205;17844.821551784575;17849.7322540162;17922.820771792376;17927;14588.781168282485;14605.342759575844;14688.779668304984;14690;14703.55889323322;9151.267898568098;9218.308626853013;9234.122758337948;9320.533973301308;9330.95334523323;3449.9482507762405;3514.2093029068765;3517.3492903812876;3565.108722819295;3598.3522965866396;1092.229977865603;1097.8298363753631;1133.7562424078862;1148.8506494155706;1153.3425947210178;32633.51049734256;33876.83061584676;34097.488537671954;34104.48843267353;34112.31775364479;1143.3254379915888;1176.3471273443322;1198.3888217009387;1201.7656556971306;1231.3166192763103;17294.65410691779;17443.73834392485;17695.646087078443;17696.469105926844;17922.27130590152;610794;611513;637092;1023295;1040921;61489.385106148366;61665.38334616597;61837;66739.66630166819;66817;1535.293764868151;1560.7736878152832;1568.4902406717633;1579.0525684589384;1581.6599431122133;34143.317133657685;34421.82789086038;34499.65500345065;34929.65070349264;34989.125271868405;57870.710646448184;58559;58751.41248587459;58783;58947;568295;569684;570228;571326;572449;48602.270965936244;49276.26085608647;50057.749711251214;50398.24402634037;50771.74614126905;46775;53202.2019669713;53255.73372133115;53842;54239.45760542344;44491;44922.10155796931;45196.322055169854;45339;45935.08129837451;43745.343819843365;44043.779781100886;44510.41236035167;44659.33011004903;44914.77542612266;44370.77814610906;44766.77616611896;44851.551484486045;45060.09879802451;48125.75937120432;39181.41227881527;39675.60324396719;39683.60316396799;39803.60196397999;39944.80027599844;29451.852740736158;29906.102816914656;30004.399912002074;30123.548146778256;32062.19844503906 06:54:26 INFO - PROCESS | 14277 | |2;jquery.html;419.0989372848376;421.9556946520617;422.4613617637512;424.0776311522439;434.8934511044794;18575;19639.901800491014;20356.592868142627;20532.794672053275;20738.688919666216;18842;18886.905565472152;19402.417927462164;19563.510912227164;19689.901550492265;5798.942010579904;5960.016597261447;5984.760609575612;6003.789867354643;6006.309274433431;4361.956380436187;5923.14114453404;5970.462658360747;6378.29838717743;6728.865422691543;6691.330866913294;6697.799066028003;6719.832004199885;6738.157730283715;6776.796696099125;6466.35336466352;6606.570572912745;6648.102506161655;6651.334866513358;6714.992751087351;5728.942710572883;5895.4694077532795;5906.497947674453;5941.465268125889;5999.76000959961;22236.332910012727;23564.528709425715;23602;23804.761952380428;23910.88044559766;2404.8196385271;2406.5307265083316;2408.4580969281947;2475.405902583385;2653.827501212415;15069.924650376788;15222.238888055554;15424;15454.922725386414;15540.06759594428;1902.3056584346753;1991.2035185925602;2008.2368699893948;2043.1395747684685;2046.907889144992;83412.16587834105;83679.5816020916;86351.56824215902;87267.12732872654;87303.56348218281;10933.180011499011;11228.775424491465;11485.19603627738;11559.190856639954;11587.478563464665;15961.840381596268;16037.839621603867;16079.356825727074;16091.75862362042;16118.113503757171;8864.601092950832;8942.239909607626;9095.863562046574;9218.354715169873;9223.769405764775;8189.508629482131;8196.467229630054;8326.084130745614;8367.748967530984;8406.747797566082;6832.214295356098;6922.307769223037;7008.894866577006;7040.788776336718;7081.5042946994245;1821.6630467586735;1937.3994061840874;1999.8200161985492;2020.2323117215658;2050.6001329740557;1018.2414101494434;1128.6670432222513;1144.3191301175787;1147.0880649883195;1186;19454.416367509;19521.316753913547;19686;19903.384532551496;19967.600647986957;1075.5590208014676;1079.3092420850505;1102.366139469792;1131.0612191880718;1136.676047326508;11260.211785174959;11298.943505282421;11399.145064120225;11490.77018459643;11493.138014648768;484567;491993;494196;498206;501256;53405.465945340824;65337;85444;85501;88514.55742721245;1081.6322450366913;1108.1135091926426;1115.1914861725184;1123.5393488669606;1125.8254970479588;17576.91211543934;18006.90996545009;18065.096745162427;18149.818501814814;18267.634647306713;34986.47520287248;39144.217115658095;40532;40623.03555214072;41351.7932410336;52068;52488.47511524989;53081;53321.73339133435;53496.1975570359;7640.235976402315;7911.327537159406;7961.601919903866;8606.225439710455;9065.048169942062;9551.570179341807;10597.41714205726;12261.87738122643;12490.500379984698;13032.152910060815;11399.259048161843;11664.183507154758;11862.22895511789;11939.641810745692;11940.701482463008;11336.206465547333;11503.884961150281;11524.769504610029;11549.36478493691;11810.291382517076;10939.671809845717;11334.206605537533;11591;11821.940890295493;12066.638000859988;8746.912530874864;8859.822803544022;8877.20105190536;8938.1508756668;9036.954815225881;10286.331388459726;10732.141428685842;10747.731306717395;10764.192685548773;10891.564337426731 06:54:26 INFO - PROCESS | 14277 | |3;mootools.html;1555.401170549339;1599.47217418252;1762.903040332782;1914.7702275726906;1939.108010315255;8476.872846907301;9294;9661.806763864719;9975.251856110785;10014.54934527947;9376.109269619375;9611.66359177429;9654.806903861936;9726.124648781608;9727.36772109814;2448.6694296269998;2499.525090232859;2512.798976081918;2513.861737604431;2515.6478093066985;2439;2517.4461618444006;2517.7230504644476;2521.357053951249;2524.406764410362;2400.8199385046105;2426.915057972971;2434.7200071991683;2459.4958033603157;2463.027104293812;2404.350825277183;2417.8428402153804;2424.151546958568;2430.2830664953703;2432.7080750309988;2388.641703744435;2405.9398515037087;2416.5650182967233;2431.5623187826186;2456.1894574790276;9615.951920240354;9689.612415503441;9759.170470510015;9760.707178784647;9764;5710.543156547466;5789.04480760674;5813.6802475863815;5843;5853.50245229156;3503.4569641705575;3538.380783362901;3644.8906532803794;3654.7441679082476;3680.8159592020293;1167.334619267018;1220.9084318676134;1241.3606992398923;1242.502998800478;1248.0265392993479;13812.309384530734;13817.170969741746;13827.308634568231;13834.23911684857;13846;4906.460289368167;4927.334809800631;4998.750062496933;5008.974955125201;5047;11591.594294199662;11655.53377864876;11661.008814250883;11665.358405287621;11683.474243659055;5670.149477578396;5777.046787280052;5778;5798.1302804579655;5802.33273173582;4641.582257596832;5071.721055341918;5281.049411105961;5345.091334473149;5351.117065684196;4309.310510318334;4380.474343078851;4457.239390440823;4464.352668862996;4517.051419202005;1296.7600993816175;1345.3004437692541;1346.4008516210388;1353.7021855191842;1377.3113443278362;809.9595020248964;897.3494216692845;936.2135805923058;962.0475729028351;986.2603047714215;6441.355864413615;6577.309382514863;6724.361185687352;6880.793576192722;6883.518153729291;1017.8066167428165;1090.3076546393097;1097.8902109789117;1104.4588151805558;1129.9943500282611;4359.302511598129;4517.41273634432;4561.156186105581;4614.215583350839;4625.098105869391;11985.400729963467;12240;12245.93877030627;12279.079069069856;12367;11395.259308144945;11850.644480665595;12260.877391226151;12339;12402.689932751573;8974.730758077269;9097.226735727405;9124.726258212131;9174.128457796633;9181.127792859668;6508.576942498722;6574.506911981716;6607.669616519059;6679.532432729857;6773.390394864486;10902.836457452986;11144.832827507757;11289.548418063514;11330.886691132982;11339.149563782585;11028.558857645605;11358.659240222807;11404;11405.429728513707;11438.885611143782;7807;8381.622826972924;8585.484870907765;8888.60001299956;9258.259339252709;9288.907110929074;9511.76220594463;9525.857112143185;9528.285378596494;9591.520423978913;8189.385796065438;8328.791780205544;8522.48865068098;8560.229579337889;8715.825683486168;8390.119037500974;8416.789580260542;8469.364797640324;8491.57542122879;8612.48325100496;7820.335271501986;7841.607919603883;7920.722774702857;7970.760877173694;8014.719484818003;5263.973680131575;5443.673379597237;5535.39110697831;5564.276644036249;5712.6001179917;5593.07714227148;5623.2408624835125;5651.886962260814;5665.518430933417;5840.415958404125 06:54:26 INFO - PROCESS | 14277 | |4;prototype.html;342.3187856166229;346.0087198174505;346.0932357224073;349.6800427608738;352.7671736653809;5689.374168841429;5786.855328616787;5794.435502414346;5799.246098007253;5807.41925807419;5688.317401911776;5696.344920334152;5702.743376548055;5757.971210143954;5762.596618236725;4267.783681650731;4304.397384366192;4431.648347254086;4434.667399945001;4467.061916997434;4366.166210191727;4410.536893626171;4463.419755431789;4474.798634061475;4498.347739577759;4391.165678521071;4412.536683648203;4419.491758447787;4449.354843547683;4453.309736990772;4307.763073030982;4374.846880359172;4418.513963464048;4430.224710675619;4443.37792709021;3935.4490371348033;3970.2258059678375;3980.8805735827973;3982.6216509431556;3992.5807790181902;5465.699386533739;5530.778768849241;5543.501084902378;5571.13647384656;5579.497845193952;5003.324551185579;5053.9241911371355;5120.641555091145;5130.3074084998425;5138.2549530318265;5967.53795320145;5989.3112292086535;6033;6040.848978775522;6042.214512113441;4361.105973275471;4396.71421357614;4409.4047303613925;4415.359772832921;4423.424954755861;5971.462568368867;6195.5663103582765;6269.749210031593;6272.623642581505;6274.372562743689;4338.848140315074;4399.5380485049245;4414.426124603845;4415.6909016368545;4417.425734654475;4315.6763242756915;4363.410939523187;4391;4432.933505997413;4446.377507149002;5033.6224783141415;5040.521150490697;5057.21613149955;5067.493250674903;5113.565346945476;6002.369751176064;6024.608400453956;6050.606710563888;6072.51419886408;6134.877302454015;1484.1243666236971;1494.5516345096428;1534.6700459401281;1534.7314220011676;1546.9458568950258;965.5027660754716;1018.7758693087509;1037.9325343852624;1051.4164638625484;1068.385678235018;5873.295204575478;5889.676067816225;5979.19280897082;6000.699965001732;6006.219191505076;6218;6256.249250090018;6260.874782504325;6284.277308109626;6311.305756366796;5668.348139963874;5944.851378715567;5951.464368206882;6006.519478441714;6033.849153771191;3293;3308.983455082709;3331.8833840815455;3337.365900478901;3359.445691460882;6184.443400094013;6462.224533056064;6552.3775241352;6558.80323590293;6562.77030303937;6339.207599050119;6362.300146983921;6382.425581697669;6448.9355106449275;6468.6442245676;6150.50795936324;6473.546851720334;6502.642354670538;6552.213734351908;6554.770583029666;6245.5628106033955;6263.123162757127;6267.780627678009;6295.213098362705;6298.874022519432;5996.781190959373;6129.540284478593;6165.691715414122;6183.196184495987;6184.257889053342;6463.256725476443;6488.545801793829;6495.317991610813;6586.407223349922;6597.2742998271115;4279.957200428081;4322.222000040023;4357.934630980474;4362.890927726832;4379.321205213197;6046.54650901193;6233.818163642689;6235.282942461494;6340.365963403623;6341.778037768656;6048.334683184934;6071.39286071407;6078.209832721895;6108.938910611015;6131.816045518642;5916.674582897982;6098.725557350019;6145.938540614537;6155.876882462415;6158.33724894285;5788.6526808389945;5967.164596956516;5990.400959904149;6000.669963152069;6009.784765150624;6047.48596369296;6075.848103797441;6116.724747386289;6118.357572454828;6133.907991380043;5722.284714410699;5988.431099045583;5989.3711160329285;6004.639721616717;6005.939940600713 06:54:26 INFO - PROCESS | 14277 | |5;yui.html;798.1898373151253;818.4720855048494;842.6081871929554;901.7204666553367;921.1525396635095;16723.33106675733;16926.576835579115;17284.04937728426;17313.91343043283;17315.22081506332;16218.675626487464;16274.104924229192;16309.510714678549;16327.428540001103;16353.672926541461;885.327151364964;885.5572213893054;892.1970226795903;903.2367649336301;906.8503696890006;854.2055888024136;857.4298091768966;858.6651206029653;862.0732712334266;862.9352798540135;898.5731777405713;909.1590278991939;909.2089881802841;911.7355966769629;912.115248209236;903.4669544968434;904;906.2206502407923;906.7959709065474;907.6324088744069;660.247318057415;660.6531570925255;663.7278715726529;663.9468842492589;668.9464842812563;15503.612409689735;15621.140837253946;15622.531324060297;15633;15659.686806263924;14754.778678319833;15207.771883421758;15325.386984520606;15443.150626715526;15496.535103946899;12258.44836982329;12350.567730129402;12766.297853618047;12828.230306181658;12980.415881285366;3710.2950439416422;3759.8496060157563;3793.3930571108767;3819.3888977763704;3857.9421308680394;52806;60848.69575652093;64470.355296446905;66735.66632166857;77660.61169694172;11171.832422513506;11336.376499292619;11577.942110289394;11977.461014254379;12234.632961011184;22515.211967581385;22695;22726.545469090524;22742.317730468112;22748.545029099325;9203.953980230055;9205.63177472907;9254.398464099811;9373.343865929455;9413.670521531714;4949.505049495022;4998.850034498971;5046.4953504649975;5057.140286151363;5154.639175257696;3768.811559422018;3851;3854.6916246700757;3874.341361968472;3887.902802429962;678.3860606151441;686.7081490366575;690.8411065454974;709.570709720622;711.6655172069119;656.7602824968948;656.9605823650596;783.4241832253289;809.9230573095547;842.7092653034694;10824.729381765519;10986.395748233765;11116.833247501294;11328.433578321052;11537.134714896249;735.2537174767615;754.4190972950797;825.529448214524;836.180543067797;844.5144042175774;5066.695998240118;5095.821646242363;5174.663646862942;5207.843764687065;5220.321358223407;110823;113239;113619;115201;116674;97624.51187744016;99432;99466.5026674862;99694.5015274919;100169.49915250378;76733.61633191798;78304;79420.60289698515;87818.99999999872;88695.55652221826;10462.21533384984;10868.728281793019;10902.236843420884;10905.153702992218;10938.726531836768;50976;52290.95418091693;57621;57647.77635578287;58386.4161358398;73490.26509734834;73609.26390736025;81738.18261817543;81969;82519.5874020626;12931.418086185957;13135.34323283813;13143.408546615616;13257.403416846073;13811.17132972025;15038.6992260152;15196.544103676908;15254.923725381303;15348.23258837076;15488.380464781734;14518;14609.123452592878;15015.699686006437;15218;15248.237588120772;13611.25138117413;13813.309334533435;13943.16341019542;14423.49517766873;14530.782038269223;13844.030917835655;14030.859691402955;14386.705196532363;14507.1295722257;14588.635284117981;11325.093992480746;11542.307461552333;11579.88420115788;11793.174477786473;11888.108391870817;12034.879651203375;12233.571824986082;12270.815937760763;12326.137170398344;12336.938315308726 06:54:26 INFO - PROCESS | 14277 | __end_tp_report 06:54:26 INFO - PROCESS | 14277 | __start_cc_report 06:54:26 INFO - PROCESS | 14277 | _x_x_mozilla_cycle_collect,337 06:54:26 INFO - PROCESS | 14277 | __end_cc_report 06:54:26 INFO - PROCESS | 14277 | __startTimestamp1468504466922__endTimestamp 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | ------- Summary: start ------- 06:54:26 INFO - PROCESS | 14277 | Number of tests: 6 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | [#0] dojo.html Cycles:165 Average:5749.55 Median:6037.61 stddev:647.04 (10.7%) stddev-sans-first:622.51 06:54:26 INFO - PROCESS | 14277 | Values: 3412.5 3424.2 3442.4 3444.8 3454.8 5635.0 5671.2 5712.3 5718.4 5782.9 5727.1 5780.9 5789.0 5806.8 5819.2 5218.2 5244.7 5288.9 5300.9 5327.2 5156.2 5170.9 5222.6 5313.7 5342.5 5208.0 5217.9 5265.8 5304.5 5309.2 5303.8 5329.1 5338.7 5362.3 5417.2 5176.5 5294.9 5303.8 5317.0 5376.4 5525.7 5544.4 5576.3 5746.6 5759.0 6104.7 6112.4 6117.7 6182.6 6202.5 6170.7 6186.8 6189.8 6197.8 6237.8 5659.0 5698.5 5758.8 5763.7 5832.9 6205.7 6331.8 6352.6 6360.9 6375.1 6080.7 6090.1 6095.8 6096.2 6097.3 5941.4 6003.9 6039.3 6139.3 6192.4 6114.3 6116.8 6123.4 6144.5 6144.6 6115.4 6115.5 6119.8 6120.4 6125.1 4578.2 4662.4 4670.1 4678.3 4705.1 4171.3 4217.6 4228.2 4234.6 4250.3 5985.2 6019.2 6031.7 6033.9 6057.8 6089.8 6150.4 6162.6 6216.4 6305.9 5901.1 5905.0 5984.3 6014.6 6019.9 5157.4 5272.1 5275.0 5277.0 5279.7 6336.7 6425.5 6444.0 6562.3 6574.9 6098.2 6181.6 6186.5 6213.1 6219.6 6244.8 6315.0 6399.3 6406.6 6421.6 6030.3 6134.5 6137.4 6139.7 6141.9 6177.0 6217.0 6217.3 6218.3 6235.7 5892.6 5979.5 6037.6 6040.2 6053.7 6111.0 6117.2 6120.2 6124.4 6133.0 5999.4 6040.1 6051.8 6052.1 6066.2 5957.8 6029.8 6108.8 6136.3 6192.9 6040.1 6054.9 6056.7 6059.5 6063.1 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | [#1] ext.html Cycles:180 Average:72594.49 Median:44883.16 stddev:164232.25 (365.9%) stddev-sans-first:164603.94 06:54:26 INFO - PROCESS | 14277 | Values: 573.8 612.7 637.4 640.1 665.8 41633.4 45698.8 45806.1 45927.8 46003.0 46273.0 46910.3 46931.5 47023.0 47161.5 8895.4 8992.6 9010.1 9027.7 9053.5 8849.3 8974.8 8977.2 8979.7 8986.6 9013.5 9045.5 9053.5 9062.1 9065.2 8989.5 9012.9 9027.9 9030.9 9099.5 8857.7 8936.7 8944.1 8952.3 8960.1 43109.8 43121.6 43231.0 43409.6 43447.0 3964.2 4062.2 4170.7 4423.8 4718.2 35018.5 35264.0 35501.0 35934.3 36551.3 4677.2 4711.7 4719.5 4720.5 4787.7 365667.0 367507.0 368874.0 369253.0 369402.0 38446.2 65040.7 65424.7 65465.0 65790.7 39028.4 40463.4 40667.8 40676.8 40707.0 17524.5 17844.8 17849.7 17922.8 17927.0 14588.8 14605.3 14688.8 14690.0 14703.6 9151.3 9218.3 9234.1 9320.5 9331.0 3449.9 3514.2 3517.3 3565.1 3598.4 1092.2 1097.8 1133.8 1148.9 1153.3 32633.5 33876.8 34097.5 34104.5 34112.3 1143.3 1176.3 1198.4 1201.8 1231.3 17294.7 17443.7 17695.6 17696.5 17922.3 610794.0 611513.0 637092.0 1023295.0 1040921.0 61489.4 61665.4 61837.0 66739.7 66817.0 1535.3 1560.8 1568.5 1579.1 1581.7 34143.3 34421.8 34499.7 34929.7 34989.1 57870.7 58559.0 58751.4 58783.0 58947.0 568295.0 569684.0 570228.0 571326.0 572449.0 48602.3 49276.3 50057.7 50398.2 50771.7 46775.0 53202.2 53255.7 53842.0 54239.5 44491.0 44922.1 45196.3 45339.0 45935.1 43745.3 44043.8 44510.4 44659.3 44914.8 44370.8 44766.8 44851.6 45060.1 48125.8 39181.4 39675.6 39683.6 39803.6 39944.8 29451.9 29906.1 30004.4 30123.5 32062.2 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | [#2] jquery.html Cycles:180 Average:28941.69 Median:23583.26 stddev:81114.94 (344.0%) stddev-sans-first:81314.22 06:54:26 INFO - PROCESS | 14277 | Values: 419.1 422.0 422.5 424.1 434.9 18575.0 19639.9 20356.6 20532.8 20738.7 18842.0 18886.9 19402.4 19563.5 19689.9 5798.9 5960.0 5984.8 6003.8 6006.3 4362.0 5923.1 5970.5 6378.3 6728.9 6691.3 6697.8 6719.8 6738.2 6776.8 6466.4 6606.6 6648.1 6651.3 6715.0 5728.9 5895.5 5906.5 5941.5 5999.8 22236.3 23564.5 23602.0 23804.8 23910.9 2404.8 2406.5 2408.5 2475.4 2653.8 15069.9 15222.2 15424.0 15454.9 15540.1 1902.3 1991.2 2008.2 2043.1 2046.9 83412.2 83679.6 86351.6 87267.1 87303.6 10933.2 11228.8 11485.2 11559.2 11587.5 15961.8 16037.8 16079.4 16091.8 16118.1 8864.6 8942.2 9095.9 9218.4 9223.8 8189.5 8196.5 8326.1 8367.7 8406.7 6832.2 6922.3 7008.9 7040.8 7081.5 1821.7 1937.4 1999.8 2020.2 2050.6 1018.2 1128.7 1144.3 1147.1 1186.0 19454.4 19521.3 19686.0 19903.4 19967.6 1075.6 1079.3 1102.4 1131.1 1136.7 11260.2 11298.9 11399.1 11490.8 11493.1 484567.0 491993.0 494196.0 498206.0 501256.0 53405.5 65337.0 85444.0 85501.0 88514.6 1081.6 1108.1 1115.2 1123.5 1125.8 17576.9 18006.9 18065.1 18149.8 18267.6 34986.5 39144.2 40532.0 40623.0 41351.8 52068.0 52488.5 53081.0 53321.7 53496.2 7640.2 7911.3 7961.6 8606.2 9065.0 9551.6 10597.4 12261.9 12490.5 13032.2 11399.3 11664.2 11862.2 11939.6 11940.7 11336.2 11503.9 11524.8 11549.4 11810.3 10939.7 11334.2 11591.0 11821.9 12066.6 8746.9 8859.8 8877.2 8938.2 9037.0 10286.3 10732.1 10747.7 10764.2 10891.6 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | [#3] mootools.html Cycles:180 Average:6402.94 Median:4633.34 stddev:3704.82 (80.0%) stddev-sans-first:3697.30 06:54:26 INFO - PROCESS | 14277 | Values: 1555.4 1599.5 1762.9 1914.8 1939.1 8476.9 9294.0 9661.8 9975.3 10014.5 9376.1 9611.7 9654.8 9726.1 9727.4 2448.7 2499.5 2512.8 2513.9 2515.6 2439.0 2517.4 2517.7 2521.4 2524.4 2400.8 2426.9 2434.7 2459.5 2463.0 2404.4 2417.8 2424.2 2430.3 2432.7 2388.6 2405.9 2416.6 2431.6 2456.2 9616.0 9689.6 9759.2 9760.7 9764.0 5710.5 5789.0 5813.7 5843.0 5853.5 3503.5 3538.4 3644.9 3654.7 3680.8 1167.3 1220.9 1241.4 1242.5 1248.0 13812.3 13817.2 13827.3 13834.2 13846.0 4906.5 4927.3 4998.8 5009.0 5047.0 11591.6 11655.5 11661.0 11665.4 11683.5 5670.1 5777.0 5778.0 5798.1 5802.3 4641.6 5071.7 5281.0 5345.1 5351.1 4309.3 4380.5 4457.2 4464.4 4517.1 1296.8 1345.3 1346.4 1353.7 1377.3 810.0 897.3 936.2 962.0 986.3 6441.4 6577.3 6724.4 6880.8 6883.5 1017.8 1090.3 1097.9 1104.5 1130.0 4359.3 4517.4 4561.2 4614.2 4625.1 11985.4 12240.0 12245.9 12279.1 12367.0 11395.3 11850.6 12260.9 12339.0 12402.7 8974.7 9097.2 9124.7 9174.1 9181.1 6508.6 6574.5 6607.7 6679.5 6773.4 10902.8 11144.8 11289.5 11330.9 11339.1 11028.6 11358.7 11404.0 11405.4 11438.9 7807.0 8381.6 8585.5 8888.6 9258.3 9288.9 9511.8 9525.9 9528.3 9591.5 8189.4 8328.8 8522.5 8560.2 8715.8 8390.1 8416.8 8469.4 8491.6 8612.5 7820.3 7841.6 7920.7 7970.8 8014.7 5264.0 5443.7 5535.4 5564.3 5712.6 5593.1 5623.2 5651.9 5665.5 5840.4 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | [#4] prototype.html Cycles:180 Average:5100.44 Median:5803.33 stddev:1520.97 (26.2%) stddev-sans-first:1482.72 06:54:26 INFO - PROCESS | 14277 | Values: 342.3 346.0 346.1 349.7 352.8 5689.4 5786.9 5794.4 5799.2 5807.4 5688.3 5696.3 5702.7 5758.0 5762.6 4267.8 4304.4 4431.6 4434.7 4467.1 4366.2 4410.5 4463.4 4474.8 4498.3 4391.2 4412.5 4419.5 4449.4 4453.3 4307.8 4374.8 4418.5 4430.2 4443.4 3935.4 3970.2 3980.9 3982.6 3992.6 5465.7 5530.8 5543.5 5571.1 5579.5 5003.3 5053.9 5120.6 5130.3 5138.3 5967.5 5989.3 6033.0 6040.8 6042.2 4361.1 4396.7 4409.4 4415.4 4423.4 5971.5 6195.6 6269.7 6272.6 6274.4 4338.8 4399.5 4414.4 4415.7 4417.4 4315.7 4363.4 4391.0 4432.9 4446.4 5033.6 5040.5 5057.2 5067.5 5113.6 6002.4 6024.6 6050.6 6072.5 6134.9 1484.1 1494.6 1534.7 1534.7 1546.9 965.5 1018.8 1037.9 1051.4 1068.4 5873.3 5889.7 5979.2 6000.7 6006.2 6218.0 6256.2 6260.9 6284.3 6311.3 5668.3 5944.9 5951.5 6006.5 6033.8 3293.0 3309.0 3331.9 3337.4 3359.4 6184.4 6462.2 6552.4 6558.8 6562.8 6339.2 6362.3 6382.4 6448.9 6468.6 6150.5 6473.5 6502.6 6552.2 6554.8 6245.6 6263.1 6267.8 6295.2 6298.9 5996.8 6129.5 6165.7 6183.2 6184.3 6463.3 6488.5 6495.3 6586.4 6597.3 4280.0 4322.2 4357.9 4362.9 4379.3 6046.5 6233.8 6235.3 6340.4 6341.8 6048.3 6071.4 6078.2 6108.9 6131.8 5916.7 6098.7 6145.9 6155.9 6158.3 5788.7 5967.2 5990.4 6000.7 6009.8 6047.5 6075.8 6116.7 6118.4 6133.9 5722.3 5988.4 5989.4 6004.6 6005.9 06:54:26 INFO - PROCESS | 14277 | 06:54:26 INFO - PROCESS | 14277 | [#5] yui.html Cycles:180 Average:21034.81 Median:3835.19 stddev:29320.40 (764.5%) stddev-sans-first:29363.28 06:54:26 INFO - PROCESS | 14277 | Values: 798.2 818.5 842.6 901.7 921.2 16723.3 16926.6 17284.0 17313.9 17315.2 16218.7 16274.1 16309.5 16327.4 16353.7 885.3 885.6 892.2 903.2 906.9 854.2 857.4 858.7 862.1 862.9 898.6 909.2 909.2 911.7 912.1 903.5 904.0 906.2 906.8 907.6 660.2 660.7 663.7 663.9 668.9 15503.6 15621.1 15622.5 15633.0 15659.7 14754.8 15207.8 15325.4 15443.2 15496.5 12258.4 12350.6 12766.3 12828.2 12980.4 3710.3 3759.8 3793.4 3819.4 3857.9 52806.0 60848.7 64470.4 66735.7 77660.6 11171.8 11336.4 11577.9 11977.5 12234.6 22515.2 22695.0 22726.5 22742.3 22748.5 9204.0 9205.6 9254.4 9373.3 9413.7 4949.5 4998.9 5046.5 5057.1 5154.6 3768.8 3851.0 3854.7 3874.3 3887.9 678.4 686.7 690.8 709.6 711.7 656.8 657.0 783.4 809.9 842.7 10824.7 10986.4 11116.8 11328.4 11537.1 735.3 754.4 825.5 836.2 844.5 5066.7 5095.8 5174.7 5207.8 5220.3 110823.0 113239.0 113619.0 115201.0 116674.0 97624.5 99432.0 99466.5 99694.5 100169.5 76733.6 78304.0 79420.6 87819.0 88695.6 10462.2 10868.7 10902.2 10905.2 10938.7 50976.0 52291.0 57621.0 57647.8 58386.4 73490.3 73609.3 81738.2 81969.0 82519.6 12931.4 13135.3 13143.4 13257.4 13811.2 15038.7 15196.5 15254.9 15348.2 15488.4 14518.0 14609.1 15015.7 15218.0 15248.2 13611.3 13813.3 13943.2 14423.5 14530.8 13844.0 14030.9 14386.7 14507.1 14588.6 11325.1 11542.3 11579.9 11793.2 11888.1 12034.9 12233.6 12270.8 12326.1 12336.9 06:54:26 INFO - PROCESS | 14277 | -------- Summary: end -------- 06:54:26 INFO - PROCESS | 14277 | 06:54:27 INFO - TEST-INFO | 14277: exit 0 06:54:27 INFO - TEST-OK | dromaeo_css | took 1110182ms 06:54:27 INFO - TEST-START | kraken 06:54:27 INFO - operating with platform_type : linux_ 06:54:27 INFO - Initialising browser for kraken test... 06:54:27 INFO - TEST-INFO | started process 14521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph8fIkb/profile http://localhost:42465/getInfo.html) 06:54:32 INFO - PROCESS | 14521 | __metrics Screen width/height:1600/1200 06:54:32 INFO - PROCESS | 14521 | colorDepth:24 06:54:32 INFO - PROCESS | 14521 | Browser inner width/height: 1024/697 06:54:32 INFO - PROCESS | 14521 | __metrics 06:54:32 ERROR - PROCESS | 14521 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 06:54:33 INFO - TEST-INFO | 14521: exit 0 06:54:33 INFO - Browser initialized. 06:54:33 INFO - Running cycle 1/1 for kraken test... 06:54:33 INFO - TEST-INFO | started process 14648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph8fIkb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:45 INFO - PROCESS | 14648 | RSS: Main: 156164096 06:54:45 INFO - PROCESS | 14648 | 06:54:47 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42465/tests/kraken/driver.html?testName=audio-beat-detection) 06:54:48 INFO - PROCESS | 14648 | RSS: Main: 161128448 06:54:48 INFO - PROCESS | 14648 | 06:54:51 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42465/tests/kraken/driver.html?testName=audio-dft) 06:54:52 INFO - PROCESS | 14648 | RSS: Main: 160505856 06:54:52 INFO - PROCESS | 14648 | 06:54:54 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42465/tests/kraken/driver.html?testName=audio-fft) 06:54:55 INFO - PROCESS | 14648 | RSS: Main: 161271808 06:54:55 INFO - PROCESS | 14648 | 06:54:57 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42465/tests/kraken/driver.html?testName=audio-oscillator) 06:54:58 INFO - PROCESS | 14648 | RSS: Main: 161157120 06:54:58 INFO - PROCESS | 14648 | 06:55:00 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42465/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:00 INFO - PROCESS | 14648 | RSS: Main: 160722944 06:55:00 INFO - PROCESS | 14648 | 06:55:04 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42465/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:04 INFO - PROCESS | 14648 | RSS: Main: 160894976 06:55:04 INFO - PROCESS | 14648 | 06:55:08 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42465/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:08 INFO - PROCESS | 14648 | RSS: Main: 161021952 06:55:08 INFO - PROCESS | 14648 | 06:55:11 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42465/tests/kraken/driver.html?testName=json-parse-financial) 06:55:12 INFO - PROCESS | 14648 | RSS: Main: 160403456 06:55:12 INFO - PROCESS | 14648 | 06:55:13 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42465/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:14 INFO - PROCESS | 14648 | RSS: Main: 161001472 06:55:14 INFO - PROCESS | 14648 | 06:55:16 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:16 INFO - PROCESS | 14648 | RSS: Main: 160768000 06:55:16 INFO - PROCESS | 14648 | 06:55:18 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:55:19 INFO - PROCESS | 14648 | RSS: Main: 160919552 06:55:19 INFO - PROCESS | 14648 | 06:55:21 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:55:22 INFO - PROCESS | 14648 | RSS: Main: 161595392 06:55:22 INFO - PROCESS | 14648 | 06:55:25 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:55:25 INFO - PROCESS | 14648 | RSS: Main: 161366016 06:55:25 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | Cycle 1(1): loaded http://localhost:42465/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42465/tests/kraken/driver.html?testName=ai-astar) 06:55:27 INFO - PROCESS | 14648 | RSS: Main: 162148352 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | __start_tp_report 06:55:27 INFO - PROCESS | 14648 | _x_x_mozilla_page_load 06:55:27 INFO - PROCESS | 14648 | _x_x_mozilla_page_load_details 06:55:27 INFO - PROCESS | 14648 | |i|pagename|runs| 06:55:27 INFO - PROCESS | 14648 | |0;ai-astar;110;105;110;110;113;113;112;111;110;110 06:55:27 INFO - PROCESS | 14648 | |1;audio-beat-detection;148;134;151;172;129;151;154;135;182;126 06:55:27 INFO - PROCESS | 14648 | |2;audio-dft;162;164;163;163;162;162;162;161;162;161 06:55:27 INFO - PROCESS | 14648 | |3;audio-fft;77;75;75;171;75;75;74;75;166;76 06:55:27 INFO - PROCESS | 14648 | |4;audio-oscillator;85;84;140;84;85;84;144;85;83;143 06:55:27 INFO - PROCESS | 14648 | |5;imaging-gaussian-blur;117;118;118;117;117;118;122;117;117;117 06:55:27 INFO - PROCESS | 14648 | |6;imaging-darkroom;147;147;147;147;147;149;149;147;147;147 06:55:27 INFO - PROCESS | 14648 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;95;96 06:55:27 INFO - PROCESS | 14648 | |8;json-parse-financial;50;51;53;51;50;54;52;57;52;56 06:55:27 INFO - PROCESS | 14648 | |9;json-stringify-tinderbox;62;59;60;60;58;59;59;59;60;59 06:55:27 INFO - PROCESS | 14648 | |10;stanford-crypto-aes;76;76;82;76;77;77;77;79;111;77 06:55:27 INFO - PROCESS | 14648 | |11;stanford-crypto-ccm;127;116;121;117;129;130;134;121;120;132 06:55:27 INFO - PROCESS | 14648 | |12;stanford-crypto-pbkdf2;152;153;153;155;155;153;156;154;156;158 06:55:27 INFO - PROCESS | 14648 | |13;stanford-crypto-sha256-iterative;61;61;60;60;60;60;60;60;61;64 06:55:27 INFO - PROCESS | 14648 | __end_tp_report 06:55:27 INFO - PROCESS | 14648 | __start_cc_report 06:55:27 INFO - PROCESS | 14648 | _x_x_mozilla_cycle_collect,862 06:55:27 INFO - PROCESS | 14648 | __end_cc_report 06:55:27 INFO - PROCESS | 14648 | __startTimestamp1468504527704__endTimestamp 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | ------- Summary: start ------- 06:55:27 INFO - PROCESS | 14648 | Number of tests: 14 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:2.27 (2.1%) stddev-sans-first:2.40 06:55:27 INFO - PROCESS | 14648 | Values: 110.0 105.0 110.0 110.0 113.0 113.0 112.0 111.0 110.0 110.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:151.00 stddev:18.24 (12.1%) stddev-sans-first:19.35 06:55:27 INFO - PROCESS | 14648 | Values: 148.0 134.0 151.0 172.0 129.0 151.0 154.0 135.0 182.0 126.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:55:27 INFO - PROCESS | 14648 | Values: 162.0 164.0 163.0 163.0 162.0 162.0 162.0 161.0 162.0 161.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.00 stddev:39.34 (52.5%) stddev-sans-first:41.25 06:55:27 INFO - PROCESS | 14648 | Values: 77.0 75.0 75.0 171.0 75.0 75.0 74.0 75.0 166.0 76.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:84.00 stddev:28.06 (33.4%) stddev-sans-first:29.11 06:55:27 INFO - PROCESS | 14648 | Values: 85.0 84.0 140.0 84.0 85.0 84.0 144.0 85.0 83.0 143.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.50 stddev:1.55 (1.3%) stddev-sans-first:1.62 06:55:27 INFO - PROCESS | 14648 | Values: 117.0 118.0 118.0 117.0 117.0 118.0 122.0 117.0 117.0 117.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 06:55:27 INFO - PROCESS | 14648 | Values: 147.0 147.0 147.0 147.0 147.0 149.0 149.0 147.0 147.0 147.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:55:27 INFO - PROCESS | 14648 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:2.41 (4.6%) stddev-sans-first:2.37 06:55:27 INFO - PROCESS | 14648 | Values: 50.0 51.0 53.0 51.0 50.0 54.0 52.0 57.0 52.0 56.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:1.08 (1.8%) stddev-sans-first:0.67 06:55:27 INFO - PROCESS | 14648 | Values: 62.0 59.0 60.0 60.0 58.0 59.0 59.0 59.0 60.0 59.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:77.00 stddev:10.77 (14.0%) stddev-sans-first:11.28 06:55:27 INFO - PROCESS | 14648 | Values: 76.0 76.0 82.0 76.0 77.0 77.0 77.0 79.0 111.0 77.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:128.00 stddev:6.46 (5.1%) stddev-sans-first:6.80 06:55:27 INFO - PROCESS | 14648 | Values: 127.0 116.0 121.0 117.0 129.0 130.0 134.0 121.0 120.0 132.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:1.84 (1.2%) stddev-sans-first:1.72 06:55:27 INFO - PROCESS | 14648 | Values: 152.0 153.0 153.0 155.0 155.0 153.0 156.0 154.0 156.0 158.0 06:55:27 INFO - PROCESS | 14648 | 06:55:27 INFO - PROCESS | 14648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.70 Median:60.50 stddev:1.25 (2.1%) stddev-sans-first:1.32 06:55:27 INFO - PROCESS | 14648 | Values: 61.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 64.0 06:55:27 INFO - PROCESS | 14648 | -------- Summary: end -------- 06:55:27 INFO - PROCESS | 14648 | 06:55:28 INFO - TEST-INFO | 14648: exit 0 06:55:28 INFO - TEST-OK | kraken | took 61066ms 06:55:28 INFO - SUITE-END | took 1171s 06:55:28 INFO - Completed test suite (00:19:31) 06:55:28 INFO - javascript benchmark 06:55:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7745.308715325411, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3412.4881267809824, 3424.178197232665, 3442.431998720211, 3444.7588668793187, 3454.775439596426, 5635.0, 5671.206031155636, 5712.314522257325, 5718.428157184279, 5782.855428614287, 5727.083666613343, 5780.855478613037, 5788.971055144729, 5806.767729290834, 5819.156222347768, 5218.243354713573, 5244.659097158691, 5288.947110528903, 5300.946990530084, 5327.174287985368, 5156.226566015109, 5170.870728231786, 5222.63441559091, 5313.681179129265, 5342.465753424646, 5208.010478009185, 5217.947820521803, 5265.76304066318, 5304.469553044684, 5309.203619457093, 5303.761330740107, 5329.120695085307, 5338.679679219259, 5362.329708786402, 5417.187421886709, 5176.508231718019, 5294.947050529484, 5303.787848486095, 5317.0, 5376.354837419534, 5525.668459892419, 5544.417836127189, 5576.302962129734, 5746.626469279525, 5759.0, 6104.664243466607, 6112.368493048456, 6117.736059405574, 6182.598131121463, 6202.534809889231, 6170.660613666247, 6186.783462578833, 6189.81430557084, 6197.845053873644, 6237.7816776413065, 5658.971705141489, 5698.487136157766, 5758.818377259329, 5763.682997435139, 5832.883342333172, 6205.689715514297, 6331.841703957438, 6352.587081839758, 6360.9045864312075, 6375.075614035939, 6080.665563393967, 6090.056041313604, 6095.817125486243, 6096.207493025879, 6097.298810636745, 5941.435563621449, 6003.879922401527, 6039.275286965592, 6139.324674285825, 6192.380761923771, 6114.327782088734, 6116.841224961158, 6123.374584456806, 6144.477719393813, 6144.617461071312, 6115.392460733998, 6115.541219922516, 6119.775452159067, 6120.416658368064, 6125.11336343068, 4578.153041687298, 4662.417197850269, 4670.136024835417, 4678.321643361762, 4705.129551033001, 4171.311733563989, 4217.5782421758195, 4228.154369126187, 4234.597713217239, 4250.341197114452, 5985.16207730918, 6019.157317975487, 6031.668258245751, 6033.879322413527, 6057.8485537861025, 6089.786857459968, 6150.446459818638, 6162.630242185393, 6216.44052035319, 6305.873882522324, 5901.085331773582, 5905.0, 5984.311804142492, 6014.609050411709, 6019.939800602026, 5157.432682404932, 5272.103742363807, 5275.0, 5277.0, 5279.656822306538, 6336.746530138743, 6425.485961123099, 6443.967780161163, 6562.278149403562, 6574.882270014109, 6098.207233059763, 6181.598196117238, 6186.5360097993735, 6213.068039794067, 6219.595726277777, 6244.781432649836, 6314.968425158028, 6399.296077431386, 6406.583572067801, 6421.646809425526, 6030.276366836008, 6134.4978165938865, 6137.386261374006, 6139.723712432862, 6141.907871382022, 6176.969115154396, 6216.974199257072, 6217.347178546188, 6218.315985241529, 6235.719392627252, 5892.616979896293, 5979.4618484336615, 6037.607555508878, 6040.244969378828, 6053.727582258721, 6110.969445152746, 6117.218487018656, 6120.18155276438, 6124.411449640054, 6132.972589815595, 5999.400059993965, 6040.063790112539, 6051.788187413419, 6052.061930400795, 6066.211392518944, 5957.76168953237, 6029.8191054268445, 6108.786192483241, 6136.325004249618, 6192.938070619236, 6040.124181993674, 6054.9091763624465, 6056.6971651418135, 6059.545534084873, 6063.090536419572], "value": 5706.695781922717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.7590212110913, 612.6630353305682, 637.3753721353075, 640.0591131037377, 665.766981556455, 41633.375499367496, 45698.771506142504, 45806.08387832245, 45927.77036114815, 46003.0, 46273.0, 46910.296345554845, 46931.53068469314, 47023.0, 47161.52838471614, 8895.377323587352, 8992.595333210022, 9010.144036316573, 9027.729168124966, 9053.50205738684, 8849.33629977751, 8974.775630609254, 8977.236934860544, 8979.730608081769, 8986.595603197838, 9013.54932253388, 9045.547722613876, 9053.547322633842, 9062.093790620918, 9065.22945549629, 8989.460632362046, 9012.8648070279, 9027.909720902806, 9030.909690903138, 9099.454032757989, 8857.689980850704, 8936.687215947475, 8944.10558944107, 8952.328575356874, 8960.148785865333, 43109.78445107755, 43121.56878431207, 43231.0, 43409.56590434119, 43447.0, 3964.226975739732, 4062.2281766464275, 4170.72890262132, 4423.778811059434, 4718.197906355894, 35018.47472287892, 35264.0, 35501.0, 35934.281314373824, 36551.26897462036, 4677.181493238703, 4711.693739906929, 4719.457262414832, 4720.47084899588, 4787.6648634595595, 365666.9999999973, 367507.0, 368874.0, 369253.0, 369402.0, 38446.23107537834, 65040.67479662666, 65424.67287663531, 65465.01802472967, 65790.67104664446, 39028.41457378142, 40463.393049104285, 40667.7966610165, 40676.79661601673, 40706.964651767295, 17524.47426577205, 17844.821551784575, 17849.7322540162, 17922.820771792376, 17927.0, 14588.781168282485, 14605.342759575844, 14688.779668304984, 14690.0, 14703.55889323322, 9151.267898568098, 9218.308626853013, 9234.122758337948, 9320.533973301308, 9330.95334523323, 3449.9482507762405, 3514.2093029068765, 3517.3492903812876, 3565.108722819295, 3598.3522965866396, 1092.229977865603, 1097.8298363753631, 1133.7562424078862, 1148.8506494155706, 1153.3425947210178, 32633.51049734256, 33876.83061584676, 34097.488537671954, 34104.48843267353, 34112.31775364479, 1143.3254379915888, 1176.3471273443322, 1198.3888217009387, 1201.7656556971306, 1231.3166192763103, 17294.65410691779, 17443.73834392485, 17695.646087078443, 17696.469105926844, 17922.27130590152, 610794.0, 611513.0, 637092.0, 1023295.0, 1040921.0, 61489.385106148366, 61665.38334616597, 61837.0, 66739.66630166819, 66817.0, 1535.293764868151, 1560.7736878152832, 1568.4902406717633, 1579.0525684589384, 1581.6599431122133, 34143.317133657685, 34421.82789086038, 34499.65500345065, 34929.65070349264, 34989.125271868405, 57870.710646448184, 58559.0, 58751.41248587459, 58783.0, 58947.0, 568295.0, 569684.0, 570228.0, 571326.0, 572449.0, 48602.270965936244, 49276.26085608647, 50057.749711251214, 50398.24402634037, 50771.74614126905, 46775.0, 53202.2019669713, 53255.73372133115, 53842.0, 54239.45760542344, 44491.0, 44922.10155796931, 45196.322055169854, 45339.0, 45935.08129837451, 43745.343819843365, 44043.779781100886, 44510.41236035167, 44659.33011004903, 44914.77542612266, 44370.77814610906, 44766.77616611896, 44851.551484486045, 45060.09879802451, 48125.75937120432, 39181.41227881527, 39675.60324396719, 39683.60316396799, 39803.60196397999, 39944.80027599844, 29451.852740736158, 29906.102816914656, 30004.399912002074, 30123.548146778256, 32062.19844503906], "value": 20969.683424768817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.0989372848376, 421.9556946520617, 422.4613617637512, 424.0776311522439, 434.8934511044794, 18575.0, 19639.901800491014, 20356.592868142627, 20532.794672053275, 20738.688919666216, 18842.0, 18886.905565472152, 19402.417927462164, 19563.510912227164, 19689.901550492265, 5798.942010579904, 5960.016597261447, 5984.760609575612, 6003.789867354643, 6006.309274433431, 4361.956380436187, 5923.14114453404, 5970.462658360747, 6378.29838717743, 6728.865422691543, 6691.330866913294, 6697.799066028003, 6719.832004199885, 6738.157730283715, 6776.796696099125, 6466.35336466352, 6606.570572912745, 6648.102506161655, 6651.334866513358, 6714.992751087351, 5728.942710572883, 5895.4694077532795, 5906.497947674453, 5941.465268125889, 5999.76000959961, 22236.332910012727, 23564.528709425715, 23602.0, 23804.761952380428, 23910.88044559766, 2404.8196385271, 2406.5307265083316, 2408.4580969281947, 2475.405902583385, 2653.827501212415, 15069.924650376788, 15222.238888055554, 15424.0, 15454.922725386414, 15540.06759594428, 1902.3056584346753, 1991.2035185925602, 2008.2368699893948, 2043.1395747684685, 2046.907889144992, 83412.16587834105, 83679.5816020916, 86351.56824215902, 87267.12732872654, 87303.56348218281, 10933.180011499011, 11228.775424491465, 11485.19603627738, 11559.190856639954, 11587.478563464665, 15961.840381596268, 16037.839621603867, 16079.356825727074, 16091.75862362042, 16118.113503757171, 8864.601092950832, 8942.239909607626, 9095.863562046574, 9218.354715169873, 9223.769405764775, 8189.508629482131, 8196.467229630054, 8326.084130745614, 8367.748967530984, 8406.747797566082, 6832.214295356098, 6922.307769223037, 7008.894866577006, 7040.788776336718, 7081.5042946994245, 1821.6630467586735, 1937.3994061840874, 1999.8200161985492, 2020.2323117215658, 2050.6001329740557, 1018.2414101494434, 1128.6670432222513, 1144.3191301175787, 1147.0880649883195, 1186.0, 19454.416367509, 19521.316753913547, 19686.0, 19903.384532551496, 19967.600647986957, 1075.5590208014676, 1079.3092420850505, 1102.366139469792, 1131.0612191880718, 1136.676047326508, 11260.211785174959, 11298.943505282421, 11399.145064120225, 11490.77018459643, 11493.138014648768, 484567.0, 491993.0, 494196.0, 498206.0, 501256.0, 53405.465945340824, 65337.0, 85444.0, 85501.0, 88514.55742721245, 1081.6322450366913, 1108.1135091926426, 1115.1914861725184, 1123.5393488669606, 1125.8254970479588, 17576.91211543934, 18006.90996545009, 18065.096745162427, 18149.818501814814, 18267.634647306713, 34986.47520287248, 39144.217115658095, 40532.0, 40623.03555214072, 41351.7932410336, 52068.0, 52488.47511524989, 53081.0, 53321.73339133435, 53496.1975570359, 7640.235976402315, 7911.327537159406, 7961.601919903866, 8606.225439710455, 9065.048169942062, 9551.570179341807, 10597.41714205726, 12261.87738122643, 12490.500379984698, 13032.152910060815, 11399.259048161843, 11664.183507154758, 11862.22895511789, 11939.641810745692, 11940.701482463008, 11336.206465547333, 11503.884961150281, 11524.769504610029, 11549.36478493691, 11810.291382517076, 10939.671809845717, 11334.206605537533, 11591.0, 11821.940890295493, 12066.638000859988, 8746.912530874864, 8859.822803544022, 8877.20105190536, 8938.1508756668, 9036.954815225881, 10286.331388459726, 10732.141428685842, 10747.731306717395, 10764.192685548773, 10891.564337426731], "value": 9638.38788581826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.401170549339, 1599.47217418252, 1762.903040332782, 1914.7702275726906, 1939.108010315255, 8476.872846907301, 9294.0, 9661.806763864719, 9975.251856110785, 10014.54934527947, 9376.109269619375, 9611.66359177429, 9654.806903861936, 9726.124648781608, 9727.36772109814, 2448.6694296269998, 2499.525090232859, 2512.798976081918, 2513.861737604431, 2515.6478093066985, 2439.0, 2517.4461618444006, 2517.7230504644476, 2521.357053951249, 2524.406764410362, 2400.8199385046105, 2426.915057972971, 2434.7200071991683, 2459.4958033603157, 2463.027104293812, 2404.350825277183, 2417.8428402153804, 2424.151546958568, 2430.2830664953703, 2432.7080750309988, 2388.641703744435, 2405.9398515037087, 2416.5650182967233, 2431.5623187826186, 2456.1894574790276, 9615.951920240354, 9689.612415503441, 9759.170470510015, 9760.707178784647, 9764.0, 5710.543156547466, 5789.04480760674, 5813.6802475863815, 5843.0, 5853.50245229156, 3503.4569641705575, 3538.380783362901, 3644.8906532803794, 3654.7441679082476, 3680.8159592020293, 1167.334619267018, 1220.9084318676134, 1241.3606992398923, 1242.502998800478, 1248.0265392993479, 13812.309384530734, 13817.170969741746, 13827.308634568231, 13834.23911684857, 13846.0, 4906.460289368167, 4927.334809800631, 4998.750062496933, 5008.974955125201, 5047.0, 11591.594294199662, 11655.53377864876, 11661.008814250883, 11665.358405287621, 11683.474243659055, 5670.149477578396, 5777.046787280052, 5778.0, 5798.1302804579655, 5802.33273173582, 4641.582257596832, 5071.721055341918, 5281.049411105961, 5345.091334473149, 5351.117065684196, 4309.310510318334, 4380.474343078851, 4457.239390440823, 4464.352668862996, 4517.051419202005, 1296.7600993816175, 1345.3004437692541, 1346.4008516210388, 1353.7021855191842, 1377.3113443278362, 809.9595020248964, 897.3494216692845, 936.2135805923058, 962.0475729028351, 986.2603047714215, 6441.355864413615, 6577.309382514863, 6724.361185687352, 6880.793576192722, 6883.518153729291, 1017.8066167428165, 1090.3076546393097, 1097.8902109789117, 1104.4588151805558, 1129.9943500282611, 4359.302511598129, 4517.41273634432, 4561.156186105581, 4614.215583350839, 4625.098105869391, 11985.400729963467, 12240.0, 12245.93877030627, 12279.079069069856, 12367.0, 11395.259308144945, 11850.644480665595, 12260.877391226151, 12339.0, 12402.689932751573, 8974.730758077269, 9097.226735727405, 9124.726258212131, 9174.128457796633, 9181.127792859668, 6508.576942498722, 6574.506911981716, 6607.669616519059, 6679.532432729857, 6773.390394864486, 10902.836457452986, 11144.832827507757, 11289.548418063514, 11330.886691132982, 11339.149563782585, 11028.558857645605, 11358.659240222807, 11404.0, 11405.429728513707, 11438.885611143782, 7807.0, 8381.622826972924, 8585.484870907765, 8888.60001299956, 9258.259339252709, 9288.907110929074, 9511.76220594463, 9525.857112143185, 9528.285378596494, 9591.520423978913, 8189.385796065438, 8328.791780205544, 8522.48865068098, 8560.229579337889, 8715.825683486168, 8390.119037500974, 8416.789580260542, 8469.364797640324, 8491.57542122879, 8612.48325100496, 7820.335271501986, 7841.607919603883, 7920.722774702857, 7970.760877173694, 8014.719484818003, 5263.973680131575, 5443.673379597237, 5535.39110697831, 5564.276644036249, 5712.6001179917, 5593.07714227148, 5623.2408624835125, 5651.886962260814, 5665.518430933417, 5840.415958404125], "value": 5075.430845105719, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.3187856166229, 346.0087198174505, 346.0932357224073, 349.6800427608738, 352.7671736653809, 5689.374168841429, 5786.855328616787, 5794.435502414346, 5799.246098007253, 5807.41925807419, 5688.317401911776, 5696.344920334152, 5702.743376548055, 5757.971210143954, 5762.596618236725, 4267.783681650731, 4304.397384366192, 4431.648347254086, 4434.667399945001, 4467.061916997434, 4366.166210191727, 4410.536893626171, 4463.419755431789, 4474.798634061475, 4498.347739577759, 4391.165678521071, 4412.536683648203, 4419.491758447787, 4449.354843547683, 4453.309736990772, 4307.763073030982, 4374.846880359172, 4418.513963464048, 4430.224710675619, 4443.37792709021, 3935.4490371348033, 3970.2258059678375, 3980.8805735827973, 3982.6216509431556, 3992.5807790181902, 5465.699386533739, 5530.778768849241, 5543.501084902378, 5571.13647384656, 5579.497845193952, 5003.324551185579, 5053.9241911371355, 5120.641555091145, 5130.3074084998425, 5138.2549530318265, 5967.53795320145, 5989.3112292086535, 6033.0, 6040.848978775522, 6042.214512113441, 4361.105973275471, 4396.71421357614, 4409.4047303613925, 4415.359772832921, 4423.424954755861, 5971.462568368867, 6195.5663103582765, 6269.749210031593, 6272.623642581505, 6274.372562743689, 4338.848140315074, 4399.5380485049245, 4414.426124603845, 4415.6909016368545, 4417.425734654475, 4315.6763242756915, 4363.410939523187, 4391.0, 4432.933505997413, 4446.377507149002, 5033.6224783141415, 5040.521150490697, 5057.21613149955, 5067.493250674903, 5113.565346945476, 6002.369751176064, 6024.608400453956, 6050.606710563888, 6072.51419886408, 6134.877302454015, 1484.1243666236971, 1494.5516345096428, 1534.6700459401281, 1534.7314220011676, 1546.9458568950258, 965.5027660754716, 1018.7758693087509, 1037.9325343852624, 1051.4164638625484, 1068.385678235018, 5873.295204575478, 5889.676067816225, 5979.19280897082, 6000.699965001732, 6006.219191505076, 6218.0, 6256.249250090018, 6260.874782504325, 6284.277308109626, 6311.305756366796, 5668.348139963874, 5944.851378715567, 5951.464368206882, 6006.519478441714, 6033.849153771191, 3293.0, 3308.983455082709, 3331.8833840815455, 3337.365900478901, 3359.445691460882, 6184.443400094013, 6462.224533056064, 6552.3775241352, 6558.80323590293, 6562.77030303937, 6339.207599050119, 6362.300146983921, 6382.425581697669, 6448.9355106449275, 6468.6442245676, 6150.50795936324, 6473.546851720334, 6502.642354670538, 6552.213734351908, 6554.770583029666, 6245.5628106033955, 6263.123162757127, 6267.780627678009, 6295.213098362705, 6298.874022519432, 5996.781190959373, 6129.540284478593, 6165.691715414122, 6183.196184495987, 6184.257889053342, 6463.256725476443, 6488.545801793829, 6495.317991610813, 6586.407223349922, 6597.2742998271115, 4279.957200428081, 4322.222000040023, 4357.934630980474, 4362.890927726832, 4379.321205213197, 6046.54650901193, 6233.818163642689, 6235.282942461494, 6340.365963403623, 6341.778037768656, 6048.334683184934, 6071.39286071407, 6078.209832721895, 6108.938910611015, 6131.816045518642, 5916.674582897982, 6098.725557350019, 6145.938540614537, 6155.876882462415, 6158.33724894285, 5788.6526808389945, 5967.164596956516, 5990.400959904149, 6000.669963152069, 6009.784765150624, 6047.48596369296, 6075.848103797441, 6116.724747386289, 6118.357572454828, 6133.907991380043, 5722.284714410699, 5988.431099045583, 5989.3711160329285, 6004.639721616717, 6005.939940600713], "value": 4611.067744120174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.1898373151253, 818.4720855048494, 842.6081871929554, 901.7204666553367, 921.1525396635095, 16723.33106675733, 16926.576835579115, 17284.04937728426, 17313.91343043283, 17315.22081506332, 16218.675626487464, 16274.104924229192, 16309.510714678549, 16327.428540001103, 16353.672926541461, 885.327151364964, 885.5572213893054, 892.1970226795903, 903.2367649336301, 906.8503696890006, 854.2055888024136, 857.4298091768966, 858.6651206029653, 862.0732712334266, 862.9352798540135, 898.5731777405713, 909.1590278991939, 909.2089881802841, 911.7355966769629, 912.115248209236, 903.4669544968434, 904.0, 906.2206502407923, 906.7959709065474, 907.6324088744069, 660.247318057415, 660.6531570925255, 663.7278715726529, 663.9468842492589, 668.9464842812563, 15503.612409689735, 15621.140837253946, 15622.531324060297, 15633.0, 15659.686806263924, 14754.778678319833, 15207.771883421758, 15325.386984520606, 15443.150626715526, 15496.535103946899, 12258.44836982329, 12350.567730129402, 12766.297853618047, 12828.230306181658, 12980.415881285366, 3710.2950439416422, 3759.8496060157563, 3793.3930571108767, 3819.3888977763704, 3857.9421308680394, 52806.0, 60848.69575652093, 64470.355296446905, 66735.66632166857, 77660.61169694172, 11171.832422513506, 11336.376499292619, 11577.942110289394, 11977.461014254379, 12234.632961011184, 22515.211967581385, 22695.0, 22726.545469090524, 22742.317730468112, 22748.545029099325, 9203.953980230055, 9205.63177472907, 9254.398464099811, 9373.343865929455, 9413.670521531714, 4949.505049495022, 4998.850034498971, 5046.4953504649975, 5057.140286151363, 5154.639175257696, 3768.811559422018, 3851.0, 3854.6916246700757, 3874.341361968472, 3887.902802429962, 678.3860606151441, 686.7081490366575, 690.8411065454974, 709.570709720622, 711.6655172069119, 656.7602824968948, 656.9605823650596, 783.4241832253289, 809.9230573095547, 842.7092653034694, 10824.729381765519, 10986.395748233765, 11116.833247501294, 11328.433578321052, 11537.134714896249, 735.2537174767615, 754.4190972950797, 825.529448214524, 836.180543067797, 844.5144042175774, 5066.695998240118, 5095.821646242363, 5174.663646862942, 5207.843764687065, 5220.321358223407, 110823.0, 113239.0, 113619.0, 115201.0, 116674.0, 97624.51187744016, 99432.0, 99466.5026674862, 99694.5015274919, 100169.49915250378, 76733.61633191798, 78304.0, 79420.60289698515, 87818.99999999872, 88695.55652221826, 10462.21533384984, 10868.728281793019, 10902.236843420884, 10905.153702992218, 10938.726531836768, 50976.0, 52290.95418091693, 57621.0, 57647.77635578287, 58386.4161358398, 73490.26509734834, 73609.26390736025, 81738.18261817543, 81969.0, 82519.5874020626, 12931.418086185957, 13135.34323283813, 13143.408546615616, 13257.403416846073, 13811.17132972025, 15038.6992260152, 15196.544103676908, 15254.923725381303, 15348.23258837076, 15488.380464781734, 14518.0, 14609.123452592878, 15015.699686006437, 15218.0, 15248.237588120772, 13611.25138117413, 13813.309334533435, 13943.16341019542, 14423.49517766873, 14530.782038269223, 13844.030917835655, 14030.859691402955, 14386.705196532363, 14507.1295722257, 14588.635284117981, 11325.093992480746, 11542.307461552333, 11579.88420115788, 11793.174477786473, 11888.108391870817, 12034.879651203375, 12233.571824986082, 12270.815937760763, 12326.137170398344, 12336.938315308726], "value": 7997.191462078812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 110.0, 113.0, 113.0, 112.0, 111.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 134.0, 151.0, 172.0, 129.0, 151.0, 154.0, 135.0, 182.0, 126.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 163.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 171.0, 75.0, 75.0, 74.0, 75.0, 166.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 140.0, 84.0, 85.0, 84.0, 144.0, 85.0, 83.0, 143.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 122.0, 117.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 149.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 53.0, 51.0, 50.0, 54.0, 52.0, 57.0, 52.0, 56.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 60.0, 60.0, 58.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 82.0, 76.0, 77.0, 77.0, 77.0, 79.0, 111.0, 77.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 121.0, 117.0, 129.0, 130.0, 134.0, 121.0, 120.0, 132.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 153.0, 155.0, 155.0, 153.0, 156.0, 154.0, 156.0, 158.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 64.0], "value": 60.7, "unit": "score"}]}]} 06:55:28 INFO - Return code: 0 06:55:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:55:29 ERROR - # TBPL SUCCESS # 06:55:29 INFO - Running post-action listener: _resource_record_post_action 06:55:29 INFO - ##### 06:55:29 INFO - ##### Finished run-tests step (success) 06:55:29 INFO - ##### 06:55:29 INFO - Running post-run listener: _resource_record_post_run 06:55:29 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515104768; Read time: 8; Write time: 347864 06:55:29 INFO - TinderboxPrint: CPU usage
13.3% 06:55:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:55:29 INFO - TinderboxPrint: I/O write bytes / time
515,104,768 / 347,864 06:55:29 INFO - TinderboxPrint: CPU idle
8,213.7 (86.6%) 06:55:29 INFO - TinderboxPrint: CPU user
1,209.9 (12.8%) 06:55:29 INFO - TinderboxPrint: Swap in / out
0 / 0 06:55:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 263045120; Read time: 0; Write time: 200476 06:55:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 252059648; Read time: 8; Write time: 147388 06:55:29 INFO - Running post-run listener: _upload_blobber_files 06:55:29 INFO - Blob upload gear active. 06:55:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:55:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:55:29 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'] 06:55:29 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 06:55:30 INFO - (blobuploader) - INFO - Open directory for files ... 06:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:55:31 INFO - (blobuploader) - INFO - Done attempting. 06:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:55:31 INFO - (blobuploader) - INFO - Done attempting. 06:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:55:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:55:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:55:35 INFO - (blobuploader) - INFO - Done attempting. 06:55:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:55:35 INFO - Return code: 0 06:55:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:55:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:55:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16f69236ab5412e6c9e0c0e39a4a743f5d3ae03f88fdfa8fafc5305aa6deb6fcb6987696400bbadf6a1f4e4fd56b3f774aedf3528d4c95506925cb0cec0f3831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/669f4628d6c6c7cfe493b05c932328eec8e84c4e0d2758b3ac08897a57abcd687994bfd4d77b222ef7741d4854fc530e39f8ec722001c0d6f13b2a19e38c57ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977dd374d6e420506c653c59505fe2b7efc09ece491ebb4f2e56da1ddb7c8066c7c483082175c19df8505e6dbba214febe2997a862100e0c785ae4cb5ba8a4e8"} 06:55:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:55:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:55:35 INFO - Contents: 06:55:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16f69236ab5412e6c9e0c0e39a4a743f5d3ae03f88fdfa8fafc5305aa6deb6fcb6987696400bbadf6a1f4e4fd56b3f774aedf3528d4c95506925cb0cec0f3831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/669f4628d6c6c7cfe493b05c932328eec8e84c4e0d2758b3ac08897a57abcd687994bfd4d77b222ef7741d4854fc530e39f8ec722001c0d6f13b2a19e38c57ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977dd374d6e420506c653c59505fe2b7efc09ece491ebb4f2e56da1ddb7c8066c7c483082175c19df8505e6dbba214febe2997a862100e0c785ae4cb5ba8a4e8"} 06:55:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:55:35 INFO - Copying logs to upload dir... 06:55:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:55:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.449256 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-14 06:55:34.947001) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:34.951036) ========= 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=db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845 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/16f69236ab5412e6c9e0c0e39a4a743f5d3ae03f88fdfa8fafc5305aa6deb6fcb6987696400bbadf6a1f4e4fd56b3f774aedf3528d4c95506925cb0cec0f3831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/669f4628d6c6c7cfe493b05c932328eec8e84c4e0d2758b3ac08897a57abcd687994bfd4d77b222ef7741d4854fc530e39f8ec722001c0d6f13b2a19e38c57ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977dd374d6e420506c653c59505fe2b7efc09ece491ebb4f2e56da1ddb7c8066c7c483082175c19df8505e6dbba214febe2997a862100e0c785ae4cb5ba8a4e8"} build_url:https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/X4Xk-JlqSGWS2APglzQPXg/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/16f69236ab5412e6c9e0c0e39a4a743f5d3ae03f88fdfa8fafc5305aa6deb6fcb6987696400bbadf6a1f4e4fd56b3f774aedf3528d4c95506925cb0cec0f3831", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/669f4628d6c6c7cfe493b05c932328eec8e84c4e0d2758b3ac08897a57abcd687994bfd4d77b222ef7741d4854fc530e39f8ec722001c0d6f13b2a19e38c57ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/977dd374d6e420506c653c59505fe2b7efc09ece491ebb4f2e56da1ddb7c8066c7c483082175c19df8505e6dbba214febe2997a862100e0c785ae4cb5ba8a4e8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:34.976626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:34.976987) ========= 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=db7e7c15f3ca076d53731445000001ba-1468503061.308526-1626517845 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:55:35.063628) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:55:35.064024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 06:55:35.064356) ========= ========= Total master_lag: 0.17 =========