builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1468146677.21 results: success (0) buildid: 20160710004020 builduid: affcc8bb1298492488c88e7cb2823bcd revision: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.212184) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.212619) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.212911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.227926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.228202) ========= 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=6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-10 03:31:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.2M=0s 2016-07-10 03:31:18 (89.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106162 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.579340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.579666) ========= 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=6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019706 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.636858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:17.637172) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 --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 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 --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=6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-10 03:31:18,454 truncating revision to first 12 chars 2016-07-10 03:31:18,454 Setting DEBUG logging. 2016-07-10 03:31:18,454 attempt 1/10 2016-07-10 03:31:18,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e3b5b3c31e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-10 03:31:18,768 unpacking tar archive at: mozilla-aurora-8e3b5b3c31e5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737001 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:18.408455) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:18.408803) ========= script_repo_revision: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:18.409220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:18.409509) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:18.420226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-10 03:31:18.420639) ========= /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=6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:19 INFO - MultiFileLogger online at 20160710 03:31:19 in /builds/slave/test 03:31:19 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 03:31:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:19 INFO - {'append_to_log': False, 03:31:19 INFO - 'base_work_dir': '/builds/slave/test', 03:31:19 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:19 INFO - 'branch': 'Mozilla-Aurora', 03:31:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:19 INFO - 'config_files': ('talos/linux_config.py',), 03:31:19 INFO - 'default_actions': ('clobber', 03:31:19 INFO - 'read-buildbot-config', 03:31:19 INFO - 'download-and-extract', 03:31:19 INFO - 'populate-webroot', 03:31:19 INFO - 'create-virtualenv', 03:31:19 INFO - 'install', 03:31:19 INFO - 'run-tests'), 03:31:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:19 INFO - 'download_minidump_stackwalk': True, 03:31:19 INFO - 'download_symbols': 'ondemand', 03:31:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:19 INFO - 'installer_path': 'installer.exe', 03:31:19 INFO - 'log_level': 'info', 03:31:19 INFO - 'log_name': 'talos', 03:31:19 INFO - 'log_to_console': True, 03:31:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:19 INFO - 'opt_config_files': (), 03:31:19 INFO - 'pip_index': False, 03:31:19 INFO - 'sps_profile': False, 03:31:19 INFO - 'sps_profile_interval': 0, 03:31:19 INFO - 'suite': 'dromaeojs-e10s', 03:31:19 INFO - 'system_bits': '32', 03:31:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:19 INFO - 'title': 'talos-linux64-ix-050', 03:31:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:19 INFO - 'use_talos_json': True, 03:31:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:19 INFO - 'work_dir': 'build'} 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running clobber step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: clobber 03:31:19 INFO - rmtree: /builds/slave/test/build 03:31:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:19 INFO - Running post-action listener: _resource_record_post_action 03:31:19 INFO - ##### 03:31:19 INFO - ##### Finished clobber step (success) 03:31:19 INFO - ##### 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running read-buildbot-config step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: read_buildbot_config 03:31:19 INFO - Using buildbot properties: 03:31:19 INFO - { 03:31:19 INFO - "project": "", 03:31:19 INFO - "product": "firefox", 03:31:19 INFO - "script_repo_revision": "production", 03:31:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:31:19 INFO - "repository": "", 03:31:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:31:19 INFO - "buildid": "20160710004020", 03:31:19 INFO - "stage_platform": "linux64-pgo", 03:31:19 INFO - "basedir": "/builds/slave/test", 03:31:19 INFO - "nightly_build": "True", 03:31:19 INFO - "buildnumber": 393, 03:31:19 INFO - "slavename": "talos-linux64-ix-050", 03:31:19 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:31:19 INFO - "platform": "ubuntu64_hw", 03:31:19 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:19 INFO - "branch": "mozilla-aurora", 03:31:19 INFO - "repo_path": "releases/mozilla-aurora", 03:31:19 INFO - "revision": "8e3b5b3c31e5fffedaa5bc253222a6ca567bf421", 03:31:19 INFO - "pgo_build": "True", 03:31:19 INFO - "builduid": "affcc8bb1298492488c88e7cb2823bcd", 03:31:19 INFO - "slavebuilddir": "test" 03:31:19 INFO - } 03:31:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:31:19 INFO - Running post-action listener: _resource_record_post_action 03:31:19 INFO - ##### 03:31:19 INFO - ##### Finished read-buildbot-config step (success) 03:31:19 INFO - ##### 03:31:19 INFO - ##### 03:31:19 INFO - ##### Running download-and-extract step. 03:31:19 INFO - ##### 03:31:19 INFO - Running pre-action listener: _resource_record_pre_action 03:31:19 INFO - Running main action method: download_and_extract 03:31:19 INFO - mkdir: /builds/slave/test/build/tests 03:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:19 INFO - https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:31:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:22 INFO - Downloaded 1361 bytes. 03:31:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:23 INFO - Using the following test package requirements: 03:31:23 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:23 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:23 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:23 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'jsshell-linux-x86_64.zip'], 03:31:23 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:23 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:23 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:23 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:23 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:23 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:23 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:23 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31: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')]} 03:31:23 INFO - https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:25 INFO - Downloaded 24526733 bytes. 03:31:25 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'] 03:31:25 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 03:31:26 INFO - Return code: 0 03:31:26 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 03:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:26 INFO - https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:31:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:31:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:28 INFO - Downloaded 24526733 bytes. 03:31:28 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'] 03:31:28 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 03:31:30 INFO - Return code: 0 03:31:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:30 INFO - https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:31:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:31:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:31 INFO - Downloaded 10833369 bytes. 03:31:31 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'] 03:31:31 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 03:31:32 INFO - Return code: 0 03:31: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')]} 03:31:32 INFO - https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZIklfqlSR-tlGzsbTNWFw/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 03:31:33 INFO - Downloaded 63609545 bytes. 03:31:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:33 INFO - mkdir: /builds/slave/test/properties 03:31:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:33 INFO - Contents: 03:31:33 INFO - build_url:https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:31:34 INFO - Running post-action listener: _resource_record_post_action 03:31:34 INFO - Running post-action listener: set_extra_try_arguments 03:31:34 INFO - ##### 03:31:34 INFO - ##### Finished download-and-extract step (success) 03:31:34 INFO - ##### 03:31:34 INFO - ##### 03:31:34 INFO - ##### Running populate-webroot step. 03:31:34 INFO - ##### 03:31:34 INFO - Running pre-action listener: _resource_record_pre_action 03:31:34 INFO - Running main action method: populate_webroot 03:31:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:34 INFO - '--tppagecycles', 03:31:34 INFO - '7'], 03:31:34 INFO - 'tests': ['tsvgm']}}, 03:31:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['damp', 'tps']}, 03:31:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'tests': ['damp', 'tps']}, 03:31:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['dromaeo_dom']}, 03:31:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['a11yr', 03:31:34 INFO - 'ts_paint', 03:31:34 INFO - 'tpaint', 03:31:34 INFO - 'sessionrestore', 03:31:34 INFO - 'sessionrestore_no_auto_restore', 03:31:34 INFO - 'tabpaint']}, 03:31:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tsvgx', 03:31:34 INFO - 'tsvgr_opacity', 03:31:34 INFO - 'tart', 03:31:34 INFO - 'tscrollx', 03:31:34 INFO - 'cart']}, 03:31:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:34 INFO - 'tsvgr_opacity', 03:31:34 INFO - 'tart', 03:31:34 INFO - 'tscrollx', 03:31:34 INFO - 'cart']}, 03:31:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s'], 03:31:34 INFO - 'tests': ['tp5o']}, 03:31:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'tests': ['tp5o']}, 03:31:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--disable-e10s', 03:31:34 INFO - '--xperf_path', 03:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:34 INFO - 'tests': ['tp5n']}, 03:31:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:34 INFO - 'talos_options': ['--xperf_path', 03:31:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:34 INFO - 'tests': ['tp5n']}}, 03:31:34 INFO - 'talos.zip': {'path': '', 03:31:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:34 INFO - Running post-action listener: _resource_record_post_action 03:31:34 INFO - ##### 03:31:34 INFO - ##### Finished populate-webroot step (success) 03:31:34 INFO - ##### 03:31:34 INFO - ##### 03:31:34 INFO - ##### Running create-virtualenv step. 03:31:34 INFO - ##### 03:31:34 INFO - Running pre-action listener: _resource_record_pre_action 03:31:34 INFO - Running main action method: create_virtualenv 03:31:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:34 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 03:31:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:34 INFO - Using real prefix '/usr' 03:31:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:37 INFO - Installing pip.................done. 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:37 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')]} 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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')]} 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:37 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 03:31:37 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 03:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 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 03:31:37 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31:37 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')]} 03:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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')]} 03:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:37 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 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:37 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 03:31:37 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 03:31:37 INFO - Using env: {'DISPLAY': ':0', 03:31:37 INFO - 'HOME': '/home/cltbld', 03:31:37 INFO - 'LANG': 'en_US.UTF-8', 03:31:37 INFO - 'LANGUAGE': 'en_US:en', 03:31:37 INFO - 'LOGNAME': 'cltbld', 03:31:37 INFO - 'MAIL': '/var/mail/cltbld', 03:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:37 INFO - 'MOZ_NO_REMOTE': '1', 03:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:37 INFO - 'NO_EM_RESTART': '1', 03:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:37 INFO - 'PWD': '/builds/slave/test', 03:31:37 INFO - 'SHELL': '/bin/bash', 03:31:37 INFO - 'SHLVL': '1', 03:31:37 INFO - 'TERM': 'linux', 03:31:37 INFO - 'TMOUT': '86400', 03:31:37 INFO - 'USER': 'cltbld', 03:31:37 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:37 INFO - '_': '/tools/buildbot/bin/python'} 03:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:37 INFO - Downloading/unpacking psutil>=3.1.1 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:39 INFO - Installing collected packages: psutil 03:31:39 INFO - Running setup.py install for psutil 03:31:39 INFO - building 'psutil._psutil_linux' extension 03:31:39 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 03:31:39 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 03:31:40 INFO - building 'psutil._psutil_posix' extension 03:31:40 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 03:31:40 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 03:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:40 INFO - Successfully installed psutil 03:31:40 INFO - Cleaning up... 03:31:40 INFO - Return code: 0 03:31:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:31:40 INFO - Using env: {'DISPLAY': ':0', 03:31:40 INFO - 'HOME': '/home/cltbld', 03:31:40 INFO - 'LANG': 'en_US.UTF-8', 03:31:40 INFO - 'LANGUAGE': 'en_US:en', 03:31:40 INFO - 'LOGNAME': 'cltbld', 03:31:40 INFO - 'MAIL': '/var/mail/cltbld', 03:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:40 INFO - 'MOZ_NO_REMOTE': '1', 03:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:40 INFO - 'NO_EM_RESTART': '1', 03:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:40 INFO - 'PWD': '/builds/slave/test', 03:31:40 INFO - 'SHELL': '/bin/bash', 03:31:40 INFO - 'SHLVL': '1', 03:31:40 INFO - 'TERM': 'linux', 03:31:40 INFO - 'TMOUT': '86400', 03:31:40 INFO - 'USER': 'cltbld', 03:31:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:40 INFO - '_': '/tools/buildbot/bin/python'} 03:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:31:42 INFO - Installing collected packages: mozsystemmonitor 03:31:42 INFO - Running setup.py install for mozsystemmonitor 03:31:42 INFO - Successfully installed mozsystemmonitor 03:31:42 INFO - Cleaning up... 03:31:42 INFO - Return code: 0 03:31:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:31:42 INFO - Using env: {'DISPLAY': ':0', 03:31:42 INFO - 'HOME': '/home/cltbld', 03:31:42 INFO - 'LANG': 'en_US.UTF-8', 03:31:42 INFO - 'LANGUAGE': 'en_US:en', 03:31:42 INFO - 'LOGNAME': 'cltbld', 03:31:42 INFO - 'MAIL': '/var/mail/cltbld', 03:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:42 INFO - 'MOZ_NO_REMOTE': '1', 03:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:42 INFO - 'NO_EM_RESTART': '1', 03:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:42 INFO - 'PWD': '/builds/slave/test', 03:31:42 INFO - 'SHELL': '/bin/bash', 03:31:42 INFO - 'SHLVL': '1', 03:31:42 INFO - 'TERM': 'linux', 03:31:42 INFO - 'TMOUT': '86400', 03:31:42 INFO - 'USER': 'cltbld', 03:31:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:42 INFO - '_': '/tools/buildbot/bin/python'} 03:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:42 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:44 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:44 INFO - warning: no files found matching '*.txt' 03:31:44 INFO - no previously-included directories found matching 'build' 03:31:44 INFO - no previously-included directories found matching 'dist' 03:31:44 INFO - no previously-included directories found matching '.git*' 03:31:44 INFO - Installing collected packages: jsonschema, functools32 03:31:45 INFO - Running setup.py install for functools32 03:31:45 INFO - warning: no files found matching '*.txt' 03:31:45 INFO - no previously-included directories found matching 'build' 03:31:45 INFO - no previously-included directories found matching 'dist' 03:31:45 INFO - no previously-included directories found matching '.git*' 03:31:45 INFO - Successfully installed jsonschema functools32 03:31:45 INFO - Cleaning up... 03:31:45 INFO - Return code: 0 03:31:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:45 INFO - Using env: {'DISPLAY': ':0', 03:31:45 INFO - 'HOME': '/home/cltbld', 03:31:45 INFO - 'LANG': 'en_US.UTF-8', 03:31:45 INFO - 'LANGUAGE': 'en_US:en', 03:31:45 INFO - 'LOGNAME': 'cltbld', 03:31:45 INFO - 'MAIL': '/var/mail/cltbld', 03:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:45 INFO - 'MOZ_NO_REMOTE': '1', 03:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:45 INFO - 'NO_EM_RESTART': '1', 03:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:45 INFO - 'PWD': '/builds/slave/test', 03:31:45 INFO - 'SHELL': '/bin/bash', 03:31:45 INFO - 'SHLVL': '1', 03:31:45 INFO - 'TERM': 'linux', 03:31:45 INFO - 'TMOUT': '86400', 03:31:45 INFO - 'USER': 'cltbld', 03:31:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:45 INFO - '_': '/tools/buildbot/bin/python'} 03:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:47 INFO - Downloading docopt-0.6.1.tar.gz 03:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:48 INFO - Running setup.py install for blobuploader 03:31:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:48 INFO - Running setup.py install for requests 03:31:48 INFO - Running setup.py install for docopt 03:31:48 INFO - Successfully installed blobuploader requests docopt 03:31:48 INFO - Cleaning up... 03:31:48 INFO - Return code: 0 03:31:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:48 INFO - Using env: {'DISPLAY': ':0', 03:31:48 INFO - 'HOME': '/home/cltbld', 03:31:48 INFO - 'LANG': 'en_US.UTF-8', 03:31:48 INFO - 'LANGUAGE': 'en_US:en', 03:31:48 INFO - 'LOGNAME': 'cltbld', 03:31:48 INFO - 'MAIL': '/var/mail/cltbld', 03:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:48 INFO - 'MOZ_NO_REMOTE': '1', 03:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:48 INFO - 'NO_EM_RESTART': '1', 03:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:48 INFO - 'PWD': '/builds/slave/test', 03:31:48 INFO - 'SHELL': '/bin/bash', 03:31:48 INFO - 'SHLVL': '1', 03:31:48 INFO - 'TERM': 'linux', 03:31:48 INFO - 'TMOUT': '86400', 03:31:48 INFO - 'USER': 'cltbld', 03:31:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:48 INFO - '_': '/tools/buildbot/bin/python'} 03:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:48 INFO - Running setup.py (path:/tmp/pip-6uV8qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:48 INFO - Running setup.py (path:/tmp/pip-i0DY0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:48 INFO - Running setup.py (path:/tmp/pip-yhE3Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:49 INFO - Running setup.py (path:/tmp/pip-mCIhzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:49 INFO - Running setup.py (path:/tmp/pip-OKfmQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:49 INFO - Running setup.py (path:/tmp/pip-KdEN3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:49 INFO - Running setup.py (path:/tmp/pip-bGNzHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:49 INFO - Running setup.py (path:/tmp/pip-8cDmY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:49 INFO - Running setup.py (path:/tmp/pip-GnBdMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:49 INFO - Running setup.py (path:/tmp/pip-6jcbh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:49 INFO - Running setup.py (path:/tmp/pip-Arbyb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:49 INFO - Running setup.py (path:/tmp/pip-2_rqwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:49 INFO - Running setup.py (path:/tmp/pip-h3gj1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:49 INFO - Running setup.py (path:/tmp/pip-MWEHsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:49 INFO - Running setup.py (path:/tmp/pip-BPjRud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:49 INFO - Running setup.py (path:/tmp/pip-y_eeMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:50 INFO - Running setup.py (path:/tmp/pip-LtM2sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:50 INFO - Running setup.py install for manifestparser 03:31:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozcrash 03:31:50 INFO - Running setup.py install for mozdebug 03:31:50 INFO - Running setup.py install for mozdevice 03:31:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozfile 03:31:50 INFO - Running setup.py install for mozhttpd 03:31:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozinfo 03:31:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozInstall 03:31:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:50 INFO - Running setup.py install for mozleak 03:31:50 INFO - Running setup.py install for mozlog 03:31:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for moznetwork 03:31:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozprocess 03:31:51 INFO - Running setup.py install for mozprofile 03:31:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozrunner 03:31:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Running setup.py install for mozscreenshot 03:31:51 INFO - Running setup.py install for moztest 03:31:51 INFO - Running setup.py install for mozversion 03:31:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:51 INFO - Cleaning up... 03:31:51 INFO - Return code: 0 03:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:51 INFO - Using env: {'DISPLAY': ':0', 03:31:51 INFO - 'HOME': '/home/cltbld', 03:31:51 INFO - 'LANG': 'en_US.UTF-8', 03:31:51 INFO - 'LANGUAGE': 'en_US:en', 03:31:51 INFO - 'LOGNAME': 'cltbld', 03:31:51 INFO - 'MAIL': '/var/mail/cltbld', 03:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:51 INFO - 'MOZ_NO_REMOTE': '1', 03:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:51 INFO - 'NO_EM_RESTART': '1', 03:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:51 INFO - 'PWD': '/builds/slave/test', 03:31:51 INFO - 'SHELL': '/bin/bash', 03:31:51 INFO - 'SHLVL': '1', 03:31:51 INFO - 'TERM': 'linux', 03:31:51 INFO - 'TMOUT': '86400', 03:31:51 INFO - 'USER': 'cltbld', 03:31:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:51 INFO - '_': '/tools/buildbot/bin/python'} 03:31:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:52 INFO - Running setup.py (path:/tmp/pip-eTNTiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:52 INFO - Running setup.py (path:/tmp/pip-LQem8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:52 INFO - Running setup.py (path:/tmp/pip-_KQq4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:52 INFO - Running setup.py (path:/tmp/pip-jVZ0FL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:52 INFO - Running setup.py (path:/tmp/pip-r5vqOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:52 INFO - Running setup.py (path:/tmp/pip-TlSkmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:52 INFO - Running setup.py (path:/tmp/pip-4RTRIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:52 INFO - Running setup.py (path:/tmp/pip-vTEFnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:52 INFO - Running setup.py (path:/tmp/pip-hFYFQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:52 INFO - Running setup.py (path:/tmp/pip-Z6AsCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:52 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)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:52 INFO - Running setup.py (path:/tmp/pip-orrLGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:52 INFO - Running setup.py (path:/tmp/pip-a2IQY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:52 INFO - Running setup.py (path:/tmp/pip-49EmBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:53 INFO - Running setup.py (path:/tmp/pip-tPtzwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:53 INFO - Running setup.py (path:/tmp/pip-rZBVgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:53 INFO - Running setup.py (path:/tmp/pip-h95Ez8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:53 INFO - Running setup.py (path:/tmp/pip-Te9oy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:31:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:55 INFO - Downloading blessings-1.6.tar.gz 03:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:55 INFO - Installing collected packages: blessings 03:31:55 INFO - Running setup.py install for blessings 03:31:55 INFO - Successfully installed blessings 03:31:55 INFO - Cleaning up... 03:31:55 INFO - Return code: 0 03:31:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:55 INFO - Reading from file tmpfile_stdout 03:31:55 INFO - Current package versions: 03:31:55 INFO - argparse == 1.2.1 03:31:55 INFO - blessings == 1.6 03:31:55 INFO - blobuploader == 1.2.4 03:31:55 INFO - docopt == 0.6.1 03:31:55 INFO - functools32 == 3.2.3-2 03:31:55 INFO - jsonschema == 2.5.1 03:31:55 INFO - manifestparser == 1.1 03:31:55 INFO - mozInstall == 1.12 03:31:55 INFO - mozcrash == 0.17 03:31:55 INFO - mozdebug == 0.1 03:31:55 INFO - mozdevice == 0.48 03:31:55 INFO - mozfile == 1.2 03:31:55 INFO - mozhttpd == 0.7 03:31:55 INFO - mozinfo == 0.9 03:31:55 INFO - mozleak == 0.1 03:31:55 INFO - mozlog == 3.2 03:31:55 INFO - moznetwork == 0.27 03:31:55 INFO - mozprocess == 0.22 03:31:55 INFO - mozprofile == 0.28 03:31:55 INFO - mozrunner == 6.11 03:31:55 INFO - mozscreenshot == 0.1 03:31:55 INFO - mozsystemmonitor == 0.3 03:31:55 INFO - moztest == 0.7 03:31:55 INFO - mozversion == 1.4 03:31:55 INFO - psutil == 3.1.1 03:31:55 INFO - requests == 1.2.3 03:31:55 INFO - wsgiref == 0.1.2 03:31:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:31:55 INFO - Using env: {'DISPLAY': ':0', 03:31:55 INFO - 'HOME': '/home/cltbld', 03:31:55 INFO - 'LANG': 'en_US.UTF-8', 03:31:55 INFO - 'LANGUAGE': 'en_US:en', 03:31:55 INFO - 'LOGNAME': 'cltbld', 03:31:55 INFO - 'MAIL': '/var/mail/cltbld', 03:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:55 INFO - 'MOZ_NO_REMOTE': '1', 03:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:55 INFO - 'NO_EM_RESTART': '1', 03:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:55 INFO - 'PWD': '/builds/slave/test', 03:31:55 INFO - 'SHELL': '/bin/bash', 03:31:55 INFO - 'SHLVL': '1', 03:31:55 INFO - 'TERM': 'linux', 03:31:55 INFO - 'TMOUT': '86400', 03:31:55 INFO - 'USER': 'cltbld', 03:31:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:55 INFO - '_': '/tools/buildbot/bin/python'} 03:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:31:55 INFO - Cleaning up... 03:31:55 INFO - Return code: 0 03:31:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:31:55 INFO - Using env: {'DISPLAY': ':0', 03:31:55 INFO - 'HOME': '/home/cltbld', 03:31:55 INFO - 'LANG': 'en_US.UTF-8', 03:31:55 INFO - 'LANGUAGE': 'en_US:en', 03:31:55 INFO - 'LOGNAME': 'cltbld', 03:31:55 INFO - 'MAIL': '/var/mail/cltbld', 03:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:55 INFO - 'MOZ_NO_REMOTE': '1', 03:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:55 INFO - 'NO_EM_RESTART': '1', 03:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:55 INFO - 'PWD': '/builds/slave/test', 03:31:55 INFO - 'SHELL': '/bin/bash', 03:31:55 INFO - 'SHLVL': '1', 03:31:55 INFO - 'TERM': 'linux', 03:31:55 INFO - 'TMOUT': '86400', 03:31:55 INFO - 'USER': 'cltbld', 03:31:55 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:55 INFO - '_': '/tools/buildbot/bin/python'} 03:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:56 INFO - Cleaning up... 03:31:56 INFO - Return code: 0 03:31:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:56 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 0x7f08da5eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, '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': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', '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 03:31:56 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 03:31:56 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 03:31:56 INFO - Using env: {'DISPLAY': ':0', 03:31:56 INFO - 'HOME': '/home/cltbld', 03:31:56 INFO - 'LANG': 'en_US.UTF-8', 03:31:56 INFO - 'LANGUAGE': 'en_US:en', 03:31:56 INFO - 'LOGNAME': 'cltbld', 03:31:56 INFO - 'MAIL': '/var/mail/cltbld', 03:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:56 INFO - 'MOZ_NO_REMOTE': '1', 03:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:56 INFO - 'NO_EM_RESTART': '1', 03:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:56 INFO - 'PWD': '/builds/slave/test', 03:31:56 INFO - 'SHELL': '/bin/bash', 03:31:56 INFO - 'SHLVL': '1', 03:31:56 INFO - 'TERM': 'linux', 03:31:56 INFO - 'TMOUT': '86400', 03:31:56 INFO - 'USER': 'cltbld', 03:31:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:56 INFO - '_': '/tools/buildbot/bin/python'} 03:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:56 INFO - Downloading/unpacking flake8 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:58 INFO - no previously-included directories found matching 'docs/_build' 03:31:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:59 INFO - Running setup.py install for pep8 03:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:59 INFO - no previously-included directories found matching 'docs/_build' 03:31:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:59 INFO - Cleaning up... 03:31:59 INFO - Return code: 0 03:31:59 INFO - Running post-action listener: _resource_record_post_action 03:31:59 INFO - Running post-action listener: _start_resource_monitoring 03:31:59 INFO - Starting resource monitoring. 03:31:59 INFO - ##### 03:31:59 INFO - ##### Finished create-virtualenv step (success) 03:31:59 INFO - ##### 03:31:59 INFO - ##### 03:31:59 INFO - ##### Running install step. 03:31:59 INFO - ##### 03:31:59 INFO - Running pre-action listener: _resource_record_pre_action 03:31:59 INFO - Running main action method: install 03:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:59 INFO - Reading from file tmpfile_stdout 03:31:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:59 INFO - Reading from file tmpfile_stdout 03:31:59 INFO - Output received: 03:31:59 INFO - Usage: mozinstall [options] installer 03:31:59 INFO - Options: 03:31:59 INFO - -h, --help show this help message and exit 03:31:59 INFO - -d DEST, --destination=DEST 03:31:59 INFO - Directory to install application into. [default: 03:31:59 INFO - "/builds/slave/test"] 03:31:59 INFO - --app=APP Application being installed. [default: firefox] 03:31:59 INFO - mkdir: /builds/slave/test/build/application 03:31:59 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'] 03:31:59 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 03:32:15 INFO - Reading from file tmpfile_stdout 03:32:15 INFO - Output received: 03:32:15 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:15 INFO - Running post-action listener: _resource_record_post_action 03:32:15 INFO - ##### 03:32:15 INFO - ##### Finished install step (success) 03:32:15 INFO - ##### 03:32:15 INFO - ##### 03:32:15 INFO - ##### Running run-tests step. 03:32:15 INFO - ##### 03:32:15 INFO - Running pre-action listener: _resource_record_pre_action 03:32:15 INFO - Running main action method: run_tests 03:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:15 INFO - Python 2.7.3 03:32:15 INFO - Return code: 0 03:32:15 INFO - grabbing minidump binary from tooltool 03:32:15 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')]} 03:32:15 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 0xe331c0>, '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 0xe340c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:15 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 03:32:15 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 03:32:15 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 03:32:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:15 INFO - Return code: 0 03:32:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:16 INFO - Return code: 0 03:32:16 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/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:32:16 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/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 03:32:16 INFO - Using env: {'DISPLAY': ':0', 03:32:16 INFO - 'HOME': '/home/cltbld', 03:32:16 INFO - 'LANG': 'en_US.UTF-8', 03:32:16 INFO - 'LANGUAGE': 'en_US:en', 03:32:16 INFO - 'LOGNAME': 'cltbld', 03:32:16 INFO - 'MAIL': '/var/mail/cltbld', 03:32:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:16 INFO - 'MOZ_NO_REMOTE': '1', 03:32:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:16 INFO - 'NO_EM_RESTART': '1', 03:32:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:16 INFO - 'PWD': '/builds/slave/test', 03:32:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:16 INFO - 'SHELL': '/bin/bash', 03:32:16 INFO - 'SHLVL': '1', 03:32:16 INFO - 'TERM': 'linux', 03:32:16 INFO - 'TMOUT': '86400', 03:32:16 INFO - 'USER': 'cltbld', 03:32:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875', 03:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:16 INFO - '_': '/tools/buildbot/bin/python'} 03:32:16 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/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 03:32:16 INFO - mozversion application_buildid: 20160710004020 03:32:16 INFO - mozversion application_changeset: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 03:32:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:16 INFO - mozversion application_name: Firefox 03:32:16 INFO - mozversion application_remotingname: firefox-dev 03:32:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:16 INFO - mozversion application_vendor: Mozilla 03:32:16 INFO - mozversion application_version: 49.0a2 03:32:16 INFO - mozversion platform_buildid: 20160710004020 03:32:16 INFO - mozversion platform_changeset: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 03:32:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:16 INFO - mozversion platform_version: 49.0a2 03:32:16 INFO - using testdate: 1468146736 03:32:16 INFO - actual date: 1468146736 03:32:16 INFO - starting webserver on 'localhost:39561' 03:32:16 INFO - SUITE-START | Running 2 tests 03:32:16 INFO - TEST-START | dromaeo_css 03:32:16 INFO - operating with platform_type : linux_ 03:32:16 INFO - Initialising browser for dromaeo_css test... 03:32:16 INFO - TEST-INFO | started process 7705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmA9ZXi/profile http://localhost:39561/getInfo.html) 03:32:20 INFO - PROCESS | 7705 | __metrics Screen width/height:1600/1200 03:32:20 INFO - PROCESS | 7705 | colorDepth:24 03:32:20 INFO - PROCESS | 7705 | Browser inner width/height: 1024/697 03:32:20 INFO - PROCESS | 7705 | __metrics 03:32:21 ERROR - PROCESS | 7705 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:32:22 INFO - TEST-INFO | 7705: exit 0 03:32:22 INFO - Browser initialized. 03:32:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:22 INFO - TEST-INFO | started process 7831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmA9ZXi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:34 INFO - PROCESS | 7831 | RSS: Main: 156295168 03:32:34 INFO - PROCESS | 7831 | 03:33:23 INFO - PROCESS | 7831 | 1468146803674 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] 03:35:31 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:39561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39561/tests/dromaeo/cssquery-ext.html) 03:35:32 INFO - PROCESS | 7831 | RSS: Main: 158892032 03:35:32 INFO - PROCESS | 7831 | 03:38:34 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:39561/tests/dromaeo/cssquery-ext.html (next: http://localhost:39561/tests/dromaeo/cssquery-jquery.html) 03:38:35 INFO - PROCESS | 7831 | RSS: Main: 156987392 03:38:35 INFO - PROCESS | 7831 | 03:41:37 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:39561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39561/tests/dromaeo/cssquery-mootools.html) 03:41:37 INFO - PROCESS | 7831 | RSS: Main: 156098560 03:41:37 INFO - PROCESS | 7831 | 03:44:39 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:39561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39561/tests/dromaeo/cssquery-prototype.html) 03:44:40 INFO - PROCESS | 7831 | RSS: Main: 155557888 03:44:40 INFO - PROCESS | 7831 | 03:47:42 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:39561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39561/tests/dromaeo/cssquery-yui.html) 03:47:43 INFO - PROCESS | 7831 | RSS: Main: 158322688 03:47:43 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | Cycle 1(1): loaded http://localhost:39561/tests/dromaeo/cssquery-yui.html (next: http://localhost:39561/tests/dromaeo/cssquery-dojo.html) 03:50:45 INFO - PROCESS | 7831 | RSS: Main: 158851072 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | __start_tp_report 03:50:45 INFO - PROCESS | 7831 | _x_x_mozilla_page_load 03:50:45 INFO - PROCESS | 7831 | _x_x_mozilla_page_load_details 03:50:45 INFO - PROCESS | 7831 | |i|pagename|runs| 03:50:45 INFO - PROCESS | 7831 | |0;dojo.html;3343.7826541274817;3371;3404.4212483877736;3411.266577685798;3419.093940105871;5665.263515742953;5667;5668.773249070037;5722.084466485363;5730.541556675466;5667.603267771257;5770.307563092424;5770.798022069229;5771.076627739562;5790.044642633971;5052.14113600687;5146.382434107913;5174.301469301634;5188.844334669947;5199.792008319662;5069.112905241586;5112.616553758465;5152.407473140581;5154.175331946889;5178.378594568657;5133.871653208681;5153.3558305211845;5180.197069454241;5209.921851172236;5217.791288348461;5190.4290528042075;5192.558632516222;5285.814996475105;5288.603354748409;5319.175527793198;5127.615428842814;5190.32525771651;5240.580753539746;5250.579953603703;5257.894842103175;5360.571154307646;5508.614396992212;5519.834404967817;5579.358373787026;5605.607607467479;6059.515238780887;6085.726142323606;6107.114468402056;6109.63342199465;6141.50867930569;6005.879882402372;6134.96932515339;6155.230596175478;6169.198004259418;6176.104464852616;5631.521320687746;5668.744906479218;5684.459976302244;5732.512736417368;5734.598578099576;6301.464375528039;6307.842303942438;6320.683965801783;6327.335629758901;6345.270293916166;5833.766649334064;5987.251593550806;6047.516198704093;6063.818085457355;6078.787242446581;6114.908276375858;6207.596506227081;6210.006398976232;6210.254769427697;6213.409726076015;6056.848578785565;6152.046432802923;6170.598911070856;6181.598196117238;6181.876362472725;5959.76160953557;5992.880142397127;5998.4601385875485;6165.691715414211;6176.35148309421;4650.395448591661;4663.883402914954;4664.370310008173;4686.695364801345;4689.812407503661;4159.584041595816;4170.186813571385;4175.874723758292;4176.102138040336;4189.874303770892;5779.826605201851;5788.507976821933;5844.1818145459665;5853.297604287428;5866.325372582122;6043.576949613484;6074.088886667036;6080.935836228642;6121.846953826101;6138.785142519991;5830.82507524775;5836.7957121501395;5837.270341207349;5837.9124313135335;5854.2974843018255;5122.308488354024;5135.435102138762;5165.147750621106;5170.870728231825;5184.662996905189;6078.179445774852;6113.541484388688;6117.663528505975;6123.050927106306;6177.444030037228;6139.785107521216;6141.815745527641;6162.352952939877;6168.25980882297;6188.133661287334;6021.759129634941;6023.397660233942;6046.879062418815;6061.545384096298;6088.543359248163;5855.121731740102;5942.910856337245;5960.433758792908;5974.910376344272;5975.611585246945;6035.517158627387;6039.486643635164;6044.335123136363;6106.542009349228;6127.111568822585;5868.559858010581;5949.702514874152;5960.493358064613;6002.369751176064;6056.636601803906;5964.463198312173;6002.909956350571;6014.1580178775885;6042.75828966854;6051.4553690168095;5742.1673857289625;5903.291605007426;5940.881182376242;5945.613535120204;5950.851228719317;5979.970100149471;5993.520518358608;6014.338422773579;6097.7865774697675;6110.358412366638;5915;5931.288245410578;5946.494547963299;5948.256467941507;5961.970190149022 03:50:45 INFO - PROCESS | 7831 | |1;ext.html;642.4731719989608;647.5434818452991;655.8852200864848;667.4960404894302;675.4832553096878;33067.173320666996;36092.819535902316;44181.33727994079;45877.31184032242;45939.08121837561;48555.757221213935;49144.50855491444;49163.262551061765;49237;49324.26013609799;8852.601632926502;8957.95521022394;8964.641414343418;8986;8997.190252877239;8856.468611883276;8912;8945.686900958468;8957.37298389113;8961.417507862001;8974.192322690957;8979.595918183664;8995.550222488882;8996.460212387277;9011.594478248495;8918.375713700043;8965.237954773787;8987.325950553735;8987.999999999967;9009.954950225272;8938.1508756668;8973.820523589557;9021.097890210993;9029.097090290985;9050.5927233274;43735.12529749387;44223.557764422265;44624.330635040504;44655;44794.77602611966;3834.5206849143856;4027.597240275978;4179.2059508693255;4226.767527785971;4498.685092043558;34119.61710529599;34511;34718.30563388743;34879.4768078479;34895;4440.222960981815;4474.373587697725;4489.9775501122285;4504.166729155117;4575.702579332333;358821;361012;363581;363911;364917;38123.42814857779;55873.720631397395;56101.7194914031;56158;62101.06848397278;39004.80497597494;40720;40781.79609101936;40949.59050409518;41000.17999639991;14351.712965740626;14368.209748463725;14417.495387661382;14438.566842994727;14546.418143274363;12496;12528.373581320897;12612.369381530887;12623.179493332904;12662.113652044452;9087.545622718837;9122.361434699507;9186.356955013085;9212.216961558208;9235.307351948632;3445.6554344565843;3466;3501.5798104227656;3545.503629491873;3606.9819650902105;1033.3231733214757;1038.1953985661023;1146.340854008948;1174.4773575758704;1191.4400231890997;33636.32727345439;33722.662773372445;33842.49236261458;33973.490397644055;34178.48732269018;1164.5691094294996;1182.9349385783692;1266.7339858629607;1272.7772639788;1287.8454585449806;17502.562435939202;17699.557511062325;17804.287828486715;17894.91052544729;17928.55178620519;549227;555786;560902;569599;817188;64088.67955660285;64535;64545;64612.35387646157;64636.353636463034;1465.1355700136971;1467.882569394446;1469.4563011685746;1472.786445965329;1481.7703255995339;33203.667963320055;33874.83062584671;33883.83058084793;33898.8305058483;34160.82919585386;55010.44989550053;55601;55692;55781.163282549984;56216.156757649485;519972;520800;521809;525585;529190;30734.077977660705;31516;31674.366512669156;31776.682233177373;31798.682013179572;50793;51746;52451.475485246185;52505.21242181447;52904.47095528995;41881.37177942394;43568;44020;44129.33805992977;45120.09759804851;41738;43843.34234986414;44803.10393792171;45022.099558009315;45361.319580205665;43941.560584393745;44011.11977760491;44205.11589768122;44338.77830610827;44886.77556612196;37800.243995120494;39238.411423828096;39327.41008884812;39586;39796.40305395363;29073.273168170967;30074.69925300719;30165.3966920656;30239.244018899702;30388.392232155675 03:50:45 INFO - PROCESS | 7831 | |2;jquery.html;418.6650679456434;426.4179395125652;430.52642093696954;431.1678460571097;436.00590653310445;17888.19503122361;19189.616207675837;19842.20631174753;20428;20465.693014604756;18878.716819247722;18998.810011899877;19845.305414310504;20159;20176.69734953977;5602.2436971009;5910.4089591040765;5918.1418694289305;5921.496672782819;5939.495142912858;5687.402822703619;5737.7991770288045;5758.856028599276;5796.30444346679;5803.6227645203135;5763.481286684198;5770.134479828039;5813.73838177281;5828.854278643025;5842.912356314659;5553.4724201200825;5803.50670193032;5805.187273781674;5806.274215723035;5812.041013232812;5163.741812909377;5218.243354713545;5218.556422704075;5219.138842091051;5236.738163091868;22579.661305080437;23517.88241058801;23576.76423235763;23801.285961421185;23835.52328953411;2532.480841427503;2654.761071503574;2667.946641067168;2687.798415118874;2723.060544112278;9919.3056486046;10478.58085676572;10715.46422678863;10851.348919064802;10967.945160274227;1939.2727727102338;2013.094107651548;2027.6350256953742;2057.76335721391;2077.58448310337;79842;82120.58939705323;83749.58125209397;84760;85089.57455212747;11331.263467874562;11611.303321800719;11678.88321116795;12368.75262494745;12489.812652810215;16523.173841307886;16571.751423728652;16627.08551029705;16629.251683674265;16635.417760378572;7954.84090318202;8172;8261.917380826235;8279.8344033119;8414.453060551044;7726.150123486412;7892;7921.722739704198;7928.363314539108;8004.0395152580895;4847.442544107403;4997.125503036954;5047.747612619354;5057.721825299644;5119.769610367543;1957.9510512237023;2052.7639321478223;2071.637463443891;2077.6364136276393;2122.320857325672;1038.99480502597;1055.7307886488895;1103.0679076180616;1129.740159763259;1141.783061218366;18990.240390384508;19479.318223862098;19501.317453889045;19792.60414791696;20011.299604513773;919.9586018629178;1019.5819713917258;1039.4646756920192;1046.1944302886734;1061.6178175856685;10386.42874641902;10948.124150067975;10979.725506862393;11069.667909962714;11075.889241107647;512332;512986;522061;523593;529154;72434.27565724381;77136.61431692805;83482;89346;95910;1077.7305673581604;1103.150574057971;1105.8507101541188;1115.3475216997986;1125.150511363915;17405.47783566495;17834;17883.642327153644;17973.640527189644;18258.08709564543;41786;41944.58055419529;41957.1608567833;42627.5737242636;42841.1431771369;55839.162412564656;58344;58462.12306815316;59122.40877591169;59161.70419148049;8622.180892815173;8761.78095547591;8958.462492250486;9009.0990900912;9073.77315567116;12740.235585864877;13497.595072147851;13592.796108058585;13617.114887532278;13686.384112715152;11653.242539234923;11761.764764704829;11794;11842.348670822843;11898.22661526998;11275.267107637977;11573.363465009505;11601.883981160418;11744.471498782405;11773.352465614473;11723.35521546323;11752.882471175179;11764.235324703866;11825.46785394642;12042.157049006835;8850.20348168668;9032.90967090347;9077.68228112013;9158.267338613028;9160;11458.598949036743;11610.187286889837;11674.76650467003;11730.824037639613;11772.058235341323 03:50:45 INFO - PROCESS | 7831 | |3;mootools.html;1545.196497821133;1556.6108472881783;1751.2907272554612;1864.4779461750716;1869.644767494175;8445.324374050077;9202.309826762994;9267.814643707121;9768.267379946506;9838.409695418271;9343.766405839857;9692.32153749236;9741.512924353789;9766.121049105579;9770.511474426286;2417.9758202417925;2436.1838784007377;2452.1172377943926;2459.7786199242064;2460.237326428804;2420.4674971506242;2490.066225165563;2544.643749875019;2550.502651982864;2550.885210165547;2474.616434452663;2492.3519884829984;2509.0716434919013;2511.309389917769;2511.7864981476505;2414.408469924862;2440.023990403835;2445.9755402445926;2447.192426499251;2462.212092130519;2389.462370966536;2395.3293077938206;2397.4006498375406;2408.8193385495983;2461.089396923132;9571.569279382444;9776.657816976443;9786.314957952945;9800.90199098007;9805.166560842337;5514.228008078872;5613.550915926757;5679.858003549903;5682.261306030231;5684.4315568443235;3522.3659741246565;3559.8220088995445;3630.7640003399692;3700.907477313062;3727.9068023299365;1176.6999415149082;1200.3938011304322;1219.8597161326472;1235.7245705043542;1250.1936251117977;13889.583312500641;13968.231747253896;13980;13993.160410375309;13998.790018149735;5039.4708555601865;5040.218766091261;5077.39071311445;5114.795408183705;5139.460356662571;11617.767644647229;11723.941380293043;11813.291202527877;11819.349935753444;11835.585754498552;5670.943290567042;5796.536277097822;5796.797112101056;5832.329282132524;5834.183214349994;4643.419572553431;5114.130597798383;5286.841394758163;5309.681419114788;5390.272313237741;4342.913141737211;4365.279728844768;4373.759443230653;4431.4903786065015;4433.977830110829;1316.3352506984104;1343.482759137739;1345.4618152738788;1349.2376807103956;1359.4018631802173;925.4724806860025;1037.4605205293205;1042.8748550173875;1056.1709058389129;1058.6083149234832;6342.334054924167;6462.806115816533;6469.288378278386;6478.611283323015;6497.9350206498275;487.37129103456147;488.1457449463439;488.9926651100236;494.06621485392634;498.9376327959005;4336.869893903188;4350.390945267665;4377.102693947733;4378.10248898975;4380.189664912002;11852.466639001093;12175.45210465531;12215.816762748565;12321.691957701129;12363.75272494545;12014.63956081319;12120.939395302967;12121.272723636434;12157.574484892986;12187.268763874195;8456.788580285542;8780.78048048791;8830.249428798625;9001.684941027164;9084.454932704059;6196.256449226122;6398.712057957497;6450.3872132149245;6481.222253329631;6495.805125846232;10940.015398614163;11097.223194376316;11130.666080017612;11181.161412894227;11242.213045086766;11205.439728013404;11385.29220616914;11391;11418.143639226924;11546.711332216762;7699.26856948589;8536.658533658585;8610.182032706884;8770.780730481789;8842.381033327605;9499.765030545985;9533.142017218484;9551.14039736427;9575.712728618153;9599.760005999906;8316.459430137022;8372.28835548985;8381.455205411628;8634.798126477708;8635;8263.628136733982;8331.875021874797;8365.707200247962;8374.790630234293;8448.366372521963;7720.729774457867;7737.032870891138;7796.298333149817;7826;7829.45193836426;5095.847124586268;5138.3833939927445;5290.523852853108;5559.972200139136;5662.631928924607;5642.60501764889;5692.430756924275;5760.423957604206;5835.4748072673665;5877.4122587740885 03:50:45 INFO - PROCESS | 7831 | |4;prototype.html;343.76795662927526;345.571491350725;348.3364191215735;351.2851347507819;351.63781305255577;5633.295838020247;5674.638086859155;5703.258576385075;5706.942930570693;5714.200011998313;5574.331080270363;5582.246396736449;5612.242347283126;5622.803201887935;5626.887462250763;4003.4395184674167;4221.387898754679;4371.584699453547;4383.421968091485;4403.185410699015;4361.454818147731;4386.056997745484;4409.58108979648;4418.5360537143615;4420.005498762769;4387.23223435899;4392.846250381237;4413.536578659243;4413.845515406962;4432.445944256968;4283.400323954649;4355.913657614661;4392.978035109836;4400.537943515917;4435.223835828717;3875.1668391295725;3879.1271963807917;3898.9725342821857;3905.668018218455;3919.549251836047;5365.704886231256;5412.810551630674;5431.21247419122;5455.781768729285;5507.972460137714;4868.294097355899;4972.602191824645;4993.925091123636;5071.54356107952;5091.567216786578;5786.3056433228285;5842.4741773240185;5848.210491583624;5876.265466816648;5903.203067585907;4284.464441944757;4305.031367942219;4306.095719898825;4328.956710432887;4355.978220108911;5941.584089113764;6058.151858739736;6158.414950579688;6162.13730077785;6177.25872895251;4331;4336.484838793493;4343.19650864591;4358.629516491071;4371.519132895379;4403.493598236179;4432.401625780542;4440.3561483585345;4446.755428451466;4452.465704115527;4912.459629440758;5010.624203184776;5040.7479626019285;5075.822346217865;5082.593392528589;5925.703714814242;5936.13925980739;5936.584439089309;5945.524358051345;5960.211936419057;1484.9851501484848;1521.782573940843;1522.444307827635;1529.2124555853745;1529.2812378182236;945.5981207986579;971.6064993677572;979.588572799426;982.4203719805206;997.875265591801;5090.720010399464;5101.821436249787;5128.640910158811;5134.306868572769;5143.8456846294675;5363.731813409314;5420.83737487876;5459.344878614592;5464.87969966156;5473.8357849264585;4885.998370334073;5057.165567681292;5076.492350764968;5077.695338279715;5085.7457127144235;2890.638670166229;2899.9710002900124;2921.649402071765;2929.667001514306;2961.955570666442;5427.674339539641;5436.755346009439;5439.4288599696465;5460.7542660579575;5583.692896890629;5197.818076367309;5501.889962200814;5514.255575497336;5522.641028333145;5568.443155684399;5378.892422151535;5398.62209645321;5404.864878377994;5465.945340546623;5477.4248703887115;5144.845654630367;5282.550983166474;5455.781768729206;5492.945070549244;5509.641873278224;5296.920546191733;5320.707361095022;5336.813211537577;5433.891322173456;5934.7922822701;6100.633961962297;6162;6190.7523699051535;6195.2255968004;6202.534809889186;4285.957140428556;4317.460317460317;4318.9568104319815;4367.1265746851395;4380.211561918885;5867.354590995073;6107.786227482195;6112.7774445112045;6154.692265386802;6171.84570385744;5917.171595976481;5941.970290148522;5947.732352044255;5949.077892926603;5960.4635582797755;5606.803761868315;5906.675132867562;5917.142014407973;5927.525797936241;5956.791512297049;5791.9284932287665;5813.186153938367;5819.013975426846;5843.970780146072;5866.6186697864505;5883.588148829712;5951.642901425928;5971.522278217645;5984.581079324405;5996.190514280516;5735.340435849931;5811.56413269015;5835.854103647443;5842.38654941225;5863.2670916135485 03:50:45 INFO - PROCESS | 7831 | |5;yui.html;794.479615851617;819.4837252530908;839.9034111077228;846.1327139681825;879.4064006795413;15936.84063159368;16665;16676.249568769403;16756.162191890417;17056.14719264038;14810.481633142843;14827.481038163667;14893.478728244514;14926.029808062469;14949;841.2722994609679;869.1352104655845;872.8036191856845;873.3013589128703;878.0692465986043;854.9444286121413;862.5902696219308;867.6442658510013;868.2836659755727;870.2515836380708;909.2634965677822;913.9588718507683;914.8536234202529;916.2486760856101;917.1516347378648;904.1681652879366;904.3398319226935;904.6788390121511;906.229704750963;906.7053207707488;667.2926697700453;667.5594107888819;667.5961043568619;671.0705672643425;673.0442771264816;16087.758683619639;16152.030878147349;16219.675606487805;16305.429309974093;16308.184590770532;14433.927830360886;14489.492867749683;14666.120032798066;15096.396144154221;15791.210439478094;13999.370028348749;14141.222232777192;14373.425062997572;14469.20419376934;14549.854501455062;4739.691920025188;4745.383100196952;4781.234104939819;4806.110869489155;4842.031593681243;81338.59330703368;82220.17779822244;82303.5884820578;82937.58531207305;84537;11451.141164412702;11525.423728813526;11564.24832385909;11791.174617776673;11822.34977076269;20531.076101575167;20601.175952961712;20607;20726.170953161705;21246;8972.596233169523;9104.635814567475;9193.402428842237;9292.53537323131;9489.90510094904;5099.974500127476;5140.100482415637;5144.382674079135;5240.3973543042275;5496.477834605706;3983.4423180754716;4098.692598055158;4131.421600975866;4310;4547.840825571089;785.8035491127218;787.4605894961854;788.9408294377945;796.9840603187904;798.8282519258387;676.0231465532357;784.372501998399;833.9583020848934;849.2993280543453;858.3648100405779;10585.259031867696;10899.400532970763;10964.945175274073;10982.395968221665;11154.219204655596;772.3203580848817;781.1875649324752;801.1827935505752;833.1085738260125;837.342685991506;5176.870578235575;5412.269343638637;5484.698341591251;5893.528517718572;6115.296740874856;102522;127865;130778;130948.345258275;140777;74373;98705.50647246718;109506;115070;116820;99755;101062.49468752756;101461;102743;102907.4854625737;10680.963654087212;10773.73065673333;10801.837972430263;11030.834537482106;11126.777464450828;53960.460395395545;54292.185617214986;54305.18542221791;54947.450525494234;54985.725071375986;73783.6310818464;76053;82747.17252827635;82962.58518707368;85087.57456212927;14105.153690778176;14231.35958881832;14297.499587514387;14438.350274237895;14457.783133252799;14918.030328028643;15070.397184112513;15981.840181598036;16373.017618942902;16517.58706032359;14914.179720115064;15270.618234543781;15588.376464941275;15620.453284135001;16048.358065677243;14208.502702405367;14217.21805300677;14422.134671919719;15476.458323958608;15960.20198990069;14466.638334041732;14658.70682586321;14697.412103516168;15127.092374457568;15233.238338083273;12632.621021369374;12735.029545149202;13069.607911762663;13214.075014748876;13231.603051908458;13037.47850085986;13230.801537977131;13321.467141314239;13441.126326788728;13623.455061797416 03:50:45 INFO - PROCESS | 7831 | __end_tp_report 03:50:45 INFO - PROCESS | 7831 | __start_cc_report 03:50:45 INFO - PROCESS | 7831 | _x_x_mozilla_cycle_collect,349 03:50:45 INFO - PROCESS | 7831 | __end_cc_report 03:50:45 INFO - PROCESS | 7831 | __startTimestamp1468147845655__endTimestamp 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | ------- Summary: start ------- 03:50:45 INFO - PROCESS | 7831 | Number of tests: 6 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | [#0] dojo.html Cycles:165 Average:5663.15 Median:5940.88 stddev:631.49 (10.6%) stddev-sans-first:606.65 03:50:45 INFO - PROCESS | 7831 | Values: 3343.8 3371.0 3404.4 3411.3 3419.1 5665.3 5667.0 5668.8 5722.1 5730.5 5667.6 5770.3 5770.8 5771.1 5790.0 5052.1 5146.4 5174.3 5188.8 5199.8 5069.1 5112.6 5152.4 5154.2 5178.4 5133.9 5153.4 5180.2 5209.9 5217.8 5190.4 5192.6 5285.8 5288.6 5319.2 5127.6 5190.3 5240.6 5250.6 5257.9 5360.6 5508.6 5519.8 5579.4 5605.6 6059.5 6085.7 6107.1 6109.6 6141.5 6005.9 6135.0 6155.2 6169.2 6176.1 5631.5 5668.7 5684.5 5732.5 5734.6 6301.5 6307.8 6320.7 6327.3 6345.3 5833.8 5987.3 6047.5 6063.8 6078.8 6114.9 6207.6 6210.0 6210.3 6213.4 6056.8 6152.0 6170.6 6181.6 6181.9 5959.8 5992.9 5998.5 6165.7 6176.4 4650.4 4663.9 4664.4 4686.7 4689.8 4159.6 4170.2 4175.9 4176.1 4189.9 5779.8 5788.5 5844.2 5853.3 5866.3 6043.6 6074.1 6080.9 6121.8 6138.8 5830.8 5836.8 5837.3 5837.9 5854.3 5122.3 5135.4 5165.1 5170.9 5184.7 6078.2 6113.5 6117.7 6123.1 6177.4 6139.8 6141.8 6162.4 6168.3 6188.1 6021.8 6023.4 6046.9 6061.5 6088.5 5855.1 5942.9 5960.4 5974.9 5975.6 6035.5 6039.5 6044.3 6106.5 6127.1 5868.6 5949.7 5960.5 6002.4 6056.6 5964.5 6002.9 6014.2 6042.8 6051.5 5742.2 5903.3 5940.9 5945.6 5950.9 5980.0 5993.5 6014.3 6097.8 6110.4 5915.0 5931.3 5946.5 5948.3 5962.0 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | [#1] ext.html Cycles:180 Average:65219.87 Median:44155.34 stddev:136840.96 (309.9%) stddev-sans-first:137138.94 03:50:45 INFO - PROCESS | 7831 | Values: 642.5 647.5 655.9 667.5 675.5 33067.2 36092.8 44181.3 45877.3 45939.1 48555.8 49144.5 49163.3 49237.0 49324.3 8852.6 8958.0 8964.6 8986.0 8997.2 8856.5 8912.0 8945.7 8957.4 8961.4 8974.2 8979.6 8995.6 8996.5 9011.6 8918.4 8965.2 8987.3 8988.0 9010.0 8938.2 8973.8 9021.1 9029.1 9050.6 43735.1 44223.6 44624.3 44655.0 44794.8 3834.5 4027.6 4179.2 4226.8 4498.7 34119.6 34511.0 34718.3 34879.5 34895.0 4440.2 4474.4 4490.0 4504.2 4575.7 358821.0 361012.0 363581.0 363911.0 364917.0 38123.4 55873.7 56101.7 56158.0 62101.1 39004.8 40720.0 40781.8 40949.6 41000.2 14351.7 14368.2 14417.5 14438.6 14546.4 12496.0 12528.4 12612.4 12623.2 12662.1 9087.5 9122.4 9186.4 9212.2 9235.3 3445.7 3466.0 3501.6 3545.5 3607.0 1033.3 1038.2 1146.3 1174.5 1191.4 33636.3 33722.7 33842.5 33973.5 34178.5 1164.6 1182.9 1266.7 1272.8 1287.8 17502.6 17699.6 17804.3 17894.9 17928.6 549227.0 555786.0 560902.0 569599.0 817188.0 64088.7 64535.0 64545.0 64612.4 64636.4 1465.1 1467.9 1469.5 1472.8 1481.8 33203.7 33874.8 33883.8 33898.8 34160.8 55010.4 55601.0 55692.0 55781.2 56216.2 519972.0 520800.0 521809.0 525585.0 529190.0 30734.1 31516.0 31674.4 31776.7 31798.7 50793.0 51746.0 52451.5 52505.2 52904.5 41881.4 43568.0 44020.0 44129.3 45120.1 41738.0 43843.3 44803.1 45022.1 45361.3 43941.6 44011.1 44205.1 44338.8 44886.8 37800.2 39238.4 39327.4 39586.0 39796.4 29073.3 30074.7 30165.4 30239.2 30388.4 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | [#2] jquery.html Cycles:180 Average:29871.18 Median:23689.03 stddev:85448.61 (360.7%) stddev-sans-first:85659.69 03:50:45 INFO - PROCESS | 7831 | Values: 418.7 426.4 430.5 431.2 436.0 17888.2 19189.6 19842.2 20428.0 20465.7 18878.7 18998.8 19845.3 20159.0 20176.7 5602.2 5910.4 5918.1 5921.5 5939.5 5687.4 5737.8 5758.9 5796.3 5803.6 5763.5 5770.1 5813.7 5828.9 5842.9 5553.5 5803.5 5805.2 5806.3 5812.0 5163.7 5218.2 5218.6 5219.1 5236.7 22579.7 23517.9 23576.8 23801.3 23835.5 2532.5 2654.8 2667.9 2687.8 2723.1 9919.3 10478.6 10715.5 10851.3 10967.9 1939.3 2013.1 2027.6 2057.8 2077.6 79842.0 82120.6 83749.6 84760.0 85089.6 11331.3 11611.3 11678.9 12368.8 12489.8 16523.2 16571.8 16627.1 16629.3 16635.4 7954.8 8172.0 8261.9 8279.8 8414.5 7726.2 7892.0 7921.7 7928.4 8004.0 4847.4 4997.1 5047.7 5057.7 5119.8 1958.0 2052.8 2071.6 2077.6 2122.3 1039.0 1055.7 1103.1 1129.7 1141.8 18990.2 19479.3 19501.3 19792.6 20011.3 920.0 1019.6 1039.5 1046.2 1061.6 10386.4 10948.1 10979.7 11069.7 11075.9 512332.0 512986.0 522061.0 523593.0 529154.0 72434.3 77136.6 83482.0 89346.0 95910.0 1077.7 1103.2 1105.9 1115.3 1125.2 17405.5 17834.0 17883.6 17973.6 18258.1 41786.0 41944.6 41957.2 42627.6 42841.1 55839.2 58344.0 58462.1 59122.4 59161.7 8622.2 8761.8 8958.5 9009.1 9073.8 12740.2 13497.6 13592.8 13617.1 13686.4 11653.2 11761.8 11794.0 11842.3 11898.2 11275.3 11573.4 11601.9 11744.5 11773.4 11723.4 11752.9 11764.2 11825.5 12042.2 8850.2 9032.9 9077.7 9158.3 9160.0 11458.6 11610.2 11674.8 11730.8 11772.1 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | [#3] mootools.html Cycles:180 Average:6356.67 Median:487.76 stddev:3729.59 (764.6%) stddev-sans-first:3722.52 03:50:45 INFO - PROCESS | 7831 | Values: 1545.2 1556.6 1751.3 1864.5 1869.6 8445.3 9202.3 9267.8 9768.3 9838.4 9343.8 9692.3 9741.5 9766.1 9770.5 2418.0 2436.2 2452.1 2459.8 2460.2 2420.5 2490.1 2544.6 2550.5 2550.9 2474.6 2492.4 2509.1 2511.3 2511.8 2414.4 2440.0 2446.0 2447.2 2462.2 2389.5 2395.3 2397.4 2408.8 2461.1 9571.6 9776.7 9786.3 9800.9 9805.2 5514.2 5613.6 5679.9 5682.3 5684.4 3522.4 3559.8 3630.8 3700.9 3727.9 1176.7 1200.4 1219.9 1235.7 1250.2 13889.6 13968.2 13980.0 13993.2 13998.8 5039.5 5040.2 5077.4 5114.8 5139.5 11617.8 11723.9 11813.3 11819.3 11835.6 5670.9 5796.5 5796.8 5832.3 5834.2 4643.4 5114.1 5286.8 5309.7 5390.3 4342.9 4365.3 4373.8 4431.5 4434.0 1316.3 1343.5 1345.5 1349.2 1359.4 925.5 1037.5 1042.9 1056.2 1058.6 6342.3 6462.8 6469.3 6478.6 6497.9 487.4 488.1 489.0 494.1 498.9 4336.9 4350.4 4377.1 4378.1 4380.2 11852.5 12175.5 12215.8 12321.7 12363.8 12014.6 12120.9 12121.3 12157.6 12187.3 8456.8 8780.8 8830.2 9001.7 9084.5 6196.3 6398.7 6450.4 6481.2 6495.8 10940.0 11097.2 11130.7 11181.2 11242.2 11205.4 11385.3 11391.0 11418.1 11546.7 7699.3 8536.7 8610.2 8770.8 8842.4 9499.8 9533.1 9551.1 9575.7 9599.8 8316.5 8372.3 8381.5 8634.8 8635.0 8263.6 8331.9 8365.7 8374.8 8448.4 7720.7 7737.0 7796.3 7826.0 7829.5 5095.8 5138.4 5290.5 5560.0 5662.6 5642.6 5692.4 5760.4 5835.5 5877.4 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | [#4] prototype.html Cycles:180 Average:4823.36 Median:5408.84 stddev:1391.62 (25.7%) stddev-sans-first:1354.30 03:50:45 INFO - PROCESS | 7831 | Values: 343.8 345.6 348.3 351.3 351.6 5633.3 5674.6 5703.3 5706.9 5714.2 5574.3 5582.2 5612.2 5622.8 5626.9 4003.4 4221.4 4371.6 4383.4 4403.2 4361.5 4386.1 4409.6 4418.5 4420.0 4387.2 4392.8 4413.5 4413.8 4432.4 4283.4 4355.9 4393.0 4400.5 4435.2 3875.2 3879.1 3899.0 3905.7 3919.5 5365.7 5412.8 5431.2 5455.8 5508.0 4868.3 4972.6 4993.9 5071.5 5091.6 5786.3 5842.5 5848.2 5876.3 5903.2 4284.5 4305.0 4306.1 4329.0 4356.0 5941.6 6058.2 6158.4 6162.1 6177.3 4331.0 4336.5 4343.2 4358.6 4371.5 4403.5 4432.4 4440.4 4446.8 4452.5 4912.5 5010.6 5040.7 5075.8 5082.6 5925.7 5936.1 5936.6 5945.5 5960.2 1485.0 1521.8 1522.4 1529.2 1529.3 945.6 971.6 979.6 982.4 997.9 5090.7 5101.8 5128.6 5134.3 5143.8 5363.7 5420.8 5459.3 5464.9 5473.8 4886.0 5057.2 5076.5 5077.7 5085.7 2890.6 2900.0 2921.6 2929.7 2962.0 5427.7 5436.8 5439.4 5460.8 5583.7 5197.8 5501.9 5514.3 5522.6 5568.4 5378.9 5398.6 5404.9 5465.9 5477.4 5144.8 5282.6 5455.8 5492.9 5509.6 5296.9 5320.7 5336.8 5433.9 5934.8 6100.6 6162.0 6190.8 6195.2 6202.5 4286.0 4317.5 4319.0 4367.1 4380.2 5867.4 6107.8 6112.8 6154.7 6171.8 5917.2 5942.0 5947.7 5949.1 5960.5 5606.8 5906.7 5917.1 5927.5 5956.8 5791.9 5813.2 5819.0 5844.0 5866.6 5883.6 5951.6 5971.5 5984.6 5996.2 5735.3 5811.6 5835.9 5842.4 5863.3 03:50:45 INFO - PROCESS | 7831 | 03:50:45 INFO - PROCESS | 7831 | [#5] yui.html Cycles:180 Average:22708.61 Median:20986.09 stddev:32870.55 (156.6%) stddev-sans-first:32921.58 03:50:45 INFO - PROCESS | 7831 | Values: 794.5 819.5 839.9 846.1 879.4 15936.8 16665.0 16676.2 16756.2 17056.1 14810.5 14827.5 14893.5 14926.0 14949.0 841.3 869.1 872.8 873.3 878.1 854.9 862.6 867.6 868.3 870.3 909.3 914.0 914.9 916.2 917.2 904.2 904.3 904.7 906.2 906.7 667.3 667.6 667.6 671.1 673.0 16087.8 16152.0 16219.7 16305.4 16308.2 14433.9 14489.5 14666.1 15096.4 15791.2 13999.4 14141.2 14373.4 14469.2 14549.9 4739.7 4745.4 4781.2 4806.1 4842.0 81338.6 82220.2 82303.6 82937.6 84537.0 11451.1 11525.4 11564.2 11791.2 11822.3 20531.1 20601.2 20607.0 20726.2 21246.0 8972.6 9104.6 9193.4 9292.5 9489.9 5100.0 5140.1 5144.4 5240.4 5496.5 3983.4 4098.7 4131.4 4310.0 4547.8 785.8 787.5 788.9 797.0 798.8 676.0 784.4 834.0 849.3 858.4 10585.3 10899.4 10964.9 10982.4 11154.2 772.3 781.2 801.2 833.1 837.3 5176.9 5412.3 5484.7 5893.5 6115.3 102522.0 127865.0 130778.0 130948.3 140777.0 74373.0 98705.5 109506.0 115070.0 116820.0 99755.0 101062.5 101461.0 102743.0 102907.5 10681.0 10773.7 10801.8 11030.8 11126.8 53960.5 54292.2 54305.2 54947.5 54985.7 73783.6 76053.0 82747.2 82962.6 85087.6 14105.2 14231.4 14297.5 14438.4 14457.8 14918.0 15070.4 15981.8 16373.0 16517.6 14914.2 15270.6 15588.4 15620.5 16048.4 14208.5 14217.2 14422.1 15476.5 15960.2 14466.6 14658.7 14697.4 15127.1 15233.2 12632.6 12735.0 13069.6 13214.1 13231.6 13037.5 13230.8 13321.5 13441.1 13623.5 03:50:45 INFO - PROCESS | 7831 | -------- Summary: end -------- 03:50:45 INFO - PROCESS | 7831 | 03:50:46 INFO - TEST-INFO | 7831: exit 0 03:50:46 INFO - TEST-OK | dromaeo_css | took 1109714ms 03:50:46 INFO - TEST-START | kraken 03:50:46 INFO - operating with platform_type : linux_ 03:50:46 INFO - Initialising browser for kraken test... 03:50:46 INFO - TEST-INFO | started process 8077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ5d7ZJ/profile http://localhost:39561/getInfo.html) 03:50:50 INFO - PROCESS | 8077 | __metrics Screen width/height:1600/1200 03:50:50 INFO - PROCESS | 8077 | colorDepth:24 03:50:50 INFO - PROCESS | 8077 | Browser inner width/height: 1024/697 03:50:50 INFO - PROCESS | 8077 | __metrics 03:50:51 ERROR - PROCESS | 8077 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 03:50:52 INFO - TEST-INFO | 8077: exit 0 03:50:52 INFO - Browser initialized. 03:50:52 INFO - Running cycle 1/1 for kraken test... 03:50:52 INFO - TEST-INFO | started process 8207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ5d7ZJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:03 INFO - PROCESS | 8207 | RSS: Main: 155828224 03:51:03 INFO - PROCESS | 8207 | 03:51:06 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39561/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:07 INFO - PROCESS | 8207 | RSS: Main: 160624640 03:51:07 INFO - PROCESS | 8207 | 03:51:09 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39561/tests/kraken/driver.html?testName=audio-dft) 03:51:10 INFO - PROCESS | 8207 | RSS: Main: 160251904 03:51:10 INFO - PROCESS | 8207 | 03:51:13 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39561/tests/kraken/driver.html?testName=audio-fft) 03:51:14 INFO - PROCESS | 8207 | RSS: Main: 160911360 03:51:14 INFO - PROCESS | 8207 | 03:51:16 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39561/tests/kraken/driver.html?testName=audio-oscillator) 03:51:16 INFO - PROCESS | 8207 | RSS: Main: 160927744 03:51:16 INFO - PROCESS | 8207 | 03:51:18 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:19 INFO - PROCESS | 8207 | RSS: Main: 161062912 03:51:19 INFO - PROCESS | 8207 | 03:51:22 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39561/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:23 INFO - PROCESS | 8207 | RSS: Main: 160247808 03:51:23 INFO - PROCESS | 8207 | 03:51:26 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39561/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:27 INFO - PROCESS | 8207 | RSS: Main: 157130752 03:51:27 INFO - PROCESS | 8207 | 03:51:30 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39561/tests/kraken/driver.html?testName=json-parse-financial) 03:51:30 INFO - PROCESS | 8207 | RSS: Main: 158904320 03:51:30 INFO - PROCESS | 8207 | 03:51:32 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:32 INFO - PROCESS | 8207 | RSS: Main: 158744576 03:51:32 INFO - PROCESS | 8207 | 03:51:34 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:35 INFO - PROCESS | 8207 | RSS: Main: 159182848 03:51:35 INFO - PROCESS | 8207 | 03:51:37 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:38 INFO - PROCESS | 8207 | RSS: Main: 159719424 03:51:38 INFO - PROCESS | 8207 | 03:51:40 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:41 INFO - PROCESS | 8207 | RSS: Main: 159842304 03:51:41 INFO - PROCESS | 8207 | 03:51:43 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:44 INFO - PROCESS | 8207 | RSS: Main: 159375360 03:51:44 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | Cycle 1(1): loaded http://localhost:39561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39561/tests/kraken/driver.html?testName=ai-astar) 03:51:46 INFO - PROCESS | 8207 | RSS: Main: 160124928 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | __start_tp_report 03:51:46 INFO - PROCESS | 8207 | _x_x_mozilla_page_load 03:51:46 INFO - PROCESS | 8207 | _x_x_mozilla_page_load_details 03:51:46 INFO - PROCESS | 8207 | |i|pagename|runs| 03:51:46 INFO - PROCESS | 8207 | |0;ai-astar;114;105;113;112;113;113;113;113;113;111 03:51:46 INFO - PROCESS | 8207 | |1;audio-beat-detection;166;128;148;173;126;151;158;126;175;125 03:51:46 INFO - PROCESS | 8207 | |2;audio-dft;162;173;161;162;161;163;163;160;160;161 03:51:46 INFO - PROCESS | 8207 | |3;audio-fft;75;76;76;173;78;76;76;75;172;76 03:51:46 INFO - PROCESS | 8207 | |4;audio-oscillator;84;84;151;84;84;85;133;85;86;141 03:51:46 INFO - PROCESS | 8207 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;122 03:51:46 INFO - PROCESS | 8207 | |6;imaging-darkroom;147;148;147;149;146;148;146;148;147;147 03:51:46 INFO - PROCESS | 8207 | |7;imaging-desaturate;95;95;97;96;96;96;96;96;95;95 03:51:46 INFO - PROCESS | 8207 | |8;json-parse-financial;52;54;51;52;56;54;51;55;56;52 03:51:46 INFO - PROCESS | 8207 | |9;json-stringify-tinderbox;59;60;60;60;59;59;60;60;60;60 03:51:46 INFO - PROCESS | 8207 | |10;stanford-crypto-aes;82;76;77;74;76;78;77;79;107;78 03:51:46 INFO - PROCESS | 8207 | |11;stanford-crypto-ccm;120;126;119;119;118;118;134;121;140;123 03:51:46 INFO - PROCESS | 8207 | |12;stanford-crypto-pbkdf2;153;161;163;162;156;157;161;159;155;165 03:51:46 INFO - PROCESS | 8207 | |13;stanford-crypto-sha256-iterative;65;63;64;64;62;61;65;63;62;61 03:51:46 INFO - PROCESS | 8207 | __end_tp_report 03:51:46 INFO - PROCESS | 8207 | __start_cc_report 03:51:46 INFO - PROCESS | 8207 | _x_x_mozilla_cycle_collect,869 03:51:46 INFO - PROCESS | 8207 | __end_cc_report 03:51:46 INFO - PROCESS | 8207 | __startTimestamp1468147906401__endTimestamp 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | ------- Summary: start ------- 03:51:46 INFO - PROCESS | 8207 | Number of tests: 14 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.58 (2.3%) stddev-sans-first:2.64 03:51:46 INFO - PROCESS | 8207 | Values: 114.0 105.0 113.0 112.0 113.0 113.0 113.0 113.0 113.0 111.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:154.50 stddev:20.23 (13.1%) stddev-sans-first:20.33 03:51:46 INFO - PROCESS | 8207 | Values: 166.0 128.0 148.0 173.0 126.0 151.0 158.0 126.0 175.0 125.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:3.81 (2.3%) stddev-sans-first:4.03 03:51:46 INFO - PROCESS | 8207 | Values: 162.0 173.0 161.0 162.0 161.0 163.0 163.0 160.0 160.0 161.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#3] audio-fft Cycles:10 Average:95.30 Median:76.00 stddev:40.70 (53.5%) stddev-sans-first:42.50 03:51:46 INFO - PROCESS | 8207 | Values: 75.0 76.0 76.0 173.0 78.0 76.0 76.0 75.0 172.0 76.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:84.00 stddev:27.91 (33.2%) stddev-sans-first:28.86 03:51:46 INFO - PROCESS | 8207 | Values: 84.0 84.0 151.0 84.0 84.0 85.0 133.0 85.0 86.0 141.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.58 (1.3%) stddev-sans-first:1.66 03:51:46 INFO - PROCESS | 8207 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 122.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 03:51:46 INFO - PROCESS | 8207 | Values: 147.0 148.0 147.0 149.0 146.0 148.0 146.0 148.0 147.0 147.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 03:51:46 INFO - PROCESS | 8207 | Values: 95.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:54.00 stddev:1.95 (3.6%) stddev-sans-first:2.01 03:51:46 INFO - PROCESS | 8207 | Values: 52.0 54.0 51.0 52.0 56.0 54.0 51.0 55.0 56.0 52.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 03:51:46 INFO - PROCESS | 8207 | Values: 59.0 60.0 60.0 60.0 59.0 59.0 60.0 60.0 60.0 60.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:77.50 stddev:9.58 (12.4%) stddev-sans-first:10.15 03:51:46 INFO - PROCESS | 8207 | Values: 82.0 76.0 77.0 74.0 76.0 78.0 77.0 79.0 107.0 78.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:122.00 stddev:7.51 (6.2%) stddev-sans-first:7.84 03:51:46 INFO - PROCESS | 8207 | Values: 120.0 126.0 119.0 119.0 118.0 118.0 134.0 121.0 140.0 123.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:161.00 stddev:3.85 (2.4%) stddev-sans-first:3.37 03:51:46 INFO - PROCESS | 8207 | Values: 153.0 161.0 163.0 162.0 156.0 157.0 161.0 159.0 155.0 165.0 03:51:46 INFO - PROCESS | 8207 | 03:51:46 INFO - PROCESS | 8207 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:1.49 (2.3%) stddev-sans-first:1.39 03:51:46 INFO - PROCESS | 8207 | Values: 65.0 63.0 64.0 64.0 62.0 61.0 65.0 63.0 62.0 61.0 03:51:46 INFO - PROCESS | 8207 | -------- Summary: end -------- 03:51:46 INFO - PROCESS | 8207 | 03:51:47 INFO - TEST-INFO | 8207: exit 0 03:51:47 INFO - TEST-OK | kraken | took 60957ms 03:51:47 INFO - SUITE-END | took 1170s 03:51:47 INFO - Completed test suite (00:19:30) 03:51:47 INFO - javascript benchmark 03:51:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7607.466754822098, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.7826541274817, 3371.0, 3404.4212483877736, 3411.266577685798, 3419.093940105871, 5665.263515742953, 5667.0, 5668.773249070037, 5722.084466485363, 5730.541556675466, 5667.603267771257, 5770.307563092424, 5770.798022069229, 5771.076627739562, 5790.044642633971, 5052.14113600687, 5146.382434107913, 5174.301469301634, 5188.844334669947, 5199.792008319662, 5069.112905241586, 5112.616553758465, 5152.407473140581, 5154.175331946889, 5178.378594568657, 5133.871653208681, 5153.3558305211845, 5180.197069454241, 5209.921851172236, 5217.791288348461, 5190.4290528042075, 5192.558632516222, 5285.814996475105, 5288.603354748409, 5319.175527793198, 5127.615428842814, 5190.32525771651, 5240.580753539746, 5250.579953603703, 5257.894842103175, 5360.571154307646, 5508.614396992212, 5519.834404967817, 5579.358373787026, 5605.607607467479, 6059.515238780887, 6085.726142323606, 6107.114468402056, 6109.63342199465, 6141.50867930569, 6005.879882402372, 6134.96932515339, 6155.230596175478, 6169.198004259418, 6176.104464852616, 5631.521320687746, 5668.744906479218, 5684.459976302244, 5732.512736417368, 5734.598578099576, 6301.464375528039, 6307.842303942438, 6320.683965801783, 6327.335629758901, 6345.270293916166, 5833.766649334064, 5987.251593550806, 6047.516198704093, 6063.818085457355, 6078.787242446581, 6114.908276375858, 6207.596506227081, 6210.006398976232, 6210.254769427697, 6213.409726076015, 6056.848578785565, 6152.046432802923, 6170.598911070856, 6181.598196117238, 6181.876362472725, 5959.76160953557, 5992.880142397127, 5998.4601385875485, 6165.691715414211, 6176.35148309421, 4650.395448591661, 4663.883402914954, 4664.370310008173, 4686.695364801345, 4689.812407503661, 4159.584041595816, 4170.186813571385, 4175.874723758292, 4176.102138040336, 4189.874303770892, 5779.826605201851, 5788.507976821933, 5844.1818145459665, 5853.297604287428, 5866.325372582122, 6043.576949613484, 6074.088886667036, 6080.935836228642, 6121.846953826101, 6138.785142519991, 5830.82507524775, 5836.7957121501395, 5837.270341207349, 5837.9124313135335, 5854.2974843018255, 5122.308488354024, 5135.435102138762, 5165.147750621106, 5170.870728231825, 5184.662996905189, 6078.179445774852, 6113.541484388688, 6117.663528505975, 6123.050927106306, 6177.444030037228, 6139.785107521216, 6141.815745527641, 6162.352952939877, 6168.25980882297, 6188.133661287334, 6021.759129634941, 6023.397660233942, 6046.879062418815, 6061.545384096298, 6088.543359248163, 5855.121731740102, 5942.910856337245, 5960.433758792908, 5974.910376344272, 5975.611585246945, 6035.517158627387, 6039.486643635164, 6044.335123136363, 6106.542009349228, 6127.111568822585, 5868.559858010581, 5949.702514874152, 5960.493358064613, 6002.369751176064, 6056.636601803906, 5964.463198312173, 6002.909956350571, 6014.1580178775885, 6042.75828966854, 6051.4553690168095, 5742.1673857289625, 5903.291605007426, 5940.881182376242, 5945.613535120204, 5950.851228719317, 5979.970100149471, 5993.520518358608, 6014.338422773579, 6097.7865774697675, 6110.358412366638, 5915.0, 5931.288245410578, 5946.494547963299, 5948.256467941507, 5961.970190149022], "value": 5621.695729563928, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.4731719989608, 647.5434818452991, 655.8852200864848, 667.4960404894302, 675.4832553096878, 33067.173320666996, 36092.819535902316, 44181.33727994079, 45877.31184032242, 45939.08121837561, 48555.757221213935, 49144.50855491444, 49163.262551061765, 49237.0, 49324.26013609799, 8852.601632926502, 8957.95521022394, 8964.641414343418, 8986.0, 8997.190252877239, 8856.468611883276, 8912.0, 8945.686900958468, 8957.37298389113, 8961.417507862001, 8974.192322690957, 8979.595918183664, 8995.550222488882, 8996.460212387277, 9011.594478248495, 8918.375713700043, 8965.237954773787, 8987.325950553735, 8987.999999999967, 9009.954950225272, 8938.1508756668, 8973.820523589557, 9021.097890210993, 9029.097090290985, 9050.5927233274, 43735.12529749387, 44223.557764422265, 44624.330635040504, 44655.0, 44794.77602611966, 3834.5206849143856, 4027.597240275978, 4179.2059508693255, 4226.767527785971, 4498.685092043558, 34119.61710529599, 34511.0, 34718.30563388743, 34879.4768078479, 34895.0, 4440.222960981815, 4474.373587697725, 4489.9775501122285, 4504.166729155117, 4575.702579332333, 358821.0, 361012.0, 363581.0, 363911.0, 364917.0, 38123.42814857779, 55873.720631397395, 56101.7194914031, 56158.0, 62101.06848397278, 39004.80497597494, 40720.0, 40781.79609101936, 40949.59050409518, 41000.17999639991, 14351.712965740626, 14368.209748463725, 14417.495387661382, 14438.566842994727, 14546.418143274363, 12496.0, 12528.373581320897, 12612.369381530887, 12623.179493332904, 12662.113652044452, 9087.545622718837, 9122.361434699507, 9186.356955013085, 9212.216961558208, 9235.307351948632, 3445.6554344565843, 3466.0, 3501.5798104227656, 3545.503629491873, 3606.9819650902105, 1033.3231733214757, 1038.1953985661023, 1146.340854008948, 1174.4773575758704, 1191.4400231890997, 33636.32727345439, 33722.662773372445, 33842.49236261458, 33973.490397644055, 34178.48732269018, 1164.5691094294996, 1182.9349385783692, 1266.7339858629607, 1272.7772639788, 1287.8454585449806, 17502.562435939202, 17699.557511062325, 17804.287828486715, 17894.91052544729, 17928.55178620519, 549227.0, 555786.0, 560902.0, 569599.0, 817188.0, 64088.67955660285, 64535.0, 64545.0, 64612.35387646157, 64636.353636463034, 1465.1355700136971, 1467.882569394446, 1469.4563011685746, 1472.786445965329, 1481.7703255995339, 33203.667963320055, 33874.83062584671, 33883.83058084793, 33898.8305058483, 34160.82919585386, 55010.44989550053, 55601.0, 55692.0, 55781.163282549984, 56216.156757649485, 519972.0, 520800.0, 521809.0, 525585.0, 529190.0, 30734.077977660705, 31516.0, 31674.366512669156, 31776.682233177373, 31798.682013179572, 50793.0, 51746.0, 52451.475485246185, 52505.21242181447, 52904.47095528995, 41881.37177942394, 43568.0, 44020.0, 44129.33805992977, 45120.09759804851, 41738.0, 43843.34234986414, 44803.10393792171, 45022.099558009315, 45361.319580205665, 43941.560584393745, 44011.11977760491, 44205.11589768122, 44338.77830610827, 44886.77556612196, 37800.243995120494, 39238.411423828096, 39327.41008884812, 39586.0, 39796.40305395363, 29073.273168170967, 30074.69925300719, 30165.3966920656, 30239.244018899702, 30388.392232155675], "value": 20082.183907138642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.6650679456434, 426.4179395125652, 430.52642093696954, 431.1678460571097, 436.00590653310445, 17888.19503122361, 19189.616207675837, 19842.20631174753, 20428.0, 20465.693014604756, 18878.716819247722, 18998.810011899877, 19845.305414310504, 20159.0, 20176.69734953977, 5602.2436971009, 5910.4089591040765, 5918.1418694289305, 5921.496672782819, 5939.495142912858, 5687.402822703619, 5737.7991770288045, 5758.856028599276, 5796.30444346679, 5803.6227645203135, 5763.481286684198, 5770.134479828039, 5813.73838177281, 5828.854278643025, 5842.912356314659, 5553.4724201200825, 5803.50670193032, 5805.187273781674, 5806.274215723035, 5812.041013232812, 5163.741812909377, 5218.243354713545, 5218.556422704075, 5219.138842091051, 5236.738163091868, 22579.661305080437, 23517.88241058801, 23576.76423235763, 23801.285961421185, 23835.52328953411, 2532.480841427503, 2654.761071503574, 2667.946641067168, 2687.798415118874, 2723.060544112278, 9919.3056486046, 10478.58085676572, 10715.46422678863, 10851.348919064802, 10967.945160274227, 1939.2727727102338, 2013.094107651548, 2027.6350256953742, 2057.76335721391, 2077.58448310337, 79842.0, 82120.58939705323, 83749.58125209397, 84760.0, 85089.57455212747, 11331.263467874562, 11611.303321800719, 11678.88321116795, 12368.75262494745, 12489.812652810215, 16523.173841307886, 16571.751423728652, 16627.08551029705, 16629.251683674265, 16635.417760378572, 7954.84090318202, 8172.0, 8261.917380826235, 8279.8344033119, 8414.453060551044, 7726.150123486412, 7892.0, 7921.722739704198, 7928.363314539108, 8004.0395152580895, 4847.442544107403, 4997.125503036954, 5047.747612619354, 5057.721825299644, 5119.769610367543, 1957.9510512237023, 2052.7639321478223, 2071.637463443891, 2077.6364136276393, 2122.320857325672, 1038.99480502597, 1055.7307886488895, 1103.0679076180616, 1129.740159763259, 1141.783061218366, 18990.240390384508, 19479.318223862098, 19501.317453889045, 19792.60414791696, 20011.299604513773, 919.9586018629178, 1019.5819713917258, 1039.4646756920192, 1046.1944302886734, 1061.6178175856685, 10386.42874641902, 10948.124150067975, 10979.725506862393, 11069.667909962714, 11075.889241107647, 512332.0, 512986.0, 522061.0, 523593.0, 529154.0, 72434.27565724381, 77136.61431692805, 83482.0, 89346.0, 95910.0, 1077.7305673581604, 1103.150574057971, 1105.8507101541188, 1115.3475216997986, 1125.150511363915, 17405.47783566495, 17834.0, 17883.642327153644, 17973.640527189644, 18258.08709564543, 41786.0, 41944.58055419529, 41957.1608567833, 42627.5737242636, 42841.1431771369, 55839.162412564656, 58344.0, 58462.12306815316, 59122.40877591169, 59161.70419148049, 8622.180892815173, 8761.78095547591, 8958.462492250486, 9009.0990900912, 9073.77315567116, 12740.235585864877, 13497.595072147851, 13592.796108058585, 13617.114887532278, 13686.384112715152, 11653.242539234923, 11761.764764704829, 11794.0, 11842.348670822843, 11898.22661526998, 11275.267107637977, 11573.363465009505, 11601.883981160418, 11744.471498782405, 11773.352465614473, 11723.35521546323, 11752.882471175179, 11764.235324703866, 11825.46785394642, 12042.157049006835, 8850.20348168668, 9032.90967090347, 9077.68228112013, 9158.267338613028, 9160.0, 11458.598949036743, 11610.187286889837, 11674.76650467003, 11730.824037639613, 11772.058235341323], "value": 9476.96226259162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1545.196497821133, 1556.6108472881783, 1751.2907272554612, 1864.4779461750716, 1869.644767494175, 8445.324374050077, 9202.309826762994, 9267.814643707121, 9768.267379946506, 9838.409695418271, 9343.766405839857, 9692.32153749236, 9741.512924353789, 9766.121049105579, 9770.511474426286, 2417.9758202417925, 2436.1838784007377, 2452.1172377943926, 2459.7786199242064, 2460.237326428804, 2420.4674971506242, 2490.066225165563, 2544.643749875019, 2550.502651982864, 2550.885210165547, 2474.616434452663, 2492.3519884829984, 2509.0716434919013, 2511.309389917769, 2511.7864981476505, 2414.408469924862, 2440.023990403835, 2445.9755402445926, 2447.192426499251, 2462.212092130519, 2389.462370966536, 2395.3293077938206, 2397.4006498375406, 2408.8193385495983, 2461.089396923132, 9571.569279382444, 9776.657816976443, 9786.314957952945, 9800.90199098007, 9805.166560842337, 5514.228008078872, 5613.550915926757, 5679.858003549903, 5682.261306030231, 5684.4315568443235, 3522.3659741246565, 3559.8220088995445, 3630.7640003399692, 3700.907477313062, 3727.9068023299365, 1176.6999415149082, 1200.3938011304322, 1219.8597161326472, 1235.7245705043542, 1250.1936251117977, 13889.583312500641, 13968.231747253896, 13980.0, 13993.160410375309, 13998.790018149735, 5039.4708555601865, 5040.218766091261, 5077.39071311445, 5114.795408183705, 5139.460356662571, 11617.767644647229, 11723.941380293043, 11813.291202527877, 11819.349935753444, 11835.585754498552, 5670.943290567042, 5796.536277097822, 5796.797112101056, 5832.329282132524, 5834.183214349994, 4643.419572553431, 5114.130597798383, 5286.841394758163, 5309.681419114788, 5390.272313237741, 4342.913141737211, 4365.279728844768, 4373.759443230653, 4431.4903786065015, 4433.977830110829, 1316.3352506984104, 1343.482759137739, 1345.4618152738788, 1349.2376807103956, 1359.4018631802173, 925.4724806860025, 1037.4605205293205, 1042.8748550173875, 1056.1709058389129, 1058.6083149234832, 6342.334054924167, 6462.806115816533, 6469.288378278386, 6478.611283323015, 6497.9350206498275, 487.37129103456147, 488.1457449463439, 488.9926651100236, 494.06621485392634, 498.9376327959005, 4336.869893903188, 4350.390945267665, 4377.102693947733, 4378.10248898975, 4380.189664912002, 11852.466639001093, 12175.45210465531, 12215.816762748565, 12321.691957701129, 12363.75272494545, 12014.63956081319, 12120.939395302967, 12121.272723636434, 12157.574484892986, 12187.268763874195, 8456.788580285542, 8780.78048048791, 8830.249428798625, 9001.684941027164, 9084.454932704059, 6196.256449226122, 6398.712057957497, 6450.3872132149245, 6481.222253329631, 6495.805125846232, 10940.015398614163, 11097.223194376316, 11130.666080017612, 11181.161412894227, 11242.213045086766, 11205.439728013404, 11385.29220616914, 11391.0, 11418.143639226924, 11546.711332216762, 7699.26856948589, 8536.658533658585, 8610.182032706884, 8770.780730481789, 8842.381033327605, 9499.765030545985, 9533.142017218484, 9551.14039736427, 9575.712728618153, 9599.760005999906, 8316.459430137022, 8372.28835548985, 8381.455205411628, 8634.798126477708, 8635.0, 8263.628136733982, 8331.875021874797, 8365.707200247962, 8374.790630234293, 8448.366372521963, 7720.729774457867, 7737.032870891138, 7796.298333149817, 7826.0, 7829.45193836426, 5095.847124586268, 5138.3833939927445, 5290.523852853108, 5559.972200139136, 5662.631928924607, 5642.60501764889, 5692.430756924275, 5760.423957604206, 5835.4748072673665, 5877.4122587740885], "value": 4951.846389421055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.76795662927526, 345.571491350725, 348.3364191215735, 351.2851347507819, 351.63781305255577, 5633.295838020247, 5674.638086859155, 5703.258576385075, 5706.942930570693, 5714.200011998313, 5574.331080270363, 5582.246396736449, 5612.242347283126, 5622.803201887935, 5626.887462250763, 4003.4395184674167, 4221.387898754679, 4371.584699453547, 4383.421968091485, 4403.185410699015, 4361.454818147731, 4386.056997745484, 4409.58108979648, 4418.5360537143615, 4420.005498762769, 4387.23223435899, 4392.846250381237, 4413.536578659243, 4413.845515406962, 4432.445944256968, 4283.400323954649, 4355.913657614661, 4392.978035109836, 4400.537943515917, 4435.223835828717, 3875.1668391295725, 3879.1271963807917, 3898.9725342821857, 3905.668018218455, 3919.549251836047, 5365.704886231256, 5412.810551630674, 5431.21247419122, 5455.781768729285, 5507.972460137714, 4868.294097355899, 4972.602191824645, 4993.925091123636, 5071.54356107952, 5091.567216786578, 5786.3056433228285, 5842.4741773240185, 5848.210491583624, 5876.265466816648, 5903.203067585907, 4284.464441944757, 4305.031367942219, 4306.095719898825, 4328.956710432887, 4355.978220108911, 5941.584089113764, 6058.151858739736, 6158.414950579688, 6162.13730077785, 6177.25872895251, 4331.0, 4336.484838793493, 4343.19650864591, 4358.629516491071, 4371.519132895379, 4403.493598236179, 4432.401625780542, 4440.3561483585345, 4446.755428451466, 4452.465704115527, 4912.459629440758, 5010.624203184776, 5040.7479626019285, 5075.822346217865, 5082.593392528589, 5925.703714814242, 5936.13925980739, 5936.584439089309, 5945.524358051345, 5960.211936419057, 1484.9851501484848, 1521.782573940843, 1522.444307827635, 1529.2124555853745, 1529.2812378182236, 945.5981207986579, 971.6064993677572, 979.588572799426, 982.4203719805206, 997.875265591801, 5090.720010399464, 5101.821436249787, 5128.640910158811, 5134.306868572769, 5143.8456846294675, 5363.731813409314, 5420.83737487876, 5459.344878614592, 5464.87969966156, 5473.8357849264585, 4885.998370334073, 5057.165567681292, 5076.492350764968, 5077.695338279715, 5085.7457127144235, 2890.638670166229, 2899.9710002900124, 2921.649402071765, 2929.667001514306, 2961.955570666442, 5427.674339539641, 5436.755346009439, 5439.4288599696465, 5460.7542660579575, 5583.692896890629, 5197.818076367309, 5501.889962200814, 5514.255575497336, 5522.641028333145, 5568.443155684399, 5378.892422151535, 5398.62209645321, 5404.864878377994, 5465.945340546623, 5477.4248703887115, 5144.845654630367, 5282.550983166474, 5455.781768729206, 5492.945070549244, 5509.641873278224, 5296.920546191733, 5320.707361095022, 5336.813211537577, 5433.891322173456, 5934.7922822701, 6100.633961962297, 6162.0, 6190.7523699051535, 6195.2255968004, 6202.534809889186, 4285.957140428556, 4317.460317460317, 4318.9568104319815, 4367.1265746851395, 4380.211561918885, 5867.354590995073, 6107.786227482195, 6112.7774445112045, 6154.692265386802, 6171.84570385744, 5917.171595976481, 5941.970290148522, 5947.732352044255, 5949.077892926603, 5960.4635582797755, 5606.803761868315, 5906.675132867562, 5917.142014407973, 5927.525797936241, 5956.791512297049, 5791.9284932287665, 5813.186153938367, 5819.013975426846, 5843.970780146072, 5866.6186697864505, 5883.588148829712, 5951.642901425928, 5971.522278217645, 5984.581079324405, 5996.190514280516, 5735.340435849931, 5811.56413269015, 5835.854103647443, 5842.38654941225, 5863.2670916135485], "value": 4381.192324892421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.479615851617, 819.4837252530908, 839.9034111077228, 846.1327139681825, 879.4064006795413, 15936.84063159368, 16665.0, 16676.249568769403, 16756.162191890417, 17056.14719264038, 14810.481633142843, 14827.481038163667, 14893.478728244514, 14926.029808062469, 14949.0, 841.2722994609679, 869.1352104655845, 872.8036191856845, 873.3013589128703, 878.0692465986043, 854.9444286121413, 862.5902696219308, 867.6442658510013, 868.2836659755727, 870.2515836380708, 909.2634965677822, 913.9588718507683, 914.8536234202529, 916.2486760856101, 917.1516347378648, 904.1681652879366, 904.3398319226935, 904.6788390121511, 906.229704750963, 906.7053207707488, 667.2926697700453, 667.5594107888819, 667.5961043568619, 671.0705672643425, 673.0442771264816, 16087.758683619639, 16152.030878147349, 16219.675606487805, 16305.429309974093, 16308.184590770532, 14433.927830360886, 14489.492867749683, 14666.120032798066, 15096.396144154221, 15791.210439478094, 13999.370028348749, 14141.222232777192, 14373.425062997572, 14469.20419376934, 14549.854501455062, 4739.691920025188, 4745.383100196952, 4781.234104939819, 4806.110869489155, 4842.031593681243, 81338.59330703368, 82220.17779822244, 82303.5884820578, 82937.58531207305, 84537.0, 11451.141164412702, 11525.423728813526, 11564.24832385909, 11791.174617776673, 11822.34977076269, 20531.076101575167, 20601.175952961712, 20607.0, 20726.170953161705, 21246.0, 8972.596233169523, 9104.635814567475, 9193.402428842237, 9292.53537323131, 9489.90510094904, 5099.974500127476, 5140.100482415637, 5144.382674079135, 5240.3973543042275, 5496.477834605706, 3983.4423180754716, 4098.692598055158, 4131.421600975866, 4310.0, 4547.840825571089, 785.8035491127218, 787.4605894961854, 788.9408294377945, 796.9840603187904, 798.8282519258387, 676.0231465532357, 784.372501998399, 833.9583020848934, 849.2993280543453, 858.3648100405779, 10585.259031867696, 10899.400532970763, 10964.945175274073, 10982.395968221665, 11154.219204655596, 772.3203580848817, 781.1875649324752, 801.1827935505752, 833.1085738260125, 837.342685991506, 5176.870578235575, 5412.269343638637, 5484.698341591251, 5893.528517718572, 6115.296740874856, 102522.0, 127865.0, 130778.0, 130948.345258275, 140777.0, 74373.0, 98705.50647246718, 109506.0, 115070.0, 116820.0, 99755.0, 101062.49468752756, 101461.0, 102743.0, 102907.4854625737, 10680.963654087212, 10773.73065673333, 10801.837972430263, 11030.834537482106, 11126.777464450828, 53960.460395395545, 54292.185617214986, 54305.18542221791, 54947.450525494234, 54985.725071375986, 73783.6310818464, 76053.0, 82747.17252827635, 82962.58518707368, 85087.57456212927, 14105.153690778176, 14231.35958881832, 14297.499587514387, 14438.350274237895, 14457.783133252799, 14918.030328028643, 15070.397184112513, 15981.840181598036, 16373.017618942902, 16517.58706032359, 14914.179720115064, 15270.618234543781, 15588.376464941275, 15620.453284135001, 16048.358065677243, 14208.502702405367, 14217.21805300677, 14422.134671919719, 15476.458323958608, 15960.20198990069, 14466.638334041732, 14658.70682586321, 14697.412103516168, 15127.092374457568, 15233.238338083273, 12632.621021369374, 12735.029545149202, 13069.607911762663, 13214.075014748876, 13231.603051908458, 13037.47850085986, 13230.801537977131, 13321.467141314239, 13441.126326788728, 13623.455061797416], "value": 8350.115080213334, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 105.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 111.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 128.0, 148.0, 173.0, 126.0, 151.0, 158.0, 126.0, 175.0, 125.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 173.0, 161.0, 162.0, 161.0, 163.0, 163.0, 160.0, 160.0, 161.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 173.0, 78.0, 76.0, 76.0, 75.0, 172.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 151.0, 84.0, 84.0, 85.0, 133.0, 85.0, 86.0, 141.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 122.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 146.0, 148.0, 146.0, 148.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 51.0, 52.0, 56.0, 54.0, 51.0, 55.0, 56.0, 52.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 77.0, 74.0, 76.0, 78.0, 77.0, 79.0, 107.0, 78.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 126.0, 119.0, 119.0, 118.0, 118.0, 134.0, 121.0, 140.0, 123.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 161.0, 163.0, 162.0, 156.0, 157.0, 161.0, 159.0, 155.0, 165.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 64.0, 62.0, 61.0, 65.0, 63.0, 62.0, 61.0], "value": 63.0, "unit": "score"}]}]} 03:51:47 INFO - Return code: 0 03:51:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:47 ERROR - # TBPL SUCCESS # 03:51:47 INFO - Running post-action listener: _resource_record_post_action 03:51:47 INFO - ##### 03:51:47 INFO - ##### Finished run-tests step (success) 03:51:47 INFO - ##### 03:51:47 INFO - Running post-run listener: _resource_record_post_run 03:51:47 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 294912; Write bytes: 506060800; Read time: 228; Write time: 399788 03:51:47 INFO - TinderboxPrint: CPU usage
13.4% 03:51:47 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 228 03:51:47 INFO - TinderboxPrint: I/O write bytes / time
506,060,800 / 399,788 03:51:47 INFO - TinderboxPrint: CPU idle
8,206.0 (86.6%) 03:51:47 INFO - TinderboxPrint: CPU user
1,216.5 (12.8%) 03:51:47 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252743680; Read time: 0; Write time: 236836 03:51:47 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 270336; Write bytes: 253317120; Read time: 204; Write time: 162952 03:51:48 INFO - Running post-run listener: _upload_blobber_files 03:51:48 INFO - Blob upload gear active. 03:51:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:48 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 03:51:48 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'] 03:51:48 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 03:51:48 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:51:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:51:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:49 INFO - (blobuploader) - INFO - Done attempting. 03:51:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:52 INFO - (blobuploader) - INFO - Done attempting. 03:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:51:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:53 INFO - (blobuploader) - INFO - Done attempting. 03:51:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:53 INFO - Return code: 0 03:51:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ab344d0f422f08fba0d11097981102298b4c11a9d8862754cffc8c13f4d9f92d17ff99e7e41a82ddda14ea0fe6ce6f78e9f9276f7d313c1c70e4a5510bf4048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c154b6e7ee821c8e7c8b6cac8a24b20c12a75f6b17d1135cf630193219917144b6685f719779d4866bce529a8a8a0972fae1e24926104ae5f1384d8d3600a0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361717db982f1d8acd914388a08d67d89e12454f5cfdef577e0c276c439c1898fa9e0fd2e2877332828ea4947245dbc9734dbd8958a159da41dd0d46e1da7385"} 03:51:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:53 INFO - Contents: 03:51:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ab344d0f422f08fba0d11097981102298b4c11a9d8862754cffc8c13f4d9f92d17ff99e7e41a82ddda14ea0fe6ce6f78e9f9276f7d313c1c70e4a5510bf4048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c154b6e7ee821c8e7c8b6cac8a24b20c12a75f6b17d1135cf630193219917144b6685f719779d4866bce529a8a8a0972fae1e24926104ae5f1384d8d3600a0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361717db982f1d8acd914388a08d67d89e12454f5cfdef577e0c276c439c1898fa9e0fd2e2877332828ea4947245dbc9734dbd8958a159da41dd0d46e1da7385"} 03:51:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:53 INFO - Copying logs to upload dir... 03:51:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.430225 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-10 03:51:52.859824) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:52.863680) ========= 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=6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875 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/1ab344d0f422f08fba0d11097981102298b4c11a9d8862754cffc8c13f4d9f92d17ff99e7e41a82ddda14ea0fe6ce6f78e9f9276f7d313c1c70e4a5510bf4048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c154b6e7ee821c8e7c8b6cac8a24b20c12a75f6b17d1135cf630193219917144b6685f719779d4866bce529a8a8a0972fae1e24926104ae5f1384d8d3600a0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361717db982f1d8acd914388a08d67d89e12454f5cfdef577e0c276c439c1898fa9e0fd2e2877332828ea4947245dbc9734dbd8958a159da41dd0d46e1da7385"} build_url:https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/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/1ab344d0f422f08fba0d11097981102298b4c11a9d8862754cffc8c13f4d9f92d17ff99e7e41a82ddda14ea0fe6ce6f78e9f9276f7d313c1c70e4a5510bf4048", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c154b6e7ee821c8e7c8b6cac8a24b20c12a75f6b17d1135cf630193219917144b6685f719779d4866bce529a8a8a0972fae1e24926104ae5f1384d8d3600a0eb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/361717db982f1d8acd914388a08d67d89e12454f5cfdef577e0c276c439c1898fa9e0fd2e2877332828ea4947245dbc9734dbd8958a159da41dd0d46e1da7385"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:52.888589) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:52.888890) ========= 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=6dbc10da6d83fee962c624be000001a8-1468146333.694810-764394875 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:52.972970) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 03:51:52.973271) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 03:51:52.973554) ========= ========= Total master_lag: 0.42 =========