builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1466599817.99 results: success (0) buildid: 20160622030210 builduid: 1316c70cf0db49a281cf60d702b605d1 revision: 51377a64158941f89ed73f388ae437cfa494c030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:17.991071) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:17.991567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:17.991885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:18.010792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:18.011107) ========= 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=41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 05:50:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-06-22 05:50:18 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153119 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:18.364139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:18.364796) ========= 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=41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017646 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:18.411262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 05:50:18.411639) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51377a64158941f89ed73f388ae437cfa494c030 --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 51377a64158941f89ed73f388ae437cfa494c030 --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=41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 05:50:19,210 truncating revision to first 12 chars 2016-06-22 05:50:19,210 Setting DEBUG logging. 2016-06-22 05:50:19,210 attempt 1/10 2016-06-22 05:50:19,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51377a641589?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 05:50:19,509 unpacking tar archive at: mozilla-central-51377a641589/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631002 ========= master_lag: 0.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 05:50:19.589842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:19.590155) ========= script_repo_revision: 51377a64158941f89ed73f388ae437cfa494c030 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:19.590615) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:19.590922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 05:50:19.955504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-22 05:50:19.955819) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:50:20 INFO - MultiFileLogger online at 20160622 05:50:20 in /builds/slave/test 05:50:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:50:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:50:20 INFO - {'append_to_log': False, 05:50:20 INFO - 'base_work_dir': '/builds/slave/test', 05:50:20 INFO - 'blob_upload_branch': 'Firefox', 05:50:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:50:20 INFO - 'branch': 'Firefox', 05:50:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:50:20 INFO - 'config_files': ('talos/linux_config.py',), 05:50:20 INFO - 'default_actions': ('clobber', 05:50:20 INFO - 'read-buildbot-config', 05:50:20 INFO - 'download-and-extract', 05:50:20 INFO - 'populate-webroot', 05:50:20 INFO - 'create-virtualenv', 05:50:20 INFO - 'install', 05:50:20 INFO - 'run-tests'), 05:50:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:50:20 INFO - 'download_minidump_stackwalk': True, 05:50:20 INFO - 'download_symbols': 'ondemand', 05:50:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:50:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:50:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:50:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:50:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:50:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:50:20 INFO - 'installer_path': 'installer.exe', 05:50:20 INFO - 'log_level': 'info', 05:50:20 INFO - 'log_name': 'talos', 05:50:20 INFO - 'log_to_console': True, 05:50:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:50:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:50:20 INFO - 'opt_config_files': (), 05:50:20 INFO - 'pip_index': False, 05:50:20 INFO - 'sps_profile': False, 05:50:20 INFO - 'sps_profile_interval': 0, 05:50:20 INFO - 'suite': 'dromaeojs-e10s', 05:50:20 INFO - 'system_bits': '32', 05:50:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:50:20 INFO - 'title': 'talos-linux64-ix-024', 05:50:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:50:20 INFO - 'use_talos_json': True, 05:50:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:50:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:50:20 INFO - 'work_dir': 'build'} 05:50:20 INFO - ##### 05:50:20 INFO - ##### Running clobber step. 05:50:20 INFO - ##### 05:50:20 INFO - Running pre-action listener: _resource_record_pre_action 05:50:20 INFO - Running main action method: clobber 05:50:20 INFO - rmtree: /builds/slave/test/build 05:50:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:50:21 INFO - Running post-action listener: _resource_record_post_action 05:50:21 INFO - ##### 05:50:21 INFO - ##### Finished clobber step (success) 05:50:21 INFO - ##### 05:50:21 INFO - ##### 05:50:21 INFO - ##### Running read-buildbot-config step. 05:50:21 INFO - ##### 05:50:21 INFO - Running pre-action listener: _resource_record_pre_action 05:50:21 INFO - Running main action method: read_buildbot_config 05:50:21 INFO - Using buildbot properties: 05:50:21 INFO - { 05:50:21 INFO - "project": "", 05:50:21 INFO - "product": "firefox", 05:50:21 INFO - "script_repo_revision": "production", 05:50:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:50:21 INFO - "repository": "", 05:50:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:50:21 INFO - "buildid": "20160622030210", 05:50:21 INFO - "stage_platform": "linux64-pgo", 05:50:21 INFO - "basedir": "/builds/slave/test", 05:50:21 INFO - "nightly_build": "True", 05:50:21 INFO - "buildnumber": 69, 05:50:21 INFO - "slavename": "talos-linux64-ix-024", 05:50:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:50:21 INFO - "platform": "ubuntu64_hw", 05:50:21 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:50:21 INFO - "branch": "mozilla-central", 05:50:21 INFO - "repo_path": "mozilla-central", 05:50:21 INFO - "revision": "51377a64158941f89ed73f388ae437cfa494c030", 05:50:21 INFO - "pgo_build": "True", 05:50:21 INFO - "builduid": "1316c70cf0db49a281cf60d702b605d1", 05:50:21 INFO - "slavebuilddir": "test" 05:50:21 INFO - } 05:50:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:50:21 INFO - Running post-action listener: _resource_record_post_action 05:50:21 INFO - ##### 05:50:21 INFO - ##### Finished read-buildbot-config step (success) 05:50:21 INFO - ##### 05:50:21 INFO - ##### 05:50:21 INFO - ##### Running download-and-extract step. 05:50:21 INFO - ##### 05:50:21 INFO - Running pre-action listener: _resource_record_pre_action 05:50:21 INFO - Running main action method: download_and_extract 05:50:21 INFO - mkdir: /builds/slave/test/build/tests 05:50:21 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:50:21 INFO - https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:21 INFO - Downloaded 1361 bytes. 05:50:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:50:21 INFO - Using the following test package requirements: 05:50:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:50:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:50:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'jsshell-linux-x86_64.zip'], 05:50:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:50:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:50:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:50:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:50:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:50:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:50:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:50:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:50:21 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:50:21 INFO - https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:23 INFO - Downloaded 24225542 bytes. 05:50:23 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:50:23 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:50:24 INFO - Return code: 0 05:50:24 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:50:24 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:50:24 INFO - https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:50:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:50:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:26 INFO - Downloaded 24225542 bytes. 05:50:26 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:50:26 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:50:27 INFO - Return code: 0 05:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:27 INFO - https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:29 INFO - Downloaded 14405384 bytes. 05:50:29 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:50:29 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:50:30 INFO - Return code: 0 05:50:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:30 INFO - https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:50:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e09GksRxTlSlAVSAtu6r0A/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:50:32 INFO - Downloaded 60134928 bytes. 05:50:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:32 INFO - mkdir: /builds/slave/test/properties 05:50:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:32 INFO - Contents: 05:50:32 INFO - build_url:https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:50:33 INFO - Running post-action listener: _resource_record_post_action 05:50:33 INFO - Running post-action listener: set_extra_try_arguments 05:50:33 INFO - ##### 05:50:33 INFO - ##### Finished download-and-extract step (success) 05:50:33 INFO - ##### 05:50:33 INFO - ##### 05:50:33 INFO - ##### Running populate-webroot step. 05:50:33 INFO - ##### 05:50:33 INFO - Running pre-action listener: _resource_record_pre_action 05:50:33 INFO - Running main action method: populate_webroot 05:50:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:33 INFO - '--tppagecycles', 05:50:33 INFO - '7'], 05:50:33 INFO - 'tests': ['tsvgm']}}, 05:50:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:50:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:50:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:50:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['damp', 'tps']}, 05:50:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'tests': ['damp', 'tps']}, 05:50:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['dromaeo_dom']}, 05:50:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['basic_compositor_video']}, 05:50:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:50:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['a11yr', 05:50:33 INFO - 'ts_paint', 05:50:33 INFO - 'tpaint', 05:50:33 INFO - 'sessionrestore', 05:50:33 INFO - 'sessionrestore_no_auto_restore', 05:50:33 INFO - 'tabpaint']}, 05:50:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:50:33 INFO - 'ts_paint', 05:50:33 INFO - 'tpaint', 05:50:33 INFO - 'sessionrestore', 05:50:33 INFO - 'sessionrestore_no_auto_restore', 05:50:33 INFO - 'tabpaint']}, 05:50:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:50:33 INFO - 'ts_paint', 05:50:33 INFO - 'tpaint', 05:50:33 INFO - 'sessionrestore', 05:50:33 INFO - 'sessionrestore_no_auto_restore', 05:50:33 INFO - 'tabpaint']}, 05:50:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:50:33 INFO - 'ts_paint', 05:50:33 INFO - 'tpaint', 05:50:33 INFO - 'sessionrestore', 05:50:33 INFO - 'sessionrestore_no_auto_restore', 05:50:33 INFO - 'tabpaint']}, 05:50:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['a11yr', 05:50:33 INFO - 'ts_paint', 05:50:33 INFO - 'tpaint', 05:50:33 INFO - 'sessionrestore', 05:50:33 INFO - 'sessionrestore_no_auto_restore', 05:50:33 INFO - 'tabpaint']}, 05:50:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['a11yr', 05:50:33 INFO - 'ts_paint', 05:50:33 INFO - 'tpaint', 05:50:33 INFO - 'sessionrestore', 05:50:33 INFO - 'sessionrestore_no_auto_restore', 05:50:33 INFO - 'tabpaint']}, 05:50:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['tsvgx', 05:50:33 INFO - 'tsvgr_opacity', 05:50:33 INFO - 'tart', 05:50:33 INFO - 'tscrollx', 05:50:33 INFO - 'cart']}, 05:50:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:50:33 INFO - 'tsvgr_opacity', 05:50:33 INFO - 'tart', 05:50:33 INFO - 'tscrollx', 05:50:33 INFO - 'cart']}, 05:50:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'talos_options': ['--disable-e10s'], 05:50:33 INFO - 'tests': ['tp5o']}, 05:50:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'tests': ['tp5o']}, 05:50:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'talos_options': ['--disable-e10s', 05:50:33 INFO - '--xperf_path', 05:50:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:33 INFO - 'tests': ['tp5n']}, 05:50:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:33 INFO - 'talos_options': ['--xperf_path', 05:50:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:33 INFO - 'tests': ['tp5n']}}, 05:50:33 INFO - 'talos.zip': {'path': '', 05:50:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:33 INFO - Running post-action listener: _resource_record_post_action 05:50:33 INFO - ##### 05:50:33 INFO - ##### Finished populate-webroot step (success) 05:50:33 INFO - ##### 05:50:33 INFO - ##### 05:50:33 INFO - ##### Running create-virtualenv step. 05:50:33 INFO - ##### 05:50:33 INFO - Running pre-action listener: _resource_record_pre_action 05:50:33 INFO - Running main action method: create_virtualenv 05:50:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:33 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:50:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:33 INFO - Using real prefix '/usr' 05:50:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:35 INFO - Installing pip.................done. 05:50:36 INFO - Return code: 0 05:50:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:36 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:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:36 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:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:36 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 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:36 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:50:36 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:50:36 INFO - Using env: {'DISPLAY': ':0', 05:50:36 INFO - 'HOME': '/home/cltbld', 05:50:36 INFO - 'LANG': 'en_US.UTF-8', 05:50:36 INFO - 'LANGUAGE': 'en_US:en', 05:50:36 INFO - 'LOGNAME': 'cltbld', 05:50:36 INFO - 'MAIL': '/var/mail/cltbld', 05:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:36 INFO - 'MOZ_NO_REMOTE': '1', 05:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:36 INFO - 'NO_EM_RESTART': '1', 05:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:36 INFO - 'PWD': '/builds/slave/test', 05:50:36 INFO - 'SHELL': '/bin/bash', 05:50:36 INFO - 'SHLVL': '1', 05:50:36 INFO - 'TERM': 'linux', 05:50:36 INFO - 'TMOUT': '86400', 05:50:36 INFO - 'USER': 'cltbld', 05:50:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:36 INFO - '_': '/tools/buildbot/bin/python'} 05:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:36 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:50:36 INFO - Cleaning up... 05:50:36 INFO - Return code: 0 05:50:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:50:36 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:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:36 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:50:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:36 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 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:36 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:50:36 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:50:36 INFO - Using env: {'DISPLAY': ':0', 05:50:36 INFO - 'HOME': '/home/cltbld', 05:50:36 INFO - 'LANG': 'en_US.UTF-8', 05:50:36 INFO - 'LANGUAGE': 'en_US:en', 05:50:36 INFO - 'LOGNAME': 'cltbld', 05:50:36 INFO - 'MAIL': '/var/mail/cltbld', 05:50:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:36 INFO - 'MOZ_NO_REMOTE': '1', 05:50:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:36 INFO - 'NO_EM_RESTART': '1', 05:50:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:36 INFO - 'PWD': '/builds/slave/test', 05:50:36 INFO - 'SHELL': '/bin/bash', 05:50:36 INFO - 'SHLVL': '1', 05:50:36 INFO - 'TERM': 'linux', 05:50:36 INFO - 'TMOUT': '86400', 05:50:36 INFO - 'USER': 'cltbld', 05:50:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:36 INFO - '_': '/tools/buildbot/bin/python'} 05:50:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:36 INFO - Downloading/unpacking psutil>=3.1.1 05:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:38 INFO - Installing collected packages: psutil 05:50:38 INFO - Running setup.py install for psutil 05:50:38 INFO - building 'psutil._psutil_linux' extension 05:50:38 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:50:38 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:50:38 INFO - building 'psutil._psutil_posix' extension 05:50:38 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:50:38 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:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:38 INFO - Successfully installed psutil 05:50:38 INFO - Cleaning up... 05:50:39 INFO - Return code: 0 05:50:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:50:39 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:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:39 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:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:39 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 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:39 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:50:39 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:50:39 INFO - Using env: {'DISPLAY': ':0', 05:50:39 INFO - 'HOME': '/home/cltbld', 05:50:39 INFO - 'LANG': 'en_US.UTF-8', 05:50:39 INFO - 'LANGUAGE': 'en_US:en', 05:50:39 INFO - 'LOGNAME': 'cltbld', 05:50:39 INFO - 'MAIL': '/var/mail/cltbld', 05:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:39 INFO - 'MOZ_NO_REMOTE': '1', 05:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:39 INFO - 'NO_EM_RESTART': '1', 05:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:39 INFO - 'PWD': '/builds/slave/test', 05:50:39 INFO - 'SHELL': '/bin/bash', 05:50:39 INFO - 'SHLVL': '1', 05:50:39 INFO - 'TERM': 'linux', 05:50:39 INFO - 'TMOUT': '86400', 05:50:39 INFO - 'USER': 'cltbld', 05:50:39 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:39 INFO - '_': '/tools/buildbot/bin/python'} 05:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:50:39 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:50:39 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:50:39 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:50:39 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:50:39 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:50:39 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:50:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:50:42 INFO - Installing collected packages: mozsystemmonitor 05:50:42 INFO - Running setup.py install for mozsystemmonitor 05:50:42 INFO - Successfully installed mozsystemmonitor 05:50:42 INFO - Cleaning up... 05:50:42 INFO - Return code: 0 05:50:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:50:42 INFO - Using env: {'DISPLAY': ':0', 05:50:42 INFO - 'HOME': '/home/cltbld', 05:50:42 INFO - 'LANG': 'en_US.UTF-8', 05:50:42 INFO - 'LANGUAGE': 'en_US:en', 05:50:42 INFO - 'LOGNAME': 'cltbld', 05:50:42 INFO - 'MAIL': '/var/mail/cltbld', 05:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:42 INFO - 'MOZ_NO_REMOTE': '1', 05:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:42 INFO - 'NO_EM_RESTART': '1', 05:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:42 INFO - 'PWD': '/builds/slave/test', 05:50:42 INFO - 'SHELL': '/bin/bash', 05:50:42 INFO - 'SHLVL': '1', 05:50:42 INFO - 'TERM': 'linux', 05:50:42 INFO - 'TMOUT': '86400', 05:50:42 INFO - 'USER': 'cltbld', 05:50:42 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:42 INFO - '_': '/tools/buildbot/bin/python'} 05:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:42 INFO - Downloading/unpacking jsonschema==2.5.1 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:50:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:44 INFO - Downloading functools32-3.2.3-2.tar.gz 05:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:50:44 INFO - warning: no files found matching '*.txt' 05:50:44 INFO - no previously-included directories found matching 'build' 05:50:44 INFO - no previously-included directories found matching 'dist' 05:50:44 INFO - no previously-included directories found matching '.git*' 05:50:44 INFO - Installing collected packages: jsonschema, functools32 05:50:44 INFO - Running setup.py install for functools32 05:50:44 INFO - warning: no files found matching '*.txt' 05:50:44 INFO - no previously-included directories found matching 'build' 05:50:44 INFO - no previously-included directories found matching 'dist' 05:50:44 INFO - no previously-included directories found matching '.git*' 05:50:44 INFO - Successfully installed jsonschema functools32 05:50:44 INFO - Cleaning up... 05:50:44 INFO - Return code: 0 05:50:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50:44 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:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 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:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:44 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 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:44 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:50:44 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:50:44 INFO - Using env: {'DISPLAY': ':0', 05:50:44 INFO - 'HOME': '/home/cltbld', 05:50:44 INFO - 'LANG': 'en_US.UTF-8', 05:50:44 INFO - 'LANGUAGE': 'en_US:en', 05:50:44 INFO - 'LOGNAME': 'cltbld', 05:50:44 INFO - 'MAIL': '/var/mail/cltbld', 05:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:44 INFO - 'MOZ_NO_REMOTE': '1', 05:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:44 INFO - 'NO_EM_RESTART': '1', 05:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:44 INFO - 'PWD': '/builds/slave/test', 05:50:44 INFO - 'SHELL': '/bin/bash', 05:50:44 INFO - 'SHLVL': '1', 05:50:44 INFO - 'TERM': 'linux', 05:50:44 INFO - 'TMOUT': '86400', 05:50:44 INFO - 'USER': 'cltbld', 05:50:44 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:44 INFO - '_': '/tools/buildbot/bin/python'} 05:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:47 INFO - Downloading docopt-0.6.1.tar.gz 05:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:47 INFO - Running setup.py install for blobuploader 05:50:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:47 INFO - Running setup.py install for requests 05:50:48 INFO - Running setup.py install for docopt 05:50:48 INFO - Successfully installed blobuploader requests docopt 05:50:48 INFO - Cleaning up... 05:50:48 INFO - Return code: 0 05:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:48 INFO - Using env: {'DISPLAY': ':0', 05:50:48 INFO - 'HOME': '/home/cltbld', 05:50:48 INFO - 'LANG': 'en_US.UTF-8', 05:50:48 INFO - 'LANGUAGE': 'en_US:en', 05:50:48 INFO - 'LOGNAME': 'cltbld', 05:50:48 INFO - 'MAIL': '/var/mail/cltbld', 05:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:48 INFO - 'MOZ_NO_REMOTE': '1', 05:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:48 INFO - 'NO_EM_RESTART': '1', 05:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:48 INFO - 'PWD': '/builds/slave/test', 05:50:48 INFO - 'SHELL': '/bin/bash', 05:50:48 INFO - 'SHLVL': '1', 05:50:48 INFO - 'TERM': 'linux', 05:50:48 INFO - 'TMOUT': '86400', 05:50:48 INFO - 'USER': 'cltbld', 05:50:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:48 INFO - '_': '/tools/buildbot/bin/python'} 05:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:48 INFO - Running setup.py (path:/tmp/pip-J2RaBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:48 INFO - Running setup.py (path:/tmp/pip-hZaTR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:48 INFO - Running setup.py (path:/tmp/pip-diQXl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:48 INFO - Running setup.py (path:/tmp/pip-fXUomB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:48 INFO - Running setup.py (path:/tmp/pip-OM97e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:48 INFO - Running setup.py (path:/tmp/pip-37O3r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:49 INFO - Running setup.py (path:/tmp/pip-CCxkS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:49 INFO - Running setup.py (path:/tmp/pip-zb3msi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:49 INFO - Running setup.py (path:/tmp/pip-XnZ1BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:49 INFO - Running setup.py (path:/tmp/pip-5GLbyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:49 INFO - Running setup.py (path:/tmp/pip-rMNr8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:49 INFO - Running setup.py (path:/tmp/pip-e4FEF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:49 INFO - Running setup.py (path:/tmp/pip-Z2tdF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:49 INFO - Running setup.py (path:/tmp/pip-QvMTLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:49 INFO - Running setup.py (path:/tmp/pip-BqDY1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:49 INFO - Running setup.py (path:/tmp/pip-G2hWYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:49 INFO - Running setup.py (path:/tmp/pip-Qm7j1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:49 INFO - Running setup.py install for manifestparser 05:50:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:49 INFO - Running setup.py install for mozcrash 05:50:50 INFO - Running setup.py install for mozdebug 05:50:50 INFO - Running setup.py install for mozdevice 05:50:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Running setup.py install for mozfile 05:50:50 INFO - Running setup.py install for mozhttpd 05:50:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Running setup.py install for mozinfo 05:50:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Running setup.py install for mozInstall 05:50:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Running setup.py install for mozleak 05:50:50 INFO - Running setup.py install for mozlog 05:50:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:50 INFO - Running setup.py install for moznetwork 05:50:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:51 INFO - Running setup.py install for mozprocess 05:50:51 INFO - Running setup.py install for mozprofile 05:50:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:51 INFO - Running setup.py install for mozrunner 05:50:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:51 INFO - Running setup.py install for mozscreenshot 05:50:51 INFO - Running setup.py install for moztest 05:50:51 INFO - Running setup.py install for mozversion 05:50:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:51 INFO - Cleaning up... 05:50:51 INFO - Return code: 0 05:50:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:51 INFO - Using env: {'DISPLAY': ':0', 05:50:51 INFO - 'HOME': '/home/cltbld', 05:50:51 INFO - 'LANG': 'en_US.UTF-8', 05:50:51 INFO - 'LANGUAGE': 'en_US:en', 05:50:51 INFO - 'LOGNAME': 'cltbld', 05:50:51 INFO - 'MAIL': '/var/mail/cltbld', 05:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:51 INFO - 'MOZ_NO_REMOTE': '1', 05:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:51 INFO - 'NO_EM_RESTART': '1', 05:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:51 INFO - 'PWD': '/builds/slave/test', 05:50:51 INFO - 'SHELL': '/bin/bash', 05:50:51 INFO - 'SHLVL': '1', 05:50:51 INFO - 'TERM': 'linux', 05:50:51 INFO - 'TMOUT': '86400', 05:50:51 INFO - 'USER': 'cltbld', 05:50:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:51 INFO - '_': '/tools/buildbot/bin/python'} 05:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:51 INFO - Running setup.py (path:/tmp/pip-xLAwWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:51 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:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:51 INFO - Running setup.py (path:/tmp/pip-X7JjwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:52 INFO - Running setup.py (path:/tmp/pip-rLNw6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:52 INFO - Running setup.py (path:/tmp/pip-aJvXin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:52 INFO - Running setup.py (path:/tmp/pip-0LMnmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:52 INFO - Running setup.py (path:/tmp/pip-oJzftw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:52 INFO - Running setup.py (path:/tmp/pip-E4TbM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:52 INFO - Running setup.py (path:/tmp/pip-HFHmxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:52 INFO - Running setup.py (path:/tmp/pip-eNvilW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:52 INFO - Running setup.py (path:/tmp/pip-rFrbEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:52 INFO - Running setup.py (path:/tmp/pip-OK9qf9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:52 INFO - Running setup.py (path:/tmp/pip-gjgfCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:52 INFO - Running setup.py (path:/tmp/pip-7dXLM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:52 INFO - Running setup.py (path:/tmp/pip-oeMucA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:52 INFO - Running setup.py (path:/tmp/pip-WvuP1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:52 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:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:52 INFO - Running setup.py (path:/tmp/pip-DUHzjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:53 INFO - Running setup.py (path:/tmp/pip-cTFPDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:50:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:55 INFO - Downloading blessings-1.6.tar.gz 05:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:55 INFO - Installing collected packages: blessings 05:50:55 INFO - Running setup.py install for blessings 05:50:55 INFO - Successfully installed blessings 05:50:55 INFO - Cleaning up... 05:50:55 INFO - Return code: 0 05:50:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:50:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:55 INFO - Reading from file tmpfile_stdout 05:50:55 INFO - Current package versions: 05:50:55 INFO - argparse == 1.2.1 05:50:55 INFO - blessings == 1.6 05:50:55 INFO - blobuploader == 1.2.4 05:50:55 INFO - docopt == 0.6.1 05:50:55 INFO - functools32 == 3.2.3-2 05:50:55 INFO - jsonschema == 2.5.1 05:50:55 INFO - manifestparser == 1.1 05:50:55 INFO - mozInstall == 1.12 05:50:55 INFO - mozcrash == 0.17 05:50:55 INFO - mozdebug == 0.1 05:50:55 INFO - mozdevice == 0.48 05:50:55 INFO - mozfile == 1.2 05:50:55 INFO - mozhttpd == 0.7 05:50:55 INFO - mozinfo == 0.9 05:50:55 INFO - mozleak == 0.1 05:50:55 INFO - mozlog == 3.2 05:50:55 INFO - moznetwork == 0.27 05:50:55 INFO - mozprocess == 0.22 05:50:55 INFO - mozprofile == 0.28 05:50:55 INFO - mozrunner == 6.11 05:50:55 INFO - mozscreenshot == 0.1 05:50:55 INFO - mozsystemmonitor == 0.3 05:50:55 INFO - moztest == 0.7 05:50:55 INFO - mozversion == 1.4 05:50:55 INFO - psutil == 3.1.1 05:50:55 INFO - requests == 1.2.3 05:50:55 INFO - wsgiref == 0.1.2 05:50:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50: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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:55 INFO - Using env: {'DISPLAY': ':0', 05:50:55 INFO - 'HOME': '/home/cltbld', 05:50:55 INFO - 'LANG': 'en_US.UTF-8', 05:50:55 INFO - 'LANGUAGE': 'en_US:en', 05:50:55 INFO - 'LOGNAME': 'cltbld', 05:50:55 INFO - 'MAIL': '/var/mail/cltbld', 05:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:55 INFO - 'MOZ_NO_REMOTE': '1', 05:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:55 INFO - 'NO_EM_RESTART': '1', 05:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:55 INFO - 'PWD': '/builds/slave/test', 05:50:55 INFO - 'SHELL': '/bin/bash', 05:50:55 INFO - 'SHLVL': '1', 05:50:55 INFO - 'TERM': 'linux', 05:50:55 INFO - 'TMOUT': '86400', 05:50:55 INFO - 'USER': 'cltbld', 05:50:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:55 INFO - '_': '/tools/buildbot/bin/python'} 05:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:50:55 INFO - Cleaning up... 05:50:55 INFO - Return code: 0 05:50:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:50: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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:50:55 INFO - Using env: {'DISPLAY': ':0', 05:50:55 INFO - 'HOME': '/home/cltbld', 05:50:55 INFO - 'LANG': 'en_US.UTF-8', 05:50:55 INFO - 'LANGUAGE': 'en_US:en', 05:50:55 INFO - 'LOGNAME': 'cltbld', 05:50:55 INFO - 'MAIL': '/var/mail/cltbld', 05:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:55 INFO - 'MOZ_NO_REMOTE': '1', 05:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:55 INFO - 'NO_EM_RESTART': '1', 05:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:55 INFO - 'PWD': '/builds/slave/test', 05:50:55 INFO - 'SHELL': '/bin/bash', 05:50:55 INFO - 'SHLVL': '1', 05:50:55 INFO - 'TERM': 'linux', 05:50:55 INFO - 'TMOUT': '86400', 05:50:55 INFO - 'USER': 'cltbld', 05:50:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:55 INFO - '_': '/tools/buildbot/bin/python'} 05:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:50:55 INFO - Cleaning up... 05:50:55 INFO - Return code: 0 05:50:55 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:50: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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6406b84f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfe9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, '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': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', '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:50: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', 'flake8'] in /builds/slave/test/build 05:50: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 flake8 05:50:55 INFO - Using env: {'DISPLAY': ':0', 05:50:55 INFO - 'HOME': '/home/cltbld', 05:50:55 INFO - 'LANG': 'en_US.UTF-8', 05:50:55 INFO - 'LANGUAGE': 'en_US:en', 05:50:55 INFO - 'LOGNAME': 'cltbld', 05:50:55 INFO - 'MAIL': '/var/mail/cltbld', 05:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:55 INFO - 'MOZ_NO_REMOTE': '1', 05:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:55 INFO - 'NO_EM_RESTART': '1', 05:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:55 INFO - 'PWD': '/builds/slave/test', 05:50:55 INFO - 'SHELL': '/bin/bash', 05:50:55 INFO - 'SHLVL': '1', 05:50:55 INFO - 'TERM': 'linux', 05:50:55 INFO - 'TMOUT': '86400', 05:50:55 INFO - 'USER': 'cltbld', 05:50:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:55 INFO - '_': '/tools/buildbot/bin/python'} 05:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:56 INFO - Downloading/unpacking flake8 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:50:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:50: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:50: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:50: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:50: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:50: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:50: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:50:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:50:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:50: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:50: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:50: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:50: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:50: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:50: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:50:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:50: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:50: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:50: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:50: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:50: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:50: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:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:59 INFO - no previously-included directories found matching 'docs/_build' 05:50:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:50:59 INFO - Running setup.py install for pep8 05:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:50:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:50:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:50:59 INFO - no previously-included directories found matching 'docs/_build' 05:50:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:50:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:50:59 INFO - Cleaning up... 05:50:59 INFO - Return code: 0 05:50:59 INFO - Running post-action listener: _resource_record_post_action 05:50:59 INFO - Running post-action listener: _start_resource_monitoring 05:50:59 INFO - Starting resource monitoring. 05:50:59 INFO - ##### 05:50:59 INFO - ##### Finished create-virtualenv step (success) 05:50:59 INFO - ##### 05:50:59 INFO - ##### 05:50:59 INFO - ##### Running install step. 05:50:59 INFO - ##### 05:50:59 INFO - Running pre-action listener: _resource_record_pre_action 05:50:59 INFO - Running main action method: install 05:50:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:00 INFO - Reading from file tmpfile_stdout 05:51:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:00 INFO - Reading from file tmpfile_stdout 05:51:00 INFO - Output received: 05:51:00 INFO - Usage: mozinstall [options] installer 05:51:00 INFO - Options: 05:51:00 INFO - -h, --help show this help message and exit 05:51:00 INFO - -d DEST, --destination=DEST 05:51:00 INFO - Directory to install application into. [default: 05:51:00 INFO - "/builds/slave/test"] 05:51:00 INFO - --app=APP Application being installed. [default: firefox] 05:51:00 INFO - mkdir: /builds/slave/test/build/application 05:51:00 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:51:00 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:51:17 INFO - Reading from file tmpfile_stdout 05:51:17 INFO - Output received: 05:51:17 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:17 INFO - Running post-action listener: _resource_record_post_action 05:51:17 INFO - ##### 05:51:17 INFO - ##### Finished install step (success) 05:51:17 INFO - ##### 05:51:17 INFO - ##### 05:51:17 INFO - ##### Running run-tests step. 05:51:17 INFO - ##### 05:51:17 INFO - Running pre-action listener: _resource_record_pre_action 05:51:17 INFO - Running main action method: run_tests 05:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:17 INFO - Python 2.7.3 05:51:17 INFO - Return code: 0 05:51:17 INFO - grabbing minidump binary from tooltool 05:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:17 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 0x10781c0>, '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 0x10790c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:17 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:51:17 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:51:17 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:51:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:17 INFO - Return code: 0 05:51:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:51:18 INFO - Return code: 0 05:51:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:51:18 INFO - Using env: {'DISPLAY': ':0', 05:51:18 INFO - 'HOME': '/home/cltbld', 05:51:18 INFO - 'LANG': 'en_US.UTF-8', 05:51:18 INFO - 'LANGUAGE': 'en_US:en', 05:51:18 INFO - 'LOGNAME': 'cltbld', 05:51:18 INFO - 'MAIL': '/var/mail/cltbld', 05:51:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:18 INFO - 'MOZ_NO_REMOTE': '1', 05:51:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:18 INFO - 'NO_EM_RESTART': '1', 05:51:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:18 INFO - 'PWD': '/builds/slave/test', 05:51:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:18 INFO - 'SHELL': '/bin/bash', 05:51:18 INFO - 'SHLVL': '1', 05:51:18 INFO - 'TERM': 'linux', 05:51:18 INFO - 'TMOUT': '86400', 05:51:18 INFO - 'USER': 'cltbld', 05:51:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415', 05:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:18 INFO - '_': '/tools/buildbot/bin/python'} 05:51:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:51:18 INFO - mozversion application_buildid: 20160622030210 05:51:18 INFO - mozversion application_changeset: 51377a64158941f89ed73f388ae437cfa494c030 05:51:18 INFO - mozversion application_display_name: Nightly 05:51:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:18 INFO - mozversion application_name: Firefox 05:51:18 INFO - mozversion application_remotingname: firefox 05:51:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:51:18 INFO - mozversion application_vendor: Mozilla 05:51:18 INFO - mozversion application_version: 50.0a1 05:51:18 INFO - mozversion platform_buildid: 20160622030210 05:51:18 INFO - mozversion platform_changeset: 51377a64158941f89ed73f388ae437cfa494c030 05:51:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:51:18 INFO - mozversion platform_version: 50.0a1 05:51:18 INFO - using testdate: 1466599878 05:51:18 INFO - actual date: 1466599878 05:51:18 INFO - starting webserver on 'localhost:53652' 05:51:18 INFO - SUITE-START | Running 2 tests 05:51:18 INFO - TEST-START | dromaeo_css 05:51:18 INFO - operating with platform_type : linux_ 05:51:18 INFO - Initialising browser for dromaeo_css test... 05:51:18 INFO - TEST-INFO | started process 30232 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFScf3a/profile http://localhost:53652/getInfo.html) 05:51:23 INFO - PROCESS | 30232 | __metrics Screen width/height:1600/1200 05:51:23 INFO - PROCESS | 30232 | colorDepth:24 05:51:23 INFO - PROCESS | 30232 | Browser inner width/height: 1024/697 05:51:23 INFO - PROCESS | 30232 | __metrics 05:51:24 ERROR - PROCESS | 30232 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 05:51:24 INFO - TEST-INFO | 30232: exit 0 05:51:24 INFO - Browser initialized. 05:51:24 INFO - Running cycle 1/1 for dromaeo_css test... 05:51:24 INFO - TEST-INFO | started process 30352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFScf3a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:36 INFO - PROCESS | 30352 | RSS: Main: 185012224 05:51:36 INFO - PROCESS | 30352 | 05:52:26 INFO - PROCESS | 30352 | 1466599946402 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:54:34 INFO - PROCESS | 30352 | Cycle 1(1): loaded http://localhost:53652/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53652/tests/dromaeo/cssquery-ext.html) 05:54:35 INFO - PROCESS | 30352 | RSS: Main: 189337600 05:54:35 INFO - PROCESS | 30352 | 05:57:38 INFO - PROCESS | 30352 | Cycle 1(1): loaded http://localhost:53652/tests/dromaeo/cssquery-ext.html (next: http://localhost:53652/tests/dromaeo/cssquery-jquery.html) 05:57:38 INFO - PROCESS | 30352 | RSS: Main: 188243968 05:57:38 INFO - PROCESS | 30352 | 06:00:40 INFO - PROCESS | 30352 | Cycle 1(1): loaded http://localhost:53652/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53652/tests/dromaeo/cssquery-mootools.html) 06:00:41 INFO - PROCESS | 30352 | RSS: Main: 188878848 06:00:41 INFO - PROCESS | 30352 | 06:03:42 INFO - PROCESS | 30352 | Cycle 1(1): loaded http://localhost:53652/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53652/tests/dromaeo/cssquery-prototype.html) 06:03:43 INFO - PROCESS | 30352 | RSS: Main: 186540032 06:03:43 INFO - PROCESS | 30352 | 06:06:45 INFO - PROCESS | 30352 | Cycle 1(1): loaded http://localhost:53652/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53652/tests/dromaeo/cssquery-yui.html) 06:06:46 INFO - PROCESS | 30352 | RSS: Main: 188264448 06:06:46 INFO - PROCESS | 30352 | 06:09:48 INFO - PROCESS | 30352 | Cycle 1(1): loaded http://localhost:53652/tests/dromaeo/cssquery-yui.html (next: http://localhost:53652/tests/dromaeo/cssquery-dojo.html) 06:09:49 INFO - PROCESS | 30352 | RSS: Main: 189489152 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | __start_tp_report 06:09:49 INFO - PROCESS | 30352 | _x_x_mozilla_page_load 06:09:49 INFO - PROCESS | 30352 | _x_x_mozilla_page_load_details 06:09:49 INFO - PROCESS | 30352 | |i|pagename|runs| 06:09:49 INFO - PROCESS | 30352 | |0;dojo.html;3103.9844800776;3172.936541269173;3183.617965844099;3196.3926853897756;3199.4400979828524;5418.810341638044;5456.481634244746;5477.342718873736;5525.613207075507;5527.806526771564;5314;5391.703456309901;5432.429594892538;5475.72621368932;5527.419620939803;4888.242322440027;4924.162892308316;5027.4972502749615;5046.617141147718;5107.28498010277;792.8934354615706;4951.5791157751455;4987.875303117415;5018.84943451697;5029.220470827027;4923.532264434873;4930.80276788928;4947.282644016615;4956.975215123919;5003.17447621142;4812.951870481285;4947.50524947506;4950.579200767939;4971.1549036663855;5005.6496045276845;4897.730624815634;4922.852314430573;4950.801967921278;4970.701757894538;4992.026554821811;5402.432744561804;5488.588355873326;5559.722013899329;5566.248556444909;5634.295713035871;5862.179294898718;5933.3473317934995;5943.078822782476;5946.881062378771;5961.642301461926;5924.1113832924975;5955.52355811534;6004.759809607611;6009.60937539063;6060.666663333515;5590.888182236373;5607.80372686954;5608.270924779753;5610;5616.157576363496;5761.107028410603;5876.706164691748;5927.377625349276;5928.525717942554;6150.7847225346895;5745.68398738065;5752.28096487939;5760.0207964646115;5760.135979603093;5763.250777398911;5838.036723940587;5846.064629659234;5853.385394533512;5856.765729370863;5857.7949771757785;5621.494065534122;5747.885042299131;5848.152017957457;5888.440598143169;5904.0553511437965;5653.265075540236;5741.799037033684;5803.129530570448;5861.325947516005;5924;4448.110377924428;4453.46558412986;4462.3752674625575;4500.504944456107;4512.52618475062;3861.7296789224483;3928.64642182205;3942.1721438498234;3985.7807820570147;3995.081131339808;5500.22996780451;5509.3664228613425;5532.6680399176175;5535.667859928417;5552.7223638817895;5807.477327040502;5908.379620139909;5912.497437717842;5919.260092488439;5971;5344.545713614309;5439.836804895859;5502;5514.6691198528215;5521.3926468088475;5060.063888180698;5061.924071138936;5065.822696205615;5078.746062696924;5117.8464646060675;5874.559408044328;6065.60573562717;6080.452759251689;6085.330613632497;6086.6348019119;5822.505087067647;5896.820635872757;5936.228290322403;5983.820485385445;6000.159977603226;6116.969415153074;6160.291566469913;6179.81460556184;6187;6191.9690401547705;5561.360443549043;5653.095504719226;5878.2064421304285;5881.264841894763;5882.147088672033;5832.533397328119;5833.212516310244;5853.151293062397;5915.2310199675485;5926.496247818811;5705.144228365778;5746.827595172152;5753.165790960204;5761.366249712444;5768.221290125779;5551.777928882961;5665.461781130786;5710.4004079572705;5745.454181852718;5763.827085187451;5391.919121213106;5455.290812194548;5518.751656175402;5525.530329921841;5699.088145896637;5625.549956003591;5655.4344565543115;5698.943010569841;5701.7434215461235;5705.343885453226;5438.374586922555;5596.888062238814;5616.578756593353;5623.662580245198;5657.038303488499 06:09:49 INFO - PROCESS | 30352 | |1;ext.html;575.2895174459542;611.7033238879145;619.8357435279651;636.9108324834524;640.7372977079399;42551;44368.55631443684;44432.77783611078;44691;47942.28086578704;46585.534144658544;47204.52795472044;47226.52773472273;47250.527494725044;47273;9014.594343254554;9066.274698024143;9090.318226133033;9100.089991000914;9100.8634870477;8895;8959.776005599879;8960.820783584324;8970.327225458084;9029.729108126734;8932.285417166611;8974.19232269099;8979.64081436745;8985.640574377017;9040.547972601376;9051.818963620724;9066.274698024175;9068.591913363849;9084.863727044067;9100.089991000914;8912.197902188835;8914.197722205032;8945.686900958435;8989.146031127033;9000.954995224982;43206.35190472114;43495;43634.781826090984;43652;43710.781446092886;3557.573091229069;3671.1372827385544;3801.467794508771;3953.881383558498;4025.3595666830583;31827.522587161213;32966.83516582425;33945.32109357823;33960;35292.47061294083;4244.257254980366;4282.764447955361;4300.204462174476;4325.264705000158;4484.035932274576;365520;365782;365923;367091.9999999973;367314;60319;61080.694596527625;61179.38820611737;61187.694061530296;61307.6934615333;35559.64440355615;36671;36801.23990700708;38475.42286865699;38627.80686096552;16930.238139283763;17059;17060.829391705924;17066.061366624956;17119.657606848043;13713.382897769625;13797.724045519033;13807.378667959965;13828.03203775746;13838.723225535434;19609.411717648494;19642.312519061765;19824.20703171886;19941;20063.498412539513;7353.4484913631695;7373.668184931584;7448.4041276697735;7457.776266712007;7550.5469671819865;968.5012218707371;1065.3075500924306;1082.226208261097;1135.9091272698165;1164.1908873332952;32912.00898648542;32983.50524742131;33245.83377083147;33393.165170870925;33684.663153368645;1038.6520515627349;1089.8637670291214;1106.983395249072;1114.7268919114706;1154.6824623228679;16647.750283745754;16987.830121698626;17021.574460638334;17240.568985775455;17415.39046133379;610950;613747;615050;620753;621752;60339.39660603426;60536.394636053956;60672.39327606667;60831.69584152051;61033;1329.5213723059692;1349.743548725739;1361.611940596925;1373.0251521419905;1393.9860601393857;30569.23576910595;31811.20471988126;31849.203769905936;32072.358552828347;32516;52028.47971520236;52798;52867.73566132145;52876.97668721465;52925.470745292056;501478;511553;511789;511834;512809.43595281785;28871.56692649654;29094.27264318409;29191.08089191064;29196.854015729787;29237.70762292435;48692;48788.75605621949;49120.263196051375;49134.75432622814;49873.750631246614;41046.79476602598;42064;42131;42802.78598607112;42912.78543607262;41145.58854411417;41179.7941010293;41442.792786035876;41943.161136776485;42637.36043959405;35266.29467410689;39715.80142099271;40043.599564005155;40845;41181.794091029355;34403.65596344005;37412.94228817441;37722;37798.62201377951;37927.62072379241;27227.72772272252;27654.446911061263;27774.5833812497;28094.85952570224;28269 06:09:49 INFO - PROCESS | 30352 | |2;jquery.html;362.18508356198555;380.67071982734944;380.92762375148726;382.8717379677808;397.01936217542675;17592.648147037053;19606.31377901774;19871.701924471145;19956.20175192994;20166.092525836335;17787.288508459646;18451.169697363617;18477.7228341575;19279.22883084675;19306.227750889946;5023.4725353837775;5183.403908550527;5207.557357624606;5217.034848553011;5557;5588.748506317205;5660.122680984454;5689.203511508392;5702.372738998707;5706;5622;5628.662280263176;5656.519195868335;5664.291963504562;5717.628354156987;5545.112781954888;5672.404397538282;5686.3744988051285;5707.172459993299;5714.799982000631;4845.660803743739;4946.752662366867;4960.900781984376;5037.017781532602;5054.721990290533;12134.453949572291;12240.632781016584;12309.753804923941;12414.565490207799;15560.92219538895;2229.4092065602626;2255.729312482513;2293.312006398074;2514.6982362116664;2839.943201135966;9335.299852511089;9369.344145909788;9407.153356197976;9548.856767148498;12243.20419172751;1837.4120281509922;1961.7351657526337;1969.5765410436682;1969.9212031518723;1971.8422526198012;55987.44012559863;72712.27287727161;74363;76698.61650691766;79886.6005669968;9710.320277580642;9798.559064842098;10223.284370094021;10242.948785256174;10263.435511046964;13645.658858528615;13763.31183440824;13783.173009619455;13798.310084495735;13802.861971380358;7598.392128629696;7808.375329973588;7945.48354356965;7983.600819958979;8142.592870356459;8059.959700201462;8082;8155.632996515171;8271.627776750061;8382.49705017701;4119.711620186558;4197.8320867164975;4227.915441691149;4296.097819457948;4310.22415965123;1710.042376269293;1720.1743163281694;1731.5757639378432;1770.4334612924;1799.361226764506;955.8852937647388;957.1385752822376;968.2060710217554;981.2346369831542;1031.6389263757624;18937.33719319817;19171;19176.52058698516;19410.90058013572;19502.804971950383;972.9173020293213;1045.4250162410644;1045.6131231444263;1055.4142450939648;1084.8969347911936;10316.329438586468;10846.403447810446;10893.509792059218;10973.615923442641;11061.778764424827;461991;467023;467803;469722;476920;59388;94255.52872235594;99612;99923.50038249762;100643;992.7666998255404;1019.3934608907688;1038.2680210451613;1044.6970378590124;1053.6154303679255;17628.91185544064;17867.195976180843;17981.73027404564;18029.81970180334;18540.907295463436;40250;42107.578924210364;42405.57594424016;43072.13855722931;43124.137517248855;61596;62096.68951655213;62867.6856615714;63208.36791632025;63621;8166.673333066611;8402.957985210034;8447.197516235949;8492.70275540353;8598.957005214934;12265.26408415498;12856.228626282453;13018.893394061612;13154;13678.521251756141;11281.548738050715;11316.37759923212;11404.144689148514;11526.596569120376;11764.35296058725;10019.660090017276;10037.949810250902;11253.66239012831;11578.536858525902;11982.520699171935;11112;11112.444377780917;11185.944070279596;11614.419279035845;11709.76580468403;7992.440529163136;8107.716229931924;8203.466774659866;8303.875441868498;8332.250097491255;8003.239692229229;10155.695329140137;10999.065079468015;11380.146489013523;11534.307941523535 06:09:49 INFO - PROCESS | 30352 | |3;mootools.html;1449.3043339197188;1482.384810303724;1584.7147513447583;1719.191979769508;1721.449136276392;7110.0756901602845;7856.882146767803;7957.482763620361;8472.279856212213;8481.745547633573;7973.521588704667;8234.547099909503;8261.793455163624;8286.83426331473;8300.045494768088;2121.809037186653;2158.201465457775;2159.600473912323;2164.1667957836266;2165.72928383952;2070.554830711397;2103.92636257731;2105.0422057963588;2110.0715685098507;2114.7145135406754;2072;2075.169932027186;2105.0422057963665;2109.504266497372;2131.765505794361;2145.313499680095;2169.457635591102;2175.8912054397215;2178.869267843919;2179.4660308224506;2051.5896820635785;2094.8219401350902;2101.5796840631783;2112.7359080114984;2123.2568600989684;8284.212999765012;8302.501849888966;8327.20891515305;8349.791255218668;8351.830743695888;4823;4930.260460930853;4936.111499930011;4961.08219979305;4963.3299504566785;3112.517559778238;3158.873645054195;3248.2691394436297;3273.623533293654;3300.7689461737687;1046.5918291866178;1096.2490693874643;1100.5157730598512;1116.1963386361888;1123.9606613768478;11024.44877756109;11077.335359878352;11137.05335046522;11176.832347514794;11193.328400296008;4123.773192474383;4158.771267580312;4206.4531610891;4211.873643790691;4256.57434256578;9456.669016584525;9585.712428627152;9595.760105997406;9598.808023839483;9634.662786802428;4819.180739274261;4823.204171311694;4843.39457567804;4847.442544107403;4853.150698627726;4012.4382586437923;4407.162639098561;4484.1255955088445;4551.453825540956;4564.041551274269;3696.2053158571034;3731.067233191702;3761.7366784324836;3819.350710379242;3823.6941044716355;1178.3636836108576;1180.433391971841;1183.7040739815047;1187.4834447015403;1192.451472322724;988;1001.5042553935848;1006.7432804634772;1011.2567263061644;1014.401503113152;5747.597668163272;5906.734196961147;5965.612235204698;5966.463018328372;6091;391.4167889844169;391.5399405698293;393.54348955211816;393.9074317535377;406.3863566015338;4028.274910516135;4212.262854000538;4383.671224658164;4438.7114837535455;4453.910921781546;9751.17115045215;10238.897611023795;10324.845127323097;10325.74185645365;10331.948340258401;9929.851052234222;10184.490775461198;10192.490375481197;10216.335938163995;10221.693349199535;7380.74167404149;7409.925900741031;7474.663640136207;7477.252274772588;7494.850102998019;5697.658140511582;5746.482816546531;5820.097884827858;5827.446392592697;5915.37888521699;8746.38775285724;8854.380193386658;8961.775955601162;8963.462192268486;9043.864342035007;8501.319894408309;8887.73336799897;9002.279817614706;9065.093490650883;9115.817683646157;7340.70637174507;7412.555246685216;7478.775636730907;7479.70081196746;7516.699332026657;7997.560134192675;8008.319292859939;8029.518228906284;8033.116357200586;8044.235797599219;6862.142232220973;7192.964035179791;7202.71189152428;7247.9637601811655;7249.093863267091;7088.822779430349;7100.715971361295;7108.253633368422;7182.569045857265;7281.089863767029;6396.456301214449;6402.775902843378;6441.581297215666;6456.354364563506;6456.709448074942;4915.21356582945;5042.39491261051;5086.669366491166;5126.077306084941;5177.922331165111;5005.5745261653165;5086.287919691172;5133.281340612242;5136.845894623168;5282.577393808563 06:09:49 INFO - PROCESS | 30352 | |4;prototype.html;287.17007847321247;290.4409012650647;290.4800407270985;304.2697525937749;305.8654192155453;5471.206675032118;5539.556835453164;5699.943000569998;5737.971310143449;5754.539636829054;5583.553315734742;5633.971830140854;5642.830715078544;5676.829695109143;5677.48902598766;4192.182524407742;4241.639460645849;4301.505326887409;4309.698321117523;4343.522212556616;4022.8994275143064;4246.532881383061;4250.298700714378;4270.807813648377;4278.828846846122;4211.599898009684;4225.788710564475;4226.830926762941;4241.512226094008;4242.787860606957;4237.453329534728;4258.87223383299;4265.87202383929;4294.227039132955;4324.2648749712625;3489.255372313843;3730.9440358394645;3734.1784807342615;3734.197147613249;3744.850205991757;5453.618246722731;5470.671759694431;5479.890402191973;5520.227168196456;5530.889382212374;4782.497837727024;4878.536539028786;4879.707217566922;4880.658353915227;4889.437714662824;5548.78048780487;5772.682502462363;5803.65178089316;5844.444777746107;5850.180974663551;4001.799910004517;4022.391043582561;4035.1122752994293;4037.212743515016;4041.333180025292;6130.662813545253;6131.662758548278;6135.110408990716;6141.385861413823;6172.290186628506;4054.1283624020975;4122.628963393309;4128.566500517462;4142.420061191436;4146.813393397304;4176.705221381381;4180.122174343361;4183.309753890635;4192.769397683157;4204.957950420518;4845.843599598145;4859.837372369262;4926.778294976734;4935.8025678972435;4947.554720075211;5713.200151978726;5924.156404925659;5935;5980.37206093354;6016.548758843104;1427.9214643194723;1435.7200345932442;1443.4226309476294;1445.0534899640752;1447.2835946206694;856.4133568505594;882.5454890731279;884.2307192742355;896.188949001155;896.9237614802685;5012.949870501321;5028.843366025834;5036.269740887624;5050.3182070420025;5070.366204224472;5397.3523177218985;5445.732560463769;5465.699386533779;5466.508014278734;5504.7155430495895;4946.826861059845;5009.373828271466;5032.924506132411;5241.6068794839775;5700.173474846124;3245.659205783406;3249.602670851509;3274.9683849587304;3296.7197788188273;3297.884574039897;6068.787592434243;6253.530985176039;6258.968705156445;6308.369163083655;6365.840853978595;6104.779044191179;6179.5056395489155;6188.752449902044;6204;6240.812775616739;6228.937710622927;6243.282022567372;6244.250689917239;6332.810015699536;6362.618242905441;5877.265341832271;6063.907407222437;6109.633421994695;6136.846578835565;6165.784197553064;6003.87992240144;6048.183495228088;6069.939300606938;6113.868934247179;6123.234595675541;6102.420270074336;6250;6298.889871892784;6318.6840657965995;6329.810105696836;4103.4870641169855;4104.261232977973;4115.958840411678;4143.606357396043;4144.44050053239;6066.542071019477;6072.453479186895;6101.816945491642;6109.694515274307;6114.38856114385;5791.971040144772;5938.229224442423;5944.375840536854;5959.67221802805;5989;5873.970630146822;5874;5900.409959004065;5924.851878703067;5927.547750801082;5555.527780138734;5718.971405142947;5797.681127538026;5828.6211396259105;5866.2960444746905;5919.911201331897;5952.732127054206;5969.910451343147;5991.981363168359;6012.969935150296;5800.88267782248;5811.360750317546;5812.193013576114;5814.854628634318;5855.795047173328 06:09:49 INFO - PROCESS | 30352 | |5;yui.html;733.1934871641193;738.4978214813927;744.2483092077;756.7654027251556;781.1407451803018;14609.269536523172;15002.174880381575;15442.69114617707;15494.922525387372;15940.84059159408;15037.699246015072;15053.924730376333;15178.31697573609;15206.847931520682;15215.543533693979;664.5481072870447;764.2548515197666;788.996055019724;805.5972013993004;805.7139715401037;798.022422532396;812.544974814106;813.5769399912072;817.5666896544811;820.1798201798201;850.642730053376;851.8466675998318;853.4793775796759;854.1927878155146;857.0914830279892;836.1387770596295;845.3533047218882;848.5078654380476;850.3579797253066;852.586495549661;614.9354317796611;615.4430240632234;616.7687117331001;618;620.3951147631069;15143;15300.540983770505;15334.539963801104;15355.462558810388;15370.692586148214;14822.258887055712;14970.62573435662;15271.847281527154;15322;15334.616634584225;12272.76581101091;12420.875791242153;12425.254484730945;12586.81119783204;12607.369631518388;3905.49228600283;3908.687305015592;3927.3716205407;4085.6935729820384;4100.569440208795;85938.5703071487;86265.56867215624;86527;86696;89990.99999999935;11563.826542601868;11716.70708232301;11731.76536469266;11883.346415947206;12273.140880138304;22564.097436102373;22840.771592284196;22913.541729165656;22918.541629167325;22997.540049198924;7852.842943141105;8013.519188848688;8114.026316842017;8292.792680183044;8627.61175747093;4424.867253982386;4517.141743068806;4537.296719008559;4541.6593755468475;4601.44782626087;3336.849841757078;3377.5102610121394;3404.7616666833082;3417.1969587147;3453.5855697316483;588.5732843688377;592.9792457264061;593.8426317025992;606.6269244414653;609.430182779103;662.4766434516678;704.7357241034612;714.1715609892603;717.150177040209;730.3459741904867;8812.735617931472;9293.90706092944;9458.763530911645;9756.560954757053;9810.950945245371;637.6875331087733;694.6179601219309;712.7469748239404;731.5647189921988;733.5158795195146;4659.2312268476;4792.233242681224;4825.469198388175;4826.420829500412;4852.175130227799;74526.6273668639;75408.62295688486;97292;113746.43126784313;117435.41282293534;105320;105982;105991.47004265084;107536;108259.45870270756;75815;91549;93011;93473;94910.52544737232;9831.85252221203;10036.247281454067;10173.643922462677;10301.690949271533;10324.690259292232;53040;54805.72597137148;55409.44590554043;55785;56297.71851140718;75137;79815;80591.59704201441;81853.59073204595;83586.5820670917;13115.540956066874;13265.469381224642;13302.866971330162;13837.169769813843;14007.579772606838;15046.94999650737;15313.157776322409;15425.614359641098;15532.534023979299;15683.843161568238;14167.858321416654;14171.362288696828;14185.503507377192;14390.953406868191;14451.421943122157;13205.725517767349;13293.800592991307;13628.386722597308;13917.973389761211;14103.153810771386;13296.933515332361;13453.687292135768;13489.527866524624;13659.317034148055;13816.93091534536;11268.887311126784;11617.26101228857;11654.242474239147;11673.824892626448;11711.648650540497;11830.231034982698;12041.819372709591;12052.457639406422;12124.939375303067;12164.2701437914 06:09:49 INFO - PROCESS | 30352 | __end_tp_report 06:09:49 INFO - PROCESS | 30352 | __start_cc_report 06:09:49 INFO - PROCESS | 30352 | _x_x_mozilla_cycle_collect,346 06:09:49 INFO - PROCESS | 30352 | __end_cc_report 06:09:49 INFO - PROCESS | 30352 | __startTimestamp1466600989232__endTimestamp 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | ------- Summary: start ------- 06:09:49 INFO - PROCESS | 30352 | Number of tests: 6 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | [#0] dojo.html Cycles:165 Average:5413.53 Median:5621.49 stddev:724.09 (12.9%) stddev-sans-first:703.28 06:09:49 INFO - PROCESS | 30352 | Values: 3104.0 3172.9 3183.6 3196.4 3199.4 5418.8 5456.5 5477.3 5525.6 5527.8 5314.0 5391.7 5432.4 5475.7 5527.4 4888.2 4924.2 5027.5 5046.6 5107.3 792.9 4951.6 4987.9 5018.8 5029.2 4923.5 4930.8 4947.3 4957.0 5003.2 4813.0 4947.5 4950.6 4971.2 5005.6 4897.7 4922.9 4950.8 4970.7 4992.0 5402.4 5488.6 5559.7 5566.2 5634.3 5862.2 5933.3 5943.1 5946.9 5961.6 5924.1 5955.5 6004.8 6009.6 6060.7 5590.9 5607.8 5608.3 5610.0 5616.2 5761.1 5876.7 5927.4 5928.5 6150.8 5745.7 5752.3 5760.0 5760.1 5763.3 5838.0 5846.1 5853.4 5856.8 5857.8 5621.5 5747.9 5848.2 5888.4 5904.1 5653.3 5741.8 5803.1 5861.3 5924.0 4448.1 4453.5 4462.4 4500.5 4512.5 3861.7 3928.6 3942.2 3985.8 3995.1 5500.2 5509.4 5532.7 5535.7 5552.7 5807.5 5908.4 5912.5 5919.3 5971.0 5344.5 5439.8 5502.0 5514.7 5521.4 5060.1 5061.9 5065.8 5078.7 5117.8 5874.6 6065.6 6080.5 6085.3 6086.6 5822.5 5896.8 5936.2 5983.8 6000.2 6117.0 6160.3 6179.8 6187.0 6192.0 5561.4 5653.1 5878.2 5881.3 5882.1 5832.5 5833.2 5853.2 5915.2 5926.5 5705.1 5746.8 5753.2 5761.4 5768.2 5551.8 5665.5 5710.4 5745.5 5763.8 5391.9 5455.3 5518.8 5525.5 5699.1 5625.5 5655.4 5698.9 5701.7 5705.3 5438.4 5596.9 5616.6 5623.7 5657.0 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | [#1] ext.html Cycles:180 Average:64922.53 Median:23187.63 stddev:135323.10 (583.6%) stddev-sans-first:135616.48 06:09:49 INFO - PROCESS | 30352 | Values: 575.3 611.7 619.8 636.9 640.7 42551.0 44368.6 44432.8 44691.0 47942.3 46585.5 47204.5 47226.5 47250.5 47273.0 9014.6 9066.3 9090.3 9100.1 9100.9 8895.0 8959.8 8960.8 8970.3 9029.7 8932.3 8974.2 8979.6 8985.6 9040.5 9051.8 9066.3 9068.6 9084.9 9100.1 8912.2 8914.2 8945.7 8989.1 9001.0 43206.4 43495.0 43634.8 43652.0 43710.8 3557.6 3671.1 3801.5 3953.9 4025.4 31827.5 32966.8 33945.3 33960.0 35292.5 4244.3 4282.8 4300.2 4325.3 4484.0 365520.0 365782.0 365923.0 367092.0 367314.0 60319.0 61080.7 61179.4 61187.7 61307.7 35559.6 36671.0 36801.2 38475.4 38627.8 16930.2 17059.0 17060.8 17066.1 17119.7 13713.4 13797.7 13807.4 13828.0 13838.7 19609.4 19642.3 19824.2 19941.0 20063.5 7353.4 7373.7 7448.4 7457.8 7550.5 968.5 1065.3 1082.2 1135.9 1164.2 32912.0 32983.5 33245.8 33393.2 33684.7 1038.7 1089.9 1107.0 1114.7 1154.7 16647.8 16987.8 17021.6 17240.6 17415.4 610950.0 613747.0 615050.0 620753.0 621752.0 60339.4 60536.4 60672.4 60831.7 61033.0 1329.5 1349.7 1361.6 1373.0 1394.0 30569.2 31811.2 31849.2 32072.4 32516.0 52028.5 52798.0 52867.7 52877.0 52925.5 501478.0 511553.0 511789.0 511834.0 512809.4 28871.6 29094.3 29191.1 29196.9 29237.7 48692.0 48788.8 49120.3 49134.8 49873.8 41046.8 42064.0 42131.0 42802.8 42912.8 41145.6 41179.8 41442.8 41943.2 42637.4 35266.3 39715.8 40043.6 40845.0 41181.8 34403.7 37412.9 37722.0 37798.6 37927.6 27227.7 27654.4 27774.6 28094.9 28269.0 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | [#2] jquery.html Cycles:180 Average:27777.80 Median:381.90 stddev:77418.20 (20271.9%) stddev-sans-first:77608.01 06:09:49 INFO - PROCESS | 30352 | Values: 362.2 380.7 380.9 382.9 397.0 17592.6 19606.3 19871.7 19956.2 20166.1 17787.3 18451.2 18477.7 19279.2 19306.2 5023.5 5183.4 5207.6 5217.0 5557.0 5588.7 5660.1 5689.2 5702.4 5706.0 5622.0 5628.7 5656.5 5664.3 5717.6 5545.1 5672.4 5686.4 5707.2 5714.8 4845.7 4946.8 4960.9 5037.0 5054.7 12134.5 12240.6 12309.8 12414.6 15560.9 2229.4 2255.7 2293.3 2514.7 2839.9 9335.3 9369.3 9407.2 9548.9 12243.2 1837.4 1961.7 1969.6 1969.9 1971.8 55987.4 72712.3 74363.0 76698.6 79886.6 9710.3 9798.6 10223.3 10242.9 10263.4 13645.7 13763.3 13783.2 13798.3 13802.9 7598.4 7808.4 7945.5 7983.6 8142.6 8060.0 8082.0 8155.6 8271.6 8382.5 4119.7 4197.8 4227.9 4296.1 4310.2 1710.0 1720.2 1731.6 1770.4 1799.4 955.9 957.1 968.2 981.2 1031.6 18937.3 19171.0 19176.5 19410.9 19502.8 972.9 1045.4 1045.6 1055.4 1084.9 10316.3 10846.4 10893.5 10973.6 11061.8 461991.0 467023.0 467803.0 469722.0 476920.0 59388.0 94255.5 99612.0 99923.5 100643.0 992.8 1019.4 1038.3 1044.7 1053.6 17628.9 17867.2 17981.7 18029.8 18540.9 40250.0 42107.6 42405.6 43072.1 43124.1 61596.0 62096.7 62867.7 63208.4 63621.0 8166.7 8403.0 8447.2 8492.7 8599.0 12265.3 12856.2 13018.9 13154.0 13678.5 11281.5 11316.4 11404.1 11526.6 11764.4 10019.7 10037.9 11253.7 11578.5 11982.5 11112.0 11112.4 11185.9 11614.4 11709.8 7992.4 8107.7 8203.5 8303.9 8332.3 8003.2 10155.7 10999.1 11380.1 11534.3 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | [#3] mootools.html Cycles:180 Average:5402.77 Median:4845.42 stddev:3024.97 (62.4%) stddev-sans-first:3018.86 06:09:49 INFO - PROCESS | 30352 | Values: 1449.3 1482.4 1584.7 1719.2 1721.4 7110.1 7856.9 7957.5 8472.3 8481.7 7973.5 8234.5 8261.8 8286.8 8300.0 2121.8 2158.2 2159.6 2164.2 2165.7 2070.6 2103.9 2105.0 2110.1 2114.7 2072.0 2075.2 2105.0 2109.5 2131.8 2145.3 2169.5 2175.9 2178.9 2179.5 2051.6 2094.8 2101.6 2112.7 2123.3 8284.2 8302.5 8327.2 8349.8 8351.8 4823.0 4930.3 4936.1 4961.1 4963.3 3112.5 3158.9 3248.3 3273.6 3300.8 1046.6 1096.2 1100.5 1116.2 1124.0 11024.4 11077.3 11137.1 11176.8 11193.3 4123.8 4158.8 4206.5 4211.9 4256.6 9456.7 9585.7 9595.8 9598.8 9634.7 4819.2 4823.2 4843.4 4847.4 4853.2 4012.4 4407.2 4484.1 4551.5 4564.0 3696.2 3731.1 3761.7 3819.4 3823.7 1178.4 1180.4 1183.7 1187.5 1192.5 988.0 1001.5 1006.7 1011.3 1014.4 5747.6 5906.7 5965.6 5966.5 6091.0 391.4 391.5 393.5 393.9 406.4 4028.3 4212.3 4383.7 4438.7 4453.9 9751.2 10238.9 10324.8 10325.7 10331.9 9929.9 10184.5 10192.5 10216.3 10221.7 7380.7 7409.9 7474.7 7477.3 7494.9 5697.7 5746.5 5820.1 5827.4 5915.4 8746.4 8854.4 8961.8 8963.5 9043.9 8501.3 8887.7 9002.3 9065.1 9115.8 7340.7 7412.6 7478.8 7479.7 7516.7 7997.6 8008.3 8029.5 8033.1 8044.2 6862.1 7193.0 7202.7 7248.0 7249.1 7088.8 7100.7 7108.3 7182.6 7281.1 6396.5 6402.8 6441.6 6456.4 6456.7 4915.2 5042.4 5086.7 5126.1 5177.9 5005.6 5086.3 5133.3 5136.8 5282.6 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | [#4] prototype.html Cycles:180 Average:4879.26 Median:5544.17 stddev:1486.77 (26.8%) stddev-sans-first:1450.44 06:09:49 INFO - PROCESS | 30352 | Values: 287.2 290.4 290.5 304.3 305.9 5471.2 5539.6 5699.9 5738.0 5754.5 5583.6 5634.0 5642.8 5676.8 5677.5 4192.2 4241.6 4301.5 4309.7 4343.5 4022.9 4246.5 4250.3 4270.8 4278.8 4211.6 4225.8 4226.8 4241.5 4242.8 4237.5 4258.9 4265.9 4294.2 4324.3 3489.3 3730.9 3734.2 3734.2 3744.9 5453.6 5470.7 5479.9 5520.2 5530.9 4782.5 4878.5 4879.7 4880.7 4889.4 5548.8 5772.7 5803.7 5844.4 5850.2 4001.8 4022.4 4035.1 4037.2 4041.3 6130.7 6131.7 6135.1 6141.4 6172.3 4054.1 4122.6 4128.6 4142.4 4146.8 4176.7 4180.1 4183.3 4192.8 4205.0 4845.8 4859.8 4926.8 4935.8 4947.6 5713.2 5924.2 5935.0 5980.4 6016.5 1427.9 1435.7 1443.4 1445.1 1447.3 856.4 882.5 884.2 896.2 896.9 5012.9 5028.8 5036.3 5050.3 5070.4 5397.4 5445.7 5465.7 5466.5 5504.7 4946.8 5009.4 5032.9 5241.6 5700.2 3245.7 3249.6 3275.0 3296.7 3297.9 6068.8 6253.5 6259.0 6308.4 6365.8 6104.8 6179.5 6188.8 6204.0 6240.8 6228.9 6243.3 6244.3 6332.8 6362.6 5877.3 6063.9 6109.6 6136.8 6165.8 6003.9 6048.2 6069.9 6113.9 6123.2 6102.4 6250.0 6298.9 6318.7 6329.8 4103.5 4104.3 4116.0 4143.6 4144.4 6066.5 6072.5 6101.8 6109.7 6114.4 5792.0 5938.2 5944.4 5959.7 5989.0 5874.0 5874.0 5900.4 5924.9 5927.5 5555.5 5719.0 5797.7 5828.6 5866.3 5919.9 5952.7 5969.9 5992.0 6013.0 5800.9 5811.4 5812.2 5814.9 5855.8 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - PROCESS | 30352 | [#5] yui.html Cycles:180 Average:21319.34 Median:4262.72 stddev:30364.77 (712.3%) stddev-sans-first:30410.61 06:09:49 INFO - PROCESS | 30352 | Values: 733.2 738.5 744.2 756.8 781.1 14609.3 15002.2 15442.7 15494.9 15940.8 15037.7 15053.9 15178.3 15206.8 15215.5 664.5 764.3 789.0 805.6 805.7 798.0 812.5 813.6 817.6 820.2 850.6 851.8 853.5 854.2 857.1 836.1 845.4 848.5 850.4 852.6 614.9 615.4 616.8 618.0 620.4 15143.0 15300.5 15334.5 15355.5 15370.7 14822.3 14970.6 15271.8 15322.0 15334.6 12272.8 12420.9 12425.3 12586.8 12607.4 3905.5 3908.7 3927.4 4085.7 4100.6 85938.6 86265.6 86527.0 86696.0 89991.0 11563.8 11716.7 11731.8 11883.3 12273.1 22564.1 22840.8 22913.5 22918.5 22997.5 7852.8 8013.5 8114.0 8292.8 8627.6 4424.9 4517.1 4537.3 4541.7 4601.4 3336.8 3377.5 3404.8 3417.2 3453.6 588.6 593.0 593.8 606.6 609.4 662.5 704.7 714.2 717.2 730.3 8812.7 9293.9 9458.8 9756.6 9811.0 637.7 694.6 712.7 731.6 733.5 4659.2 4792.2 4825.5 4826.4 4852.2 74526.6 75408.6 97292.0 113746.4 117435.4 105320.0 105982.0 105991.5 107536.0 108259.5 75815.0 91549.0 93011.0 93473.0 94910.5 9831.9 10036.2 10173.6 10301.7 10324.7 53040.0 54805.7 55409.4 55785.0 56297.7 75137.0 79815.0 80591.6 81853.6 83586.6 13115.5 13265.5 13302.9 13837.2 14007.6 15046.9 15313.2 15425.6 15532.5 15683.8 14167.9 14171.4 14185.5 14391.0 14451.4 13205.7 13293.8 13628.4 13918.0 14103.2 13296.9 13453.7 13489.5 13659.3 13816.9 11268.9 11617.3 11654.2 11673.8 11711.6 11830.2 12041.8 12052.5 12124.9 12164.3 06:09:49 INFO - PROCESS | 30352 | -------- Summary: end -------- 06:09:49 INFO - PROCESS | 30352 | 06:09:49 INFO - TEST-INFO | 30352: exit 0 06:09:50 INFO - TEST-OK | dromaeo_css | took 1111496ms 06:09:50 INFO - TEST-START | kraken 06:09:50 INFO - operating with platform_type : linux_ 06:09:50 INFO - Initialising browser for kraken test... 06:09:50 INFO - TEST-INFO | started process 30588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph8nTyU/profile http://localhost:53652/getInfo.html) 06:09:54 INFO - PROCESS | 30588 | __metrics Screen width/height:1600/1200 06:09:54 INFO - PROCESS | 30588 | colorDepth:24 06:09:54 INFO - PROCESS | 30588 | Browser inner width/height: 1024/697 06:09:54 INFO - PROCESS | 30588 | __metrics 06:09:55 ERROR - PROCESS | 30588 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 06:09:56 INFO - TEST-INFO | 30588: exit 0 06:09:56 INFO - Browser initialized. 06:09:56 INFO - Running cycle 1/1 for kraken test... 06:09:56 INFO - TEST-INFO | started process 30710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph8nTyU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:08 INFO - PROCESS | 30710 | RSS: Main: 184709120 06:10:08 INFO - PROCESS | 30710 | 06:10:10 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53652/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:11 INFO - PROCESS | 30710 | RSS: Main: 189919232 06:10:11 INFO - PROCESS | 30710 | 06:10:14 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53652/tests/kraken/driver.html?testName=audio-dft) 06:10:14 INFO - PROCESS | 30710 | RSS: Main: 189587456 06:10:14 INFO - PROCESS | 30710 | 06:10:17 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53652/tests/kraken/driver.html?testName=audio-fft) 06:10:18 INFO - PROCESS | 30710 | RSS: Main: 184811520 06:10:18 INFO - PROCESS | 30710 | 06:10:20 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53652/tests/kraken/driver.html?testName=audio-oscillator) 06:10:21 INFO - PROCESS | 30710 | RSS: Main: 185831424 06:10:21 INFO - PROCESS | 30710 | 06:10:23 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53652/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:24 INFO - PROCESS | 30710 | RSS: Main: 185921536 06:10:24 INFO - PROCESS | 30710 | 06:10:27 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53652/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:27 INFO - PROCESS | 30710 | RSS: Main: 186793984 06:10:27 INFO - PROCESS | 30710 | 06:10:31 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53652/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:32 INFO - PROCESS | 30710 | RSS: Main: 183472128 06:10:32 INFO - PROCESS | 30710 | 06:10:34 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53652/tests/kraken/driver.html?testName=json-parse-financial) 06:10:35 INFO - PROCESS | 30710 | RSS: Main: 184844288 06:10:35 INFO - PROCESS | 30710 | 06:10:37 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53652/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:37 INFO - PROCESS | 30710 | RSS: Main: 185368576 06:10:37 INFO - PROCESS | 30710 | 06:10:39 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:40 INFO - PROCESS | 30710 | RSS: Main: 185810944 06:10:40 INFO - PROCESS | 30710 | 06:10:42 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:42 INFO - PROCESS | 30710 | RSS: Main: 186228736 06:10:42 INFO - PROCESS | 30710 | 06:10:45 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:46 INFO - PROCESS | 30710 | RSS: Main: 187289600 06:10:46 INFO - PROCESS | 30710 | 06:10:48 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:49 INFO - PROCESS | 30710 | RSS: Main: 186523648 06:10:49 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | Cycle 1(1): loaded http://localhost:53652/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53652/tests/kraken/driver.html?testName=ai-astar) 06:10:51 INFO - PROCESS | 30710 | RSS: Main: 187265024 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | __start_tp_report 06:10:51 INFO - PROCESS | 30710 | _x_x_mozilla_page_load 06:10:51 INFO - PROCESS | 30710 | _x_x_mozilla_page_load_details 06:10:51 INFO - PROCESS | 30710 | |i|pagename|runs| 06:10:51 INFO - PROCESS | 30710 | |0;ai-astar;114;107;111;111;112;110;109;111;112;111 06:10:51 INFO - PROCESS | 30710 | |1;audio-beat-detection;167;127;152;182;131;160;153;129;177;127 06:10:51 INFO - PROCESS | 30710 | |2;audio-dft;163;161;165;161;165;176;164;162;163;161 06:10:51 INFO - PROCESS | 30710 | |3;audio-fft;75;75;76;165;75;74;75;74;170;76 06:10:51 INFO - PROCESS | 30710 | |4;audio-oscillator;85;84;142;84;84;86;134;85;85;157 06:10:51 INFO - PROCESS | 30710 | |5;imaging-gaussian-blur;118;118;118;117;118;117;117;117;118;118 06:10:51 INFO - PROCESS | 30710 | |6;imaging-darkroom;150;151;147;148;146;147;148;147;148;148 06:10:51 INFO - PROCESS | 30710 | |7;imaging-desaturate;97;96;95;96;96;96;96;96;95;96 06:10:51 INFO - PROCESS | 30710 | |8;json-parse-financial;56;55;56;54;56;55;54;56;55;57 06:10:51 INFO - PROCESS | 30710 | |9;json-stringify-tinderbox;61;61;60;61;62;62;61;61;61;62 06:10:51 INFO - PROCESS | 30710 | |10;stanford-crypto-aes;80;79;82;83;81;83;82;86;112;81 06:10:51 INFO - PROCESS | 30710 | |11;stanford-crypto-ccm;137;130;129;132;132;139;133;142;129;132 06:10:51 INFO - PROCESS | 30710 | |12;stanford-crypto-pbkdf2;164;167;164;164;163;160;172;162;164;168 06:10:51 INFO - PROCESS | 30710 | |13;stanford-crypto-sha256-iterative;65;68;66;64;63;68;67;63;65;66 06:10:51 INFO - PROCESS | 30710 | __end_tp_report 06:10:51 INFO - PROCESS | 30710 | __start_cc_report 06:10:51 INFO - PROCESS | 30710 | _x_x_mozilla_cycle_collect,892 06:10:51 INFO - PROCESS | 30710 | __end_cc_report 06:10:51 INFO - PROCESS | 30710 | __startTimestamp1466601051542__endTimestamp 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | ------- Summary: start ------- 06:10:51 INFO - PROCESS | 30710 | Number of tests: 14 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.87 (1.7%) stddev-sans-first:1.59 06:10:51 INFO - PROCESS | 30710 | Values: 114.0 107.0 111.0 111.0 112.0 110.0 109.0 111.0 112.0 111.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:156.50 stddev:21.11 (13.5%) stddev-sans-first:21.53 06:10:51 INFO - PROCESS | 30710 | Values: 167.0 127.0 152.0 182.0 131.0 160.0 153.0 129.0 177.0 127.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:4.46 (2.7%) stddev-sans-first:4.71 06:10:51 INFO - PROCESS | 30710 | Values: 163.0 161.0 165.0 161.0 165.0 176.0 164.0 162.0 163.0 161.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:39.02 (52.0%) stddev-sans-first:40.81 06:10:51 INFO - PROCESS | 30710 | Values: 75.0 75.0 76.0 165.0 75.0 74.0 75.0 74.0 170.0 76.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:84.50 stddev:29.33 (34.7%) stddev-sans-first:30.41 06:10:51 INFO - PROCESS | 30710 | Values: 85.0 84.0 142.0 84.0 84.0 86.0 134.0 85.0 85.0 157.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:10:51 INFO - PROCESS | 30710 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.49 (1.0%) stddev-sans-first:1.39 06:10:51 INFO - PROCESS | 30710 | Values: 150.0 151.0 147.0 148.0 146.0 147.0 148.0 147.0 148.0 148.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 06:10:51 INFO - PROCESS | 30710 | Values: 97.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:1.00 06:10:51 INFO - PROCESS | 30710 | Values: 56.0 55.0 56.0 54.0 56.0 55.0 54.0 56.0 55.0 57.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:10:51 INFO - PROCESS | 30710 | Values: 61.0 61.0 60.0 61.0 62.0 62.0 61.0 61.0 61.0 62.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:82.00 stddev:9.71 (11.8%) stddev-sans-first:10.14 06:10:51 INFO - PROCESS | 30710 | Values: 80.0 79.0 82.0 83.0 81.0 83.0 82.0 86.0 112.0 81.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:132.50 stddev:4.40 (3.3%) stddev-sans-first:4.48 06:10:51 INFO - PROCESS | 30710 | Values: 137.0 130.0 129.0 132.0 132.0 139.0 133.0 142.0 129.0 132.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:164.00 stddev:3.39 (2.1%) stddev-sans-first:3.59 06:10:51 INFO - PROCESS | 30710 | Values: 164.0 167.0 164.0 164.0 163.0 160.0 172.0 162.0 164.0 168.0 06:10:51 INFO - PROCESS | 30710 | 06:10:51 INFO - PROCESS | 30710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.84 (2.8%) stddev-sans-first:1.94 06:10:51 INFO - PROCESS | 30710 | Values: 65.0 68.0 66.0 64.0 63.0 68.0 67.0 63.0 65.0 66.0 06:10:51 INFO - PROCESS | 30710 | -------- Summary: end -------- 06:10:51 INFO - PROCESS | 30710 | 06:10:52 INFO - TEST-INFO | 30710: exit 0 06:10:52 INFO - TEST-OK | kraken | took 62538ms 06:10:52 INFO - SUITE-END | took 1174s 06:10:52 INFO - Completed test suite (00:19:34) 06:10:52 INFO - javascript benchmark 06:10:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7199.5894910917505, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.9844800776, 3172.936541269173, 3183.617965844099, 3196.3926853897756, 3199.4400979828524, 5418.810341638044, 5456.481634244746, 5477.342718873736, 5525.613207075507, 5527.806526771564, 5314.0, 5391.703456309901, 5432.429594892538, 5475.72621368932, 5527.419620939803, 4888.242322440027, 4924.162892308316, 5027.4972502749615, 5046.617141147718, 5107.28498010277, 792.8934354615706, 4951.5791157751455, 4987.875303117415, 5018.84943451697, 5029.220470827027, 4923.532264434873, 4930.80276788928, 4947.282644016615, 4956.975215123919, 5003.17447621142, 4812.951870481285, 4947.50524947506, 4950.579200767939, 4971.1549036663855, 5005.6496045276845, 4897.730624815634, 4922.852314430573, 4950.801967921278, 4970.701757894538, 4992.026554821811, 5402.432744561804, 5488.588355873326, 5559.722013899329, 5566.248556444909, 5634.295713035871, 5862.179294898718, 5933.3473317934995, 5943.078822782476, 5946.881062378771, 5961.642301461926, 5924.1113832924975, 5955.52355811534, 6004.759809607611, 6009.60937539063, 6060.666663333515, 5590.888182236373, 5607.80372686954, 5608.270924779753, 5610.0, 5616.157576363496, 5761.107028410603, 5876.706164691748, 5927.377625349276, 5928.525717942554, 6150.7847225346895, 5745.68398738065, 5752.28096487939, 5760.0207964646115, 5760.135979603093, 5763.250777398911, 5838.036723940587, 5846.064629659234, 5853.385394533512, 5856.765729370863, 5857.7949771757785, 5621.494065534122, 5747.885042299131, 5848.152017957457, 5888.440598143169, 5904.0553511437965, 5653.265075540236, 5741.799037033684, 5803.129530570448, 5861.325947516005, 5924.0, 4448.110377924428, 4453.46558412986, 4462.3752674625575, 4500.504944456107, 4512.52618475062, 3861.7296789224483, 3928.64642182205, 3942.1721438498234, 3985.7807820570147, 3995.081131339808, 5500.22996780451, 5509.3664228613425, 5532.6680399176175, 5535.667859928417, 5552.7223638817895, 5807.477327040502, 5908.379620139909, 5912.497437717842, 5919.260092488439, 5971.0, 5344.545713614309, 5439.836804895859, 5502.0, 5514.6691198528215, 5521.3926468088475, 5060.063888180698, 5061.924071138936, 5065.822696205615, 5078.746062696924, 5117.8464646060675, 5874.559408044328, 6065.60573562717, 6080.452759251689, 6085.330613632497, 6086.6348019119, 5822.505087067647, 5896.820635872757, 5936.228290322403, 5983.820485385445, 6000.159977603226, 6116.969415153074, 6160.291566469913, 6179.81460556184, 6187.0, 6191.9690401547705, 5561.360443549043, 5653.095504719226, 5878.2064421304285, 5881.264841894763, 5882.147088672033, 5832.533397328119, 5833.212516310244, 5853.151293062397, 5915.2310199675485, 5926.496247818811, 5705.144228365778, 5746.827595172152, 5753.165790960204, 5761.366249712444, 5768.221290125779, 5551.777928882961, 5665.461781130786, 5710.4004079572705, 5745.454181852718, 5763.827085187451, 5391.919121213106, 5455.290812194548, 5518.751656175402, 5525.530329921841, 5699.088145896637, 5625.549956003591, 5655.4344565543115, 5698.943010569841, 5701.7434215461235, 5705.343885453226, 5438.374586922555, 5596.888062238814, 5616.578756593353, 5623.662580245198, 5657.038303488499], "value": 5366.101263610496, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2895174459542, 611.7033238879145, 619.8357435279651, 636.9108324834524, 640.7372977079399, 42551.0, 44368.55631443684, 44432.77783611078, 44691.0, 47942.28086578704, 46585.534144658544, 47204.52795472044, 47226.52773472273, 47250.527494725044, 47273.0, 9014.594343254554, 9066.274698024143, 9090.318226133033, 9100.089991000914, 9100.8634870477, 8895.0, 8959.776005599879, 8960.820783584324, 8970.327225458084, 9029.729108126734, 8932.285417166611, 8974.19232269099, 8979.64081436745, 8985.640574377017, 9040.547972601376, 9051.818963620724, 9066.274698024175, 9068.591913363849, 9084.863727044067, 9100.089991000914, 8912.197902188835, 8914.197722205032, 8945.686900958435, 8989.146031127033, 9000.954995224982, 43206.35190472114, 43495.0, 43634.781826090984, 43652.0, 43710.781446092886, 3557.573091229069, 3671.1372827385544, 3801.467794508771, 3953.881383558498, 4025.3595666830583, 31827.522587161213, 32966.83516582425, 33945.32109357823, 33960.0, 35292.47061294083, 4244.257254980366, 4282.764447955361, 4300.204462174476, 4325.264705000158, 4484.035932274576, 365520.0, 365782.0, 365923.0, 367091.9999999973, 367314.0, 60319.0, 61080.694596527625, 61179.38820611737, 61187.694061530296, 61307.6934615333, 35559.64440355615, 36671.0, 36801.23990700708, 38475.42286865699, 38627.80686096552, 16930.238139283763, 17059.0, 17060.829391705924, 17066.061366624956, 17119.657606848043, 13713.382897769625, 13797.724045519033, 13807.378667959965, 13828.03203775746, 13838.723225535434, 19609.411717648494, 19642.312519061765, 19824.20703171886, 19941.0, 20063.498412539513, 7353.4484913631695, 7373.668184931584, 7448.4041276697735, 7457.776266712007, 7550.5469671819865, 968.5012218707371, 1065.3075500924306, 1082.226208261097, 1135.9091272698165, 1164.1908873332952, 32912.00898648542, 32983.50524742131, 33245.83377083147, 33393.165170870925, 33684.663153368645, 1038.6520515627349, 1089.8637670291214, 1106.983395249072, 1114.7268919114706, 1154.6824623228679, 16647.750283745754, 16987.830121698626, 17021.574460638334, 17240.568985775455, 17415.39046133379, 610950.0, 613747.0, 615050.0, 620753.0, 621752.0, 60339.39660603426, 60536.394636053956, 60672.39327606667, 60831.69584152051, 61033.0, 1329.5213723059692, 1349.743548725739, 1361.611940596925, 1373.0251521419905, 1393.9860601393857, 30569.23576910595, 31811.20471988126, 31849.203769905936, 32072.358552828347, 32516.0, 52028.47971520236, 52798.0, 52867.73566132145, 52876.97668721465, 52925.470745292056, 501478.0, 511553.0, 511789.0, 511834.0, 512809.43595281785, 28871.56692649654, 29094.27264318409, 29191.08089191064, 29196.854015729787, 29237.70762292435, 48692.0, 48788.75605621949, 49120.263196051375, 49134.75432622814, 49873.750631246614, 41046.79476602598, 42064.0, 42131.0, 42802.78598607112, 42912.78543607262, 41145.58854411417, 41179.7941010293, 41442.792786035876, 41943.161136776485, 42637.36043959405, 35266.29467410689, 39715.80142099271, 40043.599564005155, 40845.0, 41181.794091029355, 34403.65596344005, 37412.94228817441, 37722.0, 37798.62201377951, 37927.62072379241, 27227.72772272252, 27654.446911061263, 27774.5833812497, 28094.85952570224, 28269.0], "value": 20481.176830232263, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.18508356198555, 380.67071982734944, 380.92762375148726, 382.8717379677808, 397.01936217542675, 17592.648147037053, 19606.31377901774, 19871.701924471145, 19956.20175192994, 20166.092525836335, 17787.288508459646, 18451.169697363617, 18477.7228341575, 19279.22883084675, 19306.227750889946, 5023.4725353837775, 5183.403908550527, 5207.557357624606, 5217.034848553011, 5557.0, 5588.748506317205, 5660.122680984454, 5689.203511508392, 5702.372738998707, 5706.0, 5622.0, 5628.662280263176, 5656.519195868335, 5664.291963504562, 5717.628354156987, 5545.112781954888, 5672.404397538282, 5686.3744988051285, 5707.172459993299, 5714.799982000631, 4845.660803743739, 4946.752662366867, 4960.900781984376, 5037.017781532602, 5054.721990290533, 12134.453949572291, 12240.632781016584, 12309.753804923941, 12414.565490207799, 15560.92219538895, 2229.4092065602626, 2255.729312482513, 2293.312006398074, 2514.6982362116664, 2839.943201135966, 9335.299852511089, 9369.344145909788, 9407.153356197976, 9548.856767148498, 12243.20419172751, 1837.4120281509922, 1961.7351657526337, 1969.5765410436682, 1969.9212031518723, 1971.8422526198012, 55987.44012559863, 72712.27287727161, 74363.0, 76698.61650691766, 79886.6005669968, 9710.320277580642, 9798.559064842098, 10223.284370094021, 10242.948785256174, 10263.435511046964, 13645.658858528615, 13763.31183440824, 13783.173009619455, 13798.310084495735, 13802.861971380358, 7598.392128629696, 7808.375329973588, 7945.48354356965, 7983.600819958979, 8142.592870356459, 8059.959700201462, 8082.0, 8155.632996515171, 8271.627776750061, 8382.49705017701, 4119.711620186558, 4197.8320867164975, 4227.915441691149, 4296.097819457948, 4310.22415965123, 1710.042376269293, 1720.1743163281694, 1731.5757639378432, 1770.4334612924, 1799.361226764506, 955.8852937647388, 957.1385752822376, 968.2060710217554, 981.2346369831542, 1031.6389263757624, 18937.33719319817, 19171.0, 19176.52058698516, 19410.90058013572, 19502.804971950383, 972.9173020293213, 1045.4250162410644, 1045.6131231444263, 1055.4142450939648, 1084.8969347911936, 10316.329438586468, 10846.403447810446, 10893.509792059218, 10973.615923442641, 11061.778764424827, 461991.0, 467023.0, 467803.0, 469722.0, 476920.0, 59388.0, 94255.52872235594, 99612.0, 99923.50038249762, 100643.0, 992.7666998255404, 1019.3934608907688, 1038.2680210451613, 1044.6970378590124, 1053.6154303679255, 17628.91185544064, 17867.195976180843, 17981.73027404564, 18029.81970180334, 18540.907295463436, 40250.0, 42107.578924210364, 42405.57594424016, 43072.13855722931, 43124.137517248855, 61596.0, 62096.68951655213, 62867.6856615714, 63208.36791632025, 63621.0, 8166.673333066611, 8402.957985210034, 8447.197516235949, 8492.70275540353, 8598.957005214934, 12265.26408415498, 12856.228626282453, 13018.893394061612, 13154.0, 13678.521251756141, 11281.548738050715, 11316.37759923212, 11404.144689148514, 11526.596569120376, 11764.35296058725, 10019.660090017276, 10037.949810250902, 11253.66239012831, 11578.536858525902, 11982.520699171935, 11112.0, 11112.444377780917, 11185.944070279596, 11614.419279035845, 11709.76580468403, 7992.440529163136, 8107.716229931924, 8203.466774659866, 8303.875441868498, 8332.250097491255, 8003.239692229229, 10155.695329140137, 10999.065079468015, 11380.146489013523, 11534.307941523535], "value": 8826.609112299107, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.3043339197188, 1482.384810303724, 1584.7147513447583, 1719.191979769508, 1721.449136276392, 7110.0756901602845, 7856.882146767803, 7957.482763620361, 8472.279856212213, 8481.745547633573, 7973.521588704667, 8234.547099909503, 8261.793455163624, 8286.83426331473, 8300.045494768088, 2121.809037186653, 2158.201465457775, 2159.600473912323, 2164.1667957836266, 2165.72928383952, 2070.554830711397, 2103.92636257731, 2105.0422057963588, 2110.0715685098507, 2114.7145135406754, 2072.0, 2075.169932027186, 2105.0422057963665, 2109.504266497372, 2131.765505794361, 2145.313499680095, 2169.457635591102, 2175.8912054397215, 2178.869267843919, 2179.4660308224506, 2051.5896820635785, 2094.8219401350902, 2101.5796840631783, 2112.7359080114984, 2123.2568600989684, 8284.212999765012, 8302.501849888966, 8327.20891515305, 8349.791255218668, 8351.830743695888, 4823.0, 4930.260460930853, 4936.111499930011, 4961.08219979305, 4963.3299504566785, 3112.517559778238, 3158.873645054195, 3248.2691394436297, 3273.623533293654, 3300.7689461737687, 1046.5918291866178, 1096.2490693874643, 1100.5157730598512, 1116.1963386361888, 1123.9606613768478, 11024.44877756109, 11077.335359878352, 11137.05335046522, 11176.832347514794, 11193.328400296008, 4123.773192474383, 4158.771267580312, 4206.4531610891, 4211.873643790691, 4256.57434256578, 9456.669016584525, 9585.712428627152, 9595.760105997406, 9598.808023839483, 9634.662786802428, 4819.180739274261, 4823.204171311694, 4843.39457567804, 4847.442544107403, 4853.150698627726, 4012.4382586437923, 4407.162639098561, 4484.1255955088445, 4551.453825540956, 4564.041551274269, 3696.2053158571034, 3731.067233191702, 3761.7366784324836, 3819.350710379242, 3823.6941044716355, 1178.3636836108576, 1180.433391971841, 1183.7040739815047, 1187.4834447015403, 1192.451472322724, 988.0, 1001.5042553935848, 1006.7432804634772, 1011.2567263061644, 1014.401503113152, 5747.597668163272, 5906.734196961147, 5965.612235204698, 5966.463018328372, 6091.0, 391.4167889844169, 391.5399405698293, 393.54348955211816, 393.9074317535377, 406.3863566015338, 4028.274910516135, 4212.262854000538, 4383.671224658164, 4438.7114837535455, 4453.910921781546, 9751.17115045215, 10238.897611023795, 10324.845127323097, 10325.74185645365, 10331.948340258401, 9929.851052234222, 10184.490775461198, 10192.490375481197, 10216.335938163995, 10221.693349199535, 7380.74167404149, 7409.925900741031, 7474.663640136207, 7477.252274772588, 7494.850102998019, 5697.658140511582, 5746.482816546531, 5820.097884827858, 5827.446392592697, 5915.37888521699, 8746.38775285724, 8854.380193386658, 8961.775955601162, 8963.462192268486, 9043.864342035007, 8501.319894408309, 8887.73336799897, 9002.279817614706, 9065.093490650883, 9115.817683646157, 7340.70637174507, 7412.555246685216, 7478.775636730907, 7479.70081196746, 7516.699332026657, 7997.560134192675, 8008.319292859939, 8029.518228906284, 8033.116357200586, 8044.235797599219, 6862.142232220973, 7192.964035179791, 7202.71189152428, 7247.9637601811655, 7249.093863267091, 7088.822779430349, 7100.715971361295, 7108.253633368422, 7182.569045857265, 7281.089863767029, 6396.456301214449, 6402.775902843378, 6441.581297215666, 6456.354364563506, 6456.709448074942, 4915.21356582945, 5042.39491261051, 5086.669366491166, 5126.077306084941, 5177.922331165111, 5005.5745261653165, 5086.287919691172, 5133.281340612242, 5136.845894623168, 5282.577393808563], "value": 4273.454268059634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.17007847321247, 290.4409012650647, 290.4800407270985, 304.2697525937749, 305.8654192155453, 5471.206675032118, 5539.556835453164, 5699.943000569998, 5737.971310143449, 5754.539636829054, 5583.553315734742, 5633.971830140854, 5642.830715078544, 5676.829695109143, 5677.48902598766, 4192.182524407742, 4241.639460645849, 4301.505326887409, 4309.698321117523, 4343.522212556616, 4022.8994275143064, 4246.532881383061, 4250.298700714378, 4270.807813648377, 4278.828846846122, 4211.599898009684, 4225.788710564475, 4226.830926762941, 4241.512226094008, 4242.787860606957, 4237.453329534728, 4258.87223383299, 4265.87202383929, 4294.227039132955, 4324.2648749712625, 3489.255372313843, 3730.9440358394645, 3734.1784807342615, 3734.197147613249, 3744.850205991757, 5453.618246722731, 5470.671759694431, 5479.890402191973, 5520.227168196456, 5530.889382212374, 4782.497837727024, 4878.536539028786, 4879.707217566922, 4880.658353915227, 4889.437714662824, 5548.78048780487, 5772.682502462363, 5803.65178089316, 5844.444777746107, 5850.180974663551, 4001.799910004517, 4022.391043582561, 4035.1122752994293, 4037.212743515016, 4041.333180025292, 6130.662813545253, 6131.662758548278, 6135.110408990716, 6141.385861413823, 6172.290186628506, 4054.1283624020975, 4122.628963393309, 4128.566500517462, 4142.420061191436, 4146.813393397304, 4176.705221381381, 4180.122174343361, 4183.309753890635, 4192.769397683157, 4204.957950420518, 4845.843599598145, 4859.837372369262, 4926.778294976734, 4935.8025678972435, 4947.554720075211, 5713.200151978726, 5924.156404925659, 5935.0, 5980.37206093354, 6016.548758843104, 1427.9214643194723, 1435.7200345932442, 1443.4226309476294, 1445.0534899640752, 1447.2835946206694, 856.4133568505594, 882.5454890731279, 884.2307192742355, 896.188949001155, 896.9237614802685, 5012.949870501321, 5028.843366025834, 5036.269740887624, 5050.3182070420025, 5070.366204224472, 5397.3523177218985, 5445.732560463769, 5465.699386533779, 5466.508014278734, 5504.7155430495895, 4946.826861059845, 5009.373828271466, 5032.924506132411, 5241.6068794839775, 5700.173474846124, 3245.659205783406, 3249.602670851509, 3274.9683849587304, 3296.7197788188273, 3297.884574039897, 6068.787592434243, 6253.530985176039, 6258.968705156445, 6308.369163083655, 6365.840853978595, 6104.779044191179, 6179.5056395489155, 6188.752449902044, 6204.0, 6240.812775616739, 6228.937710622927, 6243.282022567372, 6244.250689917239, 6332.810015699536, 6362.618242905441, 5877.265341832271, 6063.907407222437, 6109.633421994695, 6136.846578835565, 6165.784197553064, 6003.87992240144, 6048.183495228088, 6069.939300606938, 6113.868934247179, 6123.234595675541, 6102.420270074336, 6250.0, 6298.889871892784, 6318.6840657965995, 6329.810105696836, 4103.4870641169855, 4104.261232977973, 4115.958840411678, 4143.606357396043, 4144.44050053239, 6066.542071019477, 6072.453479186895, 6101.816945491642, 6109.694515274307, 6114.38856114385, 5791.971040144772, 5938.229224442423, 5944.375840536854, 5959.67221802805, 5989.0, 5873.970630146822, 5874.0, 5900.409959004065, 5924.851878703067, 5927.547750801082, 5555.527780138734, 5718.971405142947, 5797.681127538026, 5828.6211396259105, 5866.2960444746905, 5919.911201331897, 5952.732127054206, 5969.910451343147, 5991.981363168359, 6012.969935150296, 5800.88267782248, 5811.360750317546, 5812.193013576114, 5814.854628634318, 5855.795047173328], "value": 4382.174543161798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.1934871641193, 738.4978214813927, 744.2483092077, 756.7654027251556, 781.1407451803018, 14609.269536523172, 15002.174880381575, 15442.69114617707, 15494.922525387372, 15940.84059159408, 15037.699246015072, 15053.924730376333, 15178.31697573609, 15206.847931520682, 15215.543533693979, 664.5481072870447, 764.2548515197666, 788.996055019724, 805.5972013993004, 805.7139715401037, 798.022422532396, 812.544974814106, 813.5769399912072, 817.5666896544811, 820.1798201798201, 850.642730053376, 851.8466675998318, 853.4793775796759, 854.1927878155146, 857.0914830279892, 836.1387770596295, 845.3533047218882, 848.5078654380476, 850.3579797253066, 852.586495549661, 614.9354317796611, 615.4430240632234, 616.7687117331001, 618.0, 620.3951147631069, 15143.0, 15300.540983770505, 15334.539963801104, 15355.462558810388, 15370.692586148214, 14822.258887055712, 14970.62573435662, 15271.847281527154, 15322.0, 15334.616634584225, 12272.76581101091, 12420.875791242153, 12425.254484730945, 12586.81119783204, 12607.369631518388, 3905.49228600283, 3908.687305015592, 3927.3716205407, 4085.6935729820384, 4100.569440208795, 85938.5703071487, 86265.56867215624, 86527.0, 86696.0, 89990.99999999935, 11563.826542601868, 11716.70708232301, 11731.76536469266, 11883.346415947206, 12273.140880138304, 22564.097436102373, 22840.771592284196, 22913.541729165656, 22918.541629167325, 22997.540049198924, 7852.842943141105, 8013.519188848688, 8114.026316842017, 8292.792680183044, 8627.61175747093, 4424.867253982386, 4517.141743068806, 4537.296719008559, 4541.6593755468475, 4601.44782626087, 3336.849841757078, 3377.5102610121394, 3404.7616666833082, 3417.1969587147, 3453.5855697316483, 588.5732843688377, 592.9792457264061, 593.8426317025992, 606.6269244414653, 609.430182779103, 662.4766434516678, 704.7357241034612, 714.1715609892603, 717.150177040209, 730.3459741904867, 8812.735617931472, 9293.90706092944, 9458.763530911645, 9756.560954757053, 9810.950945245371, 637.6875331087733, 694.6179601219309, 712.7469748239404, 731.5647189921988, 733.5158795195146, 4659.2312268476, 4792.233242681224, 4825.469198388175, 4826.420829500412, 4852.175130227799, 74526.6273668639, 75408.62295688486, 97292.0, 113746.43126784313, 117435.41282293534, 105320.0, 105982.0, 105991.47004265084, 107536.0, 108259.45870270756, 75815.0, 91549.0, 93011.0, 93473.0, 94910.52544737232, 9831.85252221203, 10036.247281454067, 10173.643922462677, 10301.690949271533, 10324.690259292232, 53040.0, 54805.72597137148, 55409.44590554043, 55785.0, 56297.71851140718, 75137.0, 79815.0, 80591.59704201441, 81853.59073204595, 83586.5820670917, 13115.540956066874, 13265.469381224642, 13302.866971330162, 13837.169769813843, 14007.579772606838, 15046.94999650737, 15313.157776322409, 15425.614359641098, 15532.534023979299, 15683.843161568238, 14167.858321416654, 14171.362288696828, 14185.503507377192, 14390.953406868191, 14451.421943122157, 13205.725517767349, 13293.800592991307, 13628.386722597308, 13917.973389761211, 14103.153810771386, 13296.933515332361, 13453.687292135768, 13489.527866524624, 13659.317034148055, 13816.93091534536, 11268.887311126784, 11617.26101228857, 11654.242474239147, 11673.824892626448, 11711.648650540497, 11830.231034982698, 12041.819372709591, 12052.457639406422, 12124.939375303067, 12164.2701437914], "value": 7665.195297259343, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 111.0, 111.0, 112.0, 110.0, 109.0, 111.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 127.0, 152.0, 182.0, 131.0, 160.0, 153.0, 129.0, 177.0, 127.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 165.0, 161.0, 165.0, 176.0, 164.0, 162.0, 163.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 165.0, 75.0, 74.0, 75.0, 74.0, 170.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 142.0, 84.0, 84.0, 86.0, 134.0, 85.0, 85.0, 157.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 147.0, 148.0, 146.0, 147.0, 148.0, 147.0, 148.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 54.0, 56.0, 55.0, 54.0, 56.0, 55.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 82.0, 83.0, 81.0, 83.0, 82.0, 86.0, 112.0, 81.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 129.0, 132.0, 132.0, 139.0, 133.0, 142.0, 129.0, 132.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 164.0, 164.0, 163.0, 160.0, 172.0, 162.0, 164.0, 168.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 66.0, 64.0, 63.0, 68.0, 67.0, 63.0, 65.0, 66.0], "value": 65.5, "unit": "score"}]}]} 06:10:52 INFO - Return code: 0 06:10:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:10:52 ERROR - # TBPL SUCCESS # 06:10:52 INFO - Running post-action listener: _resource_record_post_action 06:10:52 INFO - ##### 06:10:52 INFO - ##### Finished run-tests step (success) 06:10:52 INFO - ##### 06:10:52 INFO - Running post-run listener: _resource_record_post_run 06:10:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 403120128; Read time: 0; Write time: 233368 06:10:52 INFO - TinderboxPrint: CPU usage
13.5% 06:10:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:10:52 INFO - TinderboxPrint: I/O write bytes / time
403,120,128 / 233,368 06:10:52 INFO - TinderboxPrint: CPU idle
8,224.5 (86.5%) 06:10:52 INFO - TinderboxPrint: CPU user
1,226.9 (12.9%) 06:10:52 INFO - TinderboxPrint: Swap in / out
0 / 0 06:10:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 104603648; Read time: 0; Write time: 76824 06:10:52 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 293289984; Read time: 0; Write time: 155732 06:10:53 INFO - Running post-run listener: _upload_blobber_files 06:10:53 INFO - Blob upload gear active. 06:10:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:10:53 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:10:53 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:10:53 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:10:53 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:10:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:54 INFO - (blobuploader) - INFO - Done attempting. 06:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:10:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:58 INFO - (blobuploader) - INFO - Done attempting. 06:10:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:10:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:10:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:58 INFO - (blobuploader) - INFO - Done attempting. 06:10:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:58 INFO - Return code: 0 06:10:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97a2ef84a7bae20f82ebf2c6dfa74bf765097ecc65015d8e3a49e6a05c59f3fdfaa2437388ea467a743054ffaea069d47deabf8056bbafd6717db826de55c52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b718d464ca8cf4156eb64ad97661a2c0f1000b869eb76bd075a36db782c4752acdb09ae805b1aff1a4cbf4b11daa9b65355be045afdd122a79c222ad47ee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a829c4ce3807e955acde62f6ad9e601489041693f243eb7186852910b7fec3011682f17f0bd749a62fc76c04cd4051a4ba9672b2b94358f3216c7828f66b89a4"} 06:10:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:58 INFO - Contents: 06:10:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97a2ef84a7bae20f82ebf2c6dfa74bf765097ecc65015d8e3a49e6a05c59f3fdfaa2437388ea467a743054ffaea069d47deabf8056bbafd6717db826de55c52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b718d464ca8cf4156eb64ad97661a2c0f1000b869eb76bd075a36db782c4752acdb09ae805b1aff1a4cbf4b11daa9b65355be045afdd122a79c222ad47ee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a829c4ce3807e955acde62f6ad9e601489041693f243eb7186852910b7fec3011682f17f0bd749a62fc76c04cd4051a4ba9672b2b94358f3216c7828f66b89a4"} 06:10:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:58 INFO - Copying logs to upload dir... 06:10:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.118777 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-22 06:10:58.100113) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:10:58.103739) ========= 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=41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97a2ef84a7bae20f82ebf2c6dfa74bf765097ecc65015d8e3a49e6a05c59f3fdfaa2437388ea467a743054ffaea069d47deabf8056bbafd6717db826de55c52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b718d464ca8cf4156eb64ad97661a2c0f1000b869eb76bd075a36db782c4752acdb09ae805b1aff1a4cbf4b11daa9b65355be045afdd122a79c222ad47ee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a829c4ce3807e955acde62f6ad9e601489041693f243eb7186852910b7fec3011682f17f0bd749a62fc76c04cd4051a4ba9672b2b94358f3216c7828f66b89a4"} build_url:https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/e09GksRxTlSlAVSAtu6r0A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f97a2ef84a7bae20f82ebf2c6dfa74bf765097ecc65015d8e3a49e6a05c59f3fdfaa2437388ea467a743054ffaea069d47deabf8056bbafd6717db826de55c52", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/94b718d464ca8cf4156eb64ad97661a2c0f1000b869eb76bd075a36db782c4752acdb09ae805b1aff1a4cbf4b11daa9b65355be045afdd122a79c222ad47ee94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a829c4ce3807e955acde62f6ad9e601489041693f243eb7186852910b7fec3011682f17f0bd749a62fc76c04cd4051a4ba9672b2b94358f3216c7828f66b89a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 06:10:58.129402) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:10:58.129975) ========= 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=41a7e32711b8e08598a63237000001d6-1466599364.197400-2094830415 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 06:10:58.213543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:10:58.213861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 06:10:58.214142) ========= ========= Total master_lag: 0.89 =========