builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1467058283.63 results: success (0) buildid: 20160627114219 builduid: 198eaa5d26024137b4fec53212a122a1 revision: 5d888fb5d239f87e99f854add952471d353e33ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.632396) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.632859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.633185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.688450) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.688718) ========= 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=923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 13:11:23-- 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% 67.6M=0s 2016-06-27 13:11:23 (67.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186836 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.932709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.932993) ========= 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=923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.042358 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.986368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:23.986727) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5d888fb5d239f87e99f854add952471d353e33ed --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 5d888fb5d239f87e99f854add952471d353e33ed --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=923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 13:11:24,064 truncating revision to first 12 chars 2016-06-27 13:11:24,064 Setting DEBUG logging. 2016-06-27 13:11:24,064 attempt 1/10 2016-06-27 13:11:24,064 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5d888fb5d239?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 13:11:24,407 unpacking tar archive at: fx-team-5d888fb5d239/testing/mozharness/ program finished with exit code 0 elapsedTime=0.705850 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:24.708269) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:24.708817) ========= script_repo_revision: 5d888fb5d239f87e99f854add952471d353e33ed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:24.709510) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:24.709988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 13:11:24.721898) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-27 13:11:24.722449) ========= /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=923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:11:24 INFO - MultiFileLogger online at 20160627 13:11:24 in /builds/slave/test 13:11:24 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 13:11:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:11:24 INFO - {'append_to_log': False, 13:11:24 INFO - 'base_work_dir': '/builds/slave/test', 13:11:24 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:11:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:11:24 INFO - 'branch': 'Fx-Team-Non-PGO', 13:11:24 INFO - 'buildbot_json_path': 'buildprops.json', 13:11:24 INFO - 'config_files': ('talos/linux_config.py',), 13:11:24 INFO - 'default_actions': ('clobber', 13:11:24 INFO - 'read-buildbot-config', 13:11:24 INFO - 'download-and-extract', 13:11:24 INFO - 'populate-webroot', 13:11:24 INFO - 'create-virtualenv', 13:11:24 INFO - 'install', 13:11:24 INFO - 'run-tests'), 13:11:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:11:24 INFO - 'download_minidump_stackwalk': True, 13:11:24 INFO - 'download_symbols': 'ondemand', 13:11:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:11:24 INFO - 'tooltool.py': '/tools/tooltool.py', 13:11:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:11:24 INFO - '/tools/misc-python/virtualenv.py')}, 13:11:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:11:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:11:24 INFO - 'installer_path': 'installer.exe', 13:11:24 INFO - 'log_level': 'info', 13:11:24 INFO - 'log_name': 'talos', 13:11:24 INFO - 'log_to_console': True, 13:11:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:11:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:11:24 INFO - 'opt_config_files': (), 13:11:24 INFO - 'pip_index': False, 13:11:24 INFO - 'sps_profile': False, 13:11:24 INFO - 'sps_profile_interval': 0, 13:11:24 INFO - 'suite': 'dromaeojs-e10s', 13:11:24 INFO - 'system_bits': '32', 13:11:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:11:24 INFO - 'title': 'talos-linux64-ix-007', 13:11:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:11:24 INFO - 'use_talos_json': True, 13:11:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:11:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:11:24 INFO - 'work_dir': 'build'} 13:11:24 INFO - ##### 13:11:24 INFO - ##### Running clobber step. 13:11:24 INFO - ##### 13:11:24 INFO - Running pre-action listener: _resource_record_pre_action 13:11:24 INFO - Running main action method: clobber 13:11:24 INFO - rmtree: /builds/slave/test/build 13:11:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:11:26 INFO - Running post-action listener: _resource_record_post_action 13:11:26 INFO - ##### 13:11:26 INFO - ##### Finished clobber step (success) 13:11:26 INFO - ##### 13:11:26 INFO - ##### 13:11:26 INFO - ##### Running read-buildbot-config step. 13:11:26 INFO - ##### 13:11:26 INFO - Running pre-action listener: _resource_record_pre_action 13:11:26 INFO - Running main action method: read_buildbot_config 13:11:26 INFO - Using buildbot properties: 13:11:26 INFO - { 13:11:26 INFO - "project": "", 13:11:26 INFO - "product": "firefox", 13:11:26 INFO - "script_repo_revision": "production", 13:11:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:11:26 INFO - "repository": "", 13:11:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:11:26 INFO - "buildid": "20160627114219", 13:11:26 INFO - "pgo_build": "False", 13:11:26 INFO - "basedir": "/builds/slave/test", 13:11:26 INFO - "buildnumber": 1617, 13:11:26 INFO - "slavename": "talos-linux64-ix-007", 13:11:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:11:26 INFO - "platform": "ubuntu64_hw", 13:11:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:11:26 INFO - "branch": "fx-team", 13:11:26 INFO - "repo_path": "integration/fx-team", 13:11:26 INFO - "revision": "5d888fb5d239f87e99f854add952471d353e33ed", 13:11:26 INFO - "stage_platform": "linux64", 13:11:26 INFO - "builduid": "198eaa5d26024137b4fec53212a122a1", 13:11:26 INFO - "slavebuilddir": "test" 13:11:26 INFO - } 13:11:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:11:26 INFO - Running post-action listener: _resource_record_post_action 13:11:26 INFO - ##### 13:11:26 INFO - ##### Finished read-buildbot-config step (success) 13:11:26 INFO - ##### 13:11:26 INFO - ##### 13:11:26 INFO - ##### Running download-and-extract step. 13:11:26 INFO - ##### 13:11:26 INFO - Running pre-action listener: _resource_record_pre_action 13:11:26 INFO - Running main action method: download_and_extract 13:11:26 INFO - mkdir: /builds/slave/test/build/tests 13:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:26 INFO - https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:11:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:11:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:11:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:29 INFO - Downloaded 1361 bytes. 13:11:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:11:29 INFO - Using the following test package requirements: 13:11:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:11:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:11:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:11:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'jsshell-linux-x86_64.zip'], 13:11:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:11:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:11:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:11:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:11:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:11:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:11:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:11:29 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')]} 13:11:29 INFO - https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:11:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:11:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:11:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:33 INFO - Downloaded 22713224 bytes. 13:11:33 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'] 13:11:33 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 13:11:34 INFO - Return code: 0 13:11: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 13:11: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')]} 13:11:34 INFO - https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:11:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:11:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:11:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:42 INFO - Downloaded 22713224 bytes. 13:11:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:11:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 13:11:43 INFO - Return code: 0 13:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:43 INFO - https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:44 INFO - Downloaded 14405245 bytes. 13:11:45 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'] 13:11:45 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 13:11:45 INFO - Return code: 0 13:11: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')]} 13:11:45 INFO - https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:11:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:11:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:11:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VxwJSmC0T4-nVinl0q-pZA/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 13:11:47 INFO - Downloaded 56287577 bytes. 13:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:11:47 INFO - mkdir: /builds/slave/test/properties 13:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:47 INFO - Contents: 13:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:11:48 INFO - Running post-action listener: _resource_record_post_action 13:11:48 INFO - Running post-action listener: set_extra_try_arguments 13:11:48 INFO - ##### 13:11:48 INFO - ##### Finished download-and-extract step (success) 13:11:48 INFO - ##### 13:11:48 INFO - ##### 13:11:48 INFO - ##### Running populate-webroot step. 13:11:48 INFO - ##### 13:11:48 INFO - Running pre-action listener: _resource_record_pre_action 13:11:48 INFO - Running main action method: populate_webroot 13:11:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:48 INFO - '--tppagecycles', 13:11:48 INFO - '7'], 13:11:48 INFO - 'tests': ['tsvgm']}}, 13:11:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:11:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:11:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:11:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['damp', 'tps']}, 13:11:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'tests': ['damp', 'tps']}, 13:11:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['dromaeo_dom']}, 13:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['basic_compositor_video']}, 13:11:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:11:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['a11yr', 13:11:48 INFO - 'ts_paint', 13:11:48 INFO - 'tpaint', 13:11:48 INFO - 'sessionrestore', 13:11:48 INFO - 'sessionrestore_no_auto_restore', 13:11:48 INFO - 'tabpaint']}, 13:11:48 INFO - 'other-e10s': {'tests': ['a11yr', 13:11:48 INFO - 'ts_paint', 13:11:48 INFO - 'tpaint', 13:11:48 INFO - 'sessionrestore', 13:11:48 INFO - 'sessionrestore_no_auto_restore', 13:11:48 INFO - 'tabpaint']}, 13:11:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:11:48 INFO - 'ts_paint', 13:11:48 INFO - 'tpaint', 13:11:48 INFO - 'sessionrestore', 13:11:48 INFO - 'sessionrestore_no_auto_restore', 13:11:48 INFO - 'tabpaint']}, 13:11:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:11:48 INFO - 'ts_paint', 13:11:48 INFO - 'tpaint', 13:11:48 INFO - 'sessionrestore', 13:11:48 INFO - 'sessionrestore_no_auto_restore', 13:11:48 INFO - 'tabpaint']}, 13:11:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['a11yr', 13:11:48 INFO - 'ts_paint', 13:11:48 INFO - 'tpaint', 13:11:48 INFO - 'sessionrestore', 13:11:48 INFO - 'sessionrestore_no_auto_restore', 13:11:48 INFO - 'tabpaint']}, 13:11:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['a11yr', 13:11:48 INFO - 'ts_paint', 13:11:48 INFO - 'tpaint', 13:11:48 INFO - 'sessionrestore', 13:11:48 INFO - 'sessionrestore_no_auto_restore', 13:11:48 INFO - 'tabpaint']}, 13:11:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['tsvgx', 13:11:48 INFO - 'tsvgr_opacity', 13:11:48 INFO - 'tart', 13:11:48 INFO - 'tscrollx', 13:11:48 INFO - 'cart']}, 13:11:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:11:48 INFO - 'tsvgr_opacity', 13:11:48 INFO - 'tart', 13:11:48 INFO - 'tscrollx', 13:11:48 INFO - 'cart']}, 13:11:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'talos_options': ['--disable-e10s'], 13:11:48 INFO - 'tests': ['tp5o']}, 13:11:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'tests': ['tp5o']}, 13:11:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'talos_options': ['--disable-e10s', 13:11:48 INFO - '--xperf_path', 13:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:48 INFO - 'tests': ['tp5n']}, 13:11:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:48 INFO - 'talos_options': ['--xperf_path', 13:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:48 INFO - 'tests': ['tp5n']}}, 13:11:48 INFO - 'talos.zip': {'path': '', 13:11:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:48 INFO - Running post-action listener: _resource_record_post_action 13:11:48 INFO - ##### 13:11:48 INFO - ##### Finished populate-webroot step (success) 13:11:48 INFO - ##### 13:11:48 INFO - ##### 13:11:48 INFO - ##### Running create-virtualenv step. 13:11:48 INFO - ##### 13:11:48 INFO - Running pre-action listener: _resource_record_pre_action 13:11:48 INFO - Running main action method: create_virtualenv 13:11:48 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:48 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 13:11:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:48 INFO - Using real prefix '/usr' 13:11:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:48 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:51 INFO - Installing pip.................done. 13:11:51 INFO - Return code: 0 13:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:11:51 INFO - Using env: {'DISPLAY': ':0', 13:11:51 INFO - 'HOME': '/home/cltbld', 13:11:51 INFO - 'LANG': 'en_US.UTF-8', 13:11:51 INFO - 'LANGUAGE': 'en_US:en', 13:11:51 INFO - 'LOGNAME': 'cltbld', 13:11:51 INFO - 'MAIL': '/var/mail/cltbld', 13:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:51 INFO - 'MOZ_NO_REMOTE': '1', 13:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:51 INFO - 'NO_EM_RESTART': '1', 13:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:51 INFO - 'PWD': '/builds/slave/test', 13:11:51 INFO - 'SHELL': '/bin/bash', 13:11:51 INFO - 'SHLVL': '1', 13:11:51 INFO - 'TERM': 'linux', 13:11:51 INFO - 'TMOUT': '86400', 13:11:51 INFO - 'USER': 'cltbld', 13:11:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:51 INFO - '_': '/tools/buildbot/bin/python'} 13:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:51 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 13:11:51 INFO - Cleaning up... 13:11:51 INFO - Return code: 0 13:11:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:11:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:11:51 INFO - Using env: {'DISPLAY': ':0', 13:11:51 INFO - 'HOME': '/home/cltbld', 13:11:51 INFO - 'LANG': 'en_US.UTF-8', 13:11:51 INFO - 'LANGUAGE': 'en_US:en', 13:11:51 INFO - 'LOGNAME': 'cltbld', 13:11:51 INFO - 'MAIL': '/var/mail/cltbld', 13:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:51 INFO - 'MOZ_NO_REMOTE': '1', 13:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:51 INFO - 'NO_EM_RESTART': '1', 13:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:51 INFO - 'PWD': '/builds/slave/test', 13:11:51 INFO - 'SHELL': '/bin/bash', 13:11:51 INFO - 'SHLVL': '1', 13:11:51 INFO - 'TERM': 'linux', 13:11:51 INFO - 'TMOUT': '86400', 13:11:51 INFO - 'USER': 'cltbld', 13:11:51 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:51 INFO - '_': '/tools/buildbot/bin/python'} 13:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:51 INFO - Downloading/unpacking psutil>=3.1.1 13:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:53 INFO - Installing collected packages: psutil 13:11:53 INFO - Running setup.py install for psutil 13:11:53 INFO - building 'psutil._psutil_linux' extension 13:11:53 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 13:11:54 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 13:11:54 INFO - building 'psutil._psutil_posix' extension 13:11:54 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 13:11:54 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 13:11:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:55 INFO - Successfully installed psutil 13:11:55 INFO - Cleaning up... 13:11:55 INFO - Return code: 0 13:11:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:11:55 INFO - Using env: {'DISPLAY': ':0', 13:11:55 INFO - 'HOME': '/home/cltbld', 13:11:55 INFO - 'LANG': 'en_US.UTF-8', 13:11:55 INFO - 'LANGUAGE': 'en_US:en', 13:11:55 INFO - 'LOGNAME': 'cltbld', 13:11:55 INFO - 'MAIL': '/var/mail/cltbld', 13:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:55 INFO - 'MOZ_NO_REMOTE': '1', 13:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:55 INFO - 'NO_EM_RESTART': '1', 13:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:55 INFO - 'PWD': '/builds/slave/test', 13:11:55 INFO - 'SHELL': '/bin/bash', 13:11:55 INFO - 'SHLVL': '1', 13:11:55 INFO - 'TERM': 'linux', 13:11:55 INFO - 'TMOUT': '86400', 13:11:55 INFO - 'USER': 'cltbld', 13:11:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:55 INFO - '_': '/tools/buildbot/bin/python'} 13:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11: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 13:11:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:11:57 INFO - Installing collected packages: mozsystemmonitor 13:11:57 INFO - Running setup.py install for mozsystemmonitor 13:11:57 INFO - Successfully installed mozsystemmonitor 13:11:57 INFO - Cleaning up... 13:11:57 INFO - Return code: 0 13:11:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:11:57 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')]} 13:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:57 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')]} 13:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:57 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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:11:57 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 13:11:57 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 13:11:57 INFO - Using env: {'DISPLAY': ':0', 13:11:57 INFO - 'HOME': '/home/cltbld', 13:11:57 INFO - 'LANG': 'en_US.UTF-8', 13:11:57 INFO - 'LANGUAGE': 'en_US:en', 13:11:57 INFO - 'LOGNAME': 'cltbld', 13:11:57 INFO - 'MAIL': '/var/mail/cltbld', 13:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:57 INFO - 'MOZ_NO_REMOTE': '1', 13:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:57 INFO - 'NO_EM_RESTART': '1', 13:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:57 INFO - 'PWD': '/builds/slave/test', 13:11:57 INFO - 'SHELL': '/bin/bash', 13:11:57 INFO - 'SHLVL': '1', 13:11:57 INFO - 'TERM': 'linux', 13:11:57 INFO - 'TMOUT': '86400', 13:11:57 INFO - 'USER': 'cltbld', 13:11:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:57 INFO - '_': '/tools/buildbot/bin/python'} 13:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:57 INFO - Downloading/unpacking jsonschema==2.5.1 13:11:57 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 13:11:57 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 13:11:57 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 13:11:57 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 13:11:57 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 13:11:57 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 13:11:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:11:59 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 13:11:59 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 13:11:59 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 13:11:59 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 13:11:59 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 13:11:59 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 13:11:59 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:59 INFO - warning: no files found matching '*.txt' 13:11:59 INFO - no previously-included directories found matching 'build' 13:11:59 INFO - no previously-included directories found matching 'dist' 13:11:59 INFO - no previously-included directories found matching '.git*' 13:11:59 INFO - Installing collected packages: jsonschema, functools32 13:11:59 INFO - Running setup.py install for functools32 13:11:59 INFO - warning: no files found matching '*.txt' 13:11:59 INFO - no previously-included directories found matching 'build' 13:11:59 INFO - no previously-included directories found matching 'dist' 13:11:59 INFO - no previously-included directories found matching '.git*' 13:11:59 INFO - Successfully installed jsonschema functools32 13:11:59 INFO - Cleaning up... 13:12:00 INFO - Return code: 0 13:12:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:12:00 INFO - Using env: {'DISPLAY': ':0', 13:12:00 INFO - 'HOME': '/home/cltbld', 13:12:00 INFO - 'LANG': 'en_US.UTF-8', 13:12:00 INFO - 'LANGUAGE': 'en_US:en', 13:12:00 INFO - 'LOGNAME': 'cltbld', 13:12:00 INFO - 'MAIL': '/var/mail/cltbld', 13:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:00 INFO - 'MOZ_NO_REMOTE': '1', 13:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:00 INFO - 'NO_EM_RESTART': '1', 13:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:00 INFO - 'PWD': '/builds/slave/test', 13:12:00 INFO - 'SHELL': '/bin/bash', 13:12:00 INFO - 'SHLVL': '1', 13:12:00 INFO - 'TERM': 'linux', 13:12:00 INFO - 'TMOUT': '86400', 13:12:00 INFO - 'USER': 'cltbld', 13:12:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:00 INFO - '_': '/tools/buildbot/bin/python'} 13:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:00 INFO - Downloading/unpacking blobuploader==1.2.4 13:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:02 INFO - Downloading blobuploader-1.2.4.tar.gz 13:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:12:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:12:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:02 INFO - Downloading docopt-0.6.1.tar.gz 13:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:12:02 INFO - Installing collected packages: blobuploader, requests, docopt 13:12:02 INFO - Running setup.py install for blobuploader 13:12:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:12:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:12:02 INFO - Running setup.py install for requests 13:12:03 INFO - Running setup.py install for docopt 13:12:03 INFO - Successfully installed blobuploader requests docopt 13:12:03 INFO - Cleaning up... 13:12:03 INFO - Return code: 0 13:12:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:03 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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:12:03 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 13:12:03 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 13:12:03 INFO - Using env: {'DISPLAY': ':0', 13:12:03 INFO - 'HOME': '/home/cltbld', 13:12:03 INFO - 'LANG': 'en_US.UTF-8', 13:12:03 INFO - 'LANGUAGE': 'en_US:en', 13:12:03 INFO - 'LOGNAME': 'cltbld', 13:12:03 INFO - 'MAIL': '/var/mail/cltbld', 13:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:03 INFO - 'MOZ_NO_REMOTE': '1', 13:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:03 INFO - 'NO_EM_RESTART': '1', 13:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:03 INFO - 'PWD': '/builds/slave/test', 13:12:03 INFO - 'SHELL': '/bin/bash', 13:12:03 INFO - 'SHLVL': '1', 13:12:03 INFO - 'TERM': 'linux', 13:12:03 INFO - 'TMOUT': '86400', 13:12:03 INFO - 'USER': 'cltbld', 13:12:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:03 INFO - '_': '/tools/buildbot/bin/python'} 13:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:03 INFO - Running setup.py (path:/tmp/pip-5cwbo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:03 INFO - Running setup.py (path:/tmp/pip-QhyxUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:03 INFO - Running setup.py (path:/tmp/pip-SAsxcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:03 INFO - Running setup.py (path:/tmp/pip-wu9OgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:03 INFO - Running setup.py (path:/tmp/pip-NSn5F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:04 INFO - Running setup.py (path:/tmp/pip-zswdL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:04 INFO - Running setup.py (path:/tmp/pip-YlqbHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:04 INFO - Running setup.py (path:/tmp/pip-usVdqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:04 INFO - Running setup.py (path:/tmp/pip-unJzPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:04 INFO - Running setup.py (path:/tmp/pip-KM0g_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:04 INFO - Running setup.py (path:/tmp/pip-SEcPFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:04 INFO - Running setup.py (path:/tmp/pip-BZ3Iv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:04 INFO - Running setup.py (path:/tmp/pip-r8kCgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:04 INFO - Running setup.py (path:/tmp/pip-G5faiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:04 INFO - Running setup.py (path:/tmp/pip-IaCxUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:04 INFO - Running setup.py (path:/tmp/pip-zKPgsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:04 INFO - Running setup.py (path:/tmp/pip-FxTihB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:12:04 INFO - Running setup.py install for manifestparser 13:12:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Running setup.py install for mozcrash 13:12:05 INFO - Running setup.py install for mozdebug 13:12:05 INFO - Running setup.py install for mozdevice 13:12:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Running setup.py install for mozfile 13:12:05 INFO - Running setup.py install for mozhttpd 13:12:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Running setup.py install for mozinfo 13:12:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Running setup.py install for mozInstall 13:12:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Running setup.py install for mozleak 13:12:05 INFO - Running setup.py install for mozlog 13:12:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:12:05 INFO - Running setup.py install for moznetwork 13:12:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:12:06 INFO - Running setup.py install for mozprocess 13:12:06 INFO - Running setup.py install for mozprofile 13:12:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:12:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:12:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:12:06 INFO - Running setup.py install for mozrunner 13:12:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:12:06 INFO - Running setup.py install for mozscreenshot 13:12:06 INFO - Running setup.py install for moztest 13:12:06 INFO - Running setup.py install for mozversion 13:12:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:12:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:12:06 INFO - Cleaning up... 13:12:06 INFO - Return code: 0 13:12:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:06 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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:12:06 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 13:12:06 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 13:12:06 INFO - Using env: {'DISPLAY': ':0', 13:12:06 INFO - 'HOME': '/home/cltbld', 13:12:06 INFO - 'LANG': 'en_US.UTF-8', 13:12:06 INFO - 'LANGUAGE': 'en_US:en', 13:12:06 INFO - 'LOGNAME': 'cltbld', 13:12:06 INFO - 'MAIL': '/var/mail/cltbld', 13:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:06 INFO - 'MOZ_NO_REMOTE': '1', 13:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:06 INFO - 'NO_EM_RESTART': '1', 13:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:06 INFO - 'PWD': '/builds/slave/test', 13:12:06 INFO - 'SHELL': '/bin/bash', 13:12:06 INFO - 'SHLVL': '1', 13:12:06 INFO - 'TERM': 'linux', 13:12:06 INFO - 'TMOUT': '86400', 13:12:06 INFO - 'USER': 'cltbld', 13:12:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:06 INFO - '_': '/tools/buildbot/bin/python'} 13:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:06 INFO - Running setup.py (path:/tmp/pip-xtiNRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:07 INFO - Running setup.py (path:/tmp/pip-Y5j6nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:07 INFO - Running setup.py (path:/tmp/pip-zihOg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:07 INFO - Running setup.py (path:/tmp/pip-tGSPPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:07 INFO - Running setup.py (path:/tmp/pip-kc9Cqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:07 INFO - Running setup.py (path:/tmp/pip-rmi6Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:07 INFO - Running setup.py (path:/tmp/pip-q4Hxlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:07 INFO - Running setup.py (path:/tmp/pip-yJdBq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:07 INFO - Running setup.py (path:/tmp/pip-LUl2lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:07 INFO - Running setup.py (path:/tmp/pip-OGpVYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:07 INFO - Running setup.py (path:/tmp/pip-FiOisb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:07 INFO - Running setup.py (path:/tmp/pip-mmJWg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:07 INFO - Running setup.py (path:/tmp/pip-4inql3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:07 INFO - Running setup.py (path:/tmp/pip-MEtDVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:07 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)) 13:12:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:07 INFO - Running setup.py (path:/tmp/pip-6JIWUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:08 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)) 13:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:08 INFO - Running setup.py (path:/tmp/pip-UNRG3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:08 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)) 13:12:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:08 INFO - Running setup.py (path:/tmp/pip-hEe749-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 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)) 13:12:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:10 INFO - Downloading blessings-1.6.tar.gz 13:12:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:12:10 INFO - Installing collected packages: blessings 13:12:10 INFO - Running setup.py install for blessings 13:12:10 INFO - Successfully installed blessings 13:12:10 INFO - Cleaning up... 13:12:10 INFO - Return code: 0 13:12:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:10 INFO - Reading from file tmpfile_stdout 13:12:10 INFO - Current package versions: 13:12:10 INFO - argparse == 1.2.1 13:12:10 INFO - blessings == 1.6 13:12:10 INFO - blobuploader == 1.2.4 13:12:10 INFO - docopt == 0.6.1 13:12:10 INFO - functools32 == 3.2.3-2 13:12:10 INFO - jsonschema == 2.5.1 13:12:10 INFO - manifestparser == 1.1 13:12:10 INFO - mozInstall == 1.12 13:12:10 INFO - mozcrash == 0.17 13:12:10 INFO - mozdebug == 0.1 13:12:10 INFO - mozdevice == 0.48 13:12:10 INFO - mozfile == 1.2 13:12:10 INFO - mozhttpd == 0.7 13:12:10 INFO - mozinfo == 0.9 13:12:10 INFO - mozleak == 0.1 13:12:10 INFO - mozlog == 3.2 13:12:10 INFO - moznetwork == 0.27 13:12:10 INFO - mozprocess == 0.22 13:12:10 INFO - mozprofile == 0.28 13:12:10 INFO - mozrunner == 6.11 13:12:10 INFO - mozscreenshot == 0.1 13:12:10 INFO - mozsystemmonitor == 0.3 13:12:10 INFO - moztest == 0.7 13:12:10 INFO - mozversion == 1.4 13:12:10 INFO - psutil == 3.1.1 13:12:10 INFO - requests == 1.2.3 13:12:10 INFO - wsgiref == 0.1.2 13:12:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:10 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')]} 13:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:10 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')]} 13:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:10 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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:12:10 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 13:12:10 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 13:12:10 INFO - Using env: {'DISPLAY': ':0', 13:12:10 INFO - 'HOME': '/home/cltbld', 13:12:10 INFO - 'LANG': 'en_US.UTF-8', 13:12:10 INFO - 'LANGUAGE': 'en_US:en', 13:12:10 INFO - 'LOGNAME': 'cltbld', 13:12:10 INFO - 'MAIL': '/var/mail/cltbld', 13:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:10 INFO - 'MOZ_NO_REMOTE': '1', 13:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:10 INFO - 'NO_EM_RESTART': '1', 13:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:10 INFO - 'PWD': '/builds/slave/test', 13:12:10 INFO - 'SHELL': '/bin/bash', 13:12:10 INFO - 'SHLVL': '1', 13:12:10 INFO - 'TERM': 'linux', 13:12:10 INFO - 'TMOUT': '86400', 13:12:10 INFO - 'USER': 'cltbld', 13:12:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:10 INFO - '_': '/tools/buildbot/bin/python'} 13:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 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)) 13:12:10 INFO - Cleaning up... 13:12:10 INFO - Return code: 0 13:12:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:12:10 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')]} 13:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:10 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')]} 13:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:10 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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:12:10 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 13:12:10 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 13:12:10 INFO - Using env: {'DISPLAY': ':0', 13:12:10 INFO - 'HOME': '/home/cltbld', 13:12:10 INFO - 'LANG': 'en_US.UTF-8', 13:12:10 INFO - 'LANGUAGE': 'en_US:en', 13:12:10 INFO - 'LOGNAME': 'cltbld', 13:12:10 INFO - 'MAIL': '/var/mail/cltbld', 13:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:10 INFO - 'MOZ_NO_REMOTE': '1', 13:12:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:10 INFO - 'NO_EM_RESTART': '1', 13:12:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:10 INFO - 'PWD': '/builds/slave/test', 13:12:10 INFO - 'SHELL': '/bin/bash', 13:12:10 INFO - 'SHLVL': '1', 13:12:10 INFO - 'TERM': 'linux', 13:12:10 INFO - 'TMOUT': '86400', 13:12:10 INFO - 'USER': 'cltbld', 13:12:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:10 INFO - '_': '/tools/buildbot/bin/python'} 13:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:12:11 INFO - Cleaning up... 13:12:11 INFO - Return code: 0 13:12:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:12:11 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')]} 13:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:11 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')]} 13:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:11 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 0x7f9702744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26257d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, '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': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', '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 13:12:11 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 13:12:11 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 13:12:11 INFO - Using env: {'DISPLAY': ':0', 13:12:11 INFO - 'HOME': '/home/cltbld', 13:12:11 INFO - 'LANG': 'en_US.UTF-8', 13:12:11 INFO - 'LANGUAGE': 'en_US:en', 13:12:11 INFO - 'LOGNAME': 'cltbld', 13:12:11 INFO - 'MAIL': '/var/mail/cltbld', 13:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:11 INFO - 'MOZ_NO_REMOTE': '1', 13:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:11 INFO - 'NO_EM_RESTART': '1', 13:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:11 INFO - 'PWD': '/builds/slave/test', 13:12:11 INFO - 'SHELL': '/bin/bash', 13:12:11 INFO - 'SHLVL': '1', 13:12:11 INFO - 'TERM': 'linux', 13:12:11 INFO - 'TMOUT': '86400', 13:12:11 INFO - 'USER': 'cltbld', 13:12:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:11 INFO - '_': '/tools/buildbot/bin/python'} 13:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:11 INFO - Downloading/unpacking flake8 13:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:12:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:12:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 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 13:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:12:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:12:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:12:13 INFO - no previously-included directories found matching 'docs/_build' 13:12:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:12:13 INFO - Running setup.py install for pep8 13:12:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:12:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:12:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:12:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:12:14 INFO - no previously-included directories found matching 'docs/_build' 13:12:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:12:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:12:14 INFO - Cleaning up... 13:12:14 INFO - Return code: 0 13:12:14 INFO - Running post-action listener: _resource_record_post_action 13:12:14 INFO - Running post-action listener: _start_resource_monitoring 13:12:14 INFO - Starting resource monitoring. 13:12:14 INFO - ##### 13:12:14 INFO - ##### Finished create-virtualenv step (success) 13:12:14 INFO - ##### 13:12:14 INFO - ##### 13:12:14 INFO - ##### Running install step. 13:12:14 INFO - ##### 13:12:14 INFO - Running pre-action listener: _resource_record_pre_action 13:12:14 INFO - Running main action method: install 13:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:14 INFO - Reading from file tmpfile_stdout 13:12:14 INFO - Detecting whether we're running mozinstall >=1.0... 13:12:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:12:14 INFO - Reading from file tmpfile_stdout 13:12:14 INFO - Output received: 13:12:14 INFO - Usage: mozinstall [options] installer 13:12:14 INFO - Options: 13:12:14 INFO - -h, --help show this help message and exit 13:12:14 INFO - -d DEST, --destination=DEST 13:12:14 INFO - Directory to install application into. [default: 13:12:14 INFO - "/builds/slave/test"] 13:12:14 INFO - --app=APP Application being installed. [default: firefox] 13:12:14 INFO - mkdir: /builds/slave/test/build/application 13:12:14 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'] 13:12:14 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 13:12:30 INFO - Reading from file tmpfile_stdout 13:12:30 INFO - Output received: 13:12:30 INFO - /builds/slave/test/build/application/firefox/firefox 13:12:30 INFO - Running post-action listener: _resource_record_post_action 13:12:30 INFO - ##### 13:12:30 INFO - ##### Finished install step (success) 13:12:30 INFO - ##### 13:12:30 INFO - ##### 13:12:30 INFO - ##### Running run-tests step. 13:12:30 INFO - ##### 13:12:30 INFO - Running pre-action listener: _resource_record_pre_action 13:12:30 INFO - Running main action method: run_tests 13:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:12:30 INFO - Python 2.7.3 13:12:30 INFO - Return code: 0 13:12:30 INFO - grabbing minidump binary from tooltool 13:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:12:30 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 0x26b4520>, '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 0x26b5420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b58b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:12:30 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 13:12:30 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 13:12:30 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 13:12:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:12:30 INFO - Return code: 0 13:12:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:12:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:12:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:12:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:12:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:12:31 INFO - Return code: 0 13:12:31 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/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 13:12:31 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/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 13:12:31 INFO - Using env: {'DISPLAY': ':0', 13:12:31 INFO - 'HOME': '/home/cltbld', 13:12:31 INFO - 'LANG': 'en_US.UTF-8', 13:12:31 INFO - 'LANGUAGE': 'en_US:en', 13:12:31 INFO - 'LOGNAME': 'cltbld', 13:12:31 INFO - 'MAIL': '/var/mail/cltbld', 13:12:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:12:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:31 INFO - 'MOZ_NO_REMOTE': '1', 13:12:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:31 INFO - 'NO_EM_RESTART': '1', 13:12:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:31 INFO - 'PWD': '/builds/slave/test', 13:12:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:12:31 INFO - 'SHELL': '/bin/bash', 13:12:31 INFO - 'SHLVL': '1', 13:12:31 INFO - 'TERM': 'linux', 13:12:31 INFO - 'TMOUT': '86400', 13:12:31 INFO - 'USER': 'cltbld', 13:12:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461', 13:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:31 INFO - '_': '/tools/buildbot/bin/python'} 13:12:31 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/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 13:12:31 INFO - mozversion application_buildid: 20160627114219 13:12:31 INFO - mozversion application_changeset: 5d888fb5d239f87e99f854add952471d353e33ed 13:12:31 INFO - mozversion application_display_name: Nightly 13:12:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:12:31 INFO - mozversion application_name: Firefox 13:12:31 INFO - mozversion application_remotingname: firefox 13:12:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:12:31 INFO - mozversion application_vendor: Mozilla 13:12:31 INFO - mozversion application_version: 50.0a1 13:12:31 INFO - mozversion platform_buildid: 20160627114219 13:12:31 INFO - mozversion platform_changeset: 5d888fb5d239f87e99f854add952471d353e33ed 13:12:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:12:31 INFO - mozversion platform_version: 50.0a1 13:12:31 INFO - using testdate: 1467058351 13:12:31 INFO - actual date: 1467058351 13:12:31 INFO - starting webserver on 'localhost:36719' 13:12:31 INFO - SUITE-START | Running 2 tests 13:12:31 INFO - TEST-START | dromaeo_css 13:12:31 INFO - operating with platform_type : linux_ 13:12:31 INFO - Initialising browser for dromaeo_css test... 13:12:31 INFO - TEST-INFO | started process 3327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUEIyl/profile http://localhost:36719/getInfo.html) 13:12:38 INFO - PROCESS | 3327 | __metrics Screen width/height:1600/1200 13:12:38 INFO - PROCESS | 3327 | colorDepth:24 13:12:38 INFO - PROCESS | 3327 | Browser inner width/height: 1024/697 13:12:38 INFO - PROCESS | 3327 | __metrics 13:12:38 ERROR - PROCESS | 3327 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:12:39 INFO - TEST-INFO | 3327: exit 0 13:12:39 INFO - Browser initialized. 13:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:12:39 INFO - TEST-INFO | started process 3447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUEIyl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:51 INFO - PROCESS | 3447 | RSS: Main: 186339328 13:12:51 INFO - PROCESS | 3447 | 13:13:41 INFO - PROCESS | 3447 | 1467058421384 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] 13:15:53 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:36719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36719/tests/dromaeo/cssquery-ext.html) 13:15:54 INFO - PROCESS | 3447 | RSS: Main: 189378560 13:15:54 INFO - PROCESS | 3447 | 13:18:56 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:36719/tests/dromaeo/cssquery-ext.html (next: http://localhost:36719/tests/dromaeo/cssquery-jquery.html) 13:18:57 INFO - PROCESS | 3447 | RSS: Main: 188276736 13:18:57 INFO - PROCESS | 3447 | 13:21:59 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:36719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36719/tests/dromaeo/cssquery-mootools.html) 13:22:00 INFO - PROCESS | 3447 | RSS: Main: 189464576 13:22:00 INFO - PROCESS | 3447 | 13:25:01 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:36719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36719/tests/dromaeo/cssquery-prototype.html) 13:25:02 INFO - PROCESS | 3447 | RSS: Main: 186847232 13:25:02 INFO - PROCESS | 3447 | 13:28:05 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:36719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36719/tests/dromaeo/cssquery-yui.html) 13:28:05 INFO - PROCESS | 3447 | RSS: Main: 189222912 13:28:05 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | Cycle 1(1): loaded http://localhost:36719/tests/dromaeo/cssquery-yui.html (next: http://localhost:36719/tests/dromaeo/cssquery-dojo.html) 13:31:08 INFO - PROCESS | 3447 | RSS: Main: 190025728 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | __start_tp_report 13:31:08 INFO - PROCESS | 3447 | _x_x_mozilla_page_load 13:31:08 INFO - PROCESS | 3447 | _x_x_mozilla_page_load_details 13:31:08 INFO - PROCESS | 3447 | |i|pagename|runs| 13:31:08 INFO - PROCESS | 3447 | |0;dojo.html;2661.4544018476213;2683.8389696618206;2689.94620107598;2692.7711144552713;2695.3396417877616;4809.4469136049365;4814.7351895645725;4865.124277630025;4903.362562866822;4947.678400903938;4823.8794030149265;4932.704037757728;4951.257311403282;4968.552830245278;4974.054929563389;4508.616767574752;4544.386507821435;4585.335126406669;4677.4387073551225;4707.976460117712;4344.304911214206;4641.118187544373;4679.9298010529865;4687.320338550908;4725.621950243973;4511.684182107238;4518.88702782433;4536.296873984537;4575.313702944552;4596.632269418438;4587.174308624446;4600.17196904557;4601.953980460219;4611.631069514431;4619.214733495314;4456.286994080931;4575.977120114411;4583.839565615188;4588.908221835578;4590.265557510782;4850.126977144113;4929.802807887716;4941.530554597308;4964.404271487409;4967.776450059756;5264.236685680593;5271.710055946922;5297.682139071668;5327.893442131174;5387.326584176978;5226.686398816045;5282.603804714662;5327.840164795062;5328.307320048408;5348.572114230852;4953.0589188054155;4970.701757894538;4988.176950803077;4991.051700176955;5000.2499625056535;5481.424450432727;5487.368952570426;5488.615796894179;5495.560355171657;5598.272224610774;5141.53726164647;5194.714290713971;5265.157574788015;5295.841124766263;5304.23088652151;5197.636165468457;5297.708626025606;5338.679679219259;5366.034113859465;5398.1902714593125;5187.974060129675;5214.087534681492;5221.765020574083;5238.5547228486;5257.921131183035;5092.312537807348;5208.7916483341;5211.0359583477175;5241.449647787003;5289.047971365191;4558.111168322145;4561.977190114028;4567.406237189144;4608.400907881954;4627.467841198238;3887.475190849199;3889.416587511839;3910.3743401055694;3918.647321741057;3956.723029387973;4549.886252843706;4597.655175861823;4628.190066738307;4667.579917807346;4743.762811859393;5321.494458026558;5369.650972686841;5383.353997520244;5387.568994480433;5423.566114710814;4620.953790462119;4667.043256132485;4672.462666793363;4679.976600116977;4713.85858424241;4764.237721964469;4799.592034677022;4833.613310935117;4842.951570484321;4914.287428322945;4969.45336013031;4976.626752993468;4990.975045124751;5006.249062640633;5060.139776237975;5366.838994830161;5367.409584945731;5370.03339398912;5384.892302153857;5416.133418652997;4835.419749630067;4888.413390393175;4923.729194894172;4923.950760492349;4988.102141614544;5212.192110222922;5242.18746094356;5242.580593552583;5244.711540865289;5310.548603368602;5232.189010703347;5308.097623403954;5330.466953304638;5353;5353.330833645794;5035.043341765053;5154;5165.302684137593;5176.197689358005;5199.688018718889;5132.255822905583;5148.562372198256;5191.143461328989;5207.114790485551;5208.53123218897;5108.386993560796;5127.53852153308;5164.1995490699;5166.844994650167;5187.170052791535;5072.239164125263;5165.66423182492;5208.166693329201;5222.556082732858;5231.973840130775;5117.488251175002;5133;5139.049275883974;5145;5176.378834539879 13:31:08 INFO - PROCESS | 3447 | |1;ext.html;548.1812130467129;583.1311346094319;587.7002728608411;600.9308929473112;607.8571535689109;35673;38637.613623863755;38827.61172388282;38862;38902;39041.80479097608;39802;39962.60037399633;40014.39978400326;40109.59890401095;7641.61791910405;7755.573443460607;7776.222377762235;7810.765677029698;7813.921860781376;7707.961460192691;7710.961445192766;7791.8052048698955;7803.10264319602;7803.3367163791145;7736.226377362247;7743.767686969371;7776.53340799551;7783.2216778322;7811.375089992787;7747.496412733154;7759.844803103934;7761.573113478757;7779.494332868402;7786.715191993286;7575.659095340723;7645.770626881147;7650.120236172856;7654.885176722353;7684.615769211573;36808.81595592032;37062.07344816374;37232.06919827026;37286.813565931996;37352.25295494102;2982.2246215984;3025.2890570715863;3034.924126896823;3056.7401770849506;3064.4024415239037;29683.70316296831;29764.55353169704;29783.36191509466;30034.24914377136;31296.687033129605;3528.523649307336;3536.3104194682046;3554.111472131967;3585.515955346021;3671.4492826076034;252636;252732.73633631898;252958;254402;255746;31309.373812523623;32524.67475325264;52585.47414525806;52957.47042529602;53173.734131329096;34066.829665852005;34093.31813363769;34261.82869085639;34297;34310;12789.680257993625;12851;12938.029647776455;12982.221066736027;12997.740045199233;11242.213045086766;11255.887441125647;11268.774624507463;11284.661460156209;11340.829887551694;7862.488938219112;7930.881036784453;7931.881021784678;8015.078265999485;8020.879686804703;3074.6771588983283;3087.6912308769392;3110.9688903111132;3120.7503399727966;3163.7152656261046;875.3303722652176;888.8089060851947;893.8927328720595;914.9130832570895;963.9951800240954;26824.463510729674;27933.72066279352;28026.85986570095;28096.43807123846;28814.42371152565;902.8510295801251;916.2578311567652;942.9151376376159;957.5882370580578;989.5744829723144;13560.254186019863;13801.102928309629;14021.369038393297;14176.64558386028;14226;401136;408554;409005;409035;409675;49771.50228497669;50284;50383.49616503788;50419.49580504148;50659.74670126626;1168.2873447197373;1170.4615876696644;1182.2138278045004;1183.8638556565934;1221.9389030548436;25720.614190787528;26516.204513864614;26849.86575067112;27292.31769205786;27336;42370.36444453274;43179.568204317555;43207.78396108125;43235.35146972861;43350;358562;367281;367847;368943.86336819874;369317;25228.117015904354;25345.746542535075;25563.23310300694;25603.103891363713;25733.485330293664;42081.57918420777;42247.78876105723;43042;43820;44128;36334;36893.26213475769;37176.81411592925;37322.253554929295;37886;35223.82388088043;36822.26355472822;36973.44539831851;37462.250754984205;40347;36315.39082263543;36782;37035;37340.6265937348;37939.05152371213;32487.837560812044;33024.66975330216;33995.83002084974;34258.314833703684;34276.31447371088;26153;26286.737132629194;26372.73869597328;26471.205863824118;26540.203793886216 13:31:08 INFO - PROCESS | 3447 | |2;jquery.html;361.9420892657175;362.1941180872558;364.4969941480756;376.46729877223714;380.1408816075668;15846.128462934534;16100.275487603056;16669.16654167293;17056.23246953887;17066.146692665377;16079.356825726956;16684;17384.13079346034;17403.564910877234;17418.477445676617;5070.797168113271;5170.767315470813;5283.365996080456;5284.603654725892;5296.708681022542;5122.974385128069;5164.457731938149;5169.147090730025;5176.120059589879;6199.504039676837;6594.802155935306;6656.567323124005;6707.02748101525;6748.730050797963;6750.291219421963;6320.5891617044745;6711.9664401678165;6722.058911752359;6801.93198068018;6807.9319206807795;6491.993740970157;6519.543631945766;6584.736610535573;6603.075569420237;6664.466842652576;21810.563788724136;23121.190758323548;23782.405439863967;24024.639630405556;24157.758422415725;2026.0680087159776;2099.8555787095916;2109.156337465011;2248.9887550562307;2670.012095524649;14328.35522401484;14594.34325455357;14855.851441485554;14865.256737163207;14927.477538286217;1871.5227616957725;1922.7884932657396;1929.2765213045109;1983.9900800495905;1986.3147214211074;53996.19005714917;56448.43551564473;59505;60111.69944150251;63241.36758632447;15544.455944041903;17037.31850725957;17121.571960701083;17187.484375468757;17271;29871.253218669706;29896.701032989826;30102.84948575243;30168.698313017027;30395.544066839015;8682.826343473094;9025.729228123168;9199.126083022102;9204.355695101278;9529.714108576754;7102;7777.611119444005;7806.297433231037;7940.926770518699;8016.278534931884;8368.20502052304;8434.746957591282;8689.001529648216;8689.913100868911;8808.955955220312;3372.6458721833856;3424.161080535285;3499.737519686034;3517.9120521986642;3530.117470632342;803.5379656697422;806.4193780478164;859.1751918158512;862.5945805471418;885.0839381240514;15055;16414.42549510785;17271.913640431718;17447.389341373244;17520.561985950197;831.3930830493773;833.9291160251325;865.948043117415;870.7344260000634;897.6902968475865;9203.769905752275;9343.439393636403;9575;9700.173732969004;9763.609455621838;404377;432265;439947;444352;450166;79532.6023369891;83375.583122084;84066.57966710128;86234;87537;962.7785609309758;974.6734843827255;984.1241295247236;1032.2670903658336;1032.9070383665505;12923.289219092663;15575.987560808511;15637.01256179667;15848.207589620242;16517.58706032359;31639.367212656078;33392.66607333896;33693.83153084219;35567.46648800322;37997.81001094977;51330.74334628303;53572;54239.72880135574;54537.72731136319;54557.18164227619;7209.6034718091005;7346.191918888811;7372.48392612512;7399.48203625741;7430.331270185709;10092.89907100949;11586.131040171853;11906.404679765803;12118;12294.87705122973;9762.219022478326;9919.752006199902;10060.748481288027;10122.44326562046;10276.743081423025;10415.791684166123;10424.218183636409;10565.101966332948;10700.625478108228;10709.303895246783;9945.005499450286;10233.48832558384;10262.281640285108;10333.84499232497;10337;7123.572585644878;7252.709891604277;7321.816954576178;7352.742654007084;7460.626968651654;9045.366824322498;10219.846702299323;10258.179345652181;10440.947795260976;10484.475776211006 13:31:08 INFO - PROCESS | 3447 | |3;mootools.html;1360.3334366160582;1405.5642750747268;1455.2360010994228;1631.4453085950774;1654.3465331194186;6866.347696968793;7616.276453736893;7706.267904549059;8132.552709600969;8146.796330091744;7620.695172193119;7945.126036136035;7983.52098874068;8016.639251233694;8077.273045425911;2193.243331050789;2222.811061059812;2229.843910926236;2232.363776323748;2241.7982381585653;2201.8238540916686;2217.412385717778;2217.966730499044;2218.7115674962233;2221;2186.967195492069;2201.4936564590153;2206.139605553827;2207.8564893281887;2220.2673117871145;2163.3871434704083;2169.034779523113;2176.2927048709234;2176.9659411779357;2180.3785921012513;2146.4204664740587;2161.945951351213;2168.9566208675897;2172.283146561631;2174.902129404165;7740.690372385098;7912.80217994549;7940.563269020202;7942.444028917978;7975.96012019942;4455.710378825366;4555.658325625558;4586.289125185568;4589.609883159936;4598.356230127785;2852.286928267933;2861.6566012078683;2912.417516496709;2947.6904924982996;2990.5514172874027;931.2736065868634;963.1909196275093;974.8391515400021;978.6330126202674;991.3853410885225;10937.945310273397;11051.17116216279;11052.171087168495;11159.832602510969;11207.607733729363;4230.978845105817;4325.113351762881;4368.039031413084;4375.6280716138845;4402.163588918095;9323.393979391318;9331.673391431268;9333.579988900516;9352.392094513834;9356.251499879992;4781.880452988703;4785.880352991203;4786.617070634341;4795.232762757942;4796.06476737033;3717.0893131183034;4181.435506206623;4184.979075104605;4315.417418648505;4340.544242854455;3659.7621154624862;3666.651668091527;3683.0976410778994;3740.4202348636004;3767.811609419518;1162.976740465186;1207.2394391533278;1210.4129497193853;1212.87871212878;1214.6416807041944;737.2701025984237;770.9460337776302;791.6714563456217;809.1827254473025;835.4736515994884;4976.576990955809;5014.89970200594;5042;5064;5103.183490641553;865.4115201662804;876.4565969099071;881.744294154688;887.9778005549913;917.6191880369572;3253.4794432890626;3400.4049291374404;3407.8466469008954;3542.1498840278146;3559.661832125944;9625.470599117116;9892.455914924605;10010.399376037316;10011.299209055296;10012.148967337713;9643.180329671915;9785.804283914282;9814.803703925882;9825.705228843146;9856.556454959544;7291.635418229173;7307.415406767446;7353.338199562065;7359.411247100219;7369.668364923591;4957.4794646561595;5039.5968322534845;5087.3386459759995;5091.949080509147;5121.359830021247;8924.732258032269;9006.459612423276;9014.2788576915;9059.682911098344;9103.90896091057;8710.085441028854;9054.954725226595;9127.269818414643;9198.49408282551;9361.297902657192;6087.57386982907;6538.673066346759;6642.90035649456;6704.06143139951;6948.200956890022;7428.182899880901;7431.479796414199;7453.068366454193;7456.067991501062;7476.551406915385;6898.655067246718;6995.230524642387;7041.295870412918;7067.293270672892;7205.747798827016;6874.690638921161;6892.069570607904;6932.826679333057;6982.1272340957385;7005.159380874327;5981.671008094597;6042.788502402394;6043.54673399488;6057.7879774207695;6110.144579758926;4526.660500462544;4530.750808705553;4547.7726113693525;4624.7687615618415;4644.930326045044;4425.269830478064;4511.263272799522;4582.725036497821;4613.630909527297;4629.351890735367 13:31:08 INFO - PROCESS | 3447 | |4;prototype.html;293.2741464874435;297.6502609433915;305.8486049405543;307.2549068508865;311.08540889784035;4940.752962351886;5076.416212135606;5124.282600435942;5177.715225662582;5185.7147856867905;5138.922916156261;5148.588112950964;5160.277561141444;5171.948280517194;5178.378594568657;4063.3904914262803;4068.3897415387632;4074.9185016299657;4100.753954762724;4120.670346372283;3819.427085937104;4049.6355328020472;4108.815103320343;4141.6065473779945;4163.375493675942;3966.8214930328204;3967.523897132334;3995.8002099895034;3998.2403343364667;3998.7800670963084;3939.5272567291963;3961.267165574378;3973.602639736032;3985.9202815943518;3989.222101690157;3499.562554680665;3504.877329293488;3509.842057107436;3512.666296701809;3516.244007538366;4804.399450068741;5067.467915868854;5067.695938243717;5088.542031217208;5097.7196254206;4580.885477863047;4584.836462840629;4592.862214133581;4608.493065762764;4632.444106707183;5463.7814487420455;5463.825277565343;5466.890662186734;5488.780448782084;5497.642653227527;3727.683146932514;3775.9056023599355;3803.562590302123;3827.27281816454;3840.212756384962;5691.886162276731;5691.943080569183;5732.710140218459;5788.681622510802;5792.073268277098;3943.171933893857;3944.3491823849317;3945.2504024235304;3965.246603145451;3980.8208630611693;3868.671162951124;3988.541317748496;4006.1587066716315;4021.557628660845;4030.5163380394542;4567.086582683477;4575.336576196433;4580.152671755736;4596.724196548218;4625.259958406638;5192.662476938987;5438.537724293479;5478.808241711521;5561.972190139023;5565.41563135873;1337.3914868734703;1354.864513548657;1357.4434481862388;1360.6801402639423;1363.1820907455647;852.8166444214523;859.7678626770737;871.2986046232717;875.65411662393;888.2893685052062;4191.497020357577;4243.257429949746;4288.699791014599;4310.698251122454;4329.350597410351;4945.982950400253;4946.307516947631;4959.404871415453;4973.850784476472;5049.596032317406;4285.450157156487;4345.521992580813;4364.650827933758;4382.189294980439;4399.548149110786;2499.3126890105004;2681.075029114952;2685.221285827088;2722.4963381774437;2725.523033469135;4646.256598944153;4680.297955306732;4682.484926658065;4695.741734204583;4707.7175369477945;4843.515648435199;5048.974755126274;5077.26379674945;5101.67356487316;5149.9742501288;4504.684672072924;4630.1242654657135;4664.323673067386;4710.764461776897;4717.716936983723;4954.578860796729;4955.677880937872;4972.8508144755715;4981.135846888126;5022.723750193774;4676.953230467651;4921.926171107365;4938.17287603589;4999.675021123615;5003.824866129668;4630.560096790799;4636.466806317317;4651.488336283074;4665.790039448301;4691.202495575829;3551.7158627309236;3567.714582833419;3572.0534058474004;3586.0814464261493;3604.6575575320303;4909.239067944474;4912.8771780705765;4951.603871690329;4989.775460104376;5430.782768689208;5329.680219186861;5425.701586412785;5438.211459338453;5460.781568737206;5475.959567682127;5401.297831281908;5424.2406063151975;5447.918281225864;5454.772676147835;5463.207834864002;5170.43125256229;5219.2953951216095;5333.599980001593;5362.624616276979;5377.327834020747;5361.624686271924;5429;5435.864103397446;5497.312835895513;5499.780008799603;5305.336832895888;5361.410244872983;5363;5395.679857661244;5402.567794576503 13:31:08 INFO - PROCESS | 3447 | |5;yui.html;575.8617931696391;591.6067660659147;633.8985762278037;675.3685304240538;689.6517258784316;11299.265547739391;12314.507419703212;12327.568535101273;12370.257784532934;12469.314187719672;14090.78863817041;14778.408863645442;14839;14840.332185051671;14851.554453366416;602.2682440834385;768.2893323675605;771.5602106799126;779.4543819326494;780.0834020026474;757.8522188173308;786.7207141464755;791.0349373763999;795.2405452792569;796.2395911904117;808.9312408445289;809.6113865344638;813.4346629092782;815.3110621524831;820.1183727492939;812.6058861452191;812.975610731679;817.4931542443693;817.9059408168048;823.3125340340822;595.1489370200611;600.3876046432658;600.7296716477603;602.0758136260819;602.2532060245308;12125.393730313537;12194.451249693697;12283.078769092353;12315.5073797048;12355.32045737484;11870.406479675981;11952.223105498115;12107.39463026854;12144.817827732591;12328.445219965122;9758.512074396253;10068.848967265498;10245.334053286588;10254.282200245985;10361.740956476073;3229.54786329914;3236.676332366768;3259;3292.1440425489304;3331.783434076777;42808.14383712308;42981.57018429807;47448.76275618634;58352.416475835125;58893;9016.8647470288;9450.48022358763;9474.242060635133;9654.613815447303;9710.271729620306;17584.648307034044;17608.471745847644;17618.471445856645;17674.558136046446;17918.372856949944;6196.10156527301;6242.344553821874;6446.548741588043;6492.09110724499;6716.83207919806;3701.2227432239533;3703.870364537282;3707.5921648618632;3765.585785563586;3805.7906815125434;2824.477471667748;2940.5589161625926;2946.734793868562;2947.3515826518133;2951.8671659775364;484.4211167654689;505.3809083872301;507.3657927590512;507.45955557331325;517.6092050501848;510.3416592595584;534.4735435595935;538.0933127679872;541.1152765228801;546.4398991034142;7943.285104340522;7979.521228726179;8178.5092894426525;8184.140665230065;8448.493090414595;487.74149700658705;499.3383766509317;519.1330478101579;545.0788167996074;562.9155626655952;3695.611960744137;3810.1808111256214;3839.1937693084205;3856.749311294757;3883.5339759229073;54276;54572.72713636486;57800;90141.54929225311;90720.5463972676;46485;53465.46534534605;75468.24531754613;77039.22960770321;77571.61214194006;70174.64912675506;71378.34562618715;71511.64244178745;71736.28263717296;72627.63686181641;7230.927690723236;7312.268773122645;7324.670389832364;7346.77959661211;7417.109946806202;44094.559054409045;44836.551634483236;44981.55018449904;45212.321815173455;45619;61422;63663.6816815913;63748;64013;64393;9634.855477167988;9669.419834809934;9701.757456063655;9717.514124293615;9746.85379719319;10417.16662667;10555.94722026385;10642.627508037182;10858.077063449695;11071.501782419971;10092.949535252277;10235.283530152818;10267.94866025665;10347.12049475803;10363.896361036595;10187.235957303084;10229.437380943822;10254.487275636338;10257.538410771383;10723.624673136403;9488.95255523718;10205.795884082425;10435.060844524029;10537.104346130665;10999.945000275267;9090;9310.534473276444;9550.522473876417;9708.85436718464;9726.513674316397;10014;10025.899741002497;10118.291719579853;10289.382637041801;10351.63769268072 13:31:08 INFO - PROCESS | 3447 | __end_tp_report 13:31:08 INFO - PROCESS | 3447 | __start_cc_report 13:31:08 INFO - PROCESS | 3447 | _x_x_mozilla_cycle_collect,388 13:31:08 INFO - PROCESS | 3447 | __end_cc_report 13:31:08 INFO - PROCESS | 3447 | __startTimestamp1467059468491__endTimestamp 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | ------- Summary: start ------- 13:31:08 INFO - PROCESS | 3447 | Number of tests: 6 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | [#0] dojo.html Cycles:165 Average:4912.44 Median:5000.25 stddev:523.47 (10.5%) stddev-sans-first:494.40 13:31:08 INFO - PROCESS | 3447 | Values: 2661.5 2683.8 2689.9 2692.8 2695.3 4809.4 4814.7 4865.1 4903.4 4947.7 4823.9 4932.7 4951.3 4968.6 4974.1 4508.6 4544.4 4585.3 4677.4 4708.0 4344.3 4641.1 4679.9 4687.3 4725.6 4511.7 4518.9 4536.3 4575.3 4596.6 4587.2 4600.2 4602.0 4611.6 4619.2 4456.3 4576.0 4583.8 4588.9 4590.3 4850.1 4929.8 4941.5 4964.4 4967.8 5264.2 5271.7 5297.7 5327.9 5387.3 5226.7 5282.6 5327.8 5328.3 5348.6 4953.1 4970.7 4988.2 4991.1 5000.2 5481.4 5487.4 5488.6 5495.6 5598.3 5141.5 5194.7 5265.2 5295.8 5304.2 5197.6 5297.7 5338.7 5366.0 5398.2 5188.0 5214.1 5221.8 5238.6 5257.9 5092.3 5208.8 5211.0 5241.4 5289.0 4558.1 4562.0 4567.4 4608.4 4627.5 3887.5 3889.4 3910.4 3918.6 3956.7 4549.9 4597.7 4628.2 4667.6 4743.8 5321.5 5369.7 5383.4 5387.6 5423.6 4621.0 4667.0 4672.5 4680.0 4713.9 4764.2 4799.6 4833.6 4843.0 4914.3 4969.5 4976.6 4991.0 5006.2 5060.1 5366.8 5367.4 5370.0 5384.9 5416.1 4835.4 4888.4 4923.7 4924.0 4988.1 5212.2 5242.2 5242.6 5244.7 5310.5 5232.2 5308.1 5330.5 5353.0 5353.3 5035.0 5154.0 5165.3 5176.2 5199.7 5132.3 5148.6 5191.1 5207.1 5208.5 5108.4 5127.5 5164.2 5166.8 5187.2 5072.2 5165.7 5208.2 5222.6 5232.0 5117.5 5133.0 5139.0 5145.0 5176.4 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | [#1] ext.html Cycles:180 Average:48272.45 Median:37004.22 stddev:92244.14 (249.3%) stddev-sans-first:92433.32 13:31:08 INFO - PROCESS | 3447 | Values: 548.2 583.1 587.7 600.9 607.9 35673.0 38637.6 38827.6 38862.0 38902.0 39041.8 39802.0 39962.6 40014.4 40109.6 7641.6 7755.6 7776.2 7810.8 7813.9 7708.0 7711.0 7791.8 7803.1 7803.3 7736.2 7743.8 7776.5 7783.2 7811.4 7747.5 7759.8 7761.6 7779.5 7786.7 7575.7 7645.8 7650.1 7654.9 7684.6 36808.8 37062.1 37232.1 37286.8 37352.3 2982.2 3025.3 3034.9 3056.7 3064.4 29683.7 29764.6 29783.4 30034.2 31296.7 3528.5 3536.3 3554.1 3585.5 3671.4 252636.0 252732.7 252958.0 254402.0 255746.0 31309.4 32524.7 52585.5 52957.5 53173.7 34066.8 34093.3 34261.8 34297.0 34310.0 12789.7 12851.0 12938.0 12982.2 12997.7 11242.2 11255.9 11268.8 11284.7 11340.8 7862.5 7930.9 7931.9 8015.1 8020.9 3074.7 3087.7 3111.0 3120.8 3163.7 875.3 888.8 893.9 914.9 964.0 26824.5 27933.7 28026.9 28096.4 28814.4 902.9 916.3 942.9 957.6 989.6 13560.3 13801.1 14021.4 14176.6 14226.0 401136.0 408554.0 409005.0 409035.0 409675.0 49771.5 50284.0 50383.5 50419.5 50659.7 1168.3 1170.5 1182.2 1183.9 1221.9 25720.6 26516.2 26849.9 27292.3 27336.0 42370.4 43179.6 43207.8 43235.4 43350.0 358562.0 367281.0 367847.0 368943.9 369317.0 25228.1 25345.7 25563.2 25603.1 25733.5 42081.6 42247.8 43042.0 43820.0 44128.0 36334.0 36893.3 37176.8 37322.3 37886.0 35223.8 36822.3 36973.4 37462.3 40347.0 36315.4 36782.0 37035.0 37340.6 37939.1 32487.8 33024.7 33995.8 34258.3 34276.3 26153.0 26286.7 26372.7 26471.2 26540.2 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | [#2] jquery.html Cycles:180 Average:26641.55 Median:442149.50 stddev:71316.20 (16.1%) stddev-sans-first:71488.96 13:31:08 INFO - PROCESS | 3447 | Values: 361.9 362.2 364.5 376.5 380.1 15846.1 16100.3 16669.2 17056.2 17066.1 16079.4 16684.0 17384.1 17403.6 17418.5 5070.8 5170.8 5283.4 5284.6 5296.7 5123.0 5164.5 5169.1 5176.1 6199.5 6594.8 6656.6 6707.0 6748.7 6750.3 6320.6 6712.0 6722.1 6801.9 6807.9 6492.0 6519.5 6584.7 6603.1 6664.5 21810.6 23121.2 23782.4 24024.6 24157.8 2026.1 2099.9 2109.2 2249.0 2670.0 14328.4 14594.3 14855.9 14865.3 14927.5 1871.5 1922.8 1929.3 1984.0 1986.3 53996.2 56448.4 59505.0 60111.7 63241.4 15544.5 17037.3 17121.6 17187.5 17271.0 29871.3 29896.7 30102.8 30168.7 30395.5 8682.8 9025.7 9199.1 9204.4 9529.7 7102.0 7777.6 7806.3 7940.9 8016.3 8368.2 8434.7 8689.0 8689.9 8809.0 3372.6 3424.2 3499.7 3517.9 3530.1 803.5 806.4 859.2 862.6 885.1 15055.0 16414.4 17271.9 17447.4 17520.6 831.4 833.9 865.9 870.7 897.7 9203.8 9343.4 9575.0 9700.2 9763.6 404377.0 432265.0 439947.0 444352.0 450166.0 79532.6 83375.6 84066.6 86234.0 87537.0 962.8 974.7 984.1 1032.3 1032.9 12923.3 15576.0 15637.0 15848.2 16517.6 31639.4 33392.7 33693.8 35567.5 37997.8 51330.7 53572.0 54239.7 54537.7 54557.2 7209.6 7346.2 7372.5 7399.5 7430.3 10092.9 11586.1 11906.4 12118.0 12294.9 9762.2 9919.8 10060.7 10122.4 10276.7 10415.8 10424.2 10565.1 10700.6 10709.3 9945.0 10233.5 10262.3 10333.8 10337.0 7123.6 7252.7 7321.8 7352.7 7460.6 9045.4 10219.8 10258.2 10440.9 10484.5 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | [#3] mootools.html Cycles:180 Average:5183.00 Median:5027.25 stddev:2940.18 (58.5%) stddev-sans-first:2934.39 13:31:08 INFO - PROCESS | 3447 | Values: 1360.3 1405.6 1455.2 1631.4 1654.3 6866.3 7616.3 7706.3 8132.6 8146.8 7620.7 7945.1 7983.5 8016.6 8077.3 2193.2 2222.8 2229.8 2232.4 2241.8 2201.8 2217.4 2218.0 2218.7 2221.0 2187.0 2201.5 2206.1 2207.9 2220.3 2163.4 2169.0 2176.3 2177.0 2180.4 2146.4 2161.9 2169.0 2172.3 2174.9 7740.7 7912.8 7940.6 7942.4 7976.0 4455.7 4555.7 4586.3 4589.6 4598.4 2852.3 2861.7 2912.4 2947.7 2990.6 931.3 963.2 974.8 978.6 991.4 10937.9 11051.2 11052.2 11159.8 11207.6 4231.0 4325.1 4368.0 4375.6 4402.2 9323.4 9331.7 9333.6 9352.4 9356.3 4781.9 4785.9 4786.6 4795.2 4796.1 3717.1 4181.4 4185.0 4315.4 4340.5 3659.8 3666.7 3683.1 3740.4 3767.8 1163.0 1207.2 1210.4 1212.9 1214.6 737.3 770.9 791.7 809.2 835.5 4976.6 5014.9 5042.0 5064.0 5103.2 865.4 876.5 881.7 888.0 917.6 3253.5 3400.4 3407.8 3542.1 3559.7 9625.5 9892.5 10010.4 10011.3 10012.1 9643.2 9785.8 9814.8 9825.7 9856.6 7291.6 7307.4 7353.3 7359.4 7369.7 4957.5 5039.6 5087.3 5091.9 5121.4 8924.7 9006.5 9014.3 9059.7 9103.9 8710.1 9055.0 9127.3 9198.5 9361.3 6087.6 6538.7 6642.9 6704.1 6948.2 7428.2 7431.5 7453.1 7456.1 7476.6 6898.7 6995.2 7041.3 7067.3 7205.7 6874.7 6892.1 6932.8 6982.1 7005.2 5981.7 6042.8 6043.5 6057.8 6110.1 4526.7 4530.8 4547.8 4624.8 4644.9 4425.3 4511.3 4582.7 4613.6 4629.4 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | [#4] prototype.html Cycles:180 Average:4326.85 Median:4686.84 stddev:1259.60 (26.9%) stddev-sans-first:1226.21 13:31:08 INFO - PROCESS | 3447 | Values: 293.3 297.7 305.8 307.3 311.1 4940.8 5076.4 5124.3 5177.7 5185.7 5138.9 5148.6 5160.3 5171.9 5178.4 4063.4 4068.4 4074.9 4100.8 4120.7 3819.4 4049.6 4108.8 4141.6 4163.4 3966.8 3967.5 3995.8 3998.2 3998.8 3939.5 3961.3 3973.6 3985.9 3989.2 3499.6 3504.9 3509.8 3512.7 3516.2 4804.4 5067.5 5067.7 5088.5 5097.7 4580.9 4584.8 4592.9 4608.5 4632.4 5463.8 5463.8 5466.9 5488.8 5497.6 3727.7 3775.9 3803.6 3827.3 3840.2 5691.9 5691.9 5732.7 5788.7 5792.1 3943.2 3944.3 3945.3 3965.2 3980.8 3868.7 3988.5 4006.2 4021.6 4030.5 4567.1 4575.3 4580.2 4596.7 4625.3 5192.7 5438.5 5478.8 5562.0 5565.4 1337.4 1354.9 1357.4 1360.7 1363.2 852.8 859.8 871.3 875.7 888.3 4191.5 4243.3 4288.7 4310.7 4329.4 4946.0 4946.3 4959.4 4973.9 5049.6 4285.5 4345.5 4364.7 4382.2 4399.5 2499.3 2681.1 2685.2 2722.5 2725.5 4646.3 4680.3 4682.5 4695.7 4707.7 4843.5 5049.0 5077.3 5101.7 5150.0 4504.7 4630.1 4664.3 4710.8 4717.7 4954.6 4955.7 4972.9 4981.1 5022.7 4677.0 4921.9 4938.2 4999.7 5003.8 4630.6 4636.5 4651.5 4665.8 4691.2 3551.7 3567.7 3572.1 3586.1 3604.7 4909.2 4912.9 4951.6 4989.8 5430.8 5329.7 5425.7 5438.2 5460.8 5476.0 5401.3 5424.2 5447.9 5454.8 5463.2 5170.4 5219.3 5333.6 5362.6 5377.3 5361.6 5429.0 5435.9 5497.3 5499.8 5305.3 5361.4 5363.0 5395.7 5402.6 13:31:08 INFO - PROCESS | 3447 | 13:31:08 INFO - PROCESS | 3447 | [#5] yui.html Cycles:180 Average:15735.92 Median:526.80 stddev:21508.25 (4082.8%) stddev-sans-first:21538.46 13:31:08 INFO - PROCESS | 3447 | Values: 575.9 591.6 633.9 675.4 689.7 11299.3 12314.5 12327.6 12370.3 12469.3 14090.8 14778.4 14839.0 14840.3 14851.6 602.3 768.3 771.6 779.5 780.1 757.9 786.7 791.0 795.2 796.2 808.9 809.6 813.4 815.3 820.1 812.6 813.0 817.5 817.9 823.3 595.1 600.4 600.7 602.1 602.3 12125.4 12194.5 12283.1 12315.5 12355.3 11870.4 11952.2 12107.4 12144.8 12328.4 9758.5 10068.8 10245.3 10254.3 10361.7 3229.5 3236.7 3259.0 3292.1 3331.8 42808.1 42981.6 47448.8 58352.4 58893.0 9016.9 9450.5 9474.2 9654.6 9710.3 17584.6 17608.5 17618.5 17674.6 17918.4 6196.1 6242.3 6446.5 6492.1 6716.8 3701.2 3703.9 3707.6 3765.6 3805.8 2824.5 2940.6 2946.7 2947.4 2951.9 484.4 505.4 507.4 507.5 517.6 510.3 534.5 538.1 541.1 546.4 7943.3 7979.5 8178.5 8184.1 8448.5 487.7 499.3 519.1 545.1 562.9 3695.6 3810.2 3839.2 3856.7 3883.5 54276.0 54572.7 57800.0 90141.5 90720.5 46485.0 53465.5 75468.2 77039.2 77571.6 70174.6 71378.3 71511.6 71736.3 72627.6 7230.9 7312.3 7324.7 7346.8 7417.1 44094.6 44836.6 44981.6 45212.3 45619.0 61422.0 63663.7 63748.0 64013.0 64393.0 9634.9 9669.4 9701.8 9717.5 9746.9 10417.2 10555.9 10642.6 10858.1 11071.5 10092.9 10235.3 10267.9 10347.1 10363.9 10187.2 10229.4 10254.5 10257.5 10723.6 9489.0 10205.8 10435.1 10537.1 10999.9 9090.0 9310.5 9550.5 9708.9 9726.5 10014.0 10025.9 10118.3 10289.4 10351.6 13:31:08 INFO - PROCESS | 3447 | -------- Summary: end -------- 13:31:08 INFO - PROCESS | 3447 | 13:31:09 INFO - TEST-INFO | 3447: exit 0 13:31:09 INFO - TEST-OK | dromaeo_css | took 1117317ms 13:31:09 INFO - TEST-START | kraken 13:31:09 INFO - operating with platform_type : linux_ 13:31:09 INFO - Initialising browser for kraken test... 13:31:09 INFO - TEST-INFO | started process 3685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFAPeBc/profile http://localhost:36719/getInfo.html) 13:31:13 INFO - PROCESS | 3685 | __metrics Screen width/height:1600/1200 13:31:13 INFO - PROCESS | 3685 | colorDepth:24 13:31:13 INFO - PROCESS | 3685 | Browser inner width/height: 1024/697 13:31:13 INFO - PROCESS | 3685 | __metrics 13:31:14 ERROR - PROCESS | 3685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:31:15 INFO - TEST-INFO | 3685: exit 0 13:31:15 INFO - Browser initialized. 13:31:15 INFO - Running cycle 1/1 for kraken test... 13:31:15 INFO - TEST-INFO | started process 3802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFAPeBc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:27 INFO - PROCESS | 3802 | RSS: Main: 186810368 13:31:27 INFO - PROCESS | 3802 | 13:31:30 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36719/tests/kraken/driver.html?testName=audio-beat-detection) 13:31:31 INFO - PROCESS | 3802 | RSS: Main: 190930944 13:31:31 INFO - PROCESS | 3802 | 13:31:33 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36719/tests/kraken/driver.html?testName=audio-dft) 13:31:34 INFO - PROCESS | 3802 | RSS: Main: 190791680 13:31:34 INFO - PROCESS | 3802 | 13:31:37 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36719/tests/kraken/driver.html?testName=audio-fft) 13:31:38 INFO - PROCESS | 3802 | RSS: Main: 186728448 13:31:38 INFO - PROCESS | 3802 | 13:31:40 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36719/tests/kraken/driver.html?testName=audio-oscillator) 13:31:40 INFO - PROCESS | 3802 | RSS: Main: 187490304 13:31:40 INFO - PROCESS | 3802 | 13:31:43 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:31:43 INFO - PROCESS | 3802 | RSS: Main: 187203584 13:31:43 INFO - PROCESS | 3802 | 13:31:46 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36719/tests/kraken/driver.html?testName=imaging-darkroom) 13:31:47 INFO - PROCESS | 3802 | RSS: Main: 187547648 13:31:47 INFO - PROCESS | 3802 | 13:31:51 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36719/tests/kraken/driver.html?testName=imaging-desaturate) 13:31:51 INFO - PROCESS | 3802 | RSS: Main: 185425920 13:31:51 INFO - PROCESS | 3802 | 13:31:54 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36719/tests/kraken/driver.html?testName=json-parse-financial) 13:31:55 INFO - PROCESS | 3802 | RSS: Main: 186597376 13:31:55 INFO - PROCESS | 3802 | 13:31:57 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:31:57 INFO - PROCESS | 3802 | RSS: Main: 186654720 13:31:57 INFO - PROCESS | 3802 | 13:31:59 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:32:00 INFO - PROCESS | 3802 | RSS: Main: 187203584 13:32:00 INFO - PROCESS | 3802 | 13:32:02 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:32:03 INFO - PROCESS | 3802 | RSS: Main: 187379712 13:32:03 INFO - PROCESS | 3802 | 13:32:05 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:32:06 INFO - PROCESS | 3802 | RSS: Main: 187633664 13:32:06 INFO - PROCESS | 3802 | 13:32:09 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:32:10 INFO - PROCESS | 3802 | RSS: Main: 187383808 13:32:10 INFO - PROCESS | 3802 | 13:32:11 INFO - PROCESS | 3802 | Cycle 1(1): loaded http://localhost:36719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36719/tests/kraken/driver.html?testName=ai-astar) 13:32:12 INFO - PROCESS | 3802 | RSS: Main: 188362752 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | __start_tp_report 13:32:12 INFO - PROCESS | 3802 | _x_x_mozilla_page_load 13:32:12 INFO - PROCESS | 3802 | _x_x_mozilla_page_load_details 13:32:12 INFO - PROCESS | 3802 | |i|pagename|runs| 13:32:12 INFO - PROCESS | 3802 | |0;ai-astar;104;114;108;114;114;115;116;114;113;114 13:32:12 INFO - PROCESS | 3802 | |1;audio-beat-detection;158;132;158;189;141;157;166;142;187;133 13:32:12 INFO - PROCESS | 3802 | |2;audio-dft;163;165;177;163;165;166;161;163;164;162 13:32:12 INFO - PROCESS | 3802 | |3;audio-fft;76;77;77;165;76;76;76;76;159;76 13:32:12 INFO - PROCESS | 3802 | |4;audio-oscillator;86;86;142;86;86;87;133;87;86;136 13:32:12 INFO - PROCESS | 3802 | |5;imaging-gaussian-blur;117;117;118;118;119;119;118;118;117;120 13:32:12 INFO - PROCESS | 3802 | |6;imaging-darkroom;148;149;147;147;147;149;148;149;148;147 13:32:12 INFO - PROCESS | 3802 | |7;imaging-desaturate;96;97;96;96;96;96;95;96;95;96 13:32:12 INFO - PROCESS | 3802 | |8;json-parse-financial;65;63;62;64;65;64;64;65;63;63 13:32:12 INFO - PROCESS | 3802 | |9;json-stringify-tinderbox;66;65;65;65;65;65;64;65;65;64 13:32:12 INFO - PROCESS | 3802 | |10;stanford-crypto-aes;84;90;82;84;90;84;88;84;83;90 13:32:12 INFO - PROCESS | 3802 | |11;stanford-crypto-ccm;135;143;132;138;130;138;132;147;132;151 13:32:12 INFO - PROCESS | 3802 | |12;stanford-crypto-pbkdf2;171;166;174;171;172;171;169;172;169;172 13:32:12 INFO - PROCESS | 3802 | |13;stanford-crypto-sha256-iterative;69;67;67;67;69;66;66;66;71;65 13:32:12 INFO - PROCESS | 3802 | __end_tp_report 13:32:12 INFO - PROCESS | 3802 | __start_cc_report 13:32:12 INFO - PROCESS | 3802 | _x_x_mozilla_cycle_collect,978 13:32:12 INFO - PROCESS | 3802 | __end_cc_report 13:32:12 INFO - PROCESS | 3802 | __startTimestamp1467059532179__endTimestamp 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | ------- Summary: start ------- 13:32:12 INFO - PROCESS | 3802 | Number of tests: 14 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.69 (3.2%) stddev-sans-first:2.24 13:32:12 INFO - PROCESS | 3802 | Values: 104.0 114.0 108.0 114.0 114.0 115.0 116.0 114.0 113.0 114.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#1] audio-beat-detection Cycles:10 Average:156.30 Median:158.00 stddev:20.23 (12.8%) stddev-sans-first:21.45 13:32:12 INFO - PROCESS | 3802 | Values: 158.0 132.0 158.0 189.0 141.0 157.0 166.0 142.0 187.0 133.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:4.51 (2.7%) stddev-sans-first:4.73 13:32:12 INFO - PROCESS | 3802 | Values: 163.0 165.0 177.0 163.0 165.0 166.0 161.0 163.0 164.0 162.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:36.19 (47.6%) stddev-sans-first:37.83 13:32:12 INFO - PROCESS | 3802 | Values: 76.0 77.0 77.0 165.0 76.0 76.0 76.0 76.0 159.0 76.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:86.00 stddev:24.60 (28.6%) stddev-sans-first:25.44 13:32:12 INFO - PROCESS | 3802 | Values: 86.0 86.0 142.0 86.0 86.0 87.0 133.0 87.0 86.0 136.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:0.97 13:32:12 INFO - PROCESS | 3802 | Values: 117.0 117.0 118.0 118.0 119.0 119.0 118.0 118.0 117.0 120.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 13:32:12 INFO - PROCESS | 3802 | Values: 148.0 149.0 147.0 147.0 147.0 149.0 148.0 149.0 148.0 147.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:32:12 INFO - PROCESS | 3802 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 13:32:12 INFO - PROCESS | 3802 | Values: 65.0 63.0 62.0 64.0 65.0 64.0 64.0 65.0 63.0 63.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 13:32:12 INFO - PROCESS | 3802 | Values: 66.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:3.21 (3.7%) stddev-sans-first:3.33 13:32:12 INFO - PROCESS | 3802 | Values: 84.0 90.0 82.0 84.0 90.0 84.0 88.0 84.0 83.0 90.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:138.00 stddev:7.11 (5.2%) stddev-sans-first:7.47 13:32:12 INFO - PROCESS | 3802 | Values: 135.0 143.0 132.0 138.0 130.0 138.0 132.0 147.0 132.0 151.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.70 Median:171.50 stddev:2.21 (1.3%) stddev-sans-first:2.35 13:32:12 INFO - PROCESS | 3802 | Values: 171.0 166.0 174.0 171.0 172.0 171.0 169.0 172.0 169.0 172.0 13:32:12 INFO - PROCESS | 3802 | 13:32:12 INFO - PROCESS | 3802 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.83 13:32:12 INFO - PROCESS | 3802 | Values: 69.0 67.0 67.0 67.0 69.0 66.0 66.0 66.0 71.0 65.0 13:32:12 INFO - PROCESS | 3802 | -------- Summary: end -------- 13:32:12 INFO - PROCESS | 3802 | 13:32:13 INFO - TEST-INFO | 3802: exit 0 13:32:13 INFO - TEST-OK | kraken | took 64039ms 13:32:13 INFO - SUITE-END | took 1181s 13:32:13 INFO - Completed test suite (00:19:41) 13:32:13 INFO - javascript benchmark 13:32:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6495.895562892715, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2661.4544018476213, 2683.8389696618206, 2689.94620107598, 2692.7711144552713, 2695.3396417877616, 4809.4469136049365, 4814.7351895645725, 4865.124277630025, 4903.362562866822, 4947.678400903938, 4823.8794030149265, 4932.704037757728, 4951.257311403282, 4968.552830245278, 4974.054929563389, 4508.616767574752, 4544.386507821435, 4585.335126406669, 4677.4387073551225, 4707.976460117712, 4344.304911214206, 4641.118187544373, 4679.9298010529865, 4687.320338550908, 4725.621950243973, 4511.684182107238, 4518.88702782433, 4536.296873984537, 4575.313702944552, 4596.632269418438, 4587.174308624446, 4600.17196904557, 4601.953980460219, 4611.631069514431, 4619.214733495314, 4456.286994080931, 4575.977120114411, 4583.839565615188, 4588.908221835578, 4590.265557510782, 4850.126977144113, 4929.802807887716, 4941.530554597308, 4964.404271487409, 4967.776450059756, 5264.236685680593, 5271.710055946922, 5297.682139071668, 5327.893442131174, 5387.326584176978, 5226.686398816045, 5282.603804714662, 5327.840164795062, 5328.307320048408, 5348.572114230852, 4953.0589188054155, 4970.701757894538, 4988.176950803077, 4991.051700176955, 5000.2499625056535, 5481.424450432727, 5487.368952570426, 5488.615796894179, 5495.560355171657, 5598.272224610774, 5141.53726164647, 5194.714290713971, 5265.157574788015, 5295.841124766263, 5304.23088652151, 5197.636165468457, 5297.708626025606, 5338.679679219259, 5366.034113859465, 5398.1902714593125, 5187.974060129675, 5214.087534681492, 5221.765020574083, 5238.5547228486, 5257.921131183035, 5092.312537807348, 5208.7916483341, 5211.0359583477175, 5241.449647787003, 5289.047971365191, 4558.111168322145, 4561.977190114028, 4567.406237189144, 4608.400907881954, 4627.467841198238, 3887.475190849199, 3889.416587511839, 3910.3743401055694, 3918.647321741057, 3956.723029387973, 4549.886252843706, 4597.655175861823, 4628.190066738307, 4667.579917807346, 4743.762811859393, 5321.494458026558, 5369.650972686841, 5383.353997520244, 5387.568994480433, 5423.566114710814, 4620.953790462119, 4667.043256132485, 4672.462666793363, 4679.976600116977, 4713.85858424241, 4764.237721964469, 4799.592034677022, 4833.613310935117, 4842.951570484321, 4914.287428322945, 4969.45336013031, 4976.626752993468, 4990.975045124751, 5006.249062640633, 5060.139776237975, 5366.838994830161, 5367.409584945731, 5370.03339398912, 5384.892302153857, 5416.133418652997, 4835.419749630067, 4888.413390393175, 4923.729194894172, 4923.950760492349, 4988.102141614544, 5212.192110222922, 5242.18746094356, 5242.580593552583, 5244.711540865289, 5310.548603368602, 5232.189010703347, 5308.097623403954, 5330.466953304638, 5353.0, 5353.330833645794, 5035.043341765053, 5154.0, 5165.302684137593, 5176.197689358005, 5199.688018718889, 5132.255822905583, 5148.562372198256, 5191.143461328989, 5207.114790485551, 5208.53123218897, 5108.386993560796, 5127.53852153308, 5164.1995490699, 5166.844994650167, 5187.170052791535, 5072.239164125263, 5165.66423182492, 5208.166693329201, 5222.556082732858, 5231.973840130775, 5117.488251175002, 5133.0, 5139.049275883974, 5145.0, 5176.378834539879], "value": 4877.7193041676765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.1812130467129, 583.1311346094319, 587.7002728608411, 600.9308929473112, 607.8571535689109, 35673.0, 38637.613623863755, 38827.61172388282, 38862.0, 38902.0, 39041.80479097608, 39802.0, 39962.60037399633, 40014.39978400326, 40109.59890401095, 7641.61791910405, 7755.573443460607, 7776.222377762235, 7810.765677029698, 7813.921860781376, 7707.961460192691, 7710.961445192766, 7791.8052048698955, 7803.10264319602, 7803.3367163791145, 7736.226377362247, 7743.767686969371, 7776.53340799551, 7783.2216778322, 7811.375089992787, 7747.496412733154, 7759.844803103934, 7761.573113478757, 7779.494332868402, 7786.715191993286, 7575.659095340723, 7645.770626881147, 7650.120236172856, 7654.885176722353, 7684.615769211573, 36808.81595592032, 37062.07344816374, 37232.06919827026, 37286.813565931996, 37352.25295494102, 2982.2246215984, 3025.2890570715863, 3034.924126896823, 3056.7401770849506, 3064.4024415239037, 29683.70316296831, 29764.55353169704, 29783.36191509466, 30034.24914377136, 31296.687033129605, 3528.523649307336, 3536.3104194682046, 3554.111472131967, 3585.515955346021, 3671.4492826076034, 252636.0, 252732.73633631898, 252958.0, 254402.0, 255746.0, 31309.373812523623, 32524.67475325264, 52585.47414525806, 52957.47042529602, 53173.734131329096, 34066.829665852005, 34093.31813363769, 34261.82869085639, 34297.0, 34310.0, 12789.680257993625, 12851.0, 12938.029647776455, 12982.221066736027, 12997.740045199233, 11242.213045086766, 11255.887441125647, 11268.774624507463, 11284.661460156209, 11340.829887551694, 7862.488938219112, 7930.881036784453, 7931.881021784678, 8015.078265999485, 8020.879686804703, 3074.6771588983283, 3087.6912308769392, 3110.9688903111132, 3120.7503399727966, 3163.7152656261046, 875.3303722652176, 888.8089060851947, 893.8927328720595, 914.9130832570895, 963.9951800240954, 26824.463510729674, 27933.72066279352, 28026.85986570095, 28096.43807123846, 28814.42371152565, 902.8510295801251, 916.2578311567652, 942.9151376376159, 957.5882370580578, 989.5744829723144, 13560.254186019863, 13801.102928309629, 14021.369038393297, 14176.64558386028, 14226.0, 401136.0, 408554.0, 409005.0, 409035.0, 409675.0, 49771.50228497669, 50284.0, 50383.49616503788, 50419.49580504148, 50659.74670126626, 1168.2873447197373, 1170.4615876696644, 1182.2138278045004, 1183.8638556565934, 1221.9389030548436, 25720.614190787528, 26516.204513864614, 26849.86575067112, 27292.31769205786, 27336.0, 42370.36444453274, 43179.568204317555, 43207.78396108125, 43235.35146972861, 43350.0, 358562.0, 367281.0, 367847.0, 368943.86336819874, 369317.0, 25228.117015904354, 25345.746542535075, 25563.23310300694, 25603.103891363713, 25733.485330293664, 42081.57918420777, 42247.78876105723, 43042.0, 43820.0, 44128.0, 36334.0, 36893.26213475769, 37176.81411592925, 37322.253554929295, 37886.0, 35223.82388088043, 36822.26355472822, 36973.44539831851, 37462.250754984205, 40347.0, 36315.39082263543, 36782.0, 37035.0, 37340.6265937348, 37939.05152371213, 32487.837560812044, 33024.66975330216, 33995.83002084974, 34258.314833703684, 34276.31447371088, 26153.0, 26286.737132629194, 26372.73869597328, 26471.205863824118, 26540.203793886216], "value": 16527.500720218766, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9420892657175, 362.1941180872558, 364.4969941480756, 376.46729877223714, 380.1408816075668, 15846.128462934534, 16100.275487603056, 16669.16654167293, 17056.23246953887, 17066.146692665377, 16079.356825726956, 16684.0, 17384.13079346034, 17403.564910877234, 17418.477445676617, 5070.797168113271, 5170.767315470813, 5283.365996080456, 5284.603654725892, 5296.708681022542, 5122.974385128069, 5164.457731938149, 5169.147090730025, 5176.120059589879, 6199.504039676837, 6594.802155935306, 6656.567323124005, 6707.02748101525, 6748.730050797963, 6750.291219421963, 6320.5891617044745, 6711.9664401678165, 6722.058911752359, 6801.93198068018, 6807.9319206807795, 6491.993740970157, 6519.543631945766, 6584.736610535573, 6603.075569420237, 6664.466842652576, 21810.563788724136, 23121.190758323548, 23782.405439863967, 24024.639630405556, 24157.758422415725, 2026.0680087159776, 2099.8555787095916, 2109.156337465011, 2248.9887550562307, 2670.012095524649, 14328.35522401484, 14594.34325455357, 14855.851441485554, 14865.256737163207, 14927.477538286217, 1871.5227616957725, 1922.7884932657396, 1929.2765213045109, 1983.9900800495905, 1986.3147214211074, 53996.19005714917, 56448.43551564473, 59505.0, 60111.69944150251, 63241.36758632447, 15544.455944041903, 17037.31850725957, 17121.571960701083, 17187.484375468757, 17271.0, 29871.253218669706, 29896.701032989826, 30102.84948575243, 30168.698313017027, 30395.544066839015, 8682.826343473094, 9025.729228123168, 9199.126083022102, 9204.355695101278, 9529.714108576754, 7102.0, 7777.611119444005, 7806.297433231037, 7940.926770518699, 8016.278534931884, 8368.20502052304, 8434.746957591282, 8689.001529648216, 8689.913100868911, 8808.955955220312, 3372.6458721833856, 3424.161080535285, 3499.737519686034, 3517.9120521986642, 3530.117470632342, 803.5379656697422, 806.4193780478164, 859.1751918158512, 862.5945805471418, 885.0839381240514, 15055.0, 16414.42549510785, 17271.913640431718, 17447.389341373244, 17520.561985950197, 831.3930830493773, 833.9291160251325, 865.948043117415, 870.7344260000634, 897.6902968475865, 9203.769905752275, 9343.439393636403, 9575.0, 9700.173732969004, 9763.609455621838, 404377.0, 432265.0, 439947.0, 444352.0, 450166.0, 79532.6023369891, 83375.583122084, 84066.57966710128, 86234.0, 87537.0, 962.7785609309758, 974.6734843827255, 984.1241295247236, 1032.2670903658336, 1032.9070383665505, 12923.289219092663, 15575.987560808511, 15637.01256179667, 15848.207589620242, 16517.58706032359, 31639.367212656078, 33392.66607333896, 33693.83153084219, 35567.46648800322, 37997.81001094977, 51330.74334628303, 53572.0, 54239.72880135574, 54537.72731136319, 54557.18164227619, 7209.6034718091005, 7346.191918888811, 7372.48392612512, 7399.48203625741, 7430.331270185709, 10092.89907100949, 11586.131040171853, 11906.404679765803, 12118.0, 12294.87705122973, 9762.219022478326, 9919.752006199902, 10060.748481288027, 10122.44326562046, 10276.743081423025, 10415.791684166123, 10424.218183636409, 10565.101966332948, 10700.625478108228, 10709.303895246783, 9945.005499450286, 10233.48832558384, 10262.281640285108, 10333.84499232497, 10337.0, 7123.572585644878, 7252.709891604277, 7321.816954576178, 7352.742654007084, 7460.626968651654, 9045.366824322498, 10219.846702299323, 10258.179345652181, 10440.947795260976, 10484.475776211006], "value": 9267.687267061496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.3334366160582, 1405.5642750747268, 1455.2360010994228, 1631.4453085950774, 1654.3465331194186, 6866.347696968793, 7616.276453736893, 7706.267904549059, 8132.552709600969, 8146.796330091744, 7620.695172193119, 7945.126036136035, 7983.52098874068, 8016.639251233694, 8077.273045425911, 2193.243331050789, 2222.811061059812, 2229.843910926236, 2232.363776323748, 2241.7982381585653, 2201.8238540916686, 2217.412385717778, 2217.966730499044, 2218.7115674962233, 2221.0, 2186.967195492069, 2201.4936564590153, 2206.139605553827, 2207.8564893281887, 2220.2673117871145, 2163.3871434704083, 2169.034779523113, 2176.2927048709234, 2176.9659411779357, 2180.3785921012513, 2146.4204664740587, 2161.945951351213, 2168.9566208675897, 2172.283146561631, 2174.902129404165, 7740.690372385098, 7912.80217994549, 7940.563269020202, 7942.444028917978, 7975.96012019942, 4455.710378825366, 4555.658325625558, 4586.289125185568, 4589.609883159936, 4598.356230127785, 2852.286928267933, 2861.6566012078683, 2912.417516496709, 2947.6904924982996, 2990.5514172874027, 931.2736065868634, 963.1909196275093, 974.8391515400021, 978.6330126202674, 991.3853410885225, 10937.945310273397, 11051.17116216279, 11052.171087168495, 11159.832602510969, 11207.607733729363, 4230.978845105817, 4325.113351762881, 4368.039031413084, 4375.6280716138845, 4402.163588918095, 9323.393979391318, 9331.673391431268, 9333.579988900516, 9352.392094513834, 9356.251499879992, 4781.880452988703, 4785.880352991203, 4786.617070634341, 4795.232762757942, 4796.06476737033, 3717.0893131183034, 4181.435506206623, 4184.979075104605, 4315.417418648505, 4340.544242854455, 3659.7621154624862, 3666.651668091527, 3683.0976410778994, 3740.4202348636004, 3767.811609419518, 1162.976740465186, 1207.2394391533278, 1210.4129497193853, 1212.87871212878, 1214.6416807041944, 737.2701025984237, 770.9460337776302, 791.6714563456217, 809.1827254473025, 835.4736515994884, 4976.576990955809, 5014.89970200594, 5042.0, 5064.0, 5103.183490641553, 865.4115201662804, 876.4565969099071, 881.744294154688, 887.9778005549913, 917.6191880369572, 3253.4794432890626, 3400.4049291374404, 3407.8466469008954, 3542.1498840278146, 3559.661832125944, 9625.470599117116, 9892.455914924605, 10010.399376037316, 10011.299209055296, 10012.148967337713, 9643.180329671915, 9785.804283914282, 9814.803703925882, 9825.705228843146, 9856.556454959544, 7291.635418229173, 7307.415406767446, 7353.338199562065, 7359.411247100219, 7369.668364923591, 4957.4794646561595, 5039.5968322534845, 5087.3386459759995, 5091.949080509147, 5121.359830021247, 8924.732258032269, 9006.459612423276, 9014.2788576915, 9059.682911098344, 9103.90896091057, 8710.085441028854, 9054.954725226595, 9127.269818414643, 9198.49408282551, 9361.297902657192, 6087.57386982907, 6538.673066346759, 6642.90035649456, 6704.06143139951, 6948.200956890022, 7428.182899880901, 7431.479796414199, 7453.068366454193, 7456.067991501062, 7476.551406915385, 6898.655067246718, 6995.230524642387, 7041.295870412918, 7067.293270672892, 7205.747798827016, 6874.690638921161, 6892.069570607904, 6932.826679333057, 6982.1272340957385, 7005.159380874327, 5981.671008094597, 6042.788502402394, 6043.54673399488, 6057.7879774207695, 6110.144579758926, 4526.660500462544, 4530.750808705553, 4547.7726113693525, 4624.7687615618415, 4644.930326045044, 4425.269830478064, 4511.263272799522, 4582.725036497821, 4613.630909527297, 4629.351890735367], "value": 4165.865554000035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2741464874435, 297.6502609433915, 305.8486049405543, 307.2549068508865, 311.08540889784035, 4940.752962351886, 5076.416212135606, 5124.282600435942, 5177.715225662582, 5185.7147856867905, 5138.922916156261, 5148.588112950964, 5160.277561141444, 5171.948280517194, 5178.378594568657, 4063.3904914262803, 4068.3897415387632, 4074.9185016299657, 4100.753954762724, 4120.670346372283, 3819.427085937104, 4049.6355328020472, 4108.815103320343, 4141.6065473779945, 4163.375493675942, 3966.8214930328204, 3967.523897132334, 3995.8002099895034, 3998.2403343364667, 3998.7800670963084, 3939.5272567291963, 3961.267165574378, 3973.602639736032, 3985.9202815943518, 3989.222101690157, 3499.562554680665, 3504.877329293488, 3509.842057107436, 3512.666296701809, 3516.244007538366, 4804.399450068741, 5067.467915868854, 5067.695938243717, 5088.542031217208, 5097.7196254206, 4580.885477863047, 4584.836462840629, 4592.862214133581, 4608.493065762764, 4632.444106707183, 5463.7814487420455, 5463.825277565343, 5466.890662186734, 5488.780448782084, 5497.642653227527, 3727.683146932514, 3775.9056023599355, 3803.562590302123, 3827.27281816454, 3840.212756384962, 5691.886162276731, 5691.943080569183, 5732.710140218459, 5788.681622510802, 5792.073268277098, 3943.171933893857, 3944.3491823849317, 3945.2504024235304, 3965.246603145451, 3980.8208630611693, 3868.671162951124, 3988.541317748496, 4006.1587066716315, 4021.557628660845, 4030.5163380394542, 4567.086582683477, 4575.336576196433, 4580.152671755736, 4596.724196548218, 4625.259958406638, 5192.662476938987, 5438.537724293479, 5478.808241711521, 5561.972190139023, 5565.41563135873, 1337.3914868734703, 1354.864513548657, 1357.4434481862388, 1360.6801402639423, 1363.1820907455647, 852.8166444214523, 859.7678626770737, 871.2986046232717, 875.65411662393, 888.2893685052062, 4191.497020357577, 4243.257429949746, 4288.699791014599, 4310.698251122454, 4329.350597410351, 4945.982950400253, 4946.307516947631, 4959.404871415453, 4973.850784476472, 5049.596032317406, 4285.450157156487, 4345.521992580813, 4364.650827933758, 4382.189294980439, 4399.548149110786, 2499.3126890105004, 2681.075029114952, 2685.221285827088, 2722.4963381774437, 2725.523033469135, 4646.256598944153, 4680.297955306732, 4682.484926658065, 4695.741734204583, 4707.7175369477945, 4843.515648435199, 5048.974755126274, 5077.26379674945, 5101.67356487316, 5149.9742501288, 4504.684672072924, 4630.1242654657135, 4664.323673067386, 4710.764461776897, 4717.716936983723, 4954.578860796729, 4955.677880937872, 4972.8508144755715, 4981.135846888126, 5022.723750193774, 4676.953230467651, 4921.926171107365, 4938.17287603589, 4999.675021123615, 5003.824866129668, 4630.560096790799, 4636.466806317317, 4651.488336283074, 4665.790039448301, 4691.202495575829, 3551.7158627309236, 3567.714582833419, 3572.0534058474004, 3586.0814464261493, 3604.6575575320303, 4909.239067944474, 4912.8771780705765, 4951.603871690329, 4989.775460104376, 5430.782768689208, 5329.680219186861, 5425.701586412785, 5438.211459338453, 5460.781568737206, 5475.959567682127, 5401.297831281908, 5424.2406063151975, 5447.918281225864, 5454.772676147835, 5463.207834864002, 5170.43125256229, 5219.2953951216095, 5333.599980001593, 5362.624616276979, 5377.327834020747, 5361.624686271924, 5429.0, 5435.864103397446, 5497.312835895513, 5499.780008799603, 5305.336832895888, 5361.410244872983, 5363.0, 5395.679857661244, 5402.567794576503], "value": 3924.6839416551375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.8617931696391, 591.6067660659147, 633.8985762278037, 675.3685304240538, 689.6517258784316, 11299.265547739391, 12314.507419703212, 12327.568535101273, 12370.257784532934, 12469.314187719672, 14090.78863817041, 14778.408863645442, 14839.0, 14840.332185051671, 14851.554453366416, 602.2682440834385, 768.2893323675605, 771.5602106799126, 779.4543819326494, 780.0834020026474, 757.8522188173308, 786.7207141464755, 791.0349373763999, 795.2405452792569, 796.2395911904117, 808.9312408445289, 809.6113865344638, 813.4346629092782, 815.3110621524831, 820.1183727492939, 812.6058861452191, 812.975610731679, 817.4931542443693, 817.9059408168048, 823.3125340340822, 595.1489370200611, 600.3876046432658, 600.7296716477603, 602.0758136260819, 602.2532060245308, 12125.393730313537, 12194.451249693697, 12283.078769092353, 12315.5073797048, 12355.32045737484, 11870.406479675981, 11952.223105498115, 12107.39463026854, 12144.817827732591, 12328.445219965122, 9758.512074396253, 10068.848967265498, 10245.334053286588, 10254.282200245985, 10361.740956476073, 3229.54786329914, 3236.676332366768, 3259.0, 3292.1440425489304, 3331.783434076777, 42808.14383712308, 42981.57018429807, 47448.76275618634, 58352.416475835125, 58893.0, 9016.8647470288, 9450.48022358763, 9474.242060635133, 9654.613815447303, 9710.271729620306, 17584.648307034044, 17608.471745847644, 17618.471445856645, 17674.558136046446, 17918.372856949944, 6196.10156527301, 6242.344553821874, 6446.548741588043, 6492.09110724499, 6716.83207919806, 3701.2227432239533, 3703.870364537282, 3707.5921648618632, 3765.585785563586, 3805.7906815125434, 2824.477471667748, 2940.5589161625926, 2946.734793868562, 2947.3515826518133, 2951.8671659775364, 484.4211167654689, 505.3809083872301, 507.3657927590512, 507.45955557331325, 517.6092050501848, 510.3416592595584, 534.4735435595935, 538.0933127679872, 541.1152765228801, 546.4398991034142, 7943.285104340522, 7979.521228726179, 8178.5092894426525, 8184.140665230065, 8448.493090414595, 487.74149700658705, 499.3383766509317, 519.1330478101579, 545.0788167996074, 562.9155626655952, 3695.611960744137, 3810.1808111256214, 3839.1937693084205, 3856.749311294757, 3883.5339759229073, 54276.0, 54572.72713636486, 57800.0, 90141.54929225311, 90720.5463972676, 46485.0, 53465.46534534605, 75468.24531754613, 77039.22960770321, 77571.61214194006, 70174.64912675506, 71378.34562618715, 71511.64244178745, 71736.28263717296, 72627.63686181641, 7230.927690723236, 7312.268773122645, 7324.670389832364, 7346.77959661211, 7417.109946806202, 44094.559054409045, 44836.551634483236, 44981.55018449904, 45212.321815173455, 45619.0, 61422.0, 63663.6816815913, 63748.0, 64013.0, 64393.0, 9634.855477167988, 9669.419834809934, 9701.757456063655, 9717.514124293615, 9746.85379719319, 10417.16662667, 10555.94722026385, 10642.627508037182, 10858.077063449695, 11071.501782419971, 10092.949535252277, 10235.283530152818, 10267.94866025665, 10347.12049475803, 10363.896361036595, 10187.235957303084, 10229.437380943822, 10254.487275636338, 10257.538410771383, 10723.624673136403, 9488.95255523718, 10205.795884082425, 10435.060844524029, 10537.104346130665, 10999.945000275267, 9090.0, 9310.534473276444, 9550.522473876417, 9708.85436718464, 9726.513674316397, 10014.0, 10025.899741002497, 10118.291719579853, 10289.382637041801, 10351.63769268072], "value": 6150.10261567366, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 108.0, 114.0, 114.0, 115.0, 116.0, 114.0, 113.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 132.0, 158.0, 189.0, 141.0, 157.0, 166.0, 142.0, 187.0, 133.0], "value": 156.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 177.0, 163.0, 165.0, 166.0, 161.0, 163.0, 164.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 165.0, 76.0, 76.0, 76.0, 76.0, 159.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 142.0, 86.0, 86.0, 87.0, 133.0, 87.0, 86.0, 136.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 119.0, 119.0, 118.0, 118.0, 117.0, 120.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 147.0, 149.0, 148.0, 149.0, 148.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 64.0, 65.0, 64.0, 64.0, 65.0, 63.0, 63.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 82.0, 84.0, 90.0, 84.0, 88.0, 84.0, 83.0, 90.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 132.0, 138.0, 130.0, 138.0, 132.0, 147.0, 132.0, 151.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 174.0, 171.0, 172.0, 171.0, 169.0, 172.0, 169.0, 172.0], "value": 170.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 69.0, 66.0, 66.0, 66.0, 71.0, 65.0], "value": 67.3, "unit": "score"}]}]} 13:32:13 INFO - Return code: 0 13:32:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:32:13 ERROR - # TBPL SUCCESS # 13:32:13 INFO - Running post-action listener: _resource_record_post_action 13:32:13 INFO - ##### 13:32:13 INFO - ##### Finished run-tests step (success) 13:32:13 INFO - ##### 13:32:13 INFO - Running post-run listener: _resource_record_post_run 13:32:13 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 7696384; Write bytes: 322637824; Read time: 824; Write time: 209648 13:32:13 INFO - TinderboxPrint: CPU usage
13.5% 13:32:13 INFO - TinderboxPrint: I/O read bytes / time
7,696,384 / 824 13:32:13 INFO - TinderboxPrint: I/O write bytes / time
322,637,824 / 209,648 13:32:13 INFO - TinderboxPrint: CPU idle
8,269.3 (86.5%) 13:32:13 INFO - TinderboxPrint: CPU user
1,238.9 (13.0%) 13:32:13 INFO - TinderboxPrint: Swap in / out
0 / 0 13:32:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 7684096; Read time: 0; Write time: 5456 13:32:13 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 5935104; Write bytes: 269869056; Read time: 748; Write time: 186660 13:32:14 INFO - Running post-run listener: _upload_blobber_files 13:32:14 INFO - Blob upload gear active. 13:32:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:14 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 13:32:14 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'] 13:32:14 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 13:32:14 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:32:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:32:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:15 INFO - (blobuploader) - INFO - Done attempting. 13:32:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:32:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:19 INFO - (blobuploader) - INFO - Done attempting. 13:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:32:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:19 INFO - (blobuploader) - INFO - Done attempting. 13:32:19 INFO - (blobuploader) - INFO - Iteration through files over. 13:32:20 INFO - Return code: 0 13:32:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:32:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:32:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acdd9f09ce834e188018086a436be55a2780d376e289fe2d6c649ba0e08aa181e203f925eb19943bf0d2ddab15c0ee1fe8bba8cd7b87d36386924ee56aeb1eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/725faaaf68fd3a513aad9cdc2ebe4b9c774247193fdace7ddfe15ec661339a9902fd232c6ebe0fdbb77a021037432886c700e407def795dc118f0f63f7bf2245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1690ce540d310185b8e998df76540e0e2a0ac1d92407f3b5169f841ee642e6d078ebf3727461fca32bdb4b679fa475c4c2e94c253307594a903e04fe335b97d"} 13:32:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:32:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:32:20 INFO - Contents: 13:32:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/acdd9f09ce834e188018086a436be55a2780d376e289fe2d6c649ba0e08aa181e203f925eb19943bf0d2ddab15c0ee1fe8bba8cd7b87d36386924ee56aeb1eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/725faaaf68fd3a513aad9cdc2ebe4b9c774247193fdace7ddfe15ec661339a9902fd232c6ebe0fdbb77a021037432886c700e407def795dc118f0f63f7bf2245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1690ce540d310185b8e998df76540e0e2a0ac1d92407f3b5169f841ee642e6d078ebf3727461fca32bdb4b679fa475c4c2e94c253307594a903e04fe335b97d"} 13:32:20 INFO - Running post-run listener: copy_logs_to_upload_dir 13:32:20 INFO - Copying logs to upload dir... 13:32:20 INFO - mkdir: /builds/slave/test/build/upload/logs 13:32:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.277768 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-27 13:32:20.013170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 13:32:20.016582) ========= 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=923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461 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/acdd9f09ce834e188018086a436be55a2780d376e289fe2d6c649ba0e08aa181e203f925eb19943bf0d2ddab15c0ee1fe8bba8cd7b87d36386924ee56aeb1eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/725faaaf68fd3a513aad9cdc2ebe4b9c774247193fdace7ddfe15ec661339a9902fd232c6ebe0fdbb77a021037432886c700e407def795dc118f0f63f7bf2245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1690ce540d310185b8e998df76540e0e2a0ac1d92407f3b5169f841ee642e6d078ebf3727461fca32bdb4b679fa475c4c2e94c253307594a903e04fe335b97d"} build_url:https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/VxwJSmC0T4-nVinl0q-pZA/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/acdd9f09ce834e188018086a436be55a2780d376e289fe2d6c649ba0e08aa181e203f925eb19943bf0d2ddab15c0ee1fe8bba8cd7b87d36386924ee56aeb1eed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/725faaaf68fd3a513aad9cdc2ebe4b9c774247193fdace7ddfe15ec661339a9902fd232c6ebe0fdbb77a021037432886c700e407def795dc118f0f63f7bf2245", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d1690ce540d310185b8e998df76540e0e2a0ac1d92407f3b5169f841ee642e6d078ebf3727461fca32bdb4b679fa475c4c2e94c253307594a903e04fe335b97d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 13:32:20.042572) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:32:20.042968) ========= 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=923d835db2ba3686ebe126b700000192-1467056952.462379-2017363461 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:32:20.127545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 13:32:20.127953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 13:32:20.128325) ========= ========= Total master_lag: 0.19 =========