builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1466340685.59 results: success (0) buildid: 20160619030256 builduid: e86840d1ebe44777a2f1306630fc7688 revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.589678) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.590101) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.590382) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.650380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.650678) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-19 05:51:27-- 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% 66.8M=0s 2016-06-19 05:51:27 (66.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145304 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.817928) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.818253) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020705 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.873130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:25.873539) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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 3ce53bd1e25b93140484d3933c9339a829e0c1eb --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=5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-19 05:51:27,636 truncating revision to first 12 chars 2016-06-19 05:51:27,636 Setting DEBUG logging. 2016-06-19 05:51:27,636 attempt 1/10 2016-06-19 05:51:27,636 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ce53bd1e25b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-19 05:51:27,968 unpacking tar archive at: mozilla-central-3ce53bd1e25b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.661987 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:26.556630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:26.556935) ========= script_repo_revision: 3ce53bd1e25b93140484d3933c9339a829e0c1eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:26.557475) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:26.557762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-19 05:51:26.574330) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-19 05:51:26.574626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:28 INFO - MultiFileLogger online at 20160619 05:51:28 in /builds/slave/test 05:51:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:51:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:28 INFO - {'append_to_log': False, 05:51:28 INFO - 'base_work_dir': '/builds/slave/test', 05:51:28 INFO - 'blob_upload_branch': 'Firefox', 05:51:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:28 INFO - 'branch': 'Firefox', 05:51:28 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:28 INFO - 'config_files': ('talos/linux_config.py',), 05:51:28 INFO - 'default_actions': ('clobber', 05:51:28 INFO - 'read-buildbot-config', 05:51:28 INFO - 'download-and-extract', 05:51:28 INFO - 'populate-webroot', 05:51:28 INFO - 'create-virtualenv', 05:51:28 INFO - 'install', 05:51:28 INFO - 'run-tests'), 05:51:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:28 INFO - 'download_minidump_stackwalk': True, 05:51:28 INFO - 'download_symbols': 'ondemand', 05:51:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:28 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:28 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:28 INFO - 'installer_path': 'installer.exe', 05:51:28 INFO - 'log_level': 'info', 05:51:28 INFO - 'log_name': 'talos', 05:51:28 INFO - 'log_to_console': True, 05:51:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:28 INFO - 'opt_config_files': (), 05:51:28 INFO - 'pip_index': False, 05:51:28 INFO - 'sps_profile': False, 05:51:28 INFO - 'sps_profile_interval': 0, 05:51:28 INFO - 'suite': 'dromaeojs', 05:51:28 INFO - 'system_bits': '32', 05:51:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:28 INFO - 'title': 'talos-linux64-ix-051', 05:51:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:28 INFO - 'use_talos_json': True, 05:51:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:28 INFO - 'work_dir': 'build'} 05:51:28 INFO - ##### 05:51:28 INFO - ##### Running clobber step. 05:51:28 INFO - ##### 05:51:28 INFO - Running pre-action listener: _resource_record_pre_action 05:51:28 INFO - Running main action method: clobber 05:51:28 INFO - rmtree: /builds/slave/test/build 05:51:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:28 INFO - Running post-action listener: _resource_record_post_action 05:51:28 INFO - ##### 05:51:28 INFO - ##### Finished clobber step (success) 05:51:28 INFO - ##### 05:51:28 INFO - ##### 05:51:28 INFO - ##### Running read-buildbot-config step. 05:51:28 INFO - ##### 05:51:28 INFO - Running pre-action listener: _resource_record_pre_action 05:51:28 INFO - Running main action method: read_buildbot_config 05:51:28 INFO - Using buildbot properties: 05:51:28 INFO - { 05:51:28 INFO - "project": "", 05:51:28 INFO - "product": "firefox", 05:51:28 INFO - "script_repo_revision": "production", 05:51:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:51:28 INFO - "repository": "", 05:51:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:51:28 INFO - "buildid": "20160619030256", 05:51:28 INFO - "stage_platform": "linux64-pgo", 05:51:28 INFO - "basedir": "/builds/slave/test", 05:51:28 INFO - "nightly_build": "True", 05:51:28 INFO - "buildnumber": 349, 05:51:28 INFO - "slavename": "talos-linux64-ix-051", 05:51:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:51:28 INFO - "platform": "ubuntu64_hw", 05:51:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:51:28 INFO - "branch": "mozilla-central", 05:51:28 INFO - "repo_path": "mozilla-central", 05:51:28 INFO - "revision": "3ce53bd1e25b93140484d3933c9339a829e0c1eb", 05:51:28 INFO - "pgo_build": "True", 05:51:28 INFO - "builduid": "e86840d1ebe44777a2f1306630fc7688", 05:51:28 INFO - "slavebuilddir": "test" 05:51:28 INFO - } 05:51:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:51:28 INFO - Running post-action listener: _resource_record_post_action 05:51:28 INFO - ##### 05:51:28 INFO - ##### Finished read-buildbot-config step (success) 05:51:28 INFO - ##### 05:51:28 INFO - ##### 05:51:28 INFO - ##### Running download-and-extract step. 05:51:28 INFO - ##### 05:51:28 INFO - Running pre-action listener: _resource_record_pre_action 05:51:28 INFO - Running main action method: download_and_extract 05:51:28 INFO - mkdir: /builds/slave/test/build/tests 05:51:28 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')]} 05:51:28 INFO - https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:51:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:51:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:51:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:34 INFO - Downloaded 1361 bytes. 05:51:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:51:34 INFO - Using the following test package requirements: 05:51:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:51:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:51:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'jsshell-linux-x86_64.zip'], 05:51:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:51:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:51:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:51:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:51:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:51:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:34 INFO - https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:51:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:51:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:42 INFO - Downloaded 24220820 bytes. 05:51:42 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'] 05:51:42 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 05:51:43 INFO - Return code: 0 05:51:43 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 05:51:43 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')]} 05:51:43 INFO - https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:51:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:51:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:47 INFO - Downloaded 24220820 bytes. 05:51:47 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'] 05:51:47 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 05:51:48 INFO - Return code: 0 05:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:48 INFO - https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:49 INFO - Downloaded 14405384 bytes. 05:51:49 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'] 05:51:49 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 05:51:50 INFO - Return code: 0 05:51:50 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')]} 05:51:50 INFO - https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:51:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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 05:51:51 INFO - Downloaded 60126357 bytes. 05:51:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:51 INFO - mkdir: /builds/slave/test/properties 05:51:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:51 INFO - Contents: 05:51:51 INFO - build_url:https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:51:52 INFO - Running post-action listener: _resource_record_post_action 05:51:52 INFO - Running post-action listener: set_extra_try_arguments 05:51:52 INFO - ##### 05:51:52 INFO - ##### Finished download-and-extract step (success) 05:51:52 INFO - ##### 05:51:52 INFO - ##### 05:51:52 INFO - ##### Running populate-webroot step. 05:51:52 INFO - ##### 05:51:52 INFO - Running pre-action listener: _resource_record_pre_action 05:51:52 INFO - Running main action method: populate_webroot 05:51:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:52 INFO - '--tppagecycles', 05:51:52 INFO - '7'], 05:51:52 INFO - 'tests': ['tsvgm']}}, 05:51:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:51:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:51:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['damp', 'tps']}, 05:51:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'tests': ['damp', 'tps']}, 05:51:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['dromaeo_dom']}, 05:51:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['basic_compositor_video']}, 05:51:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:51:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'other-e10s': {'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['a11yr', 05:51:52 INFO - 'ts_paint', 05:51:52 INFO - 'tpaint', 05:51:52 INFO - 'sessionrestore', 05:51:52 INFO - 'sessionrestore_no_auto_restore', 05:51:52 INFO - 'tabpaint']}, 05:51:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['tsvgx', 05:51:52 INFO - 'tsvgr_opacity', 05:51:52 INFO - 'tart', 05:51:52 INFO - 'tscrollx', 05:51:52 INFO - 'cart']}, 05:51:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:51:52 INFO - 'tsvgr_opacity', 05:51:52 INFO - 'tart', 05:51:52 INFO - 'tscrollx', 05:51:52 INFO - 'cart']}, 05:51:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-e10s'], 05:51:52 INFO - 'tests': ['tp5o']}, 05:51:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'tests': ['tp5o']}, 05:51:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'talos_options': ['--disable-e10s', 05:51:52 INFO - '--xperf_path', 05:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:52 INFO - 'tests': ['tp5n']}, 05:51:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:52 INFO - 'talos_options': ['--xperf_path', 05:51:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:52 INFO - 'tests': ['tp5n']}}, 05:51:52 INFO - 'talos.zip': {'path': '', 05:51:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:52 INFO - Running post-action listener: _resource_record_post_action 05:51:52 INFO - ##### 05:51:52 INFO - ##### Finished populate-webroot step (success) 05:51:52 INFO - ##### 05:51:52 INFO - ##### 05:51:52 INFO - ##### Running create-virtualenv step. 05:51:52 INFO - ##### 05:51:52 INFO - Running pre-action listener: _resource_record_pre_action 05:51:52 INFO - Running main action method: create_virtualenv 05:51:52 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:52 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 05:51:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:52 INFO - Using real prefix '/usr' 05:51:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:55 INFO - Installing pip.................done. 05:51:55 INFO - Return code: 0 05:51:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:51:55 INFO - Using env: {'DISPLAY': ':0', 05:51:55 INFO - 'HOME': '/home/cltbld', 05:51:55 INFO - 'LANG': 'en_US.UTF-8', 05:51:55 INFO - 'LANGUAGE': 'en_US:en', 05:51:55 INFO - 'LOGNAME': 'cltbld', 05:51:55 INFO - 'MAIL': '/var/mail/cltbld', 05:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:55 INFO - 'MOZ_NO_REMOTE': '1', 05:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:55 INFO - 'NO_EM_RESTART': '1', 05:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:55 INFO - 'PWD': '/builds/slave/test', 05:51:55 INFO - 'SHELL': '/bin/bash', 05:51:55 INFO - 'SHLVL': '1', 05:51:55 INFO - 'TERM': 'linux', 05:51:55 INFO - 'TMOUT': '86400', 05:51:55 INFO - 'USER': 'cltbld', 05:51:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:55 INFO - '_': '/tools/buildbot/bin/python'} 05:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:55 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 05:51:55 INFO - Cleaning up... 05:51:55 INFO - Return code: 0 05:51:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:51:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:51:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:51:55 INFO - Using env: {'DISPLAY': ':0', 05:51:55 INFO - 'HOME': '/home/cltbld', 05:51:55 INFO - 'LANG': 'en_US.UTF-8', 05:51:55 INFO - 'LANGUAGE': 'en_US:en', 05:51:55 INFO - 'LOGNAME': 'cltbld', 05:51:55 INFO - 'MAIL': '/var/mail/cltbld', 05:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:55 INFO - 'MOZ_NO_REMOTE': '1', 05:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:55 INFO - 'NO_EM_RESTART': '1', 05:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:55 INFO - 'PWD': '/builds/slave/test', 05:51:55 INFO - 'SHELL': '/bin/bash', 05:51:55 INFO - 'SHLVL': '1', 05:51:55 INFO - 'TERM': 'linux', 05:51:55 INFO - 'TMOUT': '86400', 05:51:55 INFO - 'USER': 'cltbld', 05:51:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:55 INFO - '_': '/tools/buildbot/bin/python'} 05:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:55 INFO - Downloading/unpacking psutil>=3.1.1 05:51:55 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 05:51:55 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 05:51:55 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 05:51:55 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 05:51:55 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 05:51:55 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 05:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:57 INFO - Installing collected packages: psutil 05:51:57 INFO - Running setup.py install for psutil 05:51:57 INFO - building 'psutil._psutil_linux' extension 05:51:57 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 05:51:57 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 05:51:57 INFO - building 'psutil._psutil_posix' extension 05:51:57 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 05:51:57 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 05:51:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:57 INFO - Successfully installed psutil 05:51:57 INFO - Cleaning up... 05:51:57 INFO - Return code: 0 05:51:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:51:58 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')]} 05:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:58 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')]} 05:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:58 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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:51:58 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 05:51:58 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 05:51:58 INFO - Using env: {'DISPLAY': ':0', 05:51:58 INFO - 'HOME': '/home/cltbld', 05:51:58 INFO - 'LANG': 'en_US.UTF-8', 05:51:58 INFO - 'LANGUAGE': 'en_US:en', 05:51:58 INFO - 'LOGNAME': 'cltbld', 05:51:58 INFO - 'MAIL': '/var/mail/cltbld', 05:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:58 INFO - 'MOZ_NO_REMOTE': '1', 05:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:58 INFO - 'NO_EM_RESTART': '1', 05:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:58 INFO - 'PWD': '/builds/slave/test', 05:51:58 INFO - 'SHELL': '/bin/bash', 05:51:58 INFO - 'SHLVL': '1', 05:51:58 INFO - 'TERM': 'linux', 05:51:58 INFO - 'TMOUT': '86400', 05:51:58 INFO - 'USER': 'cltbld', 05:51:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:58 INFO - '_': '/tools/buildbot/bin/python'} 05:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:00 INFO - Installing collected packages: mozsystemmonitor 05:52:00 INFO - Running setup.py install for mozsystemmonitor 05:52:00 INFO - Successfully installed mozsystemmonitor 05:52:00 INFO - Cleaning up... 05:52:00 INFO - Return code: 0 05:52:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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', '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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:52: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:52: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 jsonschema==2.5.1 05:52:00 INFO - Using env: {'DISPLAY': ':0', 05:52:00 INFO - 'HOME': '/home/cltbld', 05:52:00 INFO - 'LANG': 'en_US.UTF-8', 05:52:00 INFO - 'LANGUAGE': 'en_US:en', 05:52:00 INFO - 'LOGNAME': 'cltbld', 05:52:00 INFO - 'MAIL': '/var/mail/cltbld', 05:52:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:00 INFO - 'MOZ_NO_REMOTE': '1', 05:52:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:00 INFO - 'NO_EM_RESTART': '1', 05:52:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:00 INFO - 'PWD': '/builds/slave/test', 05:52:00 INFO - 'SHELL': '/bin/bash', 05:52:00 INFO - 'SHLVL': '1', 05:52:00 INFO - 'TERM': 'linux', 05:52:00 INFO - 'TMOUT': '86400', 05:52:00 INFO - 'USER': 'cltbld', 05:52:00 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:00 INFO - '_': '/tools/buildbot/bin/python'} 05:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:00 INFO - Downloading/unpacking jsonschema==2.5.1 05:52: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 05:52: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 05:52:00 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 05:52:00 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 05:52: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 05:52: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 05:52:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:52:02 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 05:52:02 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 05:52:02 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 05:52:02 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 05:52:02 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 05:52:02 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 05:52:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:02 INFO - warning: no files found matching '*.txt' 05:52:02 INFO - no previously-included directories found matching 'build' 05:52:02 INFO - no previously-included directories found matching 'dist' 05:52:02 INFO - no previously-included directories found matching '.git*' 05:52:02 INFO - Installing collected packages: jsonschema, functools32 05:52:02 INFO - Running setup.py install for functools32 05:52:02 INFO - warning: no files found matching '*.txt' 05:52:02 INFO - no previously-included directories found matching 'build' 05:52:02 INFO - no previously-included directories found matching 'dist' 05:52:02 INFO - no previously-included directories found matching '.git*' 05:52:02 INFO - Successfully installed jsonschema functools32 05:52:02 INFO - Cleaning up... 05:52:02 INFO - Return code: 0 05:52:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:52:02 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')]} 05:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:02 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')]} 05:52:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:02 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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:52:02 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 05:52:02 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 05:52:02 INFO - Using env: {'DISPLAY': ':0', 05:52:02 INFO - 'HOME': '/home/cltbld', 05:52:02 INFO - 'LANG': 'en_US.UTF-8', 05:52:02 INFO - 'LANGUAGE': 'en_US:en', 05:52:02 INFO - 'LOGNAME': 'cltbld', 05:52:02 INFO - 'MAIL': '/var/mail/cltbld', 05:52:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:02 INFO - 'MOZ_NO_REMOTE': '1', 05:52:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:02 INFO - 'NO_EM_RESTART': '1', 05:52:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:02 INFO - 'PWD': '/builds/slave/test', 05:52:02 INFO - 'SHELL': '/bin/bash', 05:52:02 INFO - 'SHLVL': '1', 05:52:02 INFO - 'TERM': 'linux', 05:52:02 INFO - 'TMOUT': '86400', 05:52:02 INFO - 'USER': 'cltbld', 05:52:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:02 INFO - '_': '/tools/buildbot/bin/python'} 05:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:04 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:52:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 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 05:52:05 INFO - Downloading docopt-0.6.1.tar.gz 05:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:05 INFO - Running setup.py install for blobuploader 05:52:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:52:05 INFO - Running setup.py install for requests 05:52:06 INFO - Running setup.py install for docopt 05:52:06 INFO - Successfully installed blobuploader requests docopt 05:52:06 INFO - Cleaning up... 05:52:06 INFO - Return code: 0 05:52:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:06 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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:52:06 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 05:52:06 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 05:52:06 INFO - Using env: {'DISPLAY': ':0', 05:52:06 INFO - 'HOME': '/home/cltbld', 05:52:06 INFO - 'LANG': 'en_US.UTF-8', 05:52:06 INFO - 'LANGUAGE': 'en_US:en', 05:52:06 INFO - 'LOGNAME': 'cltbld', 05:52:06 INFO - 'MAIL': '/var/mail/cltbld', 05:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:06 INFO - 'MOZ_NO_REMOTE': '1', 05:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:06 INFO - 'NO_EM_RESTART': '1', 05:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:06 INFO - 'PWD': '/builds/slave/test', 05:52:06 INFO - 'SHELL': '/bin/bash', 05:52:06 INFO - 'SHLVL': '1', 05:52:06 INFO - 'TERM': 'linux', 05:52:06 INFO - 'TMOUT': '86400', 05:52:06 INFO - 'USER': 'cltbld', 05:52:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:06 INFO - '_': '/tools/buildbot/bin/python'} 05:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:06 INFO - Running setup.py (path:/tmp/pip-BA5tGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:06 INFO - Running setup.py (path:/tmp/pip-rbFl1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:06 INFO - Running setup.py (path:/tmp/pip-zd7Ulf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:06 INFO - Running setup.py (path:/tmp/pip-ag2mcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:06 INFO - Running setup.py (path:/tmp/pip-awzthB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:06 INFO - Running setup.py (path:/tmp/pip-MuSJpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:06 INFO - Running setup.py (path:/tmp/pip-RdC_wF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:07 INFO - Running setup.py (path:/tmp/pip-cCZzVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:07 INFO - Running setup.py (path:/tmp/pip-bJq0B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:07 INFO - Running setup.py (path:/tmp/pip-EPScwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:07 INFO - Running setup.py (path:/tmp/pip-LiZ2HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:07 INFO - Running setup.py (path:/tmp/pip-n9i8CW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:07 INFO - Running setup.py (path:/tmp/pip-1Hzp9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:07 INFO - Running setup.py (path:/tmp/pip-7f7KyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:07 INFO - Running setup.py (path:/tmp/pip-9W2k0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:07 INFO - Running setup.py (path:/tmp/pip-Shm6r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:07 INFO - Running setup.py (path:/tmp/pip-CNKqYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:07 INFO - Running setup.py install for manifestparser 05:52:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:52:07 INFO - Running setup.py install for mozcrash 05:52:07 INFO - Running setup.py install for mozdebug 05:52:08 INFO - Running setup.py install for mozdevice 05:52:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Running setup.py install for mozfile 05:52:08 INFO - Running setup.py install for mozhttpd 05:52:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Running setup.py install for mozinfo 05:52:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Running setup.py install for mozInstall 05:52:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Running setup.py install for mozleak 05:52:08 INFO - Running setup.py install for mozlog 05:52:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Running setup.py install for moznetwork 05:52:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:52:08 INFO - Running setup.py install for mozprocess 05:52:08 INFO - Running setup.py install for mozprofile 05:52:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:52:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:52:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:52:09 INFO - Running setup.py install for mozrunner 05:52:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:52:09 INFO - Running setup.py install for mozscreenshot 05:52:09 INFO - Running setup.py install for moztest 05:52:09 INFO - Running setup.py install for mozversion 05:52:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:52:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:09 INFO - Cleaning up... 05:52:09 INFO - Return code: 0 05:52:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:09 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')]} 05:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:09 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')]} 05:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:09 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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:52:09 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 05:52:09 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 05:52:09 INFO - Using env: {'DISPLAY': ':0', 05:52:09 INFO - 'HOME': '/home/cltbld', 05:52:09 INFO - 'LANG': 'en_US.UTF-8', 05:52:09 INFO - 'LANGUAGE': 'en_US:en', 05:52:09 INFO - 'LOGNAME': 'cltbld', 05:52:09 INFO - 'MAIL': '/var/mail/cltbld', 05:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:09 INFO - 'MOZ_NO_REMOTE': '1', 05:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:09 INFO - 'NO_EM_RESTART': '1', 05:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:09 INFO - 'PWD': '/builds/slave/test', 05:52:09 INFO - 'SHELL': '/bin/bash', 05:52:09 INFO - 'SHLVL': '1', 05:52:09 INFO - 'TERM': 'linux', 05:52:09 INFO - 'TMOUT': '86400', 05:52:09 INFO - 'USER': 'cltbld', 05:52:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:09 INFO - '_': '/tools/buildbot/bin/python'} 05:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:52:09 INFO - Running setup.py (path:/tmp/pip-KPqoSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:52:09 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)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:52:09 INFO - Running setup.py (path:/tmp/pip-RcQySZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:52:09 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)) 05:52:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:52:09 INFO - Running setup.py (path:/tmp/pip-x6KNod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:52:10 INFO - Running setup.py (path:/tmp/pip-5uLP7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:52:10 INFO - Running setup.py (path:/tmp/pip-7hQZVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:52:10 INFO - Running setup.py (path:/tmp/pip-y0DvB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:52:10 INFO - Running setup.py (path:/tmp/pip-Kj5AwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:52:10 INFO - Running setup.py (path:/tmp/pip-d6KVhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:52:10 INFO - Running setup.py (path:/tmp/pip-E7inO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:52:10 INFO - Running setup.py (path:/tmp/pip-VaDyHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:52:10 INFO - Running setup.py (path:/tmp/pip-e8GWKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:52:10 INFO - Running setup.py (path:/tmp/pip-LXkgGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:52:10 INFO - Running setup.py (path:/tmp/pip-4sQeJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:52:10 INFO - Running setup.py (path:/tmp/pip-ViZ7d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:10 INFO - Running setup.py (path:/tmp/pip-Z5tSit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:52:10 INFO - Running setup.py (path:/tmp/pip-yhvVQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:52:10 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)) 05:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:52:10 INFO - Running setup.py (path:/tmp/pip-QQqaCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 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)) 05:52:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:12 INFO - Downloading blessings-1.6.tar.gz 05:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:12 INFO - Installing collected packages: blessings 05:52:12 INFO - Running setup.py install for blessings 05:52:13 INFO - Successfully installed blessings 05:52:13 INFO - Cleaning up... 05:52:13 INFO - Return code: 0 05:52:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:52:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:13 INFO - Reading from file tmpfile_stdout 05:52:13 INFO - Current package versions: 05:52:13 INFO - argparse == 1.2.1 05:52:13 INFO - blessings == 1.6 05:52:13 INFO - blobuploader == 1.2.4 05:52:13 INFO - docopt == 0.6.1 05:52:13 INFO - functools32 == 3.2.3-2 05:52:13 INFO - jsonschema == 2.5.1 05:52:13 INFO - manifestparser == 1.1 05:52:13 INFO - mozInstall == 1.12 05:52:13 INFO - mozcrash == 0.17 05:52:13 INFO - mozdebug == 0.1 05:52:13 INFO - mozdevice == 0.48 05:52:13 INFO - mozfile == 1.2 05:52:13 INFO - mozhttpd == 0.7 05:52:13 INFO - mozinfo == 0.9 05:52:13 INFO - mozleak == 0.1 05:52:13 INFO - mozlog == 3.2 05:52:13 INFO - moznetwork == 0.27 05:52:13 INFO - mozprocess == 0.22 05:52:13 INFO - mozprofile == 0.28 05:52:13 INFO - mozrunner == 6.11 05:52:13 INFO - mozscreenshot == 0.1 05:52:13 INFO - mozsystemmonitor == 0.3 05:52:13 INFO - moztest == 0.7 05:52:13 INFO - mozversion == 1.4 05:52:13 INFO - psutil == 3.1.1 05:52:13 INFO - requests == 1.2.3 05:52:13 INFO - wsgiref == 0.1.2 05:52:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:52:13 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')]} 05:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 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')]} 05:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:52:13 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 05:52:13 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 05:52:13 INFO - Using env: {'DISPLAY': ':0', 05:52:13 INFO - 'HOME': '/home/cltbld', 05:52:13 INFO - 'LANG': 'en_US.UTF-8', 05:52:13 INFO - 'LANGUAGE': 'en_US:en', 05:52:13 INFO - 'LOGNAME': 'cltbld', 05:52:13 INFO - 'MAIL': '/var/mail/cltbld', 05:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:13 INFO - 'MOZ_NO_REMOTE': '1', 05:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:13 INFO - 'NO_EM_RESTART': '1', 05:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:13 INFO - 'PWD': '/builds/slave/test', 05:52:13 INFO - 'SHELL': '/bin/bash', 05:52:13 INFO - 'SHLVL': '1', 05:52:13 INFO - 'TERM': 'linux', 05:52:13 INFO - 'TMOUT': '86400', 05:52:13 INFO - 'USER': 'cltbld', 05:52:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:13 INFO - '_': '/tools/buildbot/bin/python'} 05:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 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)) 05:52:13 INFO - Cleaning up... 05:52:13 INFO - Return code: 0 05:52:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:52:13 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')]} 05:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 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')]} 05:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:52:13 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 05:52:13 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 05:52:13 INFO - Using env: {'DISPLAY': ':0', 05:52:13 INFO - 'HOME': '/home/cltbld', 05:52:13 INFO - 'LANG': 'en_US.UTF-8', 05:52:13 INFO - 'LANGUAGE': 'en_US:en', 05:52:13 INFO - 'LOGNAME': 'cltbld', 05:52:13 INFO - 'MAIL': '/var/mail/cltbld', 05:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:13 INFO - 'MOZ_NO_REMOTE': '1', 05:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:13 INFO - 'NO_EM_RESTART': '1', 05:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:13 INFO - 'PWD': '/builds/slave/test', 05:52:13 INFO - 'SHELL': '/bin/bash', 05:52:13 INFO - 'SHLVL': '1', 05:52:13 INFO - 'TERM': 'linux', 05:52:13 INFO - 'TMOUT': '86400', 05:52:13 INFO - 'USER': 'cltbld', 05:52:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:13 INFO - '_': '/tools/buildbot/bin/python'} 05:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:52:13 INFO - Cleaning up... 05:52:13 INFO - Return code: 0 05:52:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:52:13 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')]} 05:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 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')]} 05:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:13 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 0x7f4b0ff7bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1284a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', '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 05:52:13 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 05:52:13 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 05:52:13 INFO - Using env: {'DISPLAY': ':0', 05:52:13 INFO - 'HOME': '/home/cltbld', 05:52:13 INFO - 'LANG': 'en_US.UTF-8', 05:52:13 INFO - 'LANGUAGE': 'en_US:en', 05:52:13 INFO - 'LOGNAME': 'cltbld', 05:52:13 INFO - 'MAIL': '/var/mail/cltbld', 05:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:13 INFO - 'MOZ_NO_REMOTE': '1', 05:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:13 INFO - 'NO_EM_RESTART': '1', 05:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:13 INFO - 'PWD': '/builds/slave/test', 05:52:13 INFO - 'SHELL': '/bin/bash', 05:52:13 INFO - 'SHLVL': '1', 05:52:13 INFO - 'TERM': 'linux', 05:52:13 INFO - 'TMOUT': '86400', 05:52:13 INFO - 'USER': 'cltbld', 05:52:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:13 INFO - '_': '/tools/buildbot/bin/python'} 05:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:14 INFO - Downloading/unpacking flake8 05:52:14 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 05:52:14 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 05:52:14 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 05:52:14 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 05:52:14 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 05:52:14 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 05:52:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:52:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:52:15 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 05:52:15 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 05:52:15 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 05:52:15 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 05:52:15 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 05:52:15 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 05:52:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:52:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52: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 05:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:16 INFO - no previously-included directories found matching 'docs/_build' 05:52:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:52:16 INFO - Running setup.py install for pep8 05:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:16 INFO - no previously-included directories found matching 'docs/_build' 05:52:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:52:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:52:16 INFO - Cleaning up... 05:52:16 INFO - Return code: 0 05:52:16 INFO - Running post-action listener: _resource_record_post_action 05:52:16 INFO - Running post-action listener: _start_resource_monitoring 05:52:16 INFO - Starting resource monitoring. 05:52:16 INFO - ##### 05:52:16 INFO - ##### Finished create-virtualenv step (success) 05:52:16 INFO - ##### 05:52:16 INFO - ##### 05:52:16 INFO - ##### Running install step. 05:52:16 INFO - ##### 05:52:16 INFO - Running pre-action listener: _resource_record_pre_action 05:52:16 INFO - Running main action method: install 05:52:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:52:17 INFO - Reading from file tmpfile_stdout 05:52:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:52:17 INFO - Reading from file tmpfile_stdout 05:52:17 INFO - Output received: 05:52:17 INFO - Usage: mozinstall [options] installer 05:52:17 INFO - Options: 05:52:17 INFO - -h, --help show this help message and exit 05:52:17 INFO - -d DEST, --destination=DEST 05:52:17 INFO - Directory to install application into. [default: 05:52:17 INFO - "/builds/slave/test"] 05:52:17 INFO - --app=APP Application being installed. [default: firefox] 05:52:17 INFO - mkdir: /builds/slave/test/build/application 05:52:17 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'] 05:52:17 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 05:52:34 INFO - Reading from file tmpfile_stdout 05:52:34 INFO - Output received: 05:52:34 INFO - /builds/slave/test/build/application/firefox/firefox 05:52:34 INFO - Running post-action listener: _resource_record_post_action 05:52:34 INFO - ##### 05:52:34 INFO - ##### Finished install step (success) 05:52:34 INFO - ##### 05:52:34 INFO - ##### 05:52:34 INFO - ##### Running run-tests step. 05:52:34 INFO - ##### 05:52:34 INFO - Running pre-action listener: _resource_record_pre_action 05:52:34 INFO - Running main action method: run_tests 05:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:52:34 INFO - Python 2.7.3 05:52:34 INFO - Return code: 0 05:52:34 INFO - grabbing minidump binary from tooltool 05:52:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:34 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 0x1281d00>, '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 0x1282ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1282f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:52:34 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 05:52:34 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 05:52:34 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 05:52:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:52:34 INFO - Return code: 0 05:52:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:52:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:52:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:52:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:52:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:52:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:52:35 INFO - Return code: 0 05:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 05:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 05:52:35 INFO - Using env: {'DISPLAY': ':0', 05:52:35 INFO - 'HOME': '/home/cltbld', 05:52:35 INFO - 'LANG': 'en_US.UTF-8', 05:52:35 INFO - 'LANGUAGE': 'en_US:en', 05:52:35 INFO - 'LOGNAME': 'cltbld', 05:52:35 INFO - 'MAIL': '/var/mail/cltbld', 05:52:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:52:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:35 INFO - 'MOZ_NO_REMOTE': '1', 05:52:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:35 INFO - 'NO_EM_RESTART': '1', 05:52:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:35 INFO - 'PWD': '/builds/slave/test', 05:52:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:52:35 INFO - 'SHELL': '/bin/bash', 05:52:35 INFO - 'SHLVL': '1', 05:52:35 INFO - 'TERM': 'linux', 05:52:35 INFO - 'TMOUT': '86400', 05:52:35 INFO - 'USER': 'cltbld', 05:52:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496', 05:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:35 INFO - '_': '/tools/buildbot/bin/python'} 05:52:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 05:52:35 INFO - mozversion application_buildid: 20160619030256 05:52:35 INFO - mozversion application_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 05:52:35 INFO - mozversion application_display_name: Nightly 05:52:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:52:35 INFO - mozversion application_name: Firefox 05:52:35 INFO - mozversion application_remotingname: firefox 05:52:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:52:35 INFO - mozversion application_vendor: Mozilla 05:52:35 INFO - mozversion application_version: 50.0a1 05:52:35 INFO - mozversion platform_buildid: 20160619030256 05:52:35 INFO - mozversion platform_changeset: 3ce53bd1e25b93140484d3933c9339a829e0c1eb 05:52:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:52:35 INFO - mozversion platform_version: 50.0a1 05:52:35 INFO - using testdate: 1466340755 05:52:35 INFO - actual date: 1466340755 05:52:35 INFO - starting webserver on 'localhost:35575' 05:52:35 INFO - SUITE-START | Running 2 tests 05:52:35 INFO - TEST-START | dromaeo_css 05:52:35 INFO - operating with platform_type : linux_ 05:52:35 INFO - Initialising browser for dromaeo_css test... 05:52:35 INFO - TEST-INFO | started process 28572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSEAz2L/profile http://localhost:35575/getInfo.html) 05:52:39 INFO - PROCESS | 28572 | __metrics Screen width/height:1600/1200 05:52:39 INFO - PROCESS | 28572 | colorDepth:24 05:52:39 INFO - PROCESS | 28572 | Browser inner width/height: 1024/697 05:52:39 INFO - PROCESS | 28572 | __metrics 05:52:40 INFO - PROCESS | 28572 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:52:41 INFO - TEST-INFO | 28572: exit 0 05:52:41 INFO - Browser initialized. 05:52:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:41 INFO - TEST-INFO | started process 28655 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSEAz2L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:53 INFO - PROCESS | 28655 | RSS: Main: 173232128 05:52:53 INFO - PROCESS | 28655 | 05:53:45 INFO - PROCESS | 28655 | 1466340825305 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] 05:55:53 INFO - PROCESS | 28655 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35575/tests/dromaeo/cssquery-ext.html) 05:55:54 INFO - PROCESS | 28655 | RSS: Main: 308957184 05:55:54 INFO - PROCESS | 28655 | 05:58:57 INFO - PROCESS | 28655 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-ext.html (next: http://localhost:35575/tests/dromaeo/cssquery-jquery.html) 05:58:57 INFO - PROCESS | 28655 | RSS: Main: 259956736 05:58:57 INFO - PROCESS | 28655 | 06:01:59 INFO - PROCESS | 28655 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35575/tests/dromaeo/cssquery-mootools.html) 06:02:00 INFO - PROCESS | 28655 | RSS: Main: 271343616 06:02:00 INFO - PROCESS | 28655 | 06:05:02 INFO - PROCESS | 28655 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35575/tests/dromaeo/cssquery-prototype.html) 06:05:02 INFO - PROCESS | 28655 | RSS: Main: 250429440 06:05:02 INFO - PROCESS | 28655 | 06:08:05 INFO - PROCESS | 28655 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35575/tests/dromaeo/cssquery-yui.html) 06:08:06 INFO - PROCESS | 28655 | RSS: Main: 230961152 06:08:06 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | Cycle 1(1): loaded http://localhost:35575/tests/dromaeo/cssquery-yui.html (next: http://localhost:35575/tests/dromaeo/cssquery-dojo.html) 06:11:09 INFO - PROCESS | 28655 | RSS: Main: 282472448 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | __start_tp_report 06:11:09 INFO - PROCESS | 28655 | _x_x_mozilla_page_load 06:11:09 INFO - PROCESS | 28655 | _x_x_mozilla_page_load_details 06:11:09 INFO - PROCESS | 28655 | |i|pagename|runs| 06:11:09 INFO - PROCESS | 28655 | |0;dojo.html;3129.796563223392;3135.9843200784;3154.7003034711693;3167.0815463515582;3188.378266238083;5283.498067683574;5359.1425371940495;5417.647852889564;5538.0585300498915;5550.8057217997375;5408.432114627966;5426.240326354314;5454.672719636825;5520.033994051045;5549.306336707911;4917.582005529525;4964.776585053663;4966.751662416883;5025.748712564376;5072.594192464612;5038.244263360507;5122.897542049157;5133;5135.3067335909545;5176.870578235536;4886.169351210267;4928.654994150411;5031.421386540558;5039;5077.771500282478;5004.649674522785;5028.32117664118;5033.597312215014;5050.898982020339;5099;4962.0324036812835;4962.206047032493;5000.949990500085;5008.198688209869;5046.167382381903;5294.311739473882;5376.569874410038;5414.133738601844;5465.398806131322;5496.1755736639425;5880.029795083806;5895.675737834417;5899.734511946973;5902.32123305821;5903.468687818117;5884.08796636522;5953.761849526014;5959;5977.611455255438;5979.611325263887;5406.405295417501;5426.21319908615;5478.260434841325;5482.671039737628;5559.138333558305;6046.1723948022845;6046.566998343302;6084.939150608526;6091.360407157184;6094.360092190256;5803.100519419497;5852.4147585241135;5855.414458554111;5861.677607731615;5862.443067908542;5709.68596727184;5761.827145185651;5815.592908496449;5821.883562328814;5932.940670593325;5833.154192642043;5861.794837180678;5876;5878.882422351529;5881.235439392852;5826.883462330815;5863.413658634103;5879.676617786063;5884.440978107073;5894.646321220741;4397.560243975641;4413.117376524708;4446.9777651111535;4451.621612162938;4483;4000.6199411055904;4001.199760048002;4001.3997900315185;4041.595840415935;4043.4137050128156;5545.77816887328;5546.389897111315;5548.4174161713245;5550.222968784374;5552.41699621542;5699.316082070095;5840.445157710011;5861.736221870026;5901.380355062743;5906.114082887601;5518.089515229942;5528.75120619573;5538.944610553924;5541.27963364768;5549.250851135045;4841.419029716386;4980.950190498121;4986.90026199474;4994.925076123861;5041.773120209526;6013.729382177812;6071.241094863142;6073.939260607337;6142.662153581507;6145.0782382642965;5955.047192449188;5963.821085367446;5965.045592705146;5965.522758179422;5967.075103358986;5882.882342353043;5954.553408494467;6129.295131059806;6149.046897730859;6149.508039356931;5748.597598168088;5777.740001700017;5786.884262314814;5793.710314484343;5849.64902105875;5830.970845145747;5833.883322333445;5862.443067908542;5882.294124705063;5917.082852157922;5601.467860553241;5665.3201615806365;5703.287089113861;5767.567432442667;5778.913316300175;5766.394528574439;5768.971155144198;5771.971140144273;5785.161151633074;5798;5669.092945128759;5671.206031155724;5675.971620142038;5676.858078548069;5683.374828768915;5602.579806514446;5613.691246981455;5686.2323586315315;5723.141528770718;5778.56660750437;5514.09017512106;5525;5531.778728850801;5531.834044978657;5538.695371754592 06:11:09 INFO - PROCESS | 28655 | |1;ext.html;555.1423051385609;595.982120536384;616.8519555306727;620.8665136995545;632.4718859752106;33474.83262583687;43704.12591748167;44203.11593768123;44319.556804431944;46870.29694554576;44546;44904.77547612265;44948.77525612376;44960;44962;8020.518768873886;8908.46549207048;9060.682876099305;9067.591958361889;10633.202509811796;10349.689509314732;10791.46042697866;10792.352458852454;10793.406362650052;10800;10819.350838949687;10863.239573229877;10870.891291087106;10873.945630271877;10876.401797901151;8085.514869107872;8260.215279548433;8283.751487455385;10517.1060459861;10758.300710453796;10402.947985260025;10745.731356716067;10749.946250268777;10752.677419677344;10753.247272690915;41816.1636767263;41868;42237.36643950343;42242;42285.78857105726;3558.181618227796;3879.553851307079;4113.4035564843225;4132.628063474302;4160.563140870196;33002.339953200804;33045;33401.49897751536;33422.832885835414;34503.654963450295;4451.866444006685;4481.932771008437;4515.096980603892;4601.769911504445;4638.072385522909;352123;353752;354576;354892.22553887323;356690;36122.819385902905;36896.81551592225;36906.44640330397;57806;57913.4208657908;36820.63179368225;36895.4465683015;36914;37028;37112;15108.54674359771;15122.773158402633;15252.161131137895;15277.770833437507;15300.770488442682;10562.260641755003;12278.079144064232;12444.502219911283;12546.184498007782;12565.057620678303;8405.327573794082;8408.243258106677;8416.747497575083;8472.279856212292;8474.533900635524;3188.489841625375;3215.1319143831033;3220.9838950805565;3249.5938007749032;3321.252718138448;1050.9421981790922;1074.8441475985937;1120.5293776613842;1122.4163435013747;1134.2683968840217;32514.187145321084;33228.50157247643;33237.3352532948;33427.665723342456;33811.83094084514;1101.9256225180386;1130.0507573638183;1138.4157961427513;1182.0366401382846;1246.8316777235138;16944.068076255677;17057.573560661083;17356.305747769948;17379;17490.300387984593;559268;559735;560227;564601;564666;57293;57297.14054289189;57824.42175578274;57909;57969.71015144897;1228.2875931959443;1395.3930040432444;1395.4557722488237;1520.156313246159;1585.2390852390918;30955.69044309528;33134.668653314126;33349.66650333466;34218.31563368669;34597;52346.476535235684;56742;56850.715746421;56945.715271423374;56958.430415695315;483216;492685;493827;494528;495453;37267.25465490621;43408;43490.34764478599;44617.77691111524;46474;48510.272345914134;49258.26112608242;49619.25571116364;49770;50981;41063;42208.36687449752;42455.575444245165;43025.13949720925;43168.56831431771;40858.79570602128;41600.58399416088;41628.58371416247;42179.57820421756;42187.578124219595;41207.58792412157;41559.7922010388;42254.1549169021;42706.57293427026;42974;35220.823895880356;38343.42484862785;38447;38745;38951.22097557976;28630.57054144231;28698.856505717336;28710.282242944093;29020.419591608472;29248.853755731085 06:11:09 INFO - PROCESS | 28655 | |2;jquery.html;377.9659830615244;386.1601017786315;388.80948335315685;395.9168574599334;407.9877603671891;17363;20041.398758037245;20407.08168132434;20409.387718368434;20443.386698399034;17348.47954561362;17405.564860878483;18000;18263.26946922125;19171.904140479277;5579.497845193931;5664.631798933056;5758.769649214027;5793.275840519935;5807.303123625171;5627.43725627436;5646.830595082154;5670.234518340013;5683.744231509592;5687.289088863892;5190.299309593194;5429.701366424845;5550.888982220353;5626.831195064155;5710.343310519302;5440.129579267338;5518.530924871391;5529.336479622471;5533.170024496338;5579.13523403873;5272.235525848769;5354.27717258169;5381.48875856793;5383.407825139231;5390.110631745796;14159.929200354036;14188.787168192486;14193.219372934485;17248.913755431142;22566.75882826444;2454.398672325292;2532.8100392470637;2640.7755340796057;2792.2600510864636;3013.291876409064;10098.141657959082;10104.09063184317;10251.948740256326;10287.897121028844;10576.259661823675;1836.2379612460813;1856.8978706171156;1904.190718944443;1929.9807001929942;1959.2456904092028;79789.60105199495;80937;83963.76398596211;84959.5752021236;86994;11023.724406889893;11055.447227638586;11150.275232109887;11302;11364.48859801311;15478.9226053869;15555.22223888801;15636.68726625484;15659.451919183002;15660.608484787972;7693.346065584376;7997.080335761346;8072.192780721881;8116.391270654724;8148.22591853773;7535.246475352421;7542.321191092828;7576.24237576238;7690.615469226516;7761.728339508203;4790;4834.250691142878;4836.927446088312;4852.514748525119;4890.217565189552;1902.9048547572565;1911.206849157612;1912.722655214986;1952.6778081616658;1988.1947811136513;914.8078903430354;987.7728122531857;1004.6935684616116;1008.2639673038723;1042.4110377636612;18967.525811854815;19106.23575056982;19144.266867960614;19396.12717427691;19552.511187220432;941.6751220828803;1025.5128813813378;1034.6068493972393;1059.527257112614;1084.436093231515;9785.951070244602;10889.455527223607;10944.17918656104;10947.56209751601;11159.330440173453;443306;445692;456423;458343;459718;51248.48751512512;54484.72757636266;60394;76159;79788.60105699551;1012.119456073221;1024.2471783239462;1048.5019615682643;1070.9089727373262;1079.4063265204106;17239.3966211182;17354.82645173532;17575.736363954806;17614.55963600869;17638.823611763717;40607.796961015;40945.36218551225;41029.58970410377;42350.576494234665;43263.351049734905;57264.71367643302;58243;59501.70249148727;59595.70202148962;59855.401445984986;8598.269147122564;8602.139786021598;8605.827883442422;8618.741437756877;8637.784055398666;9330.906690933003;12731.427085780977;13550.254735989221;13584.79622805639;13750.931245343709;11893.76212475763;12031.15781895259;12072.75854482923;12146.514139434325;12283.57007504733;5970.701464926823;11750.118741094622;11909.702257443632;11917.582884599344;11951.820722689341;6991.720331186695;11827.822582661094;12024.458899349725;12044.21712588679;12259.161125831197;8349.290310323691;8403.369747268856;8420.831583368421;8492.235698787139;8576.699815506427;8676.305895528216;11138.888611113785;11964.102692297938;12038.578649747216;12135.150539462153 06:11:09 INFO - PROCESS | 28655 | |3;mootools.html;1307.921524708517;1466.5600319904026;1512.56135720641;1606.951791446257;1750.4836073358358;8397.748067557975;8812.38313318068;8828.911710882889;9100.816893803796;9122.863157052632;8856.291496680265;9055.04921983192;9056.547172641358;9061.818763624724;9063.546822658873;2046.2428901306537;2292.495650956787;2292.59879521084;2322.918697845576;2359.95280094398;2353.6587194856734;2354.434935615457;2373.750756170603;2375.477394973103;2384.237044145874;2241.1819685814644;2278.1684685089904;2300.401895507172;2303.4817166137655;2307.8615283082986;2032.8780273183581;2202.130158587349;2269.4553307206315;2275.055851821492;2284.8514846535004;2321.8374713770045;2333.56828986638;2350.17743789674;2358.068562917655;2359.8466099703464;9028.18746312835;9198.356115071947;9200.769980750469;9206.401583897024;9208.217301529377;5144.588432925357;5306.522412982811;5307.575393968474;5314.256004159421;5321;3222.5327327537375;3385.2890892912274;3421.9828900855587;3437.535932649085;3464.6015708193377;1162.372318947767;1163.5520324674976;1169.0997931592626;1188.1326631559011;1189.8750631183689;12761.489540418372;12801.679958001032;12806.103572749911;12833.358332083451;12903.612891613267;4579.702319349231;4656.906861862743;4690.6012988895645;4767.594754445911;4773.976130119397;10722.839157412489;10728.088112510368;10757.677269681923;10782.73043173927;10790.298630588986;5374.811881584125;5375.9462405376225;5378.031954248195;5378.97310513445;5381.058314794974;4350.912981740347;4833.879153021203;4970.17992031318;4980.228064649985;5061.417936937226;3944.566097729305;4000.419939108871;4028.576999415078;4094.9181016379507;4164.437800896901;1224.9448774804978;1235.1539195651008;1248;1257.849058113014;1267.271318991565;914.92680585553;989.4706332112286;1008.1481148429565;1010.4947526236881;1026.7997740440692;6090.269167699816;6135.202423684892;6135.386461353829;6210.782622608277;6273.843153921097;465.6158669098008;466.4262956563446;472.6455158631027;487.57337329836395;491.8106528986366;4031.113155105872;4133.689973252018;4147.294959856771;4165.708400412002;4195.91608167835;10917.945410272898;11324.377159256155;11350.943245283886;11396.544138234378;11426.542938282375;11129.165312601588;11200.159988000933;11204;11209.271397359145;11209.887901121048;8222.17778222185;8401.285890699237;8443.53560554163;8455.858459107942;8462.915370846336;5988.940110598838;6026.216591843207;6108.664023478574;6195.256569211543;6280.403361680633;10449.21630877672;10465.738356541147;10479.738006549896;10568.471576421302;10595.576176952836;10259;10498.842517362398;10834.458277086273;10847.620333288298;10854.728631784268;7084.326988936043;7254.0207072044595;7766.223377662189;7994.640241189044;8070.273675369245;8598.054214036325;8837.116288371111;8894.955525222333;8897.421667591845;8906.910930890608;7430.888536672062;7476.5887876167335;7552.39580833543;7812;8146.633401496828;7546;7615.048118985127;7653.005109335751;7690.730824421342;7866.6066696666085;7091.11361079865;7117.074780278737;7136.250693677089;7151.392131668658;7166.211716711262;5084.3898732152375;5089.618278629044;5253.658512196848;5260.9736951315;5268.420473747808;5206.193040078794;5225.947740522546;5276.287701160294;5277.920831187458;5337.199420087018 06:11:09 INFO - PROCESS | 28655 | |4;prototype.html;311.67430035612784;320.13563378877035;321.8390804597701;328.57777755584067;329.2739509381813;4812.27815827626;5130.256112863633;5331.786728530859;5369.865753356168;5382.51557359838;5407.810726624569;5430.348358197022;5433.212184233284;5455.1271796512565;5464.508194262516;4268.6798490113215;4289.1636130954475;4291.120320334324;4322.351647252922;4323.654107671395;4037.636612704856;4084.550699423061;4195.412642230091;4202.453681021463;4287.678424118188;4132.442120313749;4157.812898419578;4168.291390463629;4171.520275168364;4183.602557757008;4167.458040524994;4192.57452466163;4199.685023623225;4204.159168166379;4208.579142085798;3689.317476266899;3689.3728066228537;3705.7776533407814;3708.313961917027;3723.553173619156;5068.518490743373;5245.449227831061;5279.208118782175;5314.97342513285;5322.281491998569;4555.954440455586;4634.351190833286;4712.599429048535;4726.125666751662;4760.357351757503;5402.432744561804;5535;5550.806576586013;5596.748146333425;5604.1593760935775;3887.805609719531;3914.0997570558648;3936;3996.2806694794926;4015.678745700337;5764.193012978187;5808.941910580882;5815.749613833004;5821.388754180793;5855.502282306009;4116.69124815634;4117.899871065718;4120.381942708557;4144.979275103605;4150.190712810973;4022.7988600569856;4145.357469592218;4201;4213.304804707251;4217.472815898012;4656.208444564432;4704.411948506437;4738.976305118453;4741.762911854394;4743.525647435298;5606.103023516218;5645.661260324394;5671.773129074873;5675.751334706358;5680.857978550486;1416.5821082780606;1447.1968057727852;1448.6885319656324;1452.5642307307764;1460.7005563859595;905.5381755304842;920.4937284493502;924.4037595750704;925.8843094071627;927.2906226736552;4801.7995501124715;4806.206975848946;4821.26352077136;4829.9034019319415;4845.176320025604;5003.3495645565845;5084.51697088776;5086.440491545927;5087.720175390389;5146.742662866842;4490.326451032372;4735.171345014609;4752.881177970509;4772.76136193189;4814.398200224972;2678.410749635077;2713.850738209378;2726.836389816617;2779.916602501928;2783.9860800695865;5115.010291972268;5185.377754669464;5187.455317191716;5192.636515443958;5727.971360143256;5751.884962300815;5896.852578685482;5901.970490147522;5911.438413350725;5916.7337469813965;5935.317438494629;5971.850703732442;5979.22270104901;5999.190109335271;6002.909956350658;5464.590155738415;5666.17840413146;5726.914096288642;5727.739897222605;5811;5659.773609055592;5675.148727690879;5690.71546422669;5694.515966142924;5712.80005199816;5655.4344565543115;5866.266716660418;5884.910422028469;5906.645601263938;5910.7340169693325;4040.9191816162925;4044.029432936133;4060.533038700469;4078.6533144683035;4099.97950010248;5737.250138707735;5744.511716504144;5814.215080964016;5824.475797178275;5851.327097383855;5372.301600792029;5677;5690.5163061140265;5699.914501282401;5705.686187259741;5643.463870932255;5646.689432081275;5655.52956231391;5670.319561652463;5681.2330335404195;5570.275864137636;5574.303212098488;5584.301962254718;5608.831735047955;5614.410486898817;5425.674459532441;5659.603827732019;5667.20659107717;5682.6306290091015;5694.914576281276;5589.5807814413265;5593.8321850344555;5598.944010559842;5613.522850557748;5614.017546929353 06:11:09 INFO - PROCESS | 28655 | |5;yui.html;732.80946953792;767.9747537038054;810.2505182705995;844.7507985144383;864.0797550608605;15463.226838658064;15494.61263468411;15875.603109922258;16123.758143627854;16158;15998.280077396515;16603.41888033919;16625.916870415662;16645.66708665829;16653.084080375575;650.1547987616103;804.3404408385127;814.3241109878786;817.5871185051541;818.7666515043214;799.8680217764062;820.6184124382161;821.256762629821;821.6097353756977;822.1901427094307;870.651739304277;871.1114663043692;873.2097451806126;873.4540911930044;874.3224001398935;690.3234829866759;821.6754382019129;853.2406158518924;860.9053004169567;871.6731225790329;616.6639181645969;621.6083867163703;621.782376168342;621.8694074244414;622.035844441119;15600.92199538995;15606.609834754108;15609.843901560953;15646.061236325857;15648.139352335616;14594.927025364805;15103.169325687082;15136.924315378352;15139.167345795977;15227.314770835228;13453.192808431428;13530.93234533831;13747.656308592364;13806;13851.515196968057;4644.790984405709;4670.089332580148;4745.786439610226;4750.406199225097;4750.714957102585;88933.55533222356;90353.54823225907;92263.53868230616;92459.61310580414;92516;11249.94375028136;11420.37187954654;11643.825342619868;11818.113641476924;11844.407779610985;23033.42416439569;23134.190303339303;23184.884075579514;23288.184913528283;23326.883365583064;8401.36989725773;8446.746597602081;8451.915480845235;8605.31157507398;8754.606042728092;4959.181735013754;4986.127427700138;5000.449950505442;5087.313212716236;5091.541761241432;3348.330333933174;3457.6715212054814;3463.1169051891607;3468.531748213959;3470.757047006736;550.7824409358361;602.2020822410324;603.3212635784743;633.3508154142041;675.2976904019863;615.9476444502268;651.9576227545289;662.211967758366;784.1687810920442;792.559244050863;9573;9849.901500985041;10261.435621040915;10472.424016679155;10506.63226787074;663.741140955028;747.9289467500579;757.9204183560757;767.6775754183257;775.8215610409637;4741.383620129361;4788.3056956741775;4790.329353890458;4803.135435621622;4821.397325334333;114901.42549287368;115803;118302;118936;120136;103259;104850;104986.47506762417;105165;105496;86434.56782716172;87760.56119719488;88312;89142;89659;9999.450030248116;10120.544575494268;10157.288989770645;10183.490825458846;10200.4389758564;50258.497415026846;50314.245286321464;51561;51735;51843;66117.0082448754;67178.66410667915;76123;77991;78821;12067.818982715442;12532.310722910328;12560.309182994657;12738.936305318413;13102.148360356547;13938.651533711738;14030;14675.779863302272;14696.706065878836;14989.850101499282;13517.797233041709;13700;13808.930955345159;14034.438622454987;14577.125372477261;14018.649533761329;14090;14110.365033573718;14538.394737630322;14759.409623614934;13845.584632461043;14196;14780.187089710169;15474.690506190038;15630.140342281284;10880.183986200907;12140.757184856076;12592.685182870502;12663.81004284918;12695.746085078063;12535.435905384098;12559.497620095459;12561.970373085258;12600.243985360908;12961.675958101123 06:11:09 INFO - PROCESS | 28655 | __end_tp_report 06:11:09 INFO - PROCESS | 28655 | __start_cc_report 06:11:09 INFO - PROCESS | 28655 | _x_x_mozilla_cycle_collect,1143 06:11:09 INFO - PROCESS | 28655 | __end_cc_report 06:11:09 INFO - PROCESS | 28655 | __startTimestamp1466341869426__endTimestamp 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | ------- Summary: start ------- 06:11:09 INFO - PROCESS | 28655 | Number of tests: 6 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | [#0] dojo.html Cycles:165 Average:5450.59 Median:5613.69 stddev:624.87 (11.1%) stddev-sans-first:599.68 06:11:09 INFO - PROCESS | 28655 | Values: 3129.8 3136.0 3154.7 3167.1 3188.4 5283.5 5359.1 5417.6 5538.1 5550.8 5408.4 5426.2 5454.7 5520.0 5549.3 4917.6 4964.8 4966.8 5025.7 5072.6 5038.2 5122.9 5133.0 5135.3 5176.9 4886.2 4928.7 5031.4 5039.0 5077.8 5004.6 5028.3 5033.6 5050.9 5099.0 4962.0 4962.2 5000.9 5008.2 5046.2 5294.3 5376.6 5414.1 5465.4 5496.2 5880.0 5895.7 5899.7 5902.3 5903.5 5884.1 5953.8 5959.0 5977.6 5979.6 5406.4 5426.2 5478.3 5482.7 5559.1 6046.2 6046.6 6084.9 6091.4 6094.4 5803.1 5852.4 5855.4 5861.7 5862.4 5709.7 5761.8 5815.6 5821.9 5932.9 5833.2 5861.8 5876.0 5878.9 5881.2 5826.9 5863.4 5879.7 5884.4 5894.6 4397.6 4413.1 4447.0 4451.6 4483.0 4000.6 4001.2 4001.4 4041.6 4043.4 5545.8 5546.4 5548.4 5550.2 5552.4 5699.3 5840.4 5861.7 5901.4 5906.1 5518.1 5528.8 5538.9 5541.3 5549.3 4841.4 4981.0 4986.9 4994.9 5041.8 6013.7 6071.2 6073.9 6142.7 6145.1 5955.0 5963.8 5965.0 5965.5 5967.1 5882.9 5954.6 6129.3 6149.0 6149.5 5748.6 5777.7 5786.9 5793.7 5849.6 5831.0 5833.9 5862.4 5882.3 5917.1 5601.5 5665.3 5703.3 5767.6 5778.9 5766.4 5769.0 5772.0 5785.2 5798.0 5669.1 5671.2 5676.0 5676.9 5683.4 5602.6 5613.7 5686.2 5723.1 5778.6 5514.1 5525.0 5531.8 5531.8 5538.7 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | [#1] ext.html Cycles:180 Average:62179.69 Median:38395.21 stddev:126855.29 (330.4%) stddev-sans-first:127126.78 06:11:09 INFO - PROCESS | 28655 | Values: 555.1 596.0 616.9 620.9 632.5 33474.8 43704.1 44203.1 44319.6 46870.3 44546.0 44904.8 44948.8 44960.0 44962.0 8020.5 8908.5 9060.7 9067.6 10633.2 10349.7 10791.5 10792.4 10793.4 10800.0 10819.4 10863.2 10870.9 10873.9 10876.4 8085.5 8260.2 8283.8 10517.1 10758.3 10402.9 10745.7 10749.9 10752.7 10753.2 41816.2 41868.0 42237.4 42242.0 42285.8 3558.2 3879.6 4113.4 4132.6 4160.6 33002.3 33045.0 33401.5 33422.8 34503.7 4451.9 4481.9 4515.1 4601.8 4638.1 352123.0 353752.0 354576.0 354892.2 356690.0 36122.8 36896.8 36906.4 57806.0 57913.4 36820.6 36895.4 36914.0 37028.0 37112.0 15108.5 15122.8 15252.2 15277.8 15300.8 10562.3 12278.1 12444.5 12546.2 12565.1 8405.3 8408.2 8416.7 8472.3 8474.5 3188.5 3215.1 3221.0 3249.6 3321.3 1050.9 1074.8 1120.5 1122.4 1134.3 32514.2 33228.5 33237.3 33427.7 33811.8 1101.9 1130.1 1138.4 1182.0 1246.8 16944.1 17057.6 17356.3 17379.0 17490.3 559268.0 559735.0 560227.0 564601.0 564666.0 57293.0 57297.1 57824.4 57909.0 57969.7 1228.3 1395.4 1395.5 1520.2 1585.2 30955.7 33134.7 33349.7 34218.3 34597.0 52346.5 56742.0 56850.7 56945.7 56958.4 483216.0 492685.0 493827.0 494528.0 495453.0 37267.3 43408.0 43490.3 44617.8 46474.0 48510.3 49258.3 49619.3 49770.0 50981.0 41063.0 42208.4 42455.6 43025.1 43168.6 40858.8 41600.6 41628.6 42179.6 42187.6 41207.6 41559.8 42254.2 42706.6 42974.0 35220.8 38343.4 38447.0 38745.0 38951.2 28630.6 28698.9 28710.3 29020.4 29248.9 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | [#2] jquery.html Cycles:180 Average:27016.12 Median:2902.78 stddev:74471.85 (2565.5%) stddev-sans-first:74653.91 06:11:09 INFO - PROCESS | 28655 | Values: 378.0 386.2 388.8 395.9 408.0 17363.0 20041.4 20407.1 20409.4 20443.4 17348.5 17405.6 18000.0 18263.3 19171.9 5579.5 5664.6 5758.8 5793.3 5807.3 5627.4 5646.8 5670.2 5683.7 5687.3 5190.3 5429.7 5550.9 5626.8 5710.3 5440.1 5518.5 5529.3 5533.2 5579.1 5272.2 5354.3 5381.5 5383.4 5390.1 14159.9 14188.8 14193.2 17248.9 22566.8 2454.4 2532.8 2640.8 2792.3 3013.3 10098.1 10104.1 10251.9 10287.9 10576.3 1836.2 1856.9 1904.2 1930.0 1959.2 79789.6 80937.0 83963.8 84959.6 86994.0 11023.7 11055.4 11150.3 11302.0 11364.5 15478.9 15555.2 15636.7 15659.5 15660.6 7693.3 7997.1 8072.2 8116.4 8148.2 7535.2 7542.3 7576.2 7690.6 7761.7 4790.0 4834.3 4836.9 4852.5 4890.2 1902.9 1911.2 1912.7 1952.7 1988.2 914.8 987.8 1004.7 1008.3 1042.4 18967.5 19106.2 19144.3 19396.1 19552.5 941.7 1025.5 1034.6 1059.5 1084.4 9786.0 10889.5 10944.2 10947.6 11159.3 443306.0 445692.0 456423.0 458343.0 459718.0 51248.5 54484.7 60394.0 76159.0 79788.6 1012.1 1024.2 1048.5 1070.9 1079.4 17239.4 17354.8 17575.7 17614.6 17638.8 40607.8 40945.4 41029.6 42350.6 43263.4 57264.7 58243.0 59501.7 59595.7 59855.4 8598.3 8602.1 8605.8 8618.7 8637.8 9330.9 12731.4 13550.3 13584.8 13750.9 11893.8 12031.2 12072.8 12146.5 12283.6 5970.7 11750.1 11909.7 11917.6 11951.8 6991.7 11827.8 12024.5 12044.2 12259.2 8349.3 8403.4 8420.8 8492.2 8576.7 8676.3 11138.9 11964.1 12038.6 12135.2 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | [#3] mootools.html Cycles:180 Average:5916.79 Median:2561.26 stddev:3451.54 (134.8%) stddev-sans-first:3443.84 06:11:09 INFO - PROCESS | 28655 | Values: 1307.9 1466.6 1512.6 1607.0 1750.5 8397.7 8812.4 8828.9 9100.8 9122.9 8856.3 9055.0 9056.5 9061.8 9063.5 2046.2 2292.5 2292.6 2322.9 2360.0 2353.7 2354.4 2373.8 2375.5 2384.2 2241.2 2278.2 2300.4 2303.5 2307.9 2032.9 2202.1 2269.5 2275.1 2284.9 2321.8 2333.6 2350.2 2358.1 2359.8 9028.2 9198.4 9200.8 9206.4 9208.2 5144.6 5306.5 5307.6 5314.3 5321.0 3222.5 3385.3 3422.0 3437.5 3464.6 1162.4 1163.6 1169.1 1188.1 1189.9 12761.5 12801.7 12806.1 12833.4 12903.6 4579.7 4656.9 4690.6 4767.6 4774.0 10722.8 10728.1 10757.7 10782.7 10790.3 5374.8 5375.9 5378.0 5379.0 5381.1 4350.9 4833.9 4970.2 4980.2 5061.4 3944.6 4000.4 4028.6 4094.9 4164.4 1224.9 1235.2 1248.0 1257.8 1267.3 914.9 989.5 1008.1 1010.5 1026.8 6090.3 6135.2 6135.4 6210.8 6273.8 465.6 466.4 472.6 487.6 491.8 4031.1 4133.7 4147.3 4165.7 4195.9 10917.9 11324.4 11350.9 11396.5 11426.5 11129.2 11200.2 11204.0 11209.3 11209.9 8222.2 8401.3 8443.5 8455.9 8462.9 5988.9 6026.2 6108.7 6195.3 6280.4 10449.2 10465.7 10479.7 10568.5 10595.6 10259.0 10498.8 10834.5 10847.6 10854.7 7084.3 7254.0 7766.2 7994.6 8070.3 8598.1 8837.1 8895.0 8897.4 8906.9 7430.9 7476.6 7552.4 7812.0 8146.6 7546.0 7615.0 7653.0 7690.7 7866.6 7091.1 7117.1 7136.3 7151.4 7166.2 5084.4 5089.6 5253.7 5261.0 5268.4 5206.2 5225.9 5276.3 5277.9 5337.2 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | [#4] prototype.html Cycles:180 Average:4650.14 Median:5190.05 stddev:1375.63 (26.5%) stddev-sans-first:1340.39 06:11:09 INFO - PROCESS | 28655 | Values: 311.7 320.1 321.8 328.6 329.3 4812.3 5130.3 5331.8 5369.9 5382.5 5407.8 5430.3 5433.2 5455.1 5464.5 4268.7 4289.2 4291.1 4322.4 4323.7 4037.6 4084.6 4195.4 4202.5 4287.7 4132.4 4157.8 4168.3 4171.5 4183.6 4167.5 4192.6 4199.7 4204.2 4208.6 3689.3 3689.4 3705.8 3708.3 3723.6 5068.5 5245.4 5279.2 5315.0 5322.3 4556.0 4634.4 4712.6 4726.1 4760.4 5402.4 5535.0 5550.8 5596.7 5604.2 3887.8 3914.1 3936.0 3996.3 4015.7 5764.2 5808.9 5815.7 5821.4 5855.5 4116.7 4117.9 4120.4 4145.0 4150.2 4022.8 4145.4 4201.0 4213.3 4217.5 4656.2 4704.4 4739.0 4741.8 4743.5 5606.1 5645.7 5671.8 5675.8 5680.9 1416.6 1447.2 1448.7 1452.6 1460.7 905.5 920.5 924.4 925.9 927.3 4801.8 4806.2 4821.3 4829.9 4845.2 5003.3 5084.5 5086.4 5087.7 5146.7 4490.3 4735.2 4752.9 4772.8 4814.4 2678.4 2713.9 2726.8 2779.9 2784.0 5115.0 5185.4 5187.5 5192.6 5728.0 5751.9 5896.9 5902.0 5911.4 5916.7 5935.3 5971.9 5979.2 5999.2 6002.9 5464.6 5666.2 5726.9 5727.7 5811.0 5659.8 5675.1 5690.7 5694.5 5712.8 5655.4 5866.3 5884.9 5906.6 5910.7 4040.9 4044.0 4060.5 4078.7 4100.0 5737.3 5744.5 5814.2 5824.5 5851.3 5372.3 5677.0 5690.5 5699.9 5705.7 5643.5 5646.7 5655.5 5670.3 5681.2 5570.3 5574.3 5584.3 5608.8 5614.4 5425.7 5659.6 5667.2 5682.6 5694.9 5589.6 5593.8 5598.9 5613.5 5614.0 06:11:09 INFO - PROCESS | 28655 | 06:11:09 INFO - PROCESS | 28655 | [#5] yui.html Cycles:180 Average:21839.94 Median:3469.64 stddev:31398.57 (905.0%) stddev-sans-first:31446.65 06:11:09 INFO - PROCESS | 28655 | Values: 732.8 768.0 810.3 844.8 864.1 15463.2 15494.6 15875.6 16123.8 16158.0 15998.3 16603.4 16625.9 16645.7 16653.1 650.2 804.3 814.3 817.6 818.8 799.9 820.6 821.3 821.6 822.2 870.7 871.1 873.2 873.5 874.3 690.3 821.7 853.2 860.9 871.7 616.7 621.6 621.8 621.9 622.0 15600.9 15606.6 15609.8 15646.1 15648.1 14594.9 15103.2 15136.9 15139.2 15227.3 13453.2 13530.9 13747.7 13806.0 13851.5 4644.8 4670.1 4745.8 4750.4 4750.7 88933.6 90353.5 92263.5 92459.6 92516.0 11249.9 11420.4 11643.8 11818.1 11844.4 23033.4 23134.2 23184.9 23288.2 23326.9 8401.4 8446.7 8451.9 8605.3 8754.6 4959.2 4986.1 5000.4 5087.3 5091.5 3348.3 3457.7 3463.1 3468.5 3470.8 550.8 602.2 603.3 633.4 675.3 615.9 652.0 662.2 784.2 792.6 9573.0 9849.9 10261.4 10472.4 10506.6 663.7 747.9 757.9 767.7 775.8 4741.4 4788.3 4790.3 4803.1 4821.4 114901.4 115803.0 118302.0 118936.0 120136.0 103259.0 104850.0 104986.5 105165.0 105496.0 86434.6 87760.6 88312.0 89142.0 89659.0 9999.5 10120.5 10157.3 10183.5 10200.4 50258.5 50314.2 51561.0 51735.0 51843.0 66117.0 67178.7 76123.0 77991.0 78821.0 12067.8 12532.3 12560.3 12738.9 13102.1 13938.7 14030.0 14675.8 14696.7 14989.9 13517.8 13700.0 13808.9 14034.4 14577.1 14018.6 14090.0 14110.4 14538.4 14759.4 13845.6 14196.0 14780.2 15474.7 15630.1 10880.2 12140.8 12592.7 12663.8 12695.7 12535.4 12559.5 12562.0 12600.2 12961.7 06:11:09 INFO - PROCESS | 28655 | -------- Summary: end -------- 06:11:09 INFO - PROCESS | 28655 | 06:11:10 INFO - TEST-INFO | 28655: exit 0 06:11:10 INFO - TEST-OK | dromaeo_css | took 1114734ms 06:11:10 INFO - TEST-START | kraken 06:11:10 INFO - operating with platform_type : linux_ 06:11:10 INFO - Initialising browser for kraken test... 06:11:10 INFO - TEST-INFO | started process 28843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3H4jWL/profile http://localhost:35575/getInfo.html) 06:11:14 INFO - PROCESS | 28843 | __metrics Screen width/height:1600/1200 06:11:14 INFO - PROCESS | 28843 | colorDepth:24 06:11:14 INFO - PROCESS | 28843 | Browser inner width/height: 1024/697 06:11:14 INFO - PROCESS | 28843 | __metrics 06:11:15 INFO - PROCESS | 28843 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:11:15 INFO - TEST-INFO | 28843: exit 0 06:11:15 INFO - Browser initialized. 06:11:15 INFO - Running cycle 1/1 for kraken test... 06:11:15 INFO - TEST-INFO | started process 28927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3H4jWL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:27 INFO - PROCESS | 28927 | RSS: Main: 173273088 06:11:27 INFO - PROCESS | 28927 | 06:11:30 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-beat-detection) 06:11:31 INFO - PROCESS | 28927 | RSS: Main: 233279488 06:11:31 INFO - PROCESS | 28927 | 06:11:33 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-dft) 06:11:34 INFO - PROCESS | 28927 | RSS: Main: 216678400 06:11:34 INFO - PROCESS | 28927 | 06:11:37 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-fft) 06:11:38 INFO - PROCESS | 28927 | RSS: Main: 286167040 06:11:38 INFO - PROCESS | 28927 | 06:11:40 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35575/tests/kraken/driver.html?testName=audio-oscillator) 06:11:41 INFO - PROCESS | 28927 | RSS: Main: 197451776 06:11:41 INFO - PROCESS | 28927 | 06:11:43 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:43 INFO - PROCESS | 28927 | RSS: Main: 201834496 06:11:43 INFO - PROCESS | 28927 | 06:11:46 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35575/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:47 INFO - PROCESS | 28927 | RSS: Main: 236036096 06:11:47 INFO - PROCESS | 28927 | 06:11:50 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35575/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:51 INFO - PROCESS | 28927 | RSS: Main: 238850048 06:11:51 INFO - PROCESS | 28927 | 06:11:54 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35575/tests/kraken/driver.html?testName=json-parse-financial) 06:11:54 INFO - PROCESS | 28927 | RSS: Main: 238669824 06:11:54 INFO - PROCESS | 28927 | 06:11:56 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:56 INFO - PROCESS | 28927 | RSS: Main: 228200448 06:11:56 INFO - PROCESS | 28927 | 06:11:58 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:59 INFO - PROCESS | 28927 | RSS: Main: 229871616 06:11:59 INFO - PROCESS | 28927 | 06:12:01 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:02 INFO - PROCESS | 28927 | RSS: Main: 236306432 06:12:02 INFO - PROCESS | 28927 | 06:12:04 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:05 INFO - PROCESS | 28927 | RSS: Main: 239808512 06:12:05 INFO - PROCESS | 28927 | 06:12:07 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:08 INFO - PROCESS | 28927 | RSS: Main: 240238592 06:12:08 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | Cycle 1(1): loaded http://localhost:35575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35575/tests/kraken/driver.html?testName=ai-astar) 06:12:10 INFO - PROCESS | 28927 | RSS: Main: 283209728 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | __start_tp_report 06:12:10 INFO - PROCESS | 28927 | _x_x_mozilla_page_load 06:12:10 INFO - PROCESS | 28927 | _x_x_mozilla_page_load_details 06:12:10 INFO - PROCESS | 28927 | |i|pagename|runs| 06:12:10 INFO - PROCESS | 28927 | |0;ai-astar;111;106;111;112;111;112;110;108;111;111 06:12:10 INFO - PROCESS | 28927 | |1;audio-beat-detection;167;125;125;177;126;126;149;126;160;126 06:12:10 INFO - PROCESS | 28927 | |2;audio-dft;162;160;160;158;161;160;162;161;161;162 06:12:10 INFO - PROCESS | 28927 | |3;audio-fft;76;77;75;111;74;76;75;74;109;75 06:12:10 INFO - PROCESS | 28927 | |4;audio-oscillator;84;85;109;85;84;85;119;85;87;131 06:12:10 INFO - PROCESS | 28927 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;117;117;116 06:12:10 INFO - PROCESS | 28927 | |6;imaging-darkroom;145;146;146;146;146;145;146;146;145;145 06:12:10 INFO - PROCESS | 28927 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;97;94 06:12:10 INFO - PROCESS | 28927 | |8;json-parse-financial;53;52;52;53;53;52;56;53;52;53 06:12:10 INFO - PROCESS | 28927 | |9;json-stringify-tinderbox;61;61;60;60;60;61;60;61;61;62 06:12:10 INFO - PROCESS | 28927 | |10;stanford-crypto-aes;80;79;78;84;79;80;83;81;114;81 06:12:10 INFO - PROCESS | 28927 | |11;stanford-crypto-ccm;140;122;122;121;128;120;122;128;134;121 06:12:10 INFO - PROCESS | 28927 | |12;stanford-crypto-pbkdf2;158;160;160;161;158;165;166;163;162;157 06:12:10 INFO - PROCESS | 28927 | |13;stanford-crypto-sha256-iterative;64;64;64;62;62;63;62;64;65;60 06:12:10 INFO - PROCESS | 28927 | __end_tp_report 06:12:10 INFO - PROCESS | 28927 | __start_cc_report 06:12:10 INFO - PROCESS | 28927 | _x_x_mozilla_cycle_collect,1581 06:12:10 INFO - PROCESS | 28927 | __end_cc_report 06:12:10 INFO - PROCESS | 28927 | __startTimestamp1466341930406__endTimestamp 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | ------- Summary: start ------- 06:12:10 INFO - PROCESS | 28927 | Number of tests: 14 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:1.99 06:12:10 INFO - PROCESS | 28927 | Values: 111.0 106.0 111.0 112.0 111.0 112.0 110.0 108.0 111.0 111.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:137.50 stddev:20.57 (15.0%) stddev-sans-first:19.49 06:12:10 INFO - PROCESS | 28927 | Values: 167.0 125.0 125.0 177.0 126.0 126.0 149.0 126.0 160.0 126.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.24 06:12:10 INFO - PROCESS | 28927 | Values: 162.0 160.0 160.0 158.0 161.0 160.0 162.0 161.0 161.0 162.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:14.69 (19.6%) stddev-sans-first:15.41 06:12:10 INFO - PROCESS | 28927 | Values: 76.0 77.0 75.0 111.0 74.0 76.0 75.0 74.0 109.0 75.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:17.55 (20.6%) stddev-sans-first:18.12 06:12:10 INFO - PROCESS | 28927 | Values: 84.0 85.0 109.0 85.0 84.0 85.0 119.0 85.0 87.0 131.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:12:10 INFO - PROCESS | 28927 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 06:12:10 INFO - PROCESS | 28927 | Values: 145.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 06:12:10 INFO - PROCESS | 28927 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 97.0 94.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 06:12:10 INFO - PROCESS | 28927 | Values: 53.0 52.0 52.0 53.0 53.0 52.0 56.0 53.0 52.0 53.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 06:12:10 INFO - PROCESS | 28927 | Values: 61.0 61.0 60.0 60.0 60.0 61.0 60.0 61.0 61.0 62.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:80.50 stddev:10.73 (13.3%) stddev-sans-first:11.29 06:12:10 INFO - PROCESS | 28927 | Values: 80.0 79.0 78.0 84.0 79.0 80.0 83.0 81.0 114.0 81.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.00 stddev:6.68 (5.3%) stddev-sans-first:4.71 06:12:10 INFO - PROCESS | 28927 | Values: 140.0 122.0 122.0 121.0 128.0 120.0 122.0 128.0 134.0 121.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:3.02 (1.9%) stddev-sans-first:3.00 06:12:10 INFO - PROCESS | 28927 | Values: 158.0 160.0 160.0 161.0 158.0 165.0 166.0 163.0 162.0 157.0 06:12:10 INFO - PROCESS | 28927 | 06:12:10 INFO - PROCESS | 28927 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.54 06:12:10 INFO - PROCESS | 28927 | Values: 64.0 64.0 64.0 62.0 62.0 63.0 62.0 64.0 65.0 60.0 06:12:10 INFO - PROCESS | 28927 | -------- Summary: end -------- 06:12:10 INFO - PROCESS | 28927 | 06:12:11 INFO - TEST-INFO | 28927: exit 0 06:12:11 INFO - TEST-OK | kraken | took 61247ms 06:12:11 INFO - SUITE-END | took 1175s 06:12:11 INFO - Completed test suite (00:19:36) 06:12:11 INFO - javascript benchmark 06:12:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.796563223392, 3135.9843200784, 3154.7003034711693, 3167.0815463515582, 3188.378266238083, 5283.498067683574, 5359.1425371940495, 5417.647852889564, 5538.0585300498915, 5550.8057217997375, 5408.432114627966, 5426.240326354314, 5454.672719636825, 5520.033994051045, 5549.306336707911, 4917.582005529525, 4964.776585053663, 4966.751662416883, 5025.748712564376, 5072.594192464612, 5038.244263360507, 5122.897542049157, 5133.0, 5135.3067335909545, 5176.870578235536, 4886.169351210267, 4928.654994150411, 5031.421386540558, 5039.0, 5077.771500282478, 5004.649674522785, 5028.32117664118, 5033.597312215014, 5050.898982020339, 5099.0, 4962.0324036812835, 4962.206047032493, 5000.949990500085, 5008.198688209869, 5046.167382381903, 5294.311739473882, 5376.569874410038, 5414.133738601844, 5465.398806131322, 5496.1755736639425, 5880.029795083806, 5895.675737834417, 5899.734511946973, 5902.32123305821, 5903.468687818117, 5884.08796636522, 5953.761849526014, 5959.0, 5977.611455255438, 5979.611325263887, 5406.405295417501, 5426.21319908615, 5478.260434841325, 5482.671039737628, 5559.138333558305, 6046.1723948022845, 6046.566998343302, 6084.939150608526, 6091.360407157184, 6094.360092190256, 5803.100519419497, 5852.4147585241135, 5855.414458554111, 5861.677607731615, 5862.443067908542, 5709.68596727184, 5761.827145185651, 5815.592908496449, 5821.883562328814, 5932.940670593325, 5833.154192642043, 5861.794837180678, 5876.0, 5878.882422351529, 5881.235439392852, 5826.883462330815, 5863.413658634103, 5879.676617786063, 5884.440978107073, 5894.646321220741, 4397.560243975641, 4413.117376524708, 4446.9777651111535, 4451.621612162938, 4483.0, 4000.6199411055904, 4001.199760048002, 4001.3997900315185, 4041.595840415935, 4043.4137050128156, 5545.77816887328, 5546.389897111315, 5548.4174161713245, 5550.222968784374, 5552.41699621542, 5699.316082070095, 5840.445157710011, 5861.736221870026, 5901.380355062743, 5906.114082887601, 5518.089515229942, 5528.75120619573, 5538.944610553924, 5541.27963364768, 5549.250851135045, 4841.419029716386, 4980.950190498121, 4986.90026199474, 4994.925076123861, 5041.773120209526, 6013.729382177812, 6071.241094863142, 6073.939260607337, 6142.662153581507, 6145.0782382642965, 5955.047192449188, 5963.821085367446, 5965.045592705146, 5965.522758179422, 5967.075103358986, 5882.882342353043, 5954.553408494467, 6129.295131059806, 6149.046897730859, 6149.508039356931, 5748.597598168088, 5777.740001700017, 5786.884262314814, 5793.710314484343, 5849.64902105875, 5830.970845145747, 5833.883322333445, 5862.443067908542, 5882.294124705063, 5917.082852157922, 5601.467860553241, 5665.3201615806365, 5703.287089113861, 5767.567432442667, 5778.913316300175, 5766.394528574439, 5768.971155144198, 5771.971140144273, 5785.161151633074, 5798.0, 5669.092945128759, 5671.206031155724, 5675.971620142038, 5676.858078548069, 5683.374828768915, 5602.579806514446, 5613.691246981455, 5686.2323586315315, 5723.141528770718, 5778.56660750437, 5514.09017512106, 5525.0, 5531.778728850801, 5531.834044978657, 5538.695371754592], "value": 5407.956160794174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1423051385609, 595.982120536384, 616.8519555306727, 620.8665136995545, 632.4718859752106, 33474.83262583687, 43704.12591748167, 44203.11593768123, 44319.556804431944, 46870.29694554576, 44546.0, 44904.77547612265, 44948.77525612376, 44960.0, 44962.0, 8020.518768873886, 8908.46549207048, 9060.682876099305, 9067.591958361889, 10633.202509811796, 10349.689509314732, 10791.46042697866, 10792.352458852454, 10793.406362650052, 10800.0, 10819.350838949687, 10863.239573229877, 10870.891291087106, 10873.945630271877, 10876.401797901151, 8085.514869107872, 8260.215279548433, 8283.751487455385, 10517.1060459861, 10758.300710453796, 10402.947985260025, 10745.731356716067, 10749.946250268777, 10752.677419677344, 10753.247272690915, 41816.1636767263, 41868.0, 42237.36643950343, 42242.0, 42285.78857105726, 3558.181618227796, 3879.553851307079, 4113.4035564843225, 4132.628063474302, 4160.563140870196, 33002.339953200804, 33045.0, 33401.49897751536, 33422.832885835414, 34503.654963450295, 4451.866444006685, 4481.932771008437, 4515.096980603892, 4601.769911504445, 4638.072385522909, 352123.0, 353752.0, 354576.0, 354892.22553887323, 356690.0, 36122.819385902905, 36896.81551592225, 36906.44640330397, 57806.0, 57913.4208657908, 36820.63179368225, 36895.4465683015, 36914.0, 37028.0, 37112.0, 15108.54674359771, 15122.773158402633, 15252.161131137895, 15277.770833437507, 15300.770488442682, 10562.260641755003, 12278.079144064232, 12444.502219911283, 12546.184498007782, 12565.057620678303, 8405.327573794082, 8408.243258106677, 8416.747497575083, 8472.279856212292, 8474.533900635524, 3188.489841625375, 3215.1319143831033, 3220.9838950805565, 3249.5938007749032, 3321.252718138448, 1050.9421981790922, 1074.8441475985937, 1120.5293776613842, 1122.4163435013747, 1134.2683968840217, 32514.187145321084, 33228.50157247643, 33237.3352532948, 33427.665723342456, 33811.83094084514, 1101.9256225180386, 1130.0507573638183, 1138.4157961427513, 1182.0366401382846, 1246.8316777235138, 16944.068076255677, 17057.573560661083, 17356.305747769948, 17379.0, 17490.300387984593, 559268.0, 559735.0, 560227.0, 564601.0, 564666.0, 57293.0, 57297.14054289189, 57824.42175578274, 57909.0, 57969.71015144897, 1228.2875931959443, 1395.3930040432444, 1395.4557722488237, 1520.156313246159, 1585.2390852390918, 30955.69044309528, 33134.668653314126, 33349.66650333466, 34218.31563368669, 34597.0, 52346.476535235684, 56742.0, 56850.715746421, 56945.715271423374, 56958.430415695315, 483216.0, 492685.0, 493827.0, 494528.0, 495453.0, 37267.25465490621, 43408.0, 43490.34764478599, 44617.77691111524, 46474.0, 48510.272345914134, 49258.26112608242, 49619.25571116364, 49770.0, 50981.0, 41063.0, 42208.36687449752, 42455.575444245165, 43025.13949720925, 43168.56831431771, 40858.79570602128, 41600.58399416088, 41628.58371416247, 42179.57820421756, 42187.578124219595, 41207.58792412157, 41559.7922010388, 42254.1549169021, 42706.57293427026, 42974.0, 35220.823895880356, 38343.42484862785, 38447.0, 38745.0, 38951.22097557976, 28630.57054144231, 28698.856505717336, 28710.282242944093, 29020.419591608472, 29248.853755731085], "value": 19812.086507555992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.9659830615244, 386.1601017786315, 388.80948335315685, 395.9168574599334, 407.9877603671891, 17363.0, 20041.398758037245, 20407.08168132434, 20409.387718368434, 20443.386698399034, 17348.47954561362, 17405.564860878483, 18000.0, 18263.26946922125, 19171.904140479277, 5579.497845193931, 5664.631798933056, 5758.769649214027, 5793.275840519935, 5807.303123625171, 5627.43725627436, 5646.830595082154, 5670.234518340013, 5683.744231509592, 5687.289088863892, 5190.299309593194, 5429.701366424845, 5550.888982220353, 5626.831195064155, 5710.343310519302, 5440.129579267338, 5518.530924871391, 5529.336479622471, 5533.170024496338, 5579.13523403873, 5272.235525848769, 5354.27717258169, 5381.48875856793, 5383.407825139231, 5390.110631745796, 14159.929200354036, 14188.787168192486, 14193.219372934485, 17248.913755431142, 22566.75882826444, 2454.398672325292, 2532.8100392470637, 2640.7755340796057, 2792.2600510864636, 3013.291876409064, 10098.141657959082, 10104.09063184317, 10251.948740256326, 10287.897121028844, 10576.259661823675, 1836.2379612460813, 1856.8978706171156, 1904.190718944443, 1929.9807001929942, 1959.2456904092028, 79789.60105199495, 80937.0, 83963.76398596211, 84959.5752021236, 86994.0, 11023.724406889893, 11055.447227638586, 11150.275232109887, 11302.0, 11364.48859801311, 15478.9226053869, 15555.22223888801, 15636.68726625484, 15659.451919183002, 15660.608484787972, 7693.346065584376, 7997.080335761346, 8072.192780721881, 8116.391270654724, 8148.22591853773, 7535.246475352421, 7542.321191092828, 7576.24237576238, 7690.615469226516, 7761.728339508203, 4790.0, 4834.250691142878, 4836.927446088312, 4852.514748525119, 4890.217565189552, 1902.9048547572565, 1911.206849157612, 1912.722655214986, 1952.6778081616658, 1988.1947811136513, 914.8078903430354, 987.7728122531857, 1004.6935684616116, 1008.2639673038723, 1042.4110377636612, 18967.525811854815, 19106.23575056982, 19144.266867960614, 19396.12717427691, 19552.511187220432, 941.6751220828803, 1025.5128813813378, 1034.6068493972393, 1059.527257112614, 1084.436093231515, 9785.951070244602, 10889.455527223607, 10944.17918656104, 10947.56209751601, 11159.330440173453, 443306.0, 445692.0, 456423.0, 458343.0, 459718.0, 51248.48751512512, 54484.72757636266, 60394.0, 76159.0, 79788.60105699551, 1012.119456073221, 1024.2471783239462, 1048.5019615682643, 1070.9089727373262, 1079.4063265204106, 17239.3966211182, 17354.82645173532, 17575.736363954806, 17614.55963600869, 17638.823611763717, 40607.796961015, 40945.36218551225, 41029.58970410377, 42350.576494234665, 43263.351049734905, 57264.71367643302, 58243.0, 59501.70249148727, 59595.70202148962, 59855.401445984986, 8598.269147122564, 8602.139786021598, 8605.827883442422, 8618.741437756877, 8637.784055398666, 9330.906690933003, 12731.427085780977, 13550.254735989221, 13584.79622805639, 13750.931245343709, 11893.76212475763, 12031.15781895259, 12072.75854482923, 12146.514139434325, 12283.57007504733, 5970.701464926823, 11750.118741094622, 11909.702257443632, 11917.582884599344, 11951.820722689341, 6991.720331186695, 11827.822582661094, 12024.458899349725, 12044.21712588679, 12259.161125831197, 8349.290310323691, 8403.369747268856, 8420.831583368421, 8492.235698787139, 8576.699815506427, 8676.305895528216, 11138.888611113785, 11964.102692297938, 12038.578649747216, 12135.150539462153], "value": 8986.11943285037, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.921524708517, 1466.5600319904026, 1512.56135720641, 1606.951791446257, 1750.4836073358358, 8397.748067557975, 8812.38313318068, 8828.911710882889, 9100.816893803796, 9122.863157052632, 8856.291496680265, 9055.04921983192, 9056.547172641358, 9061.818763624724, 9063.546822658873, 2046.2428901306537, 2292.495650956787, 2292.59879521084, 2322.918697845576, 2359.95280094398, 2353.6587194856734, 2354.434935615457, 2373.750756170603, 2375.477394973103, 2384.237044145874, 2241.1819685814644, 2278.1684685089904, 2300.401895507172, 2303.4817166137655, 2307.8615283082986, 2032.8780273183581, 2202.130158587349, 2269.4553307206315, 2275.055851821492, 2284.8514846535004, 2321.8374713770045, 2333.56828986638, 2350.17743789674, 2358.068562917655, 2359.8466099703464, 9028.18746312835, 9198.356115071947, 9200.769980750469, 9206.401583897024, 9208.217301529377, 5144.588432925357, 5306.522412982811, 5307.575393968474, 5314.256004159421, 5321.0, 3222.5327327537375, 3385.2890892912274, 3421.9828900855587, 3437.535932649085, 3464.6015708193377, 1162.372318947767, 1163.5520324674976, 1169.0997931592626, 1188.1326631559011, 1189.8750631183689, 12761.489540418372, 12801.679958001032, 12806.103572749911, 12833.358332083451, 12903.612891613267, 4579.702319349231, 4656.906861862743, 4690.6012988895645, 4767.594754445911, 4773.976130119397, 10722.839157412489, 10728.088112510368, 10757.677269681923, 10782.73043173927, 10790.298630588986, 5374.811881584125, 5375.9462405376225, 5378.031954248195, 5378.97310513445, 5381.058314794974, 4350.912981740347, 4833.879153021203, 4970.17992031318, 4980.228064649985, 5061.417936937226, 3944.566097729305, 4000.419939108871, 4028.576999415078, 4094.9181016379507, 4164.437800896901, 1224.9448774804978, 1235.1539195651008, 1248.0, 1257.849058113014, 1267.271318991565, 914.92680585553, 989.4706332112286, 1008.1481148429565, 1010.4947526236881, 1026.7997740440692, 6090.269167699816, 6135.202423684892, 6135.386461353829, 6210.782622608277, 6273.843153921097, 465.6158669098008, 466.4262956563446, 472.6455158631027, 487.57337329836395, 491.8106528986366, 4031.113155105872, 4133.689973252018, 4147.294959856771, 4165.708400412002, 4195.91608167835, 10917.945410272898, 11324.377159256155, 11350.943245283886, 11396.544138234378, 11426.542938282375, 11129.165312601588, 11200.159988000933, 11204.0, 11209.271397359145, 11209.887901121048, 8222.17778222185, 8401.285890699237, 8443.53560554163, 8455.858459107942, 8462.915370846336, 5988.940110598838, 6026.216591843207, 6108.664023478574, 6195.256569211543, 6280.403361680633, 10449.21630877672, 10465.738356541147, 10479.738006549896, 10568.471576421302, 10595.576176952836, 10259.0, 10498.842517362398, 10834.458277086273, 10847.620333288298, 10854.728631784268, 7084.326988936043, 7254.0207072044595, 7766.223377662189, 7994.640241189044, 8070.273675369245, 8598.054214036325, 8837.116288371111, 8894.955525222333, 8897.421667591845, 8906.910930890608, 7430.888536672062, 7476.5887876167335, 7552.39580833543, 7812.0, 8146.633401496828, 7546.0, 7615.048118985127, 7653.005109335751, 7690.730824421342, 7866.6066696666085, 7091.11361079865, 7117.074780278737, 7136.250693677089, 7151.392131668658, 7166.211716711262, 5084.3898732152375, 5089.618278629044, 5253.658512196848, 5260.9736951315, 5268.420473747808, 5206.193040078794, 5225.947740522546, 5276.287701160294, 5277.920831187458, 5337.199420087018], "value": 4622.774416258511, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.67430035612784, 320.13563378877035, 321.8390804597701, 328.57777755584067, 329.2739509381813, 4812.27815827626, 5130.256112863633, 5331.786728530859, 5369.865753356168, 5382.51557359838, 5407.810726624569, 5430.348358197022, 5433.212184233284, 5455.1271796512565, 5464.508194262516, 4268.6798490113215, 4289.1636130954475, 4291.120320334324, 4322.351647252922, 4323.654107671395, 4037.636612704856, 4084.550699423061, 4195.412642230091, 4202.453681021463, 4287.678424118188, 4132.442120313749, 4157.812898419578, 4168.291390463629, 4171.520275168364, 4183.602557757008, 4167.458040524994, 4192.57452466163, 4199.685023623225, 4204.159168166379, 4208.579142085798, 3689.317476266899, 3689.3728066228537, 3705.7776533407814, 3708.313961917027, 3723.553173619156, 5068.518490743373, 5245.449227831061, 5279.208118782175, 5314.97342513285, 5322.281491998569, 4555.954440455586, 4634.351190833286, 4712.599429048535, 4726.125666751662, 4760.357351757503, 5402.432744561804, 5535.0, 5550.806576586013, 5596.748146333425, 5604.1593760935775, 3887.805609719531, 3914.0997570558648, 3936.0, 3996.2806694794926, 4015.678745700337, 5764.193012978187, 5808.941910580882, 5815.749613833004, 5821.388754180793, 5855.502282306009, 4116.69124815634, 4117.899871065718, 4120.381942708557, 4144.979275103605, 4150.190712810973, 4022.7988600569856, 4145.357469592218, 4201.0, 4213.304804707251, 4217.472815898012, 4656.208444564432, 4704.411948506437, 4738.976305118453, 4741.762911854394, 4743.525647435298, 5606.103023516218, 5645.661260324394, 5671.773129074873, 5675.751334706358, 5680.857978550486, 1416.5821082780606, 1447.1968057727852, 1448.6885319656324, 1452.5642307307764, 1460.7005563859595, 905.5381755304842, 920.4937284493502, 924.4037595750704, 925.8843094071627, 927.2906226736552, 4801.7995501124715, 4806.206975848946, 4821.26352077136, 4829.9034019319415, 4845.176320025604, 5003.3495645565845, 5084.51697088776, 5086.440491545927, 5087.720175390389, 5146.742662866842, 4490.326451032372, 4735.171345014609, 4752.881177970509, 4772.76136193189, 4814.398200224972, 2678.410749635077, 2713.850738209378, 2726.836389816617, 2779.916602501928, 2783.9860800695865, 5115.010291972268, 5185.377754669464, 5187.455317191716, 5192.636515443958, 5727.971360143256, 5751.884962300815, 5896.852578685482, 5901.970490147522, 5911.438413350725, 5916.7337469813965, 5935.317438494629, 5971.850703732442, 5979.22270104901, 5999.190109335271, 6002.909956350658, 5464.590155738415, 5666.17840413146, 5726.914096288642, 5727.739897222605, 5811.0, 5659.773609055592, 5675.148727690879, 5690.71546422669, 5694.515966142924, 5712.80005199816, 5655.4344565543115, 5866.266716660418, 5884.910422028469, 5906.645601263938, 5910.7340169693325, 4040.9191816162925, 4044.029432936133, 4060.533038700469, 4078.6533144683035, 4099.97950010248, 5737.250138707735, 5744.511716504144, 5814.215080964016, 5824.475797178275, 5851.327097383855, 5372.301600792029, 5677.0, 5690.5163061140265, 5699.914501282401, 5705.686187259741, 5643.463870932255, 5646.689432081275, 5655.52956231391, 5670.319561652463, 5681.2330335404195, 5570.275864137636, 5574.303212098488, 5584.301962254718, 5608.831735047955, 5614.410486898817, 5425.674459532441, 5659.603827732019, 5667.20659107717, 5682.6306290091015, 5694.914576281276, 5589.5807814413265, 5593.8321850344555, 5598.944010559842, 5613.522850557748, 5614.017546929353], "value": 4208.739638113145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.80946953792, 767.9747537038054, 810.2505182705995, 844.7507985144383, 864.0797550608605, 15463.226838658064, 15494.61263468411, 15875.603109922258, 16123.758143627854, 16158.0, 15998.280077396515, 16603.41888033919, 16625.916870415662, 16645.66708665829, 16653.084080375575, 650.1547987616103, 804.3404408385127, 814.3241109878786, 817.5871185051541, 818.7666515043214, 799.8680217764062, 820.6184124382161, 821.256762629821, 821.6097353756977, 822.1901427094307, 870.651739304277, 871.1114663043692, 873.2097451806126, 873.4540911930044, 874.3224001398935, 690.3234829866759, 821.6754382019129, 853.2406158518924, 860.9053004169567, 871.6731225790329, 616.6639181645969, 621.6083867163703, 621.782376168342, 621.8694074244414, 622.035844441119, 15600.92199538995, 15606.609834754108, 15609.843901560953, 15646.061236325857, 15648.139352335616, 14594.927025364805, 15103.169325687082, 15136.924315378352, 15139.167345795977, 15227.314770835228, 13453.192808431428, 13530.93234533831, 13747.656308592364, 13806.0, 13851.515196968057, 4644.790984405709, 4670.089332580148, 4745.786439610226, 4750.406199225097, 4750.714957102585, 88933.55533222356, 90353.54823225907, 92263.53868230616, 92459.61310580414, 92516.0, 11249.94375028136, 11420.37187954654, 11643.825342619868, 11818.113641476924, 11844.407779610985, 23033.42416439569, 23134.190303339303, 23184.884075579514, 23288.184913528283, 23326.883365583064, 8401.36989725773, 8446.746597602081, 8451.915480845235, 8605.31157507398, 8754.606042728092, 4959.181735013754, 4986.127427700138, 5000.449950505442, 5087.313212716236, 5091.541761241432, 3348.330333933174, 3457.6715212054814, 3463.1169051891607, 3468.531748213959, 3470.757047006736, 550.7824409358361, 602.2020822410324, 603.3212635784743, 633.3508154142041, 675.2976904019863, 615.9476444502268, 651.9576227545289, 662.211967758366, 784.1687810920442, 792.559244050863, 9573.0, 9849.901500985041, 10261.435621040915, 10472.424016679155, 10506.63226787074, 663.741140955028, 747.9289467500579, 757.9204183560757, 767.6775754183257, 775.8215610409637, 4741.383620129361, 4788.3056956741775, 4790.329353890458, 4803.135435621622, 4821.397325334333, 114901.42549287368, 115803.0, 118302.0, 118936.0, 120136.0, 103259.0, 104850.0, 104986.47506762417, 105165.0, 105496.0, 86434.56782716172, 87760.56119719488, 88312.0, 89142.0, 89659.0, 9999.450030248116, 10120.544575494268, 10157.288989770645, 10183.490825458846, 10200.4389758564, 50258.497415026846, 50314.245286321464, 51561.0, 51735.0, 51843.0, 66117.0082448754, 67178.66410667915, 76123.0, 77991.0, 78821.0, 12067.818982715442, 12532.310722910328, 12560.309182994657, 12738.936305318413, 13102.148360356547, 13938.651533711738, 14030.0, 14675.779863302272, 14696.706065878836, 14989.850101499282, 13517.797233041709, 13700.0, 13808.930955345159, 14034.438622454987, 14577.125372477261, 14018.649533761329, 14090.0, 14110.365033573718, 14538.394737630322, 14759.409623614934, 13845.584632461043, 14196.0, 14780.187089710169, 15474.690506190038, 15630.140342281284, 10880.183986200907, 12140.757184856076, 12592.685182870502, 12663.81004284918, 12695.746085078063, 12535.435905384098, 12559.497620095459, 12561.970373085258, 12600.243985360908, 12961.675958101123], "value": 7863.294301476869, "unit": "score"}], "name": "dromaeo_css", "value": 7267.30188253059, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 112.0, 111.0, 112.0, 110.0, 108.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 125.0, 125.0, 177.0, 126.0, 126.0, 149.0, 126.0, 160.0, 126.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 158.0, 161.0, 160.0, 162.0, 161.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 111.0, 74.0, 76.0, 75.0, 74.0, 109.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 85.0, 84.0, 85.0, 119.0, 85.0, 87.0, 131.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 97.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 56.0, 53.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 84.0, 79.0, 80.0, 83.0, 81.0, 114.0, 81.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 122.0, 122.0, 121.0, 128.0, 120.0, 122.0, 128.0, 134.0, 121.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 160.0, 161.0, 158.0, 165.0, 166.0, 163.0, 162.0, 157.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 62.0, 62.0, 63.0, 62.0, 64.0, 65.0, 60.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1494.2, "alertThreshold": 2.0}]} 06:12:11 INFO - Return code: 0 06:12:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:12:11 INFO - # TBPL SUCCESS # 06:12:11 INFO - Running post-action listener: _resource_record_post_action 06:12:11 INFO - ##### 06:12:11 INFO - ##### Finished run-tests step (success) 06:12:11 INFO - ##### 06:12:11 INFO - Running post-run listener: _resource_record_post_run 06:12:11 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552927232; Read time: 76; Write time: 460536 06:12:11 INFO - TinderboxPrint: CPU usage
13.2% 06:12:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 76 06:12:11 INFO - TinderboxPrint: I/O write bytes / time
552,927,232 / 460,536 06:12:11 INFO - TinderboxPrint: CPU idle
8,272.4 (86.8%) 06:12:11 INFO - TinderboxPrint: CPU user
1,206.2 (12.7%) 06:12:11 INFO - TinderboxPrint: Swap in / out
0 / 0 06:12:11 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256176128; Read time: 0; Write time: 267340 06:12:11 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296026112; Read time: 76; Write time: 193156 06:12:12 INFO - Running post-run listener: _upload_blobber_files 06:12:12 INFO - Blob upload gear active. 06:12:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:12:12 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:12:12 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:12:12 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:12:12 INFO - (blobuploader) - INFO - Open directory for files ... 06:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:12:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:13 INFO - (blobuploader) - INFO - Done attempting. 06:12:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:12:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:12:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:14 INFO - (blobuploader) - INFO - Done attempting. 06:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:12:17 INFO - (blobuploader) - INFO - Done attempting. 06:12:17 INFO - (blobuploader) - INFO - Iteration through files over. 06:12:17 INFO - Return code: 0 06:12:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:12:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:12:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e68d5da6ef52ac785df6abdb6814a4d20cf0356883566dda186f51e4cd99e8b32391329afb13828ef91fe913a3719d07846e5d687b478b3155954827235261", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7410e17da48de3963b24b539d69286771058fda875a274a2c0e84154c59c3e20a35f5d4acc5e6f0cc07d9bddbe97c958a720d53f7334dbd7fa4d3bfafd12ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f072cebed450a1b058efc35a3ab0c08396c035f862dce7dba6625fbce41b6e43a9e35ccb3353392e59dd3b6dd487c61c7a62ff9a57ee5b7c625c64b5625b6d1c"} 06:12:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:12:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:12:17 INFO - Contents: 06:12:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e68d5da6ef52ac785df6abdb6814a4d20cf0356883566dda186f51e4cd99e8b32391329afb13828ef91fe913a3719d07846e5d687b478b3155954827235261", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7410e17da48de3963b24b539d69286771058fda875a274a2c0e84154c59c3e20a35f5d4acc5e6f0cc07d9bddbe97c958a720d53f7334dbd7fa4d3bfafd12ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f072cebed450a1b058efc35a3ab0c08396c035f862dce7dba6625fbce41b6e43a9e35ccb3353392e59dd3b6dd487c61c7a62ff9a57ee5b7c625c64b5625b6d1c"} 06:12:17 INFO - Running post-run listener: copy_logs_to_upload_dir 06:12:17 INFO - Copying logs to upload dir... 06:12:17 INFO - mkdir: /builds/slave/test/build/upload/logs 06:12:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.560053 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-19 06:12:16.147854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-19 06:12:16.151015) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496 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/sha512/e0e68d5da6ef52ac785df6abdb6814a4d20cf0356883566dda186f51e4cd99e8b32391329afb13828ef91fe913a3719d07846e5d687b478b3155954827235261", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7410e17da48de3963b24b539d69286771058fda875a274a2c0e84154c59c3e20a35f5d4acc5e6f0cc07d9bddbe97c958a720d53f7334dbd7fa4d3bfafd12ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f072cebed450a1b058efc35a3ab0c08396c035f862dce7dba6625fbce41b6e43a9e35ccb3353392e59dd3b6dd487c61c7a62ff9a57ee5b7c625c64b5625b6d1c"} build_url:https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011508 build_url: 'https://queue.taskcluster.net/v1/task/eLPWIfc8SHKKkn8L_N3qgg/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/sha512/e0e68d5da6ef52ac785df6abdb6814a4d20cf0356883566dda186f51e4cd99e8b32391329afb13828ef91fe913a3719d07846e5d687b478b3155954827235261", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f7410e17da48de3963b24b539d69286771058fda875a274a2c0e84154c59c3e20a35f5d4acc5e6f0cc07d9bddbe97c958a720d53f7334dbd7fa4d3bfafd12ebb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f072cebed450a1b058efc35a3ab0c08396c035f862dce7dba6625fbce41b6e43a9e35ccb3353392e59dd3b6dd487c61c7a62ff9a57ee5b7c625c64b5625b6d1c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-19 06:12:16.184434) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 06:12:16.185142) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1466335772.478966-1892993496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-19 06:12:16.267550) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-19 06:12:16.268325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-19 06:12:16.268873) ========= ========= Total master_lag: 0.19 =========