builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-049 starttime: 1468146660.69 results: success (0) buildid: 20160710004020 builduid: affcc8bb1298492488c88e7cb2823bcd revision: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.688207) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.688907) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.689215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.777629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.777939) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-10 03:31:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-07-10 03:31:01 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102350 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.906205) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.909565) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014291 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:00.959446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-10 03:31:00.962964) ========= 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=db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-10 03:31:01,810 truncating revision to first 12 chars 2016-07-10 03:31:01,810 Setting DEBUG logging. 2016-07-10 03:31:01,810 attempt 1/10 2016-07-10 03:31:01,810 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:02,560 unpacking tar archive at: mozilla-aurora-8e3b5b3c31e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.098962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-10 03:31:02.075920) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:02.076298) ========= script_repo_revision: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:02.076842) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:02.077142) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-10 03:31:02.089304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-10 03:31:02.089775) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:03 INFO - MultiFileLogger online at 20160710 03:31:03 in /builds/slave/test 03:31:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:31:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:03 INFO - {'append_to_log': False, 03:31:03 INFO - 'base_work_dir': '/builds/slave/test', 03:31:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:31:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:03 INFO - 'branch': 'Mozilla-Aurora', 03:31:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:03 INFO - 'config_files': ('talos/linux_config.py',), 03:31:03 INFO - 'default_actions': ('clobber', 03:31:03 INFO - 'read-buildbot-config', 03:31:03 INFO - 'download-and-extract', 03:31:03 INFO - 'populate-webroot', 03:31:03 INFO - 'create-virtualenv', 03:31:03 INFO - 'install', 03:31:03 INFO - 'run-tests'), 03:31:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:03 INFO - 'download_minidump_stackwalk': True, 03:31:03 INFO - 'download_symbols': 'ondemand', 03:31:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:03 INFO - 'installer_path': 'installer.exe', 03:31:03 INFO - 'log_level': 'info', 03:31:03 INFO - 'log_name': 'talos', 03:31:03 INFO - 'log_to_console': True, 03:31:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:03 INFO - 'opt_config_files': (), 03:31:03 INFO - 'pip_index': False, 03:31:03 INFO - 'sps_profile': False, 03:31:03 INFO - 'sps_profile_interval': 0, 03:31:03 INFO - 'suite': 'dromaeojs', 03:31:03 INFO - 'system_bits': '32', 03:31:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:03 INFO - 'title': 'talos-linux64-ix-049', 03:31:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:03 INFO - 'use_talos_json': True, 03:31:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:03 INFO - 'work_dir': 'build'} 03:31:03 INFO - ##### 03:31:03 INFO - ##### Running clobber step. 03:31:03 INFO - ##### 03:31:03 INFO - Running pre-action listener: _resource_record_pre_action 03:31:03 INFO - Running main action method: clobber 03:31:03 INFO - rmtree: /builds/slave/test/build 03:31:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:03 INFO - Running post-action listener: _resource_record_post_action 03:31:03 INFO - ##### 03:31:03 INFO - ##### Finished clobber step (success) 03:31:03 INFO - ##### 03:31:03 INFO - ##### 03:31:03 INFO - ##### Running read-buildbot-config step. 03:31:03 INFO - ##### 03:31:03 INFO - Running pre-action listener: _resource_record_pre_action 03:31:03 INFO - Running main action method: read_buildbot_config 03:31:03 INFO - Using buildbot properties: 03:31:03 INFO - { 03:31:03 INFO - "project": "", 03:31:03 INFO - "product": "firefox", 03:31:03 INFO - "script_repo_revision": "production", 03:31:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:31:03 INFO - "repository": "", 03:31:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:31:03 INFO - "buildid": "20160710004020", 03:31:03 INFO - "stage_platform": "linux64-pgo", 03:31:03 INFO - "basedir": "/builds/slave/test", 03:31:03 INFO - "nightly_build": "True", 03:31:03 INFO - "buildnumber": 363, 03:31:03 INFO - "slavename": "talos-linux64-ix-049", 03:31:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:31:03 INFO - "platform": "ubuntu64_hw", 03:31:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:31:03 INFO - "branch": "mozilla-aurora", 03:31:03 INFO - "repo_path": "releases/mozilla-aurora", 03:31:03 INFO - "revision": "8e3b5b3c31e5fffedaa5bc253222a6ca567bf421", 03:31:03 INFO - "pgo_build": "True", 03:31:03 INFO - "builduid": "affcc8bb1298492488c88e7cb2823bcd", 03:31:03 INFO - "slavebuilddir": "test" 03:31:03 INFO - } 03:31:03 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:03 INFO - Running post-action listener: _resource_record_post_action 03:31:03 INFO - ##### 03:31:03 INFO - ##### Finished read-buildbot-config step (success) 03:31:03 INFO - ##### 03:31:03 INFO - ##### 03:31:03 INFO - ##### Running download-and-extract step. 03:31:03 INFO - ##### 03:31:03 INFO - Running pre-action listener: _resource_record_pre_action 03:31:03 INFO - Running main action method: download_and_extract 03:31:03 INFO - mkdir: /builds/slave/test/build/tests 03:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:03 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:03 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:03 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:03 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:03 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:08 INFO - Downloaded 1361 bytes. 03:31:08 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:31:08 INFO - Using the following test package requirements: 03:31:08 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:08 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:31:08 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:31:08 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'jsshell-linux-x86_64.zip'], 03:31:08 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:31:08 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:31:08 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:31:08 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:31:08 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:31:08 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:31:08 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:31:08 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:08 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:08 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:08 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:08 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:08 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:09 INFO - Downloaded 24526733 bytes. 03:31:09 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:09 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:11 INFO - Return code: 0 03:31:11 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:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:11 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:11 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:11 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:11 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:11 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:14 INFO - Downloaded 24526733 bytes. 03:31:14 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:14 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:15 INFO - Return code: 0 03:31: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:31:15 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:15 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:15 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:15 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:15 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:17 INFO - Downloaded 10833369 bytes. 03:31:17 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:17 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:17 INFO - Return code: 0 03:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:17 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:17 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:17 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:17 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:17 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:19 INFO - Downloaded 63609545 bytes. 03:31:19 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:19 INFO - mkdir: /builds/slave/test/properties 03:31:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:31:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:31:19 INFO - Contents: 03:31:19 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:20 INFO - Running post-action listener: _resource_record_post_action 03:31:20 INFO - Running post-action listener: set_extra_try_arguments 03:31:20 INFO - ##### 03:31:20 INFO - ##### Finished download-and-extract step (success) 03:31:20 INFO - ##### 03:31:20 INFO - ##### 03:31:20 INFO - ##### Running populate-webroot step. 03:31:20 INFO - ##### 03:31:20 INFO - Running pre-action listener: _resource_record_pre_action 03:31:20 INFO - Running main action method: populate_webroot 03:31:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:31:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:31:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:31:20 INFO - '--tppagecycles', 03:31:20 INFO - '7'], 03:31:20 INFO - 'tests': ['tsvgm']}}, 03:31:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:31:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:31:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:31:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:31:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:31:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['damp', 'tps']}, 03:31:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'tests': ['damp', 'tps']}, 03:31:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['dromaeo_dom']}, 03:31:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:31:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['a11yr', 03:31:20 INFO - 'ts_paint', 03:31:20 INFO - 'tpaint', 03:31:20 INFO - 'sessionrestore', 03:31:20 INFO - 'sessionrestore_no_auto_restore', 03:31:20 INFO - 'tabpaint']}, 03:31:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:31:20 INFO - 'ts_paint', 03:31:20 INFO - 'tpaint', 03:31:20 INFO - 'sessionrestore', 03:31:20 INFO - 'sessionrestore_no_auto_restore', 03:31:20 INFO - 'tabpaint']}, 03:31:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:31:20 INFO - 'ts_paint', 03:31:20 INFO - 'tpaint', 03:31:20 INFO - 'sessionrestore', 03:31:20 INFO - 'sessionrestore_no_auto_restore', 03:31:20 INFO - 'tabpaint']}, 03:31:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:31:20 INFO - 'ts_paint', 03:31:20 INFO - 'tpaint', 03:31:20 INFO - 'sessionrestore', 03:31:20 INFO - 'sessionrestore_no_auto_restore', 03:31:20 INFO - 'tabpaint']}, 03:31:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['a11yr', 03:31:20 INFO - 'ts_paint', 03:31:20 INFO - 'tpaint', 03:31:20 INFO - 'sessionrestore', 03:31:20 INFO - 'sessionrestore_no_auto_restore', 03:31:20 INFO - 'tabpaint']}, 03:31:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['a11yr', 03:31:20 INFO - 'ts_paint', 03:31:20 INFO - 'tpaint', 03:31:20 INFO - 'sessionrestore', 03:31:20 INFO - 'sessionrestore_no_auto_restore', 03:31:20 INFO - 'tabpaint']}, 03:31:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['tsvgx', 03:31:20 INFO - 'tsvgr_opacity', 03:31:20 INFO - 'tart', 03:31:20 INFO - 'tscrollx', 03:31:20 INFO - 'cart']}, 03:31:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:31:20 INFO - 'tsvgr_opacity', 03:31:20 INFO - 'tart', 03:31:20 INFO - 'tscrollx', 03:31:20 INFO - 'cart']}, 03:31:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'talos_options': ['--disable-e10s'], 03:31:20 INFO - 'tests': ['tp5o']}, 03:31:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'tests': ['tp5o']}, 03:31:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'talos_options': ['--disable-e10s', 03:31:20 INFO - '--xperf_path', 03:31:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:20 INFO - 'tests': ['tp5n']}, 03:31:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:31:20 INFO - 'talos_options': ['--xperf_path', 03:31:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:31:20 INFO - 'tests': ['tp5n']}}, 03:31:20 INFO - 'talos.zip': {'path': '', 03:31:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:31:20 INFO - Running post-action listener: _resource_record_post_action 03:31:20 INFO - ##### 03:31:20 INFO - ##### Finished populate-webroot step (success) 03:31:20 INFO - ##### 03:31:20 INFO - ##### 03:31:20 INFO - ##### Running create-virtualenv step. 03:31:20 INFO - ##### 03:31:20 INFO - Running pre-action listener: _resource_record_pre_action 03:31:20 INFO - Running main action method: create_virtualenv 03:31:20 INFO - Creating virtualenv /builds/slave/test/build/venv 03:31:20 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:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:31:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:31:20 INFO - Using real prefix '/usr' 03:31:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:31:20 INFO - Installing distribute.............................................................................................................................................................................................done. 03:31:22 INFO - Installing pip.................done. 03:31:22 INFO - Return code: 0 03:31:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:22 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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 03:31:22 INFO - 'HOME': '/home/cltbld', 03:31:22 INFO - 'LANG': 'en_US.UTF-8', 03:31:22 INFO - 'LANGUAGE': 'en_US:en', 03:31:22 INFO - 'LOGNAME': 'cltbld', 03:31:22 INFO - 'MAIL': '/var/mail/cltbld', 03:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:22 INFO - 'MOZ_NO_REMOTE': '1', 03:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:22 INFO - 'NO_EM_RESTART': '1', 03:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:22 INFO - 'PWD': '/builds/slave/test', 03:31:22 INFO - 'SHELL': '/bin/bash', 03:31:22 INFO - 'SHLVL': '1', 03:31:22 INFO - 'TERM': 'linux', 03:31:22 INFO - 'TMOUT': '86400', 03:31:22 INFO - 'USER': 'cltbld', 03:31:22 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:22 INFO - '_': '/tools/buildbot/bin/python'} 03:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:22 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:22 INFO - Cleaning up... 03:31:22 INFO - Return code: 0 03:31:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:22 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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 03:31:22 INFO - 'HOME': '/home/cltbld', 03:31:22 INFO - 'LANG': 'en_US.UTF-8', 03:31:22 INFO - 'LANGUAGE': 'en_US:en', 03:31:22 INFO - 'LOGNAME': 'cltbld', 03:31:22 INFO - 'MAIL': '/var/mail/cltbld', 03:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:22 INFO - 'MOZ_NO_REMOTE': '1', 03:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:22 INFO - 'NO_EM_RESTART': '1', 03:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:22 INFO - 'PWD': '/builds/slave/test', 03:31:22 INFO - 'SHELL': '/bin/bash', 03:31:22 INFO - 'SHLVL': '1', 03:31:22 INFO - 'TERM': 'linux', 03:31:22 INFO - 'TMOUT': '86400', 03:31:22 INFO - 'USER': 'cltbld', 03:31:22 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:22 INFO - '_': '/tools/buildbot/bin/python'} 03:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:23 INFO - Downloading/unpacking psutil>=3.1.1 03:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:31:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:25 INFO - Installing collected packages: psutil 03:31:25 INFO - Running setup.py install for psutil 03:31:25 INFO - building 'psutil._psutil_linux' extension 03:31:25 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:25 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:25 INFO - building 'psutil._psutil_posix' extension 03:31:25 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:25 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:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:31:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:31:25 INFO - Successfully installed psutil 03:31:25 INFO - Cleaning up... 03:31:25 INFO - Return code: 0 03:31:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:31:25 INFO - Using env: {'DISPLAY': ':0', 03:31:25 INFO - 'HOME': '/home/cltbld', 03:31:25 INFO - 'LANG': 'en_US.UTF-8', 03:31:25 INFO - 'LANGUAGE': 'en_US:en', 03:31:25 INFO - 'LOGNAME': 'cltbld', 03:31:25 INFO - 'MAIL': '/var/mail/cltbld', 03:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:25 INFO - 'MOZ_NO_REMOTE': '1', 03:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:25 INFO - 'NO_EM_RESTART': '1', 03:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:25 INFO - 'PWD': '/builds/slave/test', 03:31:25 INFO - 'SHELL': '/bin/bash', 03:31:25 INFO - 'SHLVL': '1', 03:31:25 INFO - 'TERM': 'linux', 03:31:25 INFO - 'TMOUT': '86400', 03:31:25 INFO - 'USER': 'cltbld', 03:31:25 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:25 INFO - '_': '/tools/buildbot/bin/python'} 03:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:31:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:31:27 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:27 INFO - Installing collected packages: mozsystemmonitor 03:31:27 INFO - Running setup.py install for mozsystemmonitor 03:31:27 INFO - Successfully installed mozsystemmonitor 03:31:27 INFO - Cleaning up... 03:31:27 INFO - Return code: 0 03:31:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:31:27 INFO - Using env: {'DISPLAY': ':0', 03:31:27 INFO - 'HOME': '/home/cltbld', 03:31:27 INFO - 'LANG': 'en_US.UTF-8', 03:31:27 INFO - 'LANGUAGE': 'en_US:en', 03:31:27 INFO - 'LOGNAME': 'cltbld', 03:31:27 INFO - 'MAIL': '/var/mail/cltbld', 03:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:27 INFO - 'MOZ_NO_REMOTE': '1', 03:31:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:27 INFO - 'NO_EM_RESTART': '1', 03:31:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:27 INFO - 'PWD': '/builds/slave/test', 03:31:27 INFO - 'SHELL': '/bin/bash', 03:31:27 INFO - 'SHLVL': '1', 03:31:27 INFO - 'TERM': 'linux', 03:31:27 INFO - 'TMOUT': '86400', 03:31:27 INFO - 'USER': 'cltbld', 03:31:27 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:27 INFO - '_': '/tools/buildbot/bin/python'} 03:31:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:31:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:31:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:31:30 INFO - warning: no files found matching '*.txt' 03:31:30 INFO - no previously-included directories found matching 'build' 03:31:30 INFO - no previously-included directories found matching 'dist' 03:31:30 INFO - no previously-included directories found matching '.git*' 03:31:30 INFO - Installing collected packages: jsonschema, functools32 03:31:30 INFO - Running setup.py install for functools32 03:31:30 INFO - warning: no files found matching '*.txt' 03:31:30 INFO - no previously-included directories found matching 'build' 03:31:30 INFO - no previously-included directories found matching 'dist' 03:31:30 INFO - no previously-included directories found matching '.git*' 03:31:30 INFO - Successfully installed jsonschema functools32 03:31:30 INFO - Cleaning up... 03:31:30 INFO - Return code: 0 03:31:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:31:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:31:30 INFO - Using env: {'DISPLAY': ':0', 03:31:30 INFO - 'HOME': '/home/cltbld', 03:31:30 INFO - 'LANG': 'en_US.UTF-8', 03:31:30 INFO - 'LANGUAGE': 'en_US:en', 03:31:30 INFO - 'LOGNAME': 'cltbld', 03:31:30 INFO - 'MAIL': '/var/mail/cltbld', 03:31:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:30 INFO - 'MOZ_NO_REMOTE': '1', 03:31:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:30 INFO - 'NO_EM_RESTART': '1', 03:31:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:30 INFO - 'PWD': '/builds/slave/test', 03:31:30 INFO - 'SHELL': '/bin/bash', 03:31:30 INFO - 'SHLVL': '1', 03:31:30 INFO - 'TERM': 'linux', 03:31:30 INFO - 'TMOUT': '86400', 03:31:30 INFO - 'USER': 'cltbld', 03:31:30 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:30 INFO - '_': '/tools/buildbot/bin/python'} 03:31:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:31:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:31:32 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:32 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:32 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:32 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:32 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:32 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:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:31:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:33 INFO - Downloading docopt-0.6.1.tar.gz 03:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:31:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:31:33 INFO - Running setup.py install for blobuploader 03:31:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:31:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:31:33 INFO - Running setup.py install for requests 03:31:33 INFO - Running setup.py install for docopt 03:31:33 INFO - Successfully installed blobuploader requests docopt 03:31:33 INFO - Cleaning up... 03:31:34 INFO - Return code: 0 03:31:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:34 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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:34 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:34 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:34 INFO - Using env: {'DISPLAY': ':0', 03:31:34 INFO - 'HOME': '/home/cltbld', 03:31:34 INFO - 'LANG': 'en_US.UTF-8', 03:31:34 INFO - 'LANGUAGE': 'en_US:en', 03:31:34 INFO - 'LOGNAME': 'cltbld', 03:31:34 INFO - 'MAIL': '/var/mail/cltbld', 03:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:34 INFO - 'MOZ_NO_REMOTE': '1', 03:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:34 INFO - 'NO_EM_RESTART': '1', 03:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:34 INFO - 'PWD': '/builds/slave/test', 03:31:34 INFO - 'SHELL': '/bin/bash', 03:31:34 INFO - 'SHLVL': '1', 03:31:34 INFO - 'TERM': 'linux', 03:31:34 INFO - 'TMOUT': '86400', 03:31:34 INFO - 'USER': 'cltbld', 03:31:34 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:34 INFO - '_': '/tools/buildbot/bin/python'} 03:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:34 INFO - Running setup.py (path:/tmp/pip-AopVtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:34 INFO - Running setup.py (path:/tmp/pip-ZmZDnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:34 INFO - Running setup.py (path:/tmp/pip-CMgW2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:34 INFO - Running setup.py (path:/tmp/pip-8q_6Ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:34 INFO - Running setup.py (path:/tmp/pip-qQEZCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:34 INFO - Running setup.py (path:/tmp/pip-1IaCwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:34 INFO - Running setup.py (path:/tmp/pip-9YTmzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:34 INFO - Running setup.py (path:/tmp/pip-630pCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:34 INFO - Running setup.py (path:/tmp/pip-YJgRGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:34 INFO - Running setup.py (path:/tmp/pip-LNT7Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:34 INFO - Running setup.py (path:/tmp/pip-xOQzuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:35 INFO - Running setup.py (path:/tmp/pip-YwBT3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:35 INFO - Running setup.py (path:/tmp/pip-7p9gQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:35 INFO - Running setup.py (path:/tmp/pip-bpfkhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:35 INFO - Running setup.py (path:/tmp/pip-nSyC7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:35 INFO - Running setup.py (path:/tmp/pip-gd3pcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:35 INFO - Running setup.py (path:/tmp/pip-5bFoxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:31:35 INFO - Running setup.py install for manifestparser 03:31:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:31:35 INFO - Running setup.py install for mozcrash 03:31:35 INFO - Running setup.py install for mozdebug 03:31:35 INFO - Running setup.py install for mozdevice 03:31:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:31:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:31:35 INFO - Running setup.py install for mozfile 03:31:36 INFO - Running setup.py install for mozhttpd 03:31:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Running setup.py install for mozinfo 03:31:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Running setup.py install for mozInstall 03:31:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Running setup.py install for mozleak 03:31:36 INFO - Running setup.py install for mozlog 03:31:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Running setup.py install for moznetwork 03:31:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Running setup.py install for mozprocess 03:31:36 INFO - Running setup.py install for mozprofile 03:31:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Running setup.py install for mozrunner 03:31:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:31:36 INFO - Running setup.py install for mozscreenshot 03:31:37 INFO - Running setup.py install for moztest 03:31:37 INFO - Running setup.py install for mozversion 03:31:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:31:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:31:37 INFO - Cleaning up... 03:31:37 INFO - Return code: 0 03:31:37 INFO - Installing None 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', '-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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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', '-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:37 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: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': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:31:37 INFO - Running setup.py (path:/tmp/pip-JLhS8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:31:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:31:37 INFO - Running setup.py (path:/tmp/pip-yx4sBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:31:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:31:37 INFO - Running setup.py (path:/tmp/pip-SzAJNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:31:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:31:37 INFO - Running setup.py (path:/tmp/pip-Roa_l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:31:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:31:37 INFO - Running setup.py (path:/tmp/pip-TZqKqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:31:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:31:37 INFO - Running setup.py (path:/tmp/pip-o1y2Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:31:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:31:37 INFO - Running setup.py (path:/tmp/pip-luD90e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:31:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:31:37 INFO - Running setup.py (path:/tmp/pip-0_h1qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:31:38 INFO - Running setup.py (path:/tmp/pip-0OkN9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:31:38 INFO - Running setup.py (path:/tmp/pip-E4hH1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:31:38 INFO - Running setup.py (path:/tmp/pip-p4Ff8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:31:38 INFO - Running setup.py (path:/tmp/pip-CXpI0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:31:38 INFO - Running setup.py (path:/tmp/pip-ROwFzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:31:38 INFO - Running setup.py (path:/tmp/pip-rHwDv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:38 INFO - Running setup.py (path:/tmp/pip-f1HYRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:38 INFO - Running setup.py (path:/tmp/pip-m5g0Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:38 INFO - Running setup.py (path:/tmp/pip-XGGNCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:38 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:38 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:38 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:38 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:38 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:38 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 - Downloading blessings-1.6.tar.gz 03:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:40 INFO - Installing collected packages: blessings 03:31:40 INFO - Running setup.py install for blessings 03:31:40 INFO - Successfully installed blessings 03:31:40 INFO - Cleaning up... 03:31:40 INFO - Return code: 0 03:31:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:41 INFO - Reading from file tmpfile_stdout 03:31:41 INFO - Current package versions: 03:31:41 INFO - argparse == 1.2.1 03:31:41 INFO - blessings == 1.6 03:31:41 INFO - blobuploader == 1.2.4 03:31:41 INFO - docopt == 0.6.1 03:31:41 INFO - functools32 == 3.2.3-2 03:31:41 INFO - jsonschema == 2.5.1 03:31:41 INFO - manifestparser == 1.1 03:31:41 INFO - mozInstall == 1.12 03:31:41 INFO - mozcrash == 0.17 03:31:41 INFO - mozdebug == 0.1 03:31:41 INFO - mozdevice == 0.48 03:31:41 INFO - mozfile == 1.2 03:31:41 INFO - mozhttpd == 0.7 03:31:41 INFO - mozinfo == 0.9 03:31:41 INFO - mozleak == 0.1 03:31:41 INFO - mozlog == 3.2 03:31:41 INFO - moznetwork == 0.27 03:31:41 INFO - mozprocess == 0.22 03:31:41 INFO - mozprofile == 0.28 03:31:41 INFO - mozrunner == 6.11 03:31:41 INFO - mozscreenshot == 0.1 03:31:41 INFO - mozsystemmonitor == 0.3 03:31:41 INFO - moztest == 0.7 03:31:41 INFO - mozversion == 1.4 03:31:41 INFO - psutil == 3.1.1 03:31:41 INFO - requests == 1.2.3 03:31:41 INFO - wsgiref == 0.1.2 03:31:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 03:31:41 INFO - 'HOME': '/home/cltbld', 03:31:41 INFO - 'LANG': 'en_US.UTF-8', 03:31:41 INFO - 'LANGUAGE': 'en_US:en', 03:31:41 INFO - 'LOGNAME': 'cltbld', 03:31:41 INFO - 'MAIL': '/var/mail/cltbld', 03:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:41 INFO - 'MOZ_NO_REMOTE': '1', 03:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:41 INFO - 'NO_EM_RESTART': '1', 03:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:41 INFO - 'PWD': '/builds/slave/test', 03:31:41 INFO - 'SHELL': '/bin/bash', 03:31:41 INFO - 'SHLVL': '1', 03:31:41 INFO - 'TERM': 'linux', 03:31:41 INFO - 'TMOUT': '86400', 03:31:41 INFO - 'USER': 'cltbld', 03:31:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:41 INFO - '_': '/tools/buildbot/bin/python'} 03:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Cleaning up... 03:31:41 INFO - Return code: 0 03:31:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 03:31:41 INFO - 'HOME': '/home/cltbld', 03:31:41 INFO - 'LANG': 'en_US.UTF-8', 03:31:41 INFO - 'LANGUAGE': 'en_US:en', 03:31:41 INFO - 'LOGNAME': 'cltbld', 03:31:41 INFO - 'MAIL': '/var/mail/cltbld', 03:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:41 INFO - 'MOZ_NO_REMOTE': '1', 03:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:41 INFO - 'NO_EM_RESTART': '1', 03:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:41 INFO - 'PWD': '/builds/slave/test', 03:31:41 INFO - 'SHELL': '/bin/bash', 03:31:41 INFO - 'SHLVL': '1', 03:31:41 INFO - 'TERM': 'linux', 03:31:41 INFO - 'TMOUT': '86400', 03:31:41 INFO - 'USER': 'cltbld', 03:31:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:41 INFO - '_': '/tools/buildbot/bin/python'} 03:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:41 INFO - Cleaning up... 03:31:41 INFO - Return code: 0 03:31:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31:41 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:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:41 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 0x7ffaaf280f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27bb020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 03:31:41 INFO - 'HOME': '/home/cltbld', 03:31:41 INFO - 'LANG': 'en_US.UTF-8', 03:31:41 INFO - 'LANGUAGE': 'en_US:en', 03:31:41 INFO - 'LOGNAME': 'cltbld', 03:31:41 INFO - 'MAIL': '/var/mail/cltbld', 03:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:41 INFO - 'MOZ_NO_REMOTE': '1', 03:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:41 INFO - 'NO_EM_RESTART': '1', 03:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:41 INFO - 'PWD': '/builds/slave/test', 03:31:41 INFO - 'SHELL': '/bin/bash', 03:31:41 INFO - 'SHLVL': '1', 03:31:41 INFO - 'TERM': 'linux', 03:31:41 INFO - 'TMOUT': '86400', 03:31:41 INFO - 'USER': 'cltbld', 03:31:41 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:41 INFO - '_': '/tools/buildbot/bin/python'} 03:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:41 INFO - Downloading/unpacking flake8 03:31:41 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:41 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:41 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:41 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:41 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:41 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:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:44 INFO - no previously-included directories found matching 'docs/_build' 03:31:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:44 INFO - Running setup.py install for pep8 03:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:44 INFO - no previously-included directories found matching 'docs/_build' 03:31:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:44 INFO - Cleaning up... 03:31:44 INFO - Return code: 0 03:31:44 INFO - Running post-action listener: _resource_record_post_action 03:31:44 INFO - Running post-action listener: _start_resource_monitoring 03:31:44 INFO - Starting resource monitoring. 03:31:44 INFO - ##### 03:31:44 INFO - ##### Finished create-virtualenv step (success) 03:31:44 INFO - ##### 03:31:44 INFO - ##### 03:31:44 INFO - ##### Running install step. 03:31:44 INFO - ##### 03:31:44 INFO - Running pre-action listener: _resource_record_pre_action 03:31:44 INFO - Running main action method: install 03:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:44 INFO - Reading from file tmpfile_stdout 03:31:44 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:45 INFO - Reading from file tmpfile_stdout 03:31:45 INFO - Output received: 03:31:45 INFO - Usage: mozinstall [options] installer 03:31:45 INFO - Options: 03:31:45 INFO - -h, --help show this help message and exit 03:31:45 INFO - -d DEST, --destination=DEST 03:31:45 INFO - Directory to install application into. [default: 03:31:45 INFO - "/builds/slave/test"] 03:31:45 INFO - --app=APP Application being installed. [default: firefox] 03:31:45 INFO - mkdir: /builds/slave/test/build/application 03:31:45 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:45 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:00 INFO - Reading from file tmpfile_stdout 03:32:00 INFO - Output received: 03:32:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:32:00 INFO - Running post-action listener: _resource_record_post_action 03:32:00 INFO - ##### 03:32:00 INFO - ##### Finished install step (success) 03:32:00 INFO - ##### 03:32:00 INFO - ##### 03:32:00 INFO - ##### Running run-tests step. 03:32:00 INFO - ##### 03:32:00 INFO - Running pre-action listener: _resource_record_pre_action 03:32:00 INFO - Running main action method: run_tests 03:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:32:00 INFO - Python 2.7.3 03:32:00 INFO - Return code: 0 03:32:00 INFO - grabbing minidump binary from tooltool 03:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:00 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 0x284d2e0>, '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 0x27b9140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27b95d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:32:00 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:00 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:00 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:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:32:00 INFO - Return code: 0 03:32:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:32:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:32:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:32:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:32:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:32:01 INFO - Return code: 0 03:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:32:01 INFO - Using env: {'DISPLAY': ':0', 03:32:01 INFO - 'HOME': '/home/cltbld', 03:32:01 INFO - 'LANG': 'en_US.UTF-8', 03:32:01 INFO - 'LANGUAGE': 'en_US:en', 03:32:01 INFO - 'LOGNAME': 'cltbld', 03:32:01 INFO - 'MAIL': '/var/mail/cltbld', 03:32:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:32:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:01 INFO - 'MOZ_NO_REMOTE': '1', 03:32:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:01 INFO - 'NO_EM_RESTART': '1', 03:32:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:01 INFO - 'PWD': '/builds/slave/test', 03:32:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:32:01 INFO - 'SHELL': '/bin/bash', 03:32:01 INFO - 'SHLVL': '1', 03:32:01 INFO - 'TERM': 'linux', 03:32:01 INFO - 'TMOUT': '86400', 03:32:01 INFO - 'USER': 'cltbld', 03:32:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526', 03:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:01 INFO - '_': '/tools/buildbot/bin/python'} 03:32:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZIklfqlSR-tlGzsbTNWFw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:32:02 INFO - mozversion application_buildid: 20160710004020 03:32:02 INFO - mozversion application_changeset: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 03:32:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:32:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:32:02 INFO - mozversion application_name: Firefox 03:32:02 INFO - mozversion application_remotingname: firefox-dev 03:32:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:02 INFO - mozversion application_vendor: Mozilla 03:32:02 INFO - mozversion application_version: 49.0a2 03:32:02 INFO - mozversion platform_buildid: 20160710004020 03:32:02 INFO - mozversion platform_changeset: 8e3b5b3c31e5fffedaa5bc253222a6ca567bf421 03:32:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:32:02 INFO - mozversion platform_version: 49.0a2 03:32:02 INFO - using testdate: 1468146722 03:32:02 INFO - actual date: 1468146722 03:32:02 INFO - starting webserver on 'localhost:35751' 03:32:02 INFO - SUITE-START | Running 2 tests 03:32:02 INFO - TEST-START | dromaeo_css 03:32:02 INFO - operating with platform_type : linux_ 03:32:02 INFO - Initialising browser for dromaeo_css test... 03:32:02 INFO - TEST-INFO | started process 29726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJYYoE3/profile http://localhost:35751/getInfo.html) 03:32:06 INFO - PROCESS | 29726 | __metrics Screen width/height:1600/1200 03:32:06 INFO - PROCESS | 29726 | colorDepth:24 03:32:06 INFO - PROCESS | 29726 | Browser inner width/height: 1024/697 03:32:06 INFO - PROCESS | 29726 | __metrics 03:32:07 ERROR - PROCESS | 29726 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:32:08 INFO - TEST-INFO | 29726: exit 0 03:32:08 INFO - Browser initialized. 03:32:08 INFO - Running cycle 1/1 for dromaeo_css test... 03:32:08 INFO - TEST-INFO | started process 29818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJYYoE3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:19 INFO - PROCESS | 29818 | RSS: Main: 145317888 03:32:19 INFO - PROCESS | 29818 | 03:33:11 INFO - PROCESS | 29818 | 1468146791173 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:19 INFO - PROCESS | 29818 | Cycle 1(1): loaded http://localhost:35751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35751/tests/dromaeo/cssquery-ext.html) 03:35:20 INFO - PROCESS | 29818 | RSS: Main: 244817920 03:35:20 INFO - PROCESS | 29818 | 03:38:22 INFO - PROCESS | 29818 | Cycle 1(1): loaded http://localhost:35751/tests/dromaeo/cssquery-ext.html (next: http://localhost:35751/tests/dromaeo/cssquery-jquery.html) 03:38:23 INFO - PROCESS | 29818 | RSS: Main: 232513536 03:38:23 INFO - PROCESS | 29818 | 03:41:25 INFO - PROCESS | 29818 | Cycle 1(1): loaded http://localhost:35751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35751/tests/dromaeo/cssquery-mootools.html) 03:41:25 INFO - PROCESS | 29818 | RSS: Main: 222289920 03:41:25 INFO - PROCESS | 29818 | 03:44:27 INFO - PROCESS | 29818 | Cycle 1(1): loaded http://localhost:35751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35751/tests/dromaeo/cssquery-prototype.html) 03:44:28 INFO - PROCESS | 29818 | RSS: Main: 221306880 03:44:28 INFO - PROCESS | 29818 | 03:47:30 INFO - PROCESS | 29818 | Cycle 1(1): loaded http://localhost:35751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35751/tests/dromaeo/cssquery-yui.html) 03:47:31 INFO - PROCESS | 29818 | RSS: Main: 191438848 03:47:31 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | Cycle 1(1): loaded http://localhost:35751/tests/dromaeo/cssquery-yui.html (next: http://localhost:35751/tests/dromaeo/cssquery-dojo.html) 03:50:33 INFO - PROCESS | 29818 | RSS: Main: 257040384 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | __start_tp_report 03:50:33 INFO - PROCESS | 29818 | _x_x_mozilla_page_load 03:50:33 INFO - PROCESS | 29818 | _x_x_mozilla_page_load_details 03:50:33 INFO - PROCESS | 29818 | |i|pagename|runs| 03:50:33 INFO - PROCESS | 29818 | |0;dojo.html;3325.8503367348467;3362.8654853805865;3367.0572239772855;3389.4407422775244;3410.522526846242;5524.723763811809;5583.832485025446;5585.888282234363;5586.692731899744;5612.045952188128;5604.243427137335;5670.376258611549;5677.063284558043;5683.886322273552;5687.7156142192825;4852.393450818648;5060.0132974070075;5128.640995130342;5143.048536020848;5192.324997750287;4894.730789806559;4991.151504244269;5023.547880690737;5032.421271553763;5035.471275516073;5005.1491246488;5006.524380183877;5048.62135339851;5070.594352451795;5074.644774865761;5157.5358217760395;5165.147750621143;5171.2501687255135;5174.301469301671;5206.010857936999;4879.731614761186;4902.754862256908;4932.260160975847;5053.646244762868;5077.543021128116;5318.202269659543;5321.680699158062;5360.919586206171;5380.542653874425;5394.244805727201;5908.734106965197;5956.106584012389;5958.910616340759;5961.195238642771;5966;5865.794697185578;5916.319623243296;5924.526037916957;5987.670678112702;6003.129546215774;5567.220589117527;5608.663480191201;5610.074337734269;5614.859628509279;5621.465960733764;5983.072623743326;6101.962666346732;6103.938960610426;6112.147208752953;6116.113163591343;5844.26946631671;5893.322267939242;5906.143609176645;6000.129981152796;6009.639421634716;6035.155078289043;6053.1929175555015;6065.332813390523;6071.150038994456;6103.511719062464;5704.1443783432815;5822.039363504974;6013.248343957005;6041.577089603686;6043.395660434009;5859.736311865976;5911.586188966731;5916.556258280646;5924.229850119457;5950.4049595041015;4560.156371071363;4560.293154561048;4564.52072532386;4565.178267911808;4587.990642058741;4013.8996525087105;4023.7786921719585;4047.0287131088326;4085.9785053736564;4124.876253712393;5537.169424586345;5559.972200138974;5564.4713752193475;5564.916526252109;5587.664740115606;5898.14476900847;5944.019236825961;5945.227120474311;5948.405159484017;5971.671558064349;5382.703951282639;5531.419200983839;5543.029969755276;5555.583331250173;5562.193481945095;5146.742662866842;5157.819476318311;5173.534381905646;5179.171332586768;5192.039472697563;6047.7278522466595;6081.939180608226;6095.451409373178;6099.817005489843;6102.0541816018585;5789.91315130265;5820.30156381237;5863.824085277449;6040.728167232397;6059.848503787441;5940.55445841555;5967.164596956516;5974.9103763444455;5986.461218490183;6006.759729610942;5834.27071616048;5838.474537291664;5841.269841269841;5842.38654941225;5846.269216347957;5807.912881306868;5813.157092221689;5858.326292476249;5923.170756094064;5937.050071988461;5746.166805813217;5762.596618236683;5769.79805706815;5787.189793429007;5806.2451881255165;5692.117721753135;5742;5753.108268218432;5764.308283006066;5765.423457654369;5503.944960550343;5581;5599.832005039855;5626.634268772516;5666.34836993751;5808.186853840551;5812.18629391877;5842.38654941225;5850.356460789395;5852.3269823969085;5681.289838770153;5707.343655479673;5707.571932105026;5710.543156547549;5713.371529131709 03:50:33 INFO - PROCESS | 29818 | |1;ext.html;589.9203607512984;635.3773302163877;639.2999665366424;639.6354078175439;652.6867103790183;31873.521897171533;34371.31257374851;44327.5567244327;45592.99999999992;45697.771511142484;46814.76592617041;47183.528164718344;47220.29169562451;47318;47338.76330618342;8366.330693544533;9048.683296084622;9179.770505737377;9189.356745027852;9192.954035229814;10649.627263045757;10906.727331816688;10910.454477276144;11273.718157046058;11276.943615281913;11111.333320000786;11203.60787372442;11209.327440353563;11214.943925280362;11219.775604487906;8503.48979061252;10764.892351076467;11042.779144417067;11067.833982490269;11100.278481898651;10479.318844275098;11073.557057717762;11093.889061109447;11102.61140860066;11114.333140011544;45352.3197152043;45493.090138197054;45780.08439831218;45873;45988.3101753474;3714.4799728038097;3760.7179461540495;3765.171662234304;3765.359888818907;3836.156045669948;34293;34336.656633433595;34749.826250868835;34752.82623586891;34962.12594685128;4520.186366454037;4585.518520555361;4620.19146649335;4638.1883170445035;4644.790984405709;374586;376069;379489;379665;380088.9999999972;38191.61808381881;39109.80445097813;60011.69994150088;60496;61072.08391874126;41893.79053104715;41949.79025104855;42100.368494472605;42121;42135.7893210532;15617.531474055797;15762.211889405484;15766.76349854753;15777.211139442981;15785;11676.299422034705;11923.344216068026;12562.434690438951;12824.102312838011;12837.550685725955;9327.626894924262;9344.01887801771;9363.672271470467;9394.577244024036;9430.292728045424;3476.8435420406145;3553.1650062235353;3566.2510872716502;3617.4212126059706;3647.6170002149925;1091.8635170603675;1096.1285777806663;1101.487808169189;1104.6023431564631;1165.6269993601966;32386;33373;33495.66504334974;33923.83038084794;33967;1198.6823491774687;1199.9340036297913;1238.139493052338;1243.4466662335356;1294.4563283420987;17185.7422138668;17518;17923.820761792216;17975.460736177934;17991.73012404815;555818;560232;561359;566055;566828;41615.1676966459;42340.3648945266;42380.15239695189;42489.78755106266;42491;1353.1745635162542;1414.0525847682077;1438.992805035968;1445.515752222996;1454.8690617844445;33015;33684.15789605279;34130.65869341275;34556.481652774724;34979.47530786989;53519.732401337744;54210.72894635502;54324;54333.185002225786;54335;418685;418838;419054;420016;420999;27307.815374769572;29699.703002969694;30801.229969250948;30939.84530077335;32611.34777304488;50254;51437.7428112857;51452.48547514477;51815.74092129515;52298.21552676789;42420.57579424166;42455;42834;43428.56571434371;43974;41993.58006419897;42130.578694212665;42187.78906105573;42703.78648106739;43199;42113.789431052646;42998.570014299454;43462;44142.33786493141;44225.77887110544;36750.44874326941;37733.81133094317;37908;38285.808570956964;38743;28475.43049139047;28895.42209155847;29107.417851642425;29115.417691645624;29404 03:50:33 INFO - PROCESS | 29818 | |2;jquery.html;417.8955261184704;424.3083773449279;425.67010566810717;428.3040059902659;442.94906085800125;18517.53706157345;18746;19338.806611933876;19387.418377448663;19404.90297548514;14696.824254059677;17375.47873563795;18619.627607447877;18996.62006759864;19748.90125549374;5589.161625756138;5638.830835074934;5783.306003279612;5837.445442682938;5849.327327357345;5672.234248376458;5687.4312568743;5693.743781529821;5717.571182161334;5774.249347584808;4189.329707246841;6048.092786082101;6316.210473690789;6316.778912738055;6409.2629347624925;6358.109864618957;6368.235811702579;6389.5527313088105;6408.166938298014;6486.2865084841105;5579.69311687857;5673.773049078032;5703.800366987136;5721.456461636138;5722.828315150552;22226.222082227043;22805;23272.06911723529;23553.41116472102;23676.289711308687;2354.81161507079;2364.5034542746043;2538.6065159900245;2558.2069558436756;2627.69781475129;13410.530631427951;14303;14547.854521454756;14796.852031479655;15031.473898413613;1981.9504512387161;1984.7221389005551;2030.8273796727296;2036.0939381975027;2094.413564202026;72801;75430.62284688596;77095.6145219276;80026.59986700087;84620.57689711574;11235.887641123647;11465.140114491447;11482.48328825205;11648.767024659459;11749.412529373669;16203.513894583182;16332.346706131859;16339.101349425895;16339.591510212102;16361.100139492204;7889.605519723991;7922.405819563441;7956.164602716747;7974.481658692166;8146.918530814734;7286.854262914712;7296.233895440902;7296.6716497757725;7380;7383.261673832574;4984.102861484967;5024.723640199824;5045.899082018339;5096.05722941257;5137.51193636604;2010.7587089549347;2053.4558342039372;2055.8149766520787;2064.741907261592;2086.5618220173933;973.2214228617078;1006.9697909062739;1009.8739905005865;1048.816457120001;1066.8933106689424;18956.241750330108;19098;19185.90407047984;19385.224591016482;19880;1024.9282550221562;1068.0120888178403;1088.7931293054294;1092.7213560542011;1111.7887601355717;10471.528781204865;10737.946310268399;10754.89245107539;10827.78344433107;11022.834657480144;179683;182255;377807;384004;512416;76355;86779.13220867711;86895;94544;100526;1067.4449286371043;1094.9288296260718;1107.6289443036512;1108.939008354532;1115.3976852499723;17129.743053853952;17391.826081739528;17395.826041739925;17430.738538921672;17526.82473175252;40558.39162412507;42114.789426052674;42438.78780606077;42542.361864572675;42681.57318426776;54202;54640.18039729487;58517.70741146438;59355.40644593499;60189;11870.287782733063;12811.295378753885;12973.156744811935;13396.93301533486;13418.261995589946;13262.33688315561;13432.865671343161;13906.930465348014;14327.928360358132;14487.20320382389;12128.878711212776;12151.513939442324;12215.511379544718;12315.815262770886;12425.19236249641;8541.87187192205;8933;8933.330000250136;9005.14451127142;12279.877201228232;8297.377696672895;8478.109798471318;8930.106989301017;8992;9132.08679132108;12761.55334563323;13146.145500542434;13181.340932953122;13218.867811322149;13304.933475332562;12473.438695258554;12637.684057898627;12800.295983720986;13082.934585327013;13090.80363794563 03:50:33 INFO - PROCESS | 29818 | |3;mootools.html;1381.1643955406971;1553.9456119035833;1590.173109982809;1757.376131473327;1868.504846215754;8911.509866957314;9313.860292095616;9333.346665733401;9690.85463718043;9703.757406064851;9440.339176257665;9603.759906002353;9611.23110151188;9631.855522167156;9650.083242092007;2466.4327204742876;2508.799296056311;2510.7112682041616;2511.849289042654;2512.949741005179;2408.614621660535;2422.9394265143337;2423.660687503751;2424.7454017328105;2425.733169351379;2382.213869423095;2394.8922298496523;2418.830681852271;2435.4641978764644;2440.5851005329137;2354.693889794316;2368.1948137633203;2398.520295940819;2400.075970751265;2429.477662302596;2391.1511413448147;2416.395901024744;2442.6213936839818;2449.09383528094;2450.914218002379;8219.219174178443;8880.777980550472;9492.240620750323;9571.138597526256;9581.137697607179;5427.348718153808;5624.5781566382275;5631.21163037171;5647.830565083054;5653.095504719226;3457.101153700056;3488.7034602058857;3538.4515400113023;3546.308469848381;3547.2018795771005;1148.488922429519;1189.1616410430627;1208.6313674329326;1218.9207701499374;1223.131576580629;13545.322733863268;13688.247146406944;13699.931500342534;13704.931475342659;13724.176549406968;4763;4870.0746858096845;4882;4964.826231081967;5063.5695965843315;11238.943805281086;11287.94356028231;11290.435478226056;11319.094472442184;11345.149113816497;5561.416051314634;5564.777408903679;5569.303837020372;5573.832785016456;5574.136008918624;5041.6722913010535;5141.640085194075;5235.240890070919;5240.973795131;5286.022085914118;4095.6313931746286;4127.872127872128;4159.022629682083;4179.728317659343;4185.372194170899;1301.6810881334134;1314.3428285857071;1316.8024796280442;1319.551352540141;1321.1742660836976;1019.4749703902496;1020.698893826323;1031.339942436841;1034.4155552113032;1035.140833108518;6246.4378205960775;6268.27914789805;6327.367263273636;6429.485641148697;6527.673616319165;478.44022493682473;482.43314105925396;483.98064077437215;485.0614061790447;488.6994498383469;4258.74447533149;4289.849855255051;4307.3754305626135;4308.784560771949;4320.891977700583;11496.655100347003;11815.704607384712;11880.940595296968;11899.821502677294;11918.106142039382;11702.2978621283;11763.235389699643;11774.587889423829;11793.587224447103;11834.940825295991;8385.748427547183;8703.564821758886;8723.956380218186;8770.429922055046;8902.376833621714;6233.501319894488;6334.271558770801;6412.551121421456;6430.485561155003;6442.677866106582;10676.733081673021;10851.457427128455;10934.94532527364;11056.834147487954;11069.5018724156;11154.609588664358;11255.437228138397;11328.773424531299;11372.203945724052;11568.710782230512;8457.196566326189;8525.95737021311;8595.484270943763;8597.656093756179;8598.355123365898;9016.188543030896;9027.864582031143;9100.089991001112;9280.071992800937;9295.488748118647;8312.376571757264;8335.041470231;8336.541490218096;8422.326213902996;8465.95767021161;8187.631556579849;8259.132791056853;8286.4199506034;8361.331093512626;8393.748187554384;7593.924060759322;7608.467407281659;7684;7687.923120768721;7691.961540192263;5260.421353651019;5339.3859706132735;5383.246345511553;5454.04554203005;5454.91817622728;4811.350467686958;5367.677939323653;5469.562435005269;5504.587155963399;5540.584456165723 03:50:33 INFO - PROCESS | 29818 | |4;prototype.html;342.99657003429957;346.5391029930193;350.62132896471815;352.39740044523865;359.6798849024368;5341.519263266306;5409.29679141712;5410.621256512046;5423.701696406692;5436.374816896058;5344.770702738372;5345.625806193559;5361.839144825652;5378.1663842104435;5393.460653934604;4182.268103081964;4250.426192464009;4257.74453532789;4261.913212130918;4267.658587313023;4221.556736542665;4239.724417912841;4243.8090285937205;4252.787955432702;4252.936205956913;4204.768737719424;4247.214265360918;4258.850940217093;4266.658667306623;4282.336237883118;4114.691398145151;4219.873403797891;4246.004377942393;4276.144771045788;4281.336392859112;3792.824224490389;3793.336166170909;3803.980980095082;3809.733318667694;3810.466534685146;5201.011807756514;5215;5254.31693879797;5268.28878101459;5275.498827611371;4609.308603709437;4833.984863178736;4947.431045429786;4955.677880937727;4969.7515124244;5585.2459917910965;5590.608657393984;5654.547636189095;5668.348139963916;5669.149627555858;4086.3257562502154;4091.774952377618;4094.529129150156;4113.568075352105;4128.422020917074;5811.27359080115;5824.737886795062;5860.589758716891;5920.615160014585;5975.492083172936;4147.543770185277;4164.729292595972;4171.812268447927;4172.894183041496;4181.540030596632;4209.768462734518;4234.534201237861;4234.894127646833;4235.851745188966;4238.597333253398;4692.296155576622;4841.830535931296;4846.055019271208;4860.465348811628;4886.780094895738;5673.716314184274;5680.494668912742;5706.258186435737;5720.713964301768;5774;1462.2615579132682;1473.521105640671;1473.7715654073636;1480.9037412568148;1484;916.7799728065349;929.8419268724333;939.8684184214216;947.4788866123605;949.4540639132526;4813;4851.660383773173;4854.611631069506;4885.8045678173185;4908.901821963541;5152.665076770073;5166.948330516647;5179.7928082877015;5187.887267639386;5231.398389185292;4553.200394630627;4846.5153484651955;4849.927251091236;4917.360743103445;4925.704457732476;2772.4039331543813;2776.5973933779487;2828.278788908815;2832.9716702832707;2835.3413253246667;5194.844154675366;5208.479152084761;5216.878371150221;5221.545873439477;5253.590619444272;5243.5318110929;5267.26258323835;5477.424870388551;5781.595288329777;6046.09308603713;5737.426257374229;5851.795187168514;5861.17943487912;5889.411058894077;5906.70466476683;5898.439648233411;5903.439173278532;5906.291245050621;5908.025175845937;5953.493953014043;5621.971890140523;5776.364599894092;5797.652140871562;5803.245578074992;5813.738381772746;5880.735366908585;5891.970540147272;5892.882142357214;5893.322267939242;5897.321807991964;4258.6380157686945;4260.297050986676;4268.338407546835;4286.249906266453;4303.462067241595;5622.791099913375;5817.592768506164;5831.4168583141345;5873.6534964127095;5893.145493903446;5714.971425142848;5717.828465146053;5733.426657334233;5757.740901659519;5837.562182836219;5597.572618982296;5734.741936612946;5785.913211301918;5787;5819;5613.063493095039;5620.791529821108;5638.37977822431;5672.971635141798;5673.262475878275;5737.655740655574;5743.856403589776;5760.683162425939;5795.217645617788;5820.738066787089;5417.160340147283;5673.787222982957;5689.345725241485;5703.173039909273;5703.458171473703 03:50:33 INFO - PROCESS | 29818 | |5;yui.html;807.3944541593801;810.0441479054713;856.3962406503416;891.9241864441522;918.2653876898479;16102.838971610281;16545.420910268127;16789.328426862943;16811.243494042767;16859.57851053724;15596.06423614584;15632.452864149756;15778.289976951037;15840.445584404548;15874.444394446196;701.9017337572744;823.1603764160552;853.9274161696263;861.6553378648559;864.7405778266526;836.958152092396;841.4110122913985;843.161054750521;846.2679781988567;846.6697987784769;903.5256490342557;904.5341649050744;904.5658084119626;906.0622255965078;906.1436942089728;745.8321877577556;862.5083702289697;891.1133422244843;894.7047474333486;896.7937374403858;659.2023651381834;660.2868901586276;660.8744338575704;661.7882277671147;662.5593980003292;15378.154201518912;15453.304601292968;15472.845271547252;15530.223488825626;15550.144742039183;14558.344874480674;14648.560543183721;14728.337224824909;14921.104733715903;15094.773578396333;13705.862941370558;13808.930955345259;14085.295735213198;14091;14187.78718319226;4689.531046895318;4698.882527936795;4766.904661906777;4784.569388754994;4881.34101896243;78927;79460;79695;82246;82395.58802206011;12508.562200322946;12601.432935517923;12725.745485090247;12827.935860320826;12979.610611681665;23040.53918921612;23098.191563295204;23170.7682923172;23176.53646927052;23179;8879.866801997976;9010.098990101069;9175.908240917506;9215.216706579882;9307.3019523536;4825.155597770447;4866.732329721899;5014.623903207274;5173.5602473789395;5300.761465734051;3770.1140232045445;3833.386658134685;3887.5723670396233;3893.2213557288655;3898.8830335089424;658.2167221006987;668.9966550167218;669.795712307741;671.4494114825796;680.8502129531495;660.7423104989058;674.4739103499278;747.4917056401699;767.5049593012587;778.1790211326991;10343.534540945675;10360.948195258976;10576.788464230825;10577.524011419504;10625.309354891908;703.057902410772;718.7232915327533;734.7024455095694;781.7576551269125;800.6437135474658;4920.901581968412;4923.704577725348;5059.696418214919;5102.33669622954;5126.410462796752;115647;115661;115955.42022289835;116633;122076.38961805134;97876;103398;103724;103786.48106759568;103940;87929;89563;89628.5518572403;89652.5517372409;91263.54368228116;9616.23070154372;9854.21166306708;9871.605135794774;9880.209583233467;9910.702678919644;53534.73232633812;53886.730566346916;55323.17015244694;55508.72245638746;56593.151102734315;68863.65568172127;69765.30234697588;76377;79585.20414795777;81482.59258703906;13711.520096796565;14240;14343.426262949366;14347.246692187757;14420.495282665057;11450.770984580427;14338.713225735635;15241.923790380977;15748.212589370256;16132.516024519284;12813.23120612729;15124.54626361211;15193.316300766272;15723.921380393025;16227.918860405622;14152.858471415155;14693;14727.682247997936;14801.703965920837;15115.470958516398;14677.339519721425;14900.552983410515;15016.324265407864;15271.770923435935;15573.143477108415;11137.383200733442;11723.706907327385;11731.824022639497;11855.17013809025;11949;12416.81374779397;12499.687507812378;12599.68500787451;12658.810117848056;12874 03:50:33 INFO - PROCESS | 29818 | __end_tp_report 03:50:33 INFO - PROCESS | 29818 | __start_cc_report 03:50:33 INFO - PROCESS | 29818 | _x_x_mozilla_cycle_collect,864 03:50:33 INFO - PROCESS | 29818 | __end_cc_report 03:50:33 INFO - PROCESS | 29818 | __startTimestamp1468147833840__endTimestamp 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | ------- Summary: start ------- 03:50:33 INFO - PROCESS | 29818 | Number of tests: 6 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | [#0] dojo.html Cycles:165 Average:5508.70 Median:5704.14 stddev:601.04 (10.5%) stddev-sans-first:577.98 03:50:33 INFO - PROCESS | 29818 | Values: 3325.9 3362.9 3367.1 3389.4 3410.5 5524.7 5583.8 5585.9 5586.7 5612.0 5604.2 5670.4 5677.1 5683.9 5687.7 4852.4 5060.0 5128.6 5143.0 5192.3 4894.7 4991.2 5023.5 5032.4 5035.5 5005.1 5006.5 5048.6 5070.6 5074.6 5157.5 5165.1 5171.3 5174.3 5206.0 4879.7 4902.8 4932.3 5053.6 5077.5 5318.2 5321.7 5360.9 5380.5 5394.2 5908.7 5956.1 5958.9 5961.2 5966.0 5865.8 5916.3 5924.5 5987.7 6003.1 5567.2 5608.7 5610.1 5614.9 5621.5 5983.1 6102.0 6103.9 6112.1 6116.1 5844.3 5893.3 5906.1 6000.1 6009.6 6035.2 6053.2 6065.3 6071.2 6103.5 5704.1 5822.0 6013.2 6041.6 6043.4 5859.7 5911.6 5916.6 5924.2 5950.4 4560.2 4560.3 4564.5 4565.2 4588.0 4013.9 4023.8 4047.0 4086.0 4124.9 5537.2 5560.0 5564.5 5564.9 5587.7 5898.1 5944.0 5945.2 5948.4 5971.7 5382.7 5531.4 5543.0 5555.6 5562.2 5146.7 5157.8 5173.5 5179.2 5192.0 6047.7 6081.9 6095.5 6099.8 6102.1 5789.9 5820.3 5863.8 6040.7 6059.8 5940.6 5967.2 5974.9 5986.5 6006.8 5834.3 5838.5 5841.3 5842.4 5846.3 5807.9 5813.2 5858.3 5923.2 5937.1 5746.2 5762.6 5769.8 5787.2 5806.2 5692.1 5742.0 5753.1 5764.3 5765.4 5503.9 5581.0 5599.8 5626.6 5666.3 5808.2 5812.2 5842.4 5850.4 5852.3 5681.3 5707.3 5707.6 5710.5 5713.4 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | [#1] ext.html Cycles:180 Average:60744.63 Median:379577.00 stddev:122073.91 (32.2%) stddev-sans-first:122332.81 03:50:33 INFO - PROCESS | 29818 | Values: 589.9 635.4 639.3 639.6 652.7 31873.5 34371.3 44327.6 45593.0 45697.8 46814.8 47183.5 47220.3 47318.0 47338.8 8366.3 9048.7 9179.8 9189.4 9193.0 10649.6 10906.7 10910.5 11273.7 11276.9 11111.3 11203.6 11209.3 11214.9 11219.8 8503.5 10764.9 11042.8 11067.8 11100.3 10479.3 11073.6 11093.9 11102.6 11114.3 45352.3 45493.1 45780.1 45873.0 45988.3 3714.5 3760.7 3765.2 3765.4 3836.2 34293.0 34336.7 34749.8 34752.8 34962.1 4520.2 4585.5 4620.2 4638.2 4644.8 374586.0 376069.0 379489.0 379665.0 380089.0 38191.6 39109.8 60011.7 60496.0 61072.1 41893.8 41949.8 42100.4 42121.0 42135.8 15617.5 15762.2 15766.8 15777.2 15785.0 11676.3 11923.3 12562.4 12824.1 12837.6 9327.6 9344.0 9363.7 9394.6 9430.3 3476.8 3553.2 3566.3 3617.4 3647.6 1091.9 1096.1 1101.5 1104.6 1165.6 32386.0 33373.0 33495.7 33923.8 33967.0 1198.7 1199.9 1238.1 1243.4 1294.5 17185.7 17518.0 17923.8 17975.5 17991.7 555818.0 560232.0 561359.0 566055.0 566828.0 41615.2 42340.4 42380.2 42489.8 42491.0 1353.2 1414.1 1439.0 1445.5 1454.9 33015.0 33684.2 34130.7 34556.5 34979.5 53519.7 54210.7 54324.0 54333.2 54335.0 418685.0 418838.0 419054.0 420016.0 420999.0 27307.8 29699.7 30801.2 30939.8 32611.3 50254.0 51437.7 51452.5 51815.7 52298.2 42420.6 42455.0 42834.0 43428.6 43974.0 41993.6 42130.6 42187.8 42703.8 43199.0 42113.8 42998.6 43462.0 44142.3 44225.8 36750.4 37733.8 37908.0 38285.8 38743.0 28475.4 28895.4 29107.4 29115.4 29404.0 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | [#2] jquery.html Cycles:180 Average:24629.75 Median:2075.65 stddev:59076.94 (2846.2%) stddev-sans-first:59214.69 03:50:33 INFO - PROCESS | 29818 | Values: 417.9 424.3 425.7 428.3 442.9 18517.5 18746.0 19338.8 19387.4 19404.9 14696.8 17375.5 18619.6 18996.6 19748.9 5589.2 5638.8 5783.3 5837.4 5849.3 5672.2 5687.4 5693.7 5717.6 5774.2 4189.3 6048.1 6316.2 6316.8 6409.3 6358.1 6368.2 6389.6 6408.2 6486.3 5579.7 5673.8 5703.8 5721.5 5722.8 22226.2 22805.0 23272.1 23553.4 23676.3 2354.8 2364.5 2538.6 2558.2 2627.7 13410.5 14303.0 14547.9 14796.9 15031.5 1982.0 1984.7 2030.8 2036.1 2094.4 72801.0 75430.6 77095.6 80026.6 84620.6 11235.9 11465.1 11482.5 11648.8 11749.4 16203.5 16332.3 16339.1 16339.6 16361.1 7889.6 7922.4 7956.2 7974.5 8146.9 7286.9 7296.2 7296.7 7380.0 7383.3 4984.1 5024.7 5045.9 5096.1 5137.5 2010.8 2053.5 2055.8 2064.7 2086.6 973.2 1007.0 1009.9 1048.8 1066.9 18956.2 19098.0 19185.9 19385.2 19880.0 1024.9 1068.0 1088.8 1092.7 1111.8 10471.5 10737.9 10754.9 10827.8 11022.8 179683.0 182255.0 377807.0 384004.0 512416.0 76355.0 86779.1 86895.0 94544.0 100526.0 1067.4 1094.9 1107.6 1108.9 1115.4 17129.7 17391.8 17395.8 17430.7 17526.8 40558.4 42114.8 42438.8 42542.4 42681.6 54202.0 54640.2 58517.7 59355.4 60189.0 11870.3 12811.3 12973.2 13396.9 13418.3 13262.3 13432.9 13906.9 14327.9 14487.2 12128.9 12151.5 12215.5 12315.8 12425.2 8541.9 8933.0 8933.3 9005.1 12279.9 8297.4 8478.1 8930.1 8992.0 9132.1 12761.6 13146.1 13181.3 13218.9 13304.9 12473.4 12637.7 12800.3 13082.9 13090.8 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | [#3] mootools.html Cycles:180 Average:6225.91 Median:2620.72 stddev:3645.37 (139.1%) stddev-sans-first:3637.41 03:50:33 INFO - PROCESS | 29818 | Values: 1381.2 1553.9 1590.2 1757.4 1868.5 8911.5 9313.9 9333.3 9690.9 9703.8 9440.3 9603.8 9611.2 9631.9 9650.1 2466.4 2508.8 2510.7 2511.8 2512.9 2408.6 2422.9 2423.7 2424.7 2425.7 2382.2 2394.9 2418.8 2435.5 2440.6 2354.7 2368.2 2398.5 2400.1 2429.5 2391.2 2416.4 2442.6 2449.1 2450.9 8219.2 8880.8 9492.2 9571.1 9581.1 5427.3 5624.6 5631.2 5647.8 5653.1 3457.1 3488.7 3538.5 3546.3 3547.2 1148.5 1189.2 1208.6 1218.9 1223.1 13545.3 13688.2 13699.9 13704.9 13724.2 4763.0 4870.1 4882.0 4964.8 5063.6 11238.9 11287.9 11290.4 11319.1 11345.1 5561.4 5564.8 5569.3 5573.8 5574.1 5041.7 5141.6 5235.2 5241.0 5286.0 4095.6 4127.9 4159.0 4179.7 4185.4 1301.7 1314.3 1316.8 1319.6 1321.2 1019.5 1020.7 1031.3 1034.4 1035.1 6246.4 6268.3 6327.4 6429.5 6527.7 478.4 482.4 484.0 485.1 488.7 4258.7 4289.8 4307.4 4308.8 4320.9 11496.7 11815.7 11880.9 11899.8 11918.1 11702.3 11763.2 11774.6 11793.6 11834.9 8385.7 8703.6 8724.0 8770.4 8902.4 6233.5 6334.3 6412.6 6430.5 6442.7 10676.7 10851.5 10934.9 11056.8 11069.5 11154.6 11255.4 11328.8 11372.2 11568.7 8457.2 8526.0 8595.5 8597.7 8598.4 9016.2 9027.9 9100.1 9280.1 9295.5 8312.4 8335.0 8336.5 8422.3 8466.0 8187.6 8259.1 8286.4 8361.3 8393.7 7593.9 7608.5 7684.0 7687.9 7692.0 5260.4 5339.4 5383.2 5454.0 5454.9 4811.4 5367.7 5469.6 5504.6 5540.6 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | [#4] prototype.html Cycles:180 Average:4707.26 Median:5237.47 stddev:1372.86 (26.2%) stddev-sans-first:1337.06 03:50:33 INFO - PROCESS | 29818 | Values: 343.0 346.5 350.6 352.4 359.7 5341.5 5409.3 5410.6 5423.7 5436.4 5344.8 5345.6 5361.8 5378.2 5393.5 4182.3 4250.4 4257.7 4261.9 4267.7 4221.6 4239.7 4243.8 4252.8 4252.9 4204.8 4247.2 4258.9 4266.7 4282.3 4114.7 4219.9 4246.0 4276.1 4281.3 3792.8 3793.3 3804.0 3809.7 3810.5 5201.0 5215.0 5254.3 5268.3 5275.5 4609.3 4834.0 4947.4 4955.7 4969.8 5585.2 5590.6 5654.5 5668.3 5669.1 4086.3 4091.8 4094.5 4113.6 4128.4 5811.3 5824.7 5860.6 5920.6 5975.5 4147.5 4164.7 4171.8 4172.9 4181.5 4209.8 4234.5 4234.9 4235.9 4238.6 4692.3 4841.8 4846.1 4860.5 4886.8 5673.7 5680.5 5706.3 5720.7 5774.0 1462.3 1473.5 1473.8 1480.9 1484.0 916.8 929.8 939.9 947.5 949.5 4813.0 4851.7 4854.6 4885.8 4908.9 5152.7 5166.9 5179.8 5187.9 5231.4 4553.2 4846.5 4849.9 4917.4 4925.7 2772.4 2776.6 2828.3 2833.0 2835.3 5194.8 5208.5 5216.9 5221.5 5253.6 5243.5 5267.3 5477.4 5781.6 6046.1 5737.4 5851.8 5861.2 5889.4 5906.7 5898.4 5903.4 5906.3 5908.0 5953.5 5622.0 5776.4 5797.7 5803.2 5813.7 5880.7 5892.0 5892.9 5893.3 5897.3 4258.6 4260.3 4268.3 4286.2 4303.5 5622.8 5817.6 5831.4 5873.7 5893.1 5715.0 5717.8 5733.4 5757.7 5837.6 5597.6 5734.7 5785.9 5787.0 5819.0 5613.1 5620.8 5638.4 5673.0 5673.3 5737.7 5743.9 5760.7 5795.2 5820.7 5417.2 5673.8 5689.3 5703.2 5703.5 03:50:33 INFO - PROCESS | 29818 | 03:50:33 INFO - PROCESS | 29818 | [#5] yui.html Cycles:180 Average:21823.50 Median:4732.89 stddev:30810.78 (651.0%) stddev-sans-first:30856.80 03:50:33 INFO - PROCESS | 29818 | Values: 807.4 810.0 856.4 891.9 918.3 16102.8 16545.4 16789.3 16811.2 16859.6 15596.1 15632.5 15778.3 15840.4 15874.4 701.9 823.2 853.9 861.7 864.7 837.0 841.4 843.2 846.3 846.7 903.5 904.5 904.6 906.1 906.1 745.8 862.5 891.1 894.7 896.8 659.2 660.3 660.9 661.8 662.6 15378.2 15453.3 15472.8 15530.2 15550.1 14558.3 14648.6 14728.3 14921.1 15094.8 13705.9 13808.9 14085.3 14091.0 14187.8 4689.5 4698.9 4766.9 4784.6 4881.3 78927.0 79460.0 79695.0 82246.0 82395.6 12508.6 12601.4 12725.7 12827.9 12979.6 23040.5 23098.2 23170.8 23176.5 23179.0 8879.9 9010.1 9175.9 9215.2 9307.3 4825.2 4866.7 5014.6 5173.6 5300.8 3770.1 3833.4 3887.6 3893.2 3898.9 658.2 669.0 669.8 671.4 680.9 660.7 674.5 747.5 767.5 778.2 10343.5 10360.9 10576.8 10577.5 10625.3 703.1 718.7 734.7 781.8 800.6 4920.9 4923.7 5059.7 5102.3 5126.4 115647.0 115661.0 115955.4 116633.0 122076.4 97876.0 103398.0 103724.0 103786.5 103940.0 87929.0 89563.0 89628.6 89652.6 91263.5 9616.2 9854.2 9871.6 9880.2 9910.7 53534.7 53886.7 55323.2 55508.7 56593.2 68863.7 69765.3 76377.0 79585.2 81482.6 13711.5 14240.0 14343.4 14347.2 14420.5 11450.8 14338.7 15241.9 15748.2 16132.5 12813.2 15124.5 15193.3 15723.9 16227.9 14152.9 14693.0 14727.7 14801.7 15115.5 14677.3 14900.6 15016.3 15271.8 15573.1 11137.4 11723.7 11731.8 11855.2 11949.0 12416.8 12499.7 12599.7 12658.8 12874.0 03:50:33 INFO - PROCESS | 29818 | -------- Summary: end -------- 03:50:33 INFO - PROCESS | 29818 | 03:50:34 INFO - TEST-INFO | 29818: exit 0 03:50:34 INFO - TEST-OK | dromaeo_css | took 1112396ms 03:50:34 INFO - TEST-START | kraken 03:50:34 INFO - operating with platform_type : linux_ 03:50:34 INFO - Initialising browser for kraken test... 03:50:34 INFO - TEST-INFO | started process 30009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNhAEyL/profile http://localhost:35751/getInfo.html) 03:50:38 INFO - PROCESS | 30009 | __metrics Screen width/height:1600/1200 03:50:38 INFO - PROCESS | 30009 | colorDepth:24 03:50:38 INFO - PROCESS | 30009 | Browser inner width/height: 1024/697 03:50:38 INFO - PROCESS | 30009 | __metrics 03:50:39 ERROR - PROCESS | 30009 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:50:40 INFO - TEST-INFO | 30009: exit 0 03:50:40 INFO - Browser initialized. 03:50:40 INFO - Running cycle 1/1 for kraken test... 03:50:40 INFO - TEST-INFO | started process 30104 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNhAEyL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:52 INFO - PROCESS | 30104 | RSS: Main: 144584704 03:50:52 INFO - PROCESS | 30104 | 03:50:54 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35751/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:55 INFO - PROCESS | 30104 | RSS: Main: 194469888 03:50:55 INFO - PROCESS | 30104 | 03:50:58 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35751/tests/kraken/driver.html?testName=audio-dft) 03:50:58 INFO - PROCESS | 30104 | RSS: Main: 193839104 03:50:58 INFO - PROCESS | 30104 | 03:51:01 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35751/tests/kraken/driver.html?testName=audio-fft) 03:51:02 INFO - PROCESS | 30104 | RSS: Main: 278880256 03:51:02 INFO - PROCESS | 30104 | 03:51:04 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35751/tests/kraken/driver.html?testName=audio-oscillator) 03:51:04 INFO - PROCESS | 30104 | RSS: Main: 187449344 03:51:04 INFO - PROCESS | 30104 | 03:51:07 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:51:07 INFO - PROCESS | 30104 | RSS: Main: 188465152 03:51:07 INFO - PROCESS | 30104 | 03:51:10 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35751/tests/kraken/driver.html?testName=imaging-darkroom) 03:51:11 INFO - PROCESS | 30104 | RSS: Main: 223232000 03:51:11 INFO - PROCESS | 30104 | 03:51:14 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35751/tests/kraken/driver.html?testName=imaging-desaturate) 03:51:15 INFO - PROCESS | 30104 | RSS: Main: 221147136 03:51:15 INFO - PROCESS | 30104 | 03:51:17 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35751/tests/kraken/driver.html?testName=json-parse-financial) 03:51:18 INFO - PROCESS | 30104 | RSS: Main: 221319168 03:51:18 INFO - PROCESS | 30104 | 03:51:19 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:51:20 INFO - PROCESS | 30104 | RSS: Main: 199696384 03:51:20 INFO - PROCESS | 30104 | 03:51:22 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:51:22 INFO - PROCESS | 30104 | RSS: Main: 200237056 03:51:22 INFO - PROCESS | 30104 | 03:51:24 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:51:25 INFO - PROCESS | 30104 | RSS: Main: 208760832 03:51:25 INFO - PROCESS | 30104 | 03:51:28 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:28 INFO - PROCESS | 30104 | RSS: Main: 216358912 03:51:28 INFO - PROCESS | 30104 | 03:51:31 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:31 INFO - PROCESS | 30104 | RSS: Main: 214798336 03:51:31 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | Cycle 1(1): loaded http://localhost:35751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35751/tests/kraken/driver.html?testName=ai-astar) 03:51:33 INFO - PROCESS | 30104 | RSS: Main: 257859584 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | __start_tp_report 03:51:33 INFO - PROCESS | 30104 | _x_x_mozilla_page_load 03:51:33 INFO - PROCESS | 30104 | _x_x_mozilla_page_load_details 03:51:33 INFO - PROCESS | 30104 | |i|pagename|runs| 03:51:33 INFO - PROCESS | 30104 | |0;ai-astar;112;106;111;110;111;111;111;112;112;111 03:51:33 INFO - PROCESS | 30104 | |1;audio-beat-detection;151;127;125;171;128;124;156;128;195;129 03:51:33 INFO - PROCESS | 30104 | |2;audio-dft;159;162;159;158;161;159;160;160;160;159 03:51:33 INFO - PROCESS | 30104 | |3;audio-fft;73;75;74;135;76;75;75;76;99;74 03:51:33 INFO - PROCESS | 30104 | |4;audio-oscillator;86;84;119;84;84;84;118;86;84;120 03:51:33 INFO - PROCESS | 30104 | |5;imaging-gaussian-blur;118;118;117;117;116;116;116;116;118;116 03:51:33 INFO - PROCESS | 30104 | |6;imaging-darkroom;146;146;146;146;147;146;146;148;146;146 03:51:33 INFO - PROCESS | 30104 | |7;imaging-desaturate;94;95;96;95;95;95;96;95;95;96 03:51:33 INFO - PROCESS | 30104 | |8;json-parse-financial;49;50;49;50;50;51;58;52;52;50 03:51:33 INFO - PROCESS | 30104 | |9;json-stringify-tinderbox;62;59;60;61;61;60;60;59;60;60 03:51:33 INFO - PROCESS | 30104 | |10;stanford-crypto-aes;75;82;75;83;77;76;83;76;102;76 03:51:33 INFO - PROCESS | 30104 | |11;stanford-crypto-ccm;128;122;123;129;119;127;118;130;130;128 03:51:33 INFO - PROCESS | 30104 | |12;stanford-crypto-pbkdf2;154;156;158;162;154;152;154;153;154;153 03:51:33 INFO - PROCESS | 30104 | |13;stanford-crypto-sha256-iterative;61;61;62;62;61;62;63;63;60;60 03:51:33 INFO - PROCESS | 30104 | __end_tp_report 03:51:33 INFO - PROCESS | 30104 | __start_cc_report 03:51:33 INFO - PROCESS | 30104 | _x_x_mozilla_cycle_collect,1558 03:51:33 INFO - PROCESS | 30104 | __end_cc_report 03:51:33 INFO - PROCESS | 30104 | __startTimestamp1468147893795__endTimestamp 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | ------- Summary: start ------- 03:51:33 INFO - PROCESS | 30104 | Number of tests: 14 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.77 (1.6%) stddev-sans-first:1.81 03:51:33 INFO - PROCESS | 30104 | Values: 112.0 106.0 111.0 110.0 111.0 111.0 111.0 112.0 112.0 111.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:140.00 stddev:24.28 (17.3%) stddev-sans-first:25.60 03:51:33 INFO - PROCESS | 30104 | Values: 151.0 127.0 125.0 171.0 128.0 124.0 156.0 128.0 195.0 129.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 03:51:33 INFO - PROCESS | 30104 | Values: 159.0 162.0 159.0 158.0 161.0 159.0 160.0 160.0 160.0 159.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:19.75 (26.3%) stddev-sans-first:20.60 03:51:33 INFO - PROCESS | 30104 | Values: 73.0 75.0 74.0 135.0 76.0 75.0 75.0 76.0 99.0 74.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:16.66 (19.8%) stddev-sans-first:17.35 03:51:33 INFO - PROCESS | 30104 | Values: 86.0 84.0 119.0 84.0 84.0 84.0 118.0 86.0 84.0 120.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 03:51:33 INFO - PROCESS | 30104 | Values: 118.0 118.0 117.0 117.0 116.0 116.0 116.0 116.0 118.0 116.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 03:51:33 INFO - PROCESS | 30104 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 148.0 146.0 146.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 03:51:33 INFO - PROCESS | 30104 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:50.50 stddev:2.64 (5.2%) stddev-sans-first:2.69 03:51:33 INFO - PROCESS | 30104 | Values: 49.0 50.0 49.0 50.0 50.0 51.0 58.0 52.0 52.0 50.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.92 (1.5%) stddev-sans-first:0.71 03:51:33 INFO - PROCESS | 30104 | Values: 62.0 59.0 60.0 61.0 61.0 60.0 60.0 59.0 60.0 60.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:76.50 stddev:8.24 (10.8%) stddev-sans-first:8.49 03:51:33 INFO - PROCESS | 30104 | Values: 75.0 82.0 75.0 83.0 77.0 76.0 83.0 76.0 102.0 76.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:128.00 stddev:4.53 (3.5%) stddev-sans-first:4.70 03:51:33 INFO - PROCESS | 30104 | Values: 128.0 122.0 123.0 129.0 119.0 127.0 118.0 130.0 130.0 128.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:154.00 stddev:2.98 (1.9%) stddev-sans-first:3.14 03:51:33 INFO - PROCESS | 30104 | Values: 154.0 156.0 158.0 162.0 154.0 152.0 154.0 153.0 154.0 153.0 03:51:33 INFO - PROCESS | 30104 | 03:51:33 INFO - PROCESS | 30104 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:62.00 stddev:1.08 (1.7%) stddev-sans-first:1.13 03:51:33 INFO - PROCESS | 30104 | Values: 61.0 61.0 62.0 62.0 61.0 62.0 63.0 63.0 60.0 60.0 03:51:33 INFO - PROCESS | 30104 | -------- Summary: end -------- 03:51:33 INFO - PROCESS | 30104 | 03:51:34 INFO - TEST-INFO | 30104: exit 0 03:51:34 INFO - TEST-OK | kraken | took 60214ms 03:51:34 INFO - SUITE-END | took 1172s 03:51:34 INFO - Completed test suite (00:19:32) 03:51:34 INFO - javascript benchmark 03:51:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.8503367348467, 3362.8654853805865, 3367.0572239772855, 3389.4407422775244, 3410.522526846242, 5524.723763811809, 5583.832485025446, 5585.888282234363, 5586.692731899744, 5612.045952188128, 5604.243427137335, 5670.376258611549, 5677.063284558043, 5683.886322273552, 5687.7156142192825, 4852.393450818648, 5060.0132974070075, 5128.640995130342, 5143.048536020848, 5192.324997750287, 4894.730789806559, 4991.151504244269, 5023.547880690737, 5032.421271553763, 5035.471275516073, 5005.1491246488, 5006.524380183877, 5048.62135339851, 5070.594352451795, 5074.644774865761, 5157.5358217760395, 5165.147750621143, 5171.2501687255135, 5174.301469301671, 5206.010857936999, 4879.731614761186, 4902.754862256908, 4932.260160975847, 5053.646244762868, 5077.543021128116, 5318.202269659543, 5321.680699158062, 5360.919586206171, 5380.542653874425, 5394.244805727201, 5908.734106965197, 5956.106584012389, 5958.910616340759, 5961.195238642771, 5966.0, 5865.794697185578, 5916.319623243296, 5924.526037916957, 5987.670678112702, 6003.129546215774, 5567.220589117527, 5608.663480191201, 5610.074337734269, 5614.859628509279, 5621.465960733764, 5983.072623743326, 6101.962666346732, 6103.938960610426, 6112.147208752953, 6116.113163591343, 5844.26946631671, 5893.322267939242, 5906.143609176645, 6000.129981152796, 6009.639421634716, 6035.155078289043, 6053.1929175555015, 6065.332813390523, 6071.150038994456, 6103.511719062464, 5704.1443783432815, 5822.039363504974, 6013.248343957005, 6041.577089603686, 6043.395660434009, 5859.736311865976, 5911.586188966731, 5916.556258280646, 5924.229850119457, 5950.4049595041015, 4560.156371071363, 4560.293154561048, 4564.52072532386, 4565.178267911808, 4587.990642058741, 4013.8996525087105, 4023.7786921719585, 4047.0287131088326, 4085.9785053736564, 4124.876253712393, 5537.169424586345, 5559.972200138974, 5564.4713752193475, 5564.916526252109, 5587.664740115606, 5898.14476900847, 5944.019236825961, 5945.227120474311, 5948.405159484017, 5971.671558064349, 5382.703951282639, 5531.419200983839, 5543.029969755276, 5555.583331250173, 5562.193481945095, 5146.742662866842, 5157.819476318311, 5173.534381905646, 5179.171332586768, 5192.039472697563, 6047.7278522466595, 6081.939180608226, 6095.451409373178, 6099.817005489843, 6102.0541816018585, 5789.91315130265, 5820.30156381237, 5863.824085277449, 6040.728167232397, 6059.848503787441, 5940.55445841555, 5967.164596956516, 5974.9103763444455, 5986.461218490183, 6006.759729610942, 5834.27071616048, 5838.474537291664, 5841.269841269841, 5842.38654941225, 5846.269216347957, 5807.912881306868, 5813.157092221689, 5858.326292476249, 5923.170756094064, 5937.050071988461, 5746.166805813217, 5762.596618236683, 5769.79805706815, 5787.189793429007, 5806.2451881255165, 5692.117721753135, 5742.0, 5753.108268218432, 5764.308283006066, 5765.423457654369, 5503.944960550343, 5581.0, 5599.832005039855, 5626.634268772516, 5666.34836993751, 5808.186853840551, 5812.18629391877, 5842.38654941225, 5850.356460789395, 5852.3269823969085, 5681.289838770153, 5707.343655479673, 5707.571932105026, 5710.543156547549, 5713.371529131709], "value": 5470.493646306897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9203607512984, 635.3773302163877, 639.2999665366424, 639.6354078175439, 652.6867103790183, 31873.521897171533, 34371.31257374851, 44327.5567244327, 45592.99999999992, 45697.771511142484, 46814.76592617041, 47183.528164718344, 47220.29169562451, 47318.0, 47338.76330618342, 8366.330693544533, 9048.683296084622, 9179.770505737377, 9189.356745027852, 9192.954035229814, 10649.627263045757, 10906.727331816688, 10910.454477276144, 11273.718157046058, 11276.943615281913, 11111.333320000786, 11203.60787372442, 11209.327440353563, 11214.943925280362, 11219.775604487906, 8503.48979061252, 10764.892351076467, 11042.779144417067, 11067.833982490269, 11100.278481898651, 10479.318844275098, 11073.557057717762, 11093.889061109447, 11102.61140860066, 11114.333140011544, 45352.3197152043, 45493.090138197054, 45780.08439831218, 45873.0, 45988.3101753474, 3714.4799728038097, 3760.7179461540495, 3765.171662234304, 3765.359888818907, 3836.156045669948, 34293.0, 34336.656633433595, 34749.826250868835, 34752.82623586891, 34962.12594685128, 4520.186366454037, 4585.518520555361, 4620.19146649335, 4638.1883170445035, 4644.790984405709, 374586.0, 376069.0, 379489.0, 379665.0, 380088.9999999972, 38191.61808381881, 39109.80445097813, 60011.69994150088, 60496.0, 61072.08391874126, 41893.79053104715, 41949.79025104855, 42100.368494472605, 42121.0, 42135.7893210532, 15617.531474055797, 15762.211889405484, 15766.76349854753, 15777.211139442981, 15785.0, 11676.299422034705, 11923.344216068026, 12562.434690438951, 12824.102312838011, 12837.550685725955, 9327.626894924262, 9344.01887801771, 9363.672271470467, 9394.577244024036, 9430.292728045424, 3476.8435420406145, 3553.1650062235353, 3566.2510872716502, 3617.4212126059706, 3647.6170002149925, 1091.8635170603675, 1096.1285777806663, 1101.487808169189, 1104.6023431564631, 1165.6269993601966, 32386.0, 33373.0, 33495.66504334974, 33923.83038084794, 33967.0, 1198.6823491774687, 1199.9340036297913, 1238.139493052338, 1243.4466662335356, 1294.4563283420987, 17185.7422138668, 17518.0, 17923.820761792216, 17975.460736177934, 17991.73012404815, 555818.0, 560232.0, 561359.0, 566055.0, 566828.0, 41615.1676966459, 42340.3648945266, 42380.15239695189, 42489.78755106266, 42491.0, 1353.1745635162542, 1414.0525847682077, 1438.992805035968, 1445.515752222996, 1454.8690617844445, 33015.0, 33684.15789605279, 34130.65869341275, 34556.481652774724, 34979.47530786989, 53519.732401337744, 54210.72894635502, 54324.0, 54333.185002225786, 54335.0, 418685.0, 418838.0, 419054.0, 420016.0, 420999.0, 27307.815374769572, 29699.703002969694, 30801.229969250948, 30939.84530077335, 32611.34777304488, 50254.0, 51437.7428112857, 51452.48547514477, 51815.74092129515, 52298.21552676789, 42420.57579424166, 42455.0, 42834.0, 43428.56571434371, 43974.0, 41993.58006419897, 42130.578694212665, 42187.78906105573, 42703.78648106739, 43199.0, 42113.789431052646, 42998.570014299454, 43462.0, 44142.33786493141, 44225.77887110544, 36750.44874326941, 37733.81133094317, 37908.0, 38285.808570956964, 38743.0, 28475.43049139047, 28895.42209155847, 29107.417851642425, 29115.417691645624, 29404.0], "value": 19971.59452854611, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.8955261184704, 424.3083773449279, 425.67010566810717, 428.3040059902659, 442.94906085800125, 18517.53706157345, 18746.0, 19338.806611933876, 19387.418377448663, 19404.90297548514, 14696.824254059677, 17375.47873563795, 18619.627607447877, 18996.62006759864, 19748.90125549374, 5589.161625756138, 5638.830835074934, 5783.306003279612, 5837.445442682938, 5849.327327357345, 5672.234248376458, 5687.4312568743, 5693.743781529821, 5717.571182161334, 5774.249347584808, 4189.329707246841, 6048.092786082101, 6316.210473690789, 6316.778912738055, 6409.2629347624925, 6358.109864618957, 6368.235811702579, 6389.5527313088105, 6408.166938298014, 6486.2865084841105, 5579.69311687857, 5673.773049078032, 5703.800366987136, 5721.456461636138, 5722.828315150552, 22226.222082227043, 22805.0, 23272.06911723529, 23553.41116472102, 23676.289711308687, 2354.81161507079, 2364.5034542746043, 2538.6065159900245, 2558.2069558436756, 2627.69781475129, 13410.530631427951, 14303.0, 14547.854521454756, 14796.852031479655, 15031.473898413613, 1981.9504512387161, 1984.7221389005551, 2030.8273796727296, 2036.0939381975027, 2094.413564202026, 72801.0, 75430.62284688596, 77095.6145219276, 80026.59986700087, 84620.57689711574, 11235.887641123647, 11465.140114491447, 11482.48328825205, 11648.767024659459, 11749.412529373669, 16203.513894583182, 16332.346706131859, 16339.101349425895, 16339.591510212102, 16361.100139492204, 7889.605519723991, 7922.405819563441, 7956.164602716747, 7974.481658692166, 8146.918530814734, 7286.854262914712, 7296.233895440902, 7296.6716497757725, 7380.0, 7383.261673832574, 4984.102861484967, 5024.723640199824, 5045.899082018339, 5096.05722941257, 5137.51193636604, 2010.7587089549347, 2053.4558342039372, 2055.8149766520787, 2064.741907261592, 2086.5618220173933, 973.2214228617078, 1006.9697909062739, 1009.8739905005865, 1048.816457120001, 1066.8933106689424, 18956.241750330108, 19098.0, 19185.90407047984, 19385.224591016482, 19880.0, 1024.9282550221562, 1068.0120888178403, 1088.7931293054294, 1092.7213560542011, 1111.7887601355717, 10471.528781204865, 10737.946310268399, 10754.89245107539, 10827.78344433107, 11022.834657480144, 179683.0, 182255.0, 377807.0, 384004.0, 512416.0, 76355.0, 86779.13220867711, 86895.0, 94544.0, 100526.0, 1067.4449286371043, 1094.9288296260718, 1107.6289443036512, 1108.939008354532, 1115.3976852499723, 17129.743053853952, 17391.826081739528, 17395.826041739925, 17430.738538921672, 17526.82473175252, 40558.39162412507, 42114.789426052674, 42438.78780606077, 42542.361864572675, 42681.57318426776, 54202.0, 54640.18039729487, 58517.70741146438, 59355.40644593499, 60189.0, 11870.287782733063, 12811.295378753885, 12973.156744811935, 13396.93301533486, 13418.261995589946, 13262.33688315561, 13432.865671343161, 13906.930465348014, 14327.928360358132, 14487.20320382389, 12128.878711212776, 12151.513939442324, 12215.511379544718, 12315.815262770886, 12425.19236249641, 8541.87187192205, 8933.0, 8933.330000250136, 9005.14451127142, 12279.877201228232, 8297.377696672895, 8478.109798471318, 8930.106989301017, 8992.0, 9132.08679132108, 12761.55334563323, 13146.145500542434, 13181.340932953122, 13218.867811322149, 13304.933475332562, 12473.438695258554, 12637.684057898627, 12800.295983720986, 13082.934585327013, 13090.80363794563], "value": 9477.474222862438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.1643955406971, 1553.9456119035833, 1590.173109982809, 1757.376131473327, 1868.504846215754, 8911.509866957314, 9313.860292095616, 9333.346665733401, 9690.85463718043, 9703.757406064851, 9440.339176257665, 9603.759906002353, 9611.23110151188, 9631.855522167156, 9650.083242092007, 2466.4327204742876, 2508.799296056311, 2510.7112682041616, 2511.849289042654, 2512.949741005179, 2408.614621660535, 2422.9394265143337, 2423.660687503751, 2424.7454017328105, 2425.733169351379, 2382.213869423095, 2394.8922298496523, 2418.830681852271, 2435.4641978764644, 2440.5851005329137, 2354.693889794316, 2368.1948137633203, 2398.520295940819, 2400.075970751265, 2429.477662302596, 2391.1511413448147, 2416.395901024744, 2442.6213936839818, 2449.09383528094, 2450.914218002379, 8219.219174178443, 8880.777980550472, 9492.240620750323, 9571.138597526256, 9581.137697607179, 5427.348718153808, 5624.5781566382275, 5631.21163037171, 5647.830565083054, 5653.095504719226, 3457.101153700056, 3488.7034602058857, 3538.4515400113023, 3546.308469848381, 3547.2018795771005, 1148.488922429519, 1189.1616410430627, 1208.6313674329326, 1218.9207701499374, 1223.131576580629, 13545.322733863268, 13688.247146406944, 13699.931500342534, 13704.931475342659, 13724.176549406968, 4763.0, 4870.0746858096845, 4882.0, 4964.826231081967, 5063.5695965843315, 11238.943805281086, 11287.94356028231, 11290.435478226056, 11319.094472442184, 11345.149113816497, 5561.416051314634, 5564.777408903679, 5569.303837020372, 5573.832785016456, 5574.136008918624, 5041.6722913010535, 5141.640085194075, 5235.240890070919, 5240.973795131, 5286.022085914118, 4095.6313931746286, 4127.872127872128, 4159.022629682083, 4179.728317659343, 4185.372194170899, 1301.6810881334134, 1314.3428285857071, 1316.8024796280442, 1319.551352540141, 1321.1742660836976, 1019.4749703902496, 1020.698893826323, 1031.339942436841, 1034.4155552113032, 1035.140833108518, 6246.4378205960775, 6268.27914789805, 6327.367263273636, 6429.485641148697, 6527.673616319165, 478.44022493682473, 482.43314105925396, 483.98064077437215, 485.0614061790447, 488.6994498383469, 4258.74447533149, 4289.849855255051, 4307.3754305626135, 4308.784560771949, 4320.891977700583, 11496.655100347003, 11815.704607384712, 11880.940595296968, 11899.821502677294, 11918.106142039382, 11702.2978621283, 11763.235389699643, 11774.587889423829, 11793.587224447103, 11834.940825295991, 8385.748427547183, 8703.564821758886, 8723.956380218186, 8770.429922055046, 8902.376833621714, 6233.501319894488, 6334.271558770801, 6412.551121421456, 6430.485561155003, 6442.677866106582, 10676.733081673021, 10851.457427128455, 10934.94532527364, 11056.834147487954, 11069.5018724156, 11154.609588664358, 11255.437228138397, 11328.773424531299, 11372.203945724052, 11568.710782230512, 8457.196566326189, 8525.95737021311, 8595.484270943763, 8597.656093756179, 8598.355123365898, 9016.188543030896, 9027.864582031143, 9100.089991001112, 9280.071992800937, 9295.488748118647, 8312.376571757264, 8335.041470231, 8336.541490218096, 8422.326213902996, 8465.95767021161, 8187.631556579849, 8259.132791056853, 8286.4199506034, 8361.331093512626, 8393.748187554384, 7593.924060759322, 7608.467407281659, 7684.0, 7687.923120768721, 7691.961540192263, 5260.421353651019, 5339.3859706132735, 5383.246345511553, 5454.04554203005, 5454.91817622728, 4811.350467686958, 5367.677939323653, 5469.562435005269, 5504.587155963399, 5540.584456165723], "value": 4853.513970505583, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.99657003429957, 346.5391029930193, 350.62132896471815, 352.39740044523865, 359.6798849024368, 5341.519263266306, 5409.29679141712, 5410.621256512046, 5423.701696406692, 5436.374816896058, 5344.770702738372, 5345.625806193559, 5361.839144825652, 5378.1663842104435, 5393.460653934604, 4182.268103081964, 4250.426192464009, 4257.74453532789, 4261.913212130918, 4267.658587313023, 4221.556736542665, 4239.724417912841, 4243.8090285937205, 4252.787955432702, 4252.936205956913, 4204.768737719424, 4247.214265360918, 4258.850940217093, 4266.658667306623, 4282.336237883118, 4114.691398145151, 4219.873403797891, 4246.004377942393, 4276.144771045788, 4281.336392859112, 3792.824224490389, 3793.336166170909, 3803.980980095082, 3809.733318667694, 3810.466534685146, 5201.011807756514, 5215.0, 5254.31693879797, 5268.28878101459, 5275.498827611371, 4609.308603709437, 4833.984863178736, 4947.431045429786, 4955.677880937727, 4969.7515124244, 5585.2459917910965, 5590.608657393984, 5654.547636189095, 5668.348139963916, 5669.149627555858, 4086.3257562502154, 4091.774952377618, 4094.529129150156, 4113.568075352105, 4128.422020917074, 5811.27359080115, 5824.737886795062, 5860.589758716891, 5920.615160014585, 5975.492083172936, 4147.543770185277, 4164.729292595972, 4171.812268447927, 4172.894183041496, 4181.540030596632, 4209.768462734518, 4234.534201237861, 4234.894127646833, 4235.851745188966, 4238.597333253398, 4692.296155576622, 4841.830535931296, 4846.055019271208, 4860.465348811628, 4886.780094895738, 5673.716314184274, 5680.494668912742, 5706.258186435737, 5720.713964301768, 5774.0, 1462.2615579132682, 1473.521105640671, 1473.7715654073636, 1480.9037412568148, 1484.0, 916.7799728065349, 929.8419268724333, 939.8684184214216, 947.4788866123605, 949.4540639132526, 4813.0, 4851.660383773173, 4854.611631069506, 4885.8045678173185, 4908.901821963541, 5152.665076770073, 5166.948330516647, 5179.7928082877015, 5187.887267639386, 5231.398389185292, 4553.200394630627, 4846.5153484651955, 4849.927251091236, 4917.360743103445, 4925.704457732476, 2772.4039331543813, 2776.5973933779487, 2828.278788908815, 2832.9716702832707, 2835.3413253246667, 5194.844154675366, 5208.479152084761, 5216.878371150221, 5221.545873439477, 5253.590619444272, 5243.5318110929, 5267.26258323835, 5477.424870388551, 5781.595288329777, 6046.09308603713, 5737.426257374229, 5851.795187168514, 5861.17943487912, 5889.411058894077, 5906.70466476683, 5898.439648233411, 5903.439173278532, 5906.291245050621, 5908.025175845937, 5953.493953014043, 5621.971890140523, 5776.364599894092, 5797.652140871562, 5803.245578074992, 5813.738381772746, 5880.735366908585, 5891.970540147272, 5892.882142357214, 5893.322267939242, 5897.321807991964, 4258.6380157686945, 4260.297050986676, 4268.338407546835, 4286.249906266453, 4303.462067241595, 5622.791099913375, 5817.592768506164, 5831.4168583141345, 5873.6534964127095, 5893.145493903446, 5714.971425142848, 5717.828465146053, 5733.426657334233, 5757.740901659519, 5837.562182836219, 5597.572618982296, 5734.741936612946, 5785.913211301918, 5787.0, 5819.0, 5613.063493095039, 5620.791529821108, 5638.37977822431, 5672.971635141798, 5673.262475878275, 5737.655740655574, 5743.856403589776, 5760.683162425939, 5795.217645617788, 5820.738066787089, 5417.160340147283, 5673.787222982957, 5689.345725241485, 5703.173039909273, 5703.458171473703], "value": 4273.598956960739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.3944541593801, 810.0441479054713, 856.3962406503416, 891.9241864441522, 918.2653876898479, 16102.838971610281, 16545.420910268127, 16789.328426862943, 16811.243494042767, 16859.57851053724, 15596.06423614584, 15632.452864149756, 15778.289976951037, 15840.445584404548, 15874.444394446196, 701.9017337572744, 823.1603764160552, 853.9274161696263, 861.6553378648559, 864.7405778266526, 836.958152092396, 841.4110122913985, 843.161054750521, 846.2679781988567, 846.6697987784769, 903.5256490342557, 904.5341649050744, 904.5658084119626, 906.0622255965078, 906.1436942089728, 745.8321877577556, 862.5083702289697, 891.1133422244843, 894.7047474333486, 896.7937374403858, 659.2023651381834, 660.2868901586276, 660.8744338575704, 661.7882277671147, 662.5593980003292, 15378.154201518912, 15453.304601292968, 15472.845271547252, 15530.223488825626, 15550.144742039183, 14558.344874480674, 14648.560543183721, 14728.337224824909, 14921.104733715903, 15094.773578396333, 13705.862941370558, 13808.930955345259, 14085.295735213198, 14091.0, 14187.78718319226, 4689.531046895318, 4698.882527936795, 4766.904661906777, 4784.569388754994, 4881.34101896243, 78927.0, 79460.0, 79695.0, 82246.0, 82395.58802206011, 12508.562200322946, 12601.432935517923, 12725.745485090247, 12827.935860320826, 12979.610611681665, 23040.53918921612, 23098.191563295204, 23170.7682923172, 23176.53646927052, 23179.0, 8879.866801997976, 9010.098990101069, 9175.908240917506, 9215.216706579882, 9307.3019523536, 4825.155597770447, 4866.732329721899, 5014.623903207274, 5173.5602473789395, 5300.761465734051, 3770.1140232045445, 3833.386658134685, 3887.5723670396233, 3893.2213557288655, 3898.8830335089424, 658.2167221006987, 668.9966550167218, 669.795712307741, 671.4494114825796, 680.8502129531495, 660.7423104989058, 674.4739103499278, 747.4917056401699, 767.5049593012587, 778.1790211326991, 10343.534540945675, 10360.948195258976, 10576.788464230825, 10577.524011419504, 10625.309354891908, 703.057902410772, 718.7232915327533, 734.7024455095694, 781.7576551269125, 800.6437135474658, 4920.901581968412, 4923.704577725348, 5059.696418214919, 5102.33669622954, 5126.410462796752, 115647.0, 115661.0, 115955.42022289835, 116633.0, 122076.38961805134, 97876.0, 103398.0, 103724.0, 103786.48106759568, 103940.0, 87929.0, 89563.0, 89628.5518572403, 89652.5517372409, 91263.54368228116, 9616.23070154372, 9854.21166306708, 9871.605135794774, 9880.209583233467, 9910.702678919644, 53534.73232633812, 53886.730566346916, 55323.17015244694, 55508.72245638746, 56593.151102734315, 68863.65568172127, 69765.30234697588, 76377.0, 79585.20414795777, 81482.59258703906, 13711.520096796565, 14240.0, 14343.426262949366, 14347.246692187757, 14420.495282665057, 11450.770984580427, 14338.713225735635, 15241.923790380977, 15748.212589370256, 16132.516024519284, 12813.23120612729, 15124.54626361211, 15193.316300766272, 15723.921380393025, 16227.918860405622, 14152.858471415155, 14693.0, 14727.682247997936, 14801.703965920837, 15115.470958516398, 14677.339519721425, 14900.552983410515, 15016.324265407864, 15271.770923435935, 15573.143477108415, 11137.383200733442, 11723.706907327385, 11731.824022639497, 11855.17013809025, 11949.0, 12416.81374779397, 12499.687507812378, 12599.68500787451, 12658.810117848056, 12874.0], "value": 8067.41854520678, "unit": "score"}], "name": "dromaeo_css", "value": 7466.663292377135, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 110.0, 111.0, 111.0, 111.0, 112.0, 112.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 125.0, 171.0, 128.0, 124.0, 156.0, 128.0, 195.0, 129.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 159.0, 158.0, 161.0, 159.0, 160.0, 160.0, 160.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 135.0, 76.0, 75.0, 75.0, 76.0, 99.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 119.0, 84.0, 84.0, 84.0, 118.0, 86.0, 84.0, 120.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 118.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 148.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 50.0, 50.0, 51.0, 58.0, 52.0, 52.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 59.0, 60.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 82.0, 75.0, 83.0, 77.0, 76.0, 83.0, 76.0, 102.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 122.0, 123.0, 129.0, 119.0, 127.0, 118.0, 130.0, 130.0, 128.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 158.0, 162.0, 154.0, 152.0, 154.0, 153.0, 154.0, 153.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 61.0, 62.0, 63.0, 63.0, 60.0, 60.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1483.9, "alertThreshold": 2.0}]} 03:51:35 INFO - Return code: 0 03:51:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:35 ERROR - # TBPL SUCCESS # 03:51:35 INFO - Running post-action listener: _resource_record_post_action 03:51:35 INFO - ##### 03:51:35 INFO - ##### Finished run-tests step (success) 03:51:35 INFO - ##### 03:51:35 INFO - Running post-run listener: _resource_record_post_run 03:51:35 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 303104; Write bytes: 505696256; Read time: 372; Write time: 430220 03:51:35 INFO - TinderboxPrint: CPU usage
13.1% 03:51:35 INFO - TinderboxPrint: I/O read bytes / time
303,104 / 372 03:51:35 INFO - TinderboxPrint: I/O write bytes / time
505,696,256 / 430,220 03:51:35 INFO - TinderboxPrint: CPU idle
8,255.7 (86.9%) 03:51:35 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 03:51:35 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 252600320; Read time: 108; Write time: 251580 03:51:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 274432; Write bytes: 253095936; Read time: 248; Write time: 178640 03:51:35 INFO - Running post-run listener: _upload_blobber_files 03:51:35 INFO - Blob upload gear active. 03:51:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:35 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:35 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:35 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:36 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:37 INFO - (blobuploader) - INFO - Done attempting. 03:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:37 INFO - (blobuploader) - INFO - Done attempting. 03:51:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:40 INFO - (blobuploader) - INFO - Done attempting. 03:51:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:40 INFO - Return code: 0 03:51:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa2e861cbdbc685d8eedcb4f7e21756562146d6e05f27d0c684aade66a0277ff17894f31caf00e7f264fe4e75255ad882eafc6e35d9c12ff9050e32b9c5a3f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bd9434e1db4a86b5d6c1db14583c2af0f1862aa934e92ed4437f9e658aecb9e47949de17027e274fd397b5f22f37f09698d9f09c6d6892a00ce51b6b1340dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e7576793a024a64a38f9f69ae531c81dc29f370d99593ae6c93b5ddc9a0ba873484dd1a4adc2b3d9a2f69b17a3a61bbe170992ff1817f6ec2fed0c112083a4"} 03:51:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:40 INFO - Contents: 03:51:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa2e861cbdbc685d8eedcb4f7e21756562146d6e05f27d0c684aade66a0277ff17894f31caf00e7f264fe4e75255ad882eafc6e35d9c12ff9050e32b9c5a3f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bd9434e1db4a86b5d6c1db14583c2af0f1862aa934e92ed4437f9e658aecb9e47949de17027e274fd397b5f22f37f09698d9f09c6d6892a00ce51b6b1340dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e7576793a024a64a38f9f69ae531c81dc29f370d99593ae6c93b5ddc9a0ba873484dd1a4adc2b3d9a2f69b17a3a61bbe170992ff1817f6ec2fed0c112083a4"} 03:51:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:40 INFO - Copying logs to upload dir... 03:51:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.107176 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-10 03:51:40.209254) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:40.213057) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa2e861cbdbc685d8eedcb4f7e21756562146d6e05f27d0c684aade66a0277ff17894f31caf00e7f264fe4e75255ad882eafc6e35d9c12ff9050e32b9c5a3f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bd9434e1db4a86b5d6c1db14583c2af0f1862aa934e92ed4437f9e658aecb9e47949de17027e274fd397b5f22f37f09698d9f09c6d6892a00ce51b6b1340dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e7576793a024a64a38f9f69ae531c81dc29f370d99593ae6c93b5ddc9a0ba873484dd1a4adc2b3d9a2f69b17a3a61bbe170992ff1817f6ec2fed0c112083a4"} 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.011221 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fa2e861cbdbc685d8eedcb4f7e21756562146d6e05f27d0c684aade66a0277ff17894f31caf00e7f264fe4e75255ad882eafc6e35d9c12ff9050e32b9c5a3f76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8bd9434e1db4a86b5d6c1db14583c2af0f1862aa934e92ed4437f9e658aecb9e47949de17027e274fd397b5f22f37f09698d9f09c6d6892a00ce51b6b1340dda", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69e7576793a024a64a38f9f69ae531c81dc29f370d99593ae6c93b5ddc9a0ba873484dd1a4adc2b3d9a2f69b17a3a61bbe170992ff1817f6ec2fed0c112083a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:40.238119) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:40.238438) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1468145790.401110-1187223526 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-10 03:51:40.323663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 03:51:40.323991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-10 03:51:40.324318) ========= ========= Total master_lag: 0.18 =========