builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1467418627.0 results: success (0) buildid: 20160701144421 builduid: 92ac3509565449fbb29d98a47390a1f6 revision: 4bae0c26ac7116579c5a4ee0e4cd945c2094939a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.011051) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.011579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.011862) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.060840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.061260) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 17:17:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.2M=0s 2016-07-01 17:17:07 (51.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141907 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.239839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.240171) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.133208 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:07.385955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 17:17:07.386318) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4bae0c26ac7116579c5a4ee0e4cd945c2094939a --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 4bae0c26ac7116579c5a4ee0e4cd945c2094939a --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=8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 17:17:07,456 truncating revision to first 12 chars 2016-07-01 17:17:07,456 Setting DEBUG logging. 2016-07-01 17:17:07,456 attempt 1/10 2016-07-01 17:17:07,456 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4bae0c26ac71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 17:17:08,269 unpacking tar archive at: mozilla-aurora-4bae0c26ac71/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238781 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 17:17:08.647684) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:08.647973) ========= script_repo_revision: 4bae0c26ac7116579c5a4ee0e4cd945c2094939a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:08.648351) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:08.648621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 17:17:08.682597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-01 17:17:08.682899) ========= /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=8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:08 INFO - MultiFileLogger online at 20160701 17:17:08 in /builds/slave/test 17:17:08 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 17:17:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:08 INFO - {'append_to_log': False, 17:17:08 INFO - 'base_work_dir': '/builds/slave/test', 17:17:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:17:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:08 INFO - 'branch': 'Mozilla-Aurora', 17:17:08 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:08 INFO - 'config_files': ('talos/linux_config.py',), 17:17:08 INFO - 'default_actions': ('clobber', 17:17:08 INFO - 'read-buildbot-config', 17:17:08 INFO - 'download-and-extract', 17:17:08 INFO - 'populate-webroot', 17:17:08 INFO - 'create-virtualenv', 17:17:08 INFO - 'install', 17:17:08 INFO - 'run-tests'), 17:17:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:08 INFO - 'download_minidump_stackwalk': True, 17:17:08 INFO - 'download_symbols': 'ondemand', 17:17:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:08 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:08 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:08 INFO - 'installer_path': 'installer.exe', 17:17:08 INFO - 'log_level': 'info', 17:17:08 INFO - 'log_name': 'talos', 17:17:08 INFO - 'log_to_console': True, 17:17:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:08 INFO - 'opt_config_files': (), 17:17:08 INFO - 'pip_index': False, 17:17:08 INFO - 'sps_profile': False, 17:17:08 INFO - 'sps_profile_interval': 0, 17:17:08 INFO - 'suite': 'dromaeojs', 17:17:08 INFO - 'system_bits': '32', 17:17:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:08 INFO - 'title': 'talos-linux64-ix-001', 17:17:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:08 INFO - 'use_talos_json': True, 17:17:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:08 INFO - 'work_dir': 'build'} 17:17:08 INFO - ##### 17:17:08 INFO - ##### Running clobber step. 17:17:08 INFO - ##### 17:17:08 INFO - Running pre-action listener: _resource_record_pre_action 17:17:08 INFO - Running main action method: clobber 17:17:08 INFO - rmtree: /builds/slave/test/build 17:17:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:10 INFO - Running post-action listener: _resource_record_post_action 17:17:10 INFO - ##### 17:17:10 INFO - ##### Finished clobber step (success) 17:17:10 INFO - ##### 17:17:10 INFO - ##### 17:17:10 INFO - ##### Running read-buildbot-config step. 17:17:10 INFO - ##### 17:17:10 INFO - Running pre-action listener: _resource_record_pre_action 17:17:10 INFO - Running main action method: read_buildbot_config 17:17:10 INFO - Using buildbot properties: 17:17:10 INFO - { 17:17:10 INFO - "project": "", 17:17:10 INFO - "product": "firefox", 17:17:10 INFO - "script_repo_revision": "production", 17:17:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:17:10 INFO - "repository": "", 17:17:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:17:10 INFO - "buildid": "20160701144421", 17:17:10 INFO - "pgo_build": "True", 17:17:10 INFO - "basedir": "/builds/slave/test", 17:17:10 INFO - "buildnumber": 400, 17:17:10 INFO - "slavename": "talos-linux64-ix-001", 17:17:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:17:10 INFO - "platform": "ubuntu64_hw", 17:17:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 17:17:10 INFO - "branch": "mozilla-aurora", 17:17:10 INFO - "repo_path": "releases/mozilla-aurora", 17:17:10 INFO - "revision": "4bae0c26ac7116579c5a4ee0e4cd945c2094939a", 17:17:10 INFO - "stage_platform": "linux64-pgo", 17:17:10 INFO - "builduid": "92ac3509565449fbb29d98a47390a1f6", 17:17:10 INFO - "slavebuilddir": "test" 17:17:10 INFO - } 17:17:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 17:17:10 INFO - Running post-action listener: _resource_record_post_action 17:17:10 INFO - ##### 17:17:10 INFO - ##### Finished read-buildbot-config step (success) 17:17:10 INFO - ##### 17:17:10 INFO - ##### 17:17:10 INFO - ##### Running download-and-extract step. 17:17:10 INFO - ##### 17:17:10 INFO - Running pre-action listener: _resource_record_pre_action 17:17:10 INFO - Running main action method: download_and_extract 17:17:10 INFO - mkdir: /builds/slave/test/build/tests 17:17:10 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')]} 17:17:10 INFO - https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:17:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:17:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:17:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:11 INFO - Downloaded 1361 bytes. 17:17:11 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 17:17:11 INFO - Using the following test package requirements: 17:17:11 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:17:11 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:11 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 17:17:11 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'jsshell-linux-x86_64.zip'], 17:17:11 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:11 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 17:17:11 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 17:17:11 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 17:17:11 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:11 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 17:17:11 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:11 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17: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')]} 17:17:11 INFO - https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:13 INFO - Downloaded 24526530 bytes. 17:17:13 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'] 17:17:13 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 17:17:14 INFO - Return code: 0 17:17:14 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 17:17:14 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')]} 17:17:14 INFO - https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:17:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:17:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 17:17:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:15 INFO - Downloaded 24526530 bytes. 17:17:15 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'] 17:17:15 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 17:17:17 INFO - Return code: 0 17:17: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')]} 17:17:17 INFO - https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 17:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:18 INFO - Downloaded 10833369 bytes. 17:17:18 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'] 17:17:18 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 17:17:18 INFO - Return code: 0 17:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:18 INFO - https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VS8i01DMRmqN43O9WPwsJQ/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 17:17:20 INFO - Downloaded 63626705 bytes. 17:17:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:17:20 INFO - mkdir: /builds/slave/test/properties 17:17:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:20 INFO - Contents: 17:17:20 INFO - build_url:https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 17:17:21 INFO - Running post-action listener: _resource_record_post_action 17:17:21 INFO - Running post-action listener: set_extra_try_arguments 17:17:21 INFO - ##### 17:17:21 INFO - ##### Finished download-and-extract step (success) 17:17:21 INFO - ##### 17:17:21 INFO - ##### 17:17:21 INFO - ##### Running populate-webroot step. 17:17:21 INFO - ##### 17:17:21 INFO - Running pre-action listener: _resource_record_pre_action 17:17:21 INFO - Running main action method: populate_webroot 17:17:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:21 INFO - '--tppagecycles', 17:17:21 INFO - '7'], 17:17:21 INFO - 'tests': ['tsvgm']}}, 17:17:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['damp', 'tps']}, 17:17:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'tests': ['damp', 'tps']}, 17:17:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['dromaeo_dom']}, 17:17:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['a11yr', 17:17:21 INFO - 'ts_paint', 17:17:21 INFO - 'tpaint', 17:17:21 INFO - 'sessionrestore', 17:17:21 INFO - 'sessionrestore_no_auto_restore', 17:17:21 INFO - 'tabpaint']}, 17:17:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:21 INFO - 'ts_paint', 17:17:21 INFO - 'tpaint', 17:17:21 INFO - 'sessionrestore', 17:17:21 INFO - 'sessionrestore_no_auto_restore', 17:17:21 INFO - 'tabpaint']}, 17:17:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:21 INFO - 'ts_paint', 17:17:21 INFO - 'tpaint', 17:17:21 INFO - 'sessionrestore', 17:17:21 INFO - 'sessionrestore_no_auto_restore', 17:17:21 INFO - 'tabpaint']}, 17:17:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:21 INFO - 'ts_paint', 17:17:21 INFO - 'tpaint', 17:17:21 INFO - 'sessionrestore', 17:17:21 INFO - 'sessionrestore_no_auto_restore', 17:17:21 INFO - 'tabpaint']}, 17:17:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['a11yr', 17:17:21 INFO - 'ts_paint', 17:17:21 INFO - 'tpaint', 17:17:21 INFO - 'sessionrestore', 17:17:21 INFO - 'sessionrestore_no_auto_restore', 17:17:21 INFO - 'tabpaint']}, 17:17:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['a11yr', 17:17:21 INFO - 'ts_paint', 17:17:21 INFO - 'tpaint', 17:17:21 INFO - 'sessionrestore', 17:17:21 INFO - 'sessionrestore_no_auto_restore', 17:17:21 INFO - 'tabpaint']}, 17:17:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['tsvgx', 17:17:21 INFO - 'tsvgr_opacity', 17:17:21 INFO - 'tart', 17:17:21 INFO - 'tscrollx', 17:17:21 INFO - 'cart']}, 17:17:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:21 INFO - 'tsvgr_opacity', 17:17:21 INFO - 'tart', 17:17:21 INFO - 'tscrollx', 17:17:21 INFO - 'cart']}, 17:17:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'talos_options': ['--disable-e10s'], 17:17:21 INFO - 'tests': ['tp5o']}, 17:17:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'tests': ['tp5o']}, 17:17:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'talos_options': ['--disable-e10s', 17:17:21 INFO - '--xperf_path', 17:17:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:21 INFO - 'tests': ['tp5n']}, 17:17:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:21 INFO - 'talos_options': ['--xperf_path', 17:17:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:21 INFO - 'tests': ['tp5n']}}, 17:17:21 INFO - 'talos.zip': {'path': '', 17:17:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:21 INFO - Running post-action listener: _resource_record_post_action 17:17:21 INFO - ##### 17:17:21 INFO - ##### Finished populate-webroot step (success) 17:17:21 INFO - ##### 17:17:21 INFO - ##### 17:17:21 INFO - ##### Running create-virtualenv step. 17:17:21 INFO - ##### 17:17:21 INFO - Running pre-action listener: _resource_record_pre_action 17:17:21 INFO - Running main action method: create_virtualenv 17:17:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:21 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 17:17:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:21 INFO - Using real prefix '/usr' 17:17:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:25 INFO - Installing pip.................done. 17:17:25 INFO - Return code: 0 17:17:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17: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', 'pip>=1.5'] in /builds/slave/test/build 17:17: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 pip>=1.5 17:17:25 INFO - Using env: {'DISPLAY': ':0', 17:17:25 INFO - 'HOME': '/home/cltbld', 17:17:25 INFO - 'LANG': 'en_US.UTF-8', 17:17:25 INFO - 'LANGUAGE': 'en_US:en', 17:17:25 INFO - 'LOGNAME': 'cltbld', 17:17:25 INFO - 'MAIL': '/var/mail/cltbld', 17:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:25 INFO - 'MOZ_NO_REMOTE': '1', 17:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:25 INFO - 'NO_EM_RESTART': '1', 17:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:25 INFO - 'PWD': '/builds/slave/test', 17:17:25 INFO - 'SHELL': '/bin/bash', 17:17:25 INFO - 'SHLVL': '1', 17:17:25 INFO - 'TERM': 'linux', 17:17:25 INFO - 'TMOUT': '86400', 17:17:25 INFO - 'USER': 'cltbld', 17:17:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:25 INFO - '_': '/tools/buildbot/bin/python'} 17:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:25 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 17:17:25 INFO - Cleaning up... 17:17:25 INFO - Return code: 0 17:17:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', '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 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:17: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 psutil>=3.1.1 17:17:25 INFO - Using env: {'DISPLAY': ':0', 17:17:25 INFO - 'HOME': '/home/cltbld', 17:17:25 INFO - 'LANG': 'en_US.UTF-8', 17:17:25 INFO - 'LANGUAGE': 'en_US:en', 17:17:25 INFO - 'LOGNAME': 'cltbld', 17:17:25 INFO - 'MAIL': '/var/mail/cltbld', 17:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:25 INFO - 'MOZ_NO_REMOTE': '1', 17:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:25 INFO - 'NO_EM_RESTART': '1', 17:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:25 INFO - 'PWD': '/builds/slave/test', 17:17:25 INFO - 'SHELL': '/bin/bash', 17:17:25 INFO - 'SHLVL': '1', 17:17:25 INFO - 'TERM': 'linux', 17:17:25 INFO - 'TMOUT': '86400', 17:17:25 INFO - 'USER': 'cltbld', 17:17:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:25 INFO - '_': '/tools/buildbot/bin/python'} 17:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:26 INFO - Downloading/unpacking psutil>=3.1.1 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:28 INFO - Installing collected packages: psutil 17:17:28 INFO - Running setup.py install for psutil 17:17:28 INFO - building 'psutil._psutil_linux' extension 17:17:28 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 17:17:29 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 17:17:29 INFO - building 'psutil._psutil_posix' extension 17:17:29 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 17:17:29 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 17:17:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:29 INFO - Successfully installed psutil 17:17:29 INFO - Cleaning up... 17:17:29 INFO - Return code: 0 17:17:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:29 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 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:29 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 17:17:29 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 17:17:29 INFO - Using env: {'DISPLAY': ':0', 17:17:29 INFO - 'HOME': '/home/cltbld', 17:17:29 INFO - 'LANG': 'en_US.UTF-8', 17:17:29 INFO - 'LANGUAGE': 'en_US:en', 17:17:29 INFO - 'LOGNAME': 'cltbld', 17:17:29 INFO - 'MAIL': '/var/mail/cltbld', 17:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:29 INFO - 'MOZ_NO_REMOTE': '1', 17:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:29 INFO - 'NO_EM_RESTART': '1', 17:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:29 INFO - 'PWD': '/builds/slave/test', 17:17:29 INFO - 'SHELL': '/bin/bash', 17:17:29 INFO - 'SHLVL': '1', 17:17:29 INFO - 'TERM': 'linux', 17:17:29 INFO - 'TMOUT': '86400', 17:17:29 INFO - 'USER': 'cltbld', 17:17:29 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:29 INFO - '_': '/tools/buildbot/bin/python'} 17:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:17:31 INFO - Installing collected packages: mozsystemmonitor 17:17:31 INFO - Running setup.py install for mozsystemmonitor 17:17:31 INFO - Successfully installed mozsystemmonitor 17:17:31 INFO - Cleaning up... 17:17:32 INFO - Return code: 0 17:17:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:32 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 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:32 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 17:17:32 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 17:17:32 INFO - Using env: {'DISPLAY': ':0', 17:17:32 INFO - 'HOME': '/home/cltbld', 17:17:32 INFO - 'LANG': 'en_US.UTF-8', 17:17:32 INFO - 'LANGUAGE': 'en_US:en', 17:17:32 INFO - 'LOGNAME': 'cltbld', 17:17:32 INFO - 'MAIL': '/var/mail/cltbld', 17:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:32 INFO - 'MOZ_NO_REMOTE': '1', 17:17:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:32 INFO - 'NO_EM_RESTART': '1', 17:17:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:32 INFO - 'PWD': '/builds/slave/test', 17:17:32 INFO - 'SHELL': '/bin/bash', 17:17:32 INFO - 'SHLVL': '1', 17:17:32 INFO - 'TERM': 'linux', 17:17:32 INFO - 'TMOUT': '86400', 17:17:32 INFO - 'USER': 'cltbld', 17:17:32 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:32 INFO - '_': '/tools/buildbot/bin/python'} 17:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:32 INFO - Downloading/unpacking jsonschema==2.5.1 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:34 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:34 INFO - warning: no files found matching '*.txt' 17:17:34 INFO - no previously-included directories found matching 'build' 17:17:34 INFO - no previously-included directories found matching 'dist' 17:17:34 INFO - no previously-included directories found matching '.git*' 17:17:34 INFO - Installing collected packages: jsonschema, functools32 17:17:34 INFO - Running setup.py install for functools32 17:17:34 INFO - warning: no files found matching '*.txt' 17:17:34 INFO - no previously-included directories found matching 'build' 17:17:34 INFO - no previously-included directories found matching 'dist' 17:17:34 INFO - no previously-included directories found matching '.git*' 17:17:34 INFO - Successfully installed jsonschema functools32 17:17:34 INFO - Cleaning up... 17:17:34 INFO - Return code: 0 17:17:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:34 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 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:34 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 17:17:34 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 17:17:34 INFO - Using env: {'DISPLAY': ':0', 17:17:34 INFO - 'HOME': '/home/cltbld', 17:17:34 INFO - 'LANG': 'en_US.UTF-8', 17:17:34 INFO - 'LANGUAGE': 'en_US:en', 17:17:34 INFO - 'LOGNAME': 'cltbld', 17:17:34 INFO - 'MAIL': '/var/mail/cltbld', 17:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:34 INFO - 'MOZ_NO_REMOTE': '1', 17:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:34 INFO - 'NO_EM_RESTART': '1', 17:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:34 INFO - 'PWD': '/builds/slave/test', 17:17:34 INFO - 'SHELL': '/bin/bash', 17:17:34 INFO - 'SHLVL': '1', 17:17:34 INFO - 'TERM': 'linux', 17:17:34 INFO - 'TMOUT': '86400', 17:17:34 INFO - 'USER': 'cltbld', 17:17:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:34 INFO - '_': '/tools/buildbot/bin/python'} 17:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:36 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 17:17:36 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 17:17:36 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 17:17:36 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 17:17:36 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 17:17:36 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 17:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:37 INFO - Downloading docopt-0.6.1.tar.gz 17:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:37 INFO - Running setup.py install for blobuploader 17:17:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:37 INFO - Running setup.py install for requests 17:17:37 INFO - Running setup.py install for docopt 17:17:38 INFO - Successfully installed blobuploader requests docopt 17:17:38 INFO - Cleaning up... 17:17:38 INFO - Return code: 0 17:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:38 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')]} 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:38 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')]} 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:38 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 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:38 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 17:17:38 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 17:17:38 INFO - Using env: {'DISPLAY': ':0', 17:17:38 INFO - 'HOME': '/home/cltbld', 17:17:38 INFO - 'LANG': 'en_US.UTF-8', 17:17:38 INFO - 'LANGUAGE': 'en_US:en', 17:17:38 INFO - 'LOGNAME': 'cltbld', 17:17:38 INFO - 'MAIL': '/var/mail/cltbld', 17:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:38 INFO - 'MOZ_NO_REMOTE': '1', 17:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:38 INFO - 'NO_EM_RESTART': '1', 17:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:38 INFO - 'PWD': '/builds/slave/test', 17:17:38 INFO - 'SHELL': '/bin/bash', 17:17:38 INFO - 'SHLVL': '1', 17:17:38 INFO - 'TERM': 'linux', 17:17:38 INFO - 'TMOUT': '86400', 17:17:38 INFO - 'USER': 'cltbld', 17:17:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:38 INFO - '_': '/tools/buildbot/bin/python'} 17:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:38 INFO - Running setup.py (path:/tmp/pip-WmHvN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:38 INFO - Running setup.py (path:/tmp/pip-6RDTwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:38 INFO - Running setup.py (path:/tmp/pip-SJ9mYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:38 INFO - Running setup.py (path:/tmp/pip-uCjphe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:38 INFO - Running setup.py (path:/tmp/pip-OSJgu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:38 INFO - Running setup.py (path:/tmp/pip-SPg2Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:38 INFO - Running setup.py (path:/tmp/pip-MA83oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:38 INFO - Running setup.py (path:/tmp/pip-_UstE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:38 INFO - Running setup.py (path:/tmp/pip-04YCBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:38 INFO - Running setup.py (path:/tmp/pip-IHXlLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:39 INFO - Running setup.py (path:/tmp/pip-iFCC8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:39 INFO - Running setup.py (path:/tmp/pip-5OX1QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:39 INFO - Running setup.py (path:/tmp/pip-vrFTfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:39 INFO - Running setup.py (path:/tmp/pip-bKWuWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:39 INFO - Running setup.py (path:/tmp/pip-Y3bLZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:39 INFO - Running setup.py (path:/tmp/pip-pwqHfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:39 INFO - Running setup.py (path:/tmp/pip-lLUNHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:39 INFO - Running setup.py install for manifestparser 17:17:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:39 INFO - Running setup.py install for mozcrash 17:17:39 INFO - Running setup.py install for mozdebug 17:17:39 INFO - Running setup.py install for mozdevice 17:17:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:39 INFO - Running setup.py install for mozfile 17:17:40 INFO - Running setup.py install for mozhttpd 17:17:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Running setup.py install for mozinfo 17:17:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Running setup.py install for mozInstall 17:17:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Running setup.py install for mozleak 17:17:40 INFO - Running setup.py install for mozlog 17:17:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Running setup.py install for moznetwork 17:17:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Running setup.py install for mozprocess 17:17:40 INFO - Running setup.py install for mozprofile 17:17:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Running setup.py install for mozrunner 17:17:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozscreenshot 17:17:41 INFO - Running setup.py install for moztest 17:17:41 INFO - Running setup.py install for mozversion 17:17:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:41 INFO - Cleaning up... 17:17:41 INFO - Return code: 0 17:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:41 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 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:41 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 17:17:41 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 17:17:41 INFO - Using env: {'DISPLAY': ':0', 17:17:41 INFO - 'HOME': '/home/cltbld', 17:17:41 INFO - 'LANG': 'en_US.UTF-8', 17:17:41 INFO - 'LANGUAGE': 'en_US:en', 17:17:41 INFO - 'LOGNAME': 'cltbld', 17:17:41 INFO - 'MAIL': '/var/mail/cltbld', 17:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:41 INFO - 'MOZ_NO_REMOTE': '1', 17:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:41 INFO - 'NO_EM_RESTART': '1', 17:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:41 INFO - 'PWD': '/builds/slave/test', 17:17:41 INFO - 'SHELL': '/bin/bash', 17:17:41 INFO - 'SHLVL': '1', 17:17:41 INFO - 'TERM': 'linux', 17:17:41 INFO - 'TMOUT': '86400', 17:17:41 INFO - 'USER': 'cltbld', 17:17:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:41 INFO - '_': '/tools/buildbot/bin/python'} 17:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:41 INFO - Running setup.py (path:/tmp/pip-YSAoQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:41 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)) 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:41 INFO - Running setup.py (path:/tmp/pip-3r9BPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:41 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)) 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:41 INFO - Running setup.py (path:/tmp/pip-ZS0O1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:41 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)) 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:41 INFO - Running setup.py (path:/tmp/pip-Vmav8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:41 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)) 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:41 INFO - Running setup.py (path:/tmp/pip-gezp6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:41 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)) 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:41 INFO - Running setup.py (path:/tmp/pip-O4PWuD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:41 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)) 17:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:41 INFO - Running setup.py (path:/tmp/pip-rWa5W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:42 INFO - Running setup.py (path:/tmp/pip-UPo50z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:42 INFO - Running setup.py (path:/tmp/pip-jPbZyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:42 INFO - Running setup.py (path:/tmp/pip-11OQ7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:42 INFO - Running setup.py (path:/tmp/pip-Vrm7GB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:42 INFO - Running setup.py (path:/tmp/pip-opgi2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:42 INFO - Running setup.py (path:/tmp/pip-G4LP8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:42 INFO - Running setup.py (path:/tmp/pip-dEBawf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:42 INFO - Running setup.py (path:/tmp/pip-1Y0E0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:42 INFO - Running setup.py (path:/tmp/pip-VwVMzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:42 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)) 17:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:42 INFO - Running setup.py (path:/tmp/pip-WqRfbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:42 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)) 17:17:42 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)) 17:17:42 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)) 17:17:42 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)) 17:17:42 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)) 17:17:42 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)) 17:17:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:44 INFO - Downloading blessings-1.6.tar.gz 17:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:44 INFO - Installing collected packages: blessings 17:17:44 INFO - Running setup.py install for blessings 17:17:44 INFO - Successfully installed blessings 17:17:44 INFO - Cleaning up... 17:17:44 INFO - Return code: 0 17:17:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:45 INFO - Reading from file tmpfile_stdout 17:17:45 INFO - Current package versions: 17:17:45 INFO - argparse == 1.2.1 17:17:45 INFO - blessings == 1.6 17:17:45 INFO - blobuploader == 1.2.4 17:17:45 INFO - docopt == 0.6.1 17:17:45 INFO - functools32 == 3.2.3-2 17:17:45 INFO - jsonschema == 2.5.1 17:17:45 INFO - manifestparser == 1.1 17:17:45 INFO - mozInstall == 1.12 17:17:45 INFO - mozcrash == 0.17 17:17:45 INFO - mozdebug == 0.1 17:17:45 INFO - mozdevice == 0.48 17:17:45 INFO - mozfile == 1.2 17:17:45 INFO - mozhttpd == 0.7 17:17:45 INFO - mozinfo == 0.9 17:17:45 INFO - mozleak == 0.1 17:17:45 INFO - mozlog == 3.2 17:17:45 INFO - moznetwork == 0.27 17:17:45 INFO - mozprocess == 0.22 17:17:45 INFO - mozprofile == 0.28 17:17:45 INFO - mozrunner == 6.11 17:17:45 INFO - mozscreenshot == 0.1 17:17:45 INFO - mozsystemmonitor == 0.3 17:17:45 INFO - moztest == 0.7 17:17:45 INFO - mozversion == 1.4 17:17:45 INFO - psutil == 3.1.1 17:17:45 INFO - requests == 1.2.3 17:17:45 INFO - wsgiref == 0.1.2 17:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 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 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:45 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 17:17:45 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 17:17:45 INFO - Using env: {'DISPLAY': ':0', 17:17:45 INFO - 'HOME': '/home/cltbld', 17:17:45 INFO - 'LANG': 'en_US.UTF-8', 17:17:45 INFO - 'LANGUAGE': 'en_US:en', 17:17:45 INFO - 'LOGNAME': 'cltbld', 17:17:45 INFO - 'MAIL': '/var/mail/cltbld', 17:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:45 INFO - 'MOZ_NO_REMOTE': '1', 17:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:45 INFO - 'NO_EM_RESTART': '1', 17:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:45 INFO - 'PWD': '/builds/slave/test', 17:17:45 INFO - 'SHELL': '/bin/bash', 17:17:45 INFO - 'SHLVL': '1', 17:17:45 INFO - 'TERM': 'linux', 17:17:45 INFO - 'TMOUT': '86400', 17:17:45 INFO - 'USER': 'cltbld', 17:17:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:45 INFO - '_': '/tools/buildbot/bin/python'} 17:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 INFO - Cleaning up... 17:17:45 INFO - Return code: 0 17:17:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:17:45 INFO - Using env: {'DISPLAY': ':0', 17:17:45 INFO - 'HOME': '/home/cltbld', 17:17:45 INFO - 'LANG': 'en_US.UTF-8', 17:17:45 INFO - 'LANGUAGE': 'en_US:en', 17:17:45 INFO - 'LOGNAME': 'cltbld', 17:17:45 INFO - 'MAIL': '/var/mail/cltbld', 17:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:45 INFO - 'MOZ_NO_REMOTE': '1', 17:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:45 INFO - 'NO_EM_RESTART': '1', 17:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:45 INFO - 'PWD': '/builds/slave/test', 17:17:45 INFO - 'SHELL': '/bin/bash', 17:17:45 INFO - 'SHLVL': '1', 17:17:45 INFO - 'TERM': 'linux', 17:17:45 INFO - 'TMOUT': '86400', 17:17:45 INFO - 'USER': 'cltbld', 17:17:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:45 INFO - '_': '/tools/buildbot/bin/python'} 17:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:17:45 INFO - Cleaning up... 17:17:45 INFO - Return code: 0 17:17:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7977ac4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bf350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, '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': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', '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 17:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:17:45 INFO - Using env: {'DISPLAY': ':0', 17:17:45 INFO - 'HOME': '/home/cltbld', 17:17:45 INFO - 'LANG': 'en_US.UTF-8', 17:17:45 INFO - 'LANGUAGE': 'en_US:en', 17:17:45 INFO - 'LOGNAME': 'cltbld', 17:17:45 INFO - 'MAIL': '/var/mail/cltbld', 17:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:45 INFO - 'MOZ_NO_REMOTE': '1', 17:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:17:45 INFO - 'NO_EM_RESTART': '1', 17:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:45 INFO - 'PWD': '/builds/slave/test', 17:17:45 INFO - 'SHELL': '/bin/bash', 17:17:45 INFO - 'SHLVL': '1', 17:17:45 INFO - 'TERM': 'linux', 17:17:45 INFO - 'TMOUT': '86400', 17:17:45 INFO - 'USER': 'cltbld', 17:17:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:45 INFO - '_': '/tools/buildbot/bin/python'} 17:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:45 INFO - Downloading/unpacking flake8 17:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:17:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:17:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:17:48 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 17:17:48 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 17:17:48 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 17:17:48 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 17:17:48 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 17:17:48 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 17:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:17:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:48 INFO - no previously-included directories found matching 'docs/_build' 17:17:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:17:48 INFO - Running setup.py install for pep8 17:17:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:48 INFO - no previously-included directories found matching 'docs/_build' 17:17:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:17:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:17:48 INFO - Cleaning up... 17:17:48 INFO - Return code: 0 17:17:48 INFO - Running post-action listener: _resource_record_post_action 17:17:48 INFO - Running post-action listener: _start_resource_monitoring 17:17:48 INFO - Starting resource monitoring. 17:17:48 INFO - ##### 17:17:48 INFO - ##### Finished create-virtualenv step (success) 17:17:48 INFO - ##### 17:17:48 INFO - ##### 17:17:48 INFO - ##### Running install step. 17:17:48 INFO - ##### 17:17:48 INFO - Running pre-action listener: _resource_record_pre_action 17:17:48 INFO - Running main action method: install 17:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:48 INFO - Reading from file tmpfile_stdout 17:17:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:48 INFO - Reading from file tmpfile_stdout 17:17:48 INFO - Output received: 17:17:48 INFO - Usage: mozinstall [options] installer 17:17:48 INFO - Options: 17:17:48 INFO - -h, --help show this help message and exit 17:17:48 INFO - -d DEST, --destination=DEST 17:17:48 INFO - Directory to install application into. [default: 17:17:48 INFO - "/builds/slave/test"] 17:17:48 INFO - --app=APP Application being installed. [default: firefox] 17:17:48 INFO - mkdir: /builds/slave/test/build/application 17:17:49 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'] 17:17:49 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 17:18:04 INFO - Reading from file tmpfile_stdout 17:18:04 INFO - Output received: 17:18:04 INFO - /builds/slave/test/build/application/firefox/firefox 17:18:04 INFO - Running post-action listener: _resource_record_post_action 17:18:04 INFO - ##### 17:18:04 INFO - ##### Finished install step (success) 17:18:04 INFO - ##### 17:18:04 INFO - ##### 17:18:04 INFO - ##### Running run-tests step. 17:18:04 INFO - ##### 17:18:04 INFO - Running pre-action listener: _resource_record_pre_action 17:18:04 INFO - Running main action method: run_tests 17:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:04 INFO - Python 2.7.3 17:18:04 INFO - Return code: 0 17:18:04 INFO - grabbing minidump binary from tooltool 17:18:04 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')]} 17:18:04 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 0x1a4e1c0>, '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 0x1a4f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a4f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:04 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 17:18:04 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 17:18:04 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 17:18:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:04 INFO - Return code: 0 17:18:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:18:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:18:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:18:05 INFO - Return code: 0 17:18:05 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/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 17:18:05 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/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 17:18:05 INFO - Using env: {'DISPLAY': ':0', 17:18:05 INFO - 'HOME': '/home/cltbld', 17:18:05 INFO - 'LANG': 'en_US.UTF-8', 17:18:05 INFO - 'LANGUAGE': 'en_US:en', 17:18:05 INFO - 'LOGNAME': 'cltbld', 17:18:05 INFO - 'MAIL': '/var/mail/cltbld', 17:18:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:05 INFO - 'MOZ_NO_REMOTE': '1', 17:18:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:05 INFO - 'NO_EM_RESTART': '1', 17:18:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:05 INFO - 'PWD': '/builds/slave/test', 17:18:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:05 INFO - 'SHELL': '/bin/bash', 17:18:05 INFO - 'SHLVL': '1', 17:18:05 INFO - 'TERM': 'linux', 17:18:05 INFO - 'TMOUT': '86400', 17:18:05 INFO - 'USER': 'cltbld', 17:18:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961', 17:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:05 INFO - '_': '/tools/buildbot/bin/python'} 17:18:05 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/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 17:18:06 INFO - mozversion application_buildid: 20160701144421 17:18:06 INFO - mozversion application_changeset: 4bae0c26ac7116579c5a4ee0e4cd945c2094939a 17:18:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:18:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:06 INFO - mozversion application_name: Firefox 17:18:06 INFO - mozversion application_remotingname: firefox-dev 17:18:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:18:06 INFO - mozversion application_vendor: Mozilla 17:18:06 INFO - mozversion application_version: 49.0a2 17:18:06 INFO - mozversion platform_buildid: 20160701144421 17:18:06 INFO - mozversion platform_changeset: 4bae0c26ac7116579c5a4ee0e4cd945c2094939a 17:18:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:18:06 INFO - mozversion platform_version: 49.0a2 17:18:06 INFO - using testdate: 1467418686 17:18:06 INFO - actual date: 1467418686 17:18:06 INFO - starting webserver on 'localhost:55436' 17:18:06 INFO - SUITE-START | Running 2 tests 17:18:06 INFO - TEST-START | dromaeo_css 17:18:06 INFO - operating with platform_type : linux_ 17:18:06 INFO - Initialising browser for dromaeo_css test... 17:18:06 INFO - TEST-INFO | started process 3351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhQmfF/profile http://localhost:55436/getInfo.html) 17:18:11 INFO - PROCESS | 3351 | __metrics Screen width/height:1600/1200 17:18:11 INFO - PROCESS | 3351 | colorDepth:24 17:18:11 INFO - PROCESS | 3351 | Browser inner width/height: 1024/697 17:18:11 INFO - PROCESS | 3351 | __metrics 17:18:12 ERROR - PROCESS | 3351 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:18:13 INFO - TEST-INFO | 3351: exit 0 17:18:13 INFO - Browser initialized. 17:18:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:13 INFO - TEST-INFO | started process 3440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhQmfF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:25 INFO - PROCESS | 3440 | RSS: Main: 145326080 17:18:25 INFO - PROCESS | 3440 | 17:19:16 INFO - PROCESS | 3440 | 1467418756609 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] 17:21:24 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:55436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55436/tests/dromaeo/cssquery-ext.html) 17:21:25 INFO - PROCESS | 3440 | RSS: Main: 257802240 17:21:25 INFO - PROCESS | 3440 | 17:24:28 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:55436/tests/dromaeo/cssquery-ext.html (next: http://localhost:55436/tests/dromaeo/cssquery-jquery.html) 17:24:28 INFO - PROCESS | 3440 | RSS: Main: 230387712 17:24:28 INFO - PROCESS | 3440 | 17:27:30 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:55436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55436/tests/dromaeo/cssquery-mootools.html) 17:27:31 INFO - PROCESS | 3440 | RSS: Main: 226578432 17:27:31 INFO - PROCESS | 3440 | 17:30:33 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:55436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55436/tests/dromaeo/cssquery-prototype.html) 17:30:33 INFO - PROCESS | 3440 | RSS: Main: 223830016 17:30:33 INFO - PROCESS | 3440 | 17:33:36 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:55436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55436/tests/dromaeo/cssquery-yui.html) 17:33:36 INFO - PROCESS | 3440 | RSS: Main: 218595328 17:33:36 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | Cycle 1(1): loaded http://localhost:55436/tests/dromaeo/cssquery-yui.html (next: http://localhost:55436/tests/dromaeo/cssquery-dojo.html) 17:36:39 INFO - PROCESS | 3440 | RSS: Main: 261808128 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | __start_tp_report 17:36:39 INFO - PROCESS | 3440 | _x_x_mozilla_page_load 17:36:39 INFO - PROCESS | 3440 | _x_x_mozilla_page_load_details 17:36:39 INFO - PROCESS | 3440 | |i|pagename|runs| 17:36:39 INFO - PROCESS | 3440 | |0;dojo.html;3400.8979730608085;3428.348613763383;3428.8799892003785;3456.6543345665423;3482.6865582097607;5613.522850557702;5668.348139963905;5671.120976248678;5678.886422271562;5711.400302968191;5609.467100625444;5662.433756624336;5668.319801623811;5673.432656734335;5682.659040457575;4902.852914412556;4960.379952505937;5110.463401342852;5116.386033675964;5131.3842338919385;5040.445550989388;5040.798368065273;5066.670666406671;5081.28861959326;5084.618653600976;5070.3915530136255;5143.27994080829;5186;5215.504527069922;5230.947690523103;5284.2073688946775;5284.894302113936;5298.973505132488;5302.443243459439;5326.467353264681;4976.178930476503;5032.84901452957;5057.696538207682;5181.4041385240425;5199.376074871002;5474;5480.588955828289;5483.725813709339;5500.532454741352;5536.806211782568;6071;6085.878282434371;6090.731517237602;6118.510519158456;6125.081237814319;6050.152978583002;6076.360358745286;6120.816375508742;6130.233720784902;6137.815865524041;5734.942650573483;5745.052066409079;5784.363719990798;5786.508146807484;5793.217915581385;6020.939790602038;6266.060090986297;6278.152449419361;6286.497080233662;6287.339829317947;5889.94110058894;5958.553108516879;5980.970095149496;6018.789342373084;6032.3967603239325;6075.759844288032;6080.878382432326;6082.118092876508;6082.635041897501;6108.1143234230785;5880.176775251468;5885.499732522698;6057;6059.666718330446;6067.180930574405;5932.7330270137945;6002.819915402545;6007.939920600826;6012.428819262163;6052.54605904559;4576.130535198302;4580.748058856728;4593.931091033637;4597.563231493003;4600.562946520142;4067.51189857219;4076.5515793262716;4095.4266402703647;4125.876223713293;4127.731697439657;5731.111677689964;5755.107958266475;5758.193852860602;5764.682942438122;5775.768969241268;6106.72519736604;6112.959454150325;6117.002738361962;6126.5305104610325;6134.681512609229;5496.093144631171;5662.292213473316;5691.601587888891;5707.143928410688;5725.599208055396;5263.868403289872;5276.182191760283;5280.6039547034125;5282.154855223146;5282.4717528246865;6240.968795155995;6296.33888441707;6296.370362963667;6304.716287767062;6308.211473565804;5941.1385349123275;6028.156058151774;6086;6098.329183789869;6169.938300616936;6317.6841157941;6317.983910786135;6338.461230795434;6373.075903993988;6374.617522948638;5806.593538452436;6027.276726792813;6033.396660334107;6040.607360521552;6040.909386359121;5891.027980383189;5932.614380065282;5977.521798256216;6018.9398106020135;6021.187139736079;5869;5874.118882167538;5875.265591801025;5876.529877609866;5880.382559831156;5722.542196624343;5807.274090738658;5809.564282678732;5874.823755287348;5879.412058794257;5751.281089863767;5815.476607105381;5820.912686309624;5826.592138550261;5857.326407463196;6010.789622363196;6010.909836352545;6051.243594550681;6052.788152414644;6062.969685151546;5643.322801263875;5765.91351129725;5809.883802324014;5847.181394604674;5860.560457965755 17:36:39 INFO - PROCESS | 3440 | |1;ext.html;607.9726412311445;636.4049613611273;649.3474058571138;654.2084078265299;656.5502630697971;33561.16097097574;46752.532474675245;47798.283025754645;47881;47926.76036619812;49802.252966205444;50183.749081254544;50233.49766502334;50256.24615630759;50298.49701502984;8482.575871206445;9124.54377281135;9329.95335023324;9330.160285574297;10900.563977440894;11018.228723989325;11088.33469991803;11112.055475284611;11131;11155.442227888614;11126.109911207084;11170.609028683997;11181.83227251592;11184.38485883276;11190.720231994184;8573.18554737296;11050.834237486444;11137.164712646543;11297.435128243636;11307.943460282646;10716.785664286748;11099.83350249747;11113.888861111367;11130.109591232764;11133.387663678495;46404.535954640356;46824.29763553549;46929;47008.52991470076;47025.764871175765;3855.7879316637573;3930.508686414198;3961.3859851723028;4027.97986010071;4313.676474264443;35217.47173792395;36422.453663195076;36491.817540912125;36622;36789;4804;4813.109574728686;4868.367112275417;4920.852374428773;4959.876003099916;386590;390568;391095;391154;392223;35499.29001419957;63931.36068639347;64343.35656643374;64376.67811660912;64501.677491612245;42000.369994450106;42182.367264491055;42220.57779422228;42267;42419.15161696749;17512.38706645261;17740.645187096186;17761.555961101076;17763.289468421117;17781.1998460067;13711.314434278247;14985.250737463084;15228.619284517976;15243.847561524242;15727;8702.648675662169;8704.260137888225;8707.390482666153;8722.520261385685;8779;3648.21563363878;3668.248009158116;3673.559172899269;3729.9627003730157;3754.6808521276;1106.4246591772232;1108.5953626926275;1146.691794173798;1147.386148410613;1148.9770204595861;32307.35385292281;34198.316033679184;34313;34502.654973450444;34818.30363392718;1200.699825043739;1210.328267811373;1218.4090716002731;1235.7775600391835;1309.12942892977;18320.908395458206;18370.35703750362;18453.169607367432;18553.44339669812;18664.720029199572;600649;605357;608472;613206;621439;67747.66126169337;68288.31711682919;68388.6580567104;68400;68532.31467685259;1342.7180292138564;1482.9332680029424;1502.353987785263;1513.379514399113;1531.5788158256346;34550.82724586361;35246.47130292996;35892.461613075306;36586.8170659145;36906.07734806544;58839.70580147072;59424.40575594362;59638.40361596502;59651.701741491015;59685.40314596798;423300.53398932464;424798;425143;425677;426380;26934.191974240803;29129.1261262154;31783;32107.518387223743;33929.151771205914;53690.73154634202;53891;53933.730331348095;54255;54778.72610636921;44772;45369.54630453653;45595.77202114101;46232;46961.29558056564;43847.56152438562;44635.330470042325;44636.776816115715;46079;46136.0011599245;44727.77636111798;45210;45702;46007.53992460033;46454.76772616115;38430.231395372495;39835.80082099571;40142.1971560573;40329.1934161321;41059.1788164241;30192.19430502333;30300.848495757382;30349;30457;30762.84618576893 17:36:39 INFO - PROCESS | 3440 | |2;jquery.html;407.9388091786233;427.4421879447322;429.2123952547076;430.88581525895626;444.6509490050311;18334.174962126704;19221.807781922194;19670;19735.802641973576;20041.899790501044;19022.90488547559;19454.610907781836;19522.804771952276;19791.40625781229;19799.109040093193;5623.718814059301;5837.474627283565;5874.060150375941;5885.32318783339;5886.911696324559;4317.525072242051;5151.918097199593;5729.0260655688635;5785;6462.903056454157;6366.84082897929;6431.581947173442;6466.321036291192;6520.315366886456;6543.541952063358;6324.494040476751;6370.076338930852;6437.356264373572;6460.547761656686;6485.383888530582;3884.514435695538;5416.160495123262;5717.542596592262;5823.563232757518;5839.8540036499;22580.322590322317;22761.54476910469;22773.08907643709;22776.658350124762;22846.54306913869;2470.8270421070533;2504.048461584586;2688.90588829392;2833.1783782703196;2955.143008527524;13895.652608684763;15049.699006019928;15498.690026199525;15543.533693989199;15555.688886222326;2183.3777373448493;2186.9781302186934;2194.6488561830192;2205.9558808823895;2207.845450818443;76091.61954190194;77468;77551.61224193843;86281;91263.54368228116;9183.816323673624;9757.853632195523;9788.951055244679;9814.46020468881;10326.070653641209;12686;12689;12701.555445559547;12756.234625922474;12770.23378597287;8021.558814265271;8117.107118216992;8142.226488483585;8322.70870519529;8615.095414981337;8578.571071446402;8659.567021648892;8681.826363472695;8802.295816334678;8809.603567839462;4270.402143699823;4312.9137417252105;4334.349847522833;4401.515833258339;4421.29259318514;1964.7347608073012;2022.7774944756065;2092.1213090502024;2107.483666501717;2114;1001.7896241789306;1045.9424731639833;1066.2962444786558;1111.3554138599593;1120.1151090638305;18387.448376548724;18397.448076557725;18655.813441865677;19042.238310467703;19139.2344306229;1074.8387741838787;1076.4025965589017;1099.631623406152;1105.5798796457295;1112.2436743014666;10223.284370094021;10599.470026498644;10659.73350666224;10721.172003896085;10753.51609177589;546062;547043;550017;567053;575059;91310.54344728366;91445.54277228571;91571.5421422902;92257.538712306;93095.53452232831;1073.8335557988523;1108.4070022537903;1115.0689174539189;1131.8924702153283;1137.7724455109012;16189.352425902833;16650.916745416194;17085.65828683444;17209;17371.218295176495;29712.851435742683;34391.656083438844;42593.36109958291;42768.57231427646;43856.56143438525;39362.60637393704;55632.443675562725;57410.42589574051;59913.400865990785;60576.69711651414;7780.649870755943;7957.363410927228;8006.799830004296;8833.823323533621;9006.50464224474;9466.621335146518;10667.199960003187;12124.72690367534;12784.48862045545;12856.807147892601;11007;11417.657470275904;11490.195686301879;11736.413179341169;11836.644900652995;11619.709507262387;11794.233374830608;11912.463939122586;11916.880831191924;11929.164958452826;11184.664460066211;11356.772864542829;11371.886281137413;11467.885321146681;11517.769644607228;8041.67833286662;8147.429679922348;8159.959200203961;8176.877346839683;8282.627281772215;8416.537090459839;10440.63457778974;11176.105911526896;11230.382328971658;11395.14536409756 17:36:39 INFO - PROCESS | 3440 | |3;mootools.html;1387.9306034698263;1563.1558958162595;1594.2268000019988;1842.972355414669;1918.405294358749;8086.191380861911;9141;9447.244220462364;9466.952665236673;9765.169960553343;9346.532673366339;9559.091886270793;9561.378510396837;9567.904320956788;9577.042295770438;2449.252977841762;2475.579151544233;2480.131953816168;2481.1936120760824;2482.2429159106464;2435.488547405047;2490.22802931091;2490.887910044052;2491.5888878335054;2492.6884139482563;2385.2367242482414;2417.758224177577;2445.877706114687;2447.5104979004273;2453.0800949643885;2356.6229403295474;2372.96440553391;2381.226101517005;2411.867347295898;2412.541617092747;2337.0885354711677;2356.929292121239;2373.2049763329305;2374.6675465434855;2375.5367703297866;7931.325837303836;9068.682596109105;9413.105754953269;9478.90521094787;9483.620655173785;5346.518813306782;5467.808626698086;5542.140968149944;5544.390117087117;5550.028744969614;3597.244578638463;3602.369585322558;3673.5959044505084;3682.650148235913;3738.2336620992633;1131.8189089745683;1134.6879608107836;1180.6694125644833;1197.114135539703;1206.6681662542783;13242.073054886161;13524.053316267866;13531.255780932044;13536.661583460493;13567.389467473988;4917.606591472673;4931.334269873521;4976.4525902150735;4992.425871024879;5062.417821950449;11217;11262.099032077414;11268.887311126948;11272.154588405903;11273.041791447655;5678.375378708339;5751.971240143773;5760.020796464527;5760.53915686744;5761.8559536011935;5099.668521546162;5185.0148471790235;5269.762860671279;5349.117395629678;5352.277442545206;4145.91708165841;4204.348326009474;4232.174725928415;4262.296721041055;4272.359146128106;1284.9486020559073;1311.6065180445828;1320.1748906933167;1320.4784110276387;1331.633800704814;950.9714708558754;997.4314640654902;1079.3739631013993;1100.8183649697871;1104.7072525780675;6519.622454048684;6545.770898018546;6573.769918052941;6623.2383275923885;6726.899096513458;1009.1724785675675;1033.3076838518211;1039.184240371305;1064.9893501065046;1095.118429664128;4534.841280555231;4602.470715867651;4696.060787842445;4707.176244157259;4836.927446088312;11721.531138754524;11980.041596672245;11990.280583165038;12006.579769708018;12025.759484810254;11177.552897884156;11686.94156529212;11711.590094346657;11838.230515016496;11870.703232419259;8777.605007774666;8900.109989001177;8902.198802107712;8915.37592368528;8974.14745599167;6582.111414958919;6776.792868838926;6825.453963682993;6922.896156557555;6955.513114081966;10759.515821787882;10996.23026388145;11114.16643751738;11175.21773475849;11180.04969577595;11127.109831213646;11190.776184476428;11291.717707057061;11304.491297891778;11372.943135284602;8482.703105391281;8549.87175192385;8551.786205344915;8630.741077767678;8632.697855575025;8590.098039705741;8787.5166865823;8816.250618697226;9068.727938161603;9076.818463630823;7969.442139050443;8035.397345199251;8043.3967452442475;8098.51408915467;8165.836683266421;7700;7925;7950.562719050507;8014.398920080901;8146.103928567972;7504.399648028254;7539.773806785805;7566.281203285679;7575.545467271982;7582.241775822595;5539.556835453234;5658.349289831722;5660.632058916157;5742.913856292243;5765.942340576708;5721.141828725558;5769.682667453162;5832.445917637818;5878.764849405976;5931.91307672066 17:36:39 INFO - PROCESS | 3440 | |4;prototype.html;345.45935610769146;354.62586970745866;356.72353925707574;365.5229924947945;366.26198210605634;5254.663288811604;5370.650907690997;5437.3475182978045;5446.7276636168135;5467.5899307551945;5295.894082118355;5359.866003349918;5367.946320536794;5384.707670159163;5439.156930675742;4260.893477663052;4260.914781704357;4277.422547956033;4282.14357128574;4300.548442413533;4006.717850287909;4149.240754897989;4227.266820603553;4281.67887408444;4315.158544083905;4176.519700234481;4182.414461975311;4188.554948542748;4204.978975105136;4227.682923780713;4212.389203565481;4218.595400621647;4230.830766769325;4237.216115018731;4266.509351424595;3692.593814680383;3753.9249215015548;3793.487879136309;3796.1079146400575;3806.8667596634264;5160.870978225536;5167;5180.948190518122;5180.974095129538;5205.7397130143345;4764.309175169616;4809.254565542312;4817.494163112893;4833.139241392054;4837.201861692816;5479.041317688443;5563;5570.498655121018;5637.210790489335;5653.745581448845;4082.5305089914445;4087.89780255493;4089.3661482469965;4095.2833254180696;4127.380892866094;5807;5862.267216597926;5880.5883588148845;5895.793647222326;5910.822675319747;4007.2786898358577;4188.434561334181;4197.643200327945;4197.916041679149;4206.810693518799;4201.852935147255;4227.42929704486;4232.449781528443;4242.406063151161;4242.469691288589;4870.342503762017;4871.464138944713;4895.118878601886;4909.410870695539;4915.3855768029;5539.529140023144;5696.487316141567;5708.543316534668;5744.942550574441;5766.567507436959;1386.4662105089612;1420.2117824607442;1441.9329696025077;1444.6388402899274;1449.282605110477;924.7238810441547;937.7608709778963;938.8170904660177;943.4763706143019;949.3734135470556;4822.638302127354;4880.194767863263;4925.473103337977;4928.250471082786;4969.130402179677;5206.479352064764;5230.738463076831;5243.842684719464;5251.789928402897;5259.789608415697;4555.180067587799;4857.757112144379;4965.577925876269;4973.403191617029;4981.252812078144;2728.7953403494816;2761.765249953736;2767.1560174146675;2770.224337185591;2773.8364076020735;5267.2889159962915;5267.815626453133;5289.444608316148;5312.893742125136;5353.4646535346155;4806.831760888352;5150.4849515048945;5168.2169651470185;5199.63602547818;5218.478152184751;5198.376194856642;5213.582913366921;5236.607254455931;5265.4997775211295;5289.656172348862;5037.722925239001;5082.237664350377;5089.287499749964;5122.642499737498;5124;4881.609471242363;5054.317667114892;5067.402144477463;5072.289879416959;5089.211172268157;5081.932794113278;5164.04465173944;5213.869653258547;5296.364436267672;5312.6452754547345;3799.430085487199;3830.8659196927974;3840.481534992852;3842.8270727817876;3844.020329530238;4968.403791545038;5073.097588404348;5213.40045894727;5595.300587426572;5743.827685169452;5677.858053548694;5697.800576979786;5700.287464066992;5742.569307301886;5748.511376533042;5664.603477756517;5703.401142879938;5705.686187259741;5730.570207234391;5766.4233576642;5530.751116199861;5626.915596265977;5654.46282603152;5667.291588551431;5670.092785154356;5758.481736643722;5792.943505055645;5806.477417032487;5814.592978491465;5821.912671310019;5419;5586.217929489956;5598.888022239614;5626.831195064155;5691.345495268097 17:36:39 INFO - PROCESS | 3440 | |5;yui.html;803.9477433966791;812.20404004076;848.8769128476367;865.7748985263831;878.2403221213648;15559.922200388997;16181.110038947852;16410.67178656426;16413.589660258483;16463.83536164638;14183.759145975764;14440.855591444082;14934.626634334147;14952;14962.25188740564;732.0190944134858;878.4860856398982;894.4007514964973;907.469130558624;912.8904531456235;893.120276527623;895.3821862914568;901.7520181949951;901.8241442918634;902.4269588811087;937.5874615169304;945.9763505912339;947.9573419196118;948.2319321349729;948.4498990585444;746.1121265693835;916.2852974679761;930.7766136127315;933.6312156698134;934.0146145816161;686.1251903822616;686.6875571614953;687.1650944102889;687.5633972427495;687.5977553131424;15206.619834504116;15227.162506062163;15235.324114347413;15242.542723718196;15251.466198683103;14649.487267945571;14872.62818429537;14895;14903.32935017916;15408.614784630361;13393.933030334883;13432;13472.865271347357;13523.729525409437;13779.242141682204;4660.953390466086;4715.3869996900185;4799.520047995207;4799.712017278975;4811.326414302001;75891;75940;76148.61925690336;76298;77105;12032.518699252107;12179.87820121805;12265.386730663431;12385.814212786816;12487.687807804696;22305.553888922455;22340.88829555842;22348.32955011352;22363;22366.217182398865;8817;8964.193222609996;8976.102389760972;9019.413738107001;9054.954725226331;4855.878603034952;4979.766579678795;4985.576226020757;5104.41299250591;5131;3468.618451970281;3559.6796288333658;3564.465330200439;3566.946495802565;3982.522097348337;602.286290745468;715.7137145141985;738.2101151767557;742.6806473216461;758.0865057605682;637.8150336402391;684.6063513479769;715.73315232039;736.5102207032371;752.2327226229215;10287.434191119411;10310.793784124275;10482.63310784119;10582.523786429629;10701.357918524913;787.169536139367;808.2887059387701;815.9306458950937;818.8280461103116;829.7054545636212;4987.1771157759285;5027.644087347364;5029.385396951844;5040.59675225981;5057.266696329012;71962.2803771966;72350.63824680843;72447;75550.62224688951;123607.38196309141;91183;98475;103526;103734;105144;87039;87348;87739;88396.5580172095;89228.5538572303;9775.413475191512;9869.963653816532;9879.50602469888;9880.35777674449;9998.100170984355;56004;56202.1569676447;56392.718036409555;56430.43569564252;57505.13742293953;66649.66675166594;67882.3211767876;76139.61930190313;81229.59385203036;81808;13449.798253026409;13633.250171240677;13680.589582312547;13725.382357794122;14047.789283160557;15187.924060379628;15669.216539172769;15951.44169954046;16100.27548760332;16114.758278626065;15419.229038548252;15468.92265538665;15502.844971550592;15533;15909.204539773196;14675.19286439256;14931.92534037323;15213.923930380277;15697.529074127795;15745;14927.477538286108;14940.626484337978;15548.300326485562;15625.687486249984;15650;10515;10526;10768.523239654767;10943.179261555575;11053;11054.741512230661;11144.832827507431;11221;11346.262492937933;11374 17:36:39 INFO - PROCESS | 3440 | __end_tp_report 17:36:39 INFO - PROCESS | 3440 | __start_cc_report 17:36:39 INFO - PROCESS | 3440 | _x_x_mozilla_cycle_collect,913 17:36:39 INFO - PROCESS | 3440 | __end_cc_report 17:36:39 INFO - PROCESS | 3440 | __startTimestamp1467419799722__endTimestamp 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | ------- Summary: start ------- 17:36:39 INFO - PROCESS | 3440 | Number of tests: 6 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | [#0] dojo.html Cycles:165 Average:5626.23 Median:5809.88 stddev:632.05 (10.9%) stddev-sans-first:609.40 17:36:39 INFO - PROCESS | 3440 | Values: 3400.9 3428.3 3428.9 3456.7 3482.7 5613.5 5668.3 5671.1 5678.9 5711.4 5609.5 5662.4 5668.3 5673.4 5682.7 4902.9 4960.4 5110.5 5116.4 5131.4 5040.4 5040.8 5066.7 5081.3 5084.6 5070.4 5143.3 5186.0 5215.5 5230.9 5284.2 5284.9 5299.0 5302.4 5326.5 4976.2 5032.8 5057.7 5181.4 5199.4 5474.0 5480.6 5483.7 5500.5 5536.8 6071.0 6085.9 6090.7 6118.5 6125.1 6050.2 6076.4 6120.8 6130.2 6137.8 5734.9 5745.1 5784.4 5786.5 5793.2 6020.9 6266.1 6278.2 6286.5 6287.3 5889.9 5958.6 5981.0 6018.8 6032.4 6075.8 6080.9 6082.1 6082.6 6108.1 5880.2 5885.5 6057.0 6059.7 6067.2 5932.7 6002.8 6007.9 6012.4 6052.5 4576.1 4580.7 4593.9 4597.6 4600.6 4067.5 4076.6 4095.4 4125.9 4127.7 5731.1 5755.1 5758.2 5764.7 5775.8 6106.7 6113.0 6117.0 6126.5 6134.7 5496.1 5662.3 5691.6 5707.1 5725.6 5263.9 5276.2 5280.6 5282.2 5282.5 6241.0 6296.3 6296.4 6304.7 6308.2 5941.1 6028.2 6086.0 6098.3 6169.9 6317.7 6318.0 6338.5 6373.1 6374.6 5806.6 6027.3 6033.4 6040.6 6040.9 5891.0 5932.6 5977.5 6018.9 6021.2 5869.0 5874.1 5875.3 5876.5 5880.4 5722.5 5807.3 5809.6 5874.8 5879.4 5751.3 5815.5 5820.9 5826.6 5857.3 6010.8 6010.9 6051.2 6052.8 6063.0 5643.3 5765.9 5809.9 5847.2 5860.6 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | [#1] ext.html Cycles:180 Average:64548.11 Median:21898.59 stddev:128726.85 (587.8%) stddev-sans-first:128998.44 17:36:39 INFO - PROCESS | 3440 | Values: 608.0 636.4 649.3 654.2 656.6 33561.2 46752.5 47798.3 47881.0 47926.8 49802.3 50183.7 50233.5 50256.2 50298.5 8482.6 9124.5 9330.0 9330.2 10900.6 11018.2 11088.3 11112.1 11131.0 11155.4 11126.1 11170.6 11181.8 11184.4 11190.7 8573.2 11050.8 11137.2 11297.4 11307.9 10716.8 11099.8 11113.9 11130.1 11133.4 46404.5 46824.3 46929.0 47008.5 47025.8 3855.8 3930.5 3961.4 4028.0 4313.7 35217.5 36422.5 36491.8 36622.0 36789.0 4804.0 4813.1 4868.4 4920.9 4959.9 386590.0 390568.0 391095.0 391154.0 392223.0 35499.3 63931.4 64343.4 64376.7 64501.7 42000.4 42182.4 42220.6 42267.0 42419.2 17512.4 17740.6 17761.6 17763.3 17781.2 13711.3 14985.3 15228.6 15243.8 15727.0 8702.6 8704.3 8707.4 8722.5 8779.0 3648.2 3668.2 3673.6 3730.0 3754.7 1106.4 1108.6 1146.7 1147.4 1149.0 32307.4 34198.3 34313.0 34502.7 34818.3 1200.7 1210.3 1218.4 1235.8 1309.1 18320.9 18370.4 18453.2 18553.4 18664.7 600649.0 605357.0 608472.0 613206.0 621439.0 67747.7 68288.3 68388.7 68400.0 68532.3 1342.7 1482.9 1502.4 1513.4 1531.6 34550.8 35246.5 35892.5 36586.8 36906.1 58839.7 59424.4 59638.4 59651.7 59685.4 423300.5 424798.0 425143.0 425677.0 426380.0 26934.2 29129.1 31783.0 32107.5 33929.2 53690.7 53891.0 53933.7 54255.0 54778.7 44772.0 45369.5 45595.8 46232.0 46961.3 43847.6 44635.3 44636.8 46079.0 46136.0 44727.8 45210.0 45702.0 46007.5 46454.8 38430.2 39835.8 40142.2 40329.2 41059.2 30192.2 30300.8 30349.0 30457.0 30762.8 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | [#2] jquery.html Cycles:180 Average:30672.90 Median:2596.48 stddev:91535.71 (3525.4%) stddev-sans-first:91764.29 17:36:39 INFO - PROCESS | 3440 | Values: 407.9 427.4 429.2 430.9 444.7 18334.2 19221.8 19670.0 19735.8 20041.9 19022.9 19454.6 19522.8 19791.4 19799.1 5623.7 5837.5 5874.1 5885.3 5886.9 4317.5 5151.9 5729.0 5785.0 6462.9 6366.8 6431.6 6466.3 6520.3 6543.5 6324.5 6370.1 6437.4 6460.5 6485.4 3884.5 5416.2 5717.5 5823.6 5839.9 22580.3 22761.5 22773.1 22776.7 22846.5 2470.8 2504.0 2688.9 2833.2 2955.1 13895.7 15049.7 15498.7 15543.5 15555.7 2183.4 2187.0 2194.6 2206.0 2207.8 76091.6 77468.0 77551.6 86281.0 91263.5 9183.8 9757.9 9789.0 9814.5 10326.1 12686.0 12689.0 12701.6 12756.2 12770.2 8021.6 8117.1 8142.2 8322.7 8615.1 8578.6 8659.6 8681.8 8802.3 8809.6 4270.4 4312.9 4334.3 4401.5 4421.3 1964.7 2022.8 2092.1 2107.5 2114.0 1001.8 1045.9 1066.3 1111.4 1120.1 18387.4 18397.4 18655.8 19042.2 19139.2 1074.8 1076.4 1099.6 1105.6 1112.2 10223.3 10599.5 10659.7 10721.2 10753.5 546062.0 547043.0 550017.0 567053.0 575059.0 91310.5 91445.5 91571.5 92257.5 93095.5 1073.8 1108.4 1115.1 1131.9 1137.8 16189.4 16650.9 17085.7 17209.0 17371.2 29712.9 34391.7 42593.4 42768.6 43856.6 39362.6 55632.4 57410.4 59913.4 60576.7 7780.6 7957.4 8006.8 8833.8 9006.5 9466.6 10667.2 12124.7 12784.5 12856.8 11007.0 11417.7 11490.2 11736.4 11836.6 11619.7 11794.2 11912.5 11916.9 11929.2 11184.7 11356.8 11371.9 11467.9 11517.8 8041.7 8147.4 8160.0 8176.9 8282.6 8416.5 10440.6 11176.1 11230.4 11395.1 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | [#3] mootools.html Cycles:180 Average:6267.21 Median:4701.62 stddev:3579.18 (76.1%) stddev-sans-first:3570.43 17:36:39 INFO - PROCESS | 3440 | Values: 1387.9 1563.2 1594.2 1843.0 1918.4 8086.2 9141.0 9447.2 9467.0 9765.2 9346.5 9559.1 9561.4 9567.9 9577.0 2449.3 2475.6 2480.1 2481.2 2482.2 2435.5 2490.2 2490.9 2491.6 2492.7 2385.2 2417.8 2445.9 2447.5 2453.1 2356.6 2373.0 2381.2 2411.9 2412.5 2337.1 2356.9 2373.2 2374.7 2375.5 7931.3 9068.7 9413.1 9478.9 9483.6 5346.5 5467.8 5542.1 5544.4 5550.0 3597.2 3602.4 3673.6 3682.7 3738.2 1131.8 1134.7 1180.7 1197.1 1206.7 13242.1 13524.1 13531.3 13536.7 13567.4 4917.6 4931.3 4976.5 4992.4 5062.4 11217.0 11262.1 11268.9 11272.2 11273.0 5678.4 5752.0 5760.0 5760.5 5761.9 5099.7 5185.0 5269.8 5349.1 5352.3 4145.9 4204.3 4232.2 4262.3 4272.4 1284.9 1311.6 1320.2 1320.5 1331.6 951.0 997.4 1079.4 1100.8 1104.7 6519.6 6545.8 6573.8 6623.2 6726.9 1009.2 1033.3 1039.2 1065.0 1095.1 4534.8 4602.5 4696.1 4707.2 4836.9 11721.5 11980.0 11990.3 12006.6 12025.8 11177.6 11686.9 11711.6 11838.2 11870.7 8777.6 8900.1 8902.2 8915.4 8974.1 6582.1 6776.8 6825.5 6922.9 6955.5 10759.5 10996.2 11114.2 11175.2 11180.0 11127.1 11190.8 11291.7 11304.5 11372.9 8482.7 8549.9 8551.8 8630.7 8632.7 8590.1 8787.5 8816.3 9068.7 9076.8 7969.4 8035.4 8043.4 8098.5 8165.8 7700.0 7925.0 7950.6 8014.4 8146.1 7504.4 7539.8 7566.3 7575.5 7582.2 5539.6 5658.3 5660.6 5742.9 5765.9 5721.1 5769.7 5832.4 5878.8 5931.9 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | [#4] prototype.html Cycles:180 Average:4583.88 Median:5089.25 stddev:1315.37 (25.8%) stddev-sans-first:1280.01 17:36:39 INFO - PROCESS | 3440 | Values: 345.5 354.6 356.7 365.5 366.3 5254.7 5370.7 5437.3 5446.7 5467.6 5295.9 5359.9 5367.9 5384.7 5439.2 4260.9 4260.9 4277.4 4282.1 4300.5 4006.7 4149.2 4227.3 4281.7 4315.2 4176.5 4182.4 4188.6 4205.0 4227.7 4212.4 4218.6 4230.8 4237.2 4266.5 3692.6 3753.9 3793.5 3796.1 3806.9 5160.9 5167.0 5180.9 5181.0 5205.7 4764.3 4809.3 4817.5 4833.1 4837.2 5479.0 5563.0 5570.5 5637.2 5653.7 4082.5 4087.9 4089.4 4095.3 4127.4 5807.0 5862.3 5880.6 5895.8 5910.8 4007.3 4188.4 4197.6 4197.9 4206.8 4201.9 4227.4 4232.4 4242.4 4242.5 4870.3 4871.5 4895.1 4909.4 4915.4 5539.5 5696.5 5708.5 5744.9 5766.6 1386.5 1420.2 1441.9 1444.6 1449.3 924.7 937.8 938.8 943.5 949.4 4822.6 4880.2 4925.5 4928.3 4969.1 5206.5 5230.7 5243.8 5251.8 5259.8 4555.2 4857.8 4965.6 4973.4 4981.3 2728.8 2761.8 2767.2 2770.2 2773.8 5267.3 5267.8 5289.4 5312.9 5353.5 4806.8 5150.5 5168.2 5199.6 5218.5 5198.4 5213.6 5236.6 5265.5 5289.7 5037.7 5082.2 5089.3 5122.6 5124.0 4881.6 5054.3 5067.4 5072.3 5089.2 5081.9 5164.0 5213.9 5296.4 5312.6 3799.4 3830.9 3840.5 3842.8 3844.0 4968.4 5073.1 5213.4 5595.3 5743.8 5677.9 5697.8 5700.3 5742.6 5748.5 5664.6 5703.4 5705.7 5730.6 5766.4 5530.8 5626.9 5654.5 5667.3 5670.1 5758.5 5792.9 5806.5 5814.6 5821.9 5419.0 5586.2 5598.9 5626.8 5691.3 17:36:39 INFO - PROCESS | 3440 | 17:36:39 INFO - PROCESS | 3440 | [#5] yui.html Cycles:180 Average:20584.72 Median:4982.67 stddev:28014.81 (562.2%) stddev-sans-first:28054.03 17:36:39 INFO - PROCESS | 3440 | Values: 803.9 812.2 848.9 865.8 878.2 15559.9 16181.1 16410.7 16413.6 16463.8 14183.8 14440.9 14934.6 14952.0 14962.3 732.0 878.5 894.4 907.5 912.9 893.1 895.4 901.8 901.8 902.4 937.6 946.0 948.0 948.2 948.4 746.1 916.3 930.8 933.6 934.0 686.1 686.7 687.2 687.6 687.6 15206.6 15227.2 15235.3 15242.5 15251.5 14649.5 14872.6 14895.0 14903.3 15408.6 13393.9 13432.0 13472.9 13523.7 13779.2 4661.0 4715.4 4799.5 4799.7 4811.3 75891.0 75940.0 76148.6 76298.0 77105.0 12032.5 12179.9 12265.4 12385.8 12487.7 22305.6 22340.9 22348.3 22363.0 22366.2 8817.0 8964.2 8976.1 9019.4 9055.0 4855.9 4979.8 4985.6 5104.4 5131.0 3468.6 3559.7 3564.5 3566.9 3982.5 602.3 715.7 738.2 742.7 758.1 637.8 684.6 715.7 736.5 752.2 10287.4 10310.8 10482.6 10582.5 10701.4 787.2 808.3 815.9 818.8 829.7 4987.2 5027.6 5029.4 5040.6 5057.3 71962.3 72350.6 72447.0 75550.6 123607.4 91183.0 98475.0 103526.0 103734.0 105144.0 87039.0 87348.0 87739.0 88396.6 89228.6 9775.4 9870.0 9879.5 9880.4 9998.1 56004.0 56202.2 56392.7 56430.4 57505.1 66649.7 67882.3 76139.6 81229.6 81808.0 13449.8 13633.3 13680.6 13725.4 14047.8 15187.9 15669.2 15951.4 16100.3 16114.8 15419.2 15468.9 15502.8 15533.0 15909.2 14675.2 14931.9 15213.9 15697.5 15745.0 14927.5 14940.6 15548.3 15625.7 15650.0 10515.0 10526.0 10768.5 10943.2 11053.0 11054.7 11144.8 11221.0 11346.3 11374.0 17:36:39 INFO - PROCESS | 3440 | -------- Summary: end -------- 17:36:39 INFO - PROCESS | 3440 | 17:36:40 INFO - TEST-INFO | 3440: exit 0 17:36:40 INFO - TEST-OK | dromaeo_css | took 1114267ms 17:36:40 INFO - TEST-START | kraken 17:36:40 INFO - operating with platform_type : linux_ 17:36:40 INFO - Initialising browser for kraken test... 17:36:40 INFO - TEST-INFO | started process 3635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIKjEm/profile http://localhost:55436/getInfo.html) 17:36:44 INFO - PROCESS | 3635 | __metrics Screen width/height:1600/1200 17:36:44 INFO - PROCESS | 3635 | colorDepth:24 17:36:44 INFO - PROCESS | 3635 | Browser inner width/height: 1024/697 17:36:44 INFO - PROCESS | 3635 | __metrics 17:36:45 ERROR - PROCESS | 3635 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:36:45 INFO - TEST-INFO | 3635: exit 0 17:36:45 INFO - Browser initialized. 17:36:45 INFO - Running cycle 1/1 for kraken test... 17:36:45 INFO - TEST-INFO | started process 3726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxIKjEm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:57 INFO - PROCESS | 3726 | RSS: Main: 149131264 17:36:57 INFO - PROCESS | 3726 | 17:37:00 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55436/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:00 INFO - PROCESS | 3726 | RSS: Main: 198291456 17:37:00 INFO - PROCESS | 3726 | 17:37:03 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55436/tests/kraken/driver.html?testName=audio-dft) 17:37:04 INFO - PROCESS | 3726 | RSS: Main: 194244608 17:37:04 INFO - PROCESS | 3726 | 17:37:07 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55436/tests/kraken/driver.html?testName=audio-fft) 17:37:07 INFO - PROCESS | 3726 | RSS: Main: 280506368 17:37:07 INFO - PROCESS | 3726 | 17:37:09 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55436/tests/kraken/driver.html?testName=audio-oscillator) 17:37:10 INFO - PROCESS | 3726 | RSS: Main: 189509632 17:37:10 INFO - PROCESS | 3726 | 17:37:12 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:12 INFO - PROCESS | 3726 | RSS: Main: 189825024 17:37:12 INFO - PROCESS | 3726 | 17:37:15 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55436/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:16 INFO - PROCESS | 3726 | RSS: Main: 224366592 17:37:16 INFO - PROCESS | 3726 | 17:37:19 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55436/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:20 INFO - PROCESS | 3726 | RSS: Main: 224911360 17:37:20 INFO - PROCESS | 3726 | 17:37:23 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55436/tests/kraken/driver.html?testName=json-parse-financial) 17:37:23 INFO - PROCESS | 3726 | RSS: Main: 224571392 17:37:23 INFO - PROCESS | 3726 | 17:37:25 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:26 INFO - PROCESS | 3726 | RSS: Main: 203730944 17:37:26 INFO - PROCESS | 3726 | 17:37:27 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:28 INFO - PROCESS | 3726 | RSS: Main: 204320768 17:37:28 INFO - PROCESS | 3726 | 17:37:30 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:31 INFO - PROCESS | 3726 | RSS: Main: 209096704 17:37:31 INFO - PROCESS | 3726 | 17:37:33 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:34 INFO - PROCESS | 3726 | RSS: Main: 214872064 17:37:34 INFO - PROCESS | 3726 | 17:37:36 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:37 INFO - PROCESS | 3726 | RSS: Main: 214007808 17:37:37 INFO - PROCESS | 3726 | 17:37:38 INFO - PROCESS | 3726 | Cycle 1(1): loaded http://localhost:55436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55436/tests/kraken/driver.html?testName=ai-astar) 17:37:39 INFO - PROCESS | 3726 | RSS: Main: 256270336 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | __start_tp_report 17:37:39 INFO - PROCESS | 3726 | _x_x_mozilla_page_load 17:37:39 INFO - PROCESS | 3726 | _x_x_mozilla_page_load_details 17:37:39 INFO - PROCESS | 3726 | |i|pagename|runs| 17:37:39 INFO - PROCESS | 3726 | |0;ai-astar;110;104;110;109;111;111;111;110;109;109 17:37:39 INFO - PROCESS | 3726 | |1;audio-beat-detection;147;130;126;170;131;132;153;130;149;131 17:37:39 INFO - PROCESS | 3726 | |2;audio-dft;160;161;159;161;159;161;160;160;161;161 17:37:39 INFO - PROCESS | 3726 | |3;audio-fft;72;74;87;110;75;75;73;75;102;75 17:37:39 INFO - PROCESS | 3726 | |4;audio-oscillator;84;84;110;83;84;84;122;84;85;120 17:37:39 INFO - PROCESS | 3726 | |5;imaging-gaussian-blur;116;116;117;117;117;117;116;117;117;116 17:37:39 INFO - PROCESS | 3726 | |6;imaging-darkroom;146;146;145;144;146;144;145;145;146;146 17:37:39 INFO - PROCESS | 3726 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;94;95 17:37:39 INFO - PROCESS | 3726 | |8;json-parse-financial;50;51;51;51;52;51;53;52;55;51 17:37:39 INFO - PROCESS | 3726 | |9;json-stringify-tinderbox;65;60;60;59;59;58;59;59;61;59 17:37:39 INFO - PROCESS | 3726 | |10;stanford-crypto-aes;76;81;79;76;78;77;77;78;127;77 17:37:39 INFO - PROCESS | 3726 | |11;stanford-crypto-ccm;121;118;116;116;116;118;127;121;119;127 17:37:39 INFO - PROCESS | 3726 | |12;stanford-crypto-pbkdf2;152;159;154;153;159;153;152;151;153;153 17:37:39 INFO - PROCESS | 3726 | |13;stanford-crypto-sha256-iterative;60;61;64;59;60;60;60;61;61;59 17:37:39 INFO - PROCESS | 3726 | __end_tp_report 17:37:39 INFO - PROCESS | 3726 | __start_cc_report 17:37:39 INFO - PROCESS | 3726 | _x_x_mozilla_cycle_collect,1587 17:37:39 INFO - PROCESS | 3726 | __end_cc_report 17:37:39 INFO - PROCESS | 3726 | __startTimestamp1467419859183__endTimestamp 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | ------- Summary: start ------- 17:37:39 INFO - PROCESS | 3726 | Number of tests: 14 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.07 (1.9%) stddev-sans-first:2.18 17:37:39 INFO - PROCESS | 3726 | Values: 110.0 104.0 110.0 109.0 111.0 111.0 111.0 110.0 109.0 109.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:139.50 stddev:14.22 (10.2%) stddev-sans-first:14.85 17:37:39 INFO - PROCESS | 3726 | Values: 147.0 130.0 126.0 170.0 131.0 132.0 153.0 130.0 149.0 131.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 17:37:39 INFO - PROCESS | 3726 | Values: 160.0 161.0 159.0 161.0 159.0 161.0 160.0 160.0 161.0 161.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:13.54 (18.1%) stddev-sans-first:13.89 17:37:39 INFO - PROCESS | 3726 | Values: 72.0 74.0 87.0 110.0 75.0 75.0 73.0 75.0 102.0 75.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:84.00 stddev:16.39 (19.5%) stddev-sans-first:16.98 17:37:39 INFO - PROCESS | 3726 | Values: 84.0 84.0 110.0 83.0 84.0 84.0 122.0 84.0 85.0 120.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:37:39 INFO - PROCESS | 3726 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 17:37:39 INFO - PROCESS | 3726 | Values: 146.0 146.0 145.0 144.0 146.0 144.0 145.0 145.0 146.0 146.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:37:39 INFO - PROCESS | 3726 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:51.50 stddev:1.42 (2.8%) stddev-sans-first:1.36 17:37:39 INFO - PROCESS | 3726 | Values: 50.0 51.0 51.0 51.0 52.0 51.0 53.0 52.0 55.0 51.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.50 stddev:1.97 (3.3%) stddev-sans-first:0.87 17:37:39 INFO - PROCESS | 3726 | Values: 65.0 60.0 60.0 59.0 59.0 58.0 59.0 59.0 61.0 59.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:77.50 stddev:15.67 (20.2%) stddev-sans-first:16.44 17:37:39 INFO - PROCESS | 3726 | Values: 76.0 81.0 79.0 76.0 78.0 77.0 77.0 78.0 127.0 77.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#11] stanford-crypto-ccm Cycles:10 Average:119.90 Median:120.00 stddev:4.18 (3.5%) stddev-sans-first:4.41 17:37:39 INFO - PROCESS | 3726 | Values: 121.0 118.0 116.0 116.0 116.0 118.0 127.0 121.0 119.0 127.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:153.00 stddev:2.81 (1.8%) stddev-sans-first:2.89 17:37:39 INFO - PROCESS | 3726 | Values: 152.0 159.0 154.0 153.0 159.0 153.0 152.0 151.0 153.0 153.0 17:37:39 INFO - PROCESS | 3726 | 17:37:39 INFO - PROCESS | 3726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.50 stddev:1.43 (2.4%) stddev-sans-first:1.51 17:37:39 INFO - PROCESS | 3726 | Values: 60.0 61.0 64.0 59.0 60.0 60.0 60.0 61.0 61.0 59.0 17:37:39 INFO - PROCESS | 3726 | -------- Summary: end -------- 17:37:39 INFO - PROCESS | 3726 | 17:37:40 INFO - TEST-INFO | 3726: exit 0 17:37:40 INFO - TEST-OK | kraken | took 59742ms 17:37:40 INFO - SUITE-END | took 1174s 17:37:40 INFO - Completed test suite (00:19:34) 17:37:40 INFO - javascript benchmark 17:37:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3400.8979730608085, 3428.348613763383, 3428.8799892003785, 3456.6543345665423, 3482.6865582097607, 5613.522850557702, 5668.348139963905, 5671.120976248678, 5678.886422271562, 5711.400302968191, 5609.467100625444, 5662.433756624336, 5668.319801623811, 5673.432656734335, 5682.659040457575, 4902.852914412556, 4960.379952505937, 5110.463401342852, 5116.386033675964, 5131.3842338919385, 5040.445550989388, 5040.798368065273, 5066.670666406671, 5081.28861959326, 5084.618653600976, 5070.3915530136255, 5143.27994080829, 5186.0, 5215.504527069922, 5230.947690523103, 5284.2073688946775, 5284.894302113936, 5298.973505132488, 5302.443243459439, 5326.467353264681, 4976.178930476503, 5032.84901452957, 5057.696538207682, 5181.4041385240425, 5199.376074871002, 5474.0, 5480.588955828289, 5483.725813709339, 5500.532454741352, 5536.806211782568, 6071.0, 6085.878282434371, 6090.731517237602, 6118.510519158456, 6125.081237814319, 6050.152978583002, 6076.360358745286, 6120.816375508742, 6130.233720784902, 6137.815865524041, 5734.942650573483, 5745.052066409079, 5784.363719990798, 5786.508146807484, 5793.217915581385, 6020.939790602038, 6266.060090986297, 6278.152449419361, 6286.497080233662, 6287.339829317947, 5889.94110058894, 5958.553108516879, 5980.970095149496, 6018.789342373084, 6032.3967603239325, 6075.759844288032, 6080.878382432326, 6082.118092876508, 6082.635041897501, 6108.1143234230785, 5880.176775251468, 5885.499732522698, 6057.0, 6059.666718330446, 6067.180930574405, 5932.7330270137945, 6002.819915402545, 6007.939920600826, 6012.428819262163, 6052.54605904559, 4576.130535198302, 4580.748058856728, 4593.931091033637, 4597.563231493003, 4600.562946520142, 4067.51189857219, 4076.5515793262716, 4095.4266402703647, 4125.876223713293, 4127.731697439657, 5731.111677689964, 5755.107958266475, 5758.193852860602, 5764.682942438122, 5775.768969241268, 6106.72519736604, 6112.959454150325, 6117.002738361962, 6126.5305104610325, 6134.681512609229, 5496.093144631171, 5662.292213473316, 5691.601587888891, 5707.143928410688, 5725.599208055396, 5263.868403289872, 5276.182191760283, 5280.6039547034125, 5282.154855223146, 5282.4717528246865, 6240.968795155995, 6296.33888441707, 6296.370362963667, 6304.716287767062, 6308.211473565804, 5941.1385349123275, 6028.156058151774, 6086.0, 6098.329183789869, 6169.938300616936, 6317.6841157941, 6317.983910786135, 6338.461230795434, 6373.075903993988, 6374.617522948638, 5806.593538452436, 6027.276726792813, 6033.396660334107, 6040.607360521552, 6040.909386359121, 5891.027980383189, 5932.614380065282, 5977.521798256216, 6018.9398106020135, 6021.187139736079, 5869.0, 5874.118882167538, 5875.265591801025, 5876.529877609866, 5880.382559831156, 5722.542196624343, 5807.274090738658, 5809.564282678732, 5874.823755287348, 5879.412058794257, 5751.281089863767, 5815.476607105381, 5820.912686309624, 5826.592138550261, 5857.326407463196, 6010.789622363196, 6010.909836352545, 6051.243594550681, 6052.788152414644, 6062.969685151546, 5643.322801263875, 5765.91351129725, 5809.883802324014, 5847.181394604674, 5860.560457965755], "value": 5584.9965090724745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.9726412311445, 636.4049613611273, 649.3474058571138, 654.2084078265299, 656.5502630697971, 33561.16097097574, 46752.532474675245, 47798.283025754645, 47881.0, 47926.76036619812, 49802.252966205444, 50183.749081254544, 50233.49766502334, 50256.24615630759, 50298.49701502984, 8482.575871206445, 9124.54377281135, 9329.95335023324, 9330.160285574297, 10900.563977440894, 11018.228723989325, 11088.33469991803, 11112.055475284611, 11131.0, 11155.442227888614, 11126.109911207084, 11170.609028683997, 11181.83227251592, 11184.38485883276, 11190.720231994184, 8573.18554737296, 11050.834237486444, 11137.164712646543, 11297.435128243636, 11307.943460282646, 10716.785664286748, 11099.83350249747, 11113.888861111367, 11130.109591232764, 11133.387663678495, 46404.535954640356, 46824.29763553549, 46929.0, 47008.52991470076, 47025.764871175765, 3855.7879316637573, 3930.508686414198, 3961.3859851723028, 4027.97986010071, 4313.676474264443, 35217.47173792395, 36422.453663195076, 36491.817540912125, 36622.0, 36789.0, 4804.0, 4813.109574728686, 4868.367112275417, 4920.852374428773, 4959.876003099916, 386590.0, 390568.0, 391095.0, 391154.0, 392223.0, 35499.29001419957, 63931.36068639347, 64343.35656643374, 64376.67811660912, 64501.677491612245, 42000.369994450106, 42182.367264491055, 42220.57779422228, 42267.0, 42419.15161696749, 17512.38706645261, 17740.645187096186, 17761.555961101076, 17763.289468421117, 17781.1998460067, 13711.314434278247, 14985.250737463084, 15228.619284517976, 15243.847561524242, 15727.0, 8702.648675662169, 8704.260137888225, 8707.390482666153, 8722.520261385685, 8779.0, 3648.21563363878, 3668.248009158116, 3673.559172899269, 3729.9627003730157, 3754.6808521276, 1106.4246591772232, 1108.5953626926275, 1146.691794173798, 1147.386148410613, 1148.9770204595861, 32307.35385292281, 34198.316033679184, 34313.0, 34502.654973450444, 34818.30363392718, 1200.699825043739, 1210.328267811373, 1218.4090716002731, 1235.7775600391835, 1309.12942892977, 18320.908395458206, 18370.35703750362, 18453.169607367432, 18553.44339669812, 18664.720029199572, 600649.0, 605357.0, 608472.0, 613206.0, 621439.0, 67747.66126169337, 68288.31711682919, 68388.6580567104, 68400.0, 68532.31467685259, 1342.7180292138564, 1482.9332680029424, 1502.353987785263, 1513.379514399113, 1531.5788158256346, 34550.82724586361, 35246.47130292996, 35892.461613075306, 36586.8170659145, 36906.07734806544, 58839.70580147072, 59424.40575594362, 59638.40361596502, 59651.701741491015, 59685.40314596798, 423300.53398932464, 424798.0, 425143.0, 425677.0, 426380.0, 26934.191974240803, 29129.1261262154, 31783.0, 32107.518387223743, 33929.151771205914, 53690.73154634202, 53891.0, 53933.730331348095, 54255.0, 54778.72610636921, 44772.0, 45369.54630453653, 45595.77202114101, 46232.0, 46961.29558056564, 43847.56152438562, 44635.330470042325, 44636.776816115715, 46079.0, 46136.0011599245, 44727.77636111798, 45210.0, 45702.0, 46007.53992460033, 46454.76772616115, 38430.231395372495, 39835.80082099571, 40142.1971560573, 40329.1934161321, 41059.1788164241, 30192.19430502333, 30300.848495757382, 30349.0, 30457.0, 30762.84618576893], "value": 21144.004819047484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.9388091786233, 427.4421879447322, 429.2123952547076, 430.88581525895626, 444.6509490050311, 18334.174962126704, 19221.807781922194, 19670.0, 19735.802641973576, 20041.899790501044, 19022.90488547559, 19454.610907781836, 19522.804771952276, 19791.40625781229, 19799.109040093193, 5623.718814059301, 5837.474627283565, 5874.060150375941, 5885.32318783339, 5886.911696324559, 4317.525072242051, 5151.918097199593, 5729.0260655688635, 5785.0, 6462.903056454157, 6366.84082897929, 6431.581947173442, 6466.321036291192, 6520.315366886456, 6543.541952063358, 6324.494040476751, 6370.076338930852, 6437.356264373572, 6460.547761656686, 6485.383888530582, 3884.514435695538, 5416.160495123262, 5717.542596592262, 5823.563232757518, 5839.8540036499, 22580.322590322317, 22761.54476910469, 22773.08907643709, 22776.658350124762, 22846.54306913869, 2470.8270421070533, 2504.048461584586, 2688.90588829392, 2833.1783782703196, 2955.143008527524, 13895.652608684763, 15049.699006019928, 15498.690026199525, 15543.533693989199, 15555.688886222326, 2183.3777373448493, 2186.9781302186934, 2194.6488561830192, 2205.9558808823895, 2207.845450818443, 76091.61954190194, 77468.0, 77551.61224193843, 86281.0, 91263.54368228116, 9183.816323673624, 9757.853632195523, 9788.951055244679, 9814.46020468881, 10326.070653641209, 12686.0, 12689.0, 12701.555445559547, 12756.234625922474, 12770.23378597287, 8021.558814265271, 8117.107118216992, 8142.226488483585, 8322.70870519529, 8615.095414981337, 8578.571071446402, 8659.567021648892, 8681.826363472695, 8802.295816334678, 8809.603567839462, 4270.402143699823, 4312.9137417252105, 4334.349847522833, 4401.515833258339, 4421.29259318514, 1964.7347608073012, 2022.7774944756065, 2092.1213090502024, 2107.483666501717, 2114.0, 1001.7896241789306, 1045.9424731639833, 1066.2962444786558, 1111.3554138599593, 1120.1151090638305, 18387.448376548724, 18397.448076557725, 18655.813441865677, 19042.238310467703, 19139.2344306229, 1074.8387741838787, 1076.4025965589017, 1099.631623406152, 1105.5798796457295, 1112.2436743014666, 10223.284370094021, 10599.470026498644, 10659.73350666224, 10721.172003896085, 10753.51609177589, 546062.0, 547043.0, 550017.0, 567053.0, 575059.0, 91310.54344728366, 91445.54277228571, 91571.5421422902, 92257.538712306, 93095.53452232831, 1073.8335557988523, 1108.4070022537903, 1115.0689174539189, 1131.8924702153283, 1137.7724455109012, 16189.352425902833, 16650.916745416194, 17085.65828683444, 17209.0, 17371.218295176495, 29712.851435742683, 34391.656083438844, 42593.36109958291, 42768.57231427646, 43856.56143438525, 39362.60637393704, 55632.443675562725, 57410.42589574051, 59913.400865990785, 60576.69711651414, 7780.649870755943, 7957.363410927228, 8006.799830004296, 8833.823323533621, 9006.50464224474, 9466.621335146518, 10667.199960003187, 12124.72690367534, 12784.48862045545, 12856.807147892601, 11007.0, 11417.657470275904, 11490.195686301879, 11736.413179341169, 11836.644900652995, 11619.709507262387, 11794.233374830608, 11912.463939122586, 11916.880831191924, 11929.164958452826, 11184.664460066211, 11356.772864542829, 11371.886281137413, 11467.885321146681, 11517.769644607228, 8041.67833286662, 8147.429679922348, 8159.959200203961, 8176.877346839683, 8282.627281772215, 8416.537090459839, 10440.63457778974, 11176.105911526896, 11230.382328971658, 11395.14536409756], "value": 9359.914303116351, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.9306034698263, 1563.1558958162595, 1594.2268000019988, 1842.972355414669, 1918.405294358749, 8086.191380861911, 9141.0, 9447.244220462364, 9466.952665236673, 9765.169960553343, 9346.532673366339, 9559.091886270793, 9561.378510396837, 9567.904320956788, 9577.042295770438, 2449.252977841762, 2475.579151544233, 2480.131953816168, 2481.1936120760824, 2482.2429159106464, 2435.488547405047, 2490.22802931091, 2490.887910044052, 2491.5888878335054, 2492.6884139482563, 2385.2367242482414, 2417.758224177577, 2445.877706114687, 2447.5104979004273, 2453.0800949643885, 2356.6229403295474, 2372.96440553391, 2381.226101517005, 2411.867347295898, 2412.541617092747, 2337.0885354711677, 2356.929292121239, 2373.2049763329305, 2374.6675465434855, 2375.5367703297866, 7931.325837303836, 9068.682596109105, 9413.105754953269, 9478.90521094787, 9483.620655173785, 5346.518813306782, 5467.808626698086, 5542.140968149944, 5544.390117087117, 5550.028744969614, 3597.244578638463, 3602.369585322558, 3673.5959044505084, 3682.650148235913, 3738.2336620992633, 1131.8189089745683, 1134.6879608107836, 1180.6694125644833, 1197.114135539703, 1206.6681662542783, 13242.073054886161, 13524.053316267866, 13531.255780932044, 13536.661583460493, 13567.389467473988, 4917.606591472673, 4931.334269873521, 4976.4525902150735, 4992.425871024879, 5062.417821950449, 11217.0, 11262.099032077414, 11268.887311126948, 11272.154588405903, 11273.041791447655, 5678.375378708339, 5751.971240143773, 5760.020796464527, 5760.53915686744, 5761.8559536011935, 5099.668521546162, 5185.0148471790235, 5269.762860671279, 5349.117395629678, 5352.277442545206, 4145.91708165841, 4204.348326009474, 4232.174725928415, 4262.296721041055, 4272.359146128106, 1284.9486020559073, 1311.6065180445828, 1320.1748906933167, 1320.4784110276387, 1331.633800704814, 950.9714708558754, 997.4314640654902, 1079.3739631013993, 1100.8183649697871, 1104.7072525780675, 6519.622454048684, 6545.770898018546, 6573.769918052941, 6623.2383275923885, 6726.899096513458, 1009.1724785675675, 1033.3076838518211, 1039.184240371305, 1064.9893501065046, 1095.118429664128, 4534.841280555231, 4602.470715867651, 4696.060787842445, 4707.176244157259, 4836.927446088312, 11721.531138754524, 11980.041596672245, 11990.280583165038, 12006.579769708018, 12025.759484810254, 11177.552897884156, 11686.94156529212, 11711.590094346657, 11838.230515016496, 11870.703232419259, 8777.605007774666, 8900.109989001177, 8902.198802107712, 8915.37592368528, 8974.14745599167, 6582.111414958919, 6776.792868838926, 6825.453963682993, 6922.896156557555, 6955.513114081966, 10759.515821787882, 10996.23026388145, 11114.16643751738, 11175.21773475849, 11180.04969577595, 11127.109831213646, 11190.776184476428, 11291.717707057061, 11304.491297891778, 11372.943135284602, 8482.703105391281, 8549.87175192385, 8551.786205344915, 8630.741077767678, 8632.697855575025, 8590.098039705741, 8787.5166865823, 8816.250618697226, 9068.727938161603, 9076.818463630823, 7969.442139050443, 8035.397345199251, 8043.3967452442475, 8098.51408915467, 8165.836683266421, 7700.0, 7925.0, 7950.562719050507, 8014.398920080901, 8146.103928567972, 7504.399648028254, 7539.773806785805, 7566.281203285679, 7575.545467271982, 7582.241775822595, 5539.556835453234, 5658.349289831722, 5660.632058916157, 5742.913856292243, 5765.942340576708, 5721.141828725558, 5769.682667453162, 5832.445917637818, 5878.764849405976, 5931.91307672066], "value": 4997.135199446644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.45935610769146, 354.62586970745866, 356.72353925707574, 365.5229924947945, 366.26198210605634, 5254.663288811604, 5370.650907690997, 5437.3475182978045, 5446.7276636168135, 5467.5899307551945, 5295.894082118355, 5359.866003349918, 5367.946320536794, 5384.707670159163, 5439.156930675742, 4260.893477663052, 4260.914781704357, 4277.422547956033, 4282.14357128574, 4300.548442413533, 4006.717850287909, 4149.240754897989, 4227.266820603553, 4281.67887408444, 4315.158544083905, 4176.519700234481, 4182.414461975311, 4188.554948542748, 4204.978975105136, 4227.682923780713, 4212.389203565481, 4218.595400621647, 4230.830766769325, 4237.216115018731, 4266.509351424595, 3692.593814680383, 3753.9249215015548, 3793.487879136309, 3796.1079146400575, 3806.8667596634264, 5160.870978225536, 5167.0, 5180.948190518122, 5180.974095129538, 5205.7397130143345, 4764.309175169616, 4809.254565542312, 4817.494163112893, 4833.139241392054, 4837.201861692816, 5479.041317688443, 5563.0, 5570.498655121018, 5637.210790489335, 5653.745581448845, 4082.5305089914445, 4087.89780255493, 4089.3661482469965, 4095.2833254180696, 4127.380892866094, 5807.0, 5862.267216597926, 5880.5883588148845, 5895.793647222326, 5910.822675319747, 4007.2786898358577, 4188.434561334181, 4197.643200327945, 4197.916041679149, 4206.810693518799, 4201.852935147255, 4227.42929704486, 4232.449781528443, 4242.406063151161, 4242.469691288589, 4870.342503762017, 4871.464138944713, 4895.118878601886, 4909.410870695539, 4915.3855768029, 5539.529140023144, 5696.487316141567, 5708.543316534668, 5744.942550574441, 5766.567507436959, 1386.4662105089612, 1420.2117824607442, 1441.9329696025077, 1444.6388402899274, 1449.282605110477, 924.7238810441547, 937.7608709778963, 938.8170904660177, 943.4763706143019, 949.3734135470556, 4822.638302127354, 4880.194767863263, 4925.473103337977, 4928.250471082786, 4969.130402179677, 5206.479352064764, 5230.738463076831, 5243.842684719464, 5251.789928402897, 5259.789608415697, 4555.180067587799, 4857.757112144379, 4965.577925876269, 4973.403191617029, 4981.252812078144, 2728.7953403494816, 2761.765249953736, 2767.1560174146675, 2770.224337185591, 2773.8364076020735, 5267.2889159962915, 5267.815626453133, 5289.444608316148, 5312.893742125136, 5353.4646535346155, 4806.831760888352, 5150.4849515048945, 5168.2169651470185, 5199.63602547818, 5218.478152184751, 5198.376194856642, 5213.582913366921, 5236.607254455931, 5265.4997775211295, 5289.656172348862, 5037.722925239001, 5082.237664350377, 5089.287499749964, 5122.642499737498, 5124.0, 4881.609471242363, 5054.317667114892, 5067.402144477463, 5072.289879416959, 5089.211172268157, 5081.932794113278, 5164.04465173944, 5213.869653258547, 5296.364436267672, 5312.6452754547345, 3799.430085487199, 3830.8659196927974, 3840.481534992852, 3842.8270727817876, 3844.020329530238, 4968.403791545038, 5073.097588404348, 5213.40045894727, 5595.300587426572, 5743.827685169452, 5677.858053548694, 5697.800576979786, 5700.287464066992, 5742.569307301886, 5748.511376533042, 5664.603477756517, 5703.401142879938, 5705.686187259741, 5730.570207234391, 5766.4233576642, 5530.751116199861, 5626.915596265977, 5654.46282603152, 5667.291588551431, 5670.092785154356, 5758.481736643722, 5792.943505055645, 5806.477417032487, 5814.592978491465, 5821.912671310019, 5419.0, 5586.217929489956, 5598.888022239614, 5626.831195064155, 5691.345495268097], "value": 4173.44509948536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.9477433966791, 812.20404004076, 848.8769128476367, 865.7748985263831, 878.2403221213648, 15559.922200388997, 16181.110038947852, 16410.67178656426, 16413.589660258483, 16463.83536164638, 14183.759145975764, 14440.855591444082, 14934.626634334147, 14952.0, 14962.25188740564, 732.0190944134858, 878.4860856398982, 894.4007514964973, 907.469130558624, 912.8904531456235, 893.120276527623, 895.3821862914568, 901.7520181949951, 901.8241442918634, 902.4269588811087, 937.5874615169304, 945.9763505912339, 947.9573419196118, 948.2319321349729, 948.4498990585444, 746.1121265693835, 916.2852974679761, 930.7766136127315, 933.6312156698134, 934.0146145816161, 686.1251903822616, 686.6875571614953, 687.1650944102889, 687.5633972427495, 687.5977553131424, 15206.619834504116, 15227.162506062163, 15235.324114347413, 15242.542723718196, 15251.466198683103, 14649.487267945571, 14872.62818429537, 14895.0, 14903.32935017916, 15408.614784630361, 13393.933030334883, 13432.0, 13472.865271347357, 13523.729525409437, 13779.242141682204, 4660.953390466086, 4715.3869996900185, 4799.520047995207, 4799.712017278975, 4811.326414302001, 75891.0, 75940.0, 76148.61925690336, 76298.0, 77105.0, 12032.518699252107, 12179.87820121805, 12265.386730663431, 12385.814212786816, 12487.687807804696, 22305.553888922455, 22340.88829555842, 22348.32955011352, 22363.0, 22366.217182398865, 8817.0, 8964.193222609996, 8976.102389760972, 9019.413738107001, 9054.954725226331, 4855.878603034952, 4979.766579678795, 4985.576226020757, 5104.41299250591, 5131.0, 3468.618451970281, 3559.6796288333658, 3564.465330200439, 3566.946495802565, 3982.522097348337, 602.286290745468, 715.7137145141985, 738.2101151767557, 742.6806473216461, 758.0865057605682, 637.8150336402391, 684.6063513479769, 715.73315232039, 736.5102207032371, 752.2327226229215, 10287.434191119411, 10310.793784124275, 10482.63310784119, 10582.523786429629, 10701.357918524913, 787.169536139367, 808.2887059387701, 815.9306458950937, 818.8280461103116, 829.7054545636212, 4987.1771157759285, 5027.644087347364, 5029.385396951844, 5040.59675225981, 5057.266696329012, 71962.2803771966, 72350.63824680843, 72447.0, 75550.62224688951, 123607.38196309141, 91183.0, 98475.0, 103526.0, 103734.0, 105144.0, 87039.0, 87348.0, 87739.0, 88396.5580172095, 89228.5538572303, 9775.413475191512, 9869.963653816532, 9879.50602469888, 9880.35777674449, 9998.100170984355, 56004.0, 56202.1569676447, 56392.718036409555, 56430.43569564252, 57505.13742293953, 66649.66675166594, 67882.3211767876, 76139.61930190313, 81229.59385203036, 81808.0, 13449.798253026409, 13633.250171240677, 13680.589582312547, 13725.382357794122, 14047.789283160557, 15187.924060379628, 15669.216539172769, 15951.44169954046, 16100.27548760332, 16114.758278626065, 15419.229038548252, 15468.92265538665, 15502.844971550592, 15533.0, 15909.204539773196, 14675.19286439256, 14931.92534037323, 15213.923930380277, 15697.529074127795, 15745.0, 14927.477538286108, 14940.626484337978, 15548.300326485562, 15625.687486249984, 15650.0, 10515.0, 10526.0, 10768.523239654767, 10943.179261555575, 11053.0, 11054.741512230661, 11144.832827507431, 11221.0, 11346.262492937933, 11374.0], "value": 7971.5201886833065, "unit": "score"}], "name": "dromaeo_css", "value": 7540.16048408473, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 111.0, 111.0, 111.0, 110.0, 109.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 130.0, 126.0, 170.0, 131.0, 132.0, 153.0, 130.0, 149.0, 131.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 161.0, 159.0, 161.0, 160.0, 160.0, 161.0, 161.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 87.0, 110.0, 75.0, 75.0, 73.0, 75.0, 102.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 83.0, 84.0, 84.0, 122.0, 84.0, 85.0, 120.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 144.0, 146.0, 144.0, 145.0, 145.0, 146.0, 146.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 51.0, 52.0, 51.0, 53.0, 52.0, 55.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 59.0, 59.0, 58.0, 59.0, 59.0, 61.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 81.0, 79.0, 76.0, 78.0, 77.0, 77.0, 78.0, 127.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 118.0, 116.0, 116.0, 116.0, 118.0, 127.0, 121.0, 119.0, 127.0], "value": 119.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 159.0, 154.0, 153.0, 159.0, 153.0, 152.0, 151.0, 153.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 64.0, 59.0, 60.0, 60.0, 60.0, 61.0, 61.0, 59.0], "value": 60.5, "unit": "score"}], "name": "kraken", "value": 1470.7000000000003, "alertThreshold": 2.0}]} 17:37:40 INFO - Return code: 0 17:37:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:37:40 ERROR - # TBPL SUCCESS # 17:37:40 INFO - Running post-action listener: _resource_record_post_action 17:37:40 INFO - ##### 17:37:40 INFO - ##### Finished run-tests step (success) 17:37:40 INFO - ##### 17:37:40 INFO - Running post-run listener: _resource_record_post_run 17:37:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 7921664; Write bytes: 385609728; Read time: 1024; Write time: 371488 17:37:40 INFO - TinderboxPrint: CPU usage
13.1% 17:37:40 INFO - TinderboxPrint: I/O read bytes / time
7,921,664 / 1,024 17:37:40 INFO - TinderboxPrint: I/O write bytes / time
385,609,728 / 371,488 17:37:40 INFO - TinderboxPrint: CPU idle
8,255.4 (86.8%) 17:37:40 INFO - TinderboxPrint: CPU user
1,203.4 (12.7%) 17:37:40 INFO - TinderboxPrint: Swap in / out
0 / 0 17:37:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 9277440; Read time: 0; Write time: 2628 17:37:40 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 6160384; Write bytes: 376332288; Read time: 992; Write time: 368860 17:37:41 INFO - Running post-run listener: _upload_blobber_files 17:37:41 INFO - Blob upload gear active. 17:37:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:41 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 17:37:41 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'] 17:37:41 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 17:37:41 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:37:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:47 INFO - (blobuploader) - INFO - Done attempting. 17:37:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:37:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:48 INFO - (blobuploader) - INFO - Done attempting. 17:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:37:48 INFO - (blobuploader) - INFO - Done attempting. 17:37:48 INFO - (blobuploader) - INFO - Iteration through files over. 17:37:48 INFO - Return code: 0 17:37:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:37:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:37:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e55ae7ea32212bbeefe8ed515e4b35da4963ee26b73564ddf2da53e48a1bda3396a44431600dc111c4dedc7c3f90358d26ac8bb1ad72a3bc640443af756a27d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/531550478e1fc09f552e4116f44c259de5ddfe446644dd30928e193ab1b4f9add7b966b48005f440ee941dc33ecf0229c2c63c4baff19f652f0f03709b4b296d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc5cd052e8aa4863aaae95cf077e2f7e8c0019e5c9c6f293d1360504c68a72024d01918e9b31c041aa171c873b4180070816515085e4a106bf41d8eae904198f"} 17:37:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:37:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:37:48 INFO - Contents: 17:37:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6e55ae7ea32212bbeefe8ed515e4b35da4963ee26b73564ddf2da53e48a1bda3396a44431600dc111c4dedc7c3f90358d26ac8bb1ad72a3bc640443af756a27d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/531550478e1fc09f552e4116f44c259de5ddfe446644dd30928e193ab1b4f9add7b966b48005f440ee941dc33ecf0229c2c63c4baff19f652f0f03709b4b296d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc5cd052e8aa4863aaae95cf077e2f7e8c0019e5c9c6f293d1360504c68a72024d01918e9b31c041aa171c873b4180070816515085e4a106bf41d8eae904198f"} 17:37:48 INFO - Running post-run listener: copy_logs_to_upload_dir 17:37:48 INFO - Copying logs to upload dir... 17:37:48 INFO - mkdir: /builds/slave/test/build/upload/logs 17:37:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.095856 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-01 17:37:49.206082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 17:37:49.213683) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961 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/6e55ae7ea32212bbeefe8ed515e4b35da4963ee26b73564ddf2da53e48a1bda3396a44431600dc111c4dedc7c3f90358d26ac8bb1ad72a3bc640443af756a27d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/531550478e1fc09f552e4116f44c259de5ddfe446644dd30928e193ab1b4f9add7b966b48005f440ee941dc33ecf0229c2c63c4baff19f652f0f03709b4b296d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc5cd052e8aa4863aaae95cf077e2f7e8c0019e5c9c6f293d1360504c68a72024d01918e9b31c041aa171c873b4180070816515085e4a106bf41d8eae904198f"} build_url:https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011042 build_url: 'https://queue.taskcluster.net/v1/task/VS8i01DMRmqN43O9WPwsJQ/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/6e55ae7ea32212bbeefe8ed515e4b35da4963ee26b73564ddf2da53e48a1bda3396a44431600dc111c4dedc7c3f90358d26ac8bb1ad72a3bc640443af756a27d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/531550478e1fc09f552e4116f44c259de5ddfe446644dd30928e193ab1b4f9add7b966b48005f440ee941dc33ecf0229c2c63c4baff19f652f0f03709b4b296d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc5cd052e8aa4863aaae95cf077e2f7e8c0019e5c9c6f293d1360504c68a72024d01918e9b31c041aa171c873b4180070816515085e4a106bf41d8eae904198f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 17:37:49.243761) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:37:49.244058) ========= 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=8887e36bb8e381bfd44124ac000001a8-1467416855.402309-543050961 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:37:49.293305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 17:37:49.293603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 17:37:49.293884) ========= ========= Total master_lag: 0.56 =========