builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1465864285.8 results: success (0) buildid: 20160613161325 builduid: e25adca738654530824424961b57c90d revision: ea5833a015a141c08d9d63b768841af97287033f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:25.798776) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:25.799148) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:25.799659) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:25.860837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:25.861119) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 17:31:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-13 17:31:26 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165707 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.055526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.055810) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.071241 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.138859) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.139194) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea5833a015a141c08d9d63b768841af97287033f --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 ea5833a015a141c08d9d63b768841af97287033f --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=82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 17:31:26,158 truncating revision to first 12 chars 2016-06-13 17:31:26,158 Setting DEBUG logging. 2016-06-13 17:31:26,158 attempt 1/10 2016-06-13 17:31:26,158 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea5833a015a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 17:31:26,437 unpacking tar archive at: mozilla-central-ea5833a015a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609168 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.761221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.761500) ========= script_repo_revision: ea5833a015a141c08d9d63b768841af97287033f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.761873) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.762136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 17:31:26.772638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-13 17:31:26.772903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:31:26 INFO - MultiFileLogger online at 20160613 17:31:26 in /builds/slave/test 17:31:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:31:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:31:26 INFO - {'append_to_log': False, 17:31:26 INFO - 'base_work_dir': '/builds/slave/test', 17:31:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:31:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:31:26 INFO - 'branch': 'Firefox-Non-PGO', 17:31:26 INFO - 'buildbot_json_path': 'buildprops.json', 17:31:26 INFO - 'config_files': ('talos/linux_config.py',), 17:31:26 INFO - 'default_actions': ('clobber', 17:31:26 INFO - 'read-buildbot-config', 17:31:26 INFO - 'download-and-extract', 17:31:26 INFO - 'populate-webroot', 17:31:26 INFO - 'create-virtualenv', 17:31:26 INFO - 'install', 17:31:26 INFO - 'run-tests'), 17:31:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:31:26 INFO - 'download_minidump_stackwalk': True, 17:31:26 INFO - 'download_symbols': 'ondemand', 17:31:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:31:26 INFO - 'tooltool.py': '/tools/tooltool.py', 17:31:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:31:26 INFO - '/tools/misc-python/virtualenv.py')}, 17:31:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:31:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:31:26 INFO - 'installer_path': 'installer.exe', 17:31:26 INFO - 'log_level': 'info', 17:31:26 INFO - 'log_name': 'talos', 17:31:26 INFO - 'log_to_console': True, 17:31:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:31:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:31:26 INFO - 'opt_config_files': (), 17:31:26 INFO - 'pip_index': False, 17:31:26 INFO - 'sps_profile': False, 17:31:26 INFO - 'sps_profile_interval': 0, 17:31:26 INFO - 'suite': 'dromaeojs-e10s', 17:31:26 INFO - 'system_bits': '32', 17:31:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:31:26 INFO - 'title': 'talos-linux64-ix-066', 17:31:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:31:26 INFO - 'use_talos_json': True, 17:31:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:31:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:31:26 INFO - 'work_dir': 'build'} 17:31:26 INFO - ##### 17:31:26 INFO - ##### Running clobber step. 17:31:26 INFO - ##### 17:31:26 INFO - Running pre-action listener: _resource_record_pre_action 17:31:26 INFO - Running main action method: clobber 17:31:26 INFO - rmtree: /builds/slave/test/build 17:31:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:31:28 INFO - Running post-action listener: _resource_record_post_action 17:31:28 INFO - ##### 17:31:28 INFO - ##### Finished clobber step (success) 17:31:28 INFO - ##### 17:31:28 INFO - ##### 17:31:28 INFO - ##### Running read-buildbot-config step. 17:31:28 INFO - ##### 17:31:28 INFO - Running pre-action listener: _resource_record_pre_action 17:31:28 INFO - Running main action method: read_buildbot_config 17:31:28 INFO - Using buildbot properties: 17:31:28 INFO - { 17:31:28 INFO - "project": "", 17:31:28 INFO - "product": "firefox", 17:31:28 INFO - "script_repo_revision": "production", 17:31:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:31:28 INFO - "repository": "", 17:31:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:31:28 INFO - "buildid": "20160613161325", 17:31:28 INFO - "pgo_build": "False", 17:31:28 INFO - "basedir": "/builds/slave/test", 17:31:28 INFO - "buildnumber": 347, 17:31:28 INFO - "slavename": "talos-linux64-ix-066", 17:31:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:31:28 INFO - "platform": "ubuntu64_hw", 17:31:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:31:28 INFO - "branch": "mozilla-central", 17:31:28 INFO - "repo_path": "mozilla-central", 17:31:28 INFO - "revision": "ea5833a015a141c08d9d63b768841af97287033f", 17:31:28 INFO - "stage_platform": "linux64", 17:31:28 INFO - "builduid": "e25adca738654530824424961b57c90d", 17:31:28 INFO - "slavebuilddir": "test" 17:31:28 INFO - } 17:31:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:31:28 INFO - Running post-action listener: _resource_record_post_action 17:31:28 INFO - ##### 17:31:28 INFO - ##### Finished read-buildbot-config step (success) 17:31:28 INFO - ##### 17:31:28 INFO - ##### 17:31:28 INFO - ##### Running download-and-extract step. 17:31:28 INFO - ##### 17:31:28 INFO - Running pre-action listener: _resource_record_pre_action 17:31:28 INFO - Running main action method: download_and_extract 17:31:28 INFO - mkdir: /builds/slave/test/build/tests 17:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:28 INFO - https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:31:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:31:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:31:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:28 INFO - Downloaded 1361 bytes. 17:31:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:31:28 INFO - Using the following test package requirements: 17:31:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:31:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:31:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:31:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'jsshell-linux-x86_64.zip'], 17:31:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:31:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:31:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:31:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:31:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:31:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:31:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:31:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:28 INFO - https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:31:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:30 INFO - Downloaded 22651531 bytes. 17:31:30 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'] 17:31:30 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 17:31:31 INFO - Return code: 0 17:31:31 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 17:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:31 INFO - https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:31:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:31:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:37 INFO - Downloaded 22651531 bytes. 17:31:37 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'] 17:31:37 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 17:31:38 INFO - Return code: 0 17:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:38 INFO - https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:31:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:31:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:40 INFO - Downloaded 14405384 bytes. 17:31:40 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'] 17:31:40 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 17:31:40 INFO - Return code: 0 17:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:40 INFO - https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IPfWQNepT-CS0HMfalRmIA/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 17:31:41 INFO - Downloaded 55404702 bytes. 17:31:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:41 INFO - mkdir: /builds/slave/test/properties 17:31:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:31:41 INFO - Writing to file /builds/slave/test/properties/build_url 17:31:41 INFO - Contents: 17:31:41 INFO - build_url:https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:31:42 INFO - Running post-action listener: _resource_record_post_action 17:31:42 INFO - Running post-action listener: set_extra_try_arguments 17:31:42 INFO - ##### 17:31:42 INFO - ##### Finished download-and-extract step (success) 17:31:42 INFO - ##### 17:31:42 INFO - ##### 17:31:42 INFO - ##### Running populate-webroot step. 17:31:42 INFO - ##### 17:31:42 INFO - Running pre-action listener: _resource_record_pre_action 17:31:42 INFO - Running main action method: populate_webroot 17:31:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:31:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:31:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:31:42 INFO - '--tppagecycles', 17:31:42 INFO - '7'], 17:31:42 INFO - 'tests': ['tsvgm']}}, 17:31:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:31:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:31:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:31:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:31:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['damp', 'tps']}, 17:31:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'tests': ['damp', 'tps']}, 17:31:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['dromaeo_dom']}, 17:31:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:31:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['basic_compositor_video']}, 17:31:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:31:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['a11yr', 17:31:42 INFO - 'ts_paint', 17:31:42 INFO - 'tpaint', 17:31:42 INFO - 'sessionrestore', 17:31:42 INFO - 'sessionrestore_no_auto_restore', 17:31:42 INFO - 'tabpaint']}, 17:31:42 INFO - 'other-e10s': {'tests': ['a11yr', 17:31:42 INFO - 'ts_paint', 17:31:42 INFO - 'tpaint', 17:31:42 INFO - 'sessionrestore', 17:31:42 INFO - 'sessionrestore_no_auto_restore', 17:31:42 INFO - 'tabpaint']}, 17:31:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:31:42 INFO - 'ts_paint', 17:31:42 INFO - 'tpaint', 17:31:42 INFO - 'sessionrestore', 17:31:42 INFO - 'sessionrestore_no_auto_restore', 17:31:42 INFO - 'tabpaint']}, 17:31:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:31:42 INFO - 'ts_paint', 17:31:42 INFO - 'tpaint', 17:31:42 INFO - 'sessionrestore', 17:31:42 INFO - 'sessionrestore_no_auto_restore', 17:31:42 INFO - 'tabpaint']}, 17:31:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['a11yr', 17:31:42 INFO - 'ts_paint', 17:31:42 INFO - 'tpaint', 17:31:42 INFO - 'sessionrestore', 17:31:42 INFO - 'sessionrestore_no_auto_restore', 17:31:42 INFO - 'tabpaint']}, 17:31:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['a11yr', 17:31:42 INFO - 'ts_paint', 17:31:42 INFO - 'tpaint', 17:31:42 INFO - 'sessionrestore', 17:31:42 INFO - 'sessionrestore_no_auto_restore', 17:31:42 INFO - 'tabpaint']}, 17:31:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['tsvgx', 17:31:42 INFO - 'tsvgr_opacity', 17:31:42 INFO - 'tart', 17:31:42 INFO - 'tscrollx', 17:31:42 INFO - 'cart']}, 17:31:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:31:42 INFO - 'tsvgr_opacity', 17:31:42 INFO - 'tart', 17:31:42 INFO - 'tscrollx', 17:31:42 INFO - 'cart']}, 17:31:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'talos_options': ['--disable-e10s'], 17:31:42 INFO - 'tests': ['tp5o']}, 17:31:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'tests': ['tp5o']}, 17:31:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'talos_options': ['--disable-e10s', 17:31:42 INFO - '--xperf_path', 17:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:42 INFO - 'tests': ['tp5n']}, 17:31:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:42 INFO - 'talos_options': ['--xperf_path', 17:31:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:42 INFO - 'tests': ['tp5n']}}, 17:31:42 INFO - 'talos.zip': {'path': '', 17:31:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:31:42 INFO - Running post-action listener: _resource_record_post_action 17:31:42 INFO - ##### 17:31:42 INFO - ##### Finished populate-webroot step (success) 17:31:42 INFO - ##### 17:31:42 INFO - ##### 17:31:42 INFO - ##### Running create-virtualenv step. 17:31:42 INFO - ##### 17:31:42 INFO - Running pre-action listener: _resource_record_pre_action 17:31:42 INFO - Running main action method: create_virtualenv 17:31:42 INFO - Creating virtualenv /builds/slave/test/build/venv 17:31:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:31:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:31:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:31:43 INFO - Using real prefix '/usr' 17:31:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:31:44 INFO - Installing distribute.............................................................................................................................................................................................done. 17:31:46 INFO - Installing pip.................done. 17:31:46 INFO - Return code: 0 17:31:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:46 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:31:46 INFO - Using env: {'DISPLAY': ':0', 17:31:46 INFO - 'HOME': '/home/cltbld', 17:31:46 INFO - 'LANG': 'en_US.UTF-8', 17:31:46 INFO - 'LANGUAGE': 'en_US:en', 17:31:46 INFO - 'LOGNAME': 'cltbld', 17:31:46 INFO - 'MAIL': '/var/mail/cltbld', 17:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:46 INFO - 'MOZ_NO_REMOTE': '1', 17:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:46 INFO - 'NO_EM_RESTART': '1', 17:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:46 INFO - 'PWD': '/builds/slave/test', 17:31:46 INFO - 'SHELL': '/bin/bash', 17:31:46 INFO - 'SHLVL': '1', 17:31:46 INFO - 'TERM': 'linux', 17:31:46 INFO - 'TMOUT': '86400', 17:31:46 INFO - 'USER': 'cltbld', 17:31:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:46 INFO - '_': '/tools/buildbot/bin/python'} 17:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:31:46 INFO - Cleaning up... 17:31:46 INFO - Return code: 0 17:31:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:46 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:31:46 INFO - Using env: {'DISPLAY': ':0', 17:31:46 INFO - 'HOME': '/home/cltbld', 17:31:46 INFO - 'LANG': 'en_US.UTF-8', 17:31:46 INFO - 'LANGUAGE': 'en_US:en', 17:31:46 INFO - 'LOGNAME': 'cltbld', 17:31:46 INFO - 'MAIL': '/var/mail/cltbld', 17:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:46 INFO - 'MOZ_NO_REMOTE': '1', 17:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:46 INFO - 'NO_EM_RESTART': '1', 17:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:46 INFO - 'PWD': '/builds/slave/test', 17:31:46 INFO - 'SHELL': '/bin/bash', 17:31:46 INFO - 'SHLVL': '1', 17:31:46 INFO - 'TERM': 'linux', 17:31:46 INFO - 'TMOUT': '86400', 17:31:46 INFO - 'USER': 'cltbld', 17:31:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:46 INFO - '_': '/tools/buildbot/bin/python'} 17:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:46 INFO - Downloading/unpacking psutil>=3.1.1 17:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:48 INFO - Installing collected packages: psutil 17:31:48 INFO - Running setup.py install for psutil 17:31:49 INFO - building 'psutil._psutil_linux' extension 17:31:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:31:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:31:50 INFO - building 'psutil._psutil_posix' extension 17:31:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:31:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:31:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:51 INFO - Successfully installed psutil 17:31:51 INFO - Cleaning up... 17:31:51 INFO - Return code: 0 17:31:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:51 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:31:51 INFO - Using env: {'DISPLAY': ':0', 17:31:51 INFO - 'HOME': '/home/cltbld', 17:31:51 INFO - 'LANG': 'en_US.UTF-8', 17:31:51 INFO - 'LANGUAGE': 'en_US:en', 17:31:51 INFO - 'LOGNAME': 'cltbld', 17:31:51 INFO - 'MAIL': '/var/mail/cltbld', 17:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:51 INFO - 'MOZ_NO_REMOTE': '1', 17:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:51 INFO - 'NO_EM_RESTART': '1', 17:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:51 INFO - 'PWD': '/builds/slave/test', 17:31:51 INFO - 'SHELL': '/bin/bash', 17:31:51 INFO - 'SHLVL': '1', 17:31:51 INFO - 'TERM': 'linux', 17:31:51 INFO - 'TMOUT': '86400', 17:31:51 INFO - 'USER': 'cltbld', 17:31:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:51 INFO - '_': '/tools/buildbot/bin/python'} 17:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:31:53 INFO - Installing collected packages: mozsystemmonitor 17:31:53 INFO - Running setup.py install for mozsystemmonitor 17:31:53 INFO - Successfully installed mozsystemmonitor 17:31:53 INFO - Cleaning up... 17:31:53 INFO - Return code: 0 17:31:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:53 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:31:53 INFO - Using env: {'DISPLAY': ':0', 17:31:53 INFO - 'HOME': '/home/cltbld', 17:31:53 INFO - 'LANG': 'en_US.UTF-8', 17:31:53 INFO - 'LANGUAGE': 'en_US:en', 17:31:53 INFO - 'LOGNAME': 'cltbld', 17:31:53 INFO - 'MAIL': '/var/mail/cltbld', 17:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:53 INFO - 'MOZ_NO_REMOTE': '1', 17:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:53 INFO - 'NO_EM_RESTART': '1', 17:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:53 INFO - 'PWD': '/builds/slave/test', 17:31:53 INFO - 'SHELL': '/bin/bash', 17:31:53 INFO - 'SHLVL': '1', 17:31:53 INFO - 'TERM': 'linux', 17:31:53 INFO - 'TMOUT': '86400', 17:31:53 INFO - 'USER': 'cltbld', 17:31:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:53 INFO - '_': '/tools/buildbot/bin/python'} 17:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:53 INFO - Downloading/unpacking jsonschema==2.5.1 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:31:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:55 INFO - Downloading functools32-3.2.3-2.tar.gz 17:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:31:55 INFO - warning: no files found matching '*.txt' 17:31:55 INFO - no previously-included directories found matching 'build' 17:31:55 INFO - no previously-included directories found matching 'dist' 17:31:55 INFO - no previously-included directories found matching '.git*' 17:31:55 INFO - Installing collected packages: jsonschema, functools32 17:31:55 INFO - Running setup.py install for functools32 17:31:56 INFO - warning: no files found matching '*.txt' 17:31:56 INFO - no previously-included directories found matching 'build' 17:31:56 INFO - no previously-included directories found matching 'dist' 17:31:56 INFO - no previously-included directories found matching '.git*' 17:31:56 INFO - Successfully installed jsonschema functools32 17:31:56 INFO - Cleaning up... 17:31:56 INFO - Return code: 0 17:31:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:56 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:31:56 INFO - Using env: {'DISPLAY': ':0', 17:31:56 INFO - 'HOME': '/home/cltbld', 17:31:56 INFO - 'LANG': 'en_US.UTF-8', 17:31:56 INFO - 'LANGUAGE': 'en_US:en', 17:31:56 INFO - 'LOGNAME': 'cltbld', 17:31:56 INFO - 'MAIL': '/var/mail/cltbld', 17:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:56 INFO - 'MOZ_NO_REMOTE': '1', 17:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:56 INFO - 'NO_EM_RESTART': '1', 17:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:56 INFO - 'PWD': '/builds/slave/test', 17:31:56 INFO - 'SHELL': '/bin/bash', 17:31:56 INFO - 'SHLVL': '1', 17:31:56 INFO - 'TERM': 'linux', 17:31:56 INFO - 'TMOUT': '86400', 17:31:56 INFO - 'USER': 'cltbld', 17:31:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:56 INFO - '_': '/tools/buildbot/bin/python'} 17:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:56 INFO - Downloading/unpacking blobuploader==1.2.4 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:58 INFO - Downloading blobuploader-1.2.4.tar.gz 17:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:31:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:31:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31: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 17:31:58 INFO - Downloading docopt-0.6.1.tar.gz 17:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:31:59 INFO - Installing collected packages: blobuploader, requests, docopt 17:31:59 INFO - Running setup.py install for blobuploader 17:31:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:31:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:31:59 INFO - Running setup.py install for requests 17:31:59 INFO - Running setup.py install for docopt 17:31:59 INFO - Successfully installed blobuploader requests docopt 17:31:59 INFO - Cleaning up... 17:31:59 INFO - Return code: 0 17:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:59 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:31:59 INFO - Using env: {'DISPLAY': ':0', 17:31:59 INFO - 'HOME': '/home/cltbld', 17:31:59 INFO - 'LANG': 'en_US.UTF-8', 17:31:59 INFO - 'LANGUAGE': 'en_US:en', 17:31:59 INFO - 'LOGNAME': 'cltbld', 17:31:59 INFO - 'MAIL': '/var/mail/cltbld', 17:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:59 INFO - 'MOZ_NO_REMOTE': '1', 17:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:31:59 INFO - 'NO_EM_RESTART': '1', 17:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:59 INFO - 'PWD': '/builds/slave/test', 17:31:59 INFO - 'SHELL': '/bin/bash', 17:31:59 INFO - 'SHLVL': '1', 17:31:59 INFO - 'TERM': 'linux', 17:31:59 INFO - 'TMOUT': '86400', 17:31:59 INFO - 'USER': 'cltbld', 17:31:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:59 INFO - '_': '/tools/buildbot/bin/python'} 17:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:59 INFO - Running setup.py (path:/tmp/pip-GagB67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:59 INFO - Running setup.py (path:/tmp/pip-rmrtae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:59 INFO - Running setup.py (path:/tmp/pip-rSOAew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:00 INFO - Running setup.py (path:/tmp/pip-umCFQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:00 INFO - Running setup.py (path:/tmp/pip-0nNKLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:00 INFO - Running setup.py (path:/tmp/pip-bW0cvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:00 INFO - Running setup.py (path:/tmp/pip-wJWt23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:00 INFO - Running setup.py (path:/tmp/pip-WUwpCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:00 INFO - Running setup.py (path:/tmp/pip-IdS3j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:00 INFO - Running setup.py (path:/tmp/pip-dSp8iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:00 INFO - Running setup.py (path:/tmp/pip-coVBkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:00 INFO - Running setup.py (path:/tmp/pip-AxQOr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:00 INFO - Running setup.py (path:/tmp/pip-CrKBIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:00 INFO - Running setup.py (path:/tmp/pip-BB8Omu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:00 INFO - Running setup.py (path:/tmp/pip-QUjapz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:00 INFO - Running setup.py (path:/tmp/pip-ef49FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:00 INFO - Running setup.py (path:/tmp/pip-WbFgDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:32:01 INFO - Running setup.py install for manifestparser 17:32:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Running setup.py install for mozcrash 17:32:01 INFO - Running setup.py install for mozdebug 17:32:01 INFO - Running setup.py install for mozdevice 17:32:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Running setup.py install for mozfile 17:32:01 INFO - Running setup.py install for mozhttpd 17:32:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Running setup.py install for mozinfo 17:32:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Running setup.py install for mozInstall 17:32:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:32:01 INFO - Running setup.py install for mozleak 17:32:01 INFO - Running setup.py install for mozlog 17:32:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:32:02 INFO - Running setup.py install for moznetwork 17:32:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:32:02 INFO - Running setup.py install for mozprocess 17:32:02 INFO - Running setup.py install for mozprofile 17:32:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:32:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:32:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:32:02 INFO - Running setup.py install for mozrunner 17:32:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:32:02 INFO - Running setup.py install for mozscreenshot 17:32:02 INFO - Running setup.py install for moztest 17:32:02 INFO - Running setup.py install for mozversion 17:32:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:32:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:32:02 INFO - Cleaning up... 17:32:02 INFO - Return code: 0 17:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:02 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:32:02 INFO - Using env: {'DISPLAY': ':0', 17:32:02 INFO - 'HOME': '/home/cltbld', 17:32:02 INFO - 'LANG': 'en_US.UTF-8', 17:32:02 INFO - 'LANGUAGE': 'en_US:en', 17:32:02 INFO - 'LOGNAME': 'cltbld', 17:32:02 INFO - 'MAIL': '/var/mail/cltbld', 17:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:02 INFO - 'MOZ_NO_REMOTE': '1', 17:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:02 INFO - 'NO_EM_RESTART': '1', 17:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:02 INFO - 'PWD': '/builds/slave/test', 17:32:02 INFO - 'SHELL': '/bin/bash', 17:32:02 INFO - 'SHLVL': '1', 17:32:02 INFO - 'TERM': 'linux', 17:32:02 INFO - 'TMOUT': '86400', 17:32:02 INFO - 'USER': 'cltbld', 17:32:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:02 INFO - '_': '/tools/buildbot/bin/python'} 17:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:32:03 INFO - Running setup.py (path:/tmp/pip-gujQQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:32:03 INFO - Running setup.py (path:/tmp/pip-7iDW2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:32:03 INFO - Running setup.py (path:/tmp/pip-OnQI1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:32:03 INFO - Running setup.py (path:/tmp/pip-6bK5OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:32:03 INFO - Running setup.py (path:/tmp/pip-tVYtTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:32:03 INFO - Running setup.py (path:/tmp/pip-NTLK9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:32:03 INFO - Running setup.py (path:/tmp/pip-bvTXhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:32:03 INFO - Running setup.py (path:/tmp/pip-hh1oIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:32:03 INFO - Running setup.py (path:/tmp/pip-4qwYhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:32:03 INFO - Running setup.py (path:/tmp/pip-NPGVSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:32:03 INFO - Running setup.py (path:/tmp/pip-8omzSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:32:03 INFO - Running setup.py (path:/tmp/pip-My9ycv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:32:03 INFO - Running setup.py (path:/tmp/pip-3pu87n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:32:04 INFO - Running setup.py (path:/tmp/pip-w5Uef8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:04 INFO - Running setup.py (path:/tmp/pip-b4fJDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:32:04 INFO - Running setup.py (path:/tmp/pip-NPiP26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:32:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:32:04 INFO - Running setup.py (path:/tmp/pip-WzwDUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:32:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:32:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:06 INFO - Downloading blessings-1.6.tar.gz 17:32:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:32:06 INFO - Installing collected packages: blessings 17:32:06 INFO - Running setup.py install for blessings 17:32:06 INFO - Successfully installed blessings 17:32:06 INFO - Cleaning up... 17:32:06 INFO - Return code: 0 17:32:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:32:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:06 INFO - Reading from file tmpfile_stdout 17:32:06 INFO - Current package versions: 17:32:06 INFO - argparse == 1.2.1 17:32:06 INFO - blessings == 1.6 17:32:06 INFO - blobuploader == 1.2.4 17:32:06 INFO - docopt == 0.6.1 17:32:06 INFO - functools32 == 3.2.3-2 17:32:06 INFO - jsonschema == 2.5.1 17:32:06 INFO - manifestparser == 1.1 17:32:06 INFO - mozInstall == 1.12 17:32:06 INFO - mozcrash == 0.17 17:32:06 INFO - mozdebug == 0.1 17:32:06 INFO - mozdevice == 0.48 17:32:06 INFO - mozfile == 1.2 17:32:06 INFO - mozhttpd == 0.7 17:32:06 INFO - mozinfo == 0.9 17:32:06 INFO - mozleak == 0.1 17:32:06 INFO - mozlog == 3.2 17:32:06 INFO - moznetwork == 0.27 17:32:06 INFO - mozprocess == 0.22 17:32:06 INFO - mozprofile == 0.28 17:32:06 INFO - mozrunner == 6.11 17:32:06 INFO - mozscreenshot == 0.1 17:32:06 INFO - mozsystemmonitor == 0.3 17:32:06 INFO - moztest == 0.7 17:32:06 INFO - mozversion == 1.4 17:32:06 INFO - psutil == 3.1.1 17:32:06 INFO - requests == 1.2.3 17:32:06 INFO - wsgiref == 0.1.2 17:32:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:06 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:32:06 INFO - Using env: {'DISPLAY': ':0', 17:32:06 INFO - 'HOME': '/home/cltbld', 17:32:06 INFO - 'LANG': 'en_US.UTF-8', 17:32:06 INFO - 'LANGUAGE': 'en_US:en', 17:32:06 INFO - 'LOGNAME': 'cltbld', 17:32:06 INFO - 'MAIL': '/var/mail/cltbld', 17:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:06 INFO - 'MOZ_NO_REMOTE': '1', 17:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:06 INFO - 'NO_EM_RESTART': '1', 17:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:06 INFO - 'PWD': '/builds/slave/test', 17:32:06 INFO - 'SHELL': '/bin/bash', 17:32:06 INFO - 'SHLVL': '1', 17:32:06 INFO - 'TERM': 'linux', 17:32:06 INFO - 'TMOUT': '86400', 17:32:06 INFO - 'USER': 'cltbld', 17:32:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:06 INFO - '_': '/tools/buildbot/bin/python'} 17:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:32:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:32:06 INFO - Cleaning up... 17:32:06 INFO - Return code: 0 17:32:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:32:06 INFO - Using env: {'DISPLAY': ':0', 17:32:06 INFO - 'HOME': '/home/cltbld', 17:32:06 INFO - 'LANG': 'en_US.UTF-8', 17:32:06 INFO - 'LANGUAGE': 'en_US:en', 17:32:06 INFO - 'LOGNAME': 'cltbld', 17:32:06 INFO - 'MAIL': '/var/mail/cltbld', 17:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:06 INFO - 'MOZ_NO_REMOTE': '1', 17:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:06 INFO - 'NO_EM_RESTART': '1', 17:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:06 INFO - 'PWD': '/builds/slave/test', 17:32:06 INFO - 'SHELL': '/bin/bash', 17:32:06 INFO - 'SHLVL': '1', 17:32:06 INFO - 'TERM': 'linux', 17:32:06 INFO - 'TMOUT': '86400', 17:32:06 INFO - 'USER': 'cltbld', 17:32:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:06 INFO - '_': '/tools/buildbot/bin/python'} 17:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:32:07 INFO - Cleaning up... 17:32:07 INFO - Return code: 0 17:32:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:32:07 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 0x7fe6c53a3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c8350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:32:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:32:07 INFO - Using env: {'DISPLAY': ':0', 17:32:07 INFO - 'HOME': '/home/cltbld', 17:32:07 INFO - 'LANG': 'en_US.UTF-8', 17:32:07 INFO - 'LANGUAGE': 'en_US:en', 17:32:07 INFO - 'LOGNAME': 'cltbld', 17:32:07 INFO - 'MAIL': '/var/mail/cltbld', 17:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:07 INFO - 'MOZ_NO_REMOTE': '1', 17:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:07 INFO - 'NO_EM_RESTART': '1', 17:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:07 INFO - 'PWD': '/builds/slave/test', 17:32:07 INFO - 'SHELL': '/bin/bash', 17:32:07 INFO - 'SHLVL': '1', 17:32:07 INFO - 'TERM': 'linux', 17:32:07 INFO - 'TMOUT': '86400', 17:32:07 INFO - 'USER': 'cltbld', 17:32:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:07 INFO - '_': '/tools/buildbot/bin/python'} 17:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:32:07 INFO - Downloading/unpacking flake8 17:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:32:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:32:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:32:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:32:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:09 INFO - no previously-included directories found matching 'docs/_build' 17:32:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:32:09 INFO - Running setup.py install for pep8 17:32:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:32:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:32:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:32:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:32:10 INFO - no previously-included directories found matching 'docs/_build' 17:32:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:32:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:32:10 INFO - Cleaning up... 17:32:10 INFO - Return code: 0 17:32:10 INFO - Running post-action listener: _resource_record_post_action 17:32:10 INFO - Running post-action listener: _start_resource_monitoring 17:32:10 INFO - Starting resource monitoring. 17:32:10 INFO - ##### 17:32:10 INFO - ##### Finished create-virtualenv step (success) 17:32:10 INFO - ##### 17:32:10 INFO - ##### 17:32:10 INFO - ##### Running install step. 17:32:10 INFO - ##### 17:32:10 INFO - Running pre-action listener: _resource_record_pre_action 17:32:10 INFO - Running main action method: install 17:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:32:10 INFO - Reading from file tmpfile_stdout 17:32:10 INFO - Detecting whether we're running mozinstall >=1.0... 17:32:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:32:10 INFO - Reading from file tmpfile_stdout 17:32:10 INFO - Output received: 17:32:10 INFO - Usage: mozinstall [options] installer 17:32:10 INFO - Options: 17:32:10 INFO - -h, --help show this help message and exit 17:32:10 INFO - -d DEST, --destination=DEST 17:32:10 INFO - Directory to install application into. [default: 17:32:10 INFO - "/builds/slave/test"] 17:32:10 INFO - --app=APP Application being installed. [default: firefox] 17:32:10 INFO - mkdir: /builds/slave/test/build/application 17:32:10 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'] 17:32:10 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 17:32:26 INFO - Reading from file tmpfile_stdout 17:32:26 INFO - Output received: 17:32:26 INFO - /builds/slave/test/build/application/firefox/firefox 17:32:26 INFO - Running post-action listener: _resource_record_post_action 17:32:26 INFO - ##### 17:32:26 INFO - ##### Finished install step (success) 17:32:26 INFO - ##### 17:32:26 INFO - ##### 17:32:26 INFO - ##### Running run-tests step. 17:32:26 INFO - ##### 17:32:26 INFO - Running pre-action listener: _resource_record_pre_action 17:32:26 INFO - Running main action method: run_tests 17:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:32:26 INFO - Python 2.7.3 17:32:26 INFO - Return code: 0 17:32:26 INFO - grabbing minidump binary from tooltool 17:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:32:26 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 0x1a571c0>, '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 0x1a580c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a58550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:32:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:32:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:32:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:32:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:32:26 INFO - Return code: 0 17:32:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:32:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:32:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:32:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:32:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:32:27 INFO - Return code: 0 17:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 17:32:27 INFO - Using env: {'DISPLAY': ':0', 17:32:27 INFO - 'HOME': '/home/cltbld', 17:32:27 INFO - 'LANG': 'en_US.UTF-8', 17:32:27 INFO - 'LANGUAGE': 'en_US:en', 17:32:27 INFO - 'LOGNAME': 'cltbld', 17:32:27 INFO - 'MAIL': '/var/mail/cltbld', 17:32:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:32:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:32:27 INFO - 'MOZ_NO_REMOTE': '1', 17:32:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:32:27 INFO - 'NO_EM_RESTART': '1', 17:32:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:32:27 INFO - 'PWD': '/builds/slave/test', 17:32:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:32:27 INFO - 'SHELL': '/bin/bash', 17:32:27 INFO - 'SHLVL': '1', 17:32:27 INFO - 'TERM': 'linux', 17:32:27 INFO - 'TMOUT': '86400', 17:32:27 INFO - 'USER': 'cltbld', 17:32:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000', 17:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:32:27 INFO - '_': '/tools/buildbot/bin/python'} 17:32:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 17:32:27 INFO - mozversion application_buildid: 20160613161325 17:32:27 INFO - mozversion application_changeset: ea5833a015a141c08d9d63b768841af97287033f 17:32:27 INFO - mozversion application_display_name: Nightly 17:32:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:32:27 INFO - mozversion application_name: Firefox 17:32:27 INFO - mozversion application_remotingname: firefox 17:32:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:32:27 INFO - mozversion application_vendor: Mozilla 17:32:27 INFO - mozversion application_version: 50.0a1 17:32:27 INFO - mozversion platform_buildid: 20160613161325 17:32:27 INFO - mozversion platform_changeset: ea5833a015a141c08d9d63b768841af97287033f 17:32:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:32:27 INFO - mozversion platform_version: 50.0a1 17:32:27 INFO - using testdate: 1465864347 17:32:27 INFO - actual date: 1465864347 17:32:27 INFO - starting webserver on 'localhost:47544' 17:32:27 INFO - SUITE-START | Running 2 tests 17:32:27 INFO - TEST-START | dromaeo_css 17:32:27 INFO - operating with platform_type : linux_ 17:32:27 INFO - Initialising browser for dromaeo_css test... 17:32:27 INFO - TEST-INFO | started process 3315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXs84fH/profile http://localhost:47544/getInfo.html) 17:32:36 INFO - PROCESS | 3315 | __metrics Screen width/height:1600/1200 17:32:36 INFO - PROCESS | 3315 | colorDepth:24 17:32:36 INFO - PROCESS | 3315 | Browser inner width/height: 1024/697 17:32:36 INFO - PROCESS | 3315 | __metrics 17:32:37 ERROR - PROCESS | 3315 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:32:38 INFO - TEST-INFO | 3315: exit 0 17:32:38 INFO - Browser initialized. 17:32:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:32:38 INFO - TEST-INFO | started process 3434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXs84fH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:50 INFO - PROCESS | 3434 | RSS: Main: 185704448 17:32:50 INFO - PROCESS | 3434 | 17:33:40 INFO - PROCESS | 3434 | 1465864420008 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:35:52 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:47544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47544/tests/dromaeo/cssquery-ext.html) 17:35:53 INFO - PROCESS | 3434 | RSS: Main: 189259776 17:35:53 INFO - PROCESS | 3434 | 17:38:55 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:47544/tests/dromaeo/cssquery-ext.html (next: http://localhost:47544/tests/dromaeo/cssquery-jquery.html) 17:38:56 INFO - PROCESS | 3434 | RSS: Main: 188035072 17:38:56 INFO - PROCESS | 3434 | 17:41:58 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:47544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47544/tests/dromaeo/cssquery-mootools.html) 17:41:58 INFO - PROCESS | 3434 | RSS: Main: 189038592 17:41:58 INFO - PROCESS | 3434 | 17:45:00 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:47544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47544/tests/dromaeo/cssquery-prototype.html) 17:45:01 INFO - PROCESS | 3434 | RSS: Main: 186667008 17:45:01 INFO - PROCESS | 3434 | 17:48:04 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:47544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47544/tests/dromaeo/cssquery-yui.html) 17:48:04 INFO - PROCESS | 3434 | RSS: Main: 188755968 17:48:04 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | Cycle 1(1): loaded http://localhost:47544/tests/dromaeo/cssquery-yui.html (next: http://localhost:47544/tests/dromaeo/cssquery-dojo.html) 17:51:07 INFO - PROCESS | 3434 | RSS: Main: 189829120 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | __start_tp_report 17:51:07 INFO - PROCESS | 3434 | _x_x_mozilla_page_load 17:51:07 INFO - PROCESS | 3434 | _x_x_mozilla_page_load_details 17:51:07 INFO - PROCESS | 3434 | |i|pagename|runs| 17:51:07 INFO - PROCESS | 3434 | |0;dojo.html;2639.907603233887;2679.6784385873693;2707.837529748214;2712.56598944169;2728.0588197072;4771.4035745531855;4804.2073057945445;4810.5189481051875;4866.1240976624285;4925.556699897009;4756.215224487955;4791.904161916759;4819.542143496371;4853.611711063115;4913.33669954556;4425.645948324134;4450.132224216279;4574.290984897346;4575.084983003396;4586.1974154522995;600.9141504536263;4474.395956545857;4483.14820184164;4520.593146616804;4614.538546145375;4543.363929049952;4555.954440455586;4557.954420455786;4559.931601025987;4600.953990460086;4355.368471571636;4577.9771101144615;4582.633389328846;4584.472785629662;4627.23650597651;4335.826566937319;4368.126374725036;4391.055922976543;4441.267190913495;4520.68355215135;4745.335653008581;4760.500147484534;4805.567498925114;4829.10661527615;4850.199717046683;5184.533391994739;5188.195829646411;5189.506996835295;5242.5281724644965;5243.161094224905;5297.549708274802;5297.894042119136;5302.92045619316;5336.546393556552;5347.6256662033675;4932.334134891779;4959.628027897922;4966.602671786249;4968.6025117990475;4968.652194346361;5151.9484805152215;5323.30796996388;5334.253204551366;5350.277712508761;5429.918551221735;5132.56373208274;5134.12719837621;5135.589152867761;5154.690718556899;5182.792688292501;5234.581233501311;5245.659032162974;5248.029114613809;5249.763760630704;5300.045991721528;5033.697978121324;5142.768575414116;5160.329157209614;5170.250313704491;5179.04187725272;4958.132326842788;5096.668716533488;5149.9742501288;5218.530332270114;5253.789848406097;4377.737335759864;4386.758728269912;4398.824047038147;4404.493483249404;4425;3740.682042026458;3790.7346485745734;3808.2383523295453;3844.308024555607;3864.265789499986;4535.751608413759;4577.198990176706;4595.583683697097;4601.033782905561;4609.078184363141;5105.846824595268;5279.049771041173;5321.414644389114;5326.493983071679;5355.946440535545;4528.88677783058;4565.5206203348835;4573.725576465423;4575.22221222393;4582.725036497821;4646.651501137429;4677.64917631179;4692.064538358979;4709.458412282563;4745.928811067837;4778.665493415428;4908.650121216694;4911.68074075184;4921.827736029221;4953.083679519301;5313.043652142652;5316.149416093406;5334.1732031535175;5343.839684809462;5381.757820898148;4969.254611808257;4986.925196121989;4987.975060124676;4993.076280888047;5060;5002.099622068063;5128.051310507568;5142.460041695717;5228.63399562027;5231.058409486329;5296.894062118813;5299.284596579412;5302.416734159317;5302.655327403706;5354.812581559627;5142.537171654569;5152.07295111815;5155.664881782672;5167.844964651066;5218.269442278008;4933.4819843915875;5087.542121209109;5129.48705129499;5142.125838607521;5143.871403214949;4892.339534162842;4928.581070608895;4945.480724524017;4963.478834722302;5007.198848184273;5120.667156634807;5123.308353372247;5128.410232823124;5132.8460146195675;5194.68831870089;4888.071266459361;5009.023240468074;5019.322391477104;5049.697018178921;5101.7194054327365 17:51:07 INFO - PROCESS | 3434 | |1;ext.html;535.7671435619142;594.6759016336097;600.6876424259385;606.1271768653139;617.4443001298828;33931.83034084829;39062.60937390625;39077.21845563087;39088;39096.609033909655;39750.40374394386;40181;40219;40315.59684403155;40318;7814.570198639087;7938.5236885787035;7952.324052455549;7968.28285454309;7976.641051152683;7739.57432341221;7846.529208247495;7863.8427231455335;7882.408819338544;7885.014373203349;7843.019622547182;7876.921230787705;7881.014873140857;7882.921170788305;7887.487313324616;7745.109312429058;7793.298603125746;7800.921990780076;7815.843683126305;7830.765077047669;7724.961375193145;7742.961285193594;7765.417593680497;7775.22247775218;7809.414293927978;29676.554851677243;37362.43956340657;37546.43680344797;37598.43602345967;37703;2883.3656595548946;3132.1699749566383;3148.0870547541185;3176.904692859218;3324.484704870749;28287.717122828715;28833.423331533253;30417;31248.68751312503;31590.368192636248;3505.298940211968;3589.94615080774;3594.856205751767;3625.4018087015875;3762.3792074307707;231926;236727.99999999828;237328;237697;237936;28726.281842953675;55975;56021;56543;56799;34873;35085.82457087749;35262.47106293408;35266.47100293497;35338.82330588331;13083.542076027294;13198.20810751358;13212.141210821266;13217.801732974012;13264.668383290495;10940.56237750481;10974.561017559208;11033.779324413466;11034.944825275983;11063.114950803916;8005.359571234288;8006.15935326794;8065.879011814827;8146.0632027317615;8166.142555031755;3231.1922019495128;3231.773775835669;3237.7571682123935;3258.169166862435;3263.7062664360324;867.6572753762229;876.3471213945651;882.3558802074522;944.187998321443;968.7578105473632;28839.423211535654;28860.567091493645;28885.56671649927;29123.417531649673;29125.85437072801;889.6308032166708;969.2149359019216;977.4086677559974;1002.5739060899089;1035.6064695415694;14691.191984440744;14764.26178691061;14787.408503659948;14811.481598144013;14825.62935926589;381387;381859;385174;386099;386320;49812;50505.242421363706;50563.74718126386;50755.477335679985;50757.492425075274;1197.404475754275;1213.1629175868622;1223.932683702387;1228.6252692928742;1233.4696080685212;25962;27334.863325683244;27659.320194003034;27981.720182798726;28021.57967630528;40901.38647920224;41117.383239252034;41671.58328416798;41815.1636967265;41914.58085419107;358999;361198;361997;362136;364500;25415.6187657189;25515;25944.740552594987;25961.350966225997;26014.739852601233;43505;43515;43786;43883;44375.33436998383;36878;37255.627443725214;37358.6264137366;37550.81224593859;37696.62303376931;36813;36953.63046369609;37069;37106.8144659275;37627;30138.54792178075;35577.28845423129;35750.46374304336;35798;36445.27109457849;32050.19874503063;33121.83439082789;33367.322456813585;33547;33636;25514.489710206064;25521.937367515275;25709;25843.224703258933;25864.8706756465 17:51:07 INFO - PROCESS | 3434 | |2;jquery.html;372.4227447456442;375.8064596732683;376.50865620365414;380.9599992000838;391.55753997982276;15444.613884652876;16008;16905.91547042266;16974.745378819298;16981.06604136772;15709.21453927302;16303.266353014113;16915.83084169158;17055.91472042641;17079.060651664186;5066.113430149719;5244.580433565325;5267.789288428458;5282.366116066078;5290.391604965421;5177.534021938025;5256.632035757499;5292.153255479124;5293.602979776513;5294.364676238857;5047.192449208127;5177.223416487519;5187.429382767892;5266.499682530172;5277.5514081302945;5176.352955880515;5199.506046925555;5218.217267409881;5221.530062294392;5245.160774276097;4673.3690951721765;4693.296005599153;4699.906001879977;4708.552687494683;4720.457147428056;19586.80413195864;20017;20773.792262077335;20889.791102088937;21003.78996210049;1967.3802752133033;1979.8416126709828;1982.1575830272077;2109.831213502916;2546.3379521324405;12865;12890.677733056655;12920.806187907188;13097.86902130976;13408.26254555999;1793.4888556761261;1820.8088150744113;1821.4990877508658;1824.899630520321;1862.7950925398195;47038.76480617609;62989.37010629881;66424.3357566423;67084.66457667729;68352.3164768351;9563.856542151872;9624.75938101553;9904.455254961047;9935.105840474393;10163.542640581192;13516;13616.455341786415;13624.455021799215;13638.249896255602;13689.589312320646;6824.863502729918;6987.475939304572;7103.573785572882;7122.71509139639;7261.564306141649;6729.596224226562;6761.594304341756;6838.555493892881;6861.828454288683;6912.032315475837;6336.7960087583215;6375.489960803125;6394.296627370985;6448.097266382711;6455.580387274812;1785.7321401789836;1809.6471188118453;1829.7255411688354;1833.092619153501;1843.7603111595406;417.4510518667942;417.4656439757116;436.86457198268636;833.4332653795356;892.9419587726777;10970.232083754221;11045.116390688887;11148.777024459627;11309.94345028286;11367.602133925273;427.95506471820636;437.6892406391498;449.35741889098904;842.6081871929582;880.3837313880309;8784.692535761218;8806.515641639644;8815.779605509786;9103.089691030844;9262.814743705088;403562;423109;431432;432094;433496;75459;77072;78402.6079869597;80595;81237;889.4129874282942;902.5442151713343;912.4297314178639;921.8525035994209;954.3271993244746;14598.489052883098;14661.633459163606;14675.039872408548;14691.11853288806;14890.32993515316;33500.664993349754;34267.314653706286;35040.64959350374;35086.64913350834;38098.95169393671;50967.490325096274;51658.22512662388;52835;53045.4695453056;53192.73403632957;7654.73208437702;7679.308862202429;7688.269614386624;7896.32881205104;7917.524948503108;11227.775444491228;11888.940555297168;11959;12186.939065304618;12223.633291001284;10159.44123073238;10433.791324173626;10530.31552949056;10673.679789606324;10776.730581735519;9894.15899648538;10052.145567626834;10097.747556311151;10297.124744396511;10484.947575262075;8385.706500272461;10513.264071514921;10605.204609654462;10658.360498370123;10799.56801727922;6591.274959754519;7745.535267883945;7771.92228077712;7892.881606776018;7996.080450748238;8504.829903402022;9847.901520984698;9869.753256168653;10199.84700229512;10671.306365086244 17:51:07 INFO - PROCESS | 3434 | |3;mootools.html;1360.3470334239562;1379.8896088312936;1453.2588379926235;1663.4760050584057;1663.8918470299436;7085.504014718959;7621.390288776898;7738.729144479944;8217.137200593941;8237.91762082379;7865.724699635514;8020.799480013003;8088.959555202216;8131.14622964589;8136.877946830802;2249.280230326296;2290.4159439342943;2290.610596198642;2293.6444851048113;2296.644020176867;2223.5108276179217;2243.596152692515;2284.3946354216146;2287.5653625811124;2289.69089172962;2201.878896660683;2211.933641990735;2232.3815233955415;2286.325533967484;2292.1519037955895;2230.3754948614414;2265.037359122383;2290.3815969688258;2291.278247352079;2304.781045800663;2170.6309927312395;2179.891005449737;2181.4328274648706;2184.388371256051;2191.298784388996;8078.272955434039;8119.837603247961;8145.755627331189;8162.632681529345;8178.345732341399;4652.232381657022;4800.615950723934;4802.783874725646;4808.567228949411;4830.3720516333005;2915.7084291570886;2996.355783506535;3069.5088785794164;3097.550855125994;3103.177657920653;965.9227261819037;972.6838777397303;972.810301991112;983.149575617086;985.7289245457556;11010.834837477445;11043.116550676006;11125.443727813657;11210.66368008961;11247.212695111346;4228.640565551901;4298.20483210607;4324.891877703082;4362.978185109054;4456.064226512469;9471.242300615933;9482.525873706287;9520.952395237979;9522.476263805556;9548.37935534188;4722.126406614787;4750.287456881426;4765.7140571565815;4772.570468657837;4774.283857421415;3859.614038596174;4236.555161708038;4345.283028300295;4346.673999450054;4405.31717583775;3674.52231209941;3722.7952462614817;3813.161104556993;3822.140018495816;3934.5868683788362;1234.1176059117774;1273.1597145883673;1277.5017743080207;1280.801475771257;1281.858995510493;837.937154713399;845.6744153500946;848.1306660672859;866.3242670716851;890.2521881619471;5321.973390133102;5422;5458.208559758813;5465.9726701367035;5497.8075767347955;420.74124413485487;422.7041071250137;427.0221193466988;911.9589618467185;932.6756006470828;3583.516225309602;3694.9445758313645;3774.094217387807;3778.263238668488;3792.3363411402893;9774.902250977542;9778.364406313567;9952.104310611934;10012.148967337713;10102.545385457672;9754.9024509754;9838.409695418297;9886.80226395468;9887.555060022316;9890.554925028391;7392.852142957111;7439.9256007439235;7504.662290196954;7552.6223688816435;7557.2820582044615;5269.367675878919;5275.604329675367;5293.947060529345;5338.786448542015;5474.2062400950845;9108.817823643358;9173.816523669622;9214.078592140731;9270.026647202216;9298.302627302844;8726.258268047288;9133.497657628628;9149.817003659757;9243.39917905334;9402.858957115512;6177.567570270217;6482.967585162044;6694.799156025327;6801.047853300641;6886.345797149263;7640.044994375703;7683.654235559301;7729.497582657109;7739.613019349123;7759.340456061298;6815.727370905307;7066.787996360117;7071.858562828817;7123.7506687265695;7218.169910460154;6862.3137686230975;6920.51556391068;6981.057557229912;7038.964805175941;7103.680334384861;6132.356102609162;6143.109249158758;6143.139960405636;6143.416375444325;6156.415140561639;4623.144718227139;4753.714777113384;4758.4765675776325;4768.76156192182;4776.23580227162;4686.461056978491;4696.788644510937;4716.6698331116495;4755.453122890774;4761.880952976203 17:51:07 INFO - PROCESS | 3434 | |4;prototype.html;309.91167517257577;313.3372916282063;313.6628124765877;315.7947334232747;317.09627561449855;5124.820631277906;5126.948730512703;5133.281340612308;5138.458462461265;5146.871328216792;5070.264811602316;5077.593792496601;5104.106781313274;5105.566026887719;5119.795208191668;3796.6013568575318;3908.8664287356632;4000.119973605802;4005.799710014502;4016.6385025347713;4003.7988603419003;4014.2172276406113;4021.4571032910476;4035.071933455307;4035.3139966205667;4006.559278479365;4011.2178125265586;4011.799410029487;4012.498437695288;4052.5542190359038;3749.9625003750157;3966.5636779954184;3969.206158768258;4025.778582177979;4027.7180597358197;3460.3944309745693;3470.4794280857823;3475.322312149132;3489.7906125632544;3496.9125771855906;4871.634627402959;4948.282499037656;4954.885150841068;4961.8511444656715;4974;4241.660667146652;4434.2905135178535;4529.886752831206;4535.591796738277;4569.606270087622;5289.814856480043;5312.92030619541;5319.680819150824;5322.1484562470205;5336.199570064483;3735.6637902588627;3755.3615885299564;3759.154190307186;3764.360058789985;3778.4332350147697;5359.517643412073;5593.965116453469;5596.440355964371;5604.439556044404;5622.662640241599;3854.2869569129803;3861.7489863158803;3863.9613603864163;3871.341871881787;3871.8064096795047;3918.45141680165;3938.822752976123;3944.3886197639413;3944.9013774655864;3956.7338451695755;4490.932636010462;4501.347304640809;4512.887177820581;4517.457905051415;4546.613028160243;5222.477752224823;5268.683878967274;5295.814646487354;5299.6290259681455;5384.9730751346;1343.7446885091802;1352.614504866128;1356.3692882809542;1363.863613638648;1366.1079405023916;840.4579046515086;851.0170752780548;863.7970077031893;872.816708491224;874.2568816505919;4599.126166028444;4629.953700463019;4635.188841952645;4646.651501137429;4689.835855745033;5361.919571206435;5364.91952620711;5408.540274076748;5410.161424979135;5412.729363531807;4488.820447182076;4609.953900460952;4613.5847773700525;4616.538346165424;4633.633078241859;2869.8332758766996;2895.334073163142;2895.724906133914;2906.956395654067;2929.9121026368816;5083.119245878975;5086.745662716849;5091.796328146833;5117.002184573972;5134.178531434953;5368.463153684678;5566.749496272678;5572.777088916479;5698.344690360579;5709.371969083398;5141.820036298712;5177.611679124081;5187.144121220032;5205.973970130125;5213.218017297284;5554.888902221852;5559.16612508127;5562.527185189304;5592.7762889483965;5603.915941260802;5227.947720522746;5414.485623865727;5422.295101636762;5447.291852059207;5493.587980901369;5180.663256888291;5232.555232805102;5284.735763211901;5287.920681189708;5324.8935021298585;3846.769193848378;3867.1298957734284;3900.0444891001885;3907.3943538751537;3916.2950668878734;5350.277712508761;5477.863053423696;5479.808206712746;5558.166275058774;5597.972010139923;5354.384245811626;5372.2747429098135;5374.435684253097;5393.19328025116;5398.838034858961;5146.459621739664;5289.968456151014;5383.892322153613;5384.246205531307;5418.268533747893;5284.41871394154;5292.682439053669;5295.179247216687;5329.333833270841;5350.759215835375;5144.356955380577;5272.340957380327;5421.5933804964;5433.782648694166;5438.211459338453;5296.126139186991;5305.442928492453;5321.36143662763;5336.78652853897;5380.986647477425 17:51:07 INFO - PROCESS | 3434 | |5;yui.html;651.3876955661681;713.0195980526776;727.7343769524124;744.8659241336558;761.9276168763968;12696.61910142696;12840.1011929165;12857.5499857505;12897.484100635964;12900.483980640764;12754.872451275485;12985.155964862277;13004;13009.544665936693;13214.801777973338;622.757124721359;755.2032605601089;790.4466873188762;791.6991543213571;793.9047314322289;792.2157064506155;795.2087672765606;796.1759578835906;798.648594618369;799.4963173200904;824.2952275804191;828.105645902427;828.2959484438239;828.9171082891693;835.757630287216;818.3126174013827;819.9139090395541;825.5542007316042;826.6693322670919;828.2380210206625;605.8848818724429;610.4292486525113;610.4414460768392;613.037531076206;614.5176036811126;13575;13737.107088039245;13774.380152893144;13803.17180969145;13845.792313115311;13076.673083172902;13413;13582;13630.318484075757;13815.309234538334;10156.796864062751;10176;10364.17086633075;10367.274290799647;10469.162467002698;3377.172592714776;3416.760826742129;3426.5031570422398;3426.7429942754393;3430.2281986553076;59522.70238648822;60247;60382.69808650973;62097.689511552606;62383.688081559754;9484.336096473318;9902.306838521234;10236.795264094826;10277.229207809443;10523.52644131016;17244.827551724575;17311;17473.650526989644;17518.474445766646;17540.473785786446;6779.15260592426;6792.049113124167;6893.310668933167;6950.756723514653;6983.057287266256;3847.846086156578;3876.8449262029767;3883.7475564088245;3893.844246230176;3942.766931116514;2835.617191679138;2904.302967287878;2906.4041871416307;2908;2933.8826446941885;497.1846172277468;502.62554396974485;508.4153223792668;512.1805111821056;513.5788653304329;444.3334997503744;485.51691067388174;496.6771598460957;508.1767536590747;520.4254602047956;7048.964755176191;7119.288071192839;7160.283971602902;7206.135263768381;7282.453815963824;462.2788450017983;474.71517089745873;487.30660953188095;497.25411882176735;579.322193034151;3635.9636403636155;3666.2484190740834;3690.391085470921;3782.130110074698;3977.085270387769;54019.72990135024;54562.72718636461;91342.54328728314;94176.52911735397;94176.52911735397;80391;84085.57957210175;84335;84774.57612711897;85681;70536;70601.2939870605;71068.64465677639;72358.82923512303;72464.63767681233;7269.491135620668;7310.6710198040155;7581.166071732216;7596.202398748273;7615.619219039137;36275.81862090673;42055.36916946187;42145.36781948335;42149.36775948302;43034.35448468338;54374.728126359114;56070.71964640151;56241;61119;62548.374516254255;10736.838947415952;10865.945670271598;10957.178211634318;11215.868984892844;11345;12772.1059525836;12842.807357889453;13041.478340866259;13074.28091454941;13690.110142841082;11697.766044679229;12133.939330303292;12196.81704774447;12257.38713064361;12306.630801075982;11188.66434006981;11453.713657158638;12038.458269377725;12246.081543884422;12504.437300321326;10140.949295253477;11418.31490110596;11583.362915039754;11761.176717629683;12112.515499379926;9473.952630236805;9683.32216744821;9791;9809.509524523888;9882.357646752938;9611.183049440875;9689.563969621526;9908.653197138066;9927.801443970935;9982.60069597208 17:51:07 INFO - PROCESS | 3434 | __end_tp_report 17:51:07 INFO - PROCESS | 3434 | __start_cc_report 17:51:07 INFO - PROCESS | 3434 | _x_x_mozilla_cycle_collect,390 17:51:07 INFO - PROCESS | 3434 | __end_cc_report 17:51:07 INFO - PROCESS | 3434 | __startTimestamp1465865467679__endTimestamp 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | ------- Summary: start ------- 17:51:07 INFO - PROCESS | 3434 | Number of tests: 6 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | [#0] dojo.html Cycles:165 Average:4811.81 Median:4963.48 stddev:613.61 (12.4%) stddev-sans-first:591.36 17:51:07 INFO - PROCESS | 3434 | Values: 2639.9 2679.7 2707.8 2712.6 2728.1 4771.4 4804.2 4810.5 4866.1 4925.6 4756.2 4791.9 4819.5 4853.6 4913.3 4425.6 4450.1 4574.3 4575.1 4586.2 600.9 4474.4 4483.1 4520.6 4614.5 4543.4 4556.0 4558.0 4559.9 4601.0 4355.4 4578.0 4582.6 4584.5 4627.2 4335.8 4368.1 4391.1 4441.3 4520.7 4745.3 4760.5 4805.6 4829.1 4850.2 5184.5 5188.2 5189.5 5242.5 5243.2 5297.5 5297.9 5302.9 5336.5 5347.6 4932.3 4959.6 4966.6 4968.6 4968.7 5151.9 5323.3 5334.3 5350.3 5429.9 5132.6 5134.1 5135.6 5154.7 5182.8 5234.6 5245.7 5248.0 5249.8 5300.0 5033.7 5142.8 5160.3 5170.3 5179.0 4958.1 5096.7 5150.0 5218.5 5253.8 4377.7 4386.8 4398.8 4404.5 4425.0 3740.7 3790.7 3808.2 3844.3 3864.3 4535.8 4577.2 4595.6 4601.0 4609.1 5105.8 5279.0 5321.4 5326.5 5355.9 4528.9 4565.5 4573.7 4575.2 4582.7 4646.7 4677.6 4692.1 4709.5 4745.9 4778.7 4908.7 4911.7 4921.8 4953.1 5313.0 5316.1 5334.2 5343.8 5381.8 4969.3 4986.9 4988.0 4993.1 5060.0 5002.1 5128.1 5142.5 5228.6 5231.1 5296.9 5299.3 5302.4 5302.7 5354.8 5142.5 5152.1 5155.7 5167.8 5218.3 4933.5 5087.5 5129.5 5142.1 5143.9 4892.3 4928.6 4945.5 4963.5 5007.2 5120.7 5123.3 5128.4 5132.8 5194.7 4888.1 5009.0 5019.3 5049.7 5101.7 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | [#1] ext.html Cycles:180 Average:47177.58 Median:36915.82 stddev:88203.83 (238.9%) stddev-sans-first:88381.74 17:51:07 INFO - PROCESS | 3434 | Values: 535.8 594.7 600.7 606.1 617.4 33931.8 39062.6 39077.2 39088.0 39096.6 39750.4 40181.0 40219.0 40315.6 40318.0 7814.6 7938.5 7952.3 7968.3 7976.6 7739.6 7846.5 7863.8 7882.4 7885.0 7843.0 7876.9 7881.0 7882.9 7887.5 7745.1 7793.3 7800.9 7815.8 7830.8 7725.0 7743.0 7765.4 7775.2 7809.4 29676.6 37362.4 37546.4 37598.4 37703.0 2883.4 3132.2 3148.1 3176.9 3324.5 28287.7 28833.4 30417.0 31248.7 31590.4 3505.3 3589.9 3594.9 3625.4 3762.4 231926.0 236728.0 237328.0 237697.0 237936.0 28726.3 55975.0 56021.0 56543.0 56799.0 34873.0 35085.8 35262.5 35266.5 35338.8 13083.5 13198.2 13212.1 13217.8 13264.7 10940.6 10974.6 11033.8 11034.9 11063.1 8005.4 8006.2 8065.9 8146.1 8166.1 3231.2 3231.8 3237.8 3258.2 3263.7 867.7 876.3 882.4 944.2 968.8 28839.4 28860.6 28885.6 29123.4 29125.9 889.6 969.2 977.4 1002.6 1035.6 14691.2 14764.3 14787.4 14811.5 14825.6 381387.0 381859.0 385174.0 386099.0 386320.0 49812.0 50505.2 50563.7 50755.5 50757.5 1197.4 1213.2 1223.9 1228.6 1233.5 25962.0 27334.9 27659.3 27981.7 28021.6 40901.4 41117.4 41671.6 41815.2 41914.6 358999.0 361198.0 361997.0 362136.0 364500.0 25415.6 25515.0 25944.7 25961.4 26014.7 43505.0 43515.0 43786.0 43883.0 44375.3 36878.0 37255.6 37358.6 37550.8 37696.6 36813.0 36953.6 37069.0 37106.8 37627.0 30138.5 35577.3 35750.5 35798.0 36445.3 32050.2 33121.8 33367.3 33547.0 33636.0 25514.5 25521.9 25709.0 25843.2 25864.9 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | [#2] jquery.html Cycles:180 Average:25004.29 Median:443.52 stddev:69901.64 (15760.5%) stddev-sans-first:70073.27 17:51:07 INFO - PROCESS | 3434 | Values: 372.4 375.8 376.5 381.0 391.6 15444.6 16008.0 16905.9 16974.7 16981.1 15709.2 16303.3 16915.8 17055.9 17079.1 5066.1 5244.6 5267.8 5282.4 5290.4 5177.5 5256.6 5292.2 5293.6 5294.4 5047.2 5177.2 5187.4 5266.5 5277.6 5176.4 5199.5 5218.2 5221.5 5245.2 4673.4 4693.3 4699.9 4708.6 4720.5 19586.8 20017.0 20773.8 20889.8 21003.8 1967.4 1979.8 1982.2 2109.8 2546.3 12865.0 12890.7 12920.8 13097.9 13408.3 1793.5 1820.8 1821.5 1824.9 1862.8 47038.8 62989.4 66424.3 67084.7 68352.3 9563.9 9624.8 9904.5 9935.1 10163.5 13516.0 13616.5 13624.5 13638.2 13689.6 6824.9 6987.5 7103.6 7122.7 7261.6 6729.6 6761.6 6838.6 6861.8 6912.0 6336.8 6375.5 6394.3 6448.1 6455.6 1785.7 1809.6 1829.7 1833.1 1843.8 417.5 417.5 436.9 833.4 892.9 10970.2 11045.1 11148.8 11309.9 11367.6 428.0 437.7 449.4 842.6 880.4 8784.7 8806.5 8815.8 9103.1 9262.8 403562.0 423109.0 431432.0 432094.0 433496.0 75459.0 77072.0 78402.6 80595.0 81237.0 889.4 902.5 912.4 921.9 954.3 14598.5 14661.6 14675.0 14691.1 14890.3 33500.7 34267.3 35040.6 35086.6 38099.0 50967.5 51658.2 52835.0 53045.5 53192.7 7654.7 7679.3 7688.3 7896.3 7917.5 11227.8 11888.9 11959.0 12186.9 12223.6 10159.4 10433.8 10530.3 10673.7 10776.7 9894.2 10052.1 10097.7 10297.1 10484.9 8385.7 10513.3 10605.2 10658.4 10799.6 6591.3 7745.5 7771.9 7892.9 7996.1 8504.8 9847.9 9869.8 10199.8 10671.3 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | [#3] mootools.html Cycles:180 Average:5280.12 Median:5272.49 stddev:2969.22 (56.3%) stddev-sans-first:2962.93 17:51:07 INFO - PROCESS | 3434 | Values: 1360.3 1379.9 1453.3 1663.5 1663.9 7085.5 7621.4 7738.7 8217.1 8237.9 7865.7 8020.8 8089.0 8131.1 8136.9 2249.3 2290.4 2290.6 2293.6 2296.6 2223.5 2243.6 2284.4 2287.6 2289.7 2201.9 2211.9 2232.4 2286.3 2292.2 2230.4 2265.0 2290.4 2291.3 2304.8 2170.6 2179.9 2181.4 2184.4 2191.3 8078.3 8119.8 8145.8 8162.6 8178.3 4652.2 4800.6 4802.8 4808.6 4830.4 2915.7 2996.4 3069.5 3097.6 3103.2 965.9 972.7 972.8 983.1 985.7 11010.8 11043.1 11125.4 11210.7 11247.2 4228.6 4298.2 4324.9 4363.0 4456.1 9471.2 9482.5 9521.0 9522.5 9548.4 4722.1 4750.3 4765.7 4772.6 4774.3 3859.6 4236.6 4345.3 4346.7 4405.3 3674.5 3722.8 3813.2 3822.1 3934.6 1234.1 1273.2 1277.5 1280.8 1281.9 837.9 845.7 848.1 866.3 890.3 5322.0 5422.0 5458.2 5466.0 5497.8 420.7 422.7 427.0 912.0 932.7 3583.5 3694.9 3774.1 3778.3 3792.3 9774.9 9778.4 9952.1 10012.1 10102.5 9754.9 9838.4 9886.8 9887.6 9890.6 7392.9 7439.9 7504.7 7552.6 7557.3 5269.4 5275.6 5293.9 5338.8 5474.2 9108.8 9173.8 9214.1 9270.0 9298.3 8726.3 9133.5 9149.8 9243.4 9402.9 6177.6 6483.0 6694.8 6801.0 6886.3 7640.0 7683.7 7729.5 7739.6 7759.3 6815.7 7066.8 7071.9 7123.8 7218.2 6862.3 6920.5 6981.1 7039.0 7103.7 6132.4 6143.1 6143.1 6143.4 6156.4 4623.1 4753.7 4758.5 4768.8 4776.2 4686.5 4696.8 4716.7 4755.5 4761.9 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | [#4] prototype.html Cycles:180 Average:4431.06 Median:5104.84 stddev:1296.12 (25.4%) stddev-sans-first:1262.30 17:51:07 INFO - PROCESS | 3434 | Values: 309.9 313.3 313.7 315.8 317.1 5124.8 5126.9 5133.3 5138.5 5146.9 5070.3 5077.6 5104.1 5105.6 5119.8 3796.6 3908.9 4000.1 4005.8 4016.6 4003.8 4014.2 4021.5 4035.1 4035.3 4006.6 4011.2 4011.8 4012.5 4052.6 3750.0 3966.6 3969.2 4025.8 4027.7 3460.4 3470.5 3475.3 3489.8 3496.9 4871.6 4948.3 4954.9 4961.9 4974.0 4241.7 4434.3 4529.9 4535.6 4569.6 5289.8 5312.9 5319.7 5322.1 5336.2 3735.7 3755.4 3759.2 3764.4 3778.4 5359.5 5594.0 5596.4 5604.4 5622.7 3854.3 3861.7 3864.0 3871.3 3871.8 3918.5 3938.8 3944.4 3944.9 3956.7 4490.9 4501.3 4512.9 4517.5 4546.6 5222.5 5268.7 5295.8 5299.6 5385.0 1343.7 1352.6 1356.4 1363.9 1366.1 840.5 851.0 863.8 872.8 874.3 4599.1 4630.0 4635.2 4646.7 4689.8 5361.9 5364.9 5408.5 5410.2 5412.7 4488.8 4610.0 4613.6 4616.5 4633.6 2869.8 2895.3 2895.7 2907.0 2929.9 5083.1 5086.7 5091.8 5117.0 5134.2 5368.5 5566.7 5572.8 5698.3 5709.4 5141.8 5177.6 5187.1 5206.0 5213.2 5554.9 5559.2 5562.5 5592.8 5603.9 5227.9 5414.5 5422.3 5447.3 5493.6 5180.7 5232.6 5284.7 5287.9 5324.9 3846.8 3867.1 3900.0 3907.4 3916.3 5350.3 5477.9 5479.8 5558.2 5598.0 5354.4 5372.3 5374.4 5393.2 5398.8 5146.5 5290.0 5383.9 5384.2 5418.3 5284.4 5292.7 5295.2 5329.3 5350.8 5144.4 5272.3 5421.6 5433.8 5438.2 5296.1 5305.4 5321.4 5336.8 5381.0 17:51:07 INFO - PROCESS | 3434 | 17:51:07 INFO - PROCESS | 3434 | [#5] yui.html Cycles:180 Average:16791.77 Median:499.94 stddev:23338.64 (4668.3%) stddev-sans-first:23372.64 17:51:07 INFO - PROCESS | 3434 | Values: 651.4 713.0 727.7 744.9 761.9 12696.6 12840.1 12857.5 12897.5 12900.5 12754.9 12985.2 13004.0 13009.5 13214.8 622.8 755.2 790.4 791.7 793.9 792.2 795.2 796.2 798.6 799.5 824.3 828.1 828.3 828.9 835.8 818.3 819.9 825.6 826.7 828.2 605.9 610.4 610.4 613.0 614.5 13575.0 13737.1 13774.4 13803.2 13845.8 13076.7 13413.0 13582.0 13630.3 13815.3 10156.8 10176.0 10364.2 10367.3 10469.2 3377.2 3416.8 3426.5 3426.7 3430.2 59522.7 60247.0 60382.7 62097.7 62383.7 9484.3 9902.3 10236.8 10277.2 10523.5 17244.8 17311.0 17473.7 17518.5 17540.5 6779.2 6792.0 6893.3 6950.8 6983.1 3847.8 3876.8 3883.7 3893.8 3942.8 2835.6 2904.3 2906.4 2908.0 2933.9 497.2 502.6 508.4 512.2 513.6 444.3 485.5 496.7 508.2 520.4 7049.0 7119.3 7160.3 7206.1 7282.5 462.3 474.7 487.3 497.3 579.3 3636.0 3666.2 3690.4 3782.1 3977.1 54019.7 54562.7 91342.5 94176.5 94176.5 80391.0 84085.6 84335.0 84774.6 85681.0 70536.0 70601.3 71068.6 72358.8 72464.6 7269.5 7310.7 7581.2 7596.2 7615.6 36275.8 42055.4 42145.4 42149.4 43034.4 54374.7 56070.7 56241.0 61119.0 62548.4 10736.8 10865.9 10957.2 11215.9 11345.0 12772.1 12842.8 13041.5 13074.3 13690.1 11697.8 12133.9 12196.8 12257.4 12306.6 11188.7 11453.7 12038.5 12246.1 12504.4 10140.9 11418.3 11583.4 11761.2 12112.5 9474.0 9683.3 9791.0 9809.5 9882.4 9611.2 9689.6 9908.7 9927.8 9982.6 17:51:07 INFO - PROCESS | 3434 | -------- Summary: end -------- 17:51:07 INFO - PROCESS | 3434 | 17:51:08 INFO - TEST-INFO | 3434: exit 0 17:51:08 INFO - TEST-OK | dromaeo_css | took 1120662ms 17:51:08 INFO - TEST-START | kraken 17:51:08 INFO - operating with platform_type : linux_ 17:51:08 INFO - Initialising browser for kraken test... 17:51:08 INFO - TEST-INFO | started process 3668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrj2lR/profile http://localhost:47544/getInfo.html) 17:51:13 INFO - PROCESS | 3668 | __metrics Screen width/height:1600/1200 17:51:13 INFO - PROCESS | 3668 | colorDepth:24 17:51:13 INFO - PROCESS | 3668 | Browser inner width/height: 1024/697 17:51:13 INFO - PROCESS | 3668 | __metrics 17:51:14 ERROR - PROCESS | 3668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 17:51:15 INFO - TEST-INFO | 3668: exit 0 17:51:15 INFO - Browser initialized. 17:51:15 INFO - Running cycle 1/1 for kraken test... 17:51:15 INFO - TEST-INFO | started process 3788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplrj2lR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:27 INFO - PROCESS | 3788 | RSS: Main: 185884672 17:51:27 INFO - PROCESS | 3788 | 17:51:29 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47544/tests/kraken/driver.html?testName=audio-beat-detection) 17:51:30 INFO - PROCESS | 3788 | RSS: Main: 190951424 17:51:30 INFO - PROCESS | 3788 | 17:51:33 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47544/tests/kraken/driver.html?testName=audio-dft) 17:51:34 INFO - PROCESS | 3788 | RSS: Main: 191021056 17:51:34 INFO - PROCESS | 3788 | 17:51:37 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47544/tests/kraken/driver.html?testName=audio-fft) 17:51:37 INFO - PROCESS | 3788 | RSS: Main: 186454016 17:51:37 INFO - PROCESS | 3788 | 17:51:40 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47544/tests/kraken/driver.html?testName=audio-oscillator) 17:51:40 INFO - PROCESS | 3788 | RSS: Main: 186732544 17:51:40 INFO - PROCESS | 3788 | 17:51:42 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:51:43 INFO - PROCESS | 3788 | RSS: Main: 187674624 17:51:43 INFO - PROCESS | 3788 | 17:51:46 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47544/tests/kraken/driver.html?testName=imaging-darkroom) 17:51:47 INFO - PROCESS | 3788 | RSS: Main: 187457536 17:51:47 INFO - PROCESS | 3788 | 17:51:50 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47544/tests/kraken/driver.html?testName=imaging-desaturate) 17:51:51 INFO - PROCESS | 3788 | RSS: Main: 184205312 17:51:51 INFO - PROCESS | 3788 | 17:51:54 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47544/tests/kraken/driver.html?testName=json-parse-financial) 17:51:55 INFO - PROCESS | 3788 | RSS: Main: 186277888 17:51:55 INFO - PROCESS | 3788 | 17:51:56 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:51:57 INFO - PROCESS | 3788 | RSS: Main: 186429440 17:51:57 INFO - PROCESS | 3788 | 17:51:59 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:51:59 INFO - PROCESS | 3788 | RSS: Main: 186720256 17:51:59 INFO - PROCESS | 3788 | 17:52:02 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:52:02 INFO - PROCESS | 3788 | RSS: Main: 187088896 17:52:02 INFO - PROCESS | 3788 | 17:52:05 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:52:06 INFO - PROCESS | 3788 | RSS: Main: 187441152 17:52:06 INFO - PROCESS | 3788 | 17:52:09 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:52:09 INFO - PROCESS | 3788 | RSS: Main: 186863616 17:52:09 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | Cycle 1(1): loaded http://localhost:47544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47544/tests/kraken/driver.html?testName=ai-astar) 17:52:11 INFO - PROCESS | 3788 | RSS: Main: 187990016 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | __start_tp_report 17:52:11 INFO - PROCESS | 3788 | _x_x_mozilla_page_load 17:52:11 INFO - PROCESS | 3788 | _x_x_mozilla_page_load_details 17:52:11 INFO - PROCESS | 3788 | |i|pagename|runs| 17:52:11 INFO - PROCESS | 3788 | |0;ai-astar;114;108;113;118;113;115;113;114;112;114 17:52:11 INFO - PROCESS | 3788 | |1;audio-beat-detection;158;132;158;187;133;154;157;140;179;134 17:52:11 INFO - PROCESS | 3788 | |2;audio-dft;163;166;173;166;166;163;161;164;164;162 17:52:11 INFO - PROCESS | 3788 | |3;audio-fft;77;76;80;163;76;76;76;76;161;79 17:52:11 INFO - PROCESS | 3788 | |4;audio-oscillator;86;86;149;86;87;86;138;86;85;137 17:52:11 INFO - PROCESS | 3788 | |5;imaging-gaussian-blur;117;118;118;118;120;117;119;118;118;117 17:52:11 INFO - PROCESS | 3788 | |6;imaging-darkroom;148;147;149;148;147;152;147;149;147;147 17:52:11 INFO - PROCESS | 3788 | |7;imaging-desaturate;96;95;96;97;97;95;97;95;96;95 17:52:11 INFO - PROCESS | 3788 | |8;json-parse-financial;63;66;64;65;64;63;64;63;63;63 17:52:11 INFO - PROCESS | 3788 | |9;json-stringify-tinderbox;67;66;67;68;67;68;67;68;68;67 17:52:11 INFO - PROCESS | 3788 | |10;stanford-crypto-aes;87;84;84;90;84;85;84;84;117;83 17:52:11 INFO - PROCESS | 3788 | |11;stanford-crypto-ccm;135;140;143;131;128;133;141;134;161;136 17:52:11 INFO - PROCESS | 3788 | |12;stanford-crypto-pbkdf2;171;174;170;174;172;170;166;175;173;167 17:52:11 INFO - PROCESS | 3788 | |13;stanford-crypto-sha256-iterative;68;68;69;67;70;66;66;68;66;66 17:52:11 INFO - PROCESS | 3788 | __end_tp_report 17:52:11 INFO - PROCESS | 3788 | __start_cc_report 17:52:11 INFO - PROCESS | 3788 | _x_x_mozilla_cycle_collect,972 17:52:11 INFO - PROCESS | 3788 | __end_cc_report 17:52:11 INFO - PROCESS | 3788 | __startTimestamp1465865531811__endTimestamp 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | ------- Summary: start ------- 17:52:11 INFO - PROCESS | 3788 | Number of tests: 14 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.50 (2.2%) stddev-sans-first:2.65 17:52:11 INFO - PROCESS | 3788 | Values: 114.0 108.0 113.0 118.0 113.0 115.0 113.0 114.0 112.0 114.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:157.50 stddev:19.06 (12.1%) stddev-sans-first:20.14 17:52:11 INFO - PROCESS | 3788 | Values: 158.0 132.0 158.0 187.0 133.0 154.0 157.0 140.0 179.0 134.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:3.36 (2.0%) stddev-sans-first:3.50 17:52:11 INFO - PROCESS | 3788 | Values: 163.0 166.0 173.0 166.0 166.0 163.0 161.0 164.0 164.0 162.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#3] audio-fft Cycles:10 Average:94.00 Median:76.00 stddev:35.87 (47.2%) stddev-sans-first:37.51 17:52:11 INFO - PROCESS | 3788 | Values: 77.0 76.0 80.0 163.0 76.0 76.0 76.0 76.0 161.0 79.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:86.00 stddev:26.92 (31.3%) stddev-sans-first:27.87 17:52:11 INFO - PROCESS | 3788 | Values: 86.0 86.0 149.0 86.0 87.0 86.0 138.0 86.0 85.0 137.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 17:52:11 INFO - PROCESS | 3788 | Values: 117.0 118.0 118.0 118.0 120.0 117.0 119.0 118.0 118.0 117.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.60 (1.1%) stddev-sans-first:1.69 17:52:11 INFO - PROCESS | 3788 | Values: 148.0 147.0 149.0 148.0 147.0 152.0 147.0 149.0 147.0 147.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 17:52:11 INFO - PROCESS | 3788 | Values: 96.0 95.0 96.0 97.0 97.0 95.0 97.0 95.0 96.0 95.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.05 17:52:11 INFO - PROCESS | 3788 | Values: 63.0 66.0 64.0 65.0 64.0 63.0 64.0 63.0 63.0 63.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:52:11 INFO - PROCESS | 3788 | Values: 67.0 66.0 67.0 68.0 67.0 68.0 67.0 68.0 68.0 67.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:84.00 stddev:10.33 (12.3%) stddev-sans-first:10.94 17:52:11 INFO - PROCESS | 3788 | Values: 87.0 84.0 84.0 90.0 84.0 85.0 84.0 84.0 117.0 83.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:138.00 stddev:9.25 (6.7%) stddev-sans-first:9.74 17:52:11 INFO - PROCESS | 3788 | Values: 135.0 140.0 143.0 131.0 128.0 133.0 141.0 134.0 161.0 136.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.50 stddev:3.01 (1.7%) stddev-sans-first:3.19 17:52:11 INFO - PROCESS | 3788 | Values: 171.0 174.0 170.0 174.0 172.0 170.0 166.0 175.0 173.0 167.0 17:52:11 INFO - PROCESS | 3788 | 17:52:11 INFO - PROCESS | 3788 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.43 (2.1%) stddev-sans-first:1.50 17:52:11 INFO - PROCESS | 3788 | Values: 68.0 68.0 69.0 67.0 70.0 66.0 66.0 68.0 66.0 66.0 17:52:11 INFO - PROCESS | 3788 | -------- Summary: end -------- 17:52:11 INFO - PROCESS | 3788 | 17:52:12 INFO - TEST-INFO | 3788: exit 0 17:52:12 INFO - TEST-OK | kraken | took 64495ms 17:52:12 INFO - SUITE-END | took 1185s 17:52:12 INFO - Completed test suite (00:19:45) 17:52:12 INFO - javascript benchmark 17:52:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6410.0456189773695, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2639.907603233887, 2679.6784385873693, 2707.837529748214, 2712.56598944169, 2728.0588197072, 4771.4035745531855, 4804.2073057945445, 4810.5189481051875, 4866.1240976624285, 4925.556699897009, 4756.215224487955, 4791.904161916759, 4819.542143496371, 4853.611711063115, 4913.33669954556, 4425.645948324134, 4450.132224216279, 4574.290984897346, 4575.084983003396, 4586.1974154522995, 600.9141504536263, 4474.395956545857, 4483.14820184164, 4520.593146616804, 4614.538546145375, 4543.363929049952, 4555.954440455586, 4557.954420455786, 4559.931601025987, 4600.953990460086, 4355.368471571636, 4577.9771101144615, 4582.633389328846, 4584.472785629662, 4627.23650597651, 4335.826566937319, 4368.126374725036, 4391.055922976543, 4441.267190913495, 4520.68355215135, 4745.335653008581, 4760.500147484534, 4805.567498925114, 4829.10661527615, 4850.199717046683, 5184.533391994739, 5188.195829646411, 5189.506996835295, 5242.5281724644965, 5243.161094224905, 5297.549708274802, 5297.894042119136, 5302.92045619316, 5336.546393556552, 5347.6256662033675, 4932.334134891779, 4959.628027897922, 4966.602671786249, 4968.6025117990475, 4968.652194346361, 5151.9484805152215, 5323.30796996388, 5334.253204551366, 5350.277712508761, 5429.918551221735, 5132.56373208274, 5134.12719837621, 5135.589152867761, 5154.690718556899, 5182.792688292501, 5234.581233501311, 5245.659032162974, 5248.029114613809, 5249.763760630704, 5300.045991721528, 5033.697978121324, 5142.768575414116, 5160.329157209614, 5170.250313704491, 5179.04187725272, 4958.132326842788, 5096.668716533488, 5149.9742501288, 5218.530332270114, 5253.789848406097, 4377.737335759864, 4386.758728269912, 4398.824047038147, 4404.493483249404, 4425.0, 3740.682042026458, 3790.7346485745734, 3808.2383523295453, 3844.308024555607, 3864.265789499986, 4535.751608413759, 4577.198990176706, 4595.583683697097, 4601.033782905561, 4609.078184363141, 5105.846824595268, 5279.049771041173, 5321.414644389114, 5326.493983071679, 5355.946440535545, 4528.88677783058, 4565.5206203348835, 4573.725576465423, 4575.22221222393, 4582.725036497821, 4646.651501137429, 4677.64917631179, 4692.064538358979, 4709.458412282563, 4745.928811067837, 4778.665493415428, 4908.650121216694, 4911.68074075184, 4921.827736029221, 4953.083679519301, 5313.043652142652, 5316.149416093406, 5334.1732031535175, 5343.839684809462, 5381.757820898148, 4969.254611808257, 4986.925196121989, 4987.975060124676, 4993.076280888047, 5060.0, 5002.099622068063, 5128.051310507568, 5142.460041695717, 5228.63399562027, 5231.058409486329, 5296.894062118813, 5299.284596579412, 5302.416734159317, 5302.655327403706, 5354.812581559627, 5142.537171654569, 5152.07295111815, 5155.664881782672, 5167.844964651066, 5218.269442278008, 4933.4819843915875, 5087.542121209109, 5129.48705129499, 5142.125838607521, 5143.871403214949, 4892.339534162842, 4928.581070608895, 4945.480724524017, 4963.478834722302, 5007.198848184273, 5120.667156634807, 5123.308353372247, 5128.410232823124, 5132.8460146195675, 5194.68831870089, 4888.071266459361, 5009.023240468074, 5019.322391477104, 5049.697018178921, 5101.7194054327365], "value": 4773.9950830885155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.7671435619142, 594.6759016336097, 600.6876424259385, 606.1271768653139, 617.4443001298828, 33931.83034084829, 39062.60937390625, 39077.21845563087, 39088.0, 39096.609033909655, 39750.40374394386, 40181.0, 40219.0, 40315.59684403155, 40318.0, 7814.570198639087, 7938.5236885787035, 7952.324052455549, 7968.28285454309, 7976.641051152683, 7739.57432341221, 7846.529208247495, 7863.8427231455335, 7882.408819338544, 7885.014373203349, 7843.019622547182, 7876.921230787705, 7881.014873140857, 7882.921170788305, 7887.487313324616, 7745.109312429058, 7793.298603125746, 7800.921990780076, 7815.843683126305, 7830.765077047669, 7724.961375193145, 7742.961285193594, 7765.417593680497, 7775.22247775218, 7809.414293927978, 29676.554851677243, 37362.43956340657, 37546.43680344797, 37598.43602345967, 37703.0, 2883.3656595548946, 3132.1699749566383, 3148.0870547541185, 3176.904692859218, 3324.484704870749, 28287.717122828715, 28833.423331533253, 30417.0, 31248.68751312503, 31590.368192636248, 3505.298940211968, 3589.94615080774, 3594.856205751767, 3625.4018087015875, 3762.3792074307707, 231926.0, 236727.99999999828, 237328.0, 237697.0, 237936.0, 28726.281842953675, 55975.0, 56021.0, 56543.0, 56799.0, 34873.0, 35085.82457087749, 35262.47106293408, 35266.47100293497, 35338.82330588331, 13083.542076027294, 13198.20810751358, 13212.141210821266, 13217.801732974012, 13264.668383290495, 10940.56237750481, 10974.561017559208, 11033.779324413466, 11034.944825275983, 11063.114950803916, 8005.359571234288, 8006.15935326794, 8065.879011814827, 8146.0632027317615, 8166.142555031755, 3231.1922019495128, 3231.773775835669, 3237.7571682123935, 3258.169166862435, 3263.7062664360324, 867.6572753762229, 876.3471213945651, 882.3558802074522, 944.187998321443, 968.7578105473632, 28839.423211535654, 28860.567091493645, 28885.56671649927, 29123.417531649673, 29125.85437072801, 889.6308032166708, 969.2149359019216, 977.4086677559974, 1002.5739060899089, 1035.6064695415694, 14691.191984440744, 14764.26178691061, 14787.408503659948, 14811.481598144013, 14825.62935926589, 381387.0, 381859.0, 385174.0, 386099.0, 386320.0, 49812.0, 50505.242421363706, 50563.74718126386, 50755.477335679985, 50757.492425075274, 1197.404475754275, 1213.1629175868622, 1223.932683702387, 1228.6252692928742, 1233.4696080685212, 25962.0, 27334.863325683244, 27659.320194003034, 27981.720182798726, 28021.57967630528, 40901.38647920224, 41117.383239252034, 41671.58328416798, 41815.1636967265, 41914.58085419107, 358999.0, 361198.0, 361997.0, 362136.0, 364500.0, 25415.6187657189, 25515.0, 25944.740552594987, 25961.350966225997, 26014.739852601233, 43505.0, 43515.0, 43786.0, 43883.0, 44375.33436998383, 36878.0, 37255.627443725214, 37358.6264137366, 37550.81224593859, 37696.62303376931, 36813.0, 36953.63046369609, 37069.0, 37106.8144659275, 37627.0, 30138.54792178075, 35577.28845423129, 35750.46374304336, 35798.0, 36445.27109457849, 32050.19874503063, 33121.83439082789, 33367.322456813585, 33547.0, 33636.0, 25514.489710206064, 25521.937367515275, 25709.0, 25843.224703258933, 25864.8706756465], "value": 16634.19617285504, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.4227447456442, 375.8064596732683, 376.50865620365414, 380.9599992000838, 391.55753997982276, 15444.613884652876, 16008.0, 16905.91547042266, 16974.745378819298, 16981.06604136772, 15709.21453927302, 16303.266353014113, 16915.83084169158, 17055.91472042641, 17079.060651664186, 5066.113430149719, 5244.580433565325, 5267.789288428458, 5282.366116066078, 5290.391604965421, 5177.534021938025, 5256.632035757499, 5292.153255479124, 5293.602979776513, 5294.364676238857, 5047.192449208127, 5177.223416487519, 5187.429382767892, 5266.499682530172, 5277.5514081302945, 5176.352955880515, 5199.506046925555, 5218.217267409881, 5221.530062294392, 5245.160774276097, 4673.3690951721765, 4693.296005599153, 4699.906001879977, 4708.552687494683, 4720.457147428056, 19586.80413195864, 20017.0, 20773.792262077335, 20889.791102088937, 21003.78996210049, 1967.3802752133033, 1979.8416126709828, 1982.1575830272077, 2109.831213502916, 2546.3379521324405, 12865.0, 12890.677733056655, 12920.806187907188, 13097.86902130976, 13408.26254555999, 1793.4888556761261, 1820.8088150744113, 1821.4990877508658, 1824.899630520321, 1862.7950925398195, 47038.76480617609, 62989.37010629881, 66424.3357566423, 67084.66457667729, 68352.3164768351, 9563.856542151872, 9624.75938101553, 9904.455254961047, 9935.105840474393, 10163.542640581192, 13516.0, 13616.455341786415, 13624.455021799215, 13638.249896255602, 13689.589312320646, 6824.863502729918, 6987.475939304572, 7103.573785572882, 7122.71509139639, 7261.564306141649, 6729.596224226562, 6761.594304341756, 6838.555493892881, 6861.828454288683, 6912.032315475837, 6336.7960087583215, 6375.489960803125, 6394.296627370985, 6448.097266382711, 6455.580387274812, 1785.7321401789836, 1809.6471188118453, 1829.7255411688354, 1833.092619153501, 1843.7603111595406, 417.4510518667942, 417.4656439757116, 436.86457198268636, 833.4332653795356, 892.9419587726777, 10970.232083754221, 11045.116390688887, 11148.777024459627, 11309.94345028286, 11367.602133925273, 427.95506471820636, 437.6892406391498, 449.35741889098904, 842.6081871929582, 880.3837313880309, 8784.692535761218, 8806.515641639644, 8815.779605509786, 9103.089691030844, 9262.814743705088, 403562.0, 423109.0, 431432.0, 432094.0, 433496.0, 75459.0, 77072.0, 78402.6079869597, 80595.0, 81237.0, 889.4129874282942, 902.5442151713343, 912.4297314178639, 921.8525035994209, 954.3271993244746, 14598.489052883098, 14661.633459163606, 14675.039872408548, 14691.11853288806, 14890.32993515316, 33500.664993349754, 34267.314653706286, 35040.64959350374, 35086.64913350834, 38098.95169393671, 50967.490325096274, 51658.22512662388, 52835.0, 53045.4695453056, 53192.73403632957, 7654.73208437702, 7679.308862202429, 7688.269614386624, 7896.32881205104, 7917.524948503108, 11227.775444491228, 11888.940555297168, 11959.0, 12186.939065304618, 12223.633291001284, 10159.44123073238, 10433.791324173626, 10530.31552949056, 10673.679789606324, 10776.730581735519, 9894.15899648538, 10052.145567626834, 10097.747556311151, 10297.124744396511, 10484.947575262075, 8385.706500272461, 10513.264071514921, 10605.204609654462, 10658.360498370123, 10799.56801727922, 6591.274959754519, 7745.535267883945, 7771.92228077712, 7892.881606776018, 7996.080450748238, 8504.829903402022, 9847.901520984698, 9869.753256168653, 10199.84700229512, 10671.306365086244], "value": 8046.853051729295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.3470334239562, 1379.8896088312936, 1453.2588379926235, 1663.4760050584057, 1663.8918470299436, 7085.504014718959, 7621.390288776898, 7738.729144479944, 8217.137200593941, 8237.91762082379, 7865.724699635514, 8020.799480013003, 8088.959555202216, 8131.14622964589, 8136.877946830802, 2249.280230326296, 2290.4159439342943, 2290.610596198642, 2293.6444851048113, 2296.644020176867, 2223.5108276179217, 2243.596152692515, 2284.3946354216146, 2287.5653625811124, 2289.69089172962, 2201.878896660683, 2211.933641990735, 2232.3815233955415, 2286.325533967484, 2292.1519037955895, 2230.3754948614414, 2265.037359122383, 2290.3815969688258, 2291.278247352079, 2304.781045800663, 2170.6309927312395, 2179.891005449737, 2181.4328274648706, 2184.388371256051, 2191.298784388996, 8078.272955434039, 8119.837603247961, 8145.755627331189, 8162.632681529345, 8178.345732341399, 4652.232381657022, 4800.615950723934, 4802.783874725646, 4808.567228949411, 4830.3720516333005, 2915.7084291570886, 2996.355783506535, 3069.5088785794164, 3097.550855125994, 3103.177657920653, 965.9227261819037, 972.6838777397303, 972.810301991112, 983.149575617086, 985.7289245457556, 11010.834837477445, 11043.116550676006, 11125.443727813657, 11210.66368008961, 11247.212695111346, 4228.640565551901, 4298.20483210607, 4324.891877703082, 4362.978185109054, 4456.064226512469, 9471.242300615933, 9482.525873706287, 9520.952395237979, 9522.476263805556, 9548.37935534188, 4722.126406614787, 4750.287456881426, 4765.7140571565815, 4772.570468657837, 4774.283857421415, 3859.614038596174, 4236.555161708038, 4345.283028300295, 4346.673999450054, 4405.31717583775, 3674.52231209941, 3722.7952462614817, 3813.161104556993, 3822.140018495816, 3934.5868683788362, 1234.1176059117774, 1273.1597145883673, 1277.5017743080207, 1280.801475771257, 1281.858995510493, 837.937154713399, 845.6744153500946, 848.1306660672859, 866.3242670716851, 890.2521881619471, 5321.973390133102, 5422.0, 5458.208559758813, 5465.9726701367035, 5497.8075767347955, 420.74124413485487, 422.7041071250137, 427.0221193466988, 911.9589618467185, 932.6756006470828, 3583.516225309602, 3694.9445758313645, 3774.094217387807, 3778.263238668488, 3792.3363411402893, 9774.902250977542, 9778.364406313567, 9952.104310611934, 10012.148967337713, 10102.545385457672, 9754.9024509754, 9838.409695418297, 9886.80226395468, 9887.555060022316, 9890.554925028391, 7392.852142957111, 7439.9256007439235, 7504.662290196954, 7552.6223688816435, 7557.2820582044615, 5269.367675878919, 5275.604329675367, 5293.947060529345, 5338.786448542015, 5474.2062400950845, 9108.817823643358, 9173.816523669622, 9214.078592140731, 9270.026647202216, 9298.302627302844, 8726.258268047288, 9133.497657628628, 9149.817003659757, 9243.39917905334, 9402.858957115512, 6177.567570270217, 6482.967585162044, 6694.799156025327, 6801.047853300641, 6886.345797149263, 7640.044994375703, 7683.654235559301, 7729.497582657109, 7739.613019349123, 7759.340456061298, 6815.727370905307, 7066.787996360117, 7071.858562828817, 7123.7506687265695, 7218.169910460154, 6862.3137686230975, 6920.51556391068, 6981.057557229912, 7038.964805175941, 7103.680334384861, 6132.356102609162, 6143.109249158758, 6143.139960405636, 6143.416375444325, 6156.415140561639, 4623.144718227139, 4753.714777113384, 4758.4765675776325, 4768.76156192182, 4776.23580227162, 4686.461056978491, 4696.788644510937, 4716.6698331116495, 4755.453122890774, 4761.880952976203], "value": 4226.464931638601, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.91167517257577, 313.3372916282063, 313.6628124765877, 315.7947334232747, 317.09627561449855, 5124.820631277906, 5126.948730512703, 5133.281340612308, 5138.458462461265, 5146.871328216792, 5070.264811602316, 5077.593792496601, 5104.106781313274, 5105.566026887719, 5119.795208191668, 3796.6013568575318, 3908.8664287356632, 4000.119973605802, 4005.799710014502, 4016.6385025347713, 4003.7988603419003, 4014.2172276406113, 4021.4571032910476, 4035.071933455307, 4035.3139966205667, 4006.559278479365, 4011.2178125265586, 4011.799410029487, 4012.498437695288, 4052.5542190359038, 3749.9625003750157, 3966.5636779954184, 3969.206158768258, 4025.778582177979, 4027.7180597358197, 3460.3944309745693, 3470.4794280857823, 3475.322312149132, 3489.7906125632544, 3496.9125771855906, 4871.634627402959, 4948.282499037656, 4954.885150841068, 4961.8511444656715, 4974.0, 4241.660667146652, 4434.2905135178535, 4529.886752831206, 4535.591796738277, 4569.606270087622, 5289.814856480043, 5312.92030619541, 5319.680819150824, 5322.1484562470205, 5336.199570064483, 3735.6637902588627, 3755.3615885299564, 3759.154190307186, 3764.360058789985, 3778.4332350147697, 5359.517643412073, 5593.965116453469, 5596.440355964371, 5604.439556044404, 5622.662640241599, 3854.2869569129803, 3861.7489863158803, 3863.9613603864163, 3871.341871881787, 3871.8064096795047, 3918.45141680165, 3938.822752976123, 3944.3886197639413, 3944.9013774655864, 3956.7338451695755, 4490.932636010462, 4501.347304640809, 4512.887177820581, 4517.457905051415, 4546.613028160243, 5222.477752224823, 5268.683878967274, 5295.814646487354, 5299.6290259681455, 5384.9730751346, 1343.7446885091802, 1352.614504866128, 1356.3692882809542, 1363.863613638648, 1366.1079405023916, 840.4579046515086, 851.0170752780548, 863.7970077031893, 872.816708491224, 874.2568816505919, 4599.126166028444, 4629.953700463019, 4635.188841952645, 4646.651501137429, 4689.835855745033, 5361.919571206435, 5364.91952620711, 5408.540274076748, 5410.161424979135, 5412.729363531807, 4488.820447182076, 4609.953900460952, 4613.5847773700525, 4616.538346165424, 4633.633078241859, 2869.8332758766996, 2895.334073163142, 2895.724906133914, 2906.956395654067, 2929.9121026368816, 5083.119245878975, 5086.745662716849, 5091.796328146833, 5117.002184573972, 5134.178531434953, 5368.463153684678, 5566.749496272678, 5572.777088916479, 5698.344690360579, 5709.371969083398, 5141.820036298712, 5177.611679124081, 5187.144121220032, 5205.973970130125, 5213.218017297284, 5554.888902221852, 5559.16612508127, 5562.527185189304, 5592.7762889483965, 5603.915941260802, 5227.947720522746, 5414.485623865727, 5422.295101636762, 5447.291852059207, 5493.587980901369, 5180.663256888291, 5232.555232805102, 5284.735763211901, 5287.920681189708, 5324.8935021298585, 3846.769193848378, 3867.1298957734284, 3900.0444891001885, 3907.3943538751537, 3916.2950668878734, 5350.277712508761, 5477.863053423696, 5479.808206712746, 5558.166275058774, 5597.972010139923, 5354.384245811626, 5372.2747429098135, 5374.435684253097, 5393.19328025116, 5398.838034858961, 5146.459621739664, 5289.968456151014, 5383.892322153613, 5384.246205531307, 5418.268533747893, 5284.41871394154, 5292.682439053669, 5295.179247216687, 5329.333833270841, 5350.759215835375, 5144.356955380577, 5272.340957380327, 5421.5933804964, 5433.782648694166, 5438.211459338453, 5296.126139186991, 5305.442928492453, 5321.36143662763, 5336.78652853897, 5380.986647477425], "value": 4015.1152899720955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.3876955661681, 713.0195980526776, 727.7343769524124, 744.8659241336558, 761.9276168763968, 12696.61910142696, 12840.1011929165, 12857.5499857505, 12897.484100635964, 12900.483980640764, 12754.872451275485, 12985.155964862277, 13004.0, 13009.544665936693, 13214.801777973338, 622.757124721359, 755.2032605601089, 790.4466873188762, 791.6991543213571, 793.9047314322289, 792.2157064506155, 795.2087672765606, 796.1759578835906, 798.648594618369, 799.4963173200904, 824.2952275804191, 828.105645902427, 828.2959484438239, 828.9171082891693, 835.757630287216, 818.3126174013827, 819.9139090395541, 825.5542007316042, 826.6693322670919, 828.2380210206625, 605.8848818724429, 610.4292486525113, 610.4414460768392, 613.037531076206, 614.5176036811126, 13575.0, 13737.107088039245, 13774.380152893144, 13803.17180969145, 13845.792313115311, 13076.673083172902, 13413.0, 13582.0, 13630.318484075757, 13815.309234538334, 10156.796864062751, 10176.0, 10364.17086633075, 10367.274290799647, 10469.162467002698, 3377.172592714776, 3416.760826742129, 3426.5031570422398, 3426.7429942754393, 3430.2281986553076, 59522.70238648822, 60247.0, 60382.69808650973, 62097.689511552606, 62383.688081559754, 9484.336096473318, 9902.306838521234, 10236.795264094826, 10277.229207809443, 10523.52644131016, 17244.827551724575, 17311.0, 17473.650526989644, 17518.474445766646, 17540.473785786446, 6779.15260592426, 6792.049113124167, 6893.310668933167, 6950.756723514653, 6983.057287266256, 3847.846086156578, 3876.8449262029767, 3883.7475564088245, 3893.844246230176, 3942.766931116514, 2835.617191679138, 2904.302967287878, 2906.4041871416307, 2908.0, 2933.8826446941885, 497.1846172277468, 502.62554396974485, 508.4153223792668, 512.1805111821056, 513.5788653304329, 444.3334997503744, 485.51691067388174, 496.6771598460957, 508.1767536590747, 520.4254602047956, 7048.964755176191, 7119.288071192839, 7160.283971602902, 7206.135263768381, 7282.453815963824, 462.2788450017983, 474.71517089745873, 487.30660953188095, 497.25411882176735, 579.322193034151, 3635.9636403636155, 3666.2484190740834, 3690.391085470921, 3782.130110074698, 3977.085270387769, 54019.72990135024, 54562.72718636461, 91342.54328728314, 94176.52911735397, 94176.52911735397, 80391.0, 84085.57957210175, 84335.0, 84774.57612711897, 85681.0, 70536.0, 70601.2939870605, 71068.64465677639, 72358.82923512303, 72464.63767681233, 7269.491135620668, 7310.6710198040155, 7581.166071732216, 7596.202398748273, 7615.619219039137, 36275.81862090673, 42055.36916946187, 42145.36781948335, 42149.36775948302, 43034.35448468338, 54374.728126359114, 56070.71964640151, 56241.0, 61119.0, 62548.374516254255, 10736.838947415952, 10865.945670271598, 10957.178211634318, 11215.868984892844, 11345.0, 12772.1059525836, 12842.807357889453, 13041.478340866259, 13074.28091454941, 13690.110142841082, 11697.766044679229, 12133.939330303292, 12196.81704774447, 12257.38713064361, 12306.630801075982, 11188.66434006981, 11453.713657158638, 12038.458269377725, 12246.081543884422, 12504.437300321326, 10140.949295253477, 11418.31490110596, 11583.362915039754, 11761.176717629683, 12112.515499379926, 9473.952630236805, 9683.32216744821, 9791.0, 9809.509524523888, 9882.357646752938, 9611.183049440875, 9689.563969621526, 9908.653197138066, 9927.801443970935, 9982.60069597208], "value": 6396.438574922984, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 113.0, 118.0, 113.0, 115.0, 113.0, 114.0, 112.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 158.0, 187.0, 133.0, 154.0, 157.0, 140.0, 179.0, 134.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 173.0, 166.0, 166.0, 163.0, 161.0, 164.0, 164.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 80.0, 163.0, 76.0, 76.0, 76.0, 76.0, 161.0, 79.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 149.0, 86.0, 87.0, 86.0, 138.0, 86.0, 85.0, 137.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 120.0, 117.0, 119.0, 118.0, 118.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 148.0, 147.0, 152.0, 147.0, 149.0, 147.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 97.0, 97.0, 95.0, 97.0, 95.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 64.0, 65.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 84.0, 90.0, 84.0, 85.0, 84.0, 84.0, 117.0, 83.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 140.0, 143.0, 131.0, 128.0, 133.0, 141.0, 134.0, 161.0, 136.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 170.0, 174.0, 172.0, 170.0, 166.0, 175.0, 173.0, 167.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 70.0, 66.0, 66.0, 68.0, 66.0, 66.0], "value": 67.4, "unit": "score"}]}]} 17:52:13 INFO - Return code: 0 17:52:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:52:13 ERROR - # TBPL SUCCESS # 17:52:13 INFO - Running post-action listener: _resource_record_post_action 17:52:13 INFO - ##### 17:52:13 INFO - ##### Finished run-tests step (success) 17:52:13 INFO - ##### 17:52:13 INFO - Running post-run listener: _resource_record_post_run 17:52:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7782400; Write bytes: 452939776; Read time: 1568; Write time: 483308 17:52:13 INFO - TinderboxPrint: CPU usage
13.4% 17:52:13 INFO - TinderboxPrint: I/O read bytes / time
7,782,400 / 1,568 17:52:13 INFO - TinderboxPrint: I/O write bytes / time
452,939,776 / 483,308 17:52:13 INFO - TinderboxPrint: CPU idle
8,300.8 (86.6%) 17:52:13 INFO - TinderboxPrint: CPU user
1,229.1 (12.8%) 17:52:13 INFO - TinderboxPrint: Swap in / out
0 / 0 17:52:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20254720; Read time: 0; Write time: 7064 17:52:13 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 6021120; Write bytes: 432685056; Read time: 1512; Write time: 476244 17:52:13 INFO - Running post-run listener: _upload_blobber_files 17:52:13 INFO - Blob upload gear active. 17:52:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:52:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:52:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:52:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:52:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:52:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:52:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:52:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:15 INFO - (blobuploader) - INFO - Done attempting. 17:52:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:52:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:18 INFO - (blobuploader) - INFO - Done attempting. 17:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:52:19 INFO - (blobuploader) - INFO - Done attempting. 17:52:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:52:19 INFO - Return code: 0 17:52:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:52:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:52:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb4e0f1348d928f1a80b4f2afd1c1de2f2106ceb69a96e0094e7a12f7b3bc9b89d8b7265f12da707fbe710ed625c893e616798f6dca685ea177f8542d1ba897f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3abc236b50b399f35f595cb1c5a847da6807450f95a1b7c753358f39bed83b7e20423b28657fdafd055c308926bafab9fe0516e9ec2c6488b7c3b9c890bf629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea161e89df06f0f545c495446cc444d82c8ef7eaff506494e4e1550eec4b8d86d07043bfec81bfb6ce418bc7a21a710c0b0ab3e532263fae247919f0d4f8ada4"} 17:52:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:52:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:52:19 INFO - Contents: 17:52:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/eb4e0f1348d928f1a80b4f2afd1c1de2f2106ceb69a96e0094e7a12f7b3bc9b89d8b7265f12da707fbe710ed625c893e616798f6dca685ea177f8542d1ba897f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3abc236b50b399f35f595cb1c5a847da6807450f95a1b7c753358f39bed83b7e20423b28657fdafd055c308926bafab9fe0516e9ec2c6488b7c3b9c890bf629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea161e89df06f0f545c495446cc444d82c8ef7eaff506494e4e1550eec4b8d86d07043bfec81bfb6ce418bc7a21a710c0b0ab3e532263fae247919f0d4f8ada4"} 17:52:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:52:19 INFO - Copying logs to upload dir... 17:52:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:52:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.396391 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-13 17:52:19.170164) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 17:52:19.174065) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000 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-Non-PGO/sha512/eb4e0f1348d928f1a80b4f2afd1c1de2f2106ceb69a96e0094e7a12f7b3bc9b89d8b7265f12da707fbe710ed625c893e616798f6dca685ea177f8542d1ba897f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3abc236b50b399f35f595cb1c5a847da6807450f95a1b7c753358f39bed83b7e20423b28657fdafd055c308926bafab9fe0516e9ec2c6488b7c3b9c890bf629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea161e89df06f0f545c495446cc444d82c8ef7eaff506494e4e1550eec4b8d86d07043bfec81bfb6ce418bc7a21a710c0b0ab3e532263fae247919f0d4f8ada4"} build_url:https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/IPfWQNepT-CS0HMfalRmIA/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-Non-PGO/sha512/eb4e0f1348d928f1a80b4f2afd1c1de2f2106ceb69a96e0094e7a12f7b3bc9b89d8b7265f12da707fbe710ed625c893e616798f6dca685ea177f8542d1ba897f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e3abc236b50b399f35f595cb1c5a847da6807450f95a1b7c753358f39bed83b7e20423b28657fdafd055c308926bafab9fe0516e9ec2c6488b7c3b9c890bf629", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ea161e89df06f0f545c495446cc444d82c8ef7eaff506494e4e1550eec4b8d86d07043bfec81bfb6ce418bc7a21a710c0b0ab3e532263fae247919f0d4f8ada4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 17:52:19.200472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:52:19.200817) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465863247.747338-1996400000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:52:19.282449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 17:52:19.282774) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 17:52:19.283065) ========= ========= Total master_lag: 0.15 =========