builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1464988664.43 results: success (0) buildid: 20160603064911 builduid: d0bdf0c3be9b4ee78883cb2da956c2e3 revision: be6fddfc1390a14cd560eb843162f0cccd804e63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.431724) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.432203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.432494) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.447070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.447355) ========= 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=00204705a9daa57ed339a427000001b9-1464988663.800787-265192563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-03 14:17:44-- 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% 37.6M=0s 2016-06-03 14:17:44 (37.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086664 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.547678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.547995) ========= 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=00204705a9daa57ed339a427000001b9-1464988663.800787-265192563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014728 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:44.597498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 14:17:44.597874) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be6fddfc1390a14cd560eb843162f0cccd804e63 --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 be6fddfc1390a14cd560eb843162f0cccd804e63 --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=00204705a9daa57ed339a427000001b9-1464988663.800787-265192563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-03 14:17:44,856 truncating revision to first 12 chars 2016-06-03 14:17:44,856 Setting DEBUG logging. 2016-06-03 14:17:44,856 attempt 1/10 2016-06-03 14:17:44,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be6fddfc1390?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-03 14:17:46,344 unpacking tar archive at: fx-team-be6fddfc1390/testing/mozharness/ program finished with exit code 0 elapsedTime=1.830820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-03 14:17:46.442244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:46.445604) ========= script_repo_revision: be6fddfc1390a14cd560eb843162f0cccd804e63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:46.446027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:46.446298) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-03 14:17:46.456677) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-03 14:17:46.457048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=00204705a9daa57ed339a427000001b9-1464988663.800787-265192563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:46 INFO - MultiFileLogger online at 20160603 14:17:46 in /builds/slave/test 14:17:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:17:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:46 INFO - {'append_to_log': False, 14:17:46 INFO - 'base_work_dir': '/builds/slave/test', 14:17:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:17:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:46 INFO - 'branch': 'Fx-Team-Non-PGO', 14:17:46 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:46 INFO - 'config_files': ('talos/linux_config.py',), 14:17:46 INFO - 'default_actions': ('clobber', 14:17:46 INFO - 'read-buildbot-config', 14:17:46 INFO - 'download-and-extract', 14:17:46 INFO - 'populate-webroot', 14:17:46 INFO - 'create-virtualenv', 14:17:46 INFO - 'install', 14:17:46 INFO - 'run-tests'), 14:17:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:46 INFO - 'download_minidump_stackwalk': True, 14:17:46 INFO - 'download_symbols': 'ondemand', 14:17:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:46 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:46 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:46 INFO - 'installer_path': 'installer.exe', 14:17:46 INFO - 'log_level': 'info', 14:17:46 INFO - 'log_name': 'talos', 14:17:46 INFO - 'log_to_console': True, 14:17:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:46 INFO - 'opt_config_files': (), 14:17:46 INFO - 'pip_index': False, 14:17:46 INFO - 'sps_profile': False, 14:17:46 INFO - 'sps_profile_interval': 0, 14:17:46 INFO - 'suite': 'dromaeojs', 14:17:46 INFO - 'system_bits': '32', 14:17:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:46 INFO - 'title': 'talos-linux64-ix-016', 14:17:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:46 INFO - 'use_talos_json': True, 14:17:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:46 INFO - 'work_dir': 'build'} 14:17:46 INFO - ##### 14:17:46 INFO - ##### Running clobber step. 14:17:46 INFO - ##### 14:17:46 INFO - Running pre-action listener: _resource_record_pre_action 14:17:46 INFO - Running main action method: clobber 14:17:46 INFO - rmtree: /builds/slave/test/build 14:17:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:47 INFO - Running post-action listener: _resource_record_post_action 14:17:47 INFO - ##### 14:17:47 INFO - ##### Finished clobber step (success) 14:17:47 INFO - ##### 14:17:47 INFO - ##### 14:17:47 INFO - ##### Running read-buildbot-config step. 14:17:47 INFO - ##### 14:17:47 INFO - Running pre-action listener: _resource_record_pre_action 14:17:47 INFO - Running main action method: read_buildbot_config 14:17:47 INFO - Using buildbot properties: 14:17:47 INFO - { 14:17:47 INFO - "project": "", 14:17:47 INFO - "product": "firefox", 14:17:47 INFO - "script_repo_revision": "production", 14:17:47 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:17:47 INFO - "repository": "", 14:17:47 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:17:47 INFO - "buildid": "20160603064911", 14:17:47 INFO - "pgo_build": "False", 14:17:47 INFO - "basedir": "/builds/slave/test", 14:17:47 INFO - "buildnumber": 1752, 14:17:47 INFO - "slavename": "talos-linux64-ix-016", 14:17:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:17:47 INFO - "platform": "ubuntu64_hw", 14:17:47 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:17:47 INFO - "branch": "fx-team", 14:17:47 INFO - "repo_path": "integration/fx-team", 14:17:47 INFO - "revision": "be6fddfc1390a14cd560eb843162f0cccd804e63", 14:17:47 INFO - "stage_platform": "linux64", 14:17:47 INFO - "builduid": "d0bdf0c3be9b4ee78883cb2da956c2e3", 14:17:47 INFO - "slavebuilddir": "test" 14:17:47 INFO - } 14:17:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:17:47 INFO - Running post-action listener: _resource_record_post_action 14:17:47 INFO - ##### 14:17:47 INFO - ##### Finished read-buildbot-config step (success) 14:17:47 INFO - ##### 14:17:47 INFO - ##### 14:17:47 INFO - ##### Running download-and-extract step. 14:17:47 INFO - ##### 14:17:47 INFO - Running pre-action listener: _resource_record_pre_action 14:17:47 INFO - Running main action method: download_and_extract 14:17:47 INFO - mkdir: /builds/slave/test/build/tests 14:17:47 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')]} 14:17:47 INFO - https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:17:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:17:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:17:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:17:47 INFO - Downloaded 1361 bytes. 14:17:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:17:47 INFO - Using the following test package requirements: 14:17:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:17:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:17:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'jsshell-linux-x86_64.zip'], 14:17:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:17:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:17:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:17:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:17:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:17:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:17:47 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')]} 14:17:47 INFO - https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:17:49 INFO - Downloaded 22868152 bytes. 14:17:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:17:50 INFO - Return code: 0 14:17:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:50 INFO - https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:17:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:18:03 INFO - Downloaded 22868152 bytes. 14:18:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:18:05 INFO - Return code: 0 14:18:05 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')]} 14:18:05 INFO - https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:18:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:18:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:18:07 INFO - Downloaded 10833369 bytes. 14:18:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:18:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:18:08 INFO - Return code: 0 14:18:08 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')]} 14:18:08 INFO - https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:18:13 INFO - Downloaded 55170894 bytes. 14:18:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:13 INFO - mkdir: /builds/slave/test/properties 14:18:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:18:13 INFO - Writing to file /builds/slave/test/properties/build_url 14:18:13 INFO - Contents: 14:18:13 INFO - build_url:https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:18:14 INFO - Running post-action listener: _resource_record_post_action 14:18:14 INFO - Running post-action listener: set_extra_try_arguments 14:18:14 INFO - ##### 14:18:14 INFO - ##### Finished download-and-extract step (success) 14:18:14 INFO - ##### 14:18:14 INFO - ##### 14:18:14 INFO - ##### Running populate-webroot step. 14:18:14 INFO - ##### 14:18:14 INFO - Running pre-action listener: _resource_record_pre_action 14:18:14 INFO - Running main action method: populate_webroot 14:18:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:18:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:18:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:18:14 INFO - '--tppagecycles', 14:18:14 INFO - '7'], 14:18:14 INFO - 'tests': ['tsvgm']}}, 14:18:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:18:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:18:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:18:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:18:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:18:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['damp', 'tps']}, 14:18:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'tests': ['damp', 'tps']}, 14:18:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['dromaeo_dom']}, 14:18:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:18:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['a11yr', 14:18:14 INFO - 'ts_paint', 14:18:14 INFO - 'tpaint', 14:18:14 INFO - 'sessionrestore', 14:18:14 INFO - 'sessionrestore_no_auto_restore', 14:18:14 INFO - 'tabpaint']}, 14:18:14 INFO - 'other-e10s': {'tests': ['a11yr', 14:18:14 INFO - 'ts_paint', 14:18:14 INFO - 'tpaint', 14:18:14 INFO - 'sessionrestore', 14:18:14 INFO - 'sessionrestore_no_auto_restore', 14:18:14 INFO - 'tabpaint']}, 14:18:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:18:14 INFO - 'ts_paint', 14:18:14 INFO - 'tpaint', 14:18:14 INFO - 'sessionrestore', 14:18:14 INFO - 'sessionrestore_no_auto_restore', 14:18:14 INFO - 'tabpaint']}, 14:18:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:18:14 INFO - 'ts_paint', 14:18:14 INFO - 'tpaint', 14:18:14 INFO - 'sessionrestore', 14:18:14 INFO - 'sessionrestore_no_auto_restore', 14:18:14 INFO - 'tabpaint']}, 14:18:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['a11yr', 14:18:14 INFO - 'ts_paint', 14:18:14 INFO - 'tpaint', 14:18:14 INFO - 'sessionrestore', 14:18:14 INFO - 'sessionrestore_no_auto_restore', 14:18:14 INFO - 'tabpaint']}, 14:18:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['a11yr', 14:18:14 INFO - 'ts_paint', 14:18:14 INFO - 'tpaint', 14:18:14 INFO - 'sessionrestore', 14:18:14 INFO - 'sessionrestore_no_auto_restore', 14:18:14 INFO - 'tabpaint']}, 14:18:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['tsvgx', 14:18:14 INFO - 'tsvgr_opacity', 14:18:14 INFO - 'tart', 14:18:14 INFO - 'tscrollx', 14:18:14 INFO - 'cart']}, 14:18:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:18:14 INFO - 'tsvgr_opacity', 14:18:14 INFO - 'tart', 14:18:14 INFO - 'tscrollx', 14:18:14 INFO - 'cart']}, 14:18:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'talos_options': ['--disable-e10s'], 14:18:14 INFO - 'tests': ['tp5o']}, 14:18:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'tests': ['tp5o']}, 14:18:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'talos_options': ['--disable-e10s', 14:18:14 INFO - '--xperf_path', 14:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:14 INFO - 'tests': ['tp5n']}, 14:18:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:18:14 INFO - 'talos_options': ['--xperf_path', 14:18:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:18:14 INFO - 'tests': ['tp5n']}}, 14:18:14 INFO - 'talos.zip': {'path': '', 14:18:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:18:14 INFO - Running post-action listener: _resource_record_post_action 14:18:14 INFO - ##### 14:18:14 INFO - ##### Finished populate-webroot step (success) 14:18:14 INFO - ##### 14:18:14 INFO - ##### 14:18:14 INFO - ##### Running create-virtualenv step. 14:18:14 INFO - ##### 14:18:14 INFO - Running pre-action listener: _resource_record_pre_action 14:18:14 INFO - Running main action method: create_virtualenv 14:18:14 INFO - Creating virtualenv /builds/slave/test/build/venv 14:18:14 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 14:18:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:18:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:18:14 INFO - Using real prefix '/usr' 14:18:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:18:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:18:16 INFO - Installing pip.................done. 14:18:16 INFO - Return code: 0 14:18:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:18:16 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')]} 14:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:16 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')]} 14:18:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:16 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:16 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 14:18:16 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 14:18:16 INFO - Using env: {'DISPLAY': ':0', 14:18:16 INFO - 'HOME': '/home/cltbld', 14:18:16 INFO - 'LANG': 'en_US.UTF-8', 14:18:16 INFO - 'LANGUAGE': 'en_US:en', 14:18:16 INFO - 'LOGNAME': 'cltbld', 14:18:16 INFO - 'MAIL': '/var/mail/cltbld', 14:18:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:16 INFO - 'MOZ_NO_REMOTE': '1', 14:18:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:16 INFO - 'NO_EM_RESTART': '1', 14:18:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:16 INFO - 'PWD': '/builds/slave/test', 14:18:16 INFO - 'SHELL': '/bin/bash', 14:18:16 INFO - 'SHLVL': '1', 14:18:16 INFO - 'TERM': 'linux', 14:18:16 INFO - 'TMOUT': '86400', 14:18:16 INFO - 'USER': 'cltbld', 14:18:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:16 INFO - '_': '/tools/buildbot/bin/python'} 14:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:17 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 14:18:17 INFO - Cleaning up... 14:18:17 INFO - Return code: 0 14:18:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:17 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:17 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 14:18:17 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 14:18:17 INFO - Using env: {'DISPLAY': ':0', 14:18:17 INFO - 'HOME': '/home/cltbld', 14:18:17 INFO - 'LANG': 'en_US.UTF-8', 14:18:17 INFO - 'LANGUAGE': 'en_US:en', 14:18:17 INFO - 'LOGNAME': 'cltbld', 14:18:17 INFO - 'MAIL': '/var/mail/cltbld', 14:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:17 INFO - 'MOZ_NO_REMOTE': '1', 14:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:17 INFO - 'NO_EM_RESTART': '1', 14:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:17 INFO - 'PWD': '/builds/slave/test', 14:18:17 INFO - 'SHELL': '/bin/bash', 14:18:17 INFO - 'SHLVL': '1', 14:18:17 INFO - 'TERM': 'linux', 14:18:17 INFO - 'TMOUT': '86400', 14:18:17 INFO - 'USER': 'cltbld', 14:18:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:17 INFO - '_': '/tools/buildbot/bin/python'} 14:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:17 INFO - Downloading/unpacking psutil>=3.1.1 14:18:17 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 14:18:17 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 14:18:17 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 14:18:17 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 14:18:17 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 14:18:17 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 14:18:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:19 INFO - Installing collected packages: psutil 14:18:19 INFO - Running setup.py install for psutil 14:18:19 INFO - building 'psutil._psutil_linux' extension 14:18:19 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 14:18:19 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 14:18:19 INFO - building 'psutil._psutil_posix' extension 14:18:19 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 14:18:19 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 14:18:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:19 INFO - Successfully installed psutil 14:18:19 INFO - Cleaning up... 14:18:19 INFO - Return code: 0 14:18:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:18:19 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')]} 14:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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')]} 14:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:19 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:19 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 14:18:19 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 14:18:19 INFO - Using env: {'DISPLAY': ':0', 14:18:19 INFO - 'HOME': '/home/cltbld', 14:18:19 INFO - 'LANG': 'en_US.UTF-8', 14:18:19 INFO - 'LANGUAGE': 'en_US:en', 14:18:19 INFO - 'LOGNAME': 'cltbld', 14:18:19 INFO - 'MAIL': '/var/mail/cltbld', 14:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:19 INFO - 'MOZ_NO_REMOTE': '1', 14:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:19 INFO - 'NO_EM_RESTART': '1', 14:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:19 INFO - 'PWD': '/builds/slave/test', 14:18:19 INFO - 'SHELL': '/bin/bash', 14:18:19 INFO - 'SHLVL': '1', 14:18:19 INFO - 'TERM': 'linux', 14:18:19 INFO - 'TMOUT': '86400', 14:18:19 INFO - 'USER': 'cltbld', 14:18:19 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:19 INFO - '_': '/tools/buildbot/bin/python'} 14:18:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:20 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 14:18:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:18:22 INFO - Installing collected packages: mozsystemmonitor 14:18:22 INFO - Running setup.py install for mozsystemmonitor 14:18:22 INFO - Successfully installed mozsystemmonitor 14:18:22 INFO - Cleaning up... 14:18:22 INFO - Return code: 0 14:18:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:18:22 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')]} 14:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:22 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')]} 14:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:22 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:22 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 14:18:22 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 14:18:22 INFO - Using env: {'DISPLAY': ':0', 14:18:22 INFO - 'HOME': '/home/cltbld', 14:18:22 INFO - 'LANG': 'en_US.UTF-8', 14:18:22 INFO - 'LANGUAGE': 'en_US:en', 14:18:22 INFO - 'LOGNAME': 'cltbld', 14:18:22 INFO - 'MAIL': '/var/mail/cltbld', 14:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:22 INFO - 'MOZ_NO_REMOTE': '1', 14:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:22 INFO - 'NO_EM_RESTART': '1', 14:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:22 INFO - 'PWD': '/builds/slave/test', 14:18:22 INFO - 'SHELL': '/bin/bash', 14:18:22 INFO - 'SHLVL': '1', 14:18:22 INFO - 'TERM': 'linux', 14:18:22 INFO - 'TMOUT': '86400', 14:18:22 INFO - 'USER': 'cltbld', 14:18:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:22 INFO - '_': '/tools/buildbot/bin/python'} 14:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:22 INFO - Downloading/unpacking jsonschema==2.5.1 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:22 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 14:18:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:24 INFO - warning: no files found matching '*.txt' 14:18:24 INFO - no previously-included directories found matching 'build' 14:18:24 INFO - no previously-included directories found matching 'dist' 14:18:24 INFO - no previously-included directories found matching '.git*' 14:18:24 INFO - Installing collected packages: jsonschema, functools32 14:18:24 INFO - Running setup.py install for functools32 14:18:24 INFO - warning: no files found matching '*.txt' 14:18:24 INFO - no previously-included directories found matching 'build' 14:18:24 INFO - no previously-included directories found matching 'dist' 14:18:24 INFO - no previously-included directories found matching '.git*' 14:18:24 INFO - Successfully installed jsonschema functools32 14:18:24 INFO - Cleaning up... 14:18:24 INFO - Return code: 0 14:18:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:24 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:24 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 14:18:24 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 14:18:24 INFO - Using env: {'DISPLAY': ':0', 14:18:24 INFO - 'HOME': '/home/cltbld', 14:18:24 INFO - 'LANG': 'en_US.UTF-8', 14:18:24 INFO - 'LANGUAGE': 'en_US:en', 14:18:24 INFO - 'LOGNAME': 'cltbld', 14:18:24 INFO - 'MAIL': '/var/mail/cltbld', 14:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:24 INFO - 'MOZ_NO_REMOTE': '1', 14:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:24 INFO - 'NO_EM_RESTART': '1', 14:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:24 INFO - 'PWD': '/builds/slave/test', 14:18:24 INFO - 'SHELL': '/bin/bash', 14:18:24 INFO - 'SHLVL': '1', 14:18:24 INFO - 'TERM': 'linux', 14:18:24 INFO - 'TMOUT': '86400', 14:18:24 INFO - 'USER': 'cltbld', 14:18:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:24 INFO - '_': '/tools/buildbot/bin/python'} 14:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 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 14:18:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:26 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 14:18:26 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 14:18:26 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 14:18:26 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 14:18:26 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 14:18:26 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 14:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:27 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 14:18:27 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 14:18:27 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 14:18:27 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 14:18:27 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 14:18:27 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 14:18:27 INFO - Downloading docopt-0.6.1.tar.gz 14:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:27 INFO - Running setup.py install for blobuploader 14:18:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:27 INFO - Running setup.py install for requests 14:18:28 INFO - Running setup.py install for docopt 14:18:28 INFO - Successfully installed blobuploader requests docopt 14:18:28 INFO - Cleaning up... 14:18:28 INFO - Return code: 0 14:18:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:28 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:28 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 14:18:28 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 14:18:28 INFO - Using env: {'DISPLAY': ':0', 14:18:28 INFO - 'HOME': '/home/cltbld', 14:18:28 INFO - 'LANG': 'en_US.UTF-8', 14:18:28 INFO - 'LANGUAGE': 'en_US:en', 14:18:28 INFO - 'LOGNAME': 'cltbld', 14:18:28 INFO - 'MAIL': '/var/mail/cltbld', 14:18:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:28 INFO - 'MOZ_NO_REMOTE': '1', 14:18:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:28 INFO - 'NO_EM_RESTART': '1', 14:18:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:28 INFO - 'PWD': '/builds/slave/test', 14:18:28 INFO - 'SHELL': '/bin/bash', 14:18:28 INFO - 'SHLVL': '1', 14:18:28 INFO - 'TERM': 'linux', 14:18:28 INFO - 'TMOUT': '86400', 14:18:28 INFO - 'USER': 'cltbld', 14:18:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:28 INFO - '_': '/tools/buildbot/bin/python'} 14:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:28 INFO - Running setup.py (path:/tmp/pip-UT_ouG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:28 INFO - Running setup.py (path:/tmp/pip-9tE7jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:28 INFO - Running setup.py (path:/tmp/pip-mvXI__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:28 INFO - Running setup.py (path:/tmp/pip-94ex8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:28 INFO - Running setup.py (path:/tmp/pip-2u5SIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:28 INFO - Running setup.py (path:/tmp/pip-wtFz_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:28 INFO - Running setup.py (path:/tmp/pip-8O1dqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:28 INFO - Running setup.py (path:/tmp/pip-qGWbKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:29 INFO - Running setup.py (path:/tmp/pip-XNNfz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:29 INFO - Running setup.py (path:/tmp/pip-4ew7bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:29 INFO - Running setup.py (path:/tmp/pip-dRHr0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:29 INFO - Running setup.py (path:/tmp/pip-ZpP8ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:29 INFO - Running setup.py (path:/tmp/pip-7p_AgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:29 INFO - Running setup.py (path:/tmp/pip-P2q23y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:29 INFO - Running setup.py (path:/tmp/pip-psaBpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:29 INFO - Running setup.py (path:/tmp/pip-91vqWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:29 INFO - Running setup.py (path:/tmp/pip-MMgJkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:29 INFO - Running setup.py install for manifestparser 14:18:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:29 INFO - Running setup.py install for mozcrash 14:18:29 INFO - Running setup.py install for mozdebug 14:18:29 INFO - Running setup.py install for mozdevice 14:18:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Running setup.py install for mozfile 14:18:30 INFO - Running setup.py install for mozhttpd 14:18:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Running setup.py install for mozinfo 14:18:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Running setup.py install for mozInstall 14:18:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Running setup.py install for mozleak 14:18:30 INFO - Running setup.py install for mozlog 14:18:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Running setup.py install for moznetwork 14:18:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:30 INFO - Running setup.py install for mozprocess 14:18:30 INFO - Running setup.py install for mozprofile 14:18:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:31 INFO - Running setup.py install for mozrunner 14:18:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:31 INFO - Running setup.py install for mozscreenshot 14:18:31 INFO - Running setup.py install for moztest 14:18:31 INFO - Running setup.py install for mozversion 14:18:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:31 INFO - Cleaning up... 14:18:31 INFO - Return code: 0 14:18:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:31 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:31 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 14:18:31 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 14:18:31 INFO - Using env: {'DISPLAY': ':0', 14:18:31 INFO - 'HOME': '/home/cltbld', 14:18:31 INFO - 'LANG': 'en_US.UTF-8', 14:18:31 INFO - 'LANGUAGE': 'en_US:en', 14:18:31 INFO - 'LOGNAME': 'cltbld', 14:18:31 INFO - 'MAIL': '/var/mail/cltbld', 14:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:31 INFO - 'MOZ_NO_REMOTE': '1', 14:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:31 INFO - 'NO_EM_RESTART': '1', 14:18:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:31 INFO - 'PWD': '/builds/slave/test', 14:18:31 INFO - 'SHELL': '/bin/bash', 14:18:31 INFO - 'SHLVL': '1', 14:18:31 INFO - 'TERM': 'linux', 14:18:31 INFO - 'TMOUT': '86400', 14:18:31 INFO - 'USER': 'cltbld', 14:18:31 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:31 INFO - '_': '/tools/buildbot/bin/python'} 14:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:31 INFO - Running setup.py (path:/tmp/pip-HWbfqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:31 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)) 14:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:31 INFO - Running setup.py (path:/tmp/pip-fnYIna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:31 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)) 14:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:31 INFO - Running setup.py (path:/tmp/pip-PZEboa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:31 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)) 14:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:31 INFO - Running setup.py (path:/tmp/pip-h_ULcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:32 INFO - Running setup.py (path:/tmp/pip-ru3OFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:32 INFO - Running setup.py (path:/tmp/pip-k6bQU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:32 INFO - Running setup.py (path:/tmp/pip-dG1GaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:32 INFO - Running setup.py (path:/tmp/pip-5FT6at-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:32 INFO - Running setup.py (path:/tmp/pip-_MmLM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:32 INFO - Running setup.py (path:/tmp/pip-Cm_Jxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:32 INFO - Running setup.py (path:/tmp/pip-SHcobZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:32 INFO - Running setup.py (path:/tmp/pip-Rfje5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:32 INFO - Running setup.py (path:/tmp/pip-IpPywx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:32 INFO - Running setup.py (path:/tmp/pip-A7znov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:32 INFO - Running setup.py (path:/tmp/pip-f69C9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:32 INFO - Running setup.py (path:/tmp/pip-zUv00P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:32 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)) 14:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:32 INFO - Running setup.py (path:/tmp/pip-9RvLGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:32 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)) 14:18:32 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)) 14:18:32 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)) 14:18:32 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)) 14:18:32 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)) 14:18:32 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)) 14:18:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:32 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 14:18:32 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 14:18:32 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 14:18:32 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 14:18:32 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 14:18:32 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 14:18:34 INFO - Downloading blessings-1.6.tar.gz 14:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:34 INFO - Installing collected packages: blessings 14:18:34 INFO - Running setup.py install for blessings 14:18:35 INFO - Successfully installed blessings 14:18:35 INFO - Cleaning up... 14:18:35 INFO - Return code: 0 14:18:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:35 INFO - Reading from file tmpfile_stdout 14:18:35 INFO - Current package versions: 14:18:35 INFO - argparse == 1.2.1 14:18:35 INFO - blessings == 1.6 14:18:35 INFO - blobuploader == 1.2.4 14:18:35 INFO - docopt == 0.6.1 14:18:35 INFO - functools32 == 3.2.3-2 14:18:35 INFO - jsonschema == 2.5.1 14:18:35 INFO - manifestparser == 1.1 14:18:35 INFO - mozInstall == 1.12 14:18:35 INFO - mozcrash == 0.17 14:18:35 INFO - mozdebug == 0.1 14:18:35 INFO - mozdevice == 0.48 14:18:35 INFO - mozfile == 1.2 14:18:35 INFO - mozhttpd == 0.7 14:18:35 INFO - mozinfo == 0.9 14:18:35 INFO - mozleak == 0.1 14:18:35 INFO - mozlog == 3.2 14:18:35 INFO - moznetwork == 0.27 14:18:35 INFO - mozprocess == 0.22 14:18:35 INFO - mozprofile == 0.28 14:18:35 INFO - mozrunner == 6.11 14:18:35 INFO - mozscreenshot == 0.1 14:18:35 INFO - mozsystemmonitor == 0.3 14:18:35 INFO - moztest == 0.7 14:18:35 INFO - mozversion == 1.4 14:18:35 INFO - psutil == 3.1.1 14:18:35 INFO - requests == 1.2.3 14:18:35 INFO - wsgiref == 0.1.2 14:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:35 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')]} 14:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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')]} 14:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:35 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 14:18:35 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 14:18:35 INFO - Using env: {'DISPLAY': ':0', 14:18:35 INFO - 'HOME': '/home/cltbld', 14:18:35 INFO - 'LANG': 'en_US.UTF-8', 14:18:35 INFO - 'LANGUAGE': 'en_US:en', 14:18:35 INFO - 'LOGNAME': 'cltbld', 14:18:35 INFO - 'MAIL': '/var/mail/cltbld', 14:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:35 INFO - 'MOZ_NO_REMOTE': '1', 14:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:35 INFO - 'NO_EM_RESTART': '1', 14:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:35 INFO - 'PWD': '/builds/slave/test', 14:18:35 INFO - 'SHELL': '/bin/bash', 14:18:35 INFO - 'SHLVL': '1', 14:18:35 INFO - 'TERM': 'linux', 14:18:35 INFO - 'TMOUT': '86400', 14:18:35 INFO - 'USER': 'cltbld', 14:18:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:35 INFO - '_': '/tools/buildbot/bin/python'} 14:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 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)) 14:18:35 INFO - Cleaning up... 14:18:35 INFO - Return code: 0 14:18:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:35 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')]} 14:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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')]} 14:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:35 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 14:18:35 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 14:18:35 INFO - Using env: {'DISPLAY': ':0', 14:18:35 INFO - 'HOME': '/home/cltbld', 14:18:35 INFO - 'LANG': 'en_US.UTF-8', 14:18:35 INFO - 'LANGUAGE': 'en_US:en', 14:18:35 INFO - 'LOGNAME': 'cltbld', 14:18:35 INFO - 'MAIL': '/var/mail/cltbld', 14:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:35 INFO - 'MOZ_NO_REMOTE': '1', 14:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:35 INFO - 'NO_EM_RESTART': '1', 14:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:35 INFO - 'PWD': '/builds/slave/test', 14:18:35 INFO - 'SHELL': '/bin/bash', 14:18:35 INFO - 'SHLVL': '1', 14:18:35 INFO - 'TERM': 'linux', 14:18:35 INFO - 'TMOUT': '86400', 14:18:35 INFO - 'USER': 'cltbld', 14:18:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:35 INFO - '_': '/tools/buildbot/bin/python'} 14:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:18:35 INFO - Cleaning up... 14:18:35 INFO - Return code: 0 14:18:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:18:35 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')]} 14:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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')]} 14:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:35 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 0x7ff0e7a3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ea3350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, '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': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', '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 14:18:35 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 14:18:35 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 14:18:35 INFO - Using env: {'DISPLAY': ':0', 14:18:35 INFO - 'HOME': '/home/cltbld', 14:18:35 INFO - 'LANG': 'en_US.UTF-8', 14:18:35 INFO - 'LANGUAGE': 'en_US:en', 14:18:35 INFO - 'LOGNAME': 'cltbld', 14:18:35 INFO - 'MAIL': '/var/mail/cltbld', 14:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:35 INFO - 'MOZ_NO_REMOTE': '1', 14:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:35 INFO - 'NO_EM_RESTART': '1', 14:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:35 INFO - 'PWD': '/builds/slave/test', 14:18:35 INFO - 'SHELL': '/bin/bash', 14:18:35 INFO - 'SHLVL': '1', 14:18:35 INFO - 'TERM': 'linux', 14:18:35 INFO - 'TMOUT': '86400', 14:18:35 INFO - 'USER': 'cltbld', 14:18:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:35 INFO - '_': '/tools/buildbot/bin/python'} 14:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:35 INFO - Downloading/unpacking flake8 14:18:35 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 14:18:35 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 14:18:35 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 14:18:35 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 14:18:35 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 14:18:35 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 14:18:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:37 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 14:18:37 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 14:18:37 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 14:18:37 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 14:18:37 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 14:18:37 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 14:18:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 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 14:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:38 INFO - no previously-included directories found matching 'docs/_build' 14:18:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:38 INFO - Running setup.py install for pep8 14:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:38 INFO - no previously-included directories found matching 'docs/_build' 14:18:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:38 INFO - Cleaning up... 14:18:38 INFO - Return code: 0 14:18:38 INFO - Running post-action listener: _resource_record_post_action 14:18:38 INFO - Running post-action listener: _start_resource_monitoring 14:18:38 INFO - Starting resource monitoring. 14:18:38 INFO - ##### 14:18:38 INFO - ##### Finished create-virtualenv step (success) 14:18:38 INFO - ##### 14:18:38 INFO - ##### 14:18:38 INFO - ##### Running install step. 14:18:38 INFO - ##### 14:18:38 INFO - Running pre-action listener: _resource_record_pre_action 14:18:38 INFO - Running main action method: install 14:18:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:39 INFO - Reading from file tmpfile_stdout 14:18:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:39 INFO - Reading from file tmpfile_stdout 14:18:39 INFO - Output received: 14:18:39 INFO - Usage: mozinstall [options] installer 14:18:39 INFO - Options: 14:18:39 INFO - -h, --help show this help message and exit 14:18:39 INFO - -d DEST, --destination=DEST 14:18:39 INFO - Directory to install application into. [default: 14:18:39 INFO - "/builds/slave/test"] 14:18:39 INFO - --app=APP Application being installed. [default: firefox] 14:18:39 INFO - mkdir: /builds/slave/test/build/application 14:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:18:55 INFO - Reading from file tmpfile_stdout 14:18:55 INFO - Output received: 14:18:55 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:55 INFO - Running post-action listener: _resource_record_post_action 14:18:55 INFO - ##### 14:18:55 INFO - ##### Finished install step (success) 14:18:55 INFO - ##### 14:18:55 INFO - ##### 14:18:55 INFO - ##### Running run-tests step. 14:18:55 INFO - ##### 14:18:55 INFO - Running pre-action listener: _resource_record_pre_action 14:18:55 INFO - Running main action method: run_tests 14:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:55 INFO - Python 2.7.3 14:18:55 INFO - Return code: 0 14:18:55 INFO - grabbing minidump binary from tooltool 14:18: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')]} 14:18:55 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 0x1f321c0>, '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 0x1f330c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f33550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:55 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 14:18:55 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 14:18:55 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 14:18:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:55 INFO - Return code: 0 14:18:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:18:56 INFO - Return code: 0 14:18:56 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:18:56 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:18:56 INFO - Using env: {'DISPLAY': ':0', 14:18:56 INFO - 'HOME': '/home/cltbld', 14:18:56 INFO - 'LANG': 'en_US.UTF-8', 14:18:56 INFO - 'LANGUAGE': 'en_US:en', 14:18:56 INFO - 'LOGNAME': 'cltbld', 14:18:56 INFO - 'MAIL': '/var/mail/cltbld', 14:18:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:56 INFO - 'MOZ_NO_REMOTE': '1', 14:18:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:56 INFO - 'NO_EM_RESTART': '1', 14:18:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:56 INFO - 'PWD': '/builds/slave/test', 14:18:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:56 INFO - 'SHELL': '/bin/bash', 14:18:56 INFO - 'SHLVL': '1', 14:18:56 INFO - 'TERM': 'linux', 14:18:56 INFO - 'TMOUT': '86400', 14:18:56 INFO - 'USER': 'cltbld', 14:18:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1464988663.800787-265192563', 14:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:56 INFO - '_': '/tools/buildbot/bin/python'} 14:18:56 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:18:56 INFO - mozversion application_buildid: 20160603064911 14:18:56 INFO - mozversion application_changeset: be6fddfc1390a14cd560eb843162f0cccd804e63 14:18:56 INFO - mozversion application_display_name: Nightly 14:18:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:56 INFO - mozversion application_name: Firefox 14:18:56 INFO - mozversion application_remotingname: firefox 14:18:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:18:56 INFO - mozversion application_vendor: Mozilla 14:18:56 INFO - mozversion application_version: 49.0a1 14:18:56 INFO - mozversion platform_buildid: 20160603064911 14:18:56 INFO - mozversion platform_changeset: be6fddfc1390a14cd560eb843162f0cccd804e63 14:18:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:18:56 INFO - mozversion platform_version: 49.0a1 14:18:56 INFO - using testdate: 1464988736 14:18:56 INFO - actual date: 1464988736 14:18:56 INFO - starting webserver on 'localhost:56749' 14:18:56 INFO - SUITE-START | Running 2 tests 14:18:56 INFO - TEST-START | dromaeo_css 14:18:56 INFO - operating with platform_type : linux_ 14:18:56 INFO - Initialising browser for dromaeo_css test... 14:18:56 INFO - TEST-INFO | started process 4314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkQw56/profile http://localhost:56749/getInfo.html) 14:19:00 INFO - PROCESS | 4314 | __metrics Screen width/height:1600/1200 14:19:00 INFO - PROCESS | 4314 | colorDepth:24 14:19:00 INFO - PROCESS | 4314 | Browser inner width/height: 1024/697 14:19:00 INFO - PROCESS | 4314 | __metrics 14:19:01 ERROR - PROCESS | 4314 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:19:02 INFO - TEST-INFO | 4314: exit 0 14:19:02 INFO - Browser initialized. 14:19:02 INFO - Running cycle 1/1 for dromaeo_css test... 14:19:02 INFO - TEST-INFO | started process 4394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHkQw56/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:19:14 INFO - PROCESS | 4394 | RSS: Main: 157958144 14:19:14 INFO - PROCESS | 4394 | 14:20:05 INFO - PROCESS | 4394 | 1464988805891 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] 14:22:17 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56749/tests/dromaeo/cssquery-ext.html) 14:22:18 INFO - PROCESS | 4394 | RSS: Main: 249917440 14:22:18 INFO - PROCESS | 4394 | 14:25:21 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-ext.html (next: http://localhost:56749/tests/dromaeo/cssquery-jquery.html) 14:25:21 INFO - PROCESS | 4394 | RSS: Main: 242470912 14:25:21 INFO - PROCESS | 4394 | 14:28:23 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56749/tests/dromaeo/cssquery-mootools.html) 14:28:24 INFO - PROCESS | 4394 | RSS: Main: 248766464 14:28:24 INFO - PROCESS | 4394 | 14:31:26 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56749/tests/dromaeo/cssquery-prototype.html) 14:31:27 INFO - PROCESS | 4394 | RSS: Main: 237703168 14:31:27 INFO - PROCESS | 4394 | 14:34:30 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56749/tests/dromaeo/cssquery-yui.html) 14:34:31 INFO - PROCESS | 4394 | RSS: Main: 214388736 14:34:31 INFO - PROCESS | 4394 | 14:37:33 INFO - PROCESS | 4394 | Cycle 1(1): loaded http://localhost:56749/tests/dromaeo/cssquery-yui.html (next: http://localhost:56749/tests/dromaeo/cssquery-dojo.html) 14:37:34 INFO - PROCESS | 4394 | RSS: Main: 300216320 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | __start_tp_report 14:37:34 INFO - PROCESS | 4394 | _x_x_mozilla_page_load 14:37:34 INFO - PROCESS | 4394 | _x_x_mozilla_page_load_details 14:37:34 INFO - PROCESS | 4394 | |i|pagename|runs| 14:37:34 INFO - PROCESS | 4394 | |0;dojo.html;2657.3622330640646;2672.0380662961343;2703.256604433782;2703.675558932928;2714.199311203195;4543.2957891526785;4601.079784043192;4619.584237418631;4700.600448961838;4728.858134255969;4655.464621568521;4711.90576188476;4736.360591320171;4747.121782470237;4748.145333839908;4147.0461793787445;4303.3544968254855;4400.933985990213;4431.091626216617;4480.283154695249;4409.867703968886;4448.621867141281;4461.933071003921;4463;4480.955190448102;4260.233158031569;4310.374995625648;4349;4389.385486031958;4401.185780630562;4306.935395969063;4310.181065597527;4317.935230971538;4369.257226271509;4415.779211039435;4331.198728235287;4345.217860785057;4365.781710914442;4403.899025243689;4405.383246345515;4526.072155208174;4569.611583015414;4574.817007319736;4605.0559635274685;4611.492735799059;5118.948810511884;5128.769205385766;5139.486051394868;5140.537351638371;5146.9485305146845;5103.693778373309;5154.92267615986;5158.045761534128;5158.690478571298;5167.147420675584;4629.259318509056;4657.394538709946;4711.976440117777;4716.905661886812;4730;5142.331496905378;5201.6358854880555;5204.063268611686;5206.427292997767;5213.791448342024;4868.610511159099;4987.526185012491;4991.625628077909;4998.175301075355;5007.749612519359;5030.84907452777;5040.621953353513;5052.418971818288;5086.618503612244;5114.923276150861;5011.148104822116;5012.022655582126;5028.346314979102;5031.84904452867;5071.822486212965;4987.426445958761;4987.700737955662;4996.150654388763;5002.699838009658;5049.040682270357;4209.579042095827;4251.277282861921;4253.468316460442;4293.141371725667;4302.268614335508;3788.2612890486644;3816.9427458588143;3829.463875057494;3831.540215174197;3834.7315687902137;4308.202982448257;4361.127774445124;4369.3227549729845;4373.628241599499;4384.868453946323;5110.923336149961;5113.233015047773;5117.795288188431;5118.411382690963;5176.352955880515;4188.099558594856;4361.5856493633055;4371.213181627338;4379.233634114017;4416.11677664462;4507.504174540798;4525.208088584551;4546.65900057497;4553.681242313006;4561.315802629632;4785.63909136722;4802.327674125555;4802.879928001688;4809.158397280392;4855.514448555116;4970.826021089245;5032.220005899091;5063.1898896176435;5117.795288188579;5157.0975079361715;4755.809767609257;4786.832460863853;4801.807927682993;4801.95198048015;4848.151573474557;4978.029284289529;4978.228374601942;4983.302337672656;5011.373578302712;5030.9245361320345;4868.537488938545;5034.748262586929;5070.036693028313;5073.644844860972;5130.589552835839;4949.777260023236;4964.726940018334;4968.826091086795;4970.155073637418;4994.500549944976;4952.47998960104;4955.65310428281;4956.454789973028;4963.305137280856;5002.52476014778;4694.131585656664;4795.520447955177;4817.084753896748;4837.419509658864;4907.631927605373;4940.481249468754;4946.35697359341;4951.603871690329;4980.5019498049905;4982.800687972441;4805.399325084364;4811.855644330676;4813.326134341125;4820;4864.051509955666 14:37:34 INFO - PROCESS | 4394 | |1;ext.html;558.6759679385954;592.9614575052622;596.3023262782544;597.7907732293701;612.0574315554047;28371;28908.27729306766;31328.21679458012;41438.171236575254;42491;42741.78629106858;43222;43265.35101973465;43270.78364608181;43344.78327608357;7770.33952114071;7929.246721561442;7933.841323173533;7936.880946785803;7940.126586075556;7737.955376024249;7850.057993040815;7867.134615192324;7868.842623147562;7873.448858579902;7875.094364148111;7910.762677119696;7912.525248485109;7914.722984695537;7923.12845586985;7856.4893281936775;7903.683852645887;7908.6836526539155;7912.920870791276;7916.406269529751;7733.226677332278;7802.33680137189;7804.297613214781;7813.492123011986;7815.335696465807;38783.418248726295;39064;39113.80443097766;39138.217235655415;39372;3034.9393012139853;3187.235063584723;3431.1936694876686;3441.5353927219753;3851;29955.25111872199;30402.239944001576;30415.847920760476;30459.543106853416;30778.846105769553;3237.530558069067;3274.3123943971796;3279.196596833767;3409.6590340965954;3455.9308813823836;249144;249962.9999999982;250286;250673;252373;34216.82891585526;35483.82258088693;55490.44509554853;55537.1669424959;55802.441975580536;33317.50023749645;33527.664723352456;33547.16132096668;33566.66433335684;33664.49503257453;12564.120511564102;12761.361931903368;12766.553170639168;12771.936140319425;12772.489100436065;10168.796624067478;10201.336913100624;10230.6419275325;10231;10232.53953572091;8063.717769878143;8069.233422824822;8090.271875531231;8159.632816523271;8165.959170204111;3121.7034381733697;3130.1079192430047;3131.5459258407404;3143.072793525915;3165.3669266146862;894.2354287084449;902.359324879343;935.6179741836912;936.2135805923058;1051.9631812886512;28688.426231475252;28886;29099;29281.707182928323;29316.706832931824;860.8063185783149;1002.4336250018716;1018.8369860822232;1022.6114076650825;1045.9906190526026;14792.186429746467;15003.721706289794;15162.940751516731;15230.695386092217;15274;383973;385834;388255;388821;388857;49594.50405495971;50264.24603630949;50339.24491132636;50384.49615503798;50433.747831261346;1081.8377243413552;1086.462201210406;1199.1486044908213;1204.3135412814786;1213.4660749270292;29101.417971640873;29791.55312670268;29853.402931941673;30210.54684179783;30346.241343966576;37876.62123378731;38150.427743583314;38174.236515270095;38191;38256;294260;296213;296233;296424;296538;25314.240572782845;26630.06794762174;26652;26664.733352666226;26670.19989400321;42828.35757463578;43142;43508.564914351715;44383.77808111068;44457.55424457529;36862.44706329461;37901;37902.24195516019;37928;38086;35919;36587.268254634226;37009.629903701694;37316.626833731316;37791.62208377881;37108;37344;37561.624383756905;37788.81105594454;37908.43137352887;33002.504962426065;33896.830515847265;34123.65876341205;34277.314453710285;34477.482837757954;25401.237962861145;25906.61140082938;25999.220023399328;26058.026615513394;26305.342366440993 14:37:34 INFO - PROCESS | 4394 | |2;jquery.html;378.6289436352375;380.5946666799858;380.739193652348;385.61438561438564;391.843262694922;15855.76216356754;16044.278007489662;16786.916065419686;16804.32782688691;16824.32702691891;9787.265955053364;10452.581896724141;10507.947460262707;10525.578976840936;10528.210384221195;4583.931241031387;4720.575148236658;4757.881052973668;4767.332573439721;4787.54518320759;4584.954150458503;4661.953380466202;4709.764511774398;4738.928916066262;4745.691530050535;4720.669553131283;4720.693154944935;4724.031573527436;4727.64542659302;6308.179936608234;6692.431143352821;6744.156980377453;6823.727050917957;6863.039174515572;6867.416269617113;6137.2635283765785;6491.221053473613;6492.253390860064;6496.837579060514;6594.472442204612;22395.664065039036;22713.432164196027;23312.251581131484;23325.183618573268;23347.533049339087;2076.8961551922343;2077.044559502631;2110.7045013698093;2132.2004248406847;2184.5084855907294;13801.102928309629;13954;14304.427822887175;14525.12849229039;14674.779878301833;1713.297548005312;1748.7464317673994;1754.1863513814367;1763.7707098077296;1774.4144432337428;41281.12505968188;42859.35710964338;65876.3412365875;80164.19835801626;81562;16204.918975405284;16511.669766604602;16828.83171168297;16846.747298790528;17445.47663570095;23143.421414464774;24262.272131836075;29894.701052989192;29946.700532994826;29949.401011979637;8145.714899978472;8577.485350878842;8802.86795698065;8823.970486787946;8898.11018898105;7021.5787052777;7090.6100164491445;7150.356467917913;7211.062561866924;7278.163011253773;8333.791655208668;8510.70212542558;8569.871451928226;8615.793788869563;8716.38985271025;3130.4834702274325;3183.633882103588;3262.559554460165;3367.726784420506;3412.522246885438;765.6478020110811;858.656537385051;896.4307664632875;902.1519771414848;927.9768005799909;16111.113888736232;16587.336506539843;16592.668146637243;16620.833791661928;17051;860.9096044915319;862.5859587398085;867.3408209760628;898.851689471243;905.031616170691;9370.718878433658;9528.428294302365;9550.904490955001;9583.808323833484;9753;343996;344108;345632;346306;347810;75727;77734.611326943;77744;78065.60967195127;78753;930.1767935377104;944.4474982135528;950.9049095090436;956.5695437053354;969.2052516936186;13864.445422183404;14995.400183992519;15057.472988445352;15087.32107055207;15407.075575465507;26287;33063.47424865943;34370.31259374849;35558.46662300016;36212.81893590621;44667.55332446634;46368.30447543357;49114.26328605002;49411.752941236504;49554.25668614901;7164.319389657974;7710.498817576839;7756.767296981099;7776;7846.254605812667;9225.49259790718;11746.647600571996;11799.292042477478;11972.102092342935;12188;10149.441780702133;10525.157987361146;10542.420166890895;10572.84140737874;10777.08394786452;10142.340747851365;10232.64185753495;10293.897061029294;10339;10437.843432348369;10306.845397318897;10819.188560858125;10821.188410869374;10829.891701082888;10830.729231769268;7517.887231691419;7572.924270757442;7875.763727088197;8014.479058861155;8109;10503.369797812156;10715.732106697395;10867.456627168767;10894.509747061244;10901.182411319025 14:37:34 INFO - PROCESS | 4394 | |3;mootools.html;1246.5450110709594;1390.374331550802;1425.451201287504;1545.5363390982702;1781.6525777473398;6528.086067950485;7124.46566507512;7196;7257.6371181440845;7599.392048636109;7241.23966983467;7403;7411.184769675331;7424.777256682295;7434.925650743491;2163.1131236193205;2186.147402513021;2186.1911092895652;2192.6601376786625;2194.8024677779;2081.4900349414415;2122.4057263966115;2144.6032483990434;2153.9752632525374;2156.8598041127275;2061.237342183394;2075.2529089527834;2083.260442542898;2087.9060442280133;2108.462342102762;2129.339904629562;2137.9786202137934;2138.5722855428976;2139.957200855974;2140.3150991682746;2070.6997485364686;2113.5350222950924;2118.788121187869;2119.9894000530053;2132;7133.714651413938;7285.817854553626;7339.266073392671;7387.889181662279;7402.333789958876;4312.805923733408;4473.7986790594505;4473.843415480443;4478.865634030984;4479.417675702138;2778.2498725344044;2897.492938735734;2929.1651879214533;2933.090741870027;2933.941321173586;820.1798201798201;825.471698113208;828.4283844147579;1606.2530923120687;1690.9323627054903;9969.451680157588;10088.142507886765;10090.798184036279;10090.848637270446;10096.343737657102;3850.4224366345275;3885.572587015426;3951.7036222283446;3980.8805735827973;3985.601439855991;8165.5100693957365;8183.468074575134;8187.79530511742;8195.385346099067;8198.262156405834;4364.41080454141;4370.300751879684;4372.868813935587;4378.277584198571;4380.802863871133;3569.1790888095366;3923.5487918889694;4026.6778657707314;4093.5906409358827;4128.256913755553;3181.5704879840923;3206.246532064963;3301.603807543062;3312.867485300609;3351.6815902489225;921.239977018962;949.4730424614268;953.2040745977048;953.4946478366338;963.7205210488879;857.2841677199608;884.6992022712309;899.6356475627381;908.318760929303;921.5944984206927;5383.16560933056;5477.233187353773;5505.9724701376235;5542.944570554324;5545.112781954868;379.9715021373408;390.74992005116746;392.5701357014065;398.7607435538654;399.09405649176205;3752.3433399155037;3794.29805485986;3858.266929283427;3861.6331448512346;3863;8930.732078037669;9211.815763684823;9280.303977201736;9297.209737172281;9306.86039709405;8918.866217006751;8956.552172391355;9100.362974591848;9159.542022898828;9207.585658645377;7059.858802823915;7078.150621925505;7111.4666400020205;7128.465365097639;7131.643417829087;5239.44985776488;5283.260343551829;5432.0765469871;5449.863753406196;5450.454954504517;8387.077421483755;8483.915160848312;8642.827143457222;8863.290936725176;8879.689210877588;8858.601362938554;8882.467051976902;8939.776505587151;8957.014728380003;8975.057618950177;5733.541316694571;6075.27096748393;6217.782377616762;6300.653464059521;6332.841678958063;6742.190937087385;6891.75878844238;6942.097527321416;6942.166939967236;6953.130858642669;6464.321246269074;6547.738090476328;6582.637954912526;6588.341165883373;6655.534112612071;6219.378062193744;6432.807015789534;6441.677916104082;6550.181227346582;6648.235452922782;6272.341404152498;6306.274778400542;6345.96827015862;6348.428641422294;6358.523110766803;4413.0070734084575;4658.068386322681;4700.51933640902;4716.033213191219;4770.308305295782;4706.929396058993;4713.599344055794;4737.66836321468;4802.567768900815;4818.855434336975 14:37:34 INFO - PROCESS | 4394 | |4;prototype.html;292.15130047212847;297.4319050613328;297.54921294239233;303.37958874102446;306.78678318568575;4797.02584397673;4802.32767412562;4825.611322395411;4836.250381190916;4840.588549973257;4714.175019371605;4715.693479923802;4767.189577771778;4767.6424268179935;4785.162596545608;3530.258645684403;3637.5271214742047;3680.595134535199;3774.226283611853;3789.2800367930145;3735.234276973214;3750.8124593770203;3758.2671379080953;3766.623337666239;3770.2656777882207;3535.4343305071193;3726.347889119407;3730.5896351401325;3732.1789206374688;3735.8318875650525;3633.927321453569;3710.07248187953;3726.5341832270965;3729.776213427203;3774.716896232766;3327.5674162358982;3329.1344250494803;3332.800031998064;3339.96660033399;3346.6151392589923;4529.935465165717;4552.544745525454;4560.179167749804;4567.451905771329;4577;3994.201159768029;4237.724547904407;4263.891388239049;4286.8499602514075;4289.233444428358;4913.8771530711665;4931.347998420533;4945.604351651895;4962.206047032493;5028.536017351508;3519.4017017107153;3553.662402071799;3560.305740380627;3586.0855481852223;3593.8679316015373;5063.468335824759;5189.870253243661;5194.428612852621;5294.68231906083;5330.067238233332;3578.141246100917;3587.3901436755814;3601.603823579404;3602.8018458984484;3620.818959052037;3642.4354225095153;3642.490051392754;3647.124690074363;3655.4334078217917;3665.083729067733;4146.688998325138;4160.313548264563;4204.726692764961;4214.852480163179;4217.578242175758;4724.314974328703;4989.126902791997;4989.875253118701;4992.226204938241;4996.625253106032;1264.740728150727;1265.816456613786;1267.9476034891018;1269.5175833183332;1273.5096987659817;786.6106277392727;799.8080460689392;808.4058217210346;817.0767033252387;821.7000794710008;4294.957050429518;4306.784660766949;4464.486584042812;4494.213512635276;4520.95479045212;5158.716270605153;5164.8192313268855;5172.586193104543;5183.922241166386;5188.792448302026;4326.740395576276;4404.977975110104;4419.734815911055;4432.224360736858;4435.911281774346;2737.466194092133;2737.8767955442054;2738.931526711848;2750.5324094903913;2757.8621068946472;4860.902781944341;4865.829695960624;4866.321119213865;4885.169521181408;4889.902201955941;5082.966813274646;5234.26720259164;5244.905505751549;5259.053370393366;5268.341457317835;4768.7601223681395;4820.108279968217;4832.178529650038;4864.805407783649;4892.094962431962;5082.364704411949;5102.617303702163;5102.948970510248;5131.461196574455;5181.430042695225;4775.6418268629295;5012.949870501248;5034.370703662043;5050.873728156826;5051.206821578434;4825.179719447632;4855.8057677692495;4862.440819305683;4868.196747536758;4870.196417591058;3616.7287453441622;3623.655752703489;3623.818809059589;3624.728145389159;3663.780173189617;5053.7220452875445;5095.464976177448;5134.666246693953;5312.1766126250495;5314.707691077027;4996.800127994839;5006.874828129326;5016.197408414636;5019.974900125476;5030.8239211627415;4973.085362135532;4986.15235409974;4987.775550100327;4997.900041999213;5008.899822003613;4730.5269473053795;4912.533309335608;4915.43472500667;4951.876203094807;4966.652334336562;4808.7595620219545;4906.190478570996;5028.270900719448;5043.957197335085;5058.570021548209;4859.1496488113735;4911.336969509213;4938.48145944685;4940.135476291706;4956.752162391938 14:37:34 INFO - PROCESS | 4394 | |5;yui.html;591.4676790888201;668.5253470036271;668.8428219368444;749.5465243527666;772.7990722412173;12200.145989780707;12997.220166789988;13155.605331840035;13191;13252.734945301101;12413.193142445734;12584.370781460937;12802.935985320084;12853.164544304636;12861.871381286208;782.647808486182;806.9515829050247;808.0263282744309;813.4996976859248;813.5322189740923;616.7594638091148;752.1125072414549;790.9644066017014;817.8159914019328;820.8153165537766;825.2407784837964;825.5129473610568;826.5454000299841;826.7354446577098;827.0406328658727;819.3240576524362;819.5902048975512;820.5240960243075;820.6553247636007;826.6362800367849;475.3653872080776;569.4618585436764;618.1438707390251;618.8545691762432;621.201755743867;13049.608511744567;13071.607851764462;13073.803892941614;13082.803757943639;13090.738185236338;11894.226875253167;12085.15403921726;12509.499620015189;12543.372831358396;12968.35158242084;11171.273867198606;11191.944040279746;11309.982101610894;11354.148438867036;11512.194146409754;4028.4561584186345;4037.899052523681;4040.6969477289026;4055.1889622075705;4162.979185104085;55366.72316638431;55664.72167639176;55851.720741396035;55865;56036.719816400655;9966.451845148586;9973.351732137533;10068.152733549608;10273.486325683685;10282.28024038325;18611.25554977813;18642.347517837083;18653.626927461646;18711.532211694543;18718.90640546816;6185.567010309235;6316.8420789479715;6321.810345689545;6379.234491861006;6386.9680651596445;3770.3401904666575;3784.016155799512;3809.4857194278416;3927;3963.623455771697;2860.8569571521757;2990.2673844907704;2991.341904780945;2992.1621945855195;2992.8054676445963;461.6768262216462;461.72758072737247;472.8274179924303;489.05368112702035;489.05856226764047;516.9508896654812;565.045073825234;585.6632436349116;612.3386742318286;613.671685648185;8199.385046121564;8356.28971537414;8451.112633173429;8461.661533538589;8499.490030598185;466.3098614051223;562.1371195215324;580.9550382653038;602.9457348838625;610.3499772742016;3836.290286297044;3851.8844434667003;3926.6523507466422;3938.3107956107565;4023.1953609277675;82027.58986205031;84779.5761021191;87190.1280987182;88051;88285.11714882897;73591.63204183945;74355.25644743591;74442;74766.96109285152;75942.6202868982;64614.676926615066;66683.66658166678;67123.66438167778;67370;67725.64548708998;7589.734359297398;7602.1257555381835;7654.272844079804;7657.46397752152;7827.726029588937;42166.15667686691;42240.577594223665;42537.36193957031;42838;42912.57087429086;55219;58641;59180;59267.40732592791;60529.697351514726;9558.330916836034;9687.32188746781;9753.122219000325;9774.560144793359;9965.950170249102;10500.00249976251;10612.681619551426;10652;10727.195460340661;11026.503807328529;9350.719478415658;9724.270679699192;9890.554925028247;10495.527701253615;10667.359958402521;9861;10098.091171794575;10110.69667909964;10432.739181520523;10453.216008799218;9232.723018309462;9301.209397201314;9332.253419726541;10166.085052345325;10309.917458666732;7901.288884000468;8037.196280371916;8268.2558569729;8422.452540584842;8435.814027292865;8074.959625202071;8139.267465928095;8519.318454523747;8775.517346546001;8926.910730892609 14:37:34 INFO - PROCESS | 4394 | __end_tp_report 14:37:34 INFO - PROCESS | 4394 | __start_cc_report 14:37:34 INFO - PROCESS | 4394 | _x_x_mozilla_cycle_collect,942 14:37:34 INFO - PROCESS | 4394 | __end_cc_report 14:37:34 INFO - PROCESS | 4394 | __startTimestamp1464989854041__endTimestamp 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | ------- Summary: start ------- 14:37:34 INFO - PROCESS | 4394 | Number of tests: 6 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | [#0] dojo.html Cycles:165 Average:4679.27 Median:4802.33 stddev:484.88 (10.1%) stddev-sans-first:459.70 14:37:34 INFO - PROCESS | 4394 | Values: 2657.4 2672.0 2703.3 2703.7 2714.2 4543.3 4601.1 4619.6 4700.6 4728.9 4655.5 4711.9 4736.4 4747.1 4748.1 4147.0 4303.4 4400.9 4431.1 4480.3 4409.9 4448.6 4461.9 4463.0 4481.0 4260.2 4310.4 4349.0 4389.4 4401.2 4306.9 4310.2 4317.9 4369.3 4415.8 4331.2 4345.2 4365.8 4403.9 4405.4 4526.1 4569.6 4574.8 4605.1 4611.5 5118.9 5128.8 5139.5 5140.5 5146.9 5103.7 5154.9 5158.0 5158.7 5167.1 4629.3 4657.4 4712.0 4716.9 4730.0 5142.3 5201.6 5204.1 5206.4 5213.8 4868.6 4987.5 4991.6 4998.2 5007.7 5030.8 5040.6 5052.4 5086.6 5114.9 5011.1 5012.0 5028.3 5031.8 5071.8 4987.4 4987.7 4996.2 5002.7 5049.0 4209.6 4251.3 4253.5 4293.1 4302.3 3788.3 3816.9 3829.5 3831.5 3834.7 4308.2 4361.1 4369.3 4373.6 4384.9 5110.9 5113.2 5117.8 5118.4 5176.4 4188.1 4361.6 4371.2 4379.2 4416.1 4507.5 4525.2 4546.7 4553.7 4561.3 4785.6 4802.3 4802.9 4809.2 4855.5 4970.8 5032.2 5063.2 5117.8 5157.1 4755.8 4786.8 4801.8 4802.0 4848.2 4978.0 4978.2 4983.3 5011.4 5030.9 4868.5 5034.7 5070.0 5073.6 5130.6 4949.8 4964.7 4968.8 4970.2 4994.5 4952.5 4955.7 4956.5 4963.3 5002.5 4694.1 4795.5 4817.1 4837.4 4907.6 4940.5 4946.4 4951.6 4980.5 4982.8 4805.4 4811.9 4813.3 4820.0 4864.1 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | [#1] ext.html Cycles:180 Average:45833.07 Median:36724.86 stddev:83371.60 (227.0%) stddev-sans-first:83536.18 14:37:34 INFO - PROCESS | 4394 | Values: 558.7 593.0 596.3 597.8 612.1 28371.0 28908.3 31328.2 41438.2 42491.0 42741.8 43222.0 43265.4 43270.8 43344.8 7770.3 7929.2 7933.8 7936.9 7940.1 7738.0 7850.1 7867.1 7868.8 7873.4 7875.1 7910.8 7912.5 7914.7 7923.1 7856.5 7903.7 7908.7 7912.9 7916.4 7733.2 7802.3 7804.3 7813.5 7815.3 38783.4 39064.0 39113.8 39138.2 39372.0 3034.9 3187.2 3431.2 3441.5 3851.0 29955.3 30402.2 30415.8 30459.5 30778.8 3237.5 3274.3 3279.2 3409.7 3455.9 249144.0 249963.0 250286.0 250673.0 252373.0 34216.8 35483.8 55490.4 55537.2 55802.4 33317.5 33527.7 33547.2 33566.7 33664.5 12564.1 12761.4 12766.6 12771.9 12772.5 10168.8 10201.3 10230.6 10231.0 10232.5 8063.7 8069.2 8090.3 8159.6 8166.0 3121.7 3130.1 3131.5 3143.1 3165.4 894.2 902.4 935.6 936.2 1052.0 28688.4 28886.0 29099.0 29281.7 29316.7 860.8 1002.4 1018.8 1022.6 1046.0 14792.2 15003.7 15162.9 15230.7 15274.0 383973.0 385834.0 388255.0 388821.0 388857.0 49594.5 50264.2 50339.2 50384.5 50433.7 1081.8 1086.5 1199.1 1204.3 1213.5 29101.4 29791.6 29853.4 30210.5 30346.2 37876.6 38150.4 38174.2 38191.0 38256.0 294260.0 296213.0 296233.0 296424.0 296538.0 25314.2 26630.1 26652.0 26664.7 26670.2 42828.4 43142.0 43508.6 44383.8 44457.6 36862.4 37901.0 37902.2 37928.0 38086.0 35919.0 36587.3 37009.6 37316.6 37791.6 37108.0 37344.0 37561.6 37788.8 37908.4 33002.5 33896.8 34123.7 34277.3 34477.5 25401.2 25906.6 25999.2 26058.0 26305.3 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | [#2] jquery.html Cycles:180 Average:23533.27 Median:383.18 stddev:57147.83 (14914.2%) stddev-sans-first:57281.70 14:37:34 INFO - PROCESS | 4394 | Values: 378.6 380.6 380.7 385.6 391.8 15855.8 16044.3 16786.9 16804.3 16824.3 9787.3 10452.6 10507.9 10525.6 10528.2 4583.9 4720.6 4757.9 4767.3 4787.5 4585.0 4662.0 4709.8 4738.9 4745.7 4720.7 4720.7 4724.0 4727.6 6308.2 6692.4 6744.2 6823.7 6863.0 6867.4 6137.3 6491.2 6492.3 6496.8 6594.5 22395.7 22713.4 23312.3 23325.2 23347.5 2076.9 2077.0 2110.7 2132.2 2184.5 13801.1 13954.0 14304.4 14525.1 14674.8 1713.3 1748.7 1754.2 1763.8 1774.4 41281.1 42859.4 65876.3 80164.2 81562.0 16204.9 16511.7 16828.8 16846.7 17445.5 23143.4 24262.3 29894.7 29946.7 29949.4 8145.7 8577.5 8802.9 8824.0 8898.1 7021.6 7090.6 7150.4 7211.1 7278.2 8333.8 8510.7 8569.9 8615.8 8716.4 3130.5 3183.6 3262.6 3367.7 3412.5 765.6 858.7 896.4 902.2 928.0 16111.1 16587.3 16592.7 16620.8 17051.0 860.9 862.6 867.3 898.9 905.0 9370.7 9528.4 9550.9 9583.8 9753.0 343996.0 344108.0 345632.0 346306.0 347810.0 75727.0 77734.6 77744.0 78065.6 78753.0 930.2 944.4 950.9 956.6 969.2 13864.4 14995.4 15057.5 15087.3 15407.1 26287.0 33063.5 34370.3 35558.5 36212.8 44667.6 46368.3 49114.3 49411.8 49554.3 7164.3 7710.5 7756.8 7776.0 7846.3 9225.5 11746.6 11799.3 11972.1 12188.0 10149.4 10525.2 10542.4 10572.8 10777.1 10142.3 10232.6 10293.9 10339.0 10437.8 10306.8 10819.2 10821.2 10829.9 10830.7 7517.9 7572.9 7875.8 8014.5 8109.0 10503.4 10715.7 10867.5 10894.5 10901.2 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | [#3] mootools.html Cycles:180 Average:4941.31 Median:5450.16 stddev:2724.21 (50.0%) stddev-sans-first:2717.70 14:37:34 INFO - PROCESS | 4394 | Values: 1246.5 1390.4 1425.5 1545.5 1781.7 6528.1 7124.5 7196.0 7257.6 7599.4 7241.2 7403.0 7411.2 7424.8 7434.9 2163.1 2186.1 2186.2 2192.7 2194.8 2081.5 2122.4 2144.6 2154.0 2156.9 2061.2 2075.3 2083.3 2087.9 2108.5 2129.3 2138.0 2138.6 2140.0 2140.3 2070.7 2113.5 2118.8 2120.0 2132.0 7133.7 7285.8 7339.3 7387.9 7402.3 4312.8 4473.8 4473.8 4478.9 4479.4 2778.2 2897.5 2929.2 2933.1 2933.9 820.2 825.5 828.4 1606.3 1690.9 9969.5 10088.1 10090.8 10090.8 10096.3 3850.4 3885.6 3951.7 3980.9 3985.6 8165.5 8183.5 8187.8 8195.4 8198.3 4364.4 4370.3 4372.9 4378.3 4380.8 3569.2 3923.5 4026.7 4093.6 4128.3 3181.6 3206.2 3301.6 3312.9 3351.7 921.2 949.5 953.2 953.5 963.7 857.3 884.7 899.6 908.3 921.6 5383.2 5477.2 5506.0 5542.9 5545.1 380.0 390.7 392.6 398.8 399.1 3752.3 3794.3 3858.3 3861.6 3863.0 8930.7 9211.8 9280.3 9297.2 9306.9 8918.9 8956.6 9100.4 9159.5 9207.6 7059.9 7078.2 7111.5 7128.5 7131.6 5239.4 5283.3 5432.1 5449.9 5450.5 8387.1 8483.9 8642.8 8863.3 8879.7 8858.6 8882.5 8939.8 8957.0 8975.1 5733.5 6075.3 6217.8 6300.7 6332.8 6742.2 6891.8 6942.1 6942.2 6953.1 6464.3 6547.7 6582.6 6588.3 6655.5 6219.4 6432.8 6441.7 6550.2 6648.2 6272.3 6306.3 6346.0 6348.4 6358.5 4413.0 4658.1 4700.5 4716.0 4770.3 4706.9 4713.6 4737.7 4802.6 4818.9 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | [#4] prototype.html Cycles:180 Average:4145.48 Median:4768.20 stddev:1207.35 (25.3%) stddev-sans-first:1175.58 14:37:34 INFO - PROCESS | 4394 | Values: 292.2 297.4 297.5 303.4 306.8 4797.0 4802.3 4825.6 4836.3 4840.6 4714.2 4715.7 4767.2 4767.6 4785.2 3530.3 3637.5 3680.6 3774.2 3789.3 3735.2 3750.8 3758.3 3766.6 3770.3 3535.4 3726.3 3730.6 3732.2 3735.8 3633.9 3710.1 3726.5 3729.8 3774.7 3327.6 3329.1 3332.8 3340.0 3346.6 4529.9 4552.5 4560.2 4567.5 4577.0 3994.2 4237.7 4263.9 4286.8 4289.2 4913.9 4931.3 4945.6 4962.2 5028.5 3519.4 3553.7 3560.3 3586.1 3593.9 5063.5 5189.9 5194.4 5294.7 5330.1 3578.1 3587.4 3601.6 3602.8 3620.8 3642.4 3642.5 3647.1 3655.4 3665.1 4146.7 4160.3 4204.7 4214.9 4217.6 4724.3 4989.1 4989.9 4992.2 4996.6 1264.7 1265.8 1267.9 1269.5 1273.5 786.6 799.8 808.4 817.1 821.7 4295.0 4306.8 4464.5 4494.2 4521.0 5158.7 5164.8 5172.6 5183.9 5188.8 4326.7 4405.0 4419.7 4432.2 4435.9 2737.5 2737.9 2738.9 2750.5 2757.9 4860.9 4865.8 4866.3 4885.2 4889.9 5083.0 5234.3 5244.9 5259.1 5268.3 4768.8 4820.1 4832.2 4864.8 4892.1 5082.4 5102.6 5102.9 5131.5 5181.4 4775.6 5012.9 5034.4 5050.9 5051.2 4825.2 4855.8 4862.4 4868.2 4870.2 3616.7 3623.7 3623.8 3624.7 3663.8 5053.7 5095.5 5134.7 5312.2 5314.7 4996.8 5006.9 5016.2 5020.0 5030.8 4973.1 4986.2 4987.8 4997.9 5008.9 4730.5 4912.5 4915.4 4951.9 4966.7 4808.8 4906.2 5028.3 5044.0 5058.6 4859.1 4911.3 4938.5 4940.1 4956.8 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - PROCESS | 4394 | [#5] yui.html Cycles:180 Average:16271.96 Median:29616.23 stddev:22647.30 (76.5%) stddev-sans-first:22680.23 14:37:34 INFO - PROCESS | 4394 | Values: 591.5 668.5 668.8 749.5 772.8 12200.1 12997.2 13155.6 13191.0 13252.7 12413.2 12584.4 12802.9 12853.2 12861.9 782.6 807.0 808.0 813.5 813.5 616.8 752.1 791.0 817.8 820.8 825.2 825.5 826.5 826.7 827.0 819.3 819.6 820.5 820.7 826.6 475.4 569.5 618.1 618.9 621.2 13049.6 13071.6 13073.8 13082.8 13090.7 11894.2 12085.2 12509.5 12543.4 12968.4 11171.3 11191.9 11310.0 11354.1 11512.2 4028.5 4037.9 4040.7 4055.2 4163.0 55366.7 55664.7 55851.7 55865.0 56036.7 9966.5 9973.4 10068.2 10273.5 10282.3 18611.3 18642.3 18653.6 18711.5 18718.9 6185.6 6316.8 6321.8 6379.2 6387.0 3770.3 3784.0 3809.5 3927.0 3963.6 2860.9 2990.3 2991.3 2992.2 2992.8 461.7 461.7 472.8 489.1 489.1 517.0 565.0 585.7 612.3 613.7 8199.4 8356.3 8451.1 8461.7 8499.5 466.3 562.1 581.0 602.9 610.3 3836.3 3851.9 3926.7 3938.3 4023.2 82027.6 84779.6 87190.1 88051.0 88285.1 73591.6 74355.3 74442.0 74767.0 75942.6 64614.7 66683.7 67123.7 67370.0 67725.6 7589.7 7602.1 7654.3 7657.5 7827.7 42166.2 42240.6 42537.4 42838.0 42912.6 55219.0 58641.0 59180.0 59267.4 60529.7 9558.3 9687.3 9753.1 9774.6 9966.0 10500.0 10612.7 10652.0 10727.2 11026.5 9350.7 9724.3 9890.6 10495.5 10667.4 9861.0 10098.1 10110.7 10432.7 10453.2 9232.7 9301.2 9332.3 10166.1 10309.9 7901.3 8037.2 8268.3 8422.5 8435.8 8075.0 8139.3 8519.3 8775.5 8926.9 14:37:34 INFO - PROCESS | 4394 | -------- Summary: end -------- 14:37:34 INFO - PROCESS | 4394 | 14:37:34 INFO - TEST-INFO | 4394: exit 0 14:37:34 INFO - TEST-OK | dromaeo_css | took 1118395ms 14:37:34 INFO - TEST-START | kraken 14:37:34 INFO - operating with platform_type : linux_ 14:37:34 INFO - Initialising browser for kraken test... 14:37:34 INFO - TEST-INFO | started process 4572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN_Hm_4/profile http://localhost:56749/getInfo.html) 14:37:38 INFO - PROCESS | 4572 | __metrics Screen width/height:1600/1200 14:37:38 INFO - PROCESS | 4572 | colorDepth:24 14:37:38 INFO - PROCESS | 4572 | Browser inner width/height: 1024/697 14:37:38 INFO - PROCESS | 4572 | __metrics 14:37:39 ERROR - PROCESS | 4572 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:37:40 INFO - TEST-INFO | 4572: exit 0 14:37:40 INFO - Browser initialized. 14:37:40 INFO - Running cycle 1/1 for kraken test... 14:37:40 INFO - TEST-INFO | started process 4653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN_Hm_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:52 INFO - PROCESS | 4653 | RSS: Main: 157753344 14:37:52 INFO - PROCESS | 4653 | 14:37:55 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:56 INFO - PROCESS | 4653 | RSS: Main: 214327296 14:37:56 INFO - PROCESS | 4653 | 14:37:59 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-dft) 14:37:59 INFO - PROCESS | 4653 | RSS: Main: 201441280 14:37:59 INFO - PROCESS | 4653 | 14:38:02 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-fft) 14:38:03 INFO - PROCESS | 4653 | RSS: Main: 270282752 14:38:03 INFO - PROCESS | 4653 | 14:38:05 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56749/tests/kraken/driver.html?testName=audio-oscillator) 14:38:06 INFO - PROCESS | 4653 | RSS: Main: 179982336 14:38:06 INFO - PROCESS | 4653 | 14:38:08 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56749/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:38:09 INFO - PROCESS | 4653 | RSS: Main: 183902208 14:38:09 INFO - PROCESS | 4653 | 14:38:12 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56749/tests/kraken/driver.html?testName=imaging-darkroom) 14:38:12 INFO - PROCESS | 4653 | RSS: Main: 220241920 14:38:12 INFO - PROCESS | 4653 | 14:38:16 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56749/tests/kraken/driver.html?testName=imaging-desaturate) 14:38:17 INFO - PROCESS | 4653 | RSS: Main: 216686592 14:38:17 INFO - PROCESS | 4653 | 14:38:19 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56749/tests/kraken/driver.html?testName=json-parse-financial) 14:38:20 INFO - PROCESS | 4653 | RSS: Main: 219099136 14:38:20 INFO - PROCESS | 4653 | 14:38:22 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56749/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:22 INFO - PROCESS | 4653 | RSS: Main: 208113664 14:38:22 INFO - PROCESS | 4653 | 14:38:24 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:25 INFO - PROCESS | 4653 | RSS: Main: 210767872 14:38:25 INFO - PROCESS | 4653 | 14:38:27 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:28 INFO - PROCESS | 4653 | RSS: Main: 217530368 14:38:28 INFO - PROCESS | 4653 | 14:38:31 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:31 INFO - PROCESS | 4653 | RSS: Main: 224546816 14:38:31 INFO - PROCESS | 4653 | 14:38:34 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:35 INFO - PROCESS | 4653 | RSS: Main: 224509952 14:38:35 INFO - PROCESS | 4653 | 14:38:36 INFO - PROCESS | 4653 | Cycle 1(1): loaded http://localhost:56749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56749/tests/kraken/driver.html?testName=ai-astar) 14:38:37 INFO - PROCESS | 4653 | RSS: Main: 266461184 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | __start_tp_report 14:38:37 INFO - PROCESS | 4653 | _x_x_mozilla_page_load 14:38:37 INFO - PROCESS | 4653 | _x_x_mozilla_page_load_details 14:38:37 INFO - PROCESS | 4653 | |i|pagename|runs| 14:38:37 INFO - PROCESS | 4653 | |0;ai-astar;112;109;112;113;111;112;113;112;111;112 14:38:37 INFO - PROCESS | 4653 | |1;audio-beat-detection;158;131;136;174;132;150;151;131;185;139 14:38:37 INFO - PROCESS | 4653 | |2;audio-dft;162;161;162;161;161;161;161;161;161;171 14:38:37 INFO - PROCESS | 4653 | |3;audio-fft;76;75;75;126;76;77;76;86;106;75 14:38:37 INFO - PROCESS | 4653 | |4;audio-oscillator;87;88;116;86;86;87;124;87;87;123 14:38:37 INFO - PROCESS | 4653 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;116;116 14:38:37 INFO - PROCESS | 4653 | |6;imaging-darkroom;146;148;146;146;146;146;147;146;147;146 14:38:37 INFO - PROCESS | 4653 | |7;imaging-desaturate;94;94;95;95;94;95;95;95;95;94 14:38:37 INFO - PROCESS | 4653 | |8;json-parse-financial;64;64;65;63;66;64;65;65;64;64 14:38:37 INFO - PROCESS | 4653 | |9;json-stringify-tinderbox;65;67;65;66;65;65;66;65;64;66 14:38:37 INFO - PROCESS | 4653 | |10;stanford-crypto-aes;89;82;83;82;88;84;85;90;137;90 14:38:37 INFO - PROCESS | 4653 | |11;stanford-crypto-ccm;132;146;131;132;132;141;130;131;153;140 14:38:37 INFO - PROCESS | 4653 | |12;stanford-crypto-pbkdf2;172;169;168;170;169;166;165;166;165;169 14:38:37 INFO - PROCESS | 4653 | |13;stanford-crypto-sha256-iterative;66;67;67;67;68;67;68;70;68;65 14:38:37 INFO - PROCESS | 4653 | __end_tp_report 14:38:37 INFO - PROCESS | 4653 | __start_cc_report 14:38:37 INFO - PROCESS | 4653 | _x_x_mozilla_cycle_collect,1877 14:38:37 INFO - PROCESS | 4653 | __end_cc_report 14:38:37 INFO - PROCESS | 4653 | __startTimestamp1464989917164__endTimestamp 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | ------- Summary: start ------- 14:38:37 INFO - PROCESS | 4653 | Number of tests: 14 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 14:38:37 INFO - PROCESS | 4653 | Values: 112.0 109.0 112.0 113.0 111.0 112.0 113.0 112.0 111.0 112.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#1] audio-beat-detection Cycles:10 Average:148.70 Median:150.50 stddev:18.89 (12.6%) stddev-sans-first:19.74 14:38:37 INFO - PROCESS | 4653 | Values: 158.0 131.0 136.0 174.0 132.0 150.0 151.0 131.0 185.0 139.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.00 stddev:3.12 (1.9%) stddev-sans-first:3.31 14:38:37 INFO - PROCESS | 4653 | Values: 162.0 161.0 162.0 161.0 161.0 161.0 161.0 161.0 161.0 171.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#3] audio-fft Cycles:10 Average:84.80 Median:76.00 stddev:17.42 (22.9%) stddev-sans-first:18.18 14:38:37 INFO - PROCESS | 4653 | Values: 76.0 75.0 75.0 126.0 76.0 77.0 76.0 86.0 106.0 75.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:87.00 stddev:16.63 (19.1%) stddev-sans-first:17.23 14:38:37 INFO - PROCESS | 4653 | Values: 87.0 88.0 116.0 86.0 86.0 87.0 124.0 87.0 87.0 123.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:38:37 INFO - PROCESS | 4653 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:38:37 INFO - PROCESS | 4653 | Values: 146.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:38:37 INFO - PROCESS | 4653 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 94.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 14:38:37 INFO - PROCESS | 4653 | Values: 64.0 64.0 65.0 63.0 66.0 64.0 65.0 65.0 64.0 64.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 14:38:37 INFO - PROCESS | 4653 | Values: 65.0 67.0 65.0 66.0 65.0 65.0 66.0 65.0 64.0 66.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:86.50 stddev:16.47 (19.0%) stddev-sans-first:17.46 14:38:37 INFO - PROCESS | 4653 | Values: 89.0 82.0 83.0 82.0 88.0 84.0 85.0 90.0 137.0 90.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:7.87 (5.8%) stddev-sans-first:8.15 14:38:37 INFO - PROCESS | 4653 | Values: 132.0 146.0 131.0 132.0 132.0 141.0 130.0 131.0 153.0 140.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:169.00 stddev:2.33 (1.4%) stddev-sans-first:1.94 14:38:37 INFO - PROCESS | 4653 | Values: 172.0 169.0 168.0 170.0 169.0 166.0 165.0 166.0 165.0 169.0 14:38:37 INFO - PROCESS | 4653 | 14:38:37 INFO - PROCESS | 4653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.34 (2.0%) stddev-sans-first:1.33 14:38:37 INFO - PROCESS | 4653 | Values: 66.0 67.0 67.0 67.0 68.0 67.0 68.0 70.0 68.0 65.0 14:38:37 INFO - PROCESS | 4653 | -------- Summary: end -------- 14:38:37 INFO - PROCESS | 4653 | 14:38:38 INFO - TEST-INFO | 4653: exit 0 14:38:38 INFO - TEST-OK | kraken | took 63464ms 14:38:38 INFO - SUITE-END | took 1181s 14:38:38 INFO - Completed test suite (00:19:41) 14:38:38 INFO - javascript benchmark 14:38:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2657.3622330640646, 2672.0380662961343, 2703.256604433782, 2703.675558932928, 2714.199311203195, 4543.2957891526785, 4601.079784043192, 4619.584237418631, 4700.600448961838, 4728.858134255969, 4655.464621568521, 4711.90576188476, 4736.360591320171, 4747.121782470237, 4748.145333839908, 4147.0461793787445, 4303.3544968254855, 4400.933985990213, 4431.091626216617, 4480.283154695249, 4409.867703968886, 4448.621867141281, 4461.933071003921, 4463.0, 4480.955190448102, 4260.233158031569, 4310.374995625648, 4349.0, 4389.385486031958, 4401.185780630562, 4306.935395969063, 4310.181065597527, 4317.935230971538, 4369.257226271509, 4415.779211039435, 4331.198728235287, 4345.217860785057, 4365.781710914442, 4403.899025243689, 4405.383246345515, 4526.072155208174, 4569.611583015414, 4574.817007319736, 4605.0559635274685, 4611.492735799059, 5118.948810511884, 5128.769205385766, 5139.486051394868, 5140.537351638371, 5146.9485305146845, 5103.693778373309, 5154.92267615986, 5158.045761534128, 5158.690478571298, 5167.147420675584, 4629.259318509056, 4657.394538709946, 4711.976440117777, 4716.905661886812, 4730.0, 5142.331496905378, 5201.6358854880555, 5204.063268611686, 5206.427292997767, 5213.791448342024, 4868.610511159099, 4987.526185012491, 4991.625628077909, 4998.175301075355, 5007.749612519359, 5030.84907452777, 5040.621953353513, 5052.418971818288, 5086.618503612244, 5114.923276150861, 5011.148104822116, 5012.022655582126, 5028.346314979102, 5031.84904452867, 5071.822486212965, 4987.426445958761, 4987.700737955662, 4996.150654388763, 5002.699838009658, 5049.040682270357, 4209.579042095827, 4251.277282861921, 4253.468316460442, 4293.141371725667, 4302.268614335508, 3788.2612890486644, 3816.9427458588143, 3829.463875057494, 3831.540215174197, 3834.7315687902137, 4308.202982448257, 4361.127774445124, 4369.3227549729845, 4373.628241599499, 4384.868453946323, 5110.923336149961, 5113.233015047773, 5117.795288188431, 5118.411382690963, 5176.352955880515, 4188.099558594856, 4361.5856493633055, 4371.213181627338, 4379.233634114017, 4416.11677664462, 4507.504174540798, 4525.208088584551, 4546.65900057497, 4553.681242313006, 4561.315802629632, 4785.63909136722, 4802.327674125555, 4802.879928001688, 4809.158397280392, 4855.514448555116, 4970.826021089245, 5032.220005899091, 5063.1898896176435, 5117.795288188579, 5157.0975079361715, 4755.809767609257, 4786.832460863853, 4801.807927682993, 4801.95198048015, 4848.151573474557, 4978.029284289529, 4978.228374601942, 4983.302337672656, 5011.373578302712, 5030.9245361320345, 4868.537488938545, 5034.748262586929, 5070.036693028313, 5073.644844860972, 5130.589552835839, 4949.777260023236, 4964.726940018334, 4968.826091086795, 4970.155073637418, 4994.500549944976, 4952.47998960104, 4955.65310428281, 4956.454789973028, 4963.305137280856, 5002.52476014778, 4694.131585656664, 4795.520447955177, 4817.084753896748, 4837.419509658864, 4907.631927605373, 4940.481249468754, 4946.35697359341, 4951.603871690329, 4980.5019498049905, 4982.800687972441, 4805.399325084364, 4811.855644330676, 4813.326134341125, 4820.0, 4864.051509955666], "value": 4649.06998482181, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6759679385954, 592.9614575052622, 596.3023262782544, 597.7907732293701, 612.0574315554047, 28371.0, 28908.27729306766, 31328.21679458012, 41438.171236575254, 42491.0, 42741.78629106858, 43222.0, 43265.35101973465, 43270.78364608181, 43344.78327608357, 7770.33952114071, 7929.246721561442, 7933.841323173533, 7936.880946785803, 7940.126586075556, 7737.955376024249, 7850.057993040815, 7867.134615192324, 7868.842623147562, 7873.448858579902, 7875.094364148111, 7910.762677119696, 7912.525248485109, 7914.722984695537, 7923.12845586985, 7856.4893281936775, 7903.683852645887, 7908.6836526539155, 7912.920870791276, 7916.406269529751, 7733.226677332278, 7802.33680137189, 7804.297613214781, 7813.492123011986, 7815.335696465807, 38783.418248726295, 39064.0, 39113.80443097766, 39138.217235655415, 39372.0, 3034.9393012139853, 3187.235063584723, 3431.1936694876686, 3441.5353927219753, 3851.0, 29955.25111872199, 30402.239944001576, 30415.847920760476, 30459.543106853416, 30778.846105769553, 3237.530558069067, 3274.3123943971796, 3279.196596833767, 3409.6590340965954, 3455.9308813823836, 249144.0, 249962.9999999982, 250286.0, 250673.0, 252373.0, 34216.82891585526, 35483.82258088693, 55490.44509554853, 55537.1669424959, 55802.441975580536, 33317.50023749645, 33527.664723352456, 33547.16132096668, 33566.66433335684, 33664.49503257453, 12564.120511564102, 12761.361931903368, 12766.553170639168, 12771.936140319425, 12772.489100436065, 10168.796624067478, 10201.336913100624, 10230.6419275325, 10231.0, 10232.53953572091, 8063.717769878143, 8069.233422824822, 8090.271875531231, 8159.632816523271, 8165.959170204111, 3121.7034381733697, 3130.1079192430047, 3131.5459258407404, 3143.072793525915, 3165.3669266146862, 894.2354287084449, 902.359324879343, 935.6179741836912, 936.2135805923058, 1051.9631812886512, 28688.426231475252, 28886.0, 29099.0, 29281.707182928323, 29316.706832931824, 860.8063185783149, 1002.4336250018716, 1018.8369860822232, 1022.6114076650825, 1045.9906190526026, 14792.186429746467, 15003.721706289794, 15162.940751516731, 15230.695386092217, 15274.0, 383973.0, 385834.0, 388255.0, 388821.0, 388857.0, 49594.50405495971, 50264.24603630949, 50339.24491132636, 50384.49615503798, 50433.747831261346, 1081.8377243413552, 1086.462201210406, 1199.1486044908213, 1204.3135412814786, 1213.4660749270292, 29101.417971640873, 29791.55312670268, 29853.402931941673, 30210.54684179783, 30346.241343966576, 37876.62123378731, 38150.427743583314, 38174.236515270095, 38191.0, 38256.0, 294260.0, 296213.0, 296233.0, 296424.0, 296538.0, 25314.240572782845, 26630.06794762174, 26652.0, 26664.733352666226, 26670.19989400321, 42828.35757463578, 43142.0, 43508.564914351715, 44383.77808111068, 44457.55424457529, 36862.44706329461, 37901.0, 37902.24195516019, 37928.0, 38086.0, 35919.0, 36587.268254634226, 37009.629903701694, 37316.626833731316, 37791.62208377881, 37108.0, 37344.0, 37561.624383756905, 37788.81105594454, 37908.43137352887, 33002.504962426065, 33896.830515847265, 34123.65876341205, 34277.314453710285, 34477.482837757954, 25401.237962861145, 25906.61140082938, 25999.220023399328, 26058.026615513394, 26305.342366440993], "value": 16564.12502896883, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6289436352375, 380.5946666799858, 380.739193652348, 385.61438561438564, 391.843262694922, 15855.76216356754, 16044.278007489662, 16786.916065419686, 16804.32782688691, 16824.32702691891, 9787.265955053364, 10452.581896724141, 10507.947460262707, 10525.578976840936, 10528.210384221195, 4583.931241031387, 4720.575148236658, 4757.881052973668, 4767.332573439721, 4787.54518320759, 4584.954150458503, 4661.953380466202, 4709.764511774398, 4738.928916066262, 4745.691530050535, 4720.669553131283, 4720.693154944935, 4724.031573527436, 4727.64542659302, 6308.179936608234, 6692.431143352821, 6744.156980377453, 6823.727050917957, 6863.039174515572, 6867.416269617113, 6137.2635283765785, 6491.221053473613, 6492.253390860064, 6496.837579060514, 6594.472442204612, 22395.664065039036, 22713.432164196027, 23312.251581131484, 23325.183618573268, 23347.533049339087, 2076.8961551922343, 2077.044559502631, 2110.7045013698093, 2132.2004248406847, 2184.5084855907294, 13801.102928309629, 13954.0, 14304.427822887175, 14525.12849229039, 14674.779878301833, 1713.297548005312, 1748.7464317673994, 1754.1863513814367, 1763.7707098077296, 1774.4144432337428, 41281.12505968188, 42859.35710964338, 65876.3412365875, 80164.19835801626, 81562.0, 16204.918975405284, 16511.669766604602, 16828.83171168297, 16846.747298790528, 17445.47663570095, 23143.421414464774, 24262.272131836075, 29894.701052989192, 29946.700532994826, 29949.401011979637, 8145.714899978472, 8577.485350878842, 8802.86795698065, 8823.970486787946, 8898.11018898105, 7021.5787052777, 7090.6100164491445, 7150.356467917913, 7211.062561866924, 7278.163011253773, 8333.791655208668, 8510.70212542558, 8569.871451928226, 8615.793788869563, 8716.38985271025, 3130.4834702274325, 3183.633882103588, 3262.559554460165, 3367.726784420506, 3412.522246885438, 765.6478020110811, 858.656537385051, 896.4307664632875, 902.1519771414848, 927.9768005799909, 16111.113888736232, 16587.336506539843, 16592.668146637243, 16620.833791661928, 17051.0, 860.9096044915319, 862.5859587398085, 867.3408209760628, 898.851689471243, 905.031616170691, 9370.718878433658, 9528.428294302365, 9550.904490955001, 9583.808323833484, 9753.0, 343996.0, 344108.0, 345632.0, 346306.0, 347810.0, 75727.0, 77734.611326943, 77744.0, 78065.60967195127, 78753.0, 930.1767935377104, 944.4474982135528, 950.9049095090436, 956.5695437053354, 969.2052516936186, 13864.445422183404, 14995.400183992519, 15057.472988445352, 15087.32107055207, 15407.075575465507, 26287.0, 33063.47424865943, 34370.31259374849, 35558.46662300016, 36212.81893590621, 44667.55332446634, 46368.30447543357, 49114.26328605002, 49411.752941236504, 49554.25668614901, 7164.319389657974, 7710.498817576839, 7756.767296981099, 7776.0, 7846.254605812667, 9225.49259790718, 11746.647600571996, 11799.292042477478, 11972.102092342935, 12188.0, 10149.441780702133, 10525.157987361146, 10542.420166890895, 10572.84140737874, 10777.08394786452, 10142.340747851365, 10232.64185753495, 10293.897061029294, 10339.0, 10437.843432348369, 10306.845397318897, 10819.188560858125, 10821.188410869374, 10829.891701082888, 10830.729231769268, 7517.887231691419, 7572.924270757442, 7875.763727088197, 8014.479058861155, 8109.0, 10503.369797812156, 10715.732106697395, 10867.456627168767, 10894.509747061244, 10901.182411319025], "value": 8844.395447483203, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.5450110709594, 1390.374331550802, 1425.451201287504, 1545.5363390982702, 1781.6525777473398, 6528.086067950485, 7124.46566507512, 7196.0, 7257.6371181440845, 7599.392048636109, 7241.23966983467, 7403.0, 7411.184769675331, 7424.777256682295, 7434.925650743491, 2163.1131236193205, 2186.147402513021, 2186.1911092895652, 2192.6601376786625, 2194.8024677779, 2081.4900349414415, 2122.4057263966115, 2144.6032483990434, 2153.9752632525374, 2156.8598041127275, 2061.237342183394, 2075.2529089527834, 2083.260442542898, 2087.9060442280133, 2108.462342102762, 2129.339904629562, 2137.9786202137934, 2138.5722855428976, 2139.957200855974, 2140.3150991682746, 2070.6997485364686, 2113.5350222950924, 2118.788121187869, 2119.9894000530053, 2132.0, 7133.714651413938, 7285.817854553626, 7339.266073392671, 7387.889181662279, 7402.333789958876, 4312.805923733408, 4473.7986790594505, 4473.843415480443, 4478.865634030984, 4479.417675702138, 2778.2498725344044, 2897.492938735734, 2929.1651879214533, 2933.090741870027, 2933.941321173586, 820.1798201798201, 825.471698113208, 828.4283844147579, 1606.2530923120687, 1690.9323627054903, 9969.451680157588, 10088.142507886765, 10090.798184036279, 10090.848637270446, 10096.343737657102, 3850.4224366345275, 3885.572587015426, 3951.7036222283446, 3980.8805735827973, 3985.601439855991, 8165.5100693957365, 8183.468074575134, 8187.79530511742, 8195.385346099067, 8198.262156405834, 4364.41080454141, 4370.300751879684, 4372.868813935587, 4378.277584198571, 4380.802863871133, 3569.1790888095366, 3923.5487918889694, 4026.6778657707314, 4093.5906409358827, 4128.256913755553, 3181.5704879840923, 3206.246532064963, 3301.603807543062, 3312.867485300609, 3351.6815902489225, 921.239977018962, 949.4730424614268, 953.2040745977048, 953.4946478366338, 963.7205210488879, 857.2841677199608, 884.6992022712309, 899.6356475627381, 908.318760929303, 921.5944984206927, 5383.16560933056, 5477.233187353773, 5505.9724701376235, 5542.944570554324, 5545.112781954868, 379.9715021373408, 390.74992005116746, 392.5701357014065, 398.7607435538654, 399.09405649176205, 3752.3433399155037, 3794.29805485986, 3858.266929283427, 3861.6331448512346, 3863.0, 8930.732078037669, 9211.815763684823, 9280.303977201736, 9297.209737172281, 9306.86039709405, 8918.866217006751, 8956.552172391355, 9100.362974591848, 9159.542022898828, 9207.585658645377, 7059.858802823915, 7078.150621925505, 7111.4666400020205, 7128.465365097639, 7131.643417829087, 5239.44985776488, 5283.260343551829, 5432.0765469871, 5449.863753406196, 5450.454954504517, 8387.077421483755, 8483.915160848312, 8642.827143457222, 8863.290936725176, 8879.689210877588, 8858.601362938554, 8882.467051976902, 8939.776505587151, 8957.014728380003, 8975.057618950177, 5733.541316694571, 6075.27096748393, 6217.782377616762, 6300.653464059521, 6332.841678958063, 6742.190937087385, 6891.75878844238, 6942.097527321416, 6942.166939967236, 6953.130858642669, 6464.321246269074, 6547.738090476328, 6582.637954912526, 6588.341165883373, 6655.534112612071, 6219.378062193744, 6432.807015789534, 6441.677916104082, 6550.181227346582, 6648.235452922782, 6272.341404152498, 6306.274778400542, 6345.96827015862, 6348.428641422294, 6358.523110766803, 4413.0070734084575, 4658.068386322681, 4700.51933640902, 4716.033213191219, 4770.308305295782, 4706.929396058993, 4713.599344055794, 4737.66836321468, 4802.567768900815, 4818.855434336975], "value": 3947.3571694084217, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.15130047212847, 297.4319050613328, 297.54921294239233, 303.37958874102446, 306.78678318568575, 4797.02584397673, 4802.32767412562, 4825.611322395411, 4836.250381190916, 4840.588549973257, 4714.175019371605, 4715.693479923802, 4767.189577771778, 4767.6424268179935, 4785.162596545608, 3530.258645684403, 3637.5271214742047, 3680.595134535199, 3774.226283611853, 3789.2800367930145, 3735.234276973214, 3750.8124593770203, 3758.2671379080953, 3766.623337666239, 3770.2656777882207, 3535.4343305071193, 3726.347889119407, 3730.5896351401325, 3732.1789206374688, 3735.8318875650525, 3633.927321453569, 3710.07248187953, 3726.5341832270965, 3729.776213427203, 3774.716896232766, 3327.5674162358982, 3329.1344250494803, 3332.800031998064, 3339.96660033399, 3346.6151392589923, 4529.935465165717, 4552.544745525454, 4560.179167749804, 4567.451905771329, 4577.0, 3994.201159768029, 4237.724547904407, 4263.891388239049, 4286.8499602514075, 4289.233444428358, 4913.8771530711665, 4931.347998420533, 4945.604351651895, 4962.206047032493, 5028.536017351508, 3519.4017017107153, 3553.662402071799, 3560.305740380627, 3586.0855481852223, 3593.8679316015373, 5063.468335824759, 5189.870253243661, 5194.428612852621, 5294.68231906083, 5330.067238233332, 3578.141246100917, 3587.3901436755814, 3601.603823579404, 3602.8018458984484, 3620.818959052037, 3642.4354225095153, 3642.490051392754, 3647.124690074363, 3655.4334078217917, 3665.083729067733, 4146.688998325138, 4160.313548264563, 4204.726692764961, 4214.852480163179, 4217.578242175758, 4724.314974328703, 4989.126902791997, 4989.875253118701, 4992.226204938241, 4996.625253106032, 1264.740728150727, 1265.816456613786, 1267.9476034891018, 1269.5175833183332, 1273.5096987659817, 786.6106277392727, 799.8080460689392, 808.4058217210346, 817.0767033252387, 821.7000794710008, 4294.957050429518, 4306.784660766949, 4464.486584042812, 4494.213512635276, 4520.95479045212, 5158.716270605153, 5164.8192313268855, 5172.586193104543, 5183.922241166386, 5188.792448302026, 4326.740395576276, 4404.977975110104, 4419.734815911055, 4432.224360736858, 4435.911281774346, 2737.466194092133, 2737.8767955442054, 2738.931526711848, 2750.5324094903913, 2757.8621068946472, 4860.902781944341, 4865.829695960624, 4866.321119213865, 4885.169521181408, 4889.902201955941, 5082.966813274646, 5234.26720259164, 5244.905505751549, 5259.053370393366, 5268.341457317835, 4768.7601223681395, 4820.108279968217, 4832.178529650038, 4864.805407783649, 4892.094962431962, 5082.364704411949, 5102.617303702163, 5102.948970510248, 5131.461196574455, 5181.430042695225, 4775.6418268629295, 5012.949870501248, 5034.370703662043, 5050.873728156826, 5051.206821578434, 4825.179719447632, 4855.8057677692495, 4862.440819305683, 4868.196747536758, 4870.196417591058, 3616.7287453441622, 3623.655752703489, 3623.818809059589, 3624.728145389159, 3663.780173189617, 5053.7220452875445, 5095.464976177448, 5134.666246693953, 5312.1766126250495, 5314.707691077027, 4996.800127994839, 5006.874828129326, 5016.197408414636, 5019.974900125476, 5030.8239211627415, 4973.085362135532, 4986.15235409974, 4987.775550100327, 4997.900041999213, 5008.899822003613, 4730.5269473053795, 4912.533309335608, 4915.43472500667, 4951.876203094807, 4966.652334336562, 4808.7595620219545, 4906.190478570996, 5028.270900719448, 5043.957197335085, 5058.570021548209, 4859.1496488113735, 4911.336969509213, 4938.48145944685, 4940.135476291706, 4956.752162391938], "value": 3759.7437991478996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.4676790888201, 668.5253470036271, 668.8428219368444, 749.5465243527666, 772.7990722412173, 12200.145989780707, 12997.220166789988, 13155.605331840035, 13191.0, 13252.734945301101, 12413.193142445734, 12584.370781460937, 12802.935985320084, 12853.164544304636, 12861.871381286208, 782.647808486182, 806.9515829050247, 808.0263282744309, 813.4996976859248, 813.5322189740923, 616.7594638091148, 752.1125072414549, 790.9644066017014, 817.8159914019328, 820.8153165537766, 825.2407784837964, 825.5129473610568, 826.5454000299841, 826.7354446577098, 827.0406328658727, 819.3240576524362, 819.5902048975512, 820.5240960243075, 820.6553247636007, 826.6362800367849, 475.3653872080776, 569.4618585436764, 618.1438707390251, 618.8545691762432, 621.201755743867, 13049.608511744567, 13071.607851764462, 13073.803892941614, 13082.803757943639, 13090.738185236338, 11894.226875253167, 12085.15403921726, 12509.499620015189, 12543.372831358396, 12968.35158242084, 11171.273867198606, 11191.944040279746, 11309.982101610894, 11354.148438867036, 11512.194146409754, 4028.4561584186345, 4037.899052523681, 4040.6969477289026, 4055.1889622075705, 4162.979185104085, 55366.72316638431, 55664.72167639176, 55851.720741396035, 55865.0, 56036.719816400655, 9966.451845148586, 9973.351732137533, 10068.152733549608, 10273.486325683685, 10282.28024038325, 18611.25554977813, 18642.347517837083, 18653.626927461646, 18711.532211694543, 18718.90640546816, 6185.567010309235, 6316.8420789479715, 6321.810345689545, 6379.234491861006, 6386.9680651596445, 3770.3401904666575, 3784.016155799512, 3809.4857194278416, 3927.0, 3963.623455771697, 2860.8569571521757, 2990.2673844907704, 2991.341904780945, 2992.1621945855195, 2992.8054676445963, 461.6768262216462, 461.72758072737247, 472.8274179924303, 489.05368112702035, 489.05856226764047, 516.9508896654812, 565.045073825234, 585.6632436349116, 612.3386742318286, 613.671685648185, 8199.385046121564, 8356.28971537414, 8451.112633173429, 8461.661533538589, 8499.490030598185, 466.3098614051223, 562.1371195215324, 580.9550382653038, 602.9457348838625, 610.3499772742016, 3836.290286297044, 3851.8844434667003, 3926.6523507466422, 3938.3107956107565, 4023.1953609277675, 82027.58986205031, 84779.5761021191, 87190.1280987182, 88051.0, 88285.11714882897, 73591.63204183945, 74355.25644743591, 74442.0, 74766.96109285152, 75942.6202868982, 64614.676926615066, 66683.66658166678, 67123.66438167778, 67370.0, 67725.64548708998, 7589.734359297398, 7602.1257555381835, 7654.272844079804, 7657.46397752152, 7827.726029588937, 42166.15667686691, 42240.577594223665, 42537.36193957031, 42838.0, 42912.57087429086, 55219.0, 58641.0, 59180.0, 59267.40732592791, 60529.697351514726, 9558.330916836034, 9687.32188746781, 9753.122219000325, 9774.560144793359, 9965.950170249102, 10500.00249976251, 10612.681619551426, 10652.0, 10727.195460340661, 11026.503807328529, 9350.719478415658, 9724.270679699192, 9890.554925028247, 10495.527701253615, 10667.359958402521, 9861.0, 10098.091171794575, 10110.69667909964, 10432.739181520523, 10453.216008799218, 9232.723018309462, 9301.209397201314, 9332.253419726541, 10166.085052345325, 10309.917458666732, 7901.288884000468, 8037.196280371916, 8268.2558569729, 8422.452540584842, 8435.814027292865, 8074.959625202071, 8139.267465928095, 8519.318454523747, 8775.517346546001, 8926.910730892609], "value": 6257.972746066748, "unit": "score"}], "name": "dromaeo_css", "value": 6312.363332689315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 112.0, 113.0, 111.0, 112.0, 113.0, 112.0, 111.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 136.0, 174.0, 132.0, 150.0, 151.0, 131.0, 185.0, 139.0], "value": 148.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 171.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 126.0, 76.0, 77.0, 76.0, 86.0, 106.0, 75.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 116.0, 86.0, 86.0, 87.0, 124.0, 87.0, 87.0, 123.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 63.0, 66.0, 64.0, 65.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 64.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 83.0, 82.0, 88.0, 84.0, 85.0, 90.0, 137.0, 90.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 146.0, 131.0, 132.0, 132.0, 141.0, 130.0, 131.0, 153.0, 140.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 168.0, 170.0, 169.0, 166.0, 165.0, 166.0, 165.0, 169.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 70.0, 68.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1554.8000000000002, "alertThreshold": 2.0}]} 14:38:38 INFO - Return code: 0 14:38:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:38:38 ERROR - # TBPL SUCCESS # 14:38:38 INFO - Running post-action listener: _resource_record_post_action 14:38:38 INFO - ##### 14:38:38 INFO - ##### Finished run-tests step (success) 14:38:38 INFO - ##### 14:38:38 INFO - Running post-run listener: _resource_record_post_run 14:38:38 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 385916928; Read time: 0; Write time: 220196 14:38:38 INFO - TinderboxPrint: CPU usage
13.1% 14:38:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:38:38 INFO - TinderboxPrint: I/O write bytes / time
385,916,928 / 220,196 14:38:38 INFO - TinderboxPrint: CPU idle
8,317.4 (86.9%) 14:38:38 INFO - TinderboxPrint: CPU user
1,211.9 (12.7%) 14:38:38 INFO - TinderboxPrint: Swap in / out
0 / 0 14:38:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100171776; Read time: 0; Write time: 45428 14:38:38 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 285745152; Read time: 0; Write time: 174768 14:38:39 INFO - Running post-run listener: _upload_blobber_files 14:38:39 INFO - Blob upload gear active. 14:38:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:39 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 14:38:39 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'] 14:38:39 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 14:38:39 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:40 INFO - (blobuploader) - INFO - Done attempting. 14:38:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:44 INFO - (blobuploader) - INFO - Done attempting. 14:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:45 INFO - (blobuploader) - INFO - Done attempting. 14:38:45 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:45 INFO - Return code: 0 14:38:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a004c35126cedba82fe8e9398092efaa713eac4abb8aa36293d8592c8e3912e3466355683433c3c41460698bc98277d7fa82977c193934b7da522ff86e7ead", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee832ef874f714cc40b61e0ab2e1a98a8bf7a22b7a3ae1c7fd695ea98878176b0ad062827c6d843b737b050326d27d6fd00346a5e5de1875960cc124b9dd661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfafc79d6a77a43c1b9f4a2142a996e1811a90aa3df71b284877be559bb1ee0fe5355c458d6c5f154fabd45b6fc0444c3c34fb79a6fca5a2d7c4ca1779157eee"} 14:38:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:45 INFO - Contents: 14:38:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a004c35126cedba82fe8e9398092efaa713eac4abb8aa36293d8592c8e3912e3466355683433c3c41460698bc98277d7fa82977c193934b7da522ff86e7ead", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee832ef874f714cc40b61e0ab2e1a98a8bf7a22b7a3ae1c7fd695ea98878176b0ad062827c6d843b737b050326d27d6fd00346a5e5de1875960cc124b9dd661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfafc79d6a77a43c1b9f4a2142a996e1811a90aa3df71b284877be559bb1ee0fe5355c458d6c5f154fabd45b6fc0444c3c34fb79a6fca5a2d7c4ca1779157eee"} 14:38:45 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:45 INFO - Copying logs to upload dir... 14:38:45 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.510787 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-03 14:38:44.990045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:38:44.993939) ========= 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=00204705a9daa57ed339a427000001b9-1464988663.800787-265192563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a004c35126cedba82fe8e9398092efaa713eac4abb8aa36293d8592c8e3912e3466355683433c3c41460698bc98277d7fa82977c193934b7da522ff86e7ead", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee832ef874f714cc40b61e0ab2e1a98a8bf7a22b7a3ae1c7fd695ea98878176b0ad062827c6d843b737b050326d27d6fd00346a5e5de1875960cc124b9dd661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfafc79d6a77a43c1b9f4a2142a996e1811a90aa3df71b284877be559bb1ee0fe5355c458d6c5f154fabd45b6fc0444c3c34fb79a6fca5a2d7c4ca1779157eee"} build_url:https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011553 build_url: 'https://queue.taskcluster.net/v1/task/FFT7hOmNQquLtYJDOpk1mg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/30a004c35126cedba82fe8e9398092efaa713eac4abb8aa36293d8592c8e3912e3466355683433c3c41460698bc98277d7fa82977c193934b7da522ff86e7ead", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eee832ef874f714cc40b61e0ab2e1a98a8bf7a22b7a3ae1c7fd695ea98878176b0ad062827c6d843b737b050326d27d6fd00346a5e5de1875960cc124b9dd661", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dfafc79d6a77a43c1b9f4a2142a996e1811a90aa3df71b284877be559bb1ee0fe5355c458d6c5f154fabd45b6fc0444c3c34fb79a6fca5a2d7c4ca1779157eee"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-03 14:38:45.019967) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:38:45.020304) ========= 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=00204705a9daa57ed339a427000001b9-1464988663.800787-265192563 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004403 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-03 14:38:45.103425) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:38:45.103849) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-03 14:38:45.104154) ========= ========= Total master_lag: 0.18 =========