builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1465384786.67 results: success (0) buildid: 20160608025830 builduid: 5272883740954f0b824b060112b7ada1 revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.670102) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.670541) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.670824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.685285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.685594) ========= 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=00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 04:19:46-- 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% 25.9M=0s 2016-06-08 04:19:47 (25.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114773 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.812668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.812981) ========= 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=00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019939 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:46.862842) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 04:19:46.863181) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8ad071a6e14331d73fa44c8d3108bc2b66b2174 --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=00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 04:19:47,128 truncating revision to first 12 chars 2016-06-08 04:19:47,129 Setting DEBUG logging. 2016-06-08 04:19:47,129 attempt 1/10 2016-06-08 04:19:47,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8ad071a6e14?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 04:19:48,112 unpacking tar archive at: mozilla-central-f8ad071a6e14/testing/mozharness/ program finished with exit code 0 elapsedTime=1.339660 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 04:19:48.216698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:48.217070) ========= script_repo_revision: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:48.217649) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:48.218052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 04:19:48.229775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-08 04:19:48.230148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:48 INFO - MultiFileLogger online at 20160608 04:19:48 in /builds/slave/test 04:19:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:19:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:48 INFO - {'append_to_log': False, 04:19:48 INFO - 'base_work_dir': '/builds/slave/test', 04:19:48 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:19:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:48 INFO - 'branch': 'Firefox-Non-PGO', 04:19:48 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:48 INFO - 'config_files': ('talos/linux_config.py',), 04:19:48 INFO - 'default_actions': ('clobber', 04:19:48 INFO - 'read-buildbot-config', 04:19:48 INFO - 'download-and-extract', 04:19:48 INFO - 'populate-webroot', 04:19:48 INFO - 'create-virtualenv', 04:19:48 INFO - 'install', 04:19:48 INFO - 'run-tests'), 04:19:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:48 INFO - 'download_minidump_stackwalk': True, 04:19:48 INFO - 'download_symbols': 'ondemand', 04:19:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:48 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:48 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:48 INFO - 'installer_path': 'installer.exe', 04:19:48 INFO - 'log_level': 'info', 04:19:48 INFO - 'log_name': 'talos', 04:19:48 INFO - 'log_to_console': True, 04:19:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:48 INFO - 'opt_config_files': (), 04:19:48 INFO - 'pip_index': False, 04:19:48 INFO - 'sps_profile': False, 04:19:48 INFO - 'sps_profile_interval': 0, 04:19:48 INFO - 'suite': 'dromaeojs', 04:19:48 INFO - 'system_bits': '32', 04:19:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:48 INFO - 'title': 'talos-linux64-ix-016', 04:19:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:48 INFO - 'use_talos_json': True, 04:19:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:48 INFO - 'work_dir': 'build'} 04:19:48 INFO - ##### 04:19:48 INFO - ##### Running clobber step. 04:19:48 INFO - ##### 04:19:48 INFO - Running pre-action listener: _resource_record_pre_action 04:19:48 INFO - Running main action method: clobber 04:19:48 INFO - rmtree: /builds/slave/test/build 04:19:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:49 INFO - Running post-action listener: _resource_record_post_action 04:19:49 INFO - ##### 04:19:49 INFO - ##### Finished clobber step (success) 04:19:49 INFO - ##### 04:19:49 INFO - ##### 04:19:49 INFO - ##### Running read-buildbot-config step. 04:19:49 INFO - ##### 04:19:49 INFO - Running pre-action listener: _resource_record_pre_action 04:19:49 INFO - Running main action method: read_buildbot_config 04:19:49 INFO - Using buildbot properties: 04:19:49 INFO - { 04:19:49 INFO - "project": "", 04:19:49 INFO - "product": "firefox", 04:19:49 INFO - "script_repo_revision": "production", 04:19:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:19:49 INFO - "repository": "", 04:19:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:19:49 INFO - "buildid": "20160608025830", 04:19:49 INFO - "pgo_build": "False", 04:19:49 INFO - "basedir": "/builds/slave/test", 04:19:49 INFO - "buildnumber": 522, 04:19:49 INFO - "slavename": "talos-linux64-ix-016", 04:19:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:19:49 INFO - "platform": "ubuntu64_hw", 04:19:49 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:19:49 INFO - "branch": "mozilla-central", 04:19:49 INFO - "repo_path": "mozilla-central", 04:19:49 INFO - "revision": "f8ad071a6e14331d73fa44c8d3108bc2b66b2174", 04:19:49 INFO - "stage_platform": "linux64", 04:19:49 INFO - "builduid": "5272883740954f0b824b060112b7ada1", 04:19:49 INFO - "slavebuilddir": "test" 04:19:49 INFO - } 04:19:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:19:49 INFO - Running post-action listener: _resource_record_post_action 04:19:49 INFO - ##### 04:19:49 INFO - ##### Finished read-buildbot-config step (success) 04:19:49 INFO - ##### 04:19:49 INFO - ##### 04:19:49 INFO - ##### Running download-and-extract step. 04:19:49 INFO - ##### 04:19:49 INFO - Running pre-action listener: _resource_record_pre_action 04:19:49 INFO - Running main action method: download_and_extract 04:19:49 INFO - mkdir: /builds/slave/test/build/tests 04:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:49 INFO - https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:19:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:19:49 INFO - Downloaded 1361 bytes. 04:19:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:49 INFO - Using the following test package requirements: 04:19:49 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:19:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:19:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'jsshell-linux-x86_64.zip'], 04:19:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:19:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:19:49 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:19:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:19:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:49 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:19:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:49 INFO - https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:19:50 INFO - Downloaded 22878189 bytes. 04:19:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:19:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:19:52 INFO - Return code: 0 04:19:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:52 INFO - https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:19:53 INFO - Downloaded 22878189 bytes. 04:19:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:19:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:19:54 INFO - Return code: 0 04:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:54 INFO - https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:19:55 INFO - Downloaded 10833369 bytes. 04:19:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:19:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:19:55 INFO - Return code: 0 04:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:55 INFO - https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:19:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:19:57 INFO - Downloaded 55302022 bytes. 04:19:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:57 INFO - mkdir: /builds/slave/test/properties 04:19:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:57 INFO - Contents: 04:19:57 INFO - build_url:https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:57 INFO - Running post-action listener: _resource_record_post_action 04:19:57 INFO - Running post-action listener: set_extra_try_arguments 04:19:57 INFO - ##### 04:19:57 INFO - ##### Finished download-and-extract step (success) 04:19:57 INFO - ##### 04:19:57 INFO - ##### 04:19:57 INFO - ##### Running populate-webroot step. 04:19:57 INFO - ##### 04:19:57 INFO - Running pre-action listener: _resource_record_pre_action 04:19:57 INFO - Running main action method: populate_webroot 04:19:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:57 INFO - '--tppagecycles', 04:19:57 INFO - '7'], 04:19:57 INFO - 'tests': ['tsvgm']}}, 04:19:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:19:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['damp', 'tps']}, 04:19:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'tests': ['damp', 'tps']}, 04:19:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['dromaeo_dom']}, 04:19:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['a11yr', 04:19:57 INFO - 'ts_paint', 04:19:57 INFO - 'tpaint', 04:19:57 INFO - 'sessionrestore', 04:19:57 INFO - 'sessionrestore_no_auto_restore', 04:19:57 INFO - 'tabpaint']}, 04:19:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tsvgx', 04:19:57 INFO - 'tsvgr_opacity', 04:19:57 INFO - 'tart', 04:19:57 INFO - 'tscrollx', 04:19:57 INFO - 'cart']}, 04:19:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:57 INFO - 'tsvgr_opacity', 04:19:57 INFO - 'tart', 04:19:57 INFO - 'tscrollx', 04:19:57 INFO - 'cart']}, 04:19:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s'], 04:19:57 INFO - 'tests': ['tp5o']}, 04:19:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'tests': ['tp5o']}, 04:19:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--disable-e10s', 04:19:57 INFO - '--xperf_path', 04:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:57 INFO - 'tests': ['tp5n']}, 04:19:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:57 INFO - 'talos_options': ['--xperf_path', 04:19:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:57 INFO - 'tests': ['tp5n']}}, 04:19:57 INFO - 'talos.zip': {'path': '', 04:19:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:57 INFO - Running post-action listener: _resource_record_post_action 04:19:57 INFO - ##### 04:19:57 INFO - ##### Finished populate-webroot step (success) 04:19:57 INFO - ##### 04:19:57 INFO - ##### 04:19:57 INFO - ##### Running create-virtualenv step. 04:19:57 INFO - ##### 04:19:57 INFO - Running pre-action listener: _resource_record_pre_action 04:19:57 INFO - Running main action method: create_virtualenv 04:19:57 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:19:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:58 INFO - Using real prefix '/usr' 04:19:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:00 INFO - Installing pip.................done. 04:20:00 INFO - Return code: 0 04:20:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:20:00 INFO - Using env: {'DISPLAY': ':0', 04:20:00 INFO - 'HOME': '/home/cltbld', 04:20:00 INFO - 'LANG': 'en_US.UTF-8', 04:20:00 INFO - 'LANGUAGE': 'en_US:en', 04:20:00 INFO - 'LOGNAME': 'cltbld', 04:20:00 INFO - 'MAIL': '/var/mail/cltbld', 04:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:00 INFO - 'MOZ_NO_REMOTE': '1', 04:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:00 INFO - 'NO_EM_RESTART': '1', 04:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:00 INFO - 'PWD': '/builds/slave/test', 04:20:00 INFO - 'SHELL': '/bin/bash', 04:20:00 INFO - 'SHLVL': '1', 04:20:00 INFO - 'TERM': 'linux', 04:20:00 INFO - 'TMOUT': '86400', 04:20:00 INFO - 'USER': 'cltbld', 04:20:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:00 INFO - '_': '/tools/buildbot/bin/python'} 04:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:20:00 INFO - Cleaning up... 04:20:00 INFO - Return code: 0 04:20:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:20:00 INFO - Using env: {'DISPLAY': ':0', 04:20:00 INFO - 'HOME': '/home/cltbld', 04:20:00 INFO - 'LANG': 'en_US.UTF-8', 04:20:00 INFO - 'LANGUAGE': 'en_US:en', 04:20:00 INFO - 'LOGNAME': 'cltbld', 04:20:00 INFO - 'MAIL': '/var/mail/cltbld', 04:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:00 INFO - 'MOZ_NO_REMOTE': '1', 04:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:00 INFO - 'NO_EM_RESTART': '1', 04:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:00 INFO - 'PWD': '/builds/slave/test', 04:20:00 INFO - 'SHELL': '/bin/bash', 04:20:00 INFO - 'SHLVL': '1', 04:20:00 INFO - 'TERM': 'linux', 04:20:00 INFO - 'TMOUT': '86400', 04:20:00 INFO - 'USER': 'cltbld', 04:20:00 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:00 INFO - '_': '/tools/buildbot/bin/python'} 04:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:00 INFO - Downloading/unpacking psutil>=3.1.1 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:03 INFO - Installing collected packages: psutil 04:20:03 INFO - Running setup.py install for psutil 04:20:03 INFO - building 'psutil._psutil_linux' extension 04:20:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:20:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:20:03 INFO - building 'psutil._psutil_posix' extension 04:20:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:20:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:20:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:03 INFO - Successfully installed psutil 04:20:03 INFO - Cleaning up... 04:20:03 INFO - Return code: 0 04:20:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:03 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:20:03 INFO - Using env: {'DISPLAY': ':0', 04:20:03 INFO - 'HOME': '/home/cltbld', 04:20:03 INFO - 'LANG': 'en_US.UTF-8', 04:20:03 INFO - 'LANGUAGE': 'en_US:en', 04:20:03 INFO - 'LOGNAME': 'cltbld', 04:20:03 INFO - 'MAIL': '/var/mail/cltbld', 04:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:03 INFO - 'MOZ_NO_REMOTE': '1', 04:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:03 INFO - 'NO_EM_RESTART': '1', 04:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:03 INFO - 'PWD': '/builds/slave/test', 04:20:03 INFO - 'SHELL': '/bin/bash', 04:20:03 INFO - 'SHLVL': '1', 04:20:03 INFO - 'TERM': 'linux', 04:20:03 INFO - 'TMOUT': '86400', 04:20:03 INFO - 'USER': 'cltbld', 04:20:03 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:03 INFO - '_': '/tools/buildbot/bin/python'} 04:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:20:05 INFO - Installing collected packages: mozsystemmonitor 04:20:05 INFO - Running setup.py install for mozsystemmonitor 04:20:06 INFO - Successfully installed mozsystemmonitor 04:20:06 INFO - Cleaning up... 04:20:06 INFO - Return code: 0 04:20:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:06 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:20:06 INFO - Using env: {'DISPLAY': ':0', 04:20:06 INFO - 'HOME': '/home/cltbld', 04:20:06 INFO - 'LANG': 'en_US.UTF-8', 04:20:06 INFO - 'LANGUAGE': 'en_US:en', 04:20:06 INFO - 'LOGNAME': 'cltbld', 04:20:06 INFO - 'MAIL': '/var/mail/cltbld', 04:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:06 INFO - 'MOZ_NO_REMOTE': '1', 04:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:06 INFO - 'NO_EM_RESTART': '1', 04:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:06 INFO - 'PWD': '/builds/slave/test', 04:20:06 INFO - 'SHELL': '/bin/bash', 04:20:06 INFO - 'SHLVL': '1', 04:20:06 INFO - 'TERM': 'linux', 04:20:06 INFO - 'TMOUT': '86400', 04:20:06 INFO - 'USER': 'cltbld', 04:20:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:06 INFO - '_': '/tools/buildbot/bin/python'} 04:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:06 INFO - Downloading/unpacking jsonschema==2.5.1 04:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:08 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:08 INFO - warning: no files found matching '*.txt' 04:20:08 INFO - no previously-included directories found matching 'build' 04:20:08 INFO - no previously-included directories found matching 'dist' 04:20:08 INFO - no previously-included directories found matching '.git*' 04:20:08 INFO - Installing collected packages: jsonschema, functools32 04:20:08 INFO - Running setup.py install for functools32 04:20:08 INFO - warning: no files found matching '*.txt' 04:20:08 INFO - no previously-included directories found matching 'build' 04:20:08 INFO - no previously-included directories found matching 'dist' 04:20:08 INFO - no previously-included directories found matching '.git*' 04:20:08 INFO - Successfully installed jsonschema functools32 04:20:08 INFO - Cleaning up... 04:20:08 INFO - Return code: 0 04:20:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:20:08 INFO - Using env: {'DISPLAY': ':0', 04:20:08 INFO - 'HOME': '/home/cltbld', 04:20:08 INFO - 'LANG': 'en_US.UTF-8', 04:20:08 INFO - 'LANGUAGE': 'en_US:en', 04:20:08 INFO - 'LOGNAME': 'cltbld', 04:20:08 INFO - 'MAIL': '/var/mail/cltbld', 04:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:08 INFO - 'MOZ_NO_REMOTE': '1', 04:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:08 INFO - 'NO_EM_RESTART': '1', 04:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:08 INFO - 'PWD': '/builds/slave/test', 04:20:08 INFO - 'SHELL': '/bin/bash', 04:20:08 INFO - 'SHLVL': '1', 04:20:08 INFO - 'TERM': 'linux', 04:20:08 INFO - 'TMOUT': '86400', 04:20:08 INFO - 'USER': 'cltbld', 04:20:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:08 INFO - '_': '/tools/buildbot/bin/python'} 04:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:08 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:10 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:11 INFO - Downloading docopt-0.6.1.tar.gz 04:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:11 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:11 INFO - Running setup.py install for blobuploader 04:20:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:11 INFO - Running setup.py install for requests 04:20:11 INFO - Running setup.py install for docopt 04:20:12 INFO - Successfully installed blobuploader requests docopt 04:20:12 INFO - Cleaning up... 04:20:12 INFO - Return code: 0 04:20:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:12 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:12 INFO - Using env: {'DISPLAY': ':0', 04:20:12 INFO - 'HOME': '/home/cltbld', 04:20:12 INFO - 'LANG': 'en_US.UTF-8', 04:20:12 INFO - 'LANGUAGE': 'en_US:en', 04:20:12 INFO - 'LOGNAME': 'cltbld', 04:20:12 INFO - 'MAIL': '/var/mail/cltbld', 04:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:12 INFO - 'MOZ_NO_REMOTE': '1', 04:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:12 INFO - 'NO_EM_RESTART': '1', 04:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:12 INFO - 'PWD': '/builds/slave/test', 04:20:12 INFO - 'SHELL': '/bin/bash', 04:20:12 INFO - 'SHLVL': '1', 04:20:12 INFO - 'TERM': 'linux', 04:20:12 INFO - 'TMOUT': '86400', 04:20:12 INFO - 'USER': 'cltbld', 04:20:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:12 INFO - '_': '/tools/buildbot/bin/python'} 04:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:12 INFO - Running setup.py (path:/tmp/pip-7APMr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:12 INFO - Running setup.py (path:/tmp/pip-f6RoYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:12 INFO - Running setup.py (path:/tmp/pip-2KR1SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:12 INFO - Running setup.py (path:/tmp/pip-etiNsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:12 INFO - Running setup.py (path:/tmp/pip-DwtXpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:12 INFO - Running setup.py (path:/tmp/pip-Hu4s1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:12 INFO - Running setup.py (path:/tmp/pip-xaFkpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:12 INFO - Running setup.py (path:/tmp/pip-XNSRRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:12 INFO - Running setup.py (path:/tmp/pip-krYW1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:12 INFO - Running setup.py (path:/tmp/pip-ytwXw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:13 INFO - Running setup.py (path:/tmp/pip-okERCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:13 INFO - Running setup.py (path:/tmp/pip-KJS77S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:13 INFO - Running setup.py (path:/tmp/pip-kppCEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:13 INFO - Running setup.py (path:/tmp/pip-Fu632j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:13 INFO - Running setup.py (path:/tmp/pip-u9xnJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:13 INFO - Running setup.py (path:/tmp/pip-VIsP6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:13 INFO - Running setup.py (path:/tmp/pip-Wtg_Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:13 INFO - Running setup.py install for manifestparser 04:20:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:13 INFO - Running setup.py install for mozcrash 04:20:13 INFO - Running setup.py install for mozdebug 04:20:13 INFO - Running setup.py install for mozdevice 04:20:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:13 INFO - Running setup.py install for mozfile 04:20:14 INFO - Running setup.py install for mozhttpd 04:20:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Running setup.py install for mozinfo 04:20:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Running setup.py install for mozInstall 04:20:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Running setup.py install for mozleak 04:20:14 INFO - Running setup.py install for mozlog 04:20:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Running setup.py install for moznetwork 04:20:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Running setup.py install for mozprocess 04:20:14 INFO - Running setup.py install for mozprofile 04:20:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Running setup.py install for mozrunner 04:20:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:14 INFO - Running setup.py install for mozscreenshot 04:20:15 INFO - Running setup.py install for moztest 04:20:15 INFO - Running setup.py install for mozversion 04:20:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:15 INFO - Cleaning up... 04:20:15 INFO - Return code: 0 04:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:15 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:15 INFO - Using env: {'DISPLAY': ':0', 04:20:15 INFO - 'HOME': '/home/cltbld', 04:20:15 INFO - 'LANG': 'en_US.UTF-8', 04:20:15 INFO - 'LANGUAGE': 'en_US:en', 04:20:15 INFO - 'LOGNAME': 'cltbld', 04:20:15 INFO - 'MAIL': '/var/mail/cltbld', 04:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:15 INFO - 'MOZ_NO_REMOTE': '1', 04:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:15 INFO - 'NO_EM_RESTART': '1', 04:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:15 INFO - 'PWD': '/builds/slave/test', 04:20:15 INFO - 'SHELL': '/bin/bash', 04:20:15 INFO - 'SHLVL': '1', 04:20:15 INFO - 'TERM': 'linux', 04:20:15 INFO - 'TMOUT': '86400', 04:20:15 INFO - 'USER': 'cltbld', 04:20:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:15 INFO - '_': '/tools/buildbot/bin/python'} 04:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:15 INFO - Running setup.py (path:/tmp/pip-18Edzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:15 INFO - Running setup.py (path:/tmp/pip-v2eTVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:15 INFO - Running setup.py (path:/tmp/pip-KILbYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:15 INFO - Running setup.py (path:/tmp/pip-JGx_qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:15 INFO - Running setup.py (path:/tmp/pip-NxD8j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:15 INFO - Running setup.py (path:/tmp/pip-TpRSBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:15 INFO - Running setup.py (path:/tmp/pip-L9b2CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:16 INFO - Running setup.py (path:/tmp/pip-az060J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:16 INFO - Running setup.py (path:/tmp/pip-Tvw7SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:16 INFO - Running setup.py (path:/tmp/pip-u63ixg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:16 INFO - Running setup.py (path:/tmp/pip-rXwQM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:16 INFO - Running setup.py (path:/tmp/pip-4D18IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:16 INFO - Running setup.py (path:/tmp/pip-w18oME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:16 INFO - Running setup.py (path:/tmp/pip-TAOcoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:16 INFO - Running setup.py (path:/tmp/pip-dQgLKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:16 INFO - Running setup.py (path:/tmp/pip-90t835-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:16 INFO - Running setup.py (path:/tmp/pip-OLBj8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:18 INFO - Downloading blessings-1.6.tar.gz 04:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:18 INFO - Installing collected packages: blessings 04:20:18 INFO - Running setup.py install for blessings 04:20:18 INFO - Successfully installed blessings 04:20:18 INFO - Cleaning up... 04:20:18 INFO - Return code: 0 04:20:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:19 INFO - Reading from file tmpfile_stdout 04:20:19 INFO - Current package versions: 04:20:19 INFO - argparse == 1.2.1 04:20:19 INFO - blessings == 1.6 04:20:19 INFO - blobuploader == 1.2.4 04:20:19 INFO - docopt == 0.6.1 04:20:19 INFO - functools32 == 3.2.3-2 04:20:19 INFO - jsonschema == 2.5.1 04:20:19 INFO - manifestparser == 1.1 04:20:19 INFO - mozInstall == 1.12 04:20:19 INFO - mozcrash == 0.17 04:20:19 INFO - mozdebug == 0.1 04:20:19 INFO - mozdevice == 0.48 04:20:19 INFO - mozfile == 1.2 04:20:19 INFO - mozhttpd == 0.7 04:20:19 INFO - mozinfo == 0.9 04:20:19 INFO - mozleak == 0.1 04:20:19 INFO - mozlog == 3.2 04:20:19 INFO - moznetwork == 0.27 04:20:19 INFO - mozprocess == 0.22 04:20:19 INFO - mozprofile == 0.28 04:20:19 INFO - mozrunner == 6.11 04:20:19 INFO - mozscreenshot == 0.1 04:20:19 INFO - mozsystemmonitor == 0.3 04:20:19 INFO - moztest == 0.7 04:20:19 INFO - mozversion == 1.4 04:20:19 INFO - psutil == 3.1.1 04:20:19 INFO - requests == 1.2.3 04:20:19 INFO - wsgiref == 0.1.2 04:20:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:19 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:19 INFO - Using env: {'DISPLAY': ':0', 04:20:19 INFO - 'HOME': '/home/cltbld', 04:20:19 INFO - 'LANG': 'en_US.UTF-8', 04:20:19 INFO - 'LANGUAGE': 'en_US:en', 04:20:19 INFO - 'LOGNAME': 'cltbld', 04:20:19 INFO - 'MAIL': '/var/mail/cltbld', 04:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:19 INFO - 'MOZ_NO_REMOTE': '1', 04:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:19 INFO - 'NO_EM_RESTART': '1', 04:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:19 INFO - 'PWD': '/builds/slave/test', 04:20:19 INFO - 'SHELL': '/bin/bash', 04:20:19 INFO - 'SHLVL': '1', 04:20:19 INFO - 'TERM': 'linux', 04:20:19 INFO - 'TMOUT': '86400', 04:20:19 INFO - 'USER': 'cltbld', 04:20:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:19 INFO - '_': '/tools/buildbot/bin/python'} 04:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:20:19 INFO - Cleaning up... 04:20:19 INFO - Return code: 0 04:20:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:19 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:20:19 INFO - Using env: {'DISPLAY': ':0', 04:20:19 INFO - 'HOME': '/home/cltbld', 04:20:19 INFO - 'LANG': 'en_US.UTF-8', 04:20:19 INFO - 'LANGUAGE': 'en_US:en', 04:20:19 INFO - 'LOGNAME': 'cltbld', 04:20:19 INFO - 'MAIL': '/var/mail/cltbld', 04:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:19 INFO - 'MOZ_NO_REMOTE': '1', 04:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:19 INFO - 'NO_EM_RESTART': '1', 04:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:19 INFO - 'PWD': '/builds/slave/test', 04:20:19 INFO - 'SHELL': '/bin/bash', 04:20:19 INFO - 'SHLVL': '1', 04:20:19 INFO - 'TERM': 'linux', 04:20:19 INFO - 'TMOUT': '86400', 04:20:19 INFO - 'USER': 'cltbld', 04:20:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:19 INFO - '_': '/tools/buildbot/bin/python'} 04:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:20:19 INFO - Cleaning up... 04:20:19 INFO - Return code: 0 04:20:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:19 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 0x7f53d80eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7a350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, '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': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:20:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:20:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:20:19 INFO - Using env: {'DISPLAY': ':0', 04:20:19 INFO - 'HOME': '/home/cltbld', 04:20:19 INFO - 'LANG': 'en_US.UTF-8', 04:20:19 INFO - 'LANGUAGE': 'en_US:en', 04:20:19 INFO - 'LOGNAME': 'cltbld', 04:20:19 INFO - 'MAIL': '/var/mail/cltbld', 04:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:19 INFO - 'MOZ_NO_REMOTE': '1', 04:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:19 INFO - 'NO_EM_RESTART': '1', 04:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:19 INFO - 'PWD': '/builds/slave/test', 04:20:19 INFO - 'SHELL': '/bin/bash', 04:20:19 INFO - 'SHLVL': '1', 04:20:19 INFO - 'TERM': 'linux', 04:20:19 INFO - 'TMOUT': '86400', 04:20:19 INFO - 'USER': 'cltbld', 04:20:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:19 INFO - '_': '/tools/buildbot/bin/python'} 04:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:19 INFO - Downloading/unpacking flake8 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:20:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:20:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:22 INFO - no previously-included directories found matching 'docs/_build' 04:20:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:20:22 INFO - Running setup.py install for pep8 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:22 INFO - no previously-included directories found matching 'docs/_build' 04:20:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:20:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:20:22 INFO - Cleaning up... 04:20:22 INFO - Return code: 0 04:20:22 INFO - Running post-action listener: _resource_record_post_action 04:20:22 INFO - Running post-action listener: _start_resource_monitoring 04:20:22 INFO - Starting resource monitoring. 04:20:22 INFO - ##### 04:20:22 INFO - ##### Finished create-virtualenv step (success) 04:20:22 INFO - ##### 04:20:22 INFO - ##### 04:20:22 INFO - ##### Running install step. 04:20:22 INFO - ##### 04:20:22 INFO - Running pre-action listener: _resource_record_pre_action 04:20:22 INFO - Running main action method: install 04:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:22 INFO - Reading from file tmpfile_stdout 04:20:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:22 INFO - Reading from file tmpfile_stdout 04:20:22 INFO - Output received: 04:20:22 INFO - Usage: mozinstall [options] installer 04:20:22 INFO - Options: 04:20:22 INFO - -h, --help show this help message and exit 04:20:22 INFO - -d DEST, --destination=DEST 04:20:22 INFO - Directory to install application into. [default: 04:20:22 INFO - "/builds/slave/test"] 04:20:22 INFO - --app=APP Application being installed. [default: firefox] 04:20:22 INFO - mkdir: /builds/slave/test/build/application 04:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:20:38 INFO - Reading from file tmpfile_stdout 04:20:38 INFO - Output received: 04:20:38 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:38 INFO - Running post-action listener: _resource_record_post_action 04:20:38 INFO - ##### 04:20:38 INFO - ##### Finished install step (success) 04:20:38 INFO - ##### 04:20:38 INFO - ##### 04:20:38 INFO - ##### Running run-tests step. 04:20:38 INFO - ##### 04:20:38 INFO - Running pre-action listener: _resource_record_pre_action 04:20:38 INFO - Running main action method: run_tests 04:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:38 INFO - Python 2.7.3 04:20:38 INFO - Return code: 0 04:20:38 INFO - grabbing minidump binary from tooltool 04:20: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')]} 04:20:38 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 0x2c091c0>, '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 0x2c0a0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0a550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:20:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:20:38 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:20:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:38 INFO - Return code: 0 04:20:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:20:39 INFO - Return code: 0 04:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 04:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 04:20:39 INFO - Using env: {'DISPLAY': ':0', 04:20:39 INFO - 'HOME': '/home/cltbld', 04:20:39 INFO - 'LANG': 'en_US.UTF-8', 04:20:39 INFO - 'LANGUAGE': 'en_US:en', 04:20:39 INFO - 'LOGNAME': 'cltbld', 04:20:39 INFO - 'MAIL': '/var/mail/cltbld', 04:20:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:39 INFO - 'MOZ_NO_REMOTE': '1', 04:20:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:39 INFO - 'NO_EM_RESTART': '1', 04:20:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:39 INFO - 'PWD': '/builds/slave/test', 04:20:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:39 INFO - 'SHELL': '/bin/bash', 04:20:39 INFO - 'SHLVL': '1', 04:20:39 INFO - 'TERM': 'linux', 04:20:39 INFO - 'TMOUT': '86400', 04:20:39 INFO - 'USER': 'cltbld', 04:20:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431', 04:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:39 INFO - '_': '/tools/buildbot/bin/python'} 04:20:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 04:20:40 INFO - mozversion application_buildid: 20160608025830 04:20:40 INFO - mozversion application_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 04:20:40 INFO - mozversion application_display_name: Nightly 04:20:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:40 INFO - mozversion application_name: Firefox 04:20:40 INFO - mozversion application_remotingname: firefox 04:20:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:20:40 INFO - mozversion application_vendor: Mozilla 04:20:40 INFO - mozversion application_version: 50.0a1 04:20:40 INFO - mozversion platform_buildid: 20160608025830 04:20:40 INFO - mozversion platform_changeset: f8ad071a6e14331d73fa44c8d3108bc2b66b2174 04:20:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:20:40 INFO - mozversion platform_version: 50.0a1 04:20:40 INFO - using testdate: 1465384840 04:20:40 INFO - actual date: 1465384840 04:20:40 INFO - starting webserver on 'localhost:55789' 04:20:40 INFO - SUITE-START | Running 2 tests 04:20:40 INFO - TEST-START | dromaeo_css 04:20:40 INFO - operating with platform_type : linux_ 04:20:40 INFO - Initialising browser for dromaeo_css test... 04:20:40 INFO - TEST-INFO | started process 4287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9AXgO/profile http://localhost:55789/getInfo.html) 04:20:44 INFO - PROCESS | 4287 | __metrics Screen width/height:1600/1200 04:20:44 INFO - PROCESS | 4287 | colorDepth:24 04:20:44 INFO - PROCESS | 4287 | Browser inner width/height: 1024/697 04:20:44 INFO - PROCESS | 4287 | __metrics 04:20:45 ERROR - PROCESS | 4287 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:45 INFO - PROCESS | 4287 | console.error: PushService: 04:20:45 INFO - PROCESS | 4287 | stateChangeProcessEnqueue: Error transitioning state 04:20:45 INFO - PROCESS | 4287 | UnknownError 04:20:46 INFO - TEST-INFO | 4287: exit 0 04:20:46 INFO - Browser initialized. 04:20:46 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:46 INFO - TEST-INFO | started process 4371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9AXgO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:58 INFO - PROCESS | 4371 | RSS: Main: 157659136 04:20:58 INFO - PROCESS | 4371 | 04:21:49 INFO - PROCESS | 4371 | 1465384909960 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:24:02 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55789/tests/dromaeo/cssquery-ext.html) 04:24:04 INFO - PROCESS | 4371 | RSS: Main: 261783552 04:24:04 INFO - PROCESS | 4371 | 04:27:06 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-ext.html (next: http://localhost:55789/tests/dromaeo/cssquery-jquery.html) 04:27:07 INFO - PROCESS | 4371 | RSS: Main: 244387840 04:27:07 INFO - PROCESS | 4371 | 04:30:09 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55789/tests/dromaeo/cssquery-mootools.html) 04:30:10 INFO - PROCESS | 4371 | RSS: Main: 236285952 04:30:10 INFO - PROCESS | 4371 | 04:33:12 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55789/tests/dromaeo/cssquery-prototype.html) 04:33:13 INFO - PROCESS | 4371 | RSS: Main: 235909120 04:33:13 INFO - PROCESS | 4371 | 04:36:15 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55789/tests/dromaeo/cssquery-yui.html) 04:36:16 INFO - PROCESS | 4371 | RSS: Main: 222916608 04:36:16 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-yui.html (next: http://localhost:55789/tests/dromaeo/cssquery-dojo.html) 04:39:19 INFO - PROCESS | 4371 | RSS: Main: 297377792 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | __start_tp_report 04:39:19 INFO - PROCESS | 4371 | _x_x_mozilla_page_load 04:39:19 INFO - PROCESS | 4371 | _x_x_mozilla_page_load_details 04:39:19 INFO - PROCESS | 4371 | |i|pagename|runs| 04:39:19 INFO - PROCESS | 4371 | |0;dojo.html;2674.0373465552398;2680.584509401041;2721.0748345562506;2726.740959608838;2745.4234610731746;4607.562281583244;4658.836940707076;4702.90594188116;4797.136515427226;4828.710277383359;4761.4286285645685;4772.2125849234835;4780.521947805227;4810.037992401516;4819.277108433728;4317.0934103838235;4345.261305578059;4406.779661016953;4431.1802316571375;4457.219986502365;4373;4398.3842262083335;4403.273459879116;4439.223135951212;4462.687611867171;4224.8732538023905;4303.462067241595;4308.633766129883;4320.82716691332;4381.036172042146;4230.17511585241;4239.851605193834;4248.320268757015;4340.804663790105;4401.141777353418;4245.957540424587;4249.723767955073;4262.872113836559;4303.784810759449;4347.347897815322;4513.300438432048;4548.2495388260895;4694.201985662446;4710.670253082286;4731.101090792773;4961.330220420269;5008.17365134756;5023.447420783711;5032.2703208035;5049.596032317406;5041.369828771403;5053.418856831475;5065.569426598743;5066.240063990431;5074.695518268915;4669.252919532859;4697.13103075932;4717.599004084657;4764.118638051902;4783.521647835259;5346.705931173745;5350.063738845764;5362.731863406814;5372.677639341652;5393.5954803389905;5119.1553393690365;5126.333576635014;5149.948500514947;5160.48395160481;5167.431582525919;4904.166291730415;4990.8253211137435;5170.922436163461;5171.663841850268;5211.1662134059125;4972.975135124374;4998.550130488201;4999.275105109811;5032.949670503322;5050.217216331474;4941.802327906844;4943.604511639132;4952.356193694796;5007.173816320339;5020.196768517019;4178.01816573105;4181.979090104591;4221.873343799691;4225.049363893099;4267.978660106742;3685.870994515179;3716.7026637869444;3748.5501739790852;3749.606291339425;3769.0388950817364;4501.7974191161475;4503.54964503547;4507.346434766941;4513.571210734975;4562.064776720765;5161.4322424533275;5164.638475306768;5176.068307704574;5178;5220.112580861262;4333.783310834446;4459.710118842265;4496.527864574173;4499.10017996402;4503.954960450419;4598.057398233354;4605.631549476034;4610.40064791575;4611.838585649486;4657.883552911137;4888.853334399902;4896.534829191221;4912;4915.852524424345;4943.20908654628;4973.254011898244;5040.4455509894615;5081.4664460232625;5089.51649593288;5114.33513643224;4814.350062741625;4826.179549476527;4827.396575428072;4841.1285968526;4889.437714662717;4896.2410826321975;5012.974935125301;5013.849584512471;5025;5072.949270507248;5057.494250574913;5079.238114282887;5097.413797413345;5119.360079990001;5130.384353877558;4962.702237865739;4965.255211718271;4969.055879382906;4983.476734942778;5017.422996355466;4779.928301075556;4909.877253068702;4963.925541116959;4966.627502937222;5022.648414610942;4855.441624213261;4930.802767889244;4955.4301255356095;4967.652264341461;4968.080905032581;5010.398752149619;5018.197088465974;5020.297158397754;5036.118679231046;5058.64589478733;4788.952110478851;4892.437369702529;4893.437254715754;4927.211646136744;4964.751762411793 04:39:19 INFO - PROCESS | 4371 | |1;ext.html;550.7889007088673;585.2099665451641;586.3432955090294;586.8972929737296;603.2037710222506;27341.453170936595;27984.44031119379;29778.702212977863;29784.25539361517;29890.999999999975;30043.098707038826;41544.37683434751;41992.79003604978;42062.579374206245;45660.54339456605;7684.692612295516;7787;7847.332976696987;7874.173211812763;7878.960605196966;7636.389088872905;7771.106322772869;7773.689052437924;7780.02749656293;7780.766577002699;7724.07311122666;7763.184865589116;7772.378209743207;7776.572288524129;7788.98743163388;7698.076230852305;7786.182450842636;7792.532448053135;7803.687852485894;7866.881996770053;7776.922230777676;7817.5309481431295;7857.724979625743;7861.056673199253;7861.842763144762;40393.59606403957;41088.38367424491;41111.58888411138;41133.588664113275;41160.176796464206;2656.973430265711;2825.816321939067;2860.6281183446017;3087.6140482439696;3219.4848824188016;29827.85086074556;30132.24669383261;30511.389772204653;30643;30649.080527583985;3410.5225268462186;3418.5214070030215;3463.5497385339995;3471.340445315407;3485.3552092862647;264768;265881;267823;267995;268743;55384;56102.999999999185;56137.438625614035;56190.15714764282;56214.43785562174;55803.441965580634;58834.70582647059;58877.70561147167;60525.39474605198;60703.392966070656;14523.78214326786;14696.338664760111;14732.631684207981;14736.631584210267;14741.631459213391;11544.88455115455;11766.411679415995;11776.941115294369;11780.234284771463;11788.941055294668;15107.848921510864;15461.690766184838;15494.457693980656;16135.67728645444;16650.916745416194;5772.769089236467;5821.388754180834;5883.14694369314;5921.496672782776;6000.669963152069;798.7044793426469;929.4423345992485;1017.4963393120453;1018.5416562546884;1042.2547878267076;26923.461530769277;27992.44015119727;28619.856900715364;28641.57037644437;28749.137525874256;984.9015098490094;1005.301315585661;1063.2397835547465;1063.3747475852806;1070.6199299248653;14672.559823205322;14801.333939972727;14860.479883204036;15117.244137793066;15278.618034549225;378279.1946442972;378325;379695;379792;380882;50221.74889125531;50369.74815125901;50508;50917.49082509201;51188.74405628022;1189.3399163464187;1193.3555879824971;1200.0478822097737;1215.3497878635064;1219.4390580333147;26208;27740.30649233785;27771.722282777722;27829;28148;44514;44613.33080003737;44919.55080449153;44941.32588011117;44998.77500612476;316973;317008;317899;318334;319349;30828.845855770578;31139.84430077835;37486.25027499489;37916.810415947744;38329.23341533098;42146.57853421426;42829;42897.35653965131;43743;43937.78031109824;32982.835085824416;33198.66801332052;33270;33719.831400842835;33941.66058339385;36056.27887442184;36641.45037824381;36765.44851827278;36796;37041.62958370382;35834;36581.63418365889;36713.63286367209;36990.815045924595;37011.07472313106;31179.220519487193;32670.183245419055;33147;33287.50068749019;33319;24445;25254;25413.364665883502;25541.61687574725;25559.43951480374 04:39:19 INFO - PROCESS | 4371 | |2;jquery.html;365.48649147947145;368.7234574069448;368.9391250443677;380.8400471801843;393.0272575375945;15736.370545178193;16364.83635163648;16451.50645480636;16674.916625416856;17027.82972170278;15742.370305187807;15955.12246826424;16914.069726165057;16931.407400740976;16938.3224671013;5059.139946209144;5188.8702782430555;5194.662346947455;5255.316808814849;5261.684298942057;3670.4861319415304;3838.3474809282347;3865.594112618177;3869.903252418698;5156.510131537498;5722.771089156428;6007.6996150192535;6044.637321760686;6137.294211165706;6161;6027.065804800263;6074.757009719606;6092.725827337758;6098.756049758004;6104.633721976651;3350.547676063749;4980.352554167971;5238.711870847102;5363.704996225206;5372.059889519358;18662.720059199124;19186.904065479725;19842.801571984382;19938.900305498526;20000.899995500076;1844.1793401936143;1853.1938606705992;1931.671615825313;2027.4019164346553;2377.429416939922;12202.755944881053;12282.385880706019;12535.43590538428;12654.683632909251;12799;1675.8324167583266;1742.5208067781334;1750.4923572164057;1810.2849374497132;1860.4325680667391;68418.3158168417;68833.65583172101;69136.65431672809;69206.30793692099;69465.65267173683;8833.911660883437;8997.640094396282;9177.705573606598;9219.585118669676;9335.393199442015;11869.5845645402;11972;11985.460654270579;12025.218360806519;12055.57805476804;7055.435565154775;7128.465365097535;7146.464015198881;7203.243659415791;7233.168185658611;6932.0988271524375;6978.267281935425;7079.82300442493;7131.643417829087;7132.536385134949;5587.776488940397;5693.772249110072;5710.2576665033275;5768.567357448208;5854.853628659318;1520.8290713861722;1692.424575644287;1694.246060503089;1728.6542691461507;1771.8493928016262;859.1494420523636;901.5086777706166;928.5171710710528;964.9421034737798;969.2343048991359;16109.275082621076;16416.589585260226;16574.254158562893;16600.335986560644;17117.14414279306;826.4544903696146;843.9240468357877;844.9915500844913;845.3237410071918;856.8543347630917;8275.95862020698;8721.912780872237;9206.355555111079;9230.815383692288;9318.487483188354;290096;292236;387759;405963;409937;81017;81311.5934420336;83781;84506.57746711228;85586;981.4062492192121;996.7209181429212;997.7106639074732;1018.5060245780791;1027.5222021759917;15053.172075535513;15107.39570417215;15248.313825878084;15520.5343839685;15767.605809854387;39013.41479877747;39280.2143957125;39491.605083948794;39597.20805583814;39718.80140599279;52986.47013529815;53453;53746.46253537414;54085.459145408044;54147.18779218236;5989.52083833301;6063;7620.923790762243;7645.6559454823555;7923.405744569065;10540.420276884844;11127.165462590176;11135.220534562826;11422.143339249757;11600.18798684084;9837.409755414697;10051.346662466916;10055.195584353089;10080.445575493419;10161.187105031728;9993.500324983866;10025.598976040877;10131.594736210469;10304.227182961158;10336.689899303034;9769.706908792748;9824.65613703517;10083.092521673085;10111.090001899864;10138.341007834468;7423.109226892808;7494.400447964041;7590.81022974408;7625.046869141357;7794.4543881929985;9340.766480838034;9879.555420006262;10041.799164016533;10077.09306162449;10284.09744197326 04:39:19 INFO - PROCESS | 4371 | |3;mootools.html;1213.9210951288171;1346.7845144776834;1416.9149851008938;1465.7508223601988;1723.913804309785;6828.52200345976;7833.255840695132;8078.757637270884;8083.555404452753;8319.66721331146;8028.598570071502;8167.346612271019;8169.714060007901;8183.9590802045905;8203.138670439608;1859.3399343233161;2138.77542858;2156.975436667582;2188.6607575825774;2218.0684112672716;2210.4694873230387;2236.3626366485555;2239.74242962059;2240.574290884727;2241.05875532276;2197.494576247464;2213.889305534725;2236.3067449090836;2238.7985081342676;2240.9775902241013;1803.8647101467443;2076.5223998480433;2162.37291185556;2165.4911095892453;2170.815480684144;2157.9028943697413;2179.1283486605325;2180.8146307563875;2184.584928863527;2185.8142057925097;8127.512349259064;8176.713815016446;8183.79540511486;8184.345252379855;8198.549079800609;4555.521670224645;4670.462896766881;4675.088357770236;4676.929846052312;4690.460597031317;2717.5108480473505;2860.284928767808;2885.812422192551;2896.2904088498244;2897.420515896829;890.6838072484239;901.9684311049148;908.1690253418114;1753.6317373351612;1808.1953530678852;10810.189235807346;10882.23824332297;10882.40146791926;10891.292066015763;10914.945425272823;4009.3785463253244;4057.634812866856;4124.546299907008;4156.521999969982;4168.333066709312;8404.495730256203;8445.619947102396;8458.577071146541;8469.195426434479;8481.109483504266;4533.161365147458;4588;4590.724556526619;4592.977035114803;4593.19619066662;3733.7199710021855;4152.273352163359;4280.700350975464;4292.978535107304;4337.631301339358;3241.546183534307;3344.6153692325693;3358.529805827186;3367.3770352484867;3397.371486275047;1005.3515482513737;1007.4610083605236;1023.2428003277521;1023.97440063999;1044.3159730376615;672.7544446277074;763.1872056260065;801.3308887079354;802.8217993939116;817.5707753429378;5219.739013049332;5221.536235618173;5289.550388216968;5301.522862942354;5576.86057848557;842.30509829391;843.1694780641063;845.5941148248875;899.7030979776658;900.8288425199191;3456.6370531094376;3463.826808659607;3470.9479357809655;3500.2474467989505;3641.7268704847243;9806.460644664612;9934.950325248472;10164.4917754112;10170.338927969658;10260.538275777608;10145.94927025375;10148.695539133838;10149.492525373702;10161.034701703325;10171.389716617026;7140.428765698835;7360.33756961876;7362.9631851840395;7505.587192704454;7523.887141692879;5124.1032819257225;5133.486651334837;5138.100832354248;5178.223266510054;5234.11020126587;8810.427322224035;9138.360314778167;9251.167394934488;9293.395929264576;9298.442093474414;9279.211267042107;9494.05059494045;9519.286053545873;9544.284178686765;9608.231341492525;5870.119482077723;5922.637227295964;6053.697315134314;6346.428821406095;6447.6131432114225;6689.264180939996;7986.321162701235;7997.840043198987;7998.84002319962;8008.919910801051;6886.793396198122;7000.8949865753075;7015.052967849275;7071.858562828817;7088.787336379917;6843.315668433117;6929.480288978448;6949.895751563629;6980.860382792214;7003.4747393944635;6570.737170513126;6633.436157926631;6660.600363978177;6663.500237482305;6690.799276021728;4250.3199488081755;4536.206163921366;4578.06149739296;4578.45058592971;4595.839145629887;4528.3660287559105;4541.3188021797;4588.426446694163;4604.746738929391;4618.838340658061 04:39:19 INFO - PROCESS | 4371 | |4;prototype.html;299.97150270724273;301.6485794049932;306.5218259515158;306.9232691827043;309.63308479451854;4780.737059461728;4793.209120495118;4800.447948485925;4800.90398192036;4813.422389313283;4681.602063824571;4703.2945058241285;4745.454272758634;4755.574656924967;4766.070616229837;3550.3786837303496;3620.855165793378;3663.68858647014;3731.4589384539227;3772.4529943158227;3684.5394325709285;3728.8694895678655;3739.7943113128767;3749.8312575934146;3750.6061863504347;3546.5389499365174;3696.131409118855;3697.334479793636;3708.8701895433665;3712.2761061593;3586.892393228194;3716.646918542734;3721.5906250312446;3730.0488375464083;3740.6446387593273;3300.5214243934734;3303.5705358303508;3311.2218628622254;3312.685294896981;3325.1354647791504;4522.706024108423;4541.182587134314;4545.545445455461;4566.977165114186;4570.680052396334;4025.4565633639377;4216.430781844442;4271.658267338606;4295.8496452624;4300.612944834948;4989.501049895018;4990.750462476862;5006.746963866275;5014.799408023675;5019;3608.3144202601684;3614.638536146391;3618.710503159767;3619.3666108431185;3620.2216523447323;5061.974690126563;5215.478452154792;5255.290535777697;5255.316808814868;5295.7881684732565;3633.6184700606586;3651.6348365163803;3651.8721844735305;3652.634736526326;3659.9817000914827;3694.7783133011567;3716.201016781351;3718.888433347004;3725.4411838224482;3727.7204209684382;4221.957780422218;4249.596288352602;4254.468191476066;4262.3180291153885;4267.3598960155605;4813.940932994736;4889.584385327216;4911.361523002059;4949.975250123726;4960.305557221992;1251.4994002399112;1272.3956120842527;1277.1060257819563;1283.8523569789593;1284.5054653958293;808.2523665609287;814.226484839405;852.2968550945495;852.3522123186423;860.5998210831868;4418.911621767546;4422.20400327944;4423.60187583119;4430.977845110819;4448.755318457516;5046.325447512824;5051.873703157377;5092.9745351273;5110.66780659256;5118.897622047538;4211.515675697334;4380.386745855582;4414.757188354607;4427.5572442755465;4454.443194600675;2693.3670587411943;2696.772968299419;2708.7155848636003;2710.512107820611;2718.850463224502;4793.952060479351;4797.472278049412;4800.35195248637;4831.4685384607665;4835.298881662139;5020.422651395063;5061.746912654353;5159.948400516022;5162.6128040397125;5187.948120518822;4785.712857228438;4791.976040119777;4820.9517904821205;4823.638227132979;4849.2968519564465;4991.675541089818;5006.874828129326;5013.749312534285;5021.347224860745;5065.189569668835;4763.333133361401;4936.185529387611;4945.703257804544;4953.603711703127;4970.055689418999;4770.546798054179;4776.928346074742;4809.24462571166;4823.890505183757;4839.330431001299;3604.693601043941;3606.5852426971232;3611.602723700443;3615.9819200903826;3616.3129005488872;4789.491310237264;5039.949600503948;5044.1424957758;5076.18780995039;5102.4897510248675;4878.512053823476;4889.975550122226;4891.779869905791;4894.706317620954;4919.926201106915;4892.412910450768;4894.559489645949;4903.338049363433;4904.386951631046;4912.38595175603;4682.836100736458;4806.182948898766;4837.879053023703;4838.177509823409;4841.298011788342;4849.793344028388;4917.442929676619;4935.185694360391;4937.456879743298;4940.75296235194;4785.880352991064;4800.4479484859685;4827.42070951488;4847.684900481458;4856.78144483492 04:39:19 INFO - PROCESS | 4371 | |5;yui.html;540.1249975040434;577.4369989260472;589.9557533185013;610.6519284008117;696.561166465127;12028.03775697942;12056.69858253543;12206.81689774653;12245.693857653563;12336.568220112298;12522.499100035988;12562.811557826617;12677.239365638068;12680.936595317033;12701.4919403224;632.50348476446;766.5056038854949;768.0476209500207;797.453744185232;806.8870358149863;804.2600807257309;804.6700852650414;807.6648191000728;807.9313258373045;811.2090711556244;846.8137009857821;849.2017503546647;849.2441726863096;850.2135524639715;850.2432834777053;658.7002913674266;817.9754607361789;842.3513894301415;844.0588743550958;845.813920937399;610.6946526736632;611.2298503885092;611.2634275697818;611.9418655227746;612.718149651161;12704.491820327175;12763.425645845866;12766.80849787254;12770.233785972778;12775.29735864527;11825.526978920832;12287.508499660093;12318.81521777174;12447.564335248222;12598.244105353617;11163.350696776562;11518.88481115195;11745.412729363497;11769.705757356134;12257.816132758016;4113.650339721127;4158.355454904495;4180.686448516373;4213.262679031188;4279.422277992462;53435;53849.73075134638;53896.73051634717;53921.46078539204;53946.46053539493;9004.63981440735;9173.770655733526;9714.125728684452;9714.708558743248;9734.36726612768;17814.198361073784;17825.286988520314;17825.46523604294;17839.197236124404;17844.375446859296;6386.744530218833;6430.64631445275;6493.545451818327;6499.220093588705;6632.83417914556;3485.9302813944087;3488.0582242794303;3553.8390143860142;3557.72341537462;3574.91062723434;2791.260316016257;2869.827810331387;2870.8708108135183;2871.2821794551364;2877.4101309231555;497.4229893323727;515.1371452816518;520.22486495122;521.8356217791384;525.3669328459198;454.85899371195035;468.9132510485503;509.2539429735455;518.4769491306506;525.4823998361611;7454.105507339045;7547.811304717426;7619.923800762032;7741.961290193513;7802.29779319864;396.6747267240835;475.4033687721887;495.5193462341523;498.8902441462872;508.58296197118005;3345.7825241359233;3441.5181874537584;3462.740294477924;3532.0816587687386;3588.300281445145;76945.23054769493;82007;86852.13147868567;87877;89926;53005;75967.24032759601;76045;77024.2055523925;78439;44826.55173448289;50243.74878125586;68731.3126868725;69809.65095174593;70639.2936070643;7919.960400197962;8086.757397278091;8195.71315003972;8203.015638123463;8216.21945915137;39972.40041399439;40443.79778101091;40747.796261018506;42260;42870.78564607157;58176;58479.70760146172;58951.41048589631;59374.70312648409;60184.69907650434;10731.892681073401;10909.127269818237;10974.286671366335;11008.009279164913;11012.513310702952;8195.64771812668;12285.877141228473;12791.936040319739;12891.290978996245;13097.672558186121;10114.443705596263;10433.373997560171;10636;11142.164337674545;11166.106711463226;11181.944090279496;11295.943520282346;11296.322220666787;11614.072800939151;11621.5351385947;10891.400972946563;11024.44877756125;11142.610008649659;11327.773444531229;11376.374299413612;9820.626011225764;9826.459544724823;9943.651972180938;10295.3822770634;10324.587016519556;9443.33896627257;9630.855537167088;9670.468124253233;9722.513874306114;9758.365706229073 04:39:19 INFO - PROCESS | 4371 | __end_tp_report 04:39:19 INFO - PROCESS | 4371 | __start_cc_report 04:39:19 INFO - PROCESS | 4371 | _x_x_mozilla_cycle_collect,962 04:39:19 INFO - PROCESS | 4371 | __end_cc_report 04:39:19 INFO - PROCESS | 4371 | __startTimestamp1465385959614__endTimestamp 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | ------- Summary: start ------- 04:39:19 INFO - PROCESS | 4371 | Number of tests: 6 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | [#0] dojo.html Cycles:165 Average:4706.97 Median:4888.85 stddev:499.53 (10.2%) stddev-sans-first:474.93 04:39:19 INFO - PROCESS | 4371 | Values: 2674.0 2680.6 2721.1 2726.7 2745.4 4607.6 4658.8 4702.9 4797.1 4828.7 4761.4 4772.2 4780.5 4810.0 4819.3 4317.1 4345.3 4406.8 4431.2 4457.2 4373.0 4398.4 4403.3 4439.2 4462.7 4224.9 4303.5 4308.6 4320.8 4381.0 4230.2 4239.9 4248.3 4340.8 4401.1 4246.0 4249.7 4262.9 4303.8 4347.3 4513.3 4548.2 4694.2 4710.7 4731.1 4961.3 5008.2 5023.4 5032.3 5049.6 5041.4 5053.4 5065.6 5066.2 5074.7 4669.3 4697.1 4717.6 4764.1 4783.5 5346.7 5350.1 5362.7 5372.7 5393.6 5119.2 5126.3 5149.9 5160.5 5167.4 4904.2 4990.8 5170.9 5171.7 5211.2 4973.0 4998.6 4999.3 5032.9 5050.2 4941.8 4943.6 4952.4 5007.2 5020.2 4178.0 4182.0 4221.9 4225.0 4268.0 3685.9 3716.7 3748.6 3749.6 3769.0 4501.8 4503.5 4507.3 4513.6 4562.1 5161.4 5164.6 5176.1 5178.0 5220.1 4333.8 4459.7 4496.5 4499.1 4504.0 4598.1 4605.6 4610.4 4611.8 4657.9 4888.9 4896.5 4912.0 4915.9 4943.2 4973.3 5040.4 5081.5 5089.5 5114.3 4814.4 4826.2 4827.4 4841.1 4889.4 4896.2 5013.0 5013.8 5025.0 5072.9 5057.5 5079.2 5097.4 5119.4 5130.4 4962.7 4965.3 4969.1 4983.5 5017.4 4779.9 4909.9 4963.9 4966.6 5022.6 4855.4 4930.8 4955.4 4967.7 4968.1 5010.4 5018.2 5020.3 5036.1 5058.6 4789.0 4892.4 4893.4 4927.2 4964.8 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | [#1] ext.html Cycles:180 Average:47946.34 Median:35945.14 stddev:85417.16 (237.6%) stddev-sans-first:85582.66 04:39:19 INFO - PROCESS | 4371 | Values: 550.8 585.2 586.3 586.9 603.2 27341.5 27984.4 29778.7 29784.3 29891.0 30043.1 41544.4 41992.8 42062.6 45660.5 7684.7 7787.0 7847.3 7874.2 7879.0 7636.4 7771.1 7773.7 7780.0 7780.8 7724.1 7763.2 7772.4 7776.6 7789.0 7698.1 7786.2 7792.5 7803.7 7866.9 7776.9 7817.5 7857.7 7861.1 7861.8 40393.6 41088.4 41111.6 41133.6 41160.2 2657.0 2825.8 2860.6 3087.6 3219.5 29827.9 30132.2 30511.4 30643.0 30649.1 3410.5 3418.5 3463.5 3471.3 3485.4 264768.0 265881.0 267823.0 267995.0 268743.0 55384.0 56103.0 56137.4 56190.2 56214.4 55803.4 58834.7 58877.7 60525.4 60703.4 14523.8 14696.3 14732.6 14736.6 14741.6 11544.9 11766.4 11776.9 11780.2 11788.9 15107.8 15461.7 15494.5 16135.7 16650.9 5772.8 5821.4 5883.1 5921.5 6000.7 798.7 929.4 1017.5 1018.5 1042.3 26923.5 27992.4 28619.9 28641.6 28749.1 984.9 1005.3 1063.2 1063.4 1070.6 14672.6 14801.3 14860.5 15117.2 15278.6 378279.2 378325.0 379695.0 379792.0 380882.0 50221.7 50369.7 50508.0 50917.5 51188.7 1189.3 1193.4 1200.0 1215.3 1219.4 26208.0 27740.3 27771.7 27829.0 28148.0 44514.0 44613.3 44919.6 44941.3 44998.8 316973.0 317008.0 317899.0 318334.0 319349.0 30828.8 31139.8 37486.3 37916.8 38329.2 42146.6 42829.0 42897.4 43743.0 43937.8 32982.8 33198.7 33270.0 33719.8 33941.7 36056.3 36641.5 36765.4 36796.0 37041.6 35834.0 36581.6 36713.6 36990.8 37011.1 31179.2 32670.2 33147.0 33287.5 33319.0 24445.0 25254.0 25413.4 25541.6 25559.4 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | [#2] jquery.html Cycles:180 Average:23614.86 Median:207458.68 stddev:60127.78 (29.0%) stddev-sans-first:60271.11 04:39:19 INFO - PROCESS | 4371 | Values: 365.5 368.7 368.9 380.8 393.0 15736.4 16364.8 16451.5 16674.9 17027.8 15742.4 15955.1 16914.1 16931.4 16938.3 5059.1 5188.9 5194.7 5255.3 5261.7 3670.5 3838.3 3865.6 3869.9 5156.5 5722.8 6007.7 6044.6 6137.3 6161.0 6027.1 6074.8 6092.7 6098.8 6104.6 3350.5 4980.4 5238.7 5363.7 5372.1 18662.7 19186.9 19842.8 19938.9 20000.9 1844.2 1853.2 1931.7 2027.4 2377.4 12202.8 12282.4 12535.4 12654.7 12799.0 1675.8 1742.5 1750.5 1810.3 1860.4 68418.3 68833.7 69136.7 69206.3 69465.7 8833.9 8997.6 9177.7 9219.6 9335.4 11869.6 11972.0 11985.5 12025.2 12055.6 7055.4 7128.5 7146.5 7203.2 7233.2 6932.1 6978.3 7079.8 7131.6 7132.5 5587.8 5693.8 5710.3 5768.6 5854.9 1520.8 1692.4 1694.2 1728.7 1771.8 859.1 901.5 928.5 964.9 969.2 16109.3 16416.6 16574.3 16600.3 17117.1 826.5 843.9 845.0 845.3 856.9 8276.0 8721.9 9206.4 9230.8 9318.5 290096.0 292236.0 387759.0 405963.0 409937.0 81017.0 81311.6 83781.0 84506.6 85586.0 981.4 996.7 997.7 1018.5 1027.5 15053.2 15107.4 15248.3 15520.5 15767.6 39013.4 39280.2 39491.6 39597.2 39718.8 52986.5 53453.0 53746.5 54085.5 54147.2 5989.5 6063.0 7620.9 7645.7 7923.4 10540.4 11127.2 11135.2 11422.1 11600.2 9837.4 10051.3 10055.2 10080.4 10161.2 9993.5 10025.6 10131.6 10304.2 10336.7 9769.7 9824.7 10083.1 10111.1 10138.3 7423.1 7494.4 7590.8 7625.0 7794.5 9340.8 9879.6 10041.8 10077.1 10284.1 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | [#3] mootools.html Cycles:180 Average:5197.94 Median:4644.65 stddev:2982.59 (64.2%) stddev-sans-first:2975.93 04:39:19 INFO - PROCESS | 4371 | Values: 1213.9 1346.8 1416.9 1465.8 1723.9 6828.5 7833.3 8078.8 8083.6 8319.7 8028.6 8167.3 8169.7 8184.0 8203.1 1859.3 2138.8 2157.0 2188.7 2218.1 2210.5 2236.4 2239.7 2240.6 2241.1 2197.5 2213.9 2236.3 2238.8 2241.0 1803.9 2076.5 2162.4 2165.5 2170.8 2157.9 2179.1 2180.8 2184.6 2185.8 8127.5 8176.7 8183.8 8184.3 8198.5 4555.5 4670.5 4675.1 4676.9 4690.5 2717.5 2860.3 2885.8 2896.3 2897.4 890.7 902.0 908.2 1753.6 1808.2 10810.2 10882.2 10882.4 10891.3 10914.9 4009.4 4057.6 4124.5 4156.5 4168.3 8404.5 8445.6 8458.6 8469.2 8481.1 4533.2 4588.0 4590.7 4593.0 4593.2 3733.7 4152.3 4280.7 4293.0 4337.6 3241.5 3344.6 3358.5 3367.4 3397.4 1005.4 1007.5 1023.2 1024.0 1044.3 672.8 763.2 801.3 802.8 817.6 5219.7 5221.5 5289.6 5301.5 5576.9 842.3 843.2 845.6 899.7 900.8 3456.6 3463.8 3470.9 3500.2 3641.7 9806.5 9935.0 10164.5 10170.3 10260.5 10145.9 10148.7 10149.5 10161.0 10171.4 7140.4 7360.3 7363.0 7505.6 7523.9 5124.1 5133.5 5138.1 5178.2 5234.1 8810.4 9138.4 9251.2 9293.4 9298.4 9279.2 9494.1 9519.3 9544.3 9608.2 5870.1 5922.6 6053.7 6346.4 6447.6 6689.3 7986.3 7997.8 7998.8 8008.9 6886.8 7000.9 7015.1 7071.9 7088.8 6843.3 6929.5 6949.9 6980.9 7003.5 6570.7 6633.4 6660.6 6663.5 6690.8 4250.3 4536.2 4578.1 4578.5 4595.8 4528.4 4541.3 4588.4 4604.7 4618.8 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | [#4] prototype.html Cycles:180 Average:4116.49 Median:4764.70 stddev:1181.67 (24.8%) stddev-sans-first:1149.74 04:39:19 INFO - PROCESS | 4371 | Values: 300.0 301.6 306.5 306.9 309.6 4780.7 4793.2 4800.4 4800.9 4813.4 4681.6 4703.3 4745.5 4755.6 4766.1 3550.4 3620.9 3663.7 3731.5 3772.5 3684.5 3728.9 3739.8 3749.8 3750.6 3546.5 3696.1 3697.3 3708.9 3712.3 3586.9 3716.6 3721.6 3730.0 3740.6 3300.5 3303.6 3311.2 3312.7 3325.1 4522.7 4541.2 4545.5 4567.0 4570.7 4025.5 4216.4 4271.7 4295.8 4300.6 4989.5 4990.8 5006.7 5014.8 5019.0 3608.3 3614.6 3618.7 3619.4 3620.2 5062.0 5215.5 5255.3 5255.3 5295.8 3633.6 3651.6 3651.9 3652.6 3660.0 3694.8 3716.2 3718.9 3725.4 3727.7 4222.0 4249.6 4254.5 4262.3 4267.4 4813.9 4889.6 4911.4 4950.0 4960.3 1251.5 1272.4 1277.1 1283.9 1284.5 808.3 814.2 852.3 852.4 860.6 4418.9 4422.2 4423.6 4431.0 4448.8 5046.3 5051.9 5093.0 5110.7 5118.9 4211.5 4380.4 4414.8 4427.6 4454.4 2693.4 2696.8 2708.7 2710.5 2718.9 4794.0 4797.5 4800.4 4831.5 4835.3 5020.4 5061.7 5159.9 5162.6 5187.9 4785.7 4792.0 4821.0 4823.6 4849.3 4991.7 5006.9 5013.7 5021.3 5065.2 4763.3 4936.2 4945.7 4953.6 4970.1 4770.5 4776.9 4809.2 4823.9 4839.3 3604.7 3606.6 3611.6 3616.0 3616.3 4789.5 5039.9 5044.1 5076.2 5102.5 4878.5 4890.0 4891.8 4894.7 4919.9 4892.4 4894.6 4903.3 4904.4 4912.4 4682.8 4806.2 4837.9 4838.2 4841.3 4849.8 4917.4 4935.2 4937.5 4940.8 4785.9 4800.4 4827.4 4847.7 4856.8 04:39:19 INFO - PROCESS | 4371 | 04:39:19 INFO - PROCESS | 4371 | [#5] yui.html Cycles:180 Average:16070.69 Median:508.92 stddev:21991.43 (4321.2%) stddev-sans-first:22022.20 04:39:19 INFO - PROCESS | 4371 | Values: 540.1 577.4 590.0 610.7 696.6 12028.0 12056.7 12206.8 12245.7 12336.6 12522.5 12562.8 12677.2 12680.9 12701.5 632.5 766.5 768.0 797.5 806.9 804.3 804.7 807.7 807.9 811.2 846.8 849.2 849.2 850.2 850.2 658.7 818.0 842.4 844.1 845.8 610.7 611.2 611.3 611.9 612.7 12704.5 12763.4 12766.8 12770.2 12775.3 11825.5 12287.5 12318.8 12447.6 12598.2 11163.4 11518.9 11745.4 11769.7 12257.8 4113.7 4158.4 4180.7 4213.3 4279.4 53435.0 53849.7 53896.7 53921.5 53946.5 9004.6 9173.8 9714.1 9714.7 9734.4 17814.2 17825.3 17825.5 17839.2 17844.4 6386.7 6430.6 6493.5 6499.2 6632.8 3485.9 3488.1 3553.8 3557.7 3574.9 2791.3 2869.8 2870.9 2871.3 2877.4 497.4 515.1 520.2 521.8 525.4 454.9 468.9 509.3 518.5 525.5 7454.1 7547.8 7619.9 7742.0 7802.3 396.7 475.4 495.5 498.9 508.6 3345.8 3441.5 3462.7 3532.1 3588.3 76945.2 82007.0 86852.1 87877.0 89926.0 53005.0 75967.2 76045.0 77024.2 78439.0 44826.6 50243.7 68731.3 69809.7 70639.3 7920.0 8086.8 8195.7 8203.0 8216.2 39972.4 40443.8 40747.8 42260.0 42870.8 58176.0 58479.7 58951.4 59374.7 60184.7 10731.9 10909.1 10974.3 11008.0 11012.5 8195.6 12285.9 12791.9 12891.3 13097.7 10114.4 10433.4 10636.0 11142.2 11166.1 11181.9 11295.9 11296.3 11614.1 11621.5 10891.4 11024.4 11142.6 11327.8 11376.4 9820.6 9826.5 9943.7 10295.4 10324.6 9443.3 9630.9 9670.5 9722.5 9758.4 04:39:19 INFO - PROCESS | 4371 | -------- Summary: end -------- 04:39:19 INFO - PROCESS | 4371 | 04:39:20 INFO - TEST-INFO | 4371: exit 0 04:39:20 INFO - TEST-OK | dromaeo_css | took 1120318ms 04:39:20 INFO - TEST-START | kraken 04:39:20 INFO - operating with platform_type : linux_ 04:39:20 INFO - Initialising browser for kraken test... 04:39:20 INFO - TEST-INFO | started process 4548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWEruCP/profile http://localhost:55789/getInfo.html) 04:39:24 INFO - PROCESS | 4548 | __metrics Screen width/height:1600/1200 04:39:24 INFO - PROCESS | 4548 | colorDepth:24 04:39:24 INFO - PROCESS | 4548 | Browser inner width/height: 1024/697 04:39:24 INFO - PROCESS | 4548 | __metrics 04:39:25 ERROR - PROCESS | 4548 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:39:25 INFO - PROCESS | 4548 | console.error: PushService: 04:39:25 INFO - PROCESS | 4548 | stateChangeProcessEnqueue: Error transitioning state 04:39:25 INFO - PROCESS | 4548 | UnknownError 04:39:26 INFO - TEST-INFO | 4548: exit 0 04:39:26 INFO - Browser initialized. 04:39:26 INFO - Running cycle 1/1 for kraken test... 04:39:26 INFO - TEST-INFO | started process 4626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWEruCP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:38 INFO - PROCESS | 4626 | RSS: Main: 158343168 04:39:38 INFO - PROCESS | 4626 | 04:39:41 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:42 INFO - PROCESS | 4626 | RSS: Main: 215691264 04:39:42 INFO - PROCESS | 4626 | 04:39:45 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-dft) 04:39:45 INFO - PROCESS | 4626 | RSS: Main: 202260480 04:39:45 INFO - PROCESS | 4626 | 04:39:48 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-fft) 04:39:49 INFO - PROCESS | 4626 | RSS: Main: 270278656 04:39:49 INFO - PROCESS | 4626 | 04:39:51 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-oscillator) 04:39:52 INFO - PROCESS | 4626 | RSS: Main: 180023296 04:39:52 INFO - PROCESS | 4626 | 04:39:54 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55789/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:55 INFO - PROCESS | 4626 | RSS: Main: 184950784 04:39:55 INFO - PROCESS | 4626 | 04:39:58 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55789/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:58 INFO - PROCESS | 4626 | RSS: Main: 220860416 04:39:58 INFO - PROCESS | 4626 | 04:40:02 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55789/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:02 INFO - PROCESS | 4626 | RSS: Main: 221134848 04:40:02 INFO - PROCESS | 4626 | 04:40:05 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55789/tests/kraken/driver.html?testName=json-parse-financial) 04:40:06 INFO - PROCESS | 4626 | RSS: Main: 221642752 04:40:06 INFO - PROCESS | 4626 | 04:40:08 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55789/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:08 INFO - PROCESS | 4626 | RSS: Main: 206135296 04:40:08 INFO - PROCESS | 4626 | 04:40:10 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:11 INFO - PROCESS | 4626 | RSS: Main: 210661376 04:40:11 INFO - PROCESS | 4626 | 04:40:13 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:14 INFO - PROCESS | 4626 | RSS: Main: 218189824 04:40:14 INFO - PROCESS | 4626 | 04:40:16 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:17 INFO - PROCESS | 4626 | RSS: Main: 225140736 04:40:17 INFO - PROCESS | 4626 | 04:40:20 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:21 INFO - PROCESS | 4626 | RSS: Main: 226304000 04:40:21 INFO - PROCESS | 4626 | 04:40:22 INFO - PROCESS | 4626 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55789/tests/kraken/driver.html?testName=ai-astar) 04:40:23 INFO - PROCESS | 4626 | RSS: Main: 268124160 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | __start_tp_report 04:40:23 INFO - PROCESS | 4626 | _x_x_mozilla_page_load 04:40:23 INFO - PROCESS | 4626 | _x_x_mozilla_page_load_details 04:40:23 INFO - PROCESS | 4626 | |i|pagename|runs| 04:40:23 INFO - PROCESS | 4626 | |0;ai-astar;114;110;115;114;112;114;113;113;114;114 04:40:23 INFO - PROCESS | 4626 | |1;audio-beat-detection;159;130;132;186;133;130;154;132;186;130 04:40:23 INFO - PROCESS | 4626 | |2;audio-dft;164;164;162;164;163;161;164;163;162;162 04:40:23 INFO - PROCESS | 4626 | |3;audio-fft;74;77;77;128;77;75;74;76;103;77 04:40:23 INFO - PROCESS | 4626 | |4;audio-oscillator;86;87;125;87;86;87;120;86;87;137 04:40:23 INFO - PROCESS | 4626 | |5;imaging-gaussian-blur;116;116;116;117;116;116;117;116;116;117 04:40:23 INFO - PROCESS | 4626 | |6;imaging-darkroom;146;147;146;147;146;145;146;146;145;146 04:40:23 INFO - PROCESS | 4626 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;94 04:40:23 INFO - PROCESS | 4626 | |8;json-parse-financial;63;65;64;65;66;65;65;65;63;65 04:40:23 INFO - PROCESS | 4626 | |9;json-stringify-tinderbox;64;65;64;65;65;65;64;67;65;65 04:40:23 INFO - PROCESS | 4626 | |10;stanford-crypto-aes;84;83;90;84;85;85;86;86;117;84 04:40:23 INFO - PROCESS | 4626 | |11;stanford-crypto-ccm;145;133;150;156;131;131;136;130;147;137 04:40:23 INFO - PROCESS | 4626 | |12;stanford-crypto-pbkdf2;169;170;171;173;172;174;170;172;166;167 04:40:23 INFO - PROCESS | 4626 | |13;stanford-crypto-sha256-iterative;67;68;67;67;66;66;67;67;66;67 04:40:23 INFO - PROCESS | 4626 | __end_tp_report 04:40:23 INFO - PROCESS | 4626 | __start_cc_report 04:40:23 INFO - PROCESS | 4626 | _x_x_mozilla_cycle_collect,1888 04:40:23 INFO - PROCESS | 4626 | __end_cc_report 04:40:23 INFO - PROCESS | 4626 | __startTimestamp1465386023029__endTimestamp 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | ------- Summary: start ------- 04:40:23 INFO - PROCESS | 4626 | Number of tests: 14 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.48 04:40:23 INFO - PROCESS | 4626 | Values: 114.0 110.0 115.0 114.0 112.0 114.0 113.0 113.0 114.0 114.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:143.50 stddev:22.97 (16.0%) stddev-sans-first:23.96 04:40:23 INFO - PROCESS | 4626 | Values: 159.0 130.0 132.0 186.0 133.0 130.0 154.0 132.0 186.0 130.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 04:40:23 INFO - PROCESS | 4626 | Values: 164.0 164.0 162.0 164.0 163.0 161.0 164.0 163.0 162.0 162.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.50 stddev:17.76 (23.2%) stddev-sans-first:18.48 04:40:23 INFO - PROCESS | 4626 | Values: 74.0 77.0 77.0 128.0 77.0 75.0 74.0 76.0 103.0 77.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:86.50 stddev:20.12 (23.3%) stddev-sans-first:20.80 04:40:23 INFO - PROCESS | 4626 | Values: 86.0 87.0 125.0 87.0 86.0 87.0 120.0 86.0 87.0 137.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:40:23 INFO - PROCESS | 4626 | Values: 116.0 116.0 116.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:40:23 INFO - PROCESS | 4626 | Values: 146.0 147.0 146.0 147.0 146.0 145.0 146.0 146.0 145.0 146.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:40:23 INFO - PROCESS | 4626 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:0.83 04:40:23 INFO - PROCESS | 4626 | Values: 63.0 65.0 64.0 65.0 66.0 65.0 65.0 65.0 63.0 65.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 04:40:23 INFO - PROCESS | 4626 | Values: 64.0 65.0 64.0 65.0 65.0 65.0 64.0 67.0 65.0 65.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:85.00 stddev:10.23 (12.0%) stddev-sans-first:10.73 04:40:23 INFO - PROCESS | 4626 | Values: 84.0 83.0 90.0 84.0 85.0 85.0 86.0 86.0 117.0 84.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:141.00 stddev:9.22 (6.5%) stddev-sans-first:9.57 04:40:23 INFO - PROCESS | 4626 | Values: 145.0 133.0 150.0 156.0 131.0 131.0 136.0 130.0 147.0 137.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.50 stddev:2.55 (1.5%) stddev-sans-first:2.65 04:40:23 INFO - PROCESS | 4626 | Values: 169.0 170.0 171.0 173.0 172.0 174.0 170.0 172.0 166.0 167.0 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - PROCESS | 4626 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 04:40:23 INFO - PROCESS | 4626 | Values: 67.0 68.0 67.0 67.0 66.0 66.0 67.0 67.0 66.0 67.0 04:40:23 INFO - PROCESS | 4626 | -------- Summary: end -------- 04:40:23 INFO - PROCESS | 4626 | 04:40:23 INFO - TEST-INFO | 4626: exit 0 04:40:24 INFO - TEST-OK | kraken | took 63621ms 04:40:24 INFO - SUITE-END | took 1183s 04:40:24 INFO - Completed test suite (00:19:44) 04:40:24 INFO - javascript benchmark 04:40:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.0373465552398, 2680.584509401041, 2721.0748345562506, 2726.740959608838, 2745.4234610731746, 4607.562281583244, 4658.836940707076, 4702.90594188116, 4797.136515427226, 4828.710277383359, 4761.4286285645685, 4772.2125849234835, 4780.521947805227, 4810.037992401516, 4819.277108433728, 4317.0934103838235, 4345.261305578059, 4406.779661016953, 4431.1802316571375, 4457.219986502365, 4373.0, 4398.3842262083335, 4403.273459879116, 4439.223135951212, 4462.687611867171, 4224.8732538023905, 4303.462067241595, 4308.633766129883, 4320.82716691332, 4381.036172042146, 4230.17511585241, 4239.851605193834, 4248.320268757015, 4340.804663790105, 4401.141777353418, 4245.957540424587, 4249.723767955073, 4262.872113836559, 4303.784810759449, 4347.347897815322, 4513.300438432048, 4548.2495388260895, 4694.201985662446, 4710.670253082286, 4731.101090792773, 4961.330220420269, 5008.17365134756, 5023.447420783711, 5032.2703208035, 5049.596032317406, 5041.369828771403, 5053.418856831475, 5065.569426598743, 5066.240063990431, 5074.695518268915, 4669.252919532859, 4697.13103075932, 4717.599004084657, 4764.118638051902, 4783.521647835259, 5346.705931173745, 5350.063738845764, 5362.731863406814, 5372.677639341652, 5393.5954803389905, 5119.1553393690365, 5126.333576635014, 5149.948500514947, 5160.48395160481, 5167.431582525919, 4904.166291730415, 4990.8253211137435, 5170.922436163461, 5171.663841850268, 5211.1662134059125, 4972.975135124374, 4998.550130488201, 4999.275105109811, 5032.949670503322, 5050.217216331474, 4941.802327906844, 4943.604511639132, 4952.356193694796, 5007.173816320339, 5020.196768517019, 4178.01816573105, 4181.979090104591, 4221.873343799691, 4225.049363893099, 4267.978660106742, 3685.870994515179, 3716.7026637869444, 3748.5501739790852, 3749.606291339425, 3769.0388950817364, 4501.7974191161475, 4503.54964503547, 4507.346434766941, 4513.571210734975, 4562.064776720765, 5161.4322424533275, 5164.638475306768, 5176.068307704574, 5178.0, 5220.112580861262, 4333.783310834446, 4459.710118842265, 4496.527864574173, 4499.10017996402, 4503.954960450419, 4598.057398233354, 4605.631549476034, 4610.40064791575, 4611.838585649486, 4657.883552911137, 4888.853334399902, 4896.534829191221, 4912.0, 4915.852524424345, 4943.20908654628, 4973.254011898244, 5040.4455509894615, 5081.4664460232625, 5089.51649593288, 5114.33513643224, 4814.350062741625, 4826.179549476527, 4827.396575428072, 4841.1285968526, 4889.437714662717, 4896.2410826321975, 5012.974935125301, 5013.849584512471, 5025.0, 5072.949270507248, 5057.494250574913, 5079.238114282887, 5097.413797413345, 5119.360079990001, 5130.384353877558, 4962.702237865739, 4965.255211718271, 4969.055879382906, 4983.476734942778, 5017.422996355466, 4779.928301075556, 4909.877253068702, 4963.925541116959, 4966.627502937222, 5022.648414610942, 4855.441624213261, 4930.802767889244, 4955.4301255356095, 4967.652264341461, 4968.080905032581, 5010.398752149619, 5018.197088465974, 5020.297158397754, 5036.118679231046, 5058.64589478733, 4788.952110478851, 4892.437369702529, 4893.437254715754, 4927.211646136744, 4964.751762411793], "value": 4675.25304879379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.7889007088673, 585.2099665451641, 586.3432955090294, 586.8972929737296, 603.2037710222506, 27341.453170936595, 27984.44031119379, 29778.702212977863, 29784.25539361517, 29890.999999999975, 30043.098707038826, 41544.37683434751, 41992.79003604978, 42062.579374206245, 45660.54339456605, 7684.692612295516, 7787.0, 7847.332976696987, 7874.173211812763, 7878.960605196966, 7636.389088872905, 7771.106322772869, 7773.689052437924, 7780.02749656293, 7780.766577002699, 7724.07311122666, 7763.184865589116, 7772.378209743207, 7776.572288524129, 7788.98743163388, 7698.076230852305, 7786.182450842636, 7792.532448053135, 7803.687852485894, 7866.881996770053, 7776.922230777676, 7817.5309481431295, 7857.724979625743, 7861.056673199253, 7861.842763144762, 40393.59606403957, 41088.38367424491, 41111.58888411138, 41133.588664113275, 41160.176796464206, 2656.973430265711, 2825.816321939067, 2860.6281183446017, 3087.6140482439696, 3219.4848824188016, 29827.85086074556, 30132.24669383261, 30511.389772204653, 30643.0, 30649.080527583985, 3410.5225268462186, 3418.5214070030215, 3463.5497385339995, 3471.340445315407, 3485.3552092862647, 264768.0, 265881.0, 267823.0, 267995.0, 268743.0, 55384.0, 56102.999999999185, 56137.438625614035, 56190.15714764282, 56214.43785562174, 55803.441965580634, 58834.70582647059, 58877.70561147167, 60525.39474605198, 60703.392966070656, 14523.78214326786, 14696.338664760111, 14732.631684207981, 14736.631584210267, 14741.631459213391, 11544.88455115455, 11766.411679415995, 11776.941115294369, 11780.234284771463, 11788.941055294668, 15107.848921510864, 15461.690766184838, 15494.457693980656, 16135.67728645444, 16650.916745416194, 5772.769089236467, 5821.388754180834, 5883.14694369314, 5921.496672782776, 6000.669963152069, 798.7044793426469, 929.4423345992485, 1017.4963393120453, 1018.5416562546884, 1042.2547878267076, 26923.461530769277, 27992.44015119727, 28619.856900715364, 28641.57037644437, 28749.137525874256, 984.9015098490094, 1005.301315585661, 1063.2397835547465, 1063.3747475852806, 1070.6199299248653, 14672.559823205322, 14801.333939972727, 14860.479883204036, 15117.244137793066, 15278.618034549225, 378279.1946442972, 378325.0, 379695.0, 379792.0, 380882.0, 50221.74889125531, 50369.74815125901, 50508.0, 50917.49082509201, 51188.74405628022, 1189.3399163464187, 1193.3555879824971, 1200.0478822097737, 1215.3497878635064, 1219.4390580333147, 26208.0, 27740.30649233785, 27771.722282777722, 27829.0, 28148.0, 44514.0, 44613.33080003737, 44919.55080449153, 44941.32588011117, 44998.77500612476, 316973.0, 317008.0, 317899.0, 318334.0, 319349.0, 30828.845855770578, 31139.84430077835, 37486.25027499489, 37916.810415947744, 38329.23341533098, 42146.57853421426, 42829.0, 42897.35653965131, 43743.0, 43937.78031109824, 32982.835085824416, 33198.66801332052, 33270.0, 33719.831400842835, 33941.66058339385, 36056.27887442184, 36641.45037824381, 36765.44851827278, 36796.0, 37041.62958370382, 35834.0, 36581.63418365889, 36713.63286367209, 36990.815045924595, 37011.07472313106, 31179.220519487193, 32670.183245419055, 33147.0, 33287.50068749019, 33319.0, 24445.0, 25254.0, 25413.364665883502, 25541.61687574725, 25559.43951480374], "value": 17635.83174671219, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.48649147947145, 368.7234574069448, 368.9391250443677, 380.8400471801843, 393.0272575375945, 15736.370545178193, 16364.83635163648, 16451.50645480636, 16674.916625416856, 17027.82972170278, 15742.370305187807, 15955.12246826424, 16914.069726165057, 16931.407400740976, 16938.3224671013, 5059.139946209144, 5188.8702782430555, 5194.662346947455, 5255.316808814849, 5261.684298942057, 3670.4861319415304, 3838.3474809282347, 3865.594112618177, 3869.903252418698, 5156.510131537498, 5722.771089156428, 6007.6996150192535, 6044.637321760686, 6137.294211165706, 6161.0, 6027.065804800263, 6074.757009719606, 6092.725827337758, 6098.756049758004, 6104.633721976651, 3350.547676063749, 4980.352554167971, 5238.711870847102, 5363.704996225206, 5372.059889519358, 18662.720059199124, 19186.904065479725, 19842.801571984382, 19938.900305498526, 20000.899995500076, 1844.1793401936143, 1853.1938606705992, 1931.671615825313, 2027.4019164346553, 2377.429416939922, 12202.755944881053, 12282.385880706019, 12535.43590538428, 12654.683632909251, 12799.0, 1675.8324167583266, 1742.5208067781334, 1750.4923572164057, 1810.2849374497132, 1860.4325680667391, 68418.3158168417, 68833.65583172101, 69136.65431672809, 69206.30793692099, 69465.65267173683, 8833.911660883437, 8997.640094396282, 9177.705573606598, 9219.585118669676, 9335.393199442015, 11869.5845645402, 11972.0, 11985.460654270579, 12025.218360806519, 12055.57805476804, 7055.435565154775, 7128.465365097535, 7146.464015198881, 7203.243659415791, 7233.168185658611, 6932.0988271524375, 6978.267281935425, 7079.82300442493, 7131.643417829087, 7132.536385134949, 5587.776488940397, 5693.772249110072, 5710.2576665033275, 5768.567357448208, 5854.853628659318, 1520.8290713861722, 1692.424575644287, 1694.246060503089, 1728.6542691461507, 1771.8493928016262, 859.1494420523636, 901.5086777706166, 928.5171710710528, 964.9421034737798, 969.2343048991359, 16109.275082621076, 16416.589585260226, 16574.254158562893, 16600.335986560644, 17117.14414279306, 826.4544903696146, 843.9240468357877, 844.9915500844913, 845.3237410071918, 856.8543347630917, 8275.95862020698, 8721.912780872237, 9206.355555111079, 9230.815383692288, 9318.487483188354, 290096.0, 292236.0, 387759.0, 405963.0, 409937.0, 81017.0, 81311.5934420336, 83781.0, 84506.57746711228, 85586.0, 981.4062492192121, 996.7209181429212, 997.7106639074732, 1018.5060245780791, 1027.5222021759917, 15053.172075535513, 15107.39570417215, 15248.313825878084, 15520.5343839685, 15767.605809854387, 39013.41479877747, 39280.2143957125, 39491.605083948794, 39597.20805583814, 39718.80140599279, 52986.47013529815, 53453.0, 53746.46253537414, 54085.459145408044, 54147.18779218236, 5989.52083833301, 6063.0, 7620.923790762243, 7645.6559454823555, 7923.405744569065, 10540.420276884844, 11127.165462590176, 11135.220534562826, 11422.143339249757, 11600.18798684084, 9837.409755414697, 10051.346662466916, 10055.195584353089, 10080.445575493419, 10161.187105031728, 9993.500324983866, 10025.598976040877, 10131.594736210469, 10304.227182961158, 10336.689899303034, 9769.706908792748, 9824.65613703517, 10083.092521673085, 10111.090001899864, 10138.341007834468, 7423.109226892808, 7494.400447964041, 7590.81022974408, 7625.046869141357, 7794.4543881929985, 9340.766480838034, 9879.555420006262, 10041.799164016533, 10077.09306162449, 10284.09744197326], "value": 8210.409924156384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1213.9210951288171, 1346.7845144776834, 1416.9149851008938, 1465.7508223601988, 1723.913804309785, 6828.52200345976, 7833.255840695132, 8078.757637270884, 8083.555404452753, 8319.66721331146, 8028.598570071502, 8167.346612271019, 8169.714060007901, 8183.9590802045905, 8203.138670439608, 1859.3399343233161, 2138.77542858, 2156.975436667582, 2188.6607575825774, 2218.0684112672716, 2210.4694873230387, 2236.3626366485555, 2239.74242962059, 2240.574290884727, 2241.05875532276, 2197.494576247464, 2213.889305534725, 2236.3067449090836, 2238.7985081342676, 2240.9775902241013, 1803.8647101467443, 2076.5223998480433, 2162.37291185556, 2165.4911095892453, 2170.815480684144, 2157.9028943697413, 2179.1283486605325, 2180.8146307563875, 2184.584928863527, 2185.8142057925097, 8127.512349259064, 8176.713815016446, 8183.79540511486, 8184.345252379855, 8198.549079800609, 4555.521670224645, 4670.462896766881, 4675.088357770236, 4676.929846052312, 4690.460597031317, 2717.5108480473505, 2860.284928767808, 2885.812422192551, 2896.2904088498244, 2897.420515896829, 890.6838072484239, 901.9684311049148, 908.1690253418114, 1753.6317373351612, 1808.1953530678852, 10810.189235807346, 10882.23824332297, 10882.40146791926, 10891.292066015763, 10914.945425272823, 4009.3785463253244, 4057.634812866856, 4124.546299907008, 4156.521999969982, 4168.333066709312, 8404.495730256203, 8445.619947102396, 8458.577071146541, 8469.195426434479, 8481.109483504266, 4533.161365147458, 4588.0, 4590.724556526619, 4592.977035114803, 4593.19619066662, 3733.7199710021855, 4152.273352163359, 4280.700350975464, 4292.978535107304, 4337.631301339358, 3241.546183534307, 3344.6153692325693, 3358.529805827186, 3367.3770352484867, 3397.371486275047, 1005.3515482513737, 1007.4610083605236, 1023.2428003277521, 1023.97440063999, 1044.3159730376615, 672.7544446277074, 763.1872056260065, 801.3308887079354, 802.8217993939116, 817.5707753429378, 5219.739013049332, 5221.536235618173, 5289.550388216968, 5301.522862942354, 5576.86057848557, 842.30509829391, 843.1694780641063, 845.5941148248875, 899.7030979776658, 900.8288425199191, 3456.6370531094376, 3463.826808659607, 3470.9479357809655, 3500.2474467989505, 3641.7268704847243, 9806.460644664612, 9934.950325248472, 10164.4917754112, 10170.338927969658, 10260.538275777608, 10145.94927025375, 10148.695539133838, 10149.492525373702, 10161.034701703325, 10171.389716617026, 7140.428765698835, 7360.33756961876, 7362.9631851840395, 7505.587192704454, 7523.887141692879, 5124.1032819257225, 5133.486651334837, 5138.100832354248, 5178.223266510054, 5234.11020126587, 8810.427322224035, 9138.360314778167, 9251.167394934488, 9293.395929264576, 9298.442093474414, 9279.211267042107, 9494.05059494045, 9519.286053545873, 9544.284178686765, 9608.231341492525, 5870.119482077723, 5922.637227295964, 6053.697315134314, 6346.428821406095, 6447.6131432114225, 6689.264180939996, 7986.321162701235, 7997.840043198987, 7998.84002319962, 8008.919910801051, 6886.793396198122, 7000.8949865753075, 7015.052967849275, 7071.858562828817, 7088.787336379917, 6843.315668433117, 6929.480288978448, 6949.895751563629, 6980.860382792214, 7003.4747393944635, 6570.737170513126, 6633.436157926631, 6660.600363978177, 6663.500237482305, 6690.799276021728, 4250.3199488081755, 4536.206163921366, 4578.06149739296, 4578.45058592971, 4595.839145629887, 4528.3660287559105, 4541.3188021797, 4588.426446694163, 4604.746738929391, 4618.838340658061], "value": 4159.89627578508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.97150270724273, 301.6485794049932, 306.5218259515158, 306.9232691827043, 309.63308479451854, 4780.737059461728, 4793.209120495118, 4800.447948485925, 4800.90398192036, 4813.422389313283, 4681.602063824571, 4703.2945058241285, 4745.454272758634, 4755.574656924967, 4766.070616229837, 3550.3786837303496, 3620.855165793378, 3663.68858647014, 3731.4589384539227, 3772.4529943158227, 3684.5394325709285, 3728.8694895678655, 3739.7943113128767, 3749.8312575934146, 3750.6061863504347, 3546.5389499365174, 3696.131409118855, 3697.334479793636, 3708.8701895433665, 3712.2761061593, 3586.892393228194, 3716.646918542734, 3721.5906250312446, 3730.0488375464083, 3740.6446387593273, 3300.5214243934734, 3303.5705358303508, 3311.2218628622254, 3312.685294896981, 3325.1354647791504, 4522.706024108423, 4541.182587134314, 4545.545445455461, 4566.977165114186, 4570.680052396334, 4025.4565633639377, 4216.430781844442, 4271.658267338606, 4295.8496452624, 4300.612944834948, 4989.501049895018, 4990.750462476862, 5006.746963866275, 5014.799408023675, 5019.0, 3608.3144202601684, 3614.638536146391, 3618.710503159767, 3619.3666108431185, 3620.2216523447323, 5061.974690126563, 5215.478452154792, 5255.290535777697, 5255.316808814868, 5295.7881684732565, 3633.6184700606586, 3651.6348365163803, 3651.8721844735305, 3652.634736526326, 3659.9817000914827, 3694.7783133011567, 3716.201016781351, 3718.888433347004, 3725.4411838224482, 3727.7204209684382, 4221.957780422218, 4249.596288352602, 4254.468191476066, 4262.3180291153885, 4267.3598960155605, 4813.940932994736, 4889.584385327216, 4911.361523002059, 4949.975250123726, 4960.305557221992, 1251.4994002399112, 1272.3956120842527, 1277.1060257819563, 1283.8523569789593, 1284.5054653958293, 808.2523665609287, 814.226484839405, 852.2968550945495, 852.3522123186423, 860.5998210831868, 4418.911621767546, 4422.20400327944, 4423.60187583119, 4430.977845110819, 4448.755318457516, 5046.325447512824, 5051.873703157377, 5092.9745351273, 5110.66780659256, 5118.897622047538, 4211.515675697334, 4380.386745855582, 4414.757188354607, 4427.5572442755465, 4454.443194600675, 2693.3670587411943, 2696.772968299419, 2708.7155848636003, 2710.512107820611, 2718.850463224502, 4793.952060479351, 4797.472278049412, 4800.35195248637, 4831.4685384607665, 4835.298881662139, 5020.422651395063, 5061.746912654353, 5159.948400516022, 5162.6128040397125, 5187.948120518822, 4785.712857228438, 4791.976040119777, 4820.9517904821205, 4823.638227132979, 4849.2968519564465, 4991.675541089818, 5006.874828129326, 5013.749312534285, 5021.347224860745, 5065.189569668835, 4763.333133361401, 4936.185529387611, 4945.703257804544, 4953.603711703127, 4970.055689418999, 4770.546798054179, 4776.928346074742, 4809.24462571166, 4823.890505183757, 4839.330431001299, 3604.693601043941, 3606.5852426971232, 3611.602723700443, 3615.9819200903826, 3616.3129005488872, 4789.491310237264, 5039.949600503948, 5044.1424957758, 5076.18780995039, 5102.4897510248675, 4878.512053823476, 4889.975550122226, 4891.779869905791, 4894.706317620954, 4919.926201106915, 4892.412910450768, 4894.559489645949, 4903.338049363433, 4904.386951631046, 4912.38595175603, 4682.836100736458, 4806.182948898766, 4837.879053023703, 4838.177509823409, 4841.298011788342, 4849.793344028388, 4917.442929676619, 4935.185694360391, 4937.456879743298, 4940.75296235194, 4785.880352991064, 4800.4479484859685, 4827.42070951488, 4847.684900481458, 4856.78144483492], "value": 3743.1517525829686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.1249975040434, 577.4369989260472, 589.9557533185013, 610.6519284008117, 696.561166465127, 12028.03775697942, 12056.69858253543, 12206.81689774653, 12245.693857653563, 12336.568220112298, 12522.499100035988, 12562.811557826617, 12677.239365638068, 12680.936595317033, 12701.4919403224, 632.50348476446, 766.5056038854949, 768.0476209500207, 797.453744185232, 806.8870358149863, 804.2600807257309, 804.6700852650414, 807.6648191000728, 807.9313258373045, 811.2090711556244, 846.8137009857821, 849.2017503546647, 849.2441726863096, 850.2135524639715, 850.2432834777053, 658.7002913674266, 817.9754607361789, 842.3513894301415, 844.0588743550958, 845.813920937399, 610.6946526736632, 611.2298503885092, 611.2634275697818, 611.9418655227746, 612.718149651161, 12704.491820327175, 12763.425645845866, 12766.80849787254, 12770.233785972778, 12775.29735864527, 11825.526978920832, 12287.508499660093, 12318.81521777174, 12447.564335248222, 12598.244105353617, 11163.350696776562, 11518.88481115195, 11745.412729363497, 11769.705757356134, 12257.816132758016, 4113.650339721127, 4158.355454904495, 4180.686448516373, 4213.262679031188, 4279.422277992462, 53435.0, 53849.73075134638, 53896.73051634717, 53921.46078539204, 53946.46053539493, 9004.63981440735, 9173.770655733526, 9714.125728684452, 9714.708558743248, 9734.36726612768, 17814.198361073784, 17825.286988520314, 17825.46523604294, 17839.197236124404, 17844.375446859296, 6386.744530218833, 6430.64631445275, 6493.545451818327, 6499.220093588705, 6632.83417914556, 3485.9302813944087, 3488.0582242794303, 3553.8390143860142, 3557.72341537462, 3574.91062723434, 2791.260316016257, 2869.827810331387, 2870.8708108135183, 2871.2821794551364, 2877.4101309231555, 497.4229893323727, 515.1371452816518, 520.22486495122, 521.8356217791384, 525.3669328459198, 454.85899371195035, 468.9132510485503, 509.2539429735455, 518.4769491306506, 525.4823998361611, 7454.105507339045, 7547.811304717426, 7619.923800762032, 7741.961290193513, 7802.29779319864, 396.6747267240835, 475.4033687721887, 495.5193462341523, 498.8902441462872, 508.58296197118005, 3345.7825241359233, 3441.5181874537584, 3462.740294477924, 3532.0816587687386, 3588.300281445145, 76945.23054769493, 82007.0, 86852.13147868567, 87877.0, 89926.0, 53005.0, 75967.24032759601, 76045.0, 77024.2055523925, 78439.0, 44826.55173448289, 50243.74878125586, 68731.3126868725, 69809.65095174593, 70639.2936070643, 7919.960400197962, 8086.757397278091, 8195.71315003972, 8203.015638123463, 8216.21945915137, 39972.40041399439, 40443.79778101091, 40747.796261018506, 42260.0, 42870.78564607157, 58176.0, 58479.70760146172, 58951.41048589631, 59374.70312648409, 60184.69907650434, 10731.892681073401, 10909.127269818237, 10974.286671366335, 11008.009279164913, 11012.513310702952, 8195.64771812668, 12285.877141228473, 12791.936040319739, 12891.290978996245, 13097.672558186121, 10114.443705596263, 10433.373997560171, 10636.0, 11142.164337674545, 11166.106711463226, 11181.944090279496, 11295.943520282346, 11296.322220666787, 11614.072800939151, 11621.5351385947, 10891.400972946563, 11024.44877756125, 11142.610008649659, 11327.773444531229, 11376.374299413612, 9820.626011225764, 9826.459544724823, 9943.651972180938, 10295.3822770634, 10324.587016519556, 9443.33896627257, 9630.855537167088, 9670.468124253233, 9722.513874306114, 9758.365706229073], "value": 6246.240760144594, "unit": "score"}], "name": "dromaeo_css", "value": 6354.662310441536, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 115.0, 114.0, 112.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 132.0, 186.0, 133.0, 130.0, 154.0, 132.0, 186.0, 130.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 164.0, 163.0, 161.0, 164.0, 163.0, 162.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 128.0, 77.0, 75.0, 74.0, 76.0, 103.0, 77.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 125.0, 87.0, 86.0, 87.0, 120.0, 86.0, 87.0, 137.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 63.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 67.0, 65.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 90.0, 84.0, 85.0, 85.0, 86.0, 86.0, 117.0, 84.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 133.0, 150.0, 156.0, 131.0, 131.0, 136.0, 130.0, 147.0, 137.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 171.0, 173.0, 172.0, 174.0, 170.0, 172.0, 166.0, 167.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1557.8, "alertThreshold": 2.0}]} 04:40:24 INFO - Return code: 0 04:40:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:40:24 ERROR - # TBPL SUCCESS # 04:40:24 INFO - Running post-action listener: _resource_record_post_action 04:40:24 INFO - ##### 04:40:24 INFO - ##### Finished run-tests step (success) 04:40:24 INFO - ##### 04:40:24 INFO - Running post-run listener: _resource_record_post_run 04:40:24 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 529727488; Read time: 16; Write time: 464728 04:40:24 INFO - TinderboxPrint: CPU usage
13.1% 04:40:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:40:24 INFO - TinderboxPrint: I/O write bytes / time
529,727,488 / 464,728 04:40:24 INFO - TinderboxPrint: CPU idle
8,329.3 (86.9%) 04:40:24 INFO - TinderboxPrint: CPU user
1,214.3 (12.7%) 04:40:24 INFO - TinderboxPrint: Swap in / out
0 / 0 04:40:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237891584; Read time: 0; Write time: 266792 04:40:24 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287895552; Read time: 16; Write time: 197456 04:40:24 INFO - Running post-run listener: _upload_blobber_files 04:40:24 INFO - Blob upload gear active. 04:40:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:40:24 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:40:24 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:40:25 INFO - (blobuploader) - INFO - Open directory for files ... 04:40:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:40:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:40:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:26 INFO - (blobuploader) - INFO - Done attempting. 04:40:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:40:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:40:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:30 INFO - (blobuploader) - INFO - Done attempting. 04:40:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:40:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:40:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:31 INFO - (blobuploader) - INFO - Done attempting. 04:40:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:40:31 INFO - Return code: 0 04:40:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:40:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:40:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8be0a069e911d3b3d1b2a573ceed055a05e444835e9a7d13e953a6d2d486addf109463e10602913fc6a1995d9c86d3d479d8ec11dc24ccc976a158fad4441399", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9d606d233c8655a55517bdc6036765c81367ea5744662ae75ce689da179e4ed454f806c0d69fd4bcd9c0bf10eea34af00d581db842a4e09668825e1d68844bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d699ff02040b736bfd3d8eab807974b03dc5efb1aaa76763c746a1ec9fb5641270de9ccf01f20acaa18722c2366b13ae3784bcb4295ad9b71a6d28363de4582b"} 04:40:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:40:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:40:31 INFO - Contents: 04:40:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8be0a069e911d3b3d1b2a573ceed055a05e444835e9a7d13e953a6d2d486addf109463e10602913fc6a1995d9c86d3d479d8ec11dc24ccc976a158fad4441399", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9d606d233c8655a55517bdc6036765c81367ea5744662ae75ce689da179e4ed454f806c0d69fd4bcd9c0bf10eea34af00d581db842a4e09668825e1d68844bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d699ff02040b736bfd3d8eab807974b03dc5efb1aaa76763c746a1ec9fb5641270de9ccf01f20acaa18722c2366b13ae3784bcb4295ad9b71a6d28363de4582b"} 04:40:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:40:31 INFO - Copying logs to upload dir... 04:40:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:40:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.738976 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-08 04:40:30.992983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 04:40:30.996722) ========= 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=00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8be0a069e911d3b3d1b2a573ceed055a05e444835e9a7d13e953a6d2d486addf109463e10602913fc6a1995d9c86d3d479d8ec11dc24ccc976a158fad4441399", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9d606d233c8655a55517bdc6036765c81367ea5744662ae75ce689da179e4ed454f806c0d69fd4bcd9c0bf10eea34af00d581db842a4e09668825e1d68844bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d699ff02040b736bfd3d8eab807974b03dc5efb1aaa76763c746a1ec9fb5641270de9ccf01f20acaa18722c2366b13ae3784bcb4295ad9b71a6d28363de4582b"} build_url:https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/WIiIvJPSQPK_K9Q2deX0_w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8be0a069e911d3b3d1b2a573ceed055a05e444835e9a7d13e953a6d2d486addf109463e10602913fc6a1995d9c86d3d479d8ec11dc24ccc976a158fad4441399", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9d606d233c8655a55517bdc6036765c81367ea5744662ae75ce689da179e4ed454f806c0d69fd4bcd9c0bf10eea34af00d581db842a4e09668825e1d68844bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d699ff02040b736bfd3d8eab807974b03dc5efb1aaa76763c746a1ec9fb5641270de9ccf01f20acaa18722c2366b13ae3784bcb4295ad9b71a6d28363de4582b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 04:40:31.024822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:40:31.025176) ========= 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=00204705a9daa57ed339a427000001b9-1465384786.51426-1008096431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004653 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 04:40:31.109140) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 04:40:31.109467) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 04:40:31.109752) ========= ========= Total master_lag: 0.18 =========