builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-036 starttime: 1465561225.51 results: success (0) buildid: 20160610044828 builduid: 62dbb54c4a5a42c3988caf91568269fa revision: 151500c01e44846223acb5bfcb4dcd2123e620c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.514368) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.514893) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.515266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.532346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.532626) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 05:20: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% 50.3M=0s 2016-06-10 05:20:25 (50.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124510 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.678227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.678551) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017098 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.728286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.728597) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 151500c01e44846223acb5bfcb4dcd2123e620c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 151500c01e44846223acb5bfcb4dcd2123e620c5 --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=14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 05:20:25,802 truncating revision to first 12 chars 2016-06-10 05:20:25,802 Setting DEBUG logging. 2016-06-10 05:20:25,802 attempt 1/10 2016-06-10 05:20:25,802 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/151500c01e44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 05:20:26,121 unpacking tar archive at: fx-team-151500c01e44/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644301 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.487465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.487945) ========= script_repo_revision: 151500c01e44846223acb5bfcb4dcd2123e620c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.488743) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.489040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.505434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-10 05:20:26.505710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:26 INFO - MultiFileLogger online at 20160610 05:20:26 in /builds/slave/test 05:20:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:20:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:26 INFO - {'append_to_log': False, 05:20:26 INFO - 'base_work_dir': '/builds/slave/test', 05:20:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:20:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:26 INFO - 'branch': 'Fx-Team-Non-PGO', 05:20:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:26 INFO - 'config_files': ('talos/linux_config.py',), 05:20:26 INFO - 'default_actions': ('clobber', 05:20:26 INFO - 'read-buildbot-config', 05:20:26 INFO - 'download-and-extract', 05:20:26 INFO - 'populate-webroot', 05:20:26 INFO - 'create-virtualenv', 05:20:26 INFO - 'install', 05:20:26 INFO - 'run-tests'), 05:20:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:26 INFO - 'download_minidump_stackwalk': True, 05:20:26 INFO - 'download_symbols': 'ondemand', 05:20:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:26 INFO - 'installer_path': 'installer.exe', 05:20:26 INFO - 'log_level': 'info', 05:20:26 INFO - 'log_name': 'talos', 05:20:26 INFO - 'log_to_console': True, 05:20:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:26 INFO - 'opt_config_files': (), 05:20:26 INFO - 'pip_index': False, 05:20:26 INFO - 'sps_profile': False, 05:20:26 INFO - 'sps_profile_interval': 0, 05:20:26 INFO - 'suite': 'dromaeojs-e10s', 05:20:26 INFO - 'system_bits': '32', 05:20:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:26 INFO - 'title': 'talos-linux64-ix-036', 05:20:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:26 INFO - 'use_talos_json': True, 05:20:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:26 INFO - 'work_dir': 'build'} 05:20:26 INFO - ##### 05:20:26 INFO - ##### Running clobber step. 05:20:26 INFO - ##### 05:20:26 INFO - Running pre-action listener: _resource_record_pre_action 05:20:26 INFO - Running main action method: clobber 05:20:26 INFO - rmtree: /builds/slave/test/build 05:20:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:27 INFO - Running post-action listener: _resource_record_post_action 05:20:27 INFO - ##### 05:20:27 INFO - ##### Finished clobber step (success) 05:20:27 INFO - ##### 05:20:27 INFO - ##### 05:20:27 INFO - ##### Running read-buildbot-config step. 05:20:27 INFO - ##### 05:20:27 INFO - Running pre-action listener: _resource_record_pre_action 05:20:27 INFO - Running main action method: read_buildbot_config 05:20:27 INFO - Using buildbot properties: 05:20:27 INFO - { 05:20:27 INFO - "project": "", 05:20:27 INFO - "product": "firefox", 05:20:27 INFO - "script_repo_revision": "production", 05:20:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:20:27 INFO - "repository": "", 05:20:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:20:27 INFO - "buildid": "20160610044828", 05:20:27 INFO - "pgo_build": "False", 05:20:27 INFO - "basedir": "/builds/slave/test", 05:20:27 INFO - "buildnumber": 1361, 05:20:27 INFO - "slavename": "talos-linux64-ix-036", 05:20:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:20:27 INFO - "platform": "ubuntu64_hw", 05:20:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:20:27 INFO - "branch": "fx-team", 05:20:27 INFO - "repo_path": "integration/fx-team", 05:20:27 INFO - "revision": "151500c01e44846223acb5bfcb4dcd2123e620c5", 05:20:27 INFO - "stage_platform": "linux64", 05:20:27 INFO - "builduid": "62dbb54c4a5a42c3988caf91568269fa", 05:20:27 INFO - "slavebuilddir": "test" 05:20:27 INFO - } 05:20:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:20:27 INFO - Running post-action listener: _resource_record_post_action 05:20:27 INFO - ##### 05:20:27 INFO - ##### Finished read-buildbot-config step (success) 05:20:27 INFO - ##### 05:20:27 INFO - ##### 05:20:27 INFO - ##### Running download-and-extract step. 05:20:27 INFO - ##### 05:20:27 INFO - Running pre-action listener: _resource_record_pre_action 05:20:27 INFO - Running main action method: download_and_extract 05:20:27 INFO - mkdir: /builds/slave/test/build/tests 05:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:27 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:20:31 INFO - Downloaded 1361 bytes. 05:20:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:31 INFO - Using the following test package requirements: 05:20:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'jsshell-linux-x86_64.zip'], 05:20:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20: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')]} 05:20:31 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:32 INFO - Downloaded 22879686 bytes. 05:20:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:34 INFO - Return code: 0 05:20:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:34 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:35 INFO - Downloaded 22879686 bytes. 05:20:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:37 INFO - Return code: 0 05:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:37 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:20:39 INFO - Downloaded 10833377 bytes. 05:20:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:20:39 INFO - Return code: 0 05:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:39 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:20:41 INFO - Downloaded 55378716 bytes. 05:20:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:41 INFO - mkdir: /builds/slave/test/properties 05:20:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:41 INFO - Contents: 05:20:41 INFO - build_url:https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:42 INFO - Running post-action listener: _resource_record_post_action 05:20:42 INFO - Running post-action listener: set_extra_try_arguments 05:20:42 INFO - ##### 05:20:42 INFO - ##### Finished download-and-extract step (success) 05:20:42 INFO - ##### 05:20:42 INFO - ##### 05:20:42 INFO - ##### Running populate-webroot step. 05:20:42 INFO - ##### 05:20:42 INFO - Running pre-action listener: _resource_record_pre_action 05:20:42 INFO - Running main action method: populate_webroot 05:20:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:42 INFO - '--tppagecycles', 05:20:42 INFO - '7'], 05:20:42 INFO - 'tests': ['tsvgm']}}, 05:20:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['damp', 'tps']}, 05:20:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'tests': ['damp', 'tps']}, 05:20:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['dromaeo_dom']}, 05:20:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['a11yr', 05:20:42 INFO - 'ts_paint', 05:20:42 INFO - 'tpaint', 05:20:42 INFO - 'sessionrestore', 05:20:42 INFO - 'sessionrestore_no_auto_restore', 05:20:42 INFO - 'tabpaint']}, 05:20:42 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:42 INFO - 'ts_paint', 05:20:42 INFO - 'tpaint', 05:20:42 INFO - 'sessionrestore', 05:20:42 INFO - 'sessionrestore_no_auto_restore', 05:20:42 INFO - 'tabpaint']}, 05:20:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:42 INFO - 'ts_paint', 05:20:42 INFO - 'tpaint', 05:20:42 INFO - 'sessionrestore', 05:20:42 INFO - 'sessionrestore_no_auto_restore', 05:20:42 INFO - 'tabpaint']}, 05:20:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:42 INFO - 'ts_paint', 05:20:42 INFO - 'tpaint', 05:20:42 INFO - 'sessionrestore', 05:20:42 INFO - 'sessionrestore_no_auto_restore', 05:20:42 INFO - 'tabpaint']}, 05:20:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['a11yr', 05:20:42 INFO - 'ts_paint', 05:20:42 INFO - 'tpaint', 05:20:42 INFO - 'sessionrestore', 05:20:42 INFO - 'sessionrestore_no_auto_restore', 05:20:42 INFO - 'tabpaint']}, 05:20:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['a11yr', 05:20:42 INFO - 'ts_paint', 05:20:42 INFO - 'tpaint', 05:20:42 INFO - 'sessionrestore', 05:20:42 INFO - 'sessionrestore_no_auto_restore', 05:20:42 INFO - 'tabpaint']}, 05:20:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['tsvgx', 05:20:42 INFO - 'tsvgr_opacity', 05:20:42 INFO - 'tart', 05:20:42 INFO - 'tscrollx', 05:20:42 INFO - 'cart']}, 05:20:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:42 INFO - 'tsvgr_opacity', 05:20:42 INFO - 'tart', 05:20:42 INFO - 'tscrollx', 05:20:42 INFO - 'cart']}, 05:20:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'talos_options': ['--disable-e10s'], 05:20:42 INFO - 'tests': ['tp5o']}, 05:20:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'tests': ['tp5o']}, 05:20:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'talos_options': ['--disable-e10s', 05:20:42 INFO - '--xperf_path', 05:20:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:42 INFO - 'tests': ['tp5n']}, 05:20:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:42 INFO - 'talos_options': ['--xperf_path', 05:20:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:42 INFO - 'tests': ['tp5n']}}, 05:20:42 INFO - 'talos.zip': {'path': '', 05:20:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:42 INFO - Running post-action listener: _resource_record_post_action 05:20:42 INFO - ##### 05:20:42 INFO - ##### Finished populate-webroot step (success) 05:20:42 INFO - ##### 05:20:42 INFO - ##### 05:20:42 INFO - ##### Running create-virtualenv step. 05:20:42 INFO - ##### 05:20:42 INFO - Running pre-action listener: _resource_record_pre_action 05:20:42 INFO - Running main action method: create_virtualenv 05:20:42 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20: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 05:20:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:42 INFO - Using real prefix '/usr' 05:20:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:45 INFO - Installing pip.................done. 05:20:45 INFO - Return code: 0 05:20:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:45 INFO - Using env: {'DISPLAY': ':0', 05:20:45 INFO - 'HOME': '/home/cltbld', 05:20:45 INFO - 'LANG': 'en_US.UTF-8', 05:20:45 INFO - 'LANGUAGE': 'en_US:en', 05:20:45 INFO - 'LOGNAME': 'cltbld', 05:20:45 INFO - 'MAIL': '/var/mail/cltbld', 05:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:45 INFO - 'MOZ_NO_REMOTE': '1', 05:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:45 INFO - 'NO_EM_RESTART': '1', 05:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:45 INFO - 'PWD': '/builds/slave/test', 05:20:45 INFO - 'SHELL': '/bin/bash', 05:20:45 INFO - 'SHLVL': '1', 05:20:45 INFO - 'TERM': 'linux', 05:20:45 INFO - 'TMOUT': '86400', 05:20:45 INFO - 'USER': 'cltbld', 05:20:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:45 INFO - '_': '/tools/buildbot/bin/python'} 05:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:20:45 INFO - Cleaning up... 05:20:45 INFO - Return code: 0 05:20:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:20:45 INFO - Using env: {'DISPLAY': ':0', 05:20:45 INFO - 'HOME': '/home/cltbld', 05:20:45 INFO - 'LANG': 'en_US.UTF-8', 05:20:45 INFO - 'LANGUAGE': 'en_US:en', 05:20:45 INFO - 'LOGNAME': 'cltbld', 05:20:45 INFO - 'MAIL': '/var/mail/cltbld', 05:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:45 INFO - 'MOZ_NO_REMOTE': '1', 05:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:45 INFO - 'NO_EM_RESTART': '1', 05:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:45 INFO - 'PWD': '/builds/slave/test', 05:20:45 INFO - 'SHELL': '/bin/bash', 05:20:45 INFO - 'SHLVL': '1', 05:20:45 INFO - 'TERM': 'linux', 05:20:45 INFO - 'TMOUT': '86400', 05:20:45 INFO - 'USER': 'cltbld', 05:20:45 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:45 INFO - '_': '/tools/buildbot/bin/python'} 05:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:45 INFO - Downloading/unpacking psutil>=3.1.1 05:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:47 INFO - Installing collected packages: psutil 05:20:47 INFO - Running setup.py install for psutil 05:20:47 INFO - building 'psutil._psutil_linux' extension 05:20:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:20:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:20:47 INFO - building 'psutil._psutil_posix' extension 05:20:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:20:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:20:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:47 INFO - Successfully installed psutil 05:20:47 INFO - Cleaning up... 05:20:48 INFO - Return code: 0 05:20:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:48 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 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:20:48 INFO - Using env: {'DISPLAY': ':0', 05:20:48 INFO - 'HOME': '/home/cltbld', 05:20:48 INFO - 'LANG': 'en_US.UTF-8', 05:20:48 INFO - 'LANGUAGE': 'en_US:en', 05:20:48 INFO - 'LOGNAME': 'cltbld', 05:20:48 INFO - 'MAIL': '/var/mail/cltbld', 05:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:48 INFO - 'MOZ_NO_REMOTE': '1', 05:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:48 INFO - 'NO_EM_RESTART': '1', 05:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:48 INFO - 'PWD': '/builds/slave/test', 05:20:48 INFO - 'SHELL': '/bin/bash', 05:20:48 INFO - 'SHLVL': '1', 05:20:48 INFO - 'TERM': 'linux', 05:20:48 INFO - 'TMOUT': '86400', 05:20:48 INFO - 'USER': 'cltbld', 05:20:48 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:48 INFO - '_': '/tools/buildbot/bin/python'} 05:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:20:50 INFO - Installing collected packages: mozsystemmonitor 05:20:50 INFO - Running setup.py install for mozsystemmonitor 05:20:50 INFO - Successfully installed mozsystemmonitor 05:20:50 INFO - Cleaning up... 05:20:50 INFO - Return code: 0 05:20:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:50 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 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:20:50 INFO - Using env: {'DISPLAY': ':0', 05:20:50 INFO - 'HOME': '/home/cltbld', 05:20:50 INFO - 'LANG': 'en_US.UTF-8', 05:20:50 INFO - 'LANGUAGE': 'en_US:en', 05:20:50 INFO - 'LOGNAME': 'cltbld', 05:20:50 INFO - 'MAIL': '/var/mail/cltbld', 05:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:50 INFO - 'MOZ_NO_REMOTE': '1', 05:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:50 INFO - 'NO_EM_RESTART': '1', 05:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:50 INFO - 'PWD': '/builds/slave/test', 05:20:50 INFO - 'SHELL': '/bin/bash', 05:20:50 INFO - 'SHLVL': '1', 05:20:50 INFO - 'TERM': 'linux', 05:20:50 INFO - 'TMOUT': '86400', 05:20:50 INFO - 'USER': 'cltbld', 05:20:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:50 INFO - '_': '/tools/buildbot/bin/python'} 05:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:50 INFO - Downloading/unpacking jsonschema==2.5.1 05:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:52 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:52 INFO - warning: no files found matching '*.txt' 05:20:52 INFO - no previously-included directories found matching 'build' 05:20:52 INFO - no previously-included directories found matching 'dist' 05:20:52 INFO - no previously-included directories found matching '.git*' 05:20:52 INFO - Installing collected packages: jsonschema, functools32 05:20:52 INFO - Running setup.py install for functools32 05:20:52 INFO - warning: no files found matching '*.txt' 05:20:52 INFO - no previously-included directories found matching 'build' 05:20:52 INFO - no previously-included directories found matching 'dist' 05:20:52 INFO - no previously-included directories found matching '.git*' 05:20:52 INFO - Successfully installed jsonschema functools32 05:20:52 INFO - Cleaning up... 05:20:52 INFO - Return code: 0 05:20:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:52 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 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:20:52 INFO - Using env: {'DISPLAY': ':0', 05:20:52 INFO - 'HOME': '/home/cltbld', 05:20:52 INFO - 'LANG': 'en_US.UTF-8', 05:20:52 INFO - 'LANGUAGE': 'en_US:en', 05:20:52 INFO - 'LOGNAME': 'cltbld', 05:20:52 INFO - 'MAIL': '/var/mail/cltbld', 05:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:52 INFO - 'MOZ_NO_REMOTE': '1', 05:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:52 INFO - 'NO_EM_RESTART': '1', 05:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:52 INFO - 'PWD': '/builds/slave/test', 05:20:52 INFO - 'SHELL': '/bin/bash', 05:20:52 INFO - 'SHLVL': '1', 05:20:52 INFO - 'TERM': 'linux', 05:20:52 INFO - 'TMOUT': '86400', 05:20:52 INFO - 'USER': 'cltbld', 05:20:52 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:52 INFO - '_': '/tools/buildbot/bin/python'} 05:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:55 INFO - Downloading docopt-0.6.1.tar.gz 05:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:55 INFO - Running setup.py install for blobuploader 05:20:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:55 INFO - Running setup.py install for requests 05:20:56 INFO - Running setup.py install for docopt 05:20:56 INFO - Successfully installed blobuploader requests docopt 05:20:56 INFO - Cleaning up... 05:20:56 INFO - Return code: 0 05:20:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:56 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 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:56 INFO - Using env: {'DISPLAY': ':0', 05:20:56 INFO - 'HOME': '/home/cltbld', 05:20:56 INFO - 'LANG': 'en_US.UTF-8', 05:20:56 INFO - 'LANGUAGE': 'en_US:en', 05:20:56 INFO - 'LOGNAME': 'cltbld', 05:20:56 INFO - 'MAIL': '/var/mail/cltbld', 05:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:56 INFO - 'MOZ_NO_REMOTE': '1', 05:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:56 INFO - 'NO_EM_RESTART': '1', 05:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:56 INFO - 'PWD': '/builds/slave/test', 05:20:56 INFO - 'SHELL': '/bin/bash', 05:20:56 INFO - 'SHLVL': '1', 05:20:56 INFO - 'TERM': 'linux', 05:20:56 INFO - 'TMOUT': '86400', 05:20:56 INFO - 'USER': 'cltbld', 05:20:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:56 INFO - '_': '/tools/buildbot/bin/python'} 05:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:56 INFO - Running setup.py (path:/tmp/pip-S57Lz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:56 INFO - Running setup.py (path:/tmp/pip-QB4Xhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:56 INFO - Running setup.py (path:/tmp/pip-7Iq_XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:56 INFO - Running setup.py (path:/tmp/pip-9_KhAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:56 INFO - Running setup.py (path:/tmp/pip-fWm1IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:56 INFO - Running setup.py (path:/tmp/pip-raF4yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:57 INFO - Running setup.py (path:/tmp/pip-agSPGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:57 INFO - Running setup.py (path:/tmp/pip-QBbkWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:57 INFO - Running setup.py (path:/tmp/pip-renTJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:57 INFO - Running setup.py (path:/tmp/pip-q4lwhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:57 INFO - Running setup.py (path:/tmp/pip-2Tc0l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:57 INFO - Running setup.py (path:/tmp/pip-EAeJ9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:57 INFO - Running setup.py (path:/tmp/pip-sx9NTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:57 INFO - Running setup.py (path:/tmp/pip-vir7uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:57 INFO - Running setup.py (path:/tmp/pip-gqQSsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:57 INFO - Running setup.py (path:/tmp/pip-iQLmgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:57 INFO - Running setup.py (path:/tmp/pip-hDL7si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:57 INFO - Running setup.py install for manifestparser 05:20:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:57 INFO - Running setup.py install for mozcrash 05:20:58 INFO - Running setup.py install for mozdebug 05:20:58 INFO - Running setup.py install for mozdevice 05:20:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Running setup.py install for mozfile 05:20:58 INFO - Running setup.py install for mozhttpd 05:20:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Running setup.py install for mozinfo 05:20:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Running setup.py install for mozInstall 05:20:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Running setup.py install for mozleak 05:20:58 INFO - Running setup.py install for mozlog 05:20:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Running setup.py install for moznetwork 05:20:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:58 INFO - Running setup.py install for mozprocess 05:20:59 INFO - Running setup.py install for mozprofile 05:20:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:59 INFO - Running setup.py install for mozrunner 05:20:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:59 INFO - Running setup.py install for mozscreenshot 05:20:59 INFO - Running setup.py install for moztest 05:20:59 INFO - Running setup.py install for mozversion 05:20:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:59 INFO - Cleaning up... 05:20:59 INFO - Return code: 0 05:20:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:59 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 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:20:59 INFO - Using env: {'DISPLAY': ':0', 05:20:59 INFO - 'HOME': '/home/cltbld', 05:20:59 INFO - 'LANG': 'en_US.UTF-8', 05:20:59 INFO - 'LANGUAGE': 'en_US:en', 05:20:59 INFO - 'LOGNAME': 'cltbld', 05:20:59 INFO - 'MAIL': '/var/mail/cltbld', 05:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:59 INFO - 'MOZ_NO_REMOTE': '1', 05:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:59 INFO - 'NO_EM_RESTART': '1', 05:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:59 INFO - 'PWD': '/builds/slave/test', 05:20:59 INFO - 'SHELL': '/bin/bash', 05:20:59 INFO - 'SHLVL': '1', 05:20:59 INFO - 'TERM': 'linux', 05:20:59 INFO - 'TMOUT': '86400', 05:20:59 INFO - 'USER': 'cltbld', 05:20:59 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:59 INFO - '_': '/tools/buildbot/bin/python'} 05:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:59 INFO - Running setup.py (path:/tmp/pip-hcR8Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:59 INFO - Running setup.py (path:/tmp/pip-Tia81N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:59 INFO - Running setup.py (path:/tmp/pip-FGz3SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:00 INFO - Running setup.py (path:/tmp/pip-vUT8On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:00 INFO - Running setup.py (path:/tmp/pip-g0CTI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:00 INFO - Running setup.py (path:/tmp/pip-XhESTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:00 INFO - Running setup.py (path:/tmp/pip-Ri5DVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:00 INFO - Running setup.py (path:/tmp/pip-nC4DgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:00 INFO - Running setup.py (path:/tmp/pip-H5u9j5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:00 INFO - Running setup.py (path:/tmp/pip-C_sZEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:00 INFO - Running setup.py (path:/tmp/pip-_bwaQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:00 INFO - Running setup.py (path:/tmp/pip-4Gi9k3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:00 INFO - Running setup.py (path:/tmp/pip-Jz8h4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:00 INFO - Running setup.py (path:/tmp/pip-Y_7c12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:00 INFO - Running setup.py (path:/tmp/pip-yTSCZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:00 INFO - Running setup.py (path:/tmp/pip-6zUvLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:00 INFO - Running setup.py (path:/tmp/pip-LIqAtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:02 INFO - Downloading blessings-1.6.tar.gz 05:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:03 INFO - Installing collected packages: blessings 05:21:03 INFO - Running setup.py install for blessings 05:21:03 INFO - Successfully installed blessings 05:21:03 INFO - Cleaning up... 05:21:03 INFO - Return code: 0 05:21:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:03 INFO - Reading from file tmpfile_stdout 05:21:03 INFO - Current package versions: 05:21:03 INFO - argparse == 1.2.1 05:21:03 INFO - blessings == 1.6 05:21:03 INFO - blobuploader == 1.2.4 05:21:03 INFO - docopt == 0.6.1 05:21:03 INFO - functools32 == 3.2.3-2 05:21:03 INFO - jsonschema == 2.5.1 05:21:03 INFO - manifestparser == 1.1 05:21:03 INFO - mozInstall == 1.12 05:21:03 INFO - mozcrash == 0.17 05:21:03 INFO - mozdebug == 0.1 05:21:03 INFO - mozdevice == 0.48 05:21:03 INFO - mozfile == 1.2 05:21:03 INFO - mozhttpd == 0.7 05:21:03 INFO - mozinfo == 0.9 05:21:03 INFO - mozleak == 0.1 05:21:03 INFO - mozlog == 3.2 05:21:03 INFO - moznetwork == 0.27 05:21:03 INFO - mozprocess == 0.22 05:21:03 INFO - mozprofile == 0.28 05:21:03 INFO - mozrunner == 6.11 05:21:03 INFO - mozscreenshot == 0.1 05:21:03 INFO - mozsystemmonitor == 0.3 05:21:03 INFO - moztest == 0.7 05:21:03 INFO - mozversion == 1.4 05:21:03 INFO - psutil == 3.1.1 05:21:03 INFO - requests == 1.2.3 05:21:03 INFO - wsgiref == 0.1.2 05:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 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 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:03 INFO - Using env: {'DISPLAY': ':0', 05:21:03 INFO - 'HOME': '/home/cltbld', 05:21:03 INFO - 'LANG': 'en_US.UTF-8', 05:21:03 INFO - 'LANGUAGE': 'en_US:en', 05:21:03 INFO - 'LOGNAME': 'cltbld', 05:21:03 INFO - 'MAIL': '/var/mail/cltbld', 05:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:03 INFO - 'MOZ_NO_REMOTE': '1', 05:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:03 INFO - 'NO_EM_RESTART': '1', 05:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:03 INFO - 'PWD': '/builds/slave/test', 05:21:03 INFO - 'SHELL': '/bin/bash', 05:21:03 INFO - 'SHLVL': '1', 05:21:03 INFO - 'TERM': 'linux', 05:21:03 INFO - 'TMOUT': '86400', 05:21:03 INFO - 'USER': 'cltbld', 05:21:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:03 INFO - '_': '/tools/buildbot/bin/python'} 05:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:03 INFO - Cleaning up... 05:21:03 INFO - Return code: 0 05:21:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:21:03 INFO - Using env: {'DISPLAY': ':0', 05:21:03 INFO - 'HOME': '/home/cltbld', 05:21:03 INFO - 'LANG': 'en_US.UTF-8', 05:21:03 INFO - 'LANGUAGE': 'en_US:en', 05:21:03 INFO - 'LOGNAME': 'cltbld', 05:21:03 INFO - 'MAIL': '/var/mail/cltbld', 05:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:03 INFO - 'MOZ_NO_REMOTE': '1', 05:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:03 INFO - 'NO_EM_RESTART': '1', 05:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:03 INFO - 'PWD': '/builds/slave/test', 05:21:03 INFO - 'SHELL': '/bin/bash', 05:21:03 INFO - 'SHLVL': '1', 05:21:03 INFO - 'TERM': 'linux', 05:21:03 INFO - 'TMOUT': '86400', 05:21:03 INFO - 'USER': 'cltbld', 05:21:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:03 INFO - '_': '/tools/buildbot/bin/python'} 05:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:21:03 INFO - Cleaning up... 05:21:03 INFO - Return code: 0 05:21:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5f3d190f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1768350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, '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': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:21:03 INFO - Using env: {'DISPLAY': ':0', 05:21:03 INFO - 'HOME': '/home/cltbld', 05:21:03 INFO - 'LANG': 'en_US.UTF-8', 05:21:03 INFO - 'LANGUAGE': 'en_US:en', 05:21:03 INFO - 'LOGNAME': 'cltbld', 05:21:03 INFO - 'MAIL': '/var/mail/cltbld', 05:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:03 INFO - 'MOZ_NO_REMOTE': '1', 05:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:03 INFO - 'NO_EM_RESTART': '1', 05:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:03 INFO - 'PWD': '/builds/slave/test', 05:21:03 INFO - 'SHELL': '/bin/bash', 05:21:03 INFO - 'SHLVL': '1', 05:21:03 INFO - 'TERM': 'linux', 05:21:03 INFO - 'TMOUT': '86400', 05:21:03 INFO - 'USER': 'cltbld', 05:21:03 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:03 INFO - '_': '/tools/buildbot/bin/python'} 05:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:04 INFO - Downloading/unpacking flake8 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:06 INFO - no previously-included directories found matching 'docs/_build' 05:21:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:06 INFO - Running setup.py install for pep8 05:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:06 INFO - no previously-included directories found matching 'docs/_build' 05:21:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:06 INFO - Cleaning up... 05:21:06 INFO - Return code: 0 05:21:06 INFO - Running post-action listener: _resource_record_post_action 05:21:06 INFO - Running post-action listener: _start_resource_monitoring 05:21:06 INFO - Starting resource monitoring. 05:21:06 INFO - ##### 05:21:06 INFO - ##### Finished create-virtualenv step (success) 05:21:06 INFO - ##### 05:21:06 INFO - ##### 05:21:06 INFO - ##### Running install step. 05:21:06 INFO - ##### 05:21:06 INFO - Running pre-action listener: _resource_record_pre_action 05:21:06 INFO - Running main action method: install 05:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:07 INFO - Reading from file tmpfile_stdout 05:21:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:07 INFO - Reading from file tmpfile_stdout 05:21:07 INFO - Output received: 05:21:07 INFO - Usage: mozinstall [options] installer 05:21:07 INFO - Options: 05:21:07 INFO - -h, --help show this help message and exit 05:21:07 INFO - -d DEST, --destination=DEST 05:21:07 INFO - Directory to install application into. [default: 05:21:07 INFO - "/builds/slave/test"] 05:21:07 INFO - --app=APP Application being installed. [default: firefox] 05:21:07 INFO - mkdir: /builds/slave/test/build/application 05:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:21:23 INFO - Reading from file tmpfile_stdout 05:21:23 INFO - Output received: 05:21:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:23 INFO - Running post-action listener: _resource_record_post_action 05:21:23 INFO - ##### 05:21:23 INFO - ##### Finished install step (success) 05:21:23 INFO - ##### 05:21:23 INFO - ##### 05:21:23 INFO - ##### Running run-tests step. 05:21:23 INFO - ##### 05:21:23 INFO - Running pre-action listener: _resource_record_pre_action 05:21:23 INFO - Running main action method: run_tests 05:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:23 INFO - Python 2.7.3 05:21:23 INFO - Return code: 0 05:21:23 INFO - grabbing minidump binary from tooltool 05:21:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:23 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 0x17f71c0>, '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 0x17f80c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17f8550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:21:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:21:23 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:21:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:23 INFO - Return code: 0 05:21:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:21:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:24 INFO - Return code: 0 05:21:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:21:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:21:24 INFO - Using env: {'DISPLAY': ':0', 05:21:24 INFO - 'HOME': '/home/cltbld', 05:21:24 INFO - 'LANG': 'en_US.UTF-8', 05:21:24 INFO - 'LANGUAGE': 'en_US:en', 05:21:24 INFO - 'LOGNAME': 'cltbld', 05:21:24 INFO - 'MAIL': '/var/mail/cltbld', 05:21:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:24 INFO - 'MOZ_NO_REMOTE': '1', 05:21:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:24 INFO - 'NO_EM_RESTART': '1', 05:21:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:24 INFO - 'PWD': '/builds/slave/test', 05:21:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:24 INFO - 'SHELL': '/bin/bash', 05:21:24 INFO - 'SHLVL': '1', 05:21:24 INFO - 'TERM': 'linux', 05:21:24 INFO - 'TMOUT': '86400', 05:21:24 INFO - 'USER': 'cltbld', 05:21:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360', 05:21:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:24 INFO - '_': '/tools/buildbot/bin/python'} 05:21:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:21:24 INFO - mozversion application_buildid: 20160610044828 05:21:24 INFO - mozversion application_changeset: 151500c01e44846223acb5bfcb4dcd2123e620c5 05:21:24 INFO - mozversion application_display_name: Nightly 05:21:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:24 INFO - mozversion application_name: Firefox 05:21:24 INFO - mozversion application_remotingname: firefox 05:21:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:21:24 INFO - mozversion application_vendor: Mozilla 05:21:24 INFO - mozversion application_version: 50.0a1 05:21:24 INFO - mozversion platform_buildid: 20160610044828 05:21:24 INFO - mozversion platform_changeset: 151500c01e44846223acb5bfcb4dcd2123e620c5 05:21:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:21:24 INFO - mozversion platform_version: 50.0a1 05:21:24 INFO - using testdate: 1465561284 05:21:24 INFO - actual date: 1465561284 05:21:24 INFO - starting webserver on 'localhost:59500' 05:21:24 INFO - SUITE-START | Running 2 tests 05:21:24 INFO - TEST-START | dromaeo_css 05:21:24 INFO - operating with platform_type : linux_ 05:21:24 INFO - Initialising browser for dromaeo_css test... 05:21:24 INFO - TEST-INFO | started process 12908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZyQEgK/profile http://localhost:59500/getInfo.html) 05:21:29 INFO - PROCESS | 12908 | __metrics Screen width/height:1600/1200 05:21:29 INFO - PROCESS | 12908 | colorDepth:24 05:21:29 INFO - PROCESS | 12908 | Browser inner width/height: 1024/697 05:21:29 INFO - PROCESS | 12908 | __metrics 05:21:30 ERROR - PROCESS | 12908 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:21:31 INFO - TEST-INFO | 12908: exit 0 05:21:31 INFO - Browser initialized. 05:21:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:31 INFO - TEST-INFO | started process 13027 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZyQEgK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:43 INFO - PROCESS | 13027 | RSS: Main: 185298944 05:21:43 INFO - PROCESS | 13027 | 05:22:32 INFO - PROCESS | 13027 | 1465561352951 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:24:44 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59500/tests/dromaeo/cssquery-ext.html) 05:24:45 INFO - PROCESS | 13027 | RSS: Main: 187842560 05:24:45 INFO - PROCESS | 13027 | 05:27:48 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-ext.html (next: http://localhost:59500/tests/dromaeo/cssquery-jquery.html) 05:27:48 INFO - PROCESS | 13027 | RSS: Main: 186597376 05:27:48 INFO - PROCESS | 13027 | 05:30:50 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59500/tests/dromaeo/cssquery-mootools.html) 05:30:51 INFO - PROCESS | 13027 | RSS: Main: 188215296 05:30:51 INFO - PROCESS | 13027 | 05:33:53 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59500/tests/dromaeo/cssquery-prototype.html) 05:33:53 INFO - PROCESS | 13027 | RSS: Main: 185798656 05:33:53 INFO - PROCESS | 13027 | 05:36:56 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59500/tests/dromaeo/cssquery-yui.html) 05:36:57 INFO - PROCESS | 13027 | RSS: Main: 187494400 05:36:57 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | Cycle 1(1): loaded http://localhost:59500/tests/dromaeo/cssquery-yui.html (next: http://localhost:59500/tests/dromaeo/cssquery-dojo.html) 05:39:59 INFO - PROCESS | 13027 | RSS: Main: 188792832 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | __start_tp_report 05:39:59 INFO - PROCESS | 13027 | _x_x_mozilla_page_load 05:39:59 INFO - PROCESS | 13027 | _x_x_mozilla_page_load_details 05:39:59 INFO - PROCESS | 13027 | |i|pagename|runs| 05:39:59 INFO - PROCESS | 13027 | |0;dojo.html;2625.474905018996;2673.8262012969158;2678.116221646857;2682.8792704328303;2685.7717094046993;4742.454617718963;4761.166795810736;4789.976050119749;4873.293372460991;4901.387326584177;4647.488776234612;4856.660033797635;4881.8291359802415;4907.190313598252;4914.410270767513;4439.844605438819;4483.30508771141;4611.538846115395;4611.930821037688;4637.605803506706;526.0807981278482;4362.367456718774;4414.183376075421;4452.243118669834;4458.5541445855315;4348.521662617094;4439.445069366329;4448.377227188196;4462.732236065814;4490.7530085845265;4435.401220835211;4454.37638730578;4458.687891847572;4460.063386688799;4506.7070640408265;4235;4409.536998615131;4420.403245561873;4423.889402764925;4443.155800397914;4706.10583989041;4842.782074806642;4849.878753031167;4879.024195160982;4923.655344125913;5219.138842091051;5233.842984710464;5236.7905283788605;5243.737813109329;5305.761240744176;5207.921881171786;5239.738013099368;5259.737013149365;5273.736313184326;5279.313689220377;4856.68431551948;4900.240462728283;4901.754912254373;4916.483769204254;4950.034743225036;5153.123968925217;5319.414864364917;5390.4879036491475;5391.838244852661;5395.73021348931;5089.8727531812;5118.053160165381;5133;5155.742212889416;5227.973860130675;5202.97398513005;5220.399654039834;5248.921266181011;5278.261043453919;5306.8407947761625;4991.351124353883;5096.719680417538;5113.181890897438;5124.436312005676;5133.383993920754;5127.333446651912;5143.408508021551;5163.328767260232;5164;5200.531952124251;4399.032212913154;4402.713823601455;4403.625691816232;4420.447444069491;4454.510003899569;3761.5298087739034;3807.7144214183495;3809.952263127607;3825.9617403826164;3845.769253844778;4338.696291259582;4407.294832826797;4412.779361031936;4436.26801577736;4459.1304695584695;5142.922856157161;5179.015986962465;5180.378354597472;5183.144781111075;5233.633645644768;4263.4031235627035;4434.046679963823;4435.6895017349125;4453.955460445354;4500.954990450119;4715.269133284346;4720.598749106296;4741.217699079613;4753.168195565762;4754.191787396151;4852.80588776445;4859.3682821233015;4922.310876477368;4923.163062279493;4965.379327584052;5046.84859454217;5102.872428189325;5105.157648987875;5109.3613298337705;5219.843404697714;4808.447028591757;4810.182269014206;4825.155597770306;4828.130936431476;4889.071076495455;5021.347224860745;5023;5023.995200959896;5082.745862706776;5122.974385128051;5021.221710634857;5148.665336753099;5209.791608335624;5216.504432078947;5234.18870075139;5043.243513472861;5073.34046573943;5074.594032477319;5082.593392528515;5130.58955283569;4846.588040016638;5065.366829146356;5070.264811602371;5077.77150028257;5083.466236045162;4882.90234195307;4944.950550494449;4958.900821983612;4960.677555958851;5018.698878067327;5082.059818933509;5085.46602606721;5098.9490105098475;5102;5147.9227811583605;4995.125852975642;4996.225585034325;4998.800047998039;5011.298418221525;5042.067217564762 05:39:59 INFO - PROCESS | 13027 | |1;ext.html;557.6514678326046;572.8166986564298;574.7126436781609;576.1703147467646;578.3637998201975;38650.42024369637;39755.2048959021;39797.60202397975;39842;39854.60145398545;38772.224555508874;39387.21225575494;39444.40833387501;39504.20991580174;39566.20867582646;7701.614919254029;7837.216278372174;7892;7901.130875603679;7905.565193914333;7748.535087894745;7813.296803287732;7839.960800195991;7852.371810255195;7858.29275365217;7773.106092799316;7821.882671759929;7849.215078492133;7852;7883.921160788376;7768.728094516693;7794.2205779422175;7830.256125668053;7847.725329613493;7861.2531809478005;7637.770866874002;7739.57432341221;7740.303372696484;7743.651535680908;7744.535327880345;37022.44466333007;37128.62871371279;37227;37239.441408378625;37335;2374.3945293950105;2838.630977972871;2846.957295640567;2933.9853300733575;3048.3750831079574;26663.866680666473;27934.860325698446;28966.71033289661;28984.710152898413;29547.409051819057;3098.5042393216977;3104.0842951329414;3149.086764838194;3175.063356309894;3248.090534650302;224586;224628;225598;226519.86740066358;227103;31944.840275798473;32277.838610806797;32508.512372314435;32572.67427325744;32853;33384;33639.49540756891;33726.494102588484;33739.662603373654;33801.32397352039;13085.280309583064;13134.671633209246;13288.933555332354;13334;13384.665383365298;10592.258541901992;10715.089217416607;10726.141908647289;10762.031417172491;10806.405647689453;7850.332721718718;7943.0071241094865;7958.482698624571;7965.163657815961;8051.59742012897;3158.9684103158675;3174.4920812670325;3189.728873045771;3190.3619276144864;3214.5017522284083;838.6938767349874;930.4231376546585;931.2177770672532;941.802221533472;1016.6594190945968;28038.15268016109;28187;28626;28832.279193020342;28953.710462895524;924.4037595750704;967.2407160379069;979.3389462113046;993.4039576254189;1077.7305673581604;14867.182304973114;15084;15181.772273415907;15366.923165384102;15532.767008494882;351833;356213;356252;356338;356922;48757.756211218715;49223.507764921895;49367.753161233966;49759;49799.75100124476;1202.2005366431226;1204.47090026224;1210.6731182580654;1214.520264495537;1223.0521345956954;27085.936415382916;27183.04859329914;28057.158285251477;28190.29524261828;28281.858590706914;42605.36091958685;47297.527024729316;48846;48917.51082489272;52805.7359713199;341116;342598;345222;345669;345719;39002.219955600165;39272;39296.80351598224;39470.80264598659;39582;42172.57827421809;42433.36349954815;43109.56890431055;43323.566764331954;43407.56592434035;36357.45463818098;36492.45261321135;37077.443838341904;37692.43461348027;38009.4298585527;36711.816440917624;36827.631723683495;37052.62947370492;37129.643443233945;38067.80966095152;35185;36150;36319;36445.81777091097;36456;31995.68004319927;32907.341853162325;33117.46348770441;33629.32741345208;33708.32583348369;25305.751170775864;25384.873075634503;25622.71886405635;25926.48147037011;26037.479250415265 05:39:59 INFO - PROCESS | 13027 | |2;jquery.html;342.8975842665829;349.50544978854924;352.5821901047259;355.32665598690477;371.54300210740786;15553.144577048259;16090.436834710787;16526.586835329123;16567.171641417943;16572.088535130562;15480.225988700577;16003.679926401464;16291.755623665626;16299.511014669579;17074.573135671613;4451.710638808475;4529.773511324437;4667.15991121598;4678.345031695565;4692.835750748724;2531.164715643842;4549.24937385331;5189.506996835295;5431.511163995239;5441;5528.75120619571;5534.446555344473;5537.556995440355;5546.057170281062;5549.500544950974;5155.226715992593;5446.754896029688;5467.343918729738;5531.529819965308;5558.110702287655;5323.228131920889;5359.1157459019605;5366.973165134149;5370.91943620846;5373.3014708088085;11829.585964491287;11830;12130.090243231705;12147.878521214852;12169.14815962883;1871.316969306207;1889.1026762287804;2131.9020704337277;2207.75714671386;2320.6170981787986;8746.169113934166;8941.46351218929;9165.862512062324;9279.443233406017;9639.228861691117;1598.9280482378203;1607.9356825726957;1641.6880792649358;1688.7382455719383;1705.1133410626528;66826.66586667084;68727.31272687309;69694.65152674254;69832.650836746;70299;9327.673531426368;9410.482423466638;9833.852492212622;9985.251106167067;10015.098641122335;13514.391852366667;13538.86461135376;13603.591892243248;13609.251491167883;13626.727465450636;6993.825154371079;7037.4018208451835;7145.321194486515;7212.278772122746;7270.5274157180675;6596.505262105361;6723.764668236686;6727.192736871607;6796.93203067963;6838.589684618939;4123.422720819088;4212.620864122244;4224.598663126998;4274.957250427518;4278.89302767427;1507.8944473886943;1564.4993602047236;1568.5294411676452;1809.5023868436285;1859.5630026943657;816.603947085663;841.2008591837779;870.4733636150164;874.807542340684;913.899471058183;16454.424095156613;16681.416150434678;16863.91568042152;17331.913340433468;17415.39046133379;848.1730312944952;861.8534849075672;895.7894894699871;897.2059727141527;923.3259720404009;9296;9308.627654893728;9593.712188634352;9626.133647971716;9638.759031024281;391437;392851;409298;413040;415071;74294.25705742982;76041.23958760452;76621.61689191518;77495.61252193703;78205.21794782093;877.1009715042005;879.7222549134993;900.4057322167338;908.4912449028565;922.8108237811367;15041;15056.171910545025;15214.391424342903;15225.695486090437;15293.541193764206;34819;35065.47401788924;35639.28721425505;36129;37254.6274537262;48119;48135.27797082977;48877.26684099813;49145.75427122841;49199.508004919495;6903.75836845708;6960.651967401711;6999.545029573062;7006.9649651751415;7046.718131274896;9979.301448898797;11492.82760758606;11619.128565357802;11712.180147389941;11934.104942129548;8769.91230087691;9475.33672642936;9750.463724494937;10179.541920613443;10472.528736206737;4967.354243948408;8422.91577084246;10353.689389318333;10686.984736450026;10902.563897444013;10479.371237725762;10567.418791966516;10724.195685323788;10749.785004300027;10910.836337454786;7495.287947644965;7614.124375696866;7626.084869815658;7717.845643087219;7766.106897706836;8956.910430895869;9448;9539.809203815747;9796.412215267106;9863 05:39:59 INFO - PROCESS | 13027 | |3;mootools.html;1383.2599559235805;1407.429990853704;1462.3054049326572;1655.528174470276;1668.0575474856698;6625.73497060117;7384.40924726022;7445.143808462029;7953.761387158387;7979.521228726273;7491.438142139347;7745.806354841132;7770.883436748453;7774.2614451627005;7796.610169491531;2145.1097794415336;2180.1170525937023;2187.3765976696645;2189.6824960380736;2202.4714068623575;2120.3744895255936;2141.3040761752413;2160.2223199648115;2169.240765731997;2181.2692747929464;2142.175262523932;2149.7635260121374;2152.5587254612847;2155.7305336832897;2174.706414634028;2117.311873641065;2118.597466481379;2124.7875212478784;2126.553423781008;2129.4569884679463;2060.2892002259196;2092.246791155183;2095.476130967258;2106.136484041551;2159.676048592708;7945.165757595427;8000.759977200693;8004.479708818966;8020.438569300151;8024.398170137263;4511.1654343946475;4618.699784513996;4648.558386953234;4667.13657973276;4670.696404733681;2787.7351651593067;2840.7869409794143;2917.0811194473886;2931.4869897767803;2938.38293958269;879.9340049496313;909.377076702461;920.9401388909766;923.8845144356956;928.7445952363087;10953.616623418222;10973.067289280421;10984.505697243643;11007.944960275147;11021.228514004022;4133.359329303963;4135.441715368447;4214.946263434142;4257.318828987409;4284.057507348379;9241.075892410705;9260.907390926139;9271.304652151115;9330.066993300752;9344.645026471124;4488.214562451558;4533.365328853963;4639.721616703008;4717.914879577647;4740.7392593407;3519.225770330523;4107.240160570304;4294.055307832272;4311.417958575615;4322.330038843984;3670.3209906167444;3695.981520092382;3696.7615848690452;3768.3028639701743;3768.566614839274;1171.9003884669899;1186.2704436771323;1198.7003249187703;1202.5670758526924;1210.5399948019697;786.0920636664662;797.075392544657;812.6789917982364;816.7468084893702;822.8683410654266;4897.8285759998225;5014.147594908874;5035.748212589429;5101.566366858784;5126.92309615356;385.74055708113036;386.3914334922452;394.97432666877137;401.8633664554007;408.0879234909974;3457.6369481204615;3477.3740726668934;3478.513008178857;3532.5584301962253;3545.13144279648;9123.452592844451;9290.070992900655;9454.763630909283;9465;9687.806243875082;9514.524273786283;9576.616935322649;9587.616495340248;9632.084951929555;9749.512524373753;7119.110111236096;7154.4991850571005;7336.33972942427;7366.889496657554;7367.2264412235945;5081.18701007837;5118.846434606968;5176.352955880515;5226.973865130803;5242.947570524246;8453.746387608382;8665.566721664018;8762.036176020505;8849;8971.91028089737;8858.335624828034;8911.643534258816;8980.326475514232;9021.909780902108;9065.229455496094;5481.123020316731;6105.084237364431;6219.968900155471;6229.065640154013;6396.648184349905;7161.85676286461;7186.425085993213;7233.891491627735;7237.927620723725;7274.5635261882335;6437.333944798498;6560.573562718408;6591.703373348115;6622.271550129385;6685.598864068172;6433.967830160819;6452.419282264619;6456.7740129095255;6464;6486.578372405778;5742.799002034909;5777.364489906023;5796.82609521715;5803.535717142703;5816.621919575214;4122.3404255319;4156.9376459352525;4161.3549899765585;4217.768022758778;4387.473503179639;4205.642520385802;4241.4062031315025;4336.154449882242;4372.9125417492105;4394.978025109854 05:39:59 INFO - PROCESS | 13027 | |4;prototype.html;291.49716738625864;295.18234490461407;296.2504862697376;296.6899589928524;296.7507293873146;4972.7265000425;5117.372525435271;5117.925235700498;5130.333056702628;5136.845894623158;5014.423341315741;5057.216131499615;5075.974620126904;5086.872828179297;5108.386993560769;3697.00180951143;3833.271678381099;3951.46655201547;3988.660963818079;3989.461422707941;3947.151362457071;3950.42718805773;3950.9209815803665;3953.48604681391;3975.761454312736;3936.350502167139;3943.605639436062;3950.2099580083955;3976.6023397660147;3979.363301871701;3830.367989281765;3970.5235371755575;3983.103801644636;3994;3996.320625493673;3472.392331342005;3478.8172021512555;3483.815502729084;3487.692115456704;3496.1434448560267;4950.331705219785;4969.503049695038;4970.676906001098;5027.723475208862;5039.924401133986;4556.954430455686;4565.771711414449;4570.177368073745;4570.862874113782;4591;5072.264521644378;5273.604479664041;5285;5291.444398338196;5394.163904594794;3611.259691763182;3629.8366573504254;3651.8496673547747;3662.523871896663;3676.613955534684;5550.666959982414;5586.804461843816;5606.971965140189;5615.382307946164;5625.409332020161;3712.5730540987593;3774.150816066363;3779.6204385399133;3784.962150378516;3785.1861849701895;3811.6950643948417;3819.1979684266616;3822.8088595570666;3839.6544311012144;3872.225554888977;4421.938734703713;4432.933505997413;4452.888677783081;4458.06380660065;4458.130664520452;5219.138842091088;5288.153895376799;5334.253204551366;5349;5389.841184145427;1307.66654503103;1322.987914245603;1326.5423428917009;1329.322045756671;1338.8259526261525;812.8011183504402;823.7652269103277;831.1854382704983;834.891464109674;836.9079401265856;4181.393697913846;4431.911361772811;4550.768954042666;4690.147391780296;4699.78850951708;5510.421405752419;5513.917291240635;5525.723713814293;5535.640183388067;5536.972315138399;4650.302454631765;4660.464046634613;4665.486796452387;4666.65000124992;4674.94813666929;2801.2716693659795;2940.9705902940696;2949.8643022436518;2950.3066779306846;2956.305268261957;5157.432682404932;5158.716270605153;5159.839036216897;5182.948170518246;5218.478152184827;5507.779688812483;5546.861328466821;5627.915581266284;5637.802676906289;5652.66084034951;5028.220625803006;5068.3917929849395;5079.74601269935;5081.187010078517;5084.872878178076;5533.3083364579425;5573.16402539606;5580.804671836466;5584.525315348241;5586.86032849182;5162.838361368662;5431.4840090191365;5464.9180262296895;5482.890342193214;5490.780368785204;5196.714180719945;5218.399884013235;5238.1618940969265;5247.816326428557;5255.605829562722;3831.559370672297;3935.842566297316;3959.3071212538266;3978.224246271949;3985.820638071236;5419.268398766274;5421.7560209791445;5474.452554744494;5501.4223506532835;5604.579656525859;5283.630145889751;5319.521243088141;5337.866553336197;5338.813141540028;5339.199120132012;5308.097623403954;5314.681119132864;5326.147816349366;5360.142377219626;5373.650712703662;5044.225675878326;5221.347331583552;5241.820590367137;5242.292290540729;5246.396664383645;5128.923066153936;5203.297554830201;5375.19372094189;5383.842473868137;5407.864803379947;5266.157414813764;5270.472952704698;5273.182656688219;5286.7356632169;5305.946940530545 05:39:59 INFO - PROCESS | 13027 | |5;yui.html;513.012451031764;571.3286887906711;572.364675210516;576.6223123853874;579.2701196492419;11064.723381915455;11097.16771242156;11184.832227516583;11567.479463424144;11740.647780566575;13865.306734663276;14407.423703051865;14438.783418248708;14990.700185996273;15019.624509387271;615.1111643674892;771.1478815908424;786.2098590916121;786.2177133751896;786.4062632712323;753.3445902065183;783.0485959559135;785.1716439156687;786.0371045469283;788.1173086143527;817.6443247187462;818.8198596308803;819.2053707903324;820.4257020085934;825.8307047055339;804.2158895077282;809.9838003239961;811.6063709101111;811.6753298680516;811.9797005074861;594.1562980567604;596.0254983102615;597.2623809595146;600.414595769126;601.5488383712216;12857.485700571966;12883.67790805228;12912.741745165138;12958.740825183444;12971.221726696429;10944.288621239673;11748.530058797638;12039.546246250768;12067.758644827054;12244.632661020183;9381.671641492516;9584.760380990461;9815.329123546138;9857.162141218005;10143.797124057477;3256.2347848255877;3311.6357200707903;3334.249793796401;3335.633080361158;3365.3269346130874;58964;59478.10782838304;60287;61598.69200653968;61680;9144.268458523435;9152.8627070594;9155.359124861328;9164.083591640783;9341.392809467363;18235.72646410305;18405.26378944854;18410.90794546019;18541.721874171897;18627.254909803727;6022.488088512438;6105.511559075263;6139.4781443577795;6585.078089067534;6744.898826517606;3363.882264120744;3442.1910850950007;3616.6744992950235;3641.253543023674;3676.4117741161285;2719.157061311;2837.7587905028304;2860.270630989126;2868.0822136916404;2886.696896825845;473.7110362678763;476.10492274523676;481.35258077885186;492.0527983631566;494.1451289269512;500;517.3636427194572;518.5540435225703;532.087469988963;545.5850681981398;6786.864262714718;6867.484938629623;6940.41006514452;7053.89419158713;7055.329743674342;422.2947677378785;462.66919152805906;495.3387228050521;499.505489565335;524.9816256431006;3353.983230083834;3422.8973130806116;3458.5849698035895;3466.6533346665133;3487.7035451986358;53394.46605533895;53578.73210634;55294.44705552974;55583.72208138934;55746.44253557493;49528.257076143884;69709.95435068478;76830.61584692153;78209.60895195487;78566.6071669638;68996;70051.64974175199;71834;71935.28064719391;71944.28055719376;6906.447484201151;7021.1574611047;7099.574025558483;7112.715491380287;7182.245864184186;30642;31990;38360.23279534338;43262.78368608137;43372;61022.69488652706;62004;62492;62688.37311626825;63410.68294658497;9540.427574345562;10148.695539133838;10270.743231418975;10364.119049880845;10658.573657053632;10612.204084693525;10763.246572739834;10797.784044319227;10809.891901080888;10958.671239862817;9464.952675236855;9933.552990115606;9979.60081596728;10359.22305827081;10444.63443779464;10410.583576656849;10655.360678359324;10688.038076573146;10755.784884302113;10846.620368287073;9416.717498475056;9575.569099390405;9584.089511496397;9601.711948641552;9902.108810207115;8281.337493000425;8485.91514084876;8559.186877246651;8636.611352489279;8872.778180545538;8029.3175080118845;8043.477173983672;8144.267015968591;8164.623276277314;8489.617967191367 05:39:59 INFO - PROCESS | 13027 | __end_tp_report 05:39:59 INFO - PROCESS | 13027 | __start_cc_report 05:39:59 INFO - PROCESS | 13027 | _x_x_mozilla_cycle_collect,386 05:39:59 INFO - PROCESS | 13027 | __end_cc_report 05:39:59 INFO - PROCESS | 13027 | __startTimestamp1465562399965__endTimestamp 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | ------- Summary: start ------- 05:39:59 INFO - PROCESS | 13027 | Number of tests: 6 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | [#0] dojo.html Cycles:165 Average:4765.43 Median:4923.16 stddev:611.09 (12.4%) stddev-sans-first:589.46 05:39:59 INFO - PROCESS | 13027 | Values: 2625.5 2673.8 2678.1 2682.9 2685.8 4742.5 4761.2 4790.0 4873.3 4901.4 4647.5 4856.7 4881.8 4907.2 4914.4 4439.8 4483.3 4611.5 4611.9 4637.6 526.1 4362.4 4414.2 4452.2 4458.6 4348.5 4439.4 4448.4 4462.7 4490.8 4435.4 4454.4 4458.7 4460.1 4506.7 4235.0 4409.5 4420.4 4423.9 4443.2 4706.1 4842.8 4849.9 4879.0 4923.7 5219.1 5233.8 5236.8 5243.7 5305.8 5207.9 5239.7 5259.7 5273.7 5279.3 4856.7 4900.2 4901.8 4916.5 4950.0 5153.1 5319.4 5390.5 5391.8 5395.7 5089.9 5118.1 5133.0 5155.7 5228.0 5203.0 5220.4 5248.9 5278.3 5306.8 4991.4 5096.7 5113.2 5124.4 5133.4 5127.3 5143.4 5163.3 5164.0 5200.5 4399.0 4402.7 4403.6 4420.4 4454.5 3761.5 3807.7 3810.0 3826.0 3845.8 4338.7 4407.3 4412.8 4436.3 4459.1 5142.9 5179.0 5180.4 5183.1 5233.6 4263.4 4434.0 4435.7 4454.0 4501.0 4715.3 4720.6 4741.2 4753.2 4754.2 4852.8 4859.4 4922.3 4923.2 4965.4 5046.8 5102.9 5105.2 5109.4 5219.8 4808.4 4810.2 4825.2 4828.1 4889.1 5021.3 5023.0 5024.0 5082.7 5123.0 5021.2 5148.7 5209.8 5216.5 5234.2 5043.2 5073.3 5074.6 5082.6 5130.6 4846.6 5065.4 5070.3 5077.8 5083.5 4882.9 4945.0 4958.9 4960.7 5018.7 5082.1 5085.5 5098.9 5102.0 5147.9 4995.1 4996.2 4998.8 5011.3 5042.1 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | [#1] ext.html Cycles:180 Average:45555.63 Median:36401.64 stddev:82719.59 (227.2%) stddev-sans-first:82882.64 05:39:59 INFO - PROCESS | 13027 | Values: 557.7 572.8 574.7 576.2 578.4 38650.4 39755.2 39797.6 39842.0 39854.6 38772.2 39387.2 39444.4 39504.2 39566.2 7701.6 7837.2 7892.0 7901.1 7905.6 7748.5 7813.3 7840.0 7852.4 7858.3 7773.1 7821.9 7849.2 7852.0 7883.9 7768.7 7794.2 7830.3 7847.7 7861.3 7637.8 7739.6 7740.3 7743.7 7744.5 37022.4 37128.6 37227.0 37239.4 37335.0 2374.4 2838.6 2847.0 2934.0 3048.4 26663.9 27934.9 28966.7 28984.7 29547.4 3098.5 3104.1 3149.1 3175.1 3248.1 224586.0 224628.0 225598.0 226519.9 227103.0 31944.8 32277.8 32508.5 32572.7 32853.0 33384.0 33639.5 33726.5 33739.7 33801.3 13085.3 13134.7 13288.9 13334.0 13384.7 10592.3 10715.1 10726.1 10762.0 10806.4 7850.3 7943.0 7958.5 7965.2 8051.6 3159.0 3174.5 3189.7 3190.4 3214.5 838.7 930.4 931.2 941.8 1016.7 28038.2 28187.0 28626.0 28832.3 28953.7 924.4 967.2 979.3 993.4 1077.7 14867.2 15084.0 15181.8 15366.9 15532.8 351833.0 356213.0 356252.0 356338.0 356922.0 48757.8 49223.5 49367.8 49759.0 49799.8 1202.2 1204.5 1210.7 1214.5 1223.1 27085.9 27183.0 28057.2 28190.3 28281.9 42605.4 47297.5 48846.0 48917.5 52805.7 341116.0 342598.0 345222.0 345669.0 345719.0 39002.2 39272.0 39296.8 39470.8 39582.0 42172.6 42433.4 43109.6 43323.6 43407.6 36357.5 36492.5 37077.4 37692.4 38009.4 36711.8 36827.6 37052.6 37129.6 38067.8 35185.0 36150.0 36319.0 36445.8 36456.0 31995.7 32907.3 33117.5 33629.3 33708.3 25305.8 25384.9 25622.7 25926.5 26037.5 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | [#2] jquery.html Cycles:180 Average:24167.22 Median:49172.63 stddev:66722.46 (135.7%) stddev-sans-first:66885.66 05:39:59 INFO - PROCESS | 13027 | Values: 342.9 349.5 352.6 355.3 371.5 15553.1 16090.4 16526.6 16567.2 16572.1 15480.2 16003.7 16291.8 16299.5 17074.6 4451.7 4529.8 4667.2 4678.3 4692.8 2531.2 4549.2 5189.5 5431.5 5441.0 5528.8 5534.4 5537.6 5546.1 5549.5 5155.2 5446.8 5467.3 5531.5 5558.1 5323.2 5359.1 5367.0 5370.9 5373.3 11829.6 11830.0 12130.1 12147.9 12169.1 1871.3 1889.1 2131.9 2207.8 2320.6 8746.2 8941.5 9165.9 9279.4 9639.2 1598.9 1607.9 1641.7 1688.7 1705.1 66826.7 68727.3 69694.7 69832.7 70299.0 9327.7 9410.5 9833.9 9985.3 10015.1 13514.4 13538.9 13603.6 13609.3 13626.7 6993.8 7037.4 7145.3 7212.3 7270.5 6596.5 6723.8 6727.2 6796.9 6838.6 4123.4 4212.6 4224.6 4275.0 4278.9 1507.9 1564.5 1568.5 1809.5 1859.6 816.6 841.2 870.5 874.8 913.9 16454.4 16681.4 16863.9 17331.9 17415.4 848.2 861.9 895.8 897.2 923.3 9296.0 9308.6 9593.7 9626.1 9638.8 391437.0 392851.0 409298.0 413040.0 415071.0 74294.3 76041.2 76621.6 77495.6 78205.2 877.1 879.7 900.4 908.5 922.8 15041.0 15056.2 15214.4 15225.7 15293.5 34819.0 35065.5 35639.3 36129.0 37254.6 48119.0 48135.3 48877.3 49145.8 49199.5 6903.8 6960.7 6999.5 7007.0 7046.7 9979.3 11492.8 11619.1 11712.2 11934.1 8769.9 9475.3 9750.5 10179.5 10472.5 4967.4 8422.9 10353.7 10687.0 10902.6 10479.4 10567.4 10724.2 10749.8 10910.8 7495.3 7614.1 7626.1 7717.8 7766.1 8956.9 9448.0 9539.8 9796.4 9863.0 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | [#3] mootools.html Cycles:180 Average:5042.32 Median:4955.99 stddev:2886.84 (58.2%) stddev-sans-first:2881.85 05:39:59 INFO - PROCESS | 13027 | Values: 1383.3 1407.4 1462.3 1655.5 1668.1 6625.7 7384.4 7445.1 7953.8 7979.5 7491.4 7745.8 7770.9 7774.3 7796.6 2145.1 2180.1 2187.4 2189.7 2202.5 2120.4 2141.3 2160.2 2169.2 2181.3 2142.2 2149.8 2152.6 2155.7 2174.7 2117.3 2118.6 2124.8 2126.6 2129.5 2060.3 2092.2 2095.5 2106.1 2159.7 7945.2 8000.8 8004.5 8020.4 8024.4 4511.2 4618.7 4648.6 4667.1 4670.7 2787.7 2840.8 2917.1 2931.5 2938.4 879.9 909.4 920.9 923.9 928.7 10953.6 10973.1 10984.5 11007.9 11021.2 4133.4 4135.4 4214.9 4257.3 4284.1 9241.1 9260.9 9271.3 9330.1 9344.6 4488.2 4533.4 4639.7 4717.9 4740.7 3519.2 4107.2 4294.1 4311.4 4322.3 3670.3 3696.0 3696.8 3768.3 3768.6 1171.9 1186.3 1198.7 1202.6 1210.5 786.1 797.1 812.7 816.7 822.9 4897.8 5014.1 5035.7 5101.6 5126.9 385.7 386.4 395.0 401.9 408.1 3457.6 3477.4 3478.5 3532.6 3545.1 9123.5 9290.1 9454.8 9465.0 9687.8 9514.5 9576.6 9587.6 9632.1 9749.5 7119.1 7154.5 7336.3 7366.9 7367.2 5081.2 5118.8 5176.4 5227.0 5242.9 8453.7 8665.6 8762.0 8849.0 8971.9 8858.3 8911.6 8980.3 9021.9 9065.2 5481.1 6105.1 6220.0 6229.1 6396.6 7161.9 7186.4 7233.9 7237.9 7274.6 6437.3 6560.6 6591.7 6622.3 6685.6 6434.0 6452.4 6456.8 6464.0 6486.6 5742.8 5777.4 5796.8 5803.5 5816.6 4122.3 4156.9 4161.4 4217.8 4387.5 4205.6 4241.4 4336.2 4372.9 4395.0 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | [#4] prototype.html Cycles:180 Average:4411.53 Median:5070.33 stddev:1304.58 (25.7%) stddev-sans-first:1271.06 05:39:59 INFO - PROCESS | 13027 | Values: 291.5 295.2 296.3 296.7 296.8 4972.7 5117.4 5117.9 5130.3 5136.8 5014.4 5057.2 5076.0 5086.9 5108.4 3697.0 3833.3 3951.5 3988.7 3989.5 3947.2 3950.4 3950.9 3953.5 3975.8 3936.4 3943.6 3950.2 3976.6 3979.4 3830.4 3970.5 3983.1 3994.0 3996.3 3472.4 3478.8 3483.8 3487.7 3496.1 4950.3 4969.5 4970.7 5027.7 5039.9 4557.0 4565.8 4570.2 4570.9 4591.0 5072.3 5273.6 5285.0 5291.4 5394.2 3611.3 3629.8 3651.8 3662.5 3676.6 5550.7 5586.8 5607.0 5615.4 5625.4 3712.6 3774.2 3779.6 3785.0 3785.2 3811.7 3819.2 3822.8 3839.7 3872.2 4421.9 4432.9 4452.9 4458.1 4458.1 5219.1 5288.2 5334.3 5349.0 5389.8 1307.7 1323.0 1326.5 1329.3 1338.8 812.8 823.8 831.2 834.9 836.9 4181.4 4431.9 4550.8 4690.1 4699.8 5510.4 5513.9 5525.7 5535.6 5537.0 4650.3 4660.5 4665.5 4666.7 4674.9 2801.3 2941.0 2949.9 2950.3 2956.3 5157.4 5158.7 5159.8 5182.9 5218.5 5507.8 5546.9 5627.9 5637.8 5652.7 5028.2 5068.4 5079.7 5081.2 5084.9 5533.3 5573.2 5580.8 5584.5 5586.9 5162.8 5431.5 5464.9 5482.9 5490.8 5196.7 5218.4 5238.2 5247.8 5255.6 3831.6 3935.8 3959.3 3978.2 3985.8 5419.3 5421.8 5474.5 5501.4 5604.6 5283.6 5319.5 5337.9 5338.8 5339.2 5308.1 5314.7 5326.1 5360.1 5373.7 5044.2 5221.3 5241.8 5242.3 5246.4 5128.9 5203.3 5375.2 5383.8 5407.9 5266.2 5270.5 5273.2 5286.7 5305.9 05:39:59 INFO - PROCESS | 13027 | 05:39:59 INFO - PROCESS | 13027 | [#5] yui.html Cycles:180 Average:15327.96 Median:574.49 stddev:20918.71 (3641.2%) stddev-sans-first:20947.81 05:39:59 INFO - PROCESS | 13027 | Values: 513.0 571.3 572.4 576.6 579.3 11064.7 11097.2 11184.8 11567.5 11740.6 13865.3 14407.4 14438.8 14990.7 15019.6 615.1 771.1 786.2 786.2 786.4 753.3 783.0 785.2 786.0 788.1 817.6 818.8 819.2 820.4 825.8 804.2 810.0 811.6 811.7 812.0 594.2 596.0 597.3 600.4 601.5 12857.5 12883.7 12912.7 12958.7 12971.2 10944.3 11748.5 12039.5 12067.8 12244.6 9381.7 9584.8 9815.3 9857.2 10143.8 3256.2 3311.6 3334.2 3335.6 3365.3 58964.0 59478.1 60287.0 61598.7 61680.0 9144.3 9152.9 9155.4 9164.1 9341.4 18235.7 18405.3 18410.9 18541.7 18627.3 6022.5 6105.5 6139.5 6585.1 6744.9 3363.9 3442.2 3616.7 3641.3 3676.4 2719.2 2837.8 2860.3 2868.1 2886.7 473.7 476.1 481.4 492.1 494.1 500.0 517.4 518.6 532.1 545.6 6786.9 6867.5 6940.4 7053.9 7055.3 422.3 462.7 495.3 499.5 525.0 3354.0 3422.9 3458.6 3466.7 3487.7 53394.5 53578.7 55294.4 55583.7 55746.4 49528.3 69710.0 76830.6 78209.6 78566.6 68996.0 70051.6 71834.0 71935.3 71944.3 6906.4 7021.2 7099.6 7112.7 7182.2 30642.0 31990.0 38360.2 43262.8 43372.0 61022.7 62004.0 62492.0 62688.4 63410.7 9540.4 10148.7 10270.7 10364.1 10658.6 10612.2 10763.2 10797.8 10809.9 10958.7 9465.0 9933.6 9979.6 10359.2 10444.6 10410.6 10655.4 10688.0 10755.8 10846.6 9416.7 9575.6 9584.1 9601.7 9902.1 8281.3 8485.9 8559.2 8636.6 8872.8 8029.3 8043.5 8144.3 8164.6 8489.6 05:39:59 INFO - PROCESS | 13027 | -------- Summary: end -------- 05:39:59 INFO - PROCESS | 13027 | 05:40:00 INFO - TEST-INFO | 13027: exit 0 05:40:00 INFO - TEST-OK | dromaeo_css | took 1116437ms 05:40:00 INFO - TEST-START | kraken 05:40:00 INFO - operating with platform_type : linux_ 05:40:00 INFO - Initialising browser for kraken test... 05:40:00 INFO - TEST-INFO | started process 13263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksQtJv/profile http://localhost:59500/getInfo.html) 05:40:06 INFO - PROCESS | 13263 | __metrics Screen width/height:1600/1200 05:40:06 INFO - PROCESS | 13263 | colorDepth:24 05:40:06 INFO - PROCESS | 13263 | Browser inner width/height: 1024/697 05:40:06 INFO - PROCESS | 13263 | __metrics 05:40:06 ERROR - PROCESS | 13263 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 05:40:07 INFO - TEST-INFO | 13263: exit 0 05:40:07 INFO - Browser initialized. 05:40:07 INFO - Running cycle 1/1 for kraken test... 05:40:07 INFO - TEST-INFO | started process 13383 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpksQtJv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:19 INFO - PROCESS | 13383 | RSS: Main: 185171968 05:40:19 INFO - PROCESS | 13383 | 05:40:22 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:23 INFO - PROCESS | 13383 | RSS: Main: 189698048 05:40:23 INFO - PROCESS | 13383 | 05:40:26 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-dft) 05:40:26 INFO - PROCESS | 13383 | RSS: Main: 189857792 05:40:26 INFO - PROCESS | 13383 | 05:40:29 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-fft) 05:40:30 INFO - PROCESS | 13383 | RSS: Main: 185462784 05:40:30 INFO - PROCESS | 13383 | 05:40:32 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59500/tests/kraken/driver.html?testName=audio-oscillator) 05:40:33 INFO - PROCESS | 13383 | RSS: Main: 185901056 05:40:33 INFO - PROCESS | 13383 | 05:40:35 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:36 INFO - PROCESS | 13383 | RSS: Main: 186191872 05:40:36 INFO - PROCESS | 13383 | 05:40:39 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59500/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:40 INFO - PROCESS | 13383 | RSS: Main: 186388480 05:40:40 INFO - PROCESS | 13383 | 05:40:43 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59500/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:44 INFO - PROCESS | 13383 | RSS: Main: 183857152 05:40:44 INFO - PROCESS | 13383 | 05:40:47 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59500/tests/kraken/driver.html?testName=json-parse-financial) 05:40:47 INFO - PROCESS | 13383 | RSS: Main: 185290752 05:40:47 INFO - PROCESS | 13383 | 05:40:49 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:50 INFO - PROCESS | 13383 | RSS: Main: 185364480 05:40:50 INFO - PROCESS | 13383 | 05:40:52 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:52 INFO - PROCESS | 13383 | RSS: Main: 185970688 05:40:52 INFO - PROCESS | 13383 | 05:40:54 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:55 INFO - PROCESS | 13383 | RSS: Main: 186052608 05:40:55 INFO - PROCESS | 13383 | 05:40:58 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:59 INFO - PROCESS | 13383 | RSS: Main: 186691584 05:40:59 INFO - PROCESS | 13383 | 05:41:01 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:02 INFO - PROCESS | 13383 | RSS: Main: 186372096 05:41:02 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | Cycle 1(1): loaded http://localhost:59500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59500/tests/kraken/driver.html?testName=ai-astar) 05:41:04 INFO - PROCESS | 13383 | RSS: Main: 187064320 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | __start_tp_report 05:41:04 INFO - PROCESS | 13383 | _x_x_mozilla_page_load 05:41:04 INFO - PROCESS | 13383 | _x_x_mozilla_page_load_details 05:41:04 INFO - PROCESS | 13383 | |i|pagename|runs| 05:41:04 INFO - PROCESS | 13383 | |0;ai-astar;114;109;117;115;114;115;116;115;113;114 05:41:04 INFO - PROCESS | 13383 | |1;audio-beat-detection;161;134;154;186;134;152;157;139;198;130 05:41:04 INFO - PROCESS | 13383 | |2;audio-dft;164;168;171;163;164;164;162;163;170;163 05:41:04 INFO - PROCESS | 13383 | |3;audio-fft;75;78;78;164;84;84;76;75;159;76 05:41:04 INFO - PROCESS | 13383 | |4;audio-oscillator;90;87;149;86;86;86;137;87;86;135 05:41:04 INFO - PROCESS | 13383 | |5;imaging-gaussian-blur;118;117;117;118;118;119;118;118;118;118 05:41:04 INFO - PROCESS | 13383 | |6;imaging-darkroom;147;149;147;148;148;150;147;147;148;147 05:41:04 INFO - PROCESS | 13383 | |7;imaging-desaturate;95;95;97;96;96;96;95;95;95;96 05:41:04 INFO - PROCESS | 13383 | |8;json-parse-financial;66;64;65;64;70;67;63;64;68;64 05:41:04 INFO - PROCESS | 13383 | |9;json-stringify-tinderbox;64;65;65;66;66;64;65;66;66;65 05:41:04 INFO - PROCESS | 13383 | |10;stanford-crypto-aes;85;83;83;84;86;91;85;85;116;87 05:41:04 INFO - PROCESS | 13383 | |11;stanford-crypto-ccm;145;143;135;136;129;148;146;136;150;149 05:41:04 INFO - PROCESS | 13383 | |12;stanford-crypto-pbkdf2;174;174;185;171;174;173;169;175;168;169 05:41:04 INFO - PROCESS | 13383 | |13;stanford-crypto-sha256-iterative;68;70;69;75;68;67;70;67;68;68 05:41:04 INFO - PROCESS | 13383 | __end_tp_report 05:41:04 INFO - PROCESS | 13383 | __start_cc_report 05:41:04 INFO - PROCESS | 13383 | _x_x_mozilla_cycle_collect,955 05:41:04 INFO - PROCESS | 13383 | __end_cc_report 05:41:04 INFO - PROCESS | 13383 | __startTimestamp1465562464660__endTimestamp 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | ------- Summary: start ------- 05:41:04 INFO - PROCESS | 13383 | Number of tests: 14 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:2.15 (1.9%) stddev-sans-first:2.28 05:41:04 INFO - PROCESS | 13383 | Values: 114.0 109.0 117.0 115.0 114.0 115.0 116.0 115.0 113.0 114.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#1] audio-beat-detection Cycles:10 Average:154.50 Median:155.50 stddev:22.66 (14.6%) stddev-sans-first:23.91 05:41:04 INFO - PROCESS | 13383 | Values: 161.0 134.0 154.0 186.0 134.0 152.0 157.0 139.0 198.0 130.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:3.22 (2.0%) stddev-sans-first:3.39 05:41:04 INFO - PROCESS | 13383 | Values: 164.0 168.0 171.0 163.0 164.0 164.0 162.0 163.0 170.0 163.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#3] audio-fft Cycles:10 Average:94.90 Median:77.00 stddev:35.27 (45.8%) stddev-sans-first:36.67 05:41:04 INFO - PROCESS | 13383 | Values: 75.0 78.0 78.0 164.0 84.0 84.0 76.0 75.0 159.0 76.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:86.00 stddev:26.10 (30.4%) stddev-sans-first:27.27 05:41:04 INFO - PROCESS | 13383 | Values: 90.0 87.0 149.0 86.0 86.0 86.0 137.0 87.0 86.0 135.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:41:04 INFO - PROCESS | 13383 | Values: 118.0 117.0 117.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 05:41:04 INFO - PROCESS | 13383 | Values: 147.0 149.0 147.0 148.0 148.0 150.0 147.0 147.0 148.0 147.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:41:04 INFO - PROCESS | 13383 | Values: 95.0 95.0 97.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.50 stddev:2.22 (3.4%) stddev-sans-first:2.35 05:41:04 INFO - PROCESS | 13383 | Values: 66.0 64.0 65.0 64.0 70.0 67.0 63.0 64.0 68.0 64.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 05:41:04 INFO - PROCESS | 13383 | Values: 64.0 65.0 65.0 66.0 66.0 64.0 65.0 66.0 66.0 65.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.00 stddev:9.94 (11.7%) stddev-sans-first:10.46 05:41:04 INFO - PROCESS | 13383 | Values: 85.0 83.0 83.0 84.0 86.0 91.0 85.0 85.0 116.0 87.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#11] stanford-crypto-ccm Cycles:10 Average:141.70 Median:145.50 stddev:7.18 (4.9%) stddev-sans-first:7.52 05:41:04 INFO - PROCESS | 13383 | Values: 145.0 143.0 135.0 136.0 129.0 148.0 146.0 136.0 150.0 149.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:174.00 stddev:4.85 (2.8%) stddev-sans-first:5.13 05:41:04 INFO - PROCESS | 13383 | Values: 174.0 174.0 185.0 171.0 174.0 173.0 169.0 175.0 168.0 169.0 05:41:04 INFO - PROCESS | 13383 | 05:41:04 INFO - PROCESS | 13383 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:68.50 stddev:2.36 (3.4%) stddev-sans-first:2.47 05:41:04 INFO - PROCESS | 13383 | Values: 68.0 70.0 69.0 75.0 68.0 67.0 70.0 67.0 68.0 68.0 05:41:04 INFO - PROCESS | 13383 | -------- Summary: end -------- 05:41:04 INFO - PROCESS | 13383 | 05:41:05 INFO - TEST-INFO | 13383: exit 0 05:41:05 INFO - TEST-OK | kraken | took 64931ms 05:41:05 INFO - SUITE-END | took 1181s 05:41:05 INFO - Completed test suite (00:19:41) 05:41:05 INFO - javascript benchmark 05:41:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6217.700484459709, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.474905018996, 2673.8262012969158, 2678.116221646857, 2682.8792704328303, 2685.7717094046993, 4742.454617718963, 4761.166795810736, 4789.976050119749, 4873.293372460991, 4901.387326584177, 4647.488776234612, 4856.660033797635, 4881.8291359802415, 4907.190313598252, 4914.410270767513, 4439.844605438819, 4483.30508771141, 4611.538846115395, 4611.930821037688, 4637.605803506706, 526.0807981278482, 4362.367456718774, 4414.183376075421, 4452.243118669834, 4458.5541445855315, 4348.521662617094, 4439.445069366329, 4448.377227188196, 4462.732236065814, 4490.7530085845265, 4435.401220835211, 4454.37638730578, 4458.687891847572, 4460.063386688799, 4506.7070640408265, 4235.0, 4409.536998615131, 4420.403245561873, 4423.889402764925, 4443.155800397914, 4706.10583989041, 4842.782074806642, 4849.878753031167, 4879.024195160982, 4923.655344125913, 5219.138842091051, 5233.842984710464, 5236.7905283788605, 5243.737813109329, 5305.761240744176, 5207.921881171786, 5239.738013099368, 5259.737013149365, 5273.736313184326, 5279.313689220377, 4856.68431551948, 4900.240462728283, 4901.754912254373, 4916.483769204254, 4950.034743225036, 5153.123968925217, 5319.414864364917, 5390.4879036491475, 5391.838244852661, 5395.73021348931, 5089.8727531812, 5118.053160165381, 5133.0, 5155.742212889416, 5227.973860130675, 5202.97398513005, 5220.399654039834, 5248.921266181011, 5278.261043453919, 5306.8407947761625, 4991.351124353883, 5096.719680417538, 5113.181890897438, 5124.436312005676, 5133.383993920754, 5127.333446651912, 5143.408508021551, 5163.328767260232, 5164.0, 5200.531952124251, 4399.032212913154, 4402.713823601455, 4403.625691816232, 4420.447444069491, 4454.510003899569, 3761.5298087739034, 3807.7144214183495, 3809.952263127607, 3825.9617403826164, 3845.769253844778, 4338.696291259582, 4407.294832826797, 4412.779361031936, 4436.26801577736, 4459.1304695584695, 5142.922856157161, 5179.015986962465, 5180.378354597472, 5183.144781111075, 5233.633645644768, 4263.4031235627035, 4434.046679963823, 4435.6895017349125, 4453.955460445354, 4500.954990450119, 4715.269133284346, 4720.598749106296, 4741.217699079613, 4753.168195565762, 4754.191787396151, 4852.80588776445, 4859.3682821233015, 4922.310876477368, 4923.163062279493, 4965.379327584052, 5046.84859454217, 5102.872428189325, 5105.157648987875, 5109.3613298337705, 5219.843404697714, 4808.447028591757, 4810.182269014206, 4825.155597770306, 4828.130936431476, 4889.071076495455, 5021.347224860745, 5023.0, 5023.995200959896, 5082.745862706776, 5122.974385128051, 5021.221710634857, 5148.665336753099, 5209.791608335624, 5216.504432078947, 5234.18870075139, 5043.243513472861, 5073.34046573943, 5074.594032477319, 5082.593392528515, 5130.58955283569, 4846.588040016638, 5065.366829146356, 5070.264811602371, 5077.77150028257, 5083.466236045162, 4882.90234195307, 4944.950550494449, 4958.900821983612, 4960.677555958851, 5018.698878067327, 5082.059818933509, 5085.46602606721, 5098.9490105098475, 5102.0, 5147.9227811583605, 4995.125852975642, 4996.225585034325, 4998.800047998039, 5011.298418221525, 5042.067217564762], "value": 4727.521958573784, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.6514678326046, 572.8166986564298, 574.7126436781609, 576.1703147467646, 578.3637998201975, 38650.42024369637, 39755.2048959021, 39797.60202397975, 39842.0, 39854.60145398545, 38772.224555508874, 39387.21225575494, 39444.40833387501, 39504.20991580174, 39566.20867582646, 7701.614919254029, 7837.216278372174, 7892.0, 7901.130875603679, 7905.565193914333, 7748.535087894745, 7813.296803287732, 7839.960800195991, 7852.371810255195, 7858.29275365217, 7773.106092799316, 7821.882671759929, 7849.215078492133, 7852.0, 7883.921160788376, 7768.728094516693, 7794.2205779422175, 7830.256125668053, 7847.725329613493, 7861.2531809478005, 7637.770866874002, 7739.57432341221, 7740.303372696484, 7743.651535680908, 7744.535327880345, 37022.44466333007, 37128.62871371279, 37227.0, 37239.441408378625, 37335.0, 2374.3945293950105, 2838.630977972871, 2846.957295640567, 2933.9853300733575, 3048.3750831079574, 26663.866680666473, 27934.860325698446, 28966.71033289661, 28984.710152898413, 29547.409051819057, 3098.5042393216977, 3104.0842951329414, 3149.086764838194, 3175.063356309894, 3248.090534650302, 224586.0, 224628.0, 225598.0, 226519.86740066358, 227103.0, 31944.840275798473, 32277.838610806797, 32508.512372314435, 32572.67427325744, 32853.0, 33384.0, 33639.49540756891, 33726.494102588484, 33739.662603373654, 33801.32397352039, 13085.280309583064, 13134.671633209246, 13288.933555332354, 13334.0, 13384.665383365298, 10592.258541901992, 10715.089217416607, 10726.141908647289, 10762.031417172491, 10806.405647689453, 7850.332721718718, 7943.0071241094865, 7958.482698624571, 7965.163657815961, 8051.59742012897, 3158.9684103158675, 3174.4920812670325, 3189.728873045771, 3190.3619276144864, 3214.5017522284083, 838.6938767349874, 930.4231376546585, 931.2177770672532, 941.802221533472, 1016.6594190945968, 28038.15268016109, 28187.0, 28626.0, 28832.279193020342, 28953.710462895524, 924.4037595750704, 967.2407160379069, 979.3389462113046, 993.4039576254189, 1077.7305673581604, 14867.182304973114, 15084.0, 15181.772273415907, 15366.923165384102, 15532.767008494882, 351833.0, 356213.0, 356252.0, 356338.0, 356922.0, 48757.756211218715, 49223.507764921895, 49367.753161233966, 49759.0, 49799.75100124476, 1202.2005366431226, 1204.47090026224, 1210.6731182580654, 1214.520264495537, 1223.0521345956954, 27085.936415382916, 27183.04859329914, 28057.158285251477, 28190.29524261828, 28281.858590706914, 42605.36091958685, 47297.527024729316, 48846.0, 48917.51082489272, 52805.7359713199, 341116.0, 342598.0, 345222.0, 345669.0, 345719.0, 39002.219955600165, 39272.0, 39296.80351598224, 39470.80264598659, 39582.0, 42172.57827421809, 42433.36349954815, 43109.56890431055, 43323.566764331954, 43407.56592434035, 36357.45463818098, 36492.45261321135, 37077.443838341904, 37692.43461348027, 38009.4298585527, 36711.816440917624, 36827.631723683495, 37052.62947370492, 37129.643443233945, 38067.80966095152, 35185.0, 36150.0, 36319.0, 36445.81777091097, 36456.0, 31995.68004319927, 32907.341853162325, 33117.46348770441, 33629.32741345208, 33708.32583348369, 25305.751170775864, 25384.873075634503, 25622.71886405635, 25926.48147037011, 26037.479250415265], "value": 16446.056932257216, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.8975842665829, 349.50544978854924, 352.5821901047259, 355.32665598690477, 371.54300210740786, 15553.144577048259, 16090.436834710787, 16526.586835329123, 16567.171641417943, 16572.088535130562, 15480.225988700577, 16003.679926401464, 16291.755623665626, 16299.511014669579, 17074.573135671613, 4451.710638808475, 4529.773511324437, 4667.15991121598, 4678.345031695565, 4692.835750748724, 2531.164715643842, 4549.24937385331, 5189.506996835295, 5431.511163995239, 5441.0, 5528.75120619571, 5534.446555344473, 5537.556995440355, 5546.057170281062, 5549.500544950974, 5155.226715992593, 5446.754896029688, 5467.343918729738, 5531.529819965308, 5558.110702287655, 5323.228131920889, 5359.1157459019605, 5366.973165134149, 5370.91943620846, 5373.3014708088085, 11829.585964491287, 11830.0, 12130.090243231705, 12147.878521214852, 12169.14815962883, 1871.316969306207, 1889.1026762287804, 2131.9020704337277, 2207.75714671386, 2320.6170981787986, 8746.169113934166, 8941.46351218929, 9165.862512062324, 9279.443233406017, 9639.228861691117, 1598.9280482378203, 1607.9356825726957, 1641.6880792649358, 1688.7382455719383, 1705.1133410626528, 66826.66586667084, 68727.31272687309, 69694.65152674254, 69832.650836746, 70299.0, 9327.673531426368, 9410.482423466638, 9833.852492212622, 9985.251106167067, 10015.098641122335, 13514.391852366667, 13538.86461135376, 13603.591892243248, 13609.251491167883, 13626.727465450636, 6993.825154371079, 7037.4018208451835, 7145.321194486515, 7212.278772122746, 7270.5274157180675, 6596.505262105361, 6723.764668236686, 6727.192736871607, 6796.93203067963, 6838.589684618939, 4123.422720819088, 4212.620864122244, 4224.598663126998, 4274.957250427518, 4278.89302767427, 1507.8944473886943, 1564.4993602047236, 1568.5294411676452, 1809.5023868436285, 1859.5630026943657, 816.603947085663, 841.2008591837779, 870.4733636150164, 874.807542340684, 913.899471058183, 16454.424095156613, 16681.416150434678, 16863.91568042152, 17331.913340433468, 17415.39046133379, 848.1730312944952, 861.8534849075672, 895.7894894699871, 897.2059727141527, 923.3259720404009, 9296.0, 9308.627654893728, 9593.712188634352, 9626.133647971716, 9638.759031024281, 391437.0, 392851.0, 409298.0, 413040.0, 415071.0, 74294.25705742982, 76041.23958760452, 76621.61689191518, 77495.61252193703, 78205.21794782093, 877.1009715042005, 879.7222549134993, 900.4057322167338, 908.4912449028565, 922.8108237811367, 15041.0, 15056.171910545025, 15214.391424342903, 15225.695486090437, 15293.541193764206, 34819.0, 35065.47401788924, 35639.28721425505, 36129.0, 37254.6274537262, 48119.0, 48135.27797082977, 48877.26684099813, 49145.75427122841, 49199.508004919495, 6903.75836845708, 6960.651967401711, 6999.545029573062, 7006.9649651751415, 7046.718131274896, 9979.301448898797, 11492.82760758606, 11619.128565357802, 11712.180147389941, 11934.104942129548, 8769.91230087691, 9475.33672642936, 9750.463724494937, 10179.541920613443, 10472.528736206737, 4967.354243948408, 8422.91577084246, 10353.689389318333, 10686.984736450026, 10902.563897444013, 10479.371237725762, 10567.418791966516, 10724.195685323788, 10749.785004300027, 10910.836337454786, 7495.287947644965, 7614.124375696866, 7626.084869815658, 7717.845643087219, 7766.106897706836, 8956.910430895869, 9448.0, 9539.809203815747, 9796.412215267106, 9863.0], "value": 7875.365784866605, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.2599559235805, 1407.429990853704, 1462.3054049326572, 1655.528174470276, 1668.0575474856698, 6625.73497060117, 7384.40924726022, 7445.143808462029, 7953.761387158387, 7979.521228726273, 7491.438142139347, 7745.806354841132, 7770.883436748453, 7774.2614451627005, 7796.610169491531, 2145.1097794415336, 2180.1170525937023, 2187.3765976696645, 2189.6824960380736, 2202.4714068623575, 2120.3744895255936, 2141.3040761752413, 2160.2223199648115, 2169.240765731997, 2181.2692747929464, 2142.175262523932, 2149.7635260121374, 2152.5587254612847, 2155.7305336832897, 2174.706414634028, 2117.311873641065, 2118.597466481379, 2124.7875212478784, 2126.553423781008, 2129.4569884679463, 2060.2892002259196, 2092.246791155183, 2095.476130967258, 2106.136484041551, 2159.676048592708, 7945.165757595427, 8000.759977200693, 8004.479708818966, 8020.438569300151, 8024.398170137263, 4511.1654343946475, 4618.699784513996, 4648.558386953234, 4667.13657973276, 4670.696404733681, 2787.7351651593067, 2840.7869409794143, 2917.0811194473886, 2931.4869897767803, 2938.38293958269, 879.9340049496313, 909.377076702461, 920.9401388909766, 923.8845144356956, 928.7445952363087, 10953.616623418222, 10973.067289280421, 10984.505697243643, 11007.944960275147, 11021.228514004022, 4133.359329303963, 4135.441715368447, 4214.946263434142, 4257.318828987409, 4284.057507348379, 9241.075892410705, 9260.907390926139, 9271.304652151115, 9330.066993300752, 9344.645026471124, 4488.214562451558, 4533.365328853963, 4639.721616703008, 4717.914879577647, 4740.7392593407, 3519.225770330523, 4107.240160570304, 4294.055307832272, 4311.417958575615, 4322.330038843984, 3670.3209906167444, 3695.981520092382, 3696.7615848690452, 3768.3028639701743, 3768.566614839274, 1171.9003884669899, 1186.2704436771323, 1198.7003249187703, 1202.5670758526924, 1210.5399948019697, 786.0920636664662, 797.075392544657, 812.6789917982364, 816.7468084893702, 822.8683410654266, 4897.8285759998225, 5014.147594908874, 5035.748212589429, 5101.566366858784, 5126.92309615356, 385.74055708113036, 386.3914334922452, 394.97432666877137, 401.8633664554007, 408.0879234909974, 3457.6369481204615, 3477.3740726668934, 3478.513008178857, 3532.5584301962253, 3545.13144279648, 9123.452592844451, 9290.070992900655, 9454.763630909283, 9465.0, 9687.806243875082, 9514.524273786283, 9576.616935322649, 9587.616495340248, 9632.084951929555, 9749.512524373753, 7119.110111236096, 7154.4991850571005, 7336.33972942427, 7366.889496657554, 7367.2264412235945, 5081.18701007837, 5118.846434606968, 5176.352955880515, 5226.973865130803, 5242.947570524246, 8453.746387608382, 8665.566721664018, 8762.036176020505, 8849.0, 8971.91028089737, 8858.335624828034, 8911.643534258816, 8980.326475514232, 9021.909780902108, 9065.229455496094, 5481.123020316731, 6105.084237364431, 6219.968900155471, 6229.065640154013, 6396.648184349905, 7161.85676286461, 7186.425085993213, 7233.891491627735, 7237.927620723725, 7274.5635261882335, 6437.333944798498, 6560.573562718408, 6591.703373348115, 6622.271550129385, 6685.598864068172, 6433.967830160819, 6452.419282264619, 6456.7740129095255, 6464.0, 6486.578372405778, 5742.799002034909, 5777.364489906023, 5796.82609521715, 5803.535717142703, 5816.621919575214, 4122.3404255319, 4156.9376459352525, 4161.3549899765585, 4217.768022758778, 4387.473503179639, 4205.642520385802, 4241.4062031315025, 4336.154449882242, 4372.9125417492105, 4394.978025109854], "value": 3984.506111650197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.49716738625864, 295.18234490461407, 296.2504862697376, 296.6899589928524, 296.7507293873146, 4972.7265000425, 5117.372525435271, 5117.925235700498, 5130.333056702628, 5136.845894623158, 5014.423341315741, 5057.216131499615, 5075.974620126904, 5086.872828179297, 5108.386993560769, 3697.00180951143, 3833.271678381099, 3951.46655201547, 3988.660963818079, 3989.461422707941, 3947.151362457071, 3950.42718805773, 3950.9209815803665, 3953.48604681391, 3975.761454312736, 3936.350502167139, 3943.605639436062, 3950.2099580083955, 3976.6023397660147, 3979.363301871701, 3830.367989281765, 3970.5235371755575, 3983.103801644636, 3994.0, 3996.320625493673, 3472.392331342005, 3478.8172021512555, 3483.815502729084, 3487.692115456704, 3496.1434448560267, 4950.331705219785, 4969.503049695038, 4970.676906001098, 5027.723475208862, 5039.924401133986, 4556.954430455686, 4565.771711414449, 4570.177368073745, 4570.862874113782, 4591.0, 5072.264521644378, 5273.604479664041, 5285.0, 5291.444398338196, 5394.163904594794, 3611.259691763182, 3629.8366573504254, 3651.8496673547747, 3662.523871896663, 3676.613955534684, 5550.666959982414, 5586.804461843816, 5606.971965140189, 5615.382307946164, 5625.409332020161, 3712.5730540987593, 3774.150816066363, 3779.6204385399133, 3784.962150378516, 3785.1861849701895, 3811.6950643948417, 3819.1979684266616, 3822.8088595570666, 3839.6544311012144, 3872.225554888977, 4421.938734703713, 4432.933505997413, 4452.888677783081, 4458.06380660065, 4458.130664520452, 5219.138842091088, 5288.153895376799, 5334.253204551366, 5349.0, 5389.841184145427, 1307.66654503103, 1322.987914245603, 1326.5423428917009, 1329.322045756671, 1338.8259526261525, 812.8011183504402, 823.7652269103277, 831.1854382704983, 834.891464109674, 836.9079401265856, 4181.393697913846, 4431.911361772811, 4550.768954042666, 4690.147391780296, 4699.78850951708, 5510.421405752419, 5513.917291240635, 5525.723713814293, 5535.640183388067, 5536.972315138399, 4650.302454631765, 4660.464046634613, 4665.486796452387, 4666.65000124992, 4674.94813666929, 2801.2716693659795, 2940.9705902940696, 2949.8643022436518, 2950.3066779306846, 2956.305268261957, 5157.432682404932, 5158.716270605153, 5159.839036216897, 5182.948170518246, 5218.478152184827, 5507.779688812483, 5546.861328466821, 5627.915581266284, 5637.802676906289, 5652.66084034951, 5028.220625803006, 5068.3917929849395, 5079.74601269935, 5081.187010078517, 5084.872878178076, 5533.3083364579425, 5573.16402539606, 5580.804671836466, 5584.525315348241, 5586.86032849182, 5162.838361368662, 5431.4840090191365, 5464.9180262296895, 5482.890342193214, 5490.780368785204, 5196.714180719945, 5218.399884013235, 5238.1618940969265, 5247.816326428557, 5255.605829562722, 3831.559370672297, 3935.842566297316, 3959.3071212538266, 3978.224246271949, 3985.820638071236, 5419.268398766274, 5421.7560209791445, 5474.452554744494, 5501.4223506532835, 5604.579656525859, 5283.630145889751, 5319.521243088141, 5337.866553336197, 5338.813141540028, 5339.199120132012, 5308.097623403954, 5314.681119132864, 5326.147816349366, 5360.142377219626, 5373.650712703662, 5044.225675878326, 5221.347331583552, 5241.820590367137, 5242.292290540729, 5246.396664383645, 5128.923066153936, 5203.297554830201, 5375.19372094189, 5383.842473868137, 5407.864803379947, 5266.157414813764, 5270.472952704698, 5273.182656688219, 5286.7356632169, 5305.946940530545], "value": 3985.097308181405, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.012451031764, 571.3286887906711, 572.364675210516, 576.6223123853874, 579.2701196492419, 11064.723381915455, 11097.16771242156, 11184.832227516583, 11567.479463424144, 11740.647780566575, 13865.306734663276, 14407.423703051865, 14438.783418248708, 14990.700185996273, 15019.624509387271, 615.1111643674892, 771.1478815908424, 786.2098590916121, 786.2177133751896, 786.4062632712323, 753.3445902065183, 783.0485959559135, 785.1716439156687, 786.0371045469283, 788.1173086143527, 817.6443247187462, 818.8198596308803, 819.2053707903324, 820.4257020085934, 825.8307047055339, 804.2158895077282, 809.9838003239961, 811.6063709101111, 811.6753298680516, 811.9797005074861, 594.1562980567604, 596.0254983102615, 597.2623809595146, 600.414595769126, 601.5488383712216, 12857.485700571966, 12883.67790805228, 12912.741745165138, 12958.740825183444, 12971.221726696429, 10944.288621239673, 11748.530058797638, 12039.546246250768, 12067.758644827054, 12244.632661020183, 9381.671641492516, 9584.760380990461, 9815.329123546138, 9857.162141218005, 10143.797124057477, 3256.2347848255877, 3311.6357200707903, 3334.249793796401, 3335.633080361158, 3365.3269346130874, 58964.0, 59478.10782838304, 60287.0, 61598.69200653968, 61680.0, 9144.268458523435, 9152.8627070594, 9155.359124861328, 9164.083591640783, 9341.392809467363, 18235.72646410305, 18405.26378944854, 18410.90794546019, 18541.721874171897, 18627.254909803727, 6022.488088512438, 6105.511559075263, 6139.4781443577795, 6585.078089067534, 6744.898826517606, 3363.882264120744, 3442.1910850950007, 3616.6744992950235, 3641.253543023674, 3676.4117741161285, 2719.157061311, 2837.7587905028304, 2860.270630989126, 2868.0822136916404, 2886.696896825845, 473.7110362678763, 476.10492274523676, 481.35258077885186, 492.0527983631566, 494.1451289269512, 500.0, 517.3636427194572, 518.5540435225703, 532.087469988963, 545.5850681981398, 6786.864262714718, 6867.484938629623, 6940.41006514452, 7053.89419158713, 7055.329743674342, 422.2947677378785, 462.66919152805906, 495.3387228050521, 499.505489565335, 524.9816256431006, 3353.983230083834, 3422.8973130806116, 3458.5849698035895, 3466.6533346665133, 3487.7035451986358, 53394.46605533895, 53578.73210634, 55294.44705552974, 55583.72208138934, 55746.44253557493, 49528.257076143884, 69709.95435068478, 76830.61584692153, 78209.60895195487, 78566.6071669638, 68996.0, 70051.64974175199, 71834.0, 71935.28064719391, 71944.28055719376, 6906.447484201151, 7021.1574611047, 7099.574025558483, 7112.715491380287, 7182.245864184186, 30642.0, 31990.0, 38360.23279534338, 43262.78368608137, 43372.0, 61022.69488652706, 62004.0, 62492.0, 62688.37311626825, 63410.68294658497, 9540.427574345562, 10148.695539133838, 10270.743231418975, 10364.119049880845, 10658.573657053632, 10612.204084693525, 10763.246572739834, 10797.784044319227, 10809.891901080888, 10958.671239862817, 9464.952675236855, 9933.552990115606, 9979.60081596728, 10359.22305827081, 10444.63443779464, 10410.583576656849, 10655.360678359324, 10688.038076573146, 10755.784884302113, 10846.620368287073, 9416.717498475056, 9575.569099390405, 9584.089511496397, 9601.711948641552, 9902.108810207115, 8281.337493000425, 8485.91514084876, 8559.186877246651, 8636.611352489279, 8872.778180545538, 8029.3175080118845, 8043.477173983672, 8144.267015968591, 8164.623276277314, 8489.617967191367], "value": 5942.2908190472945, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 117.0, 115.0, 114.0, 115.0, 116.0, 115.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 134.0, 154.0, 186.0, 134.0, 152.0, 157.0, 139.0, 198.0, 130.0], "value": 154.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 171.0, 163.0, 164.0, 164.0, 162.0, 163.0, 170.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 78.0, 164.0, 84.0, 84.0, 76.0, 75.0, 159.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 149.0, 86.0, 86.0, 86.0, 137.0, 87.0, 86.0, 135.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 148.0, 148.0, 150.0, 147.0, 147.0, 148.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 70.0, 67.0, 63.0, 64.0, 68.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 66.0, 64.0, 65.0, 66.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 84.0, 86.0, 91.0, 85.0, 85.0, 116.0, 87.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 135.0, 136.0, 129.0, 148.0, 146.0, 136.0, 150.0, 149.0], "value": 141.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 185.0, 171.0, 174.0, 173.0, 169.0, 175.0, 168.0, 169.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 75.0, 68.0, 67.0, 70.0, 67.0, 68.0, 68.0], "value": 69.0, "unit": "score"}]}]} 05:41:05 INFO - Return code: 0 05:41:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:41:05 ERROR - # TBPL SUCCESS # 05:41:05 INFO - Running post-action listener: _resource_record_post_action 05:41:05 INFO - ##### 05:41:05 INFO - ##### Finished run-tests step (success) 05:41:05 INFO - ##### 05:41:05 INFO - Running post-run listener: _resource_record_post_run 05:41:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 533553152; Read time: 20; Write time: 529172 05:41:06 INFO - TinderboxPrint: CPU usage
13.4% 05:41:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:41:06 INFO - TinderboxPrint: I/O write bytes / time
533,553,152 / 529,172 05:41:06 INFO - TinderboxPrint: CPU idle
8,271.3 (86.5%) 05:41:06 INFO - TinderboxPrint: CPU user
1,229.0 (12.9%) 05:41:06 INFO - TinderboxPrint: Swap in / out
0 / 0 05:41:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237936640; Read time: 0; Write time: 279228 05:41:06 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295616512; Read time: 20; Write time: 249944 05:41:06 INFO - Running post-run listener: _upload_blobber_files 05:41:06 INFO - Blob upload gear active. 05:41:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:06 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 05:41:06 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:06 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:07 INFO - (blobuploader) - INFO - Done attempting. 05:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:08 INFO - (blobuploader) - INFO - Done attempting. 05:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:12 INFO - (blobuploader) - INFO - Done attempting. 05:41:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:12 INFO - Return code: 0 05:41:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68e7c347ee3741a940099bc45b9b3426284a3627920374fb9dbd58dd57d45bca7c64e44577a7ec477a92f67a53d52e332a9cf596e35e27d030f48edb84625a91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69a3b2351543324e13f800a0791440450512d5bfd7bdacaa5bdfd8f064c3d7c13aacb28b5dba0fc9f9eb250f38db03b77a68886d370693e98ebcace057f7f804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed1e8899fad7c0cacaa9032b003e876150fec1171457cf480b9e82161800fdd52476b43139b1d20cae3d48d3958ae7045dda54786a0d369be3292d8c10f72853"} 05:41:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:12 INFO - Contents: 05:41:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/68e7c347ee3741a940099bc45b9b3426284a3627920374fb9dbd58dd57d45bca7c64e44577a7ec477a92f67a53d52e332a9cf596e35e27d030f48edb84625a91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69a3b2351543324e13f800a0791440450512d5bfd7bdacaa5bdfd8f064c3d7c13aacb28b5dba0fc9f9eb250f38db03b77a68886d370693e98ebcace057f7f804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed1e8899fad7c0cacaa9032b003e876150fec1171457cf480b9e82161800fdd52476b43139b1d20cae3d48d3958ae7045dda54786a0d369be3292d8c10f72853"} 05:41:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:12 INFO - Copying logs to upload dir... 05:41:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.418403 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-10 05:41:12.950987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:12.955076) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360 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/Fx-Team-Non-PGO/sha512/68e7c347ee3741a940099bc45b9b3426284a3627920374fb9dbd58dd57d45bca7c64e44577a7ec477a92f67a53d52e332a9cf596e35e27d030f48edb84625a91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69a3b2351543324e13f800a0791440450512d5bfd7bdacaa5bdfd8f064c3d7c13aacb28b5dba0fc9f9eb250f38db03b77a68886d370693e98ebcace057f7f804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed1e8899fad7c0cacaa9032b003e876150fec1171457cf480b9e82161800fdd52476b43139b1d20cae3d48d3958ae7045dda54786a0d369be3292d8c10f72853"} build_url:https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/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/Fx-Team-Non-PGO/sha512/68e7c347ee3741a940099bc45b9b3426284a3627920374fb9dbd58dd57d45bca7c64e44577a7ec477a92f67a53d52e332a9cf596e35e27d030f48edb84625a91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/69a3b2351543324e13f800a0791440450512d5bfd7bdacaa5bdfd8f064c3d7c13aacb28b5dba0fc9f9eb250f38db03b77a68886d370693e98ebcace057f7f804", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ed1e8899fad7c0cacaa9032b003e876150fec1171457cf480b9e82161800fdd52476b43139b1d20cae3d48d3958ae7045dda54786a0d369be3292d8c10f72853"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:12.980601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:12.980926) ========= 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=14ef55db36f7623abb31b9cf000001d5-1465560489.636648-1311423360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:13.063380) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:41:13.063714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:41:13.064033) ========= ========= Total master_lag: 0.29 =========