builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1465358905.6 results: success (0) buildid: 20160607203328 builduid: 876e1df49c984e8cb3c6907d5aebb538 revision: 1401fcd673699f8d6e431ccb643ab46e166da2a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:25.600017) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:25.600478) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:25.600773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:25.716670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:25.716923) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 21:08:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2016-06-07 21:08:25 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174590 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:25.922139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:25.922456) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.127700 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:26.061700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:26.062027) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1401fcd673699f8d6e431ccb643ab46e166da2a9 --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 1401fcd673699f8d6e431ccb643ab46e166da2a9 --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=5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 21:08:26,074 truncating revision to first 12 chars 2016-06-07 21:08:26,074 Setting DEBUG logging. 2016-06-07 21:08:26,074 attempt 1/10 2016-06-07 21:08:26,074 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1401fcd67369?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 21:08:26,402 unpacking tar archive at: fx-team-1401fcd67369/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:26.728593) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:26.728917) ========= script_repo_revision: 1401fcd673699f8d6e431ccb643ab46e166da2a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:26.729349) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:26.729713) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 21:08:26.742243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-07 21:08:26.742545) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:08:26 INFO - MultiFileLogger online at 20160607 21:08:26 in /builds/slave/test 21:08:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:08:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:08:26 INFO - {'append_to_log': False, 21:08:26 INFO - 'base_work_dir': '/builds/slave/test', 21:08:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:08:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:08:26 INFO - 'branch': 'Fx-Team-Non-PGO', 21:08:26 INFO - 'buildbot_json_path': 'buildprops.json', 21:08:26 INFO - 'config_files': ('talos/linux_config.py',), 21:08:26 INFO - 'default_actions': ('clobber', 21:08:26 INFO - 'read-buildbot-config', 21:08:26 INFO - 'download-and-extract', 21:08:26 INFO - 'populate-webroot', 21:08:26 INFO - 'create-virtualenv', 21:08:26 INFO - 'install', 21:08:26 INFO - 'run-tests'), 21:08:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:08:26 INFO - 'download_minidump_stackwalk': True, 21:08:26 INFO - 'download_symbols': 'ondemand', 21:08:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:08:26 INFO - 'tooltool.py': '/tools/tooltool.py', 21:08:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:08:26 INFO - '/tools/misc-python/virtualenv.py')}, 21:08:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:08:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:08:26 INFO - 'installer_path': 'installer.exe', 21:08:26 INFO - 'log_level': 'info', 21:08:26 INFO - 'log_name': 'talos', 21:08:26 INFO - 'log_to_console': True, 21:08:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:08:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:08:26 INFO - 'opt_config_files': (), 21:08:26 INFO - 'pip_index': False, 21:08:26 INFO - 'sps_profile': False, 21:08:26 INFO - 'sps_profile_interval': 0, 21:08:26 INFO - 'suite': 'dromaeojs-e10s', 21:08:26 INFO - 'system_bits': '32', 21:08:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:08:26 INFO - 'title': 'talos-linux64-ix-051', 21:08:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:08:26 INFO - 'use_talos_json': True, 21:08:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:08:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:08:26 INFO - 'work_dir': 'build'} 21:08:26 INFO - ##### 21:08:26 INFO - ##### Running clobber step. 21:08:26 INFO - ##### 21:08:26 INFO - Running pre-action listener: _resource_record_pre_action 21:08:26 INFO - Running main action method: clobber 21:08:26 INFO - rmtree: /builds/slave/test/build 21:08:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:08:31 INFO - Running post-action listener: _resource_record_post_action 21:08:31 INFO - ##### 21:08:31 INFO - ##### Finished clobber step (success) 21:08:31 INFO - ##### 21:08:31 INFO - ##### 21:08:31 INFO - ##### Running read-buildbot-config step. 21:08:31 INFO - ##### 21:08:31 INFO - Running pre-action listener: _resource_record_pre_action 21:08:31 INFO - Running main action method: read_buildbot_config 21:08:31 INFO - Using buildbot properties: 21:08:31 INFO - { 21:08:31 INFO - "project": "", 21:08:31 INFO - "product": "firefox", 21:08:31 INFO - "script_repo_revision": "production", 21:08:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:08:31 INFO - "repository": "", 21:08:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 21:08:31 INFO - "buildid": "20160607203328", 21:08:31 INFO - "pgo_build": "False", 21:08:31 INFO - "basedir": "/builds/slave/test", 21:08:31 INFO - "buildnumber": 1356, 21:08:31 INFO - "slavename": "talos-linux64-ix-051", 21:08:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:08:31 INFO - "platform": "ubuntu64_hw", 21:08:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:08:31 INFO - "branch": "fx-team", 21:08:31 INFO - "repo_path": "integration/fx-team", 21:08:31 INFO - "revision": "1401fcd673699f8d6e431ccb643ab46e166da2a9", 21:08:31 INFO - "stage_platform": "linux64", 21:08:31 INFO - "builduid": "876e1df49c984e8cb3c6907d5aebb538", 21:08:31 INFO - "slavebuilddir": "test" 21:08:31 INFO - } 21:08:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:08:31 INFO - Running post-action listener: _resource_record_post_action 21:08:31 INFO - ##### 21:08:31 INFO - ##### Finished read-buildbot-config step (success) 21:08:31 INFO - ##### 21:08:31 INFO - ##### 21:08:31 INFO - ##### Running download-and-extract step. 21:08:31 INFO - ##### 21:08:31 INFO - Running pre-action listener: _resource_record_pre_action 21:08:31 INFO - Running main action method: download_and_extract 21:08:31 INFO - mkdir: /builds/slave/test/build/tests 21:08: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')]} 21:08:31 INFO - https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:08:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:08:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:08:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:08:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:08:36 INFO - Downloaded 1361 bytes. 21:08:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:08:36 INFO - Using the following test package requirements: 21:08:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:08:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:08:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'jsshell-linux-x86_64.zip'], 21:08:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:08:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:08:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:08:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:08:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:08:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:08:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:08:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:36 INFO - https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:08:47 INFO - Downloaded 22873851 bytes. 21:08:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:08:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:08:48 INFO - Return code: 0 21:08:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:08:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:48 INFO - https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:08:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:08:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:08:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:08:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:08:50 INFO - Downloaded 22873851 bytes. 21:08:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:08:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:08:51 INFO - Return code: 0 21:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:51 INFO - https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:08:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:08:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:08:52 INFO - Downloaded 10833369 bytes. 21:08:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:08:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:08:53 INFO - Return code: 0 21:08:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:08:53 INFO - https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:08:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:08:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:08:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:08:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:08:54 INFO - Downloaded 55201860 bytes. 21:08:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:08:54 INFO - mkdir: /builds/slave/test/properties 21:08:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:08:54 INFO - Writing to file /builds/slave/test/properties/build_url 21:08:54 INFO - Contents: 21:08:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:08:55 INFO - Running post-action listener: _resource_record_post_action 21:08:55 INFO - Running post-action listener: set_extra_try_arguments 21:08:55 INFO - ##### 21:08:55 INFO - ##### Finished download-and-extract step (success) 21:08:55 INFO - ##### 21:08:55 INFO - ##### 21:08:55 INFO - ##### Running populate-webroot step. 21:08:55 INFO - ##### 21:08:55 INFO - Running pre-action listener: _resource_record_pre_action 21:08:55 INFO - Running main action method: populate_webroot 21:08:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:08:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:08:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:08:55 INFO - '--tppagecycles', 21:08:55 INFO - '7'], 21:08:55 INFO - 'tests': ['tsvgm']}}, 21:08:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:08:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:08:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:08:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:08:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:08:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['damp', 'tps']}, 21:08:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'tests': ['damp', 'tps']}, 21:08:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['dromaeo_dom']}, 21:08:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:08:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['a11yr', 21:08:55 INFO - 'ts_paint', 21:08:55 INFO - 'tpaint', 21:08:55 INFO - 'sessionrestore', 21:08:55 INFO - 'sessionrestore_no_auto_restore', 21:08:55 INFO - 'tabpaint']}, 21:08:55 INFO - 'other-e10s': {'tests': ['a11yr', 21:08:55 INFO - 'ts_paint', 21:08:55 INFO - 'tpaint', 21:08:55 INFO - 'sessionrestore', 21:08:55 INFO - 'sessionrestore_no_auto_restore', 21:08:55 INFO - 'tabpaint']}, 21:08:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:08:55 INFO - 'ts_paint', 21:08:55 INFO - 'tpaint', 21:08:55 INFO - 'sessionrestore', 21:08:55 INFO - 'sessionrestore_no_auto_restore', 21:08:55 INFO - 'tabpaint']}, 21:08:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:08:55 INFO - 'ts_paint', 21:08:55 INFO - 'tpaint', 21:08:55 INFO - 'sessionrestore', 21:08:55 INFO - 'sessionrestore_no_auto_restore', 21:08:55 INFO - 'tabpaint']}, 21:08:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['a11yr', 21:08:55 INFO - 'ts_paint', 21:08:55 INFO - 'tpaint', 21:08:55 INFO - 'sessionrestore', 21:08:55 INFO - 'sessionrestore_no_auto_restore', 21:08:55 INFO - 'tabpaint']}, 21:08:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['a11yr', 21:08:55 INFO - 'ts_paint', 21:08:55 INFO - 'tpaint', 21:08:55 INFO - 'sessionrestore', 21:08:55 INFO - 'sessionrestore_no_auto_restore', 21:08:55 INFO - 'tabpaint']}, 21:08:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['tsvgx', 21:08:55 INFO - 'tsvgr_opacity', 21:08:55 INFO - 'tart', 21:08:55 INFO - 'tscrollx', 21:08:55 INFO - 'cart']}, 21:08:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:08:55 INFO - 'tsvgr_opacity', 21:08:55 INFO - 'tart', 21:08:55 INFO - 'tscrollx', 21:08:55 INFO - 'cart']}, 21:08:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'talos_options': ['--disable-e10s'], 21:08:55 INFO - 'tests': ['tp5o']}, 21:08:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'tests': ['tp5o']}, 21:08:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'talos_options': ['--disable-e10s', 21:08:55 INFO - '--xperf_path', 21:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:55 INFO - 'tests': ['tp5n']}, 21:08:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:08:55 INFO - 'talos_options': ['--xperf_path', 21:08:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:08:55 INFO - 'tests': ['tp5n']}}, 21:08:55 INFO - 'talos.zip': {'path': '', 21:08:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:08:55 INFO - Running post-action listener: _resource_record_post_action 21:08:55 INFO - ##### 21:08:55 INFO - ##### Finished populate-webroot step (success) 21:08:55 INFO - ##### 21:08:55 INFO - ##### 21:08:55 INFO - ##### Running create-virtualenv step. 21:08:55 INFO - ##### 21:08:55 INFO - Running pre-action listener: _resource_record_pre_action 21:08:55 INFO - Running main action method: create_virtualenv 21:08:55 INFO - Creating virtualenv /builds/slave/test/build/venv 21:08:55 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 21:08:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:08:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:08:55 INFO - Using real prefix '/usr' 21:08:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:08:55 INFO - Installing distribute.............................................................................................................................................................................................done. 21:08:58 INFO - Installing pip.................done. 21:08:58 INFO - Return code: 0 21:08:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:08:58 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')]} 21:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 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')]} 21:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:08:58 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 21:08:58 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 21:08:58 INFO - Using env: {'DISPLAY': ':0', 21:08:58 INFO - 'HOME': '/home/cltbld', 21:08:58 INFO - 'LANG': 'en_US.UTF-8', 21:08:58 INFO - 'LANGUAGE': 'en_US:en', 21:08:58 INFO - 'LOGNAME': 'cltbld', 21:08:58 INFO - 'MAIL': '/var/mail/cltbld', 21:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:58 INFO - 'MOZ_NO_REMOTE': '1', 21:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:58 INFO - 'NO_EM_RESTART': '1', 21:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:58 INFO - 'PWD': '/builds/slave/test', 21:08:58 INFO - 'SHELL': '/bin/bash', 21:08:58 INFO - 'SHLVL': '1', 21:08:58 INFO - 'TERM': 'linux', 21:08:58 INFO - 'TMOUT': '86400', 21:08:58 INFO - 'USER': 'cltbld', 21:08:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:58 INFO - '_': '/tools/buildbot/bin/python'} 21:08:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:58 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 21:08:58 INFO - Cleaning up... 21:08:58 INFO - Return code: 0 21:08:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:08:58 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')]} 21:08:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 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')]} 21:08:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:08:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:08:58 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:08:58 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 21:08:58 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 21:08:58 INFO - Using env: {'DISPLAY': ':0', 21:08:58 INFO - 'HOME': '/home/cltbld', 21:08:58 INFO - 'LANG': 'en_US.UTF-8', 21:08:58 INFO - 'LANGUAGE': 'en_US:en', 21:08:58 INFO - 'LOGNAME': 'cltbld', 21:08:58 INFO - 'MAIL': '/var/mail/cltbld', 21:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:08:58 INFO - 'MOZ_NO_REMOTE': '1', 21:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:08:58 INFO - 'NO_EM_RESTART': '1', 21:08:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:08:58 INFO - 'PWD': '/builds/slave/test', 21:08:58 INFO - 'SHELL': '/bin/bash', 21:08:58 INFO - 'SHLVL': '1', 21:08:58 INFO - 'TERM': 'linux', 21:08:58 INFO - 'TMOUT': '86400', 21:08:58 INFO - 'USER': 'cltbld', 21:08:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:08:58 INFO - '_': '/tools/buildbot/bin/python'} 21:08:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:08:59 INFO - Downloading/unpacking psutil>=3.1.1 21:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:08:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:08:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:08:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:09:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:01 INFO - Installing collected packages: psutil 21:09:01 INFO - Running setup.py install for psutil 21:09:01 INFO - building 'psutil._psutil_linux' extension 21:09:01 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 21:09:02 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 21:09:02 INFO - building 'psutil._psutil_posix' extension 21:09:02 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 21:09:02 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 21:09:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:09:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:09:02 INFO - Successfully installed psutil 21:09:02 INFO - Cleaning up... 21:09:02 INFO - Return code: 0 21:09:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:02 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:02 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 21:09:02 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 21:09:02 INFO - Using env: {'DISPLAY': ':0', 21:09:02 INFO - 'HOME': '/home/cltbld', 21:09:02 INFO - 'LANG': 'en_US.UTF-8', 21:09:02 INFO - 'LANGUAGE': 'en_US:en', 21:09:02 INFO - 'LOGNAME': 'cltbld', 21:09:02 INFO - 'MAIL': '/var/mail/cltbld', 21:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:02 INFO - 'MOZ_NO_REMOTE': '1', 21:09:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:02 INFO - 'NO_EM_RESTART': '1', 21:09:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:02 INFO - 'PWD': '/builds/slave/test', 21:09:02 INFO - 'SHELL': '/bin/bash', 21:09:02 INFO - 'SHLVL': '1', 21:09:02 INFO - 'TERM': 'linux', 21:09:02 INFO - 'TMOUT': '86400', 21:09:02 INFO - 'USER': 'cltbld', 21:09:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:02 INFO - '_': '/tools/buildbot/bin/python'} 21:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:09:03 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 21:09:03 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 21:09:03 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 21:09:03 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 21:09:03 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 21:09:03 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 21:09:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:09:05 INFO - Installing collected packages: mozsystemmonitor 21:09:05 INFO - Running setup.py install for mozsystemmonitor 21:09:05 INFO - Successfully installed mozsystemmonitor 21:09:05 INFO - Cleaning up... 21:09:05 INFO - Return code: 0 21:09:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:09: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')]} 21:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09: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')]} 21:09:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:05 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:05 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 21:09:05 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 21:09:05 INFO - Using env: {'DISPLAY': ':0', 21:09:05 INFO - 'HOME': '/home/cltbld', 21:09:05 INFO - 'LANG': 'en_US.UTF-8', 21:09:05 INFO - 'LANGUAGE': 'en_US:en', 21:09:05 INFO - 'LOGNAME': 'cltbld', 21:09:05 INFO - 'MAIL': '/var/mail/cltbld', 21:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:05 INFO - 'MOZ_NO_REMOTE': '1', 21:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:05 INFO - 'NO_EM_RESTART': '1', 21:09:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:05 INFO - 'PWD': '/builds/slave/test', 21:09:05 INFO - 'SHELL': '/bin/bash', 21:09:05 INFO - 'SHLVL': '1', 21:09:05 INFO - 'TERM': 'linux', 21:09:05 INFO - 'TMOUT': '86400', 21:09:05 INFO - 'USER': 'cltbld', 21:09:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:05 INFO - '_': '/tools/buildbot/bin/python'} 21:09:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:05 INFO - Downloading/unpacking jsonschema==2.5.1 21:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:09:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:07 INFO - Downloading functools32-3.2.3-2.tar.gz 21:09:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:09:07 INFO - warning: no files found matching '*.txt' 21:09:07 INFO - no previously-included directories found matching 'build' 21:09:07 INFO - no previously-included directories found matching 'dist' 21:09:07 INFO - no previously-included directories found matching '.git*' 21:09:07 INFO - Installing collected packages: jsonschema, functools32 21:09:07 INFO - Running setup.py install for functools32 21:09:07 INFO - warning: no files found matching '*.txt' 21:09:07 INFO - no previously-included directories found matching 'build' 21:09:07 INFO - no previously-included directories found matching 'dist' 21:09:07 INFO - no previously-included directories found matching '.git*' 21:09:07 INFO - Successfully installed jsonschema functools32 21:09:07 INFO - Cleaning up... 21:09:07 INFO - Return code: 0 21:09:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:09:07 INFO - Using env: {'DISPLAY': ':0', 21:09:07 INFO - 'HOME': '/home/cltbld', 21:09:07 INFO - 'LANG': 'en_US.UTF-8', 21:09:07 INFO - 'LANGUAGE': 'en_US:en', 21:09:07 INFO - 'LOGNAME': 'cltbld', 21:09:07 INFO - 'MAIL': '/var/mail/cltbld', 21:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:07 INFO - 'MOZ_NO_REMOTE': '1', 21:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:07 INFO - 'NO_EM_RESTART': '1', 21:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:07 INFO - 'PWD': '/builds/slave/test', 21:09:07 INFO - 'SHELL': '/bin/bash', 21:09:07 INFO - 'SHLVL': '1', 21:09:07 INFO - 'TERM': 'linux', 21:09:07 INFO - 'TMOUT': '86400', 21:09:07 INFO - 'USER': 'cltbld', 21:09:07 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:07 INFO - '_': '/tools/buildbot/bin/python'} 21:09:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:08 INFO - Downloading/unpacking blobuploader==1.2.4 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:09:09 INFO - Downloading blobuploader-1.2.4.tar.gz 21:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:09:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:09:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 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 21:09:10 INFO - Downloading docopt-0.6.1.tar.gz 21:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:09:10 INFO - Installing collected packages: blobuploader, requests, docopt 21:09:10 INFO - Running setup.py install for blobuploader 21:09:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:09:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:09:10 INFO - Running setup.py install for requests 21:09:11 INFO - Running setup.py install for docopt 21:09:11 INFO - Successfully installed blobuploader requests docopt 21:09:11 INFO - Cleaning up... 21:09:11 INFO - Return code: 0 21:09:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:11 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:11 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 21:09:11 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 21:09:11 INFO - Using env: {'DISPLAY': ':0', 21:09:11 INFO - 'HOME': '/home/cltbld', 21:09:11 INFO - 'LANG': 'en_US.UTF-8', 21:09:11 INFO - 'LANGUAGE': 'en_US:en', 21:09:11 INFO - 'LOGNAME': 'cltbld', 21:09:11 INFO - 'MAIL': '/var/mail/cltbld', 21:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:11 INFO - 'MOZ_NO_REMOTE': '1', 21:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:11 INFO - 'NO_EM_RESTART': '1', 21:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:11 INFO - 'PWD': '/builds/slave/test', 21:09:11 INFO - 'SHELL': '/bin/bash', 21:09:11 INFO - 'SHLVL': '1', 21:09:11 INFO - 'TERM': 'linux', 21:09:11 INFO - 'TMOUT': '86400', 21:09:11 INFO - 'USER': 'cltbld', 21:09:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:11 INFO - '_': '/tools/buildbot/bin/python'} 21:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:11 INFO - Running setup.py (path:/tmp/pip-9mtfIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:11 INFO - Running setup.py (path:/tmp/pip-BkMPTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:11 INFO - Running setup.py (path:/tmp/pip-R5Nwsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:11 INFO - Running setup.py (path:/tmp/pip-UM4_rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:11 INFO - Running setup.py (path:/tmp/pip-0uoXGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:11 INFO - Running setup.py (path:/tmp/pip-SO2C3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:12 INFO - Running setup.py (path:/tmp/pip-DY3Ms7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:12 INFO - Running setup.py (path:/tmp/pip-uHfmK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:12 INFO - Running setup.py (path:/tmp/pip-HHijeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:12 INFO - Running setup.py (path:/tmp/pip-S2CL9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:12 INFO - Running setup.py (path:/tmp/pip-JZT4r3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:12 INFO - Running setup.py (path:/tmp/pip-VzHyZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:12 INFO - Running setup.py (path:/tmp/pip-6ooXu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:12 INFO - Running setup.py (path:/tmp/pip-rx2ldF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:12 INFO - Running setup.py (path:/tmp/pip-JsPEgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:12 INFO - Running setup.py (path:/tmp/pip-Eh1CbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:12 INFO - Running setup.py (path:/tmp/pip-f_GWaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:09:12 INFO - Running setup.py install for manifestparser 21:09:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:09:12 INFO - Running setup.py install for mozcrash 21:09:13 INFO - Running setup.py install for mozdebug 21:09:13 INFO - Running setup.py install for mozdevice 21:09:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozfile 21:09:13 INFO - Running setup.py install for mozhttpd 21:09:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozinfo 21:09:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozInstall 21:09:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozleak 21:09:13 INFO - Running setup.py install for mozlog 21:09:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for moznetwork 21:09:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:09:13 INFO - Running setup.py install for mozprocess 21:09:14 INFO - Running setup.py install for mozprofile 21:09:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Running setup.py install for mozrunner 21:09:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Running setup.py install for mozscreenshot 21:09:14 INFO - Running setup.py install for moztest 21:09:14 INFO - Running setup.py install for mozversion 21:09:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:09:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:09:14 INFO - Cleaning up... 21:09:14 INFO - Return code: 0 21:09:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:14 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')]} 21:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:14 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')]} 21:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:14 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:14 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 21:09:14 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 21:09:14 INFO - Using env: {'DISPLAY': ':0', 21:09:14 INFO - 'HOME': '/home/cltbld', 21:09:14 INFO - 'LANG': 'en_US.UTF-8', 21:09:14 INFO - 'LANGUAGE': 'en_US:en', 21:09:14 INFO - 'LOGNAME': 'cltbld', 21:09:14 INFO - 'MAIL': '/var/mail/cltbld', 21:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:14 INFO - 'MOZ_NO_REMOTE': '1', 21:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:14 INFO - 'NO_EM_RESTART': '1', 21:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:14 INFO - 'PWD': '/builds/slave/test', 21:09:14 INFO - 'SHELL': '/bin/bash', 21:09:14 INFO - 'SHLVL': '1', 21:09:14 INFO - 'TERM': 'linux', 21:09:14 INFO - 'TMOUT': '86400', 21:09:14 INFO - 'USER': 'cltbld', 21:09:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:14 INFO - '_': '/tools/buildbot/bin/python'} 21:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:09:14 INFO - Running setup.py (path:/tmp/pip-0_ut_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:09:14 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)) 21:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:09:14 INFO - Running setup.py (path:/tmp/pip-oJNf0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:09:14 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)) 21:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:09:14 INFO - Running setup.py (path:/tmp/pip-3PqtJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:09:15 INFO - Running setup.py (path:/tmp/pip-2hgG1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:09:15 INFO - Running setup.py (path:/tmp/pip-7ig6f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:09:15 INFO - Running setup.py (path:/tmp/pip-pPoeNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:09:15 INFO - Running setup.py (path:/tmp/pip-LGHtsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:09:15 INFO - Running setup.py (path:/tmp/pip-nSmDd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:09:15 INFO - Running setup.py (path:/tmp/pip-gLfH9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:09:15 INFO - Running setup.py (path:/tmp/pip-jpwWCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:09:15 INFO - Running setup.py (path:/tmp/pip-ObHxMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:09:15 INFO - Running setup.py (path:/tmp/pip-IPKJvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:09:15 INFO - Running setup.py (path:/tmp/pip-kNwGM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:09:15 INFO - Running setup.py (path:/tmp/pip-0lBNT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:15 INFO - Running setup.py (path:/tmp/pip-qqtVIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:09:15 INFO - Running setup.py (path:/tmp/pip-E46aur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:09:15 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)) 21:09:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:09:16 INFO - Running setup.py (path:/tmp/pip-UUS9Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:09:16 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)) 21:09:16 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)) 21:09:16 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)) 21:09:16 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)) 21:09:16 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)) 21:09:16 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)) 21:09:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:09:16 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 21:09:16 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 21:09:16 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 21:09:16 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 21:09:16 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 21:09:16 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 21:09:17 INFO - Downloading blessings-1.6.tar.gz 21:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:09:18 INFO - Installing collected packages: blessings 21:09:18 INFO - Running setup.py install for blessings 21:09:18 INFO - Successfully installed blessings 21:09:18 INFO - Cleaning up... 21:09:18 INFO - Return code: 0 21:09:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:09:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:18 INFO - Reading from file tmpfile_stdout 21:09:18 INFO - Current package versions: 21:09:18 INFO - argparse == 1.2.1 21:09:18 INFO - blessings == 1.6 21:09:18 INFO - blobuploader == 1.2.4 21:09:18 INFO - docopt == 0.6.1 21:09:18 INFO - functools32 == 3.2.3-2 21:09:18 INFO - jsonschema == 2.5.1 21:09:18 INFO - manifestparser == 1.1 21:09:18 INFO - mozInstall == 1.12 21:09:18 INFO - mozcrash == 0.17 21:09:18 INFO - mozdebug == 0.1 21:09:18 INFO - mozdevice == 0.48 21:09:18 INFO - mozfile == 1.2 21:09:18 INFO - mozhttpd == 0.7 21:09:18 INFO - mozinfo == 0.9 21:09:18 INFO - mozleak == 0.1 21:09:18 INFO - mozlog == 3.2 21:09:18 INFO - moznetwork == 0.27 21:09:18 INFO - mozprocess == 0.22 21:09:18 INFO - mozprofile == 0.28 21:09:18 INFO - mozrunner == 6.11 21:09:18 INFO - mozscreenshot == 0.1 21:09:18 INFO - mozsystemmonitor == 0.3 21:09:18 INFO - moztest == 0.7 21:09:18 INFO - mozversion == 1.4 21:09:18 INFO - psutil == 3.1.1 21:09:18 INFO - requests == 1.2.3 21:09:18 INFO - wsgiref == 0.1.2 21:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:09:18 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')]} 21:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:18 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')]} 21:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:18 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:18 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 21:09:18 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 21:09:18 INFO - Using env: {'DISPLAY': ':0', 21:09:18 INFO - 'HOME': '/home/cltbld', 21:09:18 INFO - 'LANG': 'en_US.UTF-8', 21:09:18 INFO - 'LANGUAGE': 'en_US:en', 21:09:18 INFO - 'LOGNAME': 'cltbld', 21:09:18 INFO - 'MAIL': '/var/mail/cltbld', 21:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:18 INFO - 'MOZ_NO_REMOTE': '1', 21:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:18 INFO - 'NO_EM_RESTART': '1', 21:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:18 INFO - 'PWD': '/builds/slave/test', 21:09:18 INFO - 'SHELL': '/bin/bash', 21:09:18 INFO - 'SHLVL': '1', 21:09:18 INFO - 'TERM': 'linux', 21:09:18 INFO - 'TMOUT': '86400', 21:09:18 INFO - 'USER': 'cltbld', 21:09:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:18 INFO - '_': '/tools/buildbot/bin/python'} 21:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 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)) 21:09:18 INFO - Cleaning up... 21:09:18 INFO - Return code: 0 21:09:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:09:18 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')]} 21:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:18 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')]} 21:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:18 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:18 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 21:09:18 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 21:09:18 INFO - Using env: {'DISPLAY': ':0', 21:09:18 INFO - 'HOME': '/home/cltbld', 21:09:18 INFO - 'LANG': 'en_US.UTF-8', 21:09:18 INFO - 'LANGUAGE': 'en_US:en', 21:09:18 INFO - 'LOGNAME': 'cltbld', 21:09:18 INFO - 'MAIL': '/var/mail/cltbld', 21:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:18 INFO - 'MOZ_NO_REMOTE': '1', 21:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:18 INFO - 'NO_EM_RESTART': '1', 21:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:18 INFO - 'PWD': '/builds/slave/test', 21:09:18 INFO - 'SHELL': '/bin/bash', 21:09:18 INFO - 'SHLVL': '1', 21:09:18 INFO - 'TERM': 'linux', 21:09:18 INFO - 'TMOUT': '86400', 21:09:18 INFO - 'USER': 'cltbld', 21:09:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:18 INFO - '_': '/tools/buildbot/bin/python'} 21:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:09:18 INFO - Cleaning up... 21:09:18 INFO - Return code: 0 21:09:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:09:18 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')]} 21:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:18 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')]} 21:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:09:18 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 0x7f871b726f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', '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 21:09:18 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 21:09:18 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 21:09:18 INFO - Using env: {'DISPLAY': ':0', 21:09:18 INFO - 'HOME': '/home/cltbld', 21:09:18 INFO - 'LANG': 'en_US.UTF-8', 21:09:18 INFO - 'LANGUAGE': 'en_US:en', 21:09:18 INFO - 'LOGNAME': 'cltbld', 21:09:18 INFO - 'MAIL': '/var/mail/cltbld', 21:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:18 INFO - 'MOZ_NO_REMOTE': '1', 21:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:18 INFO - 'NO_EM_RESTART': '1', 21:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:18 INFO - 'PWD': '/builds/slave/test', 21:09:18 INFO - 'SHELL': '/bin/bash', 21:09:18 INFO - 'SHLVL': '1', 21:09:18 INFO - 'TERM': 'linux', 21:09:18 INFO - 'TMOUT': '86400', 21:09:18 INFO - 'USER': 'cltbld', 21:09:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:18 INFO - '_': '/tools/buildbot/bin/python'} 21:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:09:19 INFO - Downloading/unpacking flake8 21:09:19 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 21:09:19 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 21:09:19 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 21:09:19 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 21:09:19 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 21:09:19 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 21:09:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:09:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:09:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 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 21:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:09:21 INFO - no previously-included directories found matching 'docs/_build' 21:09:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:09:21 INFO - Running setup.py install for pep8 21:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:09:21 INFO - no previously-included directories found matching 'docs/_build' 21:09:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:09:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:09:21 INFO - Cleaning up... 21:09:22 INFO - Return code: 0 21:09:22 INFO - Running post-action listener: _resource_record_post_action 21:09:22 INFO - Running post-action listener: _start_resource_monitoring 21:09:22 INFO - Starting resource monitoring. 21:09:22 INFO - ##### 21:09:22 INFO - ##### Finished create-virtualenv step (success) 21:09:22 INFO - ##### 21:09:22 INFO - ##### 21:09:22 INFO - ##### Running install step. 21:09:22 INFO - ##### 21:09:22 INFO - Running pre-action listener: _resource_record_pre_action 21:09:22 INFO - Running main action method: install 21:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:09:22 INFO - Reading from file tmpfile_stdout 21:09:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:09:22 INFO - Reading from file tmpfile_stdout 21:09:22 INFO - Output received: 21:09:22 INFO - Usage: mozinstall [options] installer 21:09:22 INFO - Options: 21:09:22 INFO - -h, --help show this help message and exit 21:09:22 INFO - -d DEST, --destination=DEST 21:09:22 INFO - Directory to install application into. [default: 21:09:22 INFO - "/builds/slave/test"] 21:09:22 INFO - --app=APP Application being installed. [default: firefox] 21:09:22 INFO - mkdir: /builds/slave/test/build/application 21:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:09:38 INFO - Reading from file tmpfile_stdout 21:09:38 INFO - Output received: 21:09:38 INFO - /builds/slave/test/build/application/firefox/firefox 21:09:38 INFO - Running post-action listener: _resource_record_post_action 21:09:38 INFO - ##### 21:09:38 INFO - ##### Finished install step (success) 21:09:38 INFO - ##### 21:09:38 INFO - ##### 21:09:38 INFO - ##### Running run-tests step. 21:09:38 INFO - ##### 21:09:38 INFO - Running pre-action listener: _resource_record_pre_action 21:09:38 INFO - Running main action method: run_tests 21:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:09:38 INFO - Python 2.7.3 21:09:38 INFO - Return code: 0 21:09:38 INFO - grabbing minidump binary from tooltool 21:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:09:38 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 0x17362c0>, '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 0x17371c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1737650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:09:38 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 21:09:38 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 21:09:38 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 21:09:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:09:38 INFO - Return code: 0 21:09:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:09:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:09:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:09:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:09:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:09:39 INFO - Return code: 0 21:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:09:39 INFO - Using env: {'DISPLAY': ':0', 21:09:39 INFO - 'HOME': '/home/cltbld', 21:09:39 INFO - 'LANG': 'en_US.UTF-8', 21:09:39 INFO - 'LANGUAGE': 'en_US:en', 21:09:39 INFO - 'LOGNAME': 'cltbld', 21:09:39 INFO - 'MAIL': '/var/mail/cltbld', 21:09:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:09:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:09:39 INFO - 'MOZ_NO_REMOTE': '1', 21:09:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:09:39 INFO - 'NO_EM_RESTART': '1', 21:09:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:09:39 INFO - 'PWD': '/builds/slave/test', 21:09:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:09:39 INFO - 'SHELL': '/bin/bash', 21:09:39 INFO - 'SHLVL': '1', 21:09:39 INFO - 'TERM': 'linux', 21:09:39 INFO - 'TMOUT': '86400', 21:09:39 INFO - 'USER': 'cltbld', 21:09:39 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868', 21:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:09:39 INFO - '_': '/tools/buildbot/bin/python'} 21:09:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:09:39 INFO - mozversion application_buildid: 20160607203328 21:09:39 INFO - mozversion application_changeset: 1401fcd673699f8d6e431ccb643ab46e166da2a9 21:09:39 INFO - mozversion application_display_name: Nightly 21:09:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:09:39 INFO - mozversion application_name: Firefox 21:09:39 INFO - mozversion application_remotingname: firefox 21:09:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:09:39 INFO - mozversion application_vendor: Mozilla 21:09:39 INFO - mozversion application_version: 50.0a1 21:09:39 INFO - mozversion platform_buildid: 20160607203328 21:09:39 INFO - mozversion platform_changeset: 1401fcd673699f8d6e431ccb643ab46e166da2a9 21:09:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:09:39 INFO - mozversion platform_version: 50.0a1 21:09:39 INFO - using testdate: 1465358979 21:09:39 INFO - actual date: 1465358979 21:09:39 INFO - starting webserver on 'localhost:37364' 21:09:39 INFO - SUITE-START | Running 2 tests 21:09:39 INFO - TEST-START | dromaeo_css 21:09:39 INFO - operating with platform_type : linux_ 21:09:39 INFO - Initialising browser for dromaeo_css test... 21:09:39 INFO - TEST-INFO | started process 3340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMU8Qck/profile http://localhost:37364/getInfo.html) 21:09:45 INFO - PROCESS | 3340 | __metrics Screen width/height:1600/1200 21:09:45 INFO - PROCESS | 3340 | colorDepth:24 21:09:45 INFO - PROCESS | 3340 | Browser inner width/height: 1024/697 21:09:45 INFO - PROCESS | 3340 | __metrics 21:09:45 ERROR - PROCESS | 3340 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 21:09:46 INFO - TEST-INFO | 3340: exit 0 21:09:46 INFO - Browser initialized. 21:09:46 INFO - Running cycle 1/1 for dromaeo_css test... 21:09:46 INFO - TEST-INFO | started process 3459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMU8Qck/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:09:58 INFO - PROCESS | 3459 | RSS: Main: 168116224 21:09:58 INFO - PROCESS | 3459 | 21:10:48 INFO - PROCESS | 3459 | 1465359048111 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] 21:12:59 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37364/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37364/tests/dromaeo/cssquery-ext.html) 21:13:00 INFO - PROCESS | 3459 | RSS: Main: 171290624 21:13:00 INFO - PROCESS | 3459 | 21:16:02 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37364/tests/dromaeo/cssquery-ext.html (next: http://localhost:37364/tests/dromaeo/cssquery-jquery.html) 21:16:02 INFO - PROCESS | 3459 | RSS: Main: 169373696 21:16:02 INFO - PROCESS | 3459 | 21:19:04 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37364/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37364/tests/dromaeo/cssquery-mootools.html) 21:19:05 INFO - PROCESS | 3459 | RSS: Main: 170885120 21:19:05 INFO - PROCESS | 3459 | 21:22:07 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37364/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37364/tests/dromaeo/cssquery-prototype.html) 21:22:08 INFO - PROCESS | 3459 | RSS: Main: 169373696 21:22:08 INFO - PROCESS | 3459 | 21:25:10 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37364/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37364/tests/dromaeo/cssquery-yui.html) 21:25:11 INFO - PROCESS | 3459 | RSS: Main: 170754048 21:25:11 INFO - PROCESS | 3459 | 21:28:13 INFO - PROCESS | 3459 | Cycle 1(1): loaded http://localhost:37364/tests/dromaeo/cssquery-yui.html (next: http://localhost:37364/tests/dromaeo/cssquery-dojo.html) 21:28:14 INFO - PROCESS | 3459 | RSS: Main: 172105728 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | __start_tp_report 21:28:14 INFO - PROCESS | 3459 | _x_x_mozilla_page_load 21:28:14 INFO - PROCESS | 3459 | _x_x_mozilla_page_load_details 21:28:14 INFO - PROCESS | 3459 | |i|pagename|runs| 21:28:14 INFO - PROCESS | 3459 | |0;dojo.html;2645.9073932412343;2650.390410205653;2682.825616334938;2685.905993290235;2700.8109432339734;4696.6477514186445;4728.101660684468;4744.525547445258;4764.356811830402;4794.304825800257;4633.1660301145785;4677.929831052537;4692.741899195551;4700.059988002405;4785.377900872891;4320.4599425071865;4362.563743625644;4382.517923028464;4387.319965405367;4453.354263631772;271.35138925977174;4336.262835318003;4464.419625448687;4474.440694913136;4513.390692256553;4362.585554372329;4380.299152135659;4387.122575484884;4393.824247030115;4401.251787196168;4427.158839820424;4453.465584129893;4462.933056004163;4479.888002799924;4511.593956543927;4319.1361727654285;4387.692861499696;4441.933370999438;4444.755538445384;4496.595306422405;4684.414448193976;4713.434387873477;4726.2201736713405;4756.571908528249;4759.857204283877;5126.820561280338;5135.35808023997;5156.149235376159;5159.638825282232;5168.870778230536;4940.975295123501;5088.592912566985;5119.385673719177;5138.997895410396;5245.029669511115;4803.615710743132;4807.543283388072;4817.108834865561;4827.61379089672;4854.635902307341;5290.127129023745;5291.444398338119;5299.49654782795;5307.283516725192;5325.174597937248;4885.218365061573;5018.548330650186;5062.265971434122;5083.186690129562;5094.6943183408375;5133.922991155136;5167.586593072545;5168.431472538018;5169.689818610896;5230.241614965808;4896.975515122402;5122.769475373617;5143.996920600447;5145.562627176657;5146.30524879144;4899.534544218293;5092.796288148506;5133.435322114565;5148.9742551287;5149;4306.138772245501;4351.695381323277;4392.516823149451;4394.758288294111;4438.245498265303;3752.249550089993;3830.272248272819;3832.7125465589634;3858.6334298241622;3865.130345672201;4392.099619577979;4419.248727716296;4419.64642828573;4423.071155057474;4431.711938723973;5113.923291150636;5114.64197506171;5114.769835357418;5123.103456895103;5125.026245013435;4316.309390497506;4365.541618130051;4399.494058183286;4445.866624001285;4449.310356894686;4557.5442455754155;4576.405067341224;4601.171789077998;4608.28571571407;4626.028534007829;4771.6898401603785;4790;4794.856154315376;4824.204006338915;4888.7311197884455;4992.950070499393;5162.664426812245;5165.845024649117;5169.250458683545;5224.947750522446;4760.547747963938;4772.045590881907;4789.904201915872;4798.448178459382;4799.784009719641;4977;5025.623078269217;5044.747762611928;5058.089543882136;5081.618878584047;4954.677945933503;5046.21783623539;5163.27714120031;5167.095758242217;5213.244079608511;4940.851774446773;4947.40631124253;4966.826161084345;4972.154733695353;5016.698998060128;4930.852074437773;4932.901341973069;4942.159832828356;4960.528749768766;5001.42483614389;4695.413073365829;4709.340692303149;4716.740579268173;4825.420949485943;4874.731889745956;4925.458199598113;4944.159492886146;4944.92582611254;4974.278729584263;4992.925106123338;4842;4859.684120532154;4861.635377346643;4862.724889877753;4896.902061958812 21:28:14 INFO - PROCESS | 3459 | |1;ext.html;505.4389627513462;562.4291344285551;562.5021855657742;574.494444888498;587.04018929051;40030;41083.79458102709;41392.37911431327;41743.58256417435;45506.31740523895;41421.792891035504;41736;41878.58121418785;42108;42257;7669.079710434742;7806.60966951653;7856.292933635971;7916.168802275735;7918.485298455611;7834.686612535492;7839.804004899866;7856.4893281936775;7915.327197188246;7935.087464941548;7936.761897143095;7962.482438641469;7995.320397766197;8001.479903806234;8020.238077382639;7870.881936770953;7872.409569282327;7914.485558438741;7920.445568810214;7938.44430889838;7797.181295963899;7816.648250828726;7826.256505631955;7834.942282791807;7865.882011769828;37733.24533509315;38146;38237;38359;38360;3009.9097027089;3161.5099659552807;3621.6559426854406;3633.8728144514816;3743.906402339936;26968;29708.55437168444;29792.70207297921;29800;29916.850415748;3302.2239773653173;3355.781874178195;3438.7592868499214;3484.5992710838073;3490.3542844573835;263573;265852;266555.66722166457;266808.33191668225;267160;32451.675483244864;33227;33483;35131.297374052374;55093.44906550963;34477;34490;34513;34658.48012279818;34709;14039.578812635433;14137;14256.572302830931;14270.3578338975;14349.56951291442;11123.110151187886;11217.439128043565;11284.774304513863;11295.03992160659;11341.829872551918;7824.726134585262;7859.882101768478;7898.249666281694;7905.051393832777;7973.521588704696;3061.663217046123;3080.476319025771;3107.368631468497;3114.6573876873526;3129.358481511285;881.6341218394423;891.5675897189858;899.604174163366;988.4859872866069;989.6288891665625;27888.302792430353;27938.066503017297;28568;28637.856810715813;29054.564181537295;910.6630546697631;977.4379731654185;981.7692842182081;1030.1810061001522;1052.3054783842626;14447.711045779026;14603.78094328586;14695.338709758087;14751.704965900837;14792.556223313319;403894;407776;408746;408973;411231;49569.50430495721;50360.74819625952;50935.745321273156;50963;50984.74507627438;1195.0977012355615;1206.8551773787026;1220.2941727747113;1220.9328486933305;1229.6987238126717;26461.33846653849;27196.864015679796;27515.44969100647;27856;27877.16368508948;37674.246515070095;37791;37846.62153378431;37908.81045594755;37973.24053518859;343006;345304;345315;345781;346763;25201.621975670012;25683.486330273663;26020.21939341823;26048.8697556511;26132.60801087947;41230.587694122674;41715.37426938659;42101.36847947344;42681.35977960271;42923.5707642932;36184.63815361918;36997.81501092477;37433.06417339479;37565.62434375731;38138.42792358172;36269.45595816012;36882.26235475329;38260.234795304495;40127.1974560513;40364.3945340826;35357;35764;36246.818765906;36653.08367290839;36886.07784805401;30283.697163028086;32638.673613263563;33048.834755826065;33120.1719957003;33226.50160247646;24684.38289042788;25285.367865803502;25395.36511587225;25412.491750165264;25479.10823121182 21:28:14 INFO - PROCESS | 3459 | |2;jquery.html;362.63555127097266;362.79683377308703;376.570709391294;386.7447484660125;391.3894324853229;15798.68402631948;17023.23395447205;17904.731429028576;17979.550511237227;17983.910080449612;10838.566457341696;15680.451184208556;16545.42091026814;16580.66838663226;17412.738808917846;4532.864014079574;4675.696079754805;4710.152172608929;4712.104700106968;4716.410448693913;3460.4117300058924;5061.19020956647;5374.5700343972385;5376.38171610264;5405.945940540583;5220.608454365919;5380.677159370431;5380.7309634518115;5381.139017757159;5393.487618676219;5048.419431765357;5374.5700343972385;5399.406065332811;5450.400455949843;5464.098423760075;5053.242013697938;5248.632595718302;5425.3489581250105;5435.891282174374;5459.563234941234;11868.703282417922;11969;11996.70008249792;12015.879841201564;21248.893755531277;1959.6178745144703;1994.2920263306607;2134.6691262854283;2211.9115235390564;2548.929449631141;13552.932235338858;13848.653783655389;13939.512117075854;14007.439702411892;14237.43050277998;1897.1747289928926;1913.062599326334;1915.5785727140008;1938.1569017477443;1952.0825212150266;78411.6079419605;79931.20068799295;80895;81009.78485322725;81265.59367203186;16199.514014579581;16855.83144168567;16945.66108677844;16962;17209.483715488554;28903.56644650332;28965.275868103465;29001;29227;29309.12072637824;8925.152110549487;9211.539423028822;9235.815283694288;9343.34596578233;9417.576209070472;7673.961630191813;7708.190639982833;7735.535867847947;7831.412644051719;7929.088154862149;8349.206825351583;8551.486910785372;8588.8527868033;8709.869351959725;8760.4305720128;1523.6267114557004;1548.9380424783108;1563.5934656989264;1599.8480144386265;3359.7816141950693;847.3560094328354;874.9912500875037;881.2113158722907;911.1708345405649;925.1950802801471;16212.027278363335;16236;16240.59398515023;16794.16029198535;16879.578010549834;829.601791140244;859.1022381611107;859.5014891362995;860.1699360117517;881.3081730841387;9202.493862837475;9527.809443811086;9706.563204655808;9743.31796774219;9873.111419972238;388797;392159;394273;399528;403921;47814.760926195144;48627;56471.71764141153;76023;76152.61923690345;855.6705668317743;862.5342315149875;870.0994470722771;874.9300055995506;878.2315473960285;9008.684696035607;9082.228010619172;14413.495527656481;14732.26338683083;15735.606609834846;34834.82582587071;35391.82304088463;36226.09434764152;36299.81850090733;36428.63571364358;43521;48737;50791.23813142732;50925.74537127439;51431.22853157131;11274.661760147208;11770.646880593597;11800.288958101199;11876.228045177037;11987.76024479523;8925.553722313989;12377.195482293622;12573;12810.103292769789;12965.481380745043;10989.725256868642;11212.27120237182;11236.438178091226;11286.363477295581;11388.544458221579;10617.787644247226;10845.674629761119;11173;11398.20212585111;11429.59996400122;11451.770964580828;11501.252418592765;11526.538938442369;11580.6525804226;11781;11713.765724685629;11772.587959421378;11792.76414471723;11861.762764744484;11870.703232419259;11315;11341.886581134084;11511.19421640477;11597.304161750322;11653.417329133339 21:28:14 INFO - PROCESS | 3459 | |3;mootools.html;1347.8854297384726;1409.4291811816215;1474.9336279867405;1693.2549678141618;1695.5252529291802;6444.420002199801;7365.668544915478;7391.852162956738;7853.842923141541;7901.525908445497;7504.737334193304;7726.8454630907345;7779.183185765498;7788;7810.531368117917;2132.4135862637745;2174.608570457317;2181.9345419637434;2187.57342318248;2192.177933275022;2131.381899249216;2149.2047942261306;2181.869087854726;2183.792539708733;2191.923282685106;2160.2223199648115;2165.8267338612873;2172.4894649757375;2175.0973346061364;2178.8256939444886;2088.592724418739;2092.6337890869113;2093.0581238442687;2093.1418118571387;2094.6857971304275;2088.749350077985;2094.5810837832496;2113.8097571218664;2116.8941552922292;2142.3572928121503;7677.0403699537555;7722.652480638385;7765.7670269892;7767.300942915164;7771.145174030852;4293.828246870122;4362.236608593484;4365.039691267916;4390.648748100176;4396.076823866992;2763.474939761459;2813.8171018883913;2883.0774152271283;2888.581155732428;2893.2477555835426;857.4940784936917;877.4472082587993;904.8959369672506;937.6390089815402;950.097407462913;9849.655262065793;9873.506324683809;9879.654212102614;9953.25350598708;9965.601375945025;3957.584453632385;3989.7805620691142;4078.1028173801715;4097.590240975938;4114.979425102915;8474.5339006354;8497.74506764798;8511.446755960842;8527.829443411098;8531.189536993976;4338.34924761282;4364.214441400515;4391.890202744893;4397.450318710161;4398.582134697199;3538.6815186633326;3958.9010274743364;3971.4638523798917;3976.1053762903116;4087.46862907826;3572.8928132156075;3597.136687195107;3613.747037707335;3703.370427027412;3716.7955762433326;1185.1644590563633;1197.3653963399413;1220.6704189868863;1223.498365670071;1228.9262644241373;769.6536558548676;869.6738722978882;869.7086476030474;884.8982367027745;900.9549522523847;5189.896202075937;5218.530332270114;5229.50319719626;5247.924175544004;5279.44565820591;364.75014614988817;368.8211217559481;369.33335329729556;372.17006076449667;918.3892711347013;3489.1626009757983;3564.4475106358555;3642.4718415829557;3650.7079433645245;3683.778973261613;9330.673426430043;9472.715818525456;9492.335536512515;9580.952095239618;9641.517924103768;9401.670941517013;9427.057294270518;9464.0598677271;9504.192143667866;9512.524373781283;7067.6112813795735;7086.999999999897;7124.145102587722;7182.42540596751;7194.928050719531;5312.043832110257;5411.402526787243;5516.282883225155;5537.335519737496;5608;8349.95825020871;8652.697155599524;8657.653693852175;8786;8958.596863141043;8792.824143517222;8905.599248033983;8910.599023044108;9079.228265597498;9087.772805679911;5783.219265399117;6339.397757213057;6566.474682025522;6623.403893649402;6801.2858649841055;7456.067991501062;7470.3276705096805;7534.39724822002;7535.208803075599;7544;6398.808035758934;6672.299408562031;6727.495437842279;6754.966225168842;6866.141732283465;6603.405693487609;6695.09616201826;6712.060311556288;6743.258241593323;6829.248782634006;6190.938090619036;6259.624422534663;6320.905186422299;6326.810195694136;6347.333529979285;4496.190685676479;4543.7955292011275;4555.088982203506;4578.40480737502;4592.402987611589;4265.360195970629;4312.353147027971;4356.869293921188;4513.277875539898;4529.297958816389 21:28:14 INFO - PROCESS | 3459 | |4;prototype.html;297.8138663335415;298.91032690192964;299.4923604490388;300.3032963524622;302.9288117292436;5089.66917150385;5120;5126.71803050832;5149.922751158736;5156.664816786911;5003.599712023039;5012.147934851075;5026.673266237701;5027.8324655467095;5028.5919942416185;3718.814059297038;3831.865884694036;3932.3315036443873;3939.8227079781477;3950.3803440589363;3918.4710064141404;3974.801259937006;3976.5228172619327;3977.34373828318;3983.243183795084;3913.9608603914025;3917.373220284755;3917.412388141773;3940.2316548273097;3941.664958478518;3811.4402684364163;3914.5498267699295;3922.293987082324;3945.408188771693;3961.722679412428;3446.5691788526433;3464.8960531184107;3469.826508674556;3471.6181220065773;3472.774269672463;4795.592374648159;4815.807367705288;4823.614110871122;4835.540623640749;4860.635452341088;4401.185780630593;4490.483594386622;4507.819687212507;4525.031611249117;4533.2746760518485;5245.10833158364;5251.396089449724;5262.842114736564;5266.526012658841;5293.973530132324;3791.3933770596573;3799.2211596622624;3801.8099095045413;3802.505674262356;3806.001849029282;5412.377576578665;5533.418991005927;5541.141123125922;5549.750261238254;5575.992642648644;3833.9424908625833;3870.6322899325082;3889.572147063821;3894.2211557688574;3906.55074666417;3920.6079392060565;3931.4495970564144;3963.8018099095507;3964;3965.167314863911;4483.30508771141;4491.034427598082;4491.685582009293;4504.211762941472;4512.616427603691;4981.302617633534;5287.312649355559;5289.312389389432;5332.200169974535;5354.250404943311;1307.5162189989574;1336.3852627791325;1338.7857942729117;1339.5311640925597;1343.6909510812372;816.7753867686315;835.4903508859591;841.4698739794013;858.772425307294;864.321507616518;4508.616767574727;4600.470945841204;4627.866172787689;4637.837675681335;4650.651201159859;5481.671099734029;5485.9725701371235;5491.835244942658;5510.972445137749;5526.115821468546;4488.4613846338;4690.7654617269;4696.272077827942;4702.741349225826;4710.411198600175;2901.9698007207558;2906.5640153977074;2912.3010477485673;2930.9888088609396;2937.1775902747263;5056.26684130799;5095.694258344512;5129.487051294841;5148.786022010497;5158.317674809154;5506.339239291311;5636.971815140898;5643.351014633287;5676.205331253545;5692.943070569241;5116.283720279164;5128.435872053997;5166.689998600096;5202;5202.505761952609;5425.511703946664;5434.5652347812875;5460.542755759844;5460.890782184413;5507.421720719267;5153.793848246029;5362.3833259174135;5432.837014889559;5437.891242175056;5461.235427040297;5141.794328226829;5171.431142574389;5187.170052791686;5200.60995425337;5239.449857765032;3780.2061567070123;3793.013816407699;3800.467934489229;3801.201747633028;3801.847926082926;5224.843254702365;5477.110396913059;5500.834974950758;5507.752151153288;5527.281453411031;5310.725425897834;5312.946870531246;5328.227407026037;5329.920051199158;5333.333333333333;5287.651648829524;5291.523762861361;5292.470752924677;5303.4696530346655;5324.600654950972;4935.259711043373;5250.873396274515;5258.106121959353;5259.606204355925;5286.867828304169;5113.386393632788;5247.9737601311745;5299;5321.243989483539;5348.358197016383;5214.530692237717;5257.211418287287;5259.15853463444;5261.526772503705;5262.631615786858 21:28:14 INFO - PROCESS | 3459 | |5;yui.html;543.2123421039494;544.4800215793915;631.9462845658119;657.5101549345738;700.639170827024;12011.939940300286;12813.615591532258;13002.479900803957;13137.146085504435;13143.737125257501;12658.367081645903;12962.935185324084;13199.274039927801;13237.867621323783;13799.172049677027;787.2363807107125;790.8497385496737;790.9011373578303;792.5759718550577;793.1473665809249;629.9149614802012;765.6860687118283;791.5053091817614;798.66456088443;804.505229283992;670.4468813229081;675.4292622733782;676.9796906092826;680.8944613584903;682.4199430484074;674.507609445103;675.6419097878132;676.3980057748607;677.069030083635;677.976270830521;486.56695540968565;486.57424753340825;488.15549100056745;489.7233063319213;491.9901601967941;12834.935825320814;12840;12845.229286242855;12849.229046257162;12887.226766394046;12453;12926.797659279633;12938.547150849676;13065.150765200327;13360.933195334059;10301.124404425633;10438.739031524197;10476;10662.147028237723;10665;3242.4812030075077;3246.642869284377;3279.2949515853966;3311.172206948263;3337.8998630041137;57164;57800.42199577992;58689.41310586882;58867.70566147142;59084.11373829396;9158.129977652112;9271.814563708687;9315.115064068903;9458.95270523643;9523.380980236263;18146.09269536518;18159;18167.36414225496;18238.908805456154;18272.817271827378;6376.39424254695;6509.674516274262;6810.216825065181;6861.451083913275;6927.480438967098;3438.432658611351;3523.823808809549;3587.0673624857723;3588.4258518636893;3656.597774244831;2913.1988703106817;3047.131567503251;3063.0198336532094;3066.861991210401;3067.539869019665;487.18153502116786;508.58296197118005;515.2142981952477;516.9041631740733;522.27143135326;544.2679595943449;601.5456935702324;604.4952464691944;610.9908351374733;611.788932818177;7393.482456228013;7617.428692848059;7691.730789422343;7755.1469338372735;7842.215778422226;398.1658425598367;464.21315869600704;511.1361798560421;541.3287523470947;547.3349879895945;3569.9286014280087;3592.8742494012586;3776.2825063237897;3869.071422858494;3879.728419010642;88436.92504599616;89928.55035724779;91331.54334228419;93847.53076234712;93990.53004734933;49318.013639727;49883;57766.422335776944;68062;78259.21740782633;72204.27795721976;73234.63382683053;73248.2675173252;73567.63216183992;73905.63047184837;7863.488873223222;7883.251091146332;8256.050554186346;8269.173082691683;8317.584120794058;31009.224769380042;31664.525032125;40958;41599.58400415957;43375.78312108419;55836.16245756398;57504.71247643735;59739;60568.39431605628;60974;10640.521176547229;10992.28550144238;11071.391073491035;11073.114150868072;11246.7750644985;12445.75108497843;12687.80968285458;12710.173838700455;12782.744345113231;12843.807342890052;10808.081313088476;11188.83216751733;11818.231814932002;12186.51253949832;12197.390130493617;10268.281220314506;10326.277160598685;10634.202434817575;10676.62631807883;11254.88745112571;10684.305520141166;11613.883861161281;11824.408779560816;11870.228435151688;11886.405679715806;9150.40522366044;9688.370255933623;9954.253430992849;9982.550785214538;10013.949930250303;9043.23132533742;9269.953650231706;9293.488858112869;9299.373878803226;9317.580708867981 21:28:14 INFO - PROCESS | 3459 | __end_tp_report 21:28:14 INFO - PROCESS | 3459 | __start_cc_report 21:28:14 INFO - PROCESS | 3459 | _x_x_mozilla_cycle_collect,388 21:28:14 INFO - PROCESS | 3459 | __end_cc_report 21:28:14 INFO - PROCESS | 3459 | __startTimestamp1465360094244__endTimestamp 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | ------- Summary: start ------- 21:28:14 INFO - PROCESS | 3459 | Number of tests: 6 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | [#0] dojo.html Cycles:165 Average:4696.72 Median:4807.54 stddev:600.73 (12.5%) stddev-sans-first:580.62 21:28:14 INFO - PROCESS | 3459 | Values: 2645.9 2650.4 2682.8 2685.9 2700.8 4696.6 4728.1 4744.5 4764.4 4794.3 4633.2 4677.9 4692.7 4700.1 4785.4 4320.5 4362.6 4382.5 4387.3 4453.4 271.4 4336.3 4464.4 4474.4 4513.4 4362.6 4380.3 4387.1 4393.8 4401.3 4427.2 4453.5 4462.9 4479.9 4511.6 4319.1 4387.7 4441.9 4444.8 4496.6 4684.4 4713.4 4726.2 4756.6 4759.9 5126.8 5135.4 5156.1 5159.6 5168.9 4941.0 5088.6 5119.4 5139.0 5245.0 4803.6 4807.5 4817.1 4827.6 4854.6 5290.1 5291.4 5299.5 5307.3 5325.2 4885.2 5018.5 5062.3 5083.2 5094.7 5133.9 5167.6 5168.4 5169.7 5230.2 4897.0 5122.8 5144.0 5145.6 5146.3 4899.5 5092.8 5133.4 5149.0 5149.0 4306.1 4351.7 4392.5 4394.8 4438.2 3752.2 3830.3 3832.7 3858.6 3865.1 4392.1 4419.2 4419.6 4423.1 4431.7 5113.9 5114.6 5114.8 5123.1 5125.0 4316.3 4365.5 4399.5 4445.9 4449.3 4557.5 4576.4 4601.2 4608.3 4626.0 4771.7 4790.0 4794.9 4824.2 4888.7 4993.0 5162.7 5165.8 5169.3 5224.9 4760.5 4772.0 4789.9 4798.4 4799.8 4977.0 5025.6 5044.7 5058.1 5081.6 4954.7 5046.2 5163.3 5167.1 5213.2 4940.9 4947.4 4966.8 4972.2 5016.7 4930.9 4932.9 4942.2 4960.5 5001.4 4695.4 4709.3 4716.7 4825.4 4874.7 4925.5 4944.2 4944.9 4974.3 4992.9 4842.0 4859.7 4861.6 4862.7 4896.9 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | [#1] ext.html Cycles:180 Average:47938.83 Median:36767.67 stddev:91101.61 (247.8%) stddev-sans-first:91287.56 21:28:14 INFO - PROCESS | 3459 | Values: 505.4 562.4 562.5 574.5 587.0 40030.0 41083.8 41392.4 41743.6 45506.3 41421.8 41736.0 41878.6 42108.0 42257.0 7669.1 7806.6 7856.3 7916.2 7918.5 7834.7 7839.8 7856.5 7915.3 7935.1 7936.8 7962.5 7995.3 8001.5 8020.2 7870.9 7872.4 7914.5 7920.4 7938.4 7797.2 7816.6 7826.3 7834.9 7865.9 37733.2 38146.0 38237.0 38359.0 38360.0 3009.9 3161.5 3621.7 3633.9 3743.9 26968.0 29708.6 29792.7 29800.0 29916.9 3302.2 3355.8 3438.8 3484.6 3490.4 263573.0 265852.0 266555.7 266808.3 267160.0 32451.7 33227.0 33483.0 35131.3 55093.4 34477.0 34490.0 34513.0 34658.5 34709.0 14039.6 14137.0 14256.6 14270.4 14349.6 11123.1 11217.4 11284.8 11295.0 11341.8 7824.7 7859.9 7898.2 7905.1 7973.5 3061.7 3080.5 3107.4 3114.7 3129.4 881.6 891.6 899.6 988.5 989.6 27888.3 27938.1 28568.0 28637.9 29054.6 910.7 977.4 981.8 1030.2 1052.3 14447.7 14603.8 14695.3 14751.7 14792.6 403894.0 407776.0 408746.0 408973.0 411231.0 49569.5 50360.7 50935.7 50963.0 50984.7 1195.1 1206.9 1220.3 1220.9 1229.7 26461.3 27196.9 27515.4 27856.0 27877.2 37674.2 37791.0 37846.6 37908.8 37973.2 343006.0 345304.0 345315.0 345781.0 346763.0 25201.6 25683.5 26020.2 26048.9 26132.6 41230.6 41715.4 42101.4 42681.4 42923.6 36184.6 36997.8 37433.1 37565.6 38138.4 36269.5 36882.3 38260.2 40127.2 40364.4 35357.0 35764.0 36246.8 36653.1 36886.1 30283.7 32638.7 33048.8 33120.2 33226.5 24684.4 25285.4 25395.4 25412.5 25479.1 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | [#2] jquery.html Cycles:180 Average:25225.57 Median:362.72 stddev:65089.12 (17944.9%) stddev-sans-first:65244.94 21:28:14 INFO - PROCESS | 3459 | Values: 362.6 362.8 376.6 386.7 391.4 15798.7 17023.2 17904.7 17979.6 17983.9 10838.6 15680.5 16545.4 16580.7 17412.7 4532.9 4675.7 4710.2 4712.1 4716.4 3460.4 5061.2 5374.6 5376.4 5405.9 5220.6 5380.7 5380.7 5381.1 5393.5 5048.4 5374.6 5399.4 5450.4 5464.1 5053.2 5248.6 5425.3 5435.9 5459.6 11868.7 11969.0 11996.7 12015.9 21248.9 1959.6 1994.3 2134.7 2211.9 2548.9 13552.9 13848.7 13939.5 14007.4 14237.4 1897.2 1913.1 1915.6 1938.2 1952.1 78411.6 79931.2 80895.0 81009.8 81265.6 16199.5 16855.8 16945.7 16962.0 17209.5 28903.6 28965.3 29001.0 29227.0 29309.1 8925.2 9211.5 9235.8 9343.3 9417.6 7674.0 7708.2 7735.5 7831.4 7929.1 8349.2 8551.5 8588.9 8709.9 8760.4 1523.6 1548.9 1563.6 1599.8 3359.8 847.4 875.0 881.2 911.2 925.2 16212.0 16236.0 16240.6 16794.2 16879.6 829.6 859.1 859.5 860.2 881.3 9202.5 9527.8 9706.6 9743.3 9873.1 388797.0 392159.0 394273.0 399528.0 403921.0 47814.8 48627.0 56471.7 76023.0 76152.6 855.7 862.5 870.1 874.9 878.2 9008.7 9082.2 14413.5 14732.3 15735.6 34834.8 35391.8 36226.1 36299.8 36428.6 43521.0 48737.0 50791.2 50925.7 51431.2 11274.7 11770.6 11800.3 11876.2 11987.8 8925.6 12377.2 12573.0 12810.1 12965.5 10989.7 11212.3 11236.4 11286.4 11388.5 10617.8 10845.7 11173.0 11398.2 11429.6 11451.8 11501.3 11526.5 11580.7 11781.0 11713.8 11772.6 11792.8 11861.8 11870.7 11315.0 11341.9 11511.2 11597.3 11653.4 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | [#3] mootools.html Cycles:180 Average:5021.17 Median:5463.84 stddev:2802.18 (51.3%) stddev-sans-first:2796.45 21:28:14 INFO - PROCESS | 3459 | Values: 1347.9 1409.4 1474.9 1693.3 1695.5 6444.4 7365.7 7391.9 7853.8 7901.5 7504.7 7726.8 7779.2 7788.0 7810.5 2132.4 2174.6 2181.9 2187.6 2192.2 2131.4 2149.2 2181.9 2183.8 2191.9 2160.2 2165.8 2172.5 2175.1 2178.8 2088.6 2092.6 2093.1 2093.1 2094.7 2088.7 2094.6 2113.8 2116.9 2142.4 7677.0 7722.7 7765.8 7767.3 7771.1 4293.8 4362.2 4365.0 4390.6 4396.1 2763.5 2813.8 2883.1 2888.6 2893.2 857.5 877.4 904.9 937.6 950.1 9849.7 9873.5 9879.7 9953.3 9965.6 3957.6 3989.8 4078.1 4097.6 4115.0 8474.5 8497.7 8511.4 8527.8 8531.2 4338.3 4364.2 4391.9 4397.5 4398.6 3538.7 3958.9 3971.5 3976.1 4087.5 3572.9 3597.1 3613.7 3703.4 3716.8 1185.2 1197.4 1220.7 1223.5 1228.9 769.7 869.7 869.7 884.9 901.0 5189.9 5218.5 5229.5 5247.9 5279.4 364.8 368.8 369.3 372.2 918.4 3489.2 3564.4 3642.5 3650.7 3683.8 9330.7 9472.7 9492.3 9581.0 9641.5 9401.7 9427.1 9464.1 9504.2 9512.5 7067.6 7087.0 7124.1 7182.4 7194.9 5312.0 5411.4 5516.3 5537.3 5608.0 8350.0 8652.7 8657.7 8786.0 8958.6 8792.8 8905.6 8910.6 9079.2 9087.8 5783.2 6339.4 6566.5 6623.4 6801.3 7456.1 7470.3 7534.4 7535.2 7544.0 6398.8 6672.3 6727.5 6755.0 6866.1 6603.4 6695.1 6712.1 6743.3 6829.2 6190.9 6259.6 6320.9 6326.8 6347.3 4496.2 4543.8 4555.1 4578.4 4592.4 4265.4 4312.4 4356.9 4513.3 4529.3 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | [#4] prototype.html Cycles:180 Average:4400.95 Median:5028.21 stddev:1289.14 (25.6%) stddev-sans-first:1255.43 21:28:14 INFO - PROCESS | 3459 | Values: 297.8 298.9 299.5 300.3 302.9 5089.7 5120.0 5126.7 5149.9 5156.7 5003.6 5012.1 5026.7 5027.8 5028.6 3718.8 3831.9 3932.3 3939.8 3950.4 3918.5 3974.8 3976.5 3977.3 3983.2 3914.0 3917.4 3917.4 3940.2 3941.7 3811.4 3914.5 3922.3 3945.4 3961.7 3446.6 3464.9 3469.8 3471.6 3472.8 4795.6 4815.8 4823.6 4835.5 4860.6 4401.2 4490.5 4507.8 4525.0 4533.3 5245.1 5251.4 5262.8 5266.5 5294.0 3791.4 3799.2 3801.8 3802.5 3806.0 5412.4 5533.4 5541.1 5549.8 5576.0 3833.9 3870.6 3889.6 3894.2 3906.6 3920.6 3931.4 3963.8 3964.0 3965.2 4483.3 4491.0 4491.7 4504.2 4512.6 4981.3 5287.3 5289.3 5332.2 5354.3 1307.5 1336.4 1338.8 1339.5 1343.7 816.8 835.5 841.5 858.8 864.3 4508.6 4600.5 4627.9 4637.8 4650.7 5481.7 5486.0 5491.8 5511.0 5526.1 4488.5 4690.8 4696.3 4702.7 4710.4 2902.0 2906.6 2912.3 2931.0 2937.2 5056.3 5095.7 5129.5 5148.8 5158.3 5506.3 5637.0 5643.4 5676.2 5692.9 5116.3 5128.4 5166.7 5202.0 5202.5 5425.5 5434.6 5460.5 5460.9 5507.4 5153.8 5362.4 5432.8 5437.9 5461.2 5141.8 5171.4 5187.2 5200.6 5239.4 3780.2 3793.0 3800.5 3801.2 3801.8 5224.8 5477.1 5500.8 5507.8 5527.3 5310.7 5312.9 5328.2 5329.9 5333.3 5287.7 5291.5 5292.5 5303.5 5324.6 4935.3 5250.9 5258.1 5259.6 5286.9 5113.4 5248.0 5299.0 5321.2 5348.4 5214.5 5257.2 5259.2 5261.5 5262.6 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - PROCESS | 3459 | [#5] yui.html Cycles:180 Average:16345.77 Median:25195.79 stddev:22744.89 (90.3%) stddev-sans-first:22777.75 21:28:14 INFO - PROCESS | 3459 | Values: 543.2 544.5 631.9 657.5 700.6 12011.9 12813.6 13002.5 13137.1 13143.7 12658.4 12962.9 13199.3 13237.9 13799.2 787.2 790.8 790.9 792.6 793.1 629.9 765.7 791.5 798.7 804.5 670.4 675.4 677.0 680.9 682.4 674.5 675.6 676.4 677.1 678.0 486.6 486.6 488.2 489.7 492.0 12834.9 12840.0 12845.2 12849.2 12887.2 12453.0 12926.8 12938.5 13065.2 13360.9 10301.1 10438.7 10476.0 10662.1 10665.0 3242.5 3246.6 3279.3 3311.2 3337.9 57164.0 57800.4 58689.4 58867.7 59084.1 9158.1 9271.8 9315.1 9459.0 9523.4 18146.1 18159.0 18167.4 18238.9 18272.8 6376.4 6509.7 6810.2 6861.5 6927.5 3438.4 3523.8 3587.1 3588.4 3656.6 2913.2 3047.1 3063.0 3066.9 3067.5 487.2 508.6 515.2 516.9 522.3 544.3 601.5 604.5 611.0 611.8 7393.5 7617.4 7691.7 7755.1 7842.2 398.2 464.2 511.1 541.3 547.3 3569.9 3592.9 3776.3 3869.1 3879.7 88436.9 89928.6 91331.5 93847.5 93990.5 49318.0 49883.0 57766.4 68062.0 78259.2 72204.3 73234.6 73248.3 73567.6 73905.6 7863.5 7883.3 8256.1 8269.2 8317.6 31009.2 31664.5 40958.0 41599.6 43375.8 55836.2 57504.7 59739.0 60568.4 60974.0 10640.5 10992.3 11071.4 11073.1 11246.8 12445.8 12687.8 12710.2 12782.7 12843.8 10808.1 11188.8 11818.2 12186.5 12197.4 10268.3 10326.3 10634.2 10676.6 11254.9 10684.3 11613.9 11824.4 11870.2 11886.4 9150.4 9688.4 9954.3 9982.6 10013.9 9043.2 9270.0 9293.5 9299.4 9317.6 21:28:14 INFO - PROCESS | 3459 | -------- Summary: end -------- 21:28:14 INFO - PROCESS | 3459 | 21:28:14 INFO - TEST-INFO | 3459: exit 0 21:28:15 INFO - TEST-OK | dromaeo_css | took 1115454ms 21:28:15 INFO - TEST-START | kraken 21:28:15 INFO - operating with platform_type : linux_ 21:28:15 INFO - Initialising browser for kraken test... 21:28:15 INFO - TEST-INFO | started process 3694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpugFePR/profile http://localhost:37364/getInfo.html) 21:28:19 INFO - PROCESS | 3694 | __metrics Screen width/height:1600/1200 21:28:19 INFO - PROCESS | 3694 | colorDepth:24 21:28:19 INFO - PROCESS | 3694 | Browser inner width/height: 1024/697 21:28:19 INFO - PROCESS | 3694 | __metrics 21:28:20 ERROR - PROCESS | 3694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 21:28:21 INFO - TEST-INFO | 3694: exit 0 21:28:21 INFO - Browser initialized. 21:28:21 INFO - Running cycle 1/1 for kraken test... 21:28:21 INFO - TEST-INFO | started process 3812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpugFePR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:28:33 INFO - PROCESS | 3812 | RSS: Main: 168128512 21:28:33 INFO - PROCESS | 3812 | 21:28:36 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37364/tests/kraken/driver.html?testName=audio-beat-detection) 21:28:37 INFO - PROCESS | 3812 | RSS: Main: 172564480 21:28:37 INFO - PROCESS | 3812 | 21:28:39 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37364/tests/kraken/driver.html?testName=audio-dft) 21:28:40 INFO - PROCESS | 3812 | RSS: Main: 172449792 21:28:40 INFO - PROCESS | 3812 | 21:28:43 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37364/tests/kraken/driver.html?testName=audio-fft) 21:28:44 INFO - PROCESS | 3812 | RSS: Main: 167776256 21:28:44 INFO - PROCESS | 3812 | 21:28:46 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37364/tests/kraken/driver.html?testName=audio-oscillator) 21:28:46 INFO - PROCESS | 3812 | RSS: Main: 167972864 21:28:46 INFO - PROCESS | 3812 | 21:28:49 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37364/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:28:49 INFO - PROCESS | 3812 | RSS: Main: 168599552 21:28:49 INFO - PROCESS | 3812 | 21:28:52 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37364/tests/kraken/driver.html?testName=imaging-darkroom) 21:28:53 INFO - PROCESS | 3812 | RSS: Main: 169074688 21:28:53 INFO - PROCESS | 3812 | 21:28:57 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37364/tests/kraken/driver.html?testName=imaging-desaturate) 21:28:57 INFO - PROCESS | 3812 | RSS: Main: 166047744 21:28:57 INFO - PROCESS | 3812 | 21:29:00 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37364/tests/kraken/driver.html?testName=json-parse-financial) 21:29:01 INFO - PROCESS | 3812 | RSS: Main: 167911424 21:29:01 INFO - PROCESS | 3812 | 21:29:02 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37364/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:29:03 INFO - PROCESS | 3812 | RSS: Main: 168321024 21:29:03 INFO - PROCESS | 3812 | 21:29:05 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:29:06 INFO - PROCESS | 3812 | RSS: Main: 168337408 21:29:06 INFO - PROCESS | 3812 | 21:29:08 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:29:09 INFO - PROCESS | 3812 | RSS: Main: 169046016 21:29:09 INFO - PROCESS | 3812 | 21:29:12 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:29:12 INFO - PROCESS | 3812 | RSS: Main: 168935424 21:29:12 INFO - PROCESS | 3812 | 21:29:15 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:29:16 INFO - PROCESS | 3812 | RSS: Main: 168734720 21:29:16 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:37364/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37364/tests/kraken/driver.html?testName=ai-astar) 21:29:18 INFO - PROCESS | 3812 | RSS: Main: 169451520 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | __start_tp_report 21:29:18 INFO - PROCESS | 3812 | _x_x_mozilla_page_load 21:29:18 INFO - PROCESS | 3812 | _x_x_mozilla_page_load_details 21:29:18 INFO - PROCESS | 3812 | |i|pagename|runs| 21:29:18 INFO - PROCESS | 3812 | |0;ai-astar;117;110;114;114;118;115;116;116;116;116 21:29:18 INFO - PROCESS | 3812 | |1;audio-beat-detection;163;132;160;188;140;163;159;132;194;136 21:29:18 INFO - PROCESS | 3812 | |2;audio-dft;164;170;166;173;162;162;162;162;162;161 21:29:18 INFO - PROCESS | 3812 | |3;audio-fft;76;76;76;164;76;76;76;74;157;77 21:29:18 INFO - PROCESS | 3812 | |4;audio-oscillator;86;87;137;87;87;87;144;87;86;133 21:29:18 INFO - PROCESS | 3812 | |5;imaging-gaussian-blur;118;119;118;119;118;118;118;118;119;117 21:29:18 INFO - PROCESS | 3812 | |6;imaging-darkroom;148;148;148;148;147;148;149;147;147;146 21:29:18 INFO - PROCESS | 3812 | |7;imaging-desaturate;95;96;97;96;95;96;96;95;95;95 21:29:18 INFO - PROCESS | 3812 | |8;json-parse-financial;65;63;63;62;63;63;64;65;63;66 21:29:18 INFO - PROCESS | 3812 | |9;json-stringify-tinderbox;65;66;67;65;66;66;65;64;65;66 21:29:18 INFO - PROCESS | 3812 | |10;stanford-crypto-aes;85;86;84;85;91;88;86;85;118;84 21:29:18 INFO - PROCESS | 3812 | |11;stanford-crypto-ccm;140;132;139;134;130;139;132;143;157;140 21:29:18 INFO - PROCESS | 3812 | |12;stanford-crypto-pbkdf2;170;176;172;168;176;173;173;178;173;172 21:29:18 INFO - PROCESS | 3812 | |13;stanford-crypto-sha256-iterative;72;70;69;68;70;73;68;69;74;68 21:29:18 INFO - PROCESS | 3812 | __end_tp_report 21:29:18 INFO - PROCESS | 3812 | __start_cc_report 21:29:18 INFO - PROCESS | 3812 | _x_x_mozilla_cycle_collect,971 21:29:18 INFO - PROCESS | 3812 | __end_cc_report 21:29:18 INFO - PROCESS | 3812 | __startTimestamp1465360158284__endTimestamp 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | ------- Summary: start ------- 21:29:18 INFO - PROCESS | 3812 | Number of tests: 14 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:2.20 (1.9%) stddev-sans-first:2.24 21:29:18 INFO - PROCESS | 3812 | Values: 117.0 110.0 114.0 114.0 118.0 115.0 116.0 116.0 116.0 116.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#1] audio-beat-detection Cycles:10 Average:156.70 Median:161.50 stddev:22.10 (13.7%) stddev-sans-first:23.32 21:29:18 INFO - PROCESS | 3812 | Values: 163.0 132.0 160.0 188.0 140.0 163.0 159.0 132.0 194.0 136.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:4.06 (2.5%) stddev-sans-first:4.30 21:29:18 INFO - PROCESS | 3812 | Values: 164.0 170.0 166.0 173.0 162.0 162.0 162.0 162.0 162.0 161.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#3] audio-fft Cycles:10 Average:92.80 Median:76.00 stddev:35.73 (47.0%) stddev-sans-first:37.37 21:29:18 INFO - PROCESS | 3812 | Values: 76.0 76.0 76.0 164.0 76.0 76.0 76.0 74.0 157.0 77.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:87.00 stddev:24.92 (28.6%) stddev-sans-first:25.74 21:29:18 INFO - PROCESS | 3812 | Values: 86.0 87.0 137.0 87.0 87.0 87.0 144.0 87.0 86.0 133.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 21:29:18 INFO - PROCESS | 3812 | Values: 118.0 119.0 118.0 119.0 118.0 118.0 118.0 118.0 119.0 117.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 21:29:18 INFO - PROCESS | 3812 | Values: 148.0 148.0 148.0 148.0 147.0 148.0 149.0 147.0 147.0 146.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 21:29:18 INFO - PROCESS | 3812 | Values: 95.0 96.0 97.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.50 stddev:1.25 (2.0%) stddev-sans-first:1.24 21:29:18 INFO - PROCESS | 3812 | Values: 65.0 63.0 63.0 62.0 63.0 63.0 64.0 65.0 63.0 66.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 21:29:18 INFO - PROCESS | 3812 | Values: 65.0 66.0 67.0 65.0 66.0 66.0 65.0 64.0 65.0 66.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:85.50 stddev:10.34 (12.1%) stddev-sans-first:10.85 21:29:18 INFO - PROCESS | 3812 | Values: 85.0 86.0 84.0 85.0 91.0 88.0 86.0 85.0 118.0 84.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:139.50 stddev:7.78 (5.6%) stddev-sans-first:8.23 21:29:18 INFO - PROCESS | 3812 | Values: 140.0 132.0 139.0 134.0 130.0 139.0 132.0 143.0 157.0 140.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.00 stddev:2.96 (1.7%) stddev-sans-first:2.92 21:29:18 INFO - PROCESS | 3812 | Values: 170.0 176.0 172.0 168.0 176.0 173.0 173.0 178.0 173.0 172.0 21:29:18 INFO - PROCESS | 3812 | 21:29:18 INFO - PROCESS | 3812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.18 (3.1%) stddev-sans-first:2.20 21:29:18 INFO - PROCESS | 3812 | Values: 72.0 70.0 69.0 68.0 70.0 73.0 68.0 69.0 74.0 68.0 21:29:18 INFO - PROCESS | 3812 | -------- Summary: end -------- 21:29:18 INFO - PROCESS | 3812 | 21:29:19 INFO - TEST-INFO | 3812: exit 0 21:29:19 INFO - TEST-OK | kraken | took 64329ms 21:29:19 INFO - SUITE-END | took 1179s 21:29:19 INFO - Completed test suite (00:19:39) 21:29:19 INFO - javascript benchmark 21:29:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6400.021545869316, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2645.9073932412343, 2650.390410205653, 2682.825616334938, 2685.905993290235, 2700.8109432339734, 4696.6477514186445, 4728.101660684468, 4744.525547445258, 4764.356811830402, 4794.304825800257, 4633.1660301145785, 4677.929831052537, 4692.741899195551, 4700.059988002405, 4785.377900872891, 4320.4599425071865, 4362.563743625644, 4382.517923028464, 4387.319965405367, 4453.354263631772, 271.35138925977174, 4336.262835318003, 4464.419625448687, 4474.440694913136, 4513.390692256553, 4362.585554372329, 4380.299152135659, 4387.122575484884, 4393.824247030115, 4401.251787196168, 4427.158839820424, 4453.465584129893, 4462.933056004163, 4479.888002799924, 4511.593956543927, 4319.1361727654285, 4387.692861499696, 4441.933370999438, 4444.755538445384, 4496.595306422405, 4684.414448193976, 4713.434387873477, 4726.2201736713405, 4756.571908528249, 4759.857204283877, 5126.820561280338, 5135.35808023997, 5156.149235376159, 5159.638825282232, 5168.870778230536, 4940.975295123501, 5088.592912566985, 5119.385673719177, 5138.997895410396, 5245.029669511115, 4803.615710743132, 4807.543283388072, 4817.108834865561, 4827.61379089672, 4854.635902307341, 5290.127129023745, 5291.444398338119, 5299.49654782795, 5307.283516725192, 5325.174597937248, 4885.218365061573, 5018.548330650186, 5062.265971434122, 5083.186690129562, 5094.6943183408375, 5133.922991155136, 5167.586593072545, 5168.431472538018, 5169.689818610896, 5230.241614965808, 4896.975515122402, 5122.769475373617, 5143.996920600447, 5145.562627176657, 5146.30524879144, 4899.534544218293, 5092.796288148506, 5133.435322114565, 5148.9742551287, 5149.0, 4306.138772245501, 4351.695381323277, 4392.516823149451, 4394.758288294111, 4438.245498265303, 3752.249550089993, 3830.272248272819, 3832.7125465589634, 3858.6334298241622, 3865.130345672201, 4392.099619577979, 4419.248727716296, 4419.64642828573, 4423.071155057474, 4431.711938723973, 5113.923291150636, 5114.64197506171, 5114.769835357418, 5123.103456895103, 5125.026245013435, 4316.309390497506, 4365.541618130051, 4399.494058183286, 4445.866624001285, 4449.310356894686, 4557.5442455754155, 4576.405067341224, 4601.171789077998, 4608.28571571407, 4626.028534007829, 4771.6898401603785, 4790.0, 4794.856154315376, 4824.204006338915, 4888.7311197884455, 4992.950070499393, 5162.664426812245, 5165.845024649117, 5169.250458683545, 5224.947750522446, 4760.547747963938, 4772.045590881907, 4789.904201915872, 4798.448178459382, 4799.784009719641, 4977.0, 5025.623078269217, 5044.747762611928, 5058.089543882136, 5081.618878584047, 4954.677945933503, 5046.21783623539, 5163.27714120031, 5167.095758242217, 5213.244079608511, 4940.851774446773, 4947.40631124253, 4966.826161084345, 4972.154733695353, 5016.698998060128, 4930.852074437773, 4932.901341973069, 4942.159832828356, 4960.528749768766, 5001.42483614389, 4695.413073365829, 4709.340692303149, 4716.740579268173, 4825.420949485943, 4874.731889745956, 4925.458199598113, 4944.159492886146, 4944.92582611254, 4974.278729584263, 4992.925106123338, 4842.0, 4859.684120532154, 4861.635377346643, 4862.724889877753, 4896.902061958812], "value": 4661.5339719485655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.4389627513462, 562.4291344285551, 562.5021855657742, 574.494444888498, 587.04018929051, 40030.0, 41083.79458102709, 41392.37911431327, 41743.58256417435, 45506.31740523895, 41421.792891035504, 41736.0, 41878.58121418785, 42108.0, 42257.0, 7669.079710434742, 7806.60966951653, 7856.292933635971, 7916.168802275735, 7918.485298455611, 7834.686612535492, 7839.804004899866, 7856.4893281936775, 7915.327197188246, 7935.087464941548, 7936.761897143095, 7962.482438641469, 7995.320397766197, 8001.479903806234, 8020.238077382639, 7870.881936770953, 7872.409569282327, 7914.485558438741, 7920.445568810214, 7938.44430889838, 7797.181295963899, 7816.648250828726, 7826.256505631955, 7834.942282791807, 7865.882011769828, 37733.24533509315, 38146.0, 38237.0, 38359.0, 38360.0, 3009.9097027089, 3161.5099659552807, 3621.6559426854406, 3633.8728144514816, 3743.906402339936, 26968.0, 29708.55437168444, 29792.70207297921, 29800.0, 29916.850415748, 3302.2239773653173, 3355.781874178195, 3438.7592868499214, 3484.5992710838073, 3490.3542844573835, 263573.0, 265852.0, 266555.66722166457, 266808.33191668225, 267160.0, 32451.675483244864, 33227.0, 33483.0, 35131.297374052374, 55093.44906550963, 34477.0, 34490.0, 34513.0, 34658.48012279818, 34709.0, 14039.578812635433, 14137.0, 14256.572302830931, 14270.3578338975, 14349.56951291442, 11123.110151187886, 11217.439128043565, 11284.774304513863, 11295.03992160659, 11341.829872551918, 7824.726134585262, 7859.882101768478, 7898.249666281694, 7905.051393832777, 7973.521588704696, 3061.663217046123, 3080.476319025771, 3107.368631468497, 3114.6573876873526, 3129.358481511285, 881.6341218394423, 891.5675897189858, 899.604174163366, 988.4859872866069, 989.6288891665625, 27888.302792430353, 27938.066503017297, 28568.0, 28637.856810715813, 29054.564181537295, 910.6630546697631, 977.4379731654185, 981.7692842182081, 1030.1810061001522, 1052.3054783842626, 14447.711045779026, 14603.78094328586, 14695.338709758087, 14751.704965900837, 14792.556223313319, 403894.0, 407776.0, 408746.0, 408973.0, 411231.0, 49569.50430495721, 50360.74819625952, 50935.745321273156, 50963.0, 50984.74507627438, 1195.0977012355615, 1206.8551773787026, 1220.2941727747113, 1220.9328486933305, 1229.6987238126717, 26461.33846653849, 27196.864015679796, 27515.44969100647, 27856.0, 27877.16368508948, 37674.246515070095, 37791.0, 37846.62153378431, 37908.81045594755, 37973.24053518859, 343006.0, 345304.0, 345315.0, 345781.0, 346763.0, 25201.621975670012, 25683.486330273663, 26020.21939341823, 26048.8697556511, 26132.60801087947, 41230.587694122674, 41715.37426938659, 42101.36847947344, 42681.35977960271, 42923.5707642932, 36184.63815361918, 36997.81501092477, 37433.06417339479, 37565.62434375731, 38138.42792358172, 36269.45595816012, 36882.26235475329, 38260.234795304495, 40127.1974560513, 40364.3945340826, 35357.0, 35764.0, 36246.818765906, 36653.08367290839, 36886.07784805401, 30283.697163028086, 32638.673613263563, 33048.834755826065, 33120.1719957003, 33226.50160247646, 24684.38289042788, 25285.367865803502, 25395.36511587225, 25412.491750165264, 25479.10823121182], "value": 16605.829409416976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.63555127097266, 362.79683377308703, 376.570709391294, 386.7447484660125, 391.3894324853229, 15798.68402631948, 17023.23395447205, 17904.731429028576, 17979.550511237227, 17983.910080449612, 10838.566457341696, 15680.451184208556, 16545.42091026814, 16580.66838663226, 17412.738808917846, 4532.864014079574, 4675.696079754805, 4710.152172608929, 4712.104700106968, 4716.410448693913, 3460.4117300058924, 5061.19020956647, 5374.5700343972385, 5376.38171610264, 5405.945940540583, 5220.608454365919, 5380.677159370431, 5380.7309634518115, 5381.139017757159, 5393.487618676219, 5048.419431765357, 5374.5700343972385, 5399.406065332811, 5450.400455949843, 5464.098423760075, 5053.242013697938, 5248.632595718302, 5425.3489581250105, 5435.891282174374, 5459.563234941234, 11868.703282417922, 11969.0, 11996.70008249792, 12015.879841201564, 21248.893755531277, 1959.6178745144703, 1994.2920263306607, 2134.6691262854283, 2211.9115235390564, 2548.929449631141, 13552.932235338858, 13848.653783655389, 13939.512117075854, 14007.439702411892, 14237.43050277998, 1897.1747289928926, 1913.062599326334, 1915.5785727140008, 1938.1569017477443, 1952.0825212150266, 78411.6079419605, 79931.20068799295, 80895.0, 81009.78485322725, 81265.59367203186, 16199.514014579581, 16855.83144168567, 16945.66108677844, 16962.0, 17209.483715488554, 28903.56644650332, 28965.275868103465, 29001.0, 29227.0, 29309.12072637824, 8925.152110549487, 9211.539423028822, 9235.815283694288, 9343.34596578233, 9417.576209070472, 7673.961630191813, 7708.190639982833, 7735.535867847947, 7831.412644051719, 7929.088154862149, 8349.206825351583, 8551.486910785372, 8588.8527868033, 8709.869351959725, 8760.4305720128, 1523.6267114557004, 1548.9380424783108, 1563.5934656989264, 1599.8480144386265, 3359.7816141950693, 847.3560094328354, 874.9912500875037, 881.2113158722907, 911.1708345405649, 925.1950802801471, 16212.027278363335, 16236.0, 16240.59398515023, 16794.16029198535, 16879.578010549834, 829.601791140244, 859.1022381611107, 859.5014891362995, 860.1699360117517, 881.3081730841387, 9202.493862837475, 9527.809443811086, 9706.563204655808, 9743.31796774219, 9873.111419972238, 388797.0, 392159.0, 394273.0, 399528.0, 403921.0, 47814.760926195144, 48627.0, 56471.71764141153, 76023.0, 76152.61923690345, 855.6705668317743, 862.5342315149875, 870.0994470722771, 874.9300055995506, 878.2315473960285, 9008.684696035607, 9082.228010619172, 14413.495527656481, 14732.26338683083, 15735.606609834846, 34834.82582587071, 35391.82304088463, 36226.09434764152, 36299.81850090733, 36428.63571364358, 43521.0, 48737.0, 50791.23813142732, 50925.74537127439, 51431.22853157131, 11274.661760147208, 11770.646880593597, 11800.288958101199, 11876.228045177037, 11987.76024479523, 8925.553722313989, 12377.195482293622, 12573.0, 12810.103292769789, 12965.481380745043, 10989.725256868642, 11212.27120237182, 11236.438178091226, 11286.363477295581, 11388.544458221579, 10617.787644247226, 10845.674629761119, 11173.0, 11398.20212585111, 11429.59996400122, 11451.770964580828, 11501.252418592765, 11526.538938442369, 11580.6525804226, 11781.0, 11713.765724685629, 11772.587959421378, 11792.76414471723, 11861.762764744484, 11870.703232419259, 11315.0, 11341.886581134084, 11511.19421640477, 11597.304161750322, 11653.417329133339], "value": 8973.985044391315, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.8854297384726, 1409.4291811816215, 1474.9336279867405, 1693.2549678141618, 1695.5252529291802, 6444.420002199801, 7365.668544915478, 7391.852162956738, 7853.842923141541, 7901.525908445497, 7504.737334193304, 7726.8454630907345, 7779.183185765498, 7788.0, 7810.531368117917, 2132.4135862637745, 2174.608570457317, 2181.9345419637434, 2187.57342318248, 2192.177933275022, 2131.381899249216, 2149.2047942261306, 2181.869087854726, 2183.792539708733, 2191.923282685106, 2160.2223199648115, 2165.8267338612873, 2172.4894649757375, 2175.0973346061364, 2178.8256939444886, 2088.592724418739, 2092.6337890869113, 2093.0581238442687, 2093.1418118571387, 2094.6857971304275, 2088.749350077985, 2094.5810837832496, 2113.8097571218664, 2116.8941552922292, 2142.3572928121503, 7677.0403699537555, 7722.652480638385, 7765.7670269892, 7767.300942915164, 7771.145174030852, 4293.828246870122, 4362.236608593484, 4365.039691267916, 4390.648748100176, 4396.076823866992, 2763.474939761459, 2813.8171018883913, 2883.0774152271283, 2888.581155732428, 2893.2477555835426, 857.4940784936917, 877.4472082587993, 904.8959369672506, 937.6390089815402, 950.097407462913, 9849.655262065793, 9873.506324683809, 9879.654212102614, 9953.25350598708, 9965.601375945025, 3957.584453632385, 3989.7805620691142, 4078.1028173801715, 4097.590240975938, 4114.979425102915, 8474.5339006354, 8497.74506764798, 8511.446755960842, 8527.829443411098, 8531.189536993976, 4338.34924761282, 4364.214441400515, 4391.890202744893, 4397.450318710161, 4398.582134697199, 3538.6815186633326, 3958.9010274743364, 3971.4638523798917, 3976.1053762903116, 4087.46862907826, 3572.8928132156075, 3597.136687195107, 3613.747037707335, 3703.370427027412, 3716.7955762433326, 1185.1644590563633, 1197.3653963399413, 1220.6704189868863, 1223.498365670071, 1228.9262644241373, 769.6536558548676, 869.6738722978882, 869.7086476030474, 884.8982367027745, 900.9549522523847, 5189.896202075937, 5218.530332270114, 5229.50319719626, 5247.924175544004, 5279.44565820591, 364.75014614988817, 368.8211217559481, 369.33335329729556, 372.17006076449667, 918.3892711347013, 3489.1626009757983, 3564.4475106358555, 3642.4718415829557, 3650.7079433645245, 3683.778973261613, 9330.673426430043, 9472.715818525456, 9492.335536512515, 9580.952095239618, 9641.517924103768, 9401.670941517013, 9427.057294270518, 9464.0598677271, 9504.192143667866, 9512.524373781283, 7067.6112813795735, 7086.999999999897, 7124.145102587722, 7182.42540596751, 7194.928050719531, 5312.043832110257, 5411.402526787243, 5516.282883225155, 5537.335519737496, 5608.0, 8349.95825020871, 8652.697155599524, 8657.653693852175, 8786.0, 8958.596863141043, 8792.824143517222, 8905.599248033983, 8910.599023044108, 9079.228265597498, 9087.772805679911, 5783.219265399117, 6339.397757213057, 6566.474682025522, 6623.403893649402, 6801.2858649841055, 7456.067991501062, 7470.3276705096805, 7534.39724822002, 7535.208803075599, 7544.0, 6398.808035758934, 6672.299408562031, 6727.495437842279, 6754.966225168842, 6866.141732283465, 6603.405693487609, 6695.09616201826, 6712.060311556288, 6743.258241593323, 6829.248782634006, 6190.938090619036, 6259.624422534663, 6320.905186422299, 6326.810195694136, 6347.333529979285, 4496.190685676479, 4543.7955292011275, 4555.088982203506, 4578.40480737502, 4592.402987611589, 4265.360195970629, 4312.353147027971, 4356.869293921188, 4513.277875539898, 4529.297958816389], "value": 4008.604607628417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.8138663335415, 298.91032690192964, 299.4923604490388, 300.3032963524622, 302.9288117292436, 5089.66917150385, 5120.0, 5126.71803050832, 5149.922751158736, 5156.664816786911, 5003.599712023039, 5012.147934851075, 5026.673266237701, 5027.8324655467095, 5028.5919942416185, 3718.814059297038, 3831.865884694036, 3932.3315036443873, 3939.8227079781477, 3950.3803440589363, 3918.4710064141404, 3974.801259937006, 3976.5228172619327, 3977.34373828318, 3983.243183795084, 3913.9608603914025, 3917.373220284755, 3917.412388141773, 3940.2316548273097, 3941.664958478518, 3811.4402684364163, 3914.5498267699295, 3922.293987082324, 3945.408188771693, 3961.722679412428, 3446.5691788526433, 3464.8960531184107, 3469.826508674556, 3471.6181220065773, 3472.774269672463, 4795.592374648159, 4815.807367705288, 4823.614110871122, 4835.540623640749, 4860.635452341088, 4401.185780630593, 4490.483594386622, 4507.819687212507, 4525.031611249117, 4533.2746760518485, 5245.10833158364, 5251.396089449724, 5262.842114736564, 5266.526012658841, 5293.973530132324, 3791.3933770596573, 3799.2211596622624, 3801.8099095045413, 3802.505674262356, 3806.001849029282, 5412.377576578665, 5533.418991005927, 5541.141123125922, 5549.750261238254, 5575.992642648644, 3833.9424908625833, 3870.6322899325082, 3889.572147063821, 3894.2211557688574, 3906.55074666417, 3920.6079392060565, 3931.4495970564144, 3963.8018099095507, 3964.0, 3965.167314863911, 4483.30508771141, 4491.034427598082, 4491.685582009293, 4504.211762941472, 4512.616427603691, 4981.302617633534, 5287.312649355559, 5289.312389389432, 5332.200169974535, 5354.250404943311, 1307.5162189989574, 1336.3852627791325, 1338.7857942729117, 1339.5311640925597, 1343.6909510812372, 816.7753867686315, 835.4903508859591, 841.4698739794013, 858.772425307294, 864.321507616518, 4508.616767574727, 4600.470945841204, 4627.866172787689, 4637.837675681335, 4650.651201159859, 5481.671099734029, 5485.9725701371235, 5491.835244942658, 5510.972445137749, 5526.115821468546, 4488.4613846338, 4690.7654617269, 4696.272077827942, 4702.741349225826, 4710.411198600175, 2901.9698007207558, 2906.5640153977074, 2912.3010477485673, 2930.9888088609396, 2937.1775902747263, 5056.26684130799, 5095.694258344512, 5129.487051294841, 5148.786022010497, 5158.317674809154, 5506.339239291311, 5636.971815140898, 5643.351014633287, 5676.205331253545, 5692.943070569241, 5116.283720279164, 5128.435872053997, 5166.689998600096, 5202.0, 5202.505761952609, 5425.511703946664, 5434.5652347812875, 5460.542755759844, 5460.890782184413, 5507.421720719267, 5153.793848246029, 5362.3833259174135, 5432.837014889559, 5437.891242175056, 5461.235427040297, 5141.794328226829, 5171.431142574389, 5187.170052791686, 5200.60995425337, 5239.449857765032, 3780.2061567070123, 3793.013816407699, 3800.467934489229, 3801.201747633028, 3801.847926082926, 5224.843254702365, 5477.110396913059, 5500.834974950758, 5507.752151153288, 5527.281453411031, 5310.725425897834, 5312.946870531246, 5328.227407026037, 5329.920051199158, 5333.333333333333, 5287.651648829524, 5291.523762861361, 5292.470752924677, 5303.4696530346655, 5324.600654950972, 4935.259711043373, 5250.873396274515, 5258.106121959353, 5259.606204355925, 5286.867828304169, 5113.386393632788, 5247.9737601311745, 5299.0, 5321.243989483539, 5348.358197016383, 5214.530692237717, 5257.211418287287, 5259.15853463444, 5261.526772503705, 5262.631615786858], "value": 3982.2958482596564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2123421039494, 544.4800215793915, 631.9462845658119, 657.5101549345738, 700.639170827024, 12011.939940300286, 12813.615591532258, 13002.479900803957, 13137.146085504435, 13143.737125257501, 12658.367081645903, 12962.935185324084, 13199.274039927801, 13237.867621323783, 13799.172049677027, 787.2363807107125, 790.8497385496737, 790.9011373578303, 792.5759718550577, 793.1473665809249, 629.9149614802012, 765.6860687118283, 791.5053091817614, 798.66456088443, 804.505229283992, 670.4468813229081, 675.4292622733782, 676.9796906092826, 680.8944613584903, 682.4199430484074, 674.507609445103, 675.6419097878132, 676.3980057748607, 677.069030083635, 677.976270830521, 486.56695540968565, 486.57424753340825, 488.15549100056745, 489.7233063319213, 491.9901601967941, 12834.935825320814, 12840.0, 12845.229286242855, 12849.229046257162, 12887.226766394046, 12453.0, 12926.797659279633, 12938.547150849676, 13065.150765200327, 13360.933195334059, 10301.124404425633, 10438.739031524197, 10476.0, 10662.147028237723, 10665.0, 3242.4812030075077, 3246.642869284377, 3279.2949515853966, 3311.172206948263, 3337.8998630041137, 57164.0, 57800.42199577992, 58689.41310586882, 58867.70566147142, 59084.11373829396, 9158.129977652112, 9271.814563708687, 9315.115064068903, 9458.95270523643, 9523.380980236263, 18146.09269536518, 18159.0, 18167.36414225496, 18238.908805456154, 18272.817271827378, 6376.39424254695, 6509.674516274262, 6810.216825065181, 6861.451083913275, 6927.480438967098, 3438.432658611351, 3523.823808809549, 3587.0673624857723, 3588.4258518636893, 3656.597774244831, 2913.1988703106817, 3047.131567503251, 3063.0198336532094, 3066.861991210401, 3067.539869019665, 487.18153502116786, 508.58296197118005, 515.2142981952477, 516.9041631740733, 522.27143135326, 544.2679595943449, 601.5456935702324, 604.4952464691944, 610.9908351374733, 611.788932818177, 7393.482456228013, 7617.428692848059, 7691.730789422343, 7755.1469338372735, 7842.215778422226, 398.1658425598367, 464.21315869600704, 511.1361798560421, 541.3287523470947, 547.3349879895945, 3569.9286014280087, 3592.8742494012586, 3776.2825063237897, 3869.071422858494, 3879.728419010642, 88436.92504599616, 89928.55035724779, 91331.54334228419, 93847.53076234712, 93990.53004734933, 49318.013639727, 49883.0, 57766.422335776944, 68062.0, 78259.21740782633, 72204.27795721976, 73234.63382683053, 73248.2675173252, 73567.63216183992, 73905.63047184837, 7863.488873223222, 7883.251091146332, 8256.050554186346, 8269.173082691683, 8317.584120794058, 31009.224769380042, 31664.525032125, 40958.0, 41599.58400415957, 43375.78312108419, 55836.16245756398, 57504.71247643735, 59739.0, 60568.39431605628, 60974.0, 10640.521176547229, 10992.28550144238, 11071.391073491035, 11073.114150868072, 11246.7750644985, 12445.75108497843, 12687.80968285458, 12710.173838700455, 12782.744345113231, 12843.807342890052, 10808.081313088476, 11188.83216751733, 11818.231814932002, 12186.51253949832, 12197.390130493617, 10268.281220314506, 10326.277160598685, 10634.202434817575, 10676.62631807883, 11254.88745112571, 10684.305520141166, 11613.883861161281, 11824.408779560816, 11870.228435151688, 11886.405679715806, 9150.40522366044, 9688.370255933623, 9954.253430992849, 9982.550785214538, 10013.949930250303, 9043.23132533742, 9269.953650231706, 9293.488858112869, 9299.373878803226, 9317.580708867981], "value": 6196.394680058877, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 114.0, 114.0, 118.0, 115.0, 116.0, 116.0, 116.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 132.0, 160.0, 188.0, 140.0, 163.0, 159.0, 132.0, 194.0, 136.0], "value": 156.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 166.0, 173.0, 162.0, 162.0, 162.0, 162.0, 162.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 164.0, 76.0, 76.0, 76.0, 74.0, 157.0, 77.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 137.0, 87.0, 87.0, 87.0, 144.0, 87.0, 86.0, 133.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 147.0, 147.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 62.0, 63.0, 63.0, 64.0, 65.0, 63.0, 66.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0, 64.0, 65.0, 66.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 85.0, 91.0, 88.0, 86.0, 85.0, 118.0, 84.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 139.0, 134.0, 130.0, 139.0, 132.0, 143.0, 157.0, 140.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 176.0, 172.0, 168.0, 176.0, 173.0, 173.0, 178.0, 173.0, 172.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 69.0, 68.0, 70.0, 73.0, 68.0, 69.0, 74.0, 68.0], "value": 70.1, "unit": "score"}]}]} 21:29:19 INFO - Return code: 0 21:29:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:29:19 ERROR - # TBPL SUCCESS # 21:29:19 INFO - Running post-action listener: _resource_record_post_action 21:29:19 INFO - ##### 21:29:19 INFO - ##### Finished run-tests step (success) 21:29:19 INFO - ##### 21:29:19 INFO - Running post-run listener: _resource_record_post_run 21:29:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 7700480; Write bytes: 419041280; Read time: 1236; Write time: 342064 21:29:19 INFO - TinderboxPrint: CPU usage
13.4% 21:29:19 INFO - TinderboxPrint: I/O read bytes / time
7,700,480 / 1,236 21:29:19 INFO - TinderboxPrint: I/O write bytes / time
419,041,280 / 342,064 21:29:19 INFO - TinderboxPrint: CPU idle
8,267.4 (86.6%) 21:29:19 INFO - TinderboxPrint: CPU user
1,228.5 (12.9%) 21:29:19 INFO - TinderboxPrint: Swap in / out
0 / 0 21:29:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 74604544; Read time: 0; Write time: 61796 21:29:19 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 5939200; Write bytes: 331984896; Read time: 1192; Write time: 262416 21:29:20 INFO - Running post-run listener: _upload_blobber_files 21:29:20 INFO - Blob upload gear active. 21:29:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:29:20 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 21:29:20 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'] 21:29:20 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 21:29:20 INFO - (blobuploader) - INFO - Open directory for files ... 21:29:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:29:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:29:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:21 INFO - (blobuploader) - INFO - Done attempting. 21:29:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:29:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:29:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:27 INFO - (blobuploader) - INFO - Done attempting. 21:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:29:28 INFO - (blobuploader) - INFO - Done attempting. 21:29:28 INFO - (blobuploader) - INFO - Iteration through files over. 21:29:28 INFO - Return code: 0 21:29:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:29:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:29:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccac276f6f427e5cbf68406917dbd0f2e62acdef5ebd430a522db5102c67b6e6b6e5d13a812378d74e39c243a4ab4c74a276026cc6eb10b0b886ad677de00e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea7e10b306e680f9abc66ddc903f5bbef8793553410d7cd3328a60eafbff82626f9fd508510c25eafdf90126f4f6d5a7e19ee4cec7f5bb5041192a6701609e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da2b8555f76c594531147fc65b009ec0d07c348611819163863bac1549c850c4c70fa734137006601c4a413a1600300c91fc28a838ed4a163bad6870750711b"} 21:29:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:29:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:29:28 INFO - Contents: 21:29:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccac276f6f427e5cbf68406917dbd0f2e62acdef5ebd430a522db5102c67b6e6b6e5d13a812378d74e39c243a4ab4c74a276026cc6eb10b0b886ad677de00e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea7e10b306e680f9abc66ddc903f5bbef8793553410d7cd3328a60eafbff82626f9fd508510c25eafdf90126f4f6d5a7e19ee4cec7f5bb5041192a6701609e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da2b8555f76c594531147fc65b009ec0d07c348611819163863bac1549c850c4c70fa734137006601c4a413a1600300c91fc28a838ed4a163bad6870750711b"} 21:29:28 INFO - Running post-run listener: copy_logs_to_upload_dir 21:29:28 INFO - Copying logs to upload dir... 21:29:28 INFO - mkdir: /builds/slave/test/build/upload/logs 21:29:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.501431 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-06-07 21:29:28.252108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 21:29:28.255960) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccac276f6f427e5cbf68406917dbd0f2e62acdef5ebd430a522db5102c67b6e6b6e5d13a812378d74e39c243a4ab4c74a276026cc6eb10b0b886ad677de00e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea7e10b306e680f9abc66ddc903f5bbef8793553410d7cd3328a60eafbff82626f9fd508510c25eafdf90126f4f6d5a7e19ee4cec7f5bb5041192a6701609e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da2b8555f76c594531147fc65b009ec0d07c348611819163863bac1549c850c4c70fa734137006601c4a413a1600300c91fc28a838ed4a163bad6870750711b"} build_url:https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/ORYRPJ_UQG27Nee3Q4cUiQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ccac276f6f427e5cbf68406917dbd0f2e62acdef5ebd430a522db5102c67b6e6b6e5d13a812378d74e39c243a4ab4c74a276026cc6eb10b0b886ad677de00e5f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ea7e10b306e680f9abc66ddc903f5bbef8793553410d7cd3328a60eafbff82626f9fd508510c25eafdf90126f4f6d5a7e19ee4cec7f5bb5041192a6701609e3b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6da2b8555f76c594531147fc65b009ec0d07c348611819163863bac1549c850c4c70fa734137006601c4a413a1600300c91fc28a838ed4a163bad6870750711b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 21:29:28.280561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:29:28.280883) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1465357964.361768-94297868 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 21:29:28.366437) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 21:29:28.366760) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 21:29:28.367041) ========= ========= Total master_lag: 0.16 =========