builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1465509122.75 results: success (0) buildid: 20160609113016 builduid: 8e4747667347419d9e7e78983d3bed2a revision: afc529c199066e9c9d8a88318f24f631a7678d53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.750863) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.751401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.751838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.773700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.774096) ========= 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=920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 14:52:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-09 14:52:03 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.864431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.864766) ========= 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=920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015485 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.915384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:02.915893) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev afc529c199066e9c9d8a88318f24f631a7678d53 --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 afc529c199066e9c9d8a88318f24f631a7678d53 --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=920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 14:52:03,559 truncating revision to first 12 chars 2016-06-09 14:52:03,559 Setting DEBUG logging. 2016-06-09 14:52:03,559 attempt 1/10 2016-06-09 14:52:03,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/afc529c19906?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 14:52:03,872 unpacking tar archive at: fx-team-afc529c19906/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637421 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:03.567413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:03.567743) ========= script_repo_revision: afc529c199066e9c9d8a88318f24f631a7678d53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:03.568195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:03.568633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:03.579166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 14:52:03.579749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:52:04 INFO - MultiFileLogger online at 20160609 14:52:04 in /builds/slave/test 14:52:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:52:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:52:04 INFO - {'append_to_log': False, 14:52:04 INFO - 'base_work_dir': '/builds/slave/test', 14:52:04 INFO - 'blob_upload_branch': 'Fx-Team', 14:52:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:52:04 INFO - 'branch': 'Fx-Team', 14:52:04 INFO - 'buildbot_json_path': 'buildprops.json', 14:52:04 INFO - 'config_files': ('talos/linux_config.py',), 14:52:04 INFO - 'default_actions': ('clobber', 14:52:04 INFO - 'read-buildbot-config', 14:52:04 INFO - 'download-and-extract', 14:52:04 INFO - 'populate-webroot', 14:52:04 INFO - 'create-virtualenv', 14:52:04 INFO - 'install', 14:52:04 INFO - 'run-tests'), 14:52:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:52:04 INFO - 'download_minidump_stackwalk': True, 14:52:04 INFO - 'download_symbols': 'ondemand', 14:52:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:52:04 INFO - 'tooltool.py': '/tools/tooltool.py', 14:52:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:52:04 INFO - '/tools/misc-python/virtualenv.py')}, 14:52:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:52:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:52:04 INFO - 'installer_path': 'installer.exe', 14:52:04 INFO - 'log_level': 'info', 14:52:04 INFO - 'log_name': 'talos', 14:52:04 INFO - 'log_to_console': True, 14:52:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:52:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:52:04 INFO - 'opt_config_files': (), 14:52:04 INFO - 'pip_index': False, 14:52:04 INFO - 'sps_profile': False, 14:52:04 INFO - 'sps_profile_interval': 0, 14:52:04 INFO - 'suite': 'dromaeojs-e10s', 14:52:04 INFO - 'system_bits': '32', 14:52:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:52:04 INFO - 'title': 'talos-linux64-ix-053', 14:52:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:52:04 INFO - 'use_talos_json': True, 14:52:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:52:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:52:04 INFO - 'work_dir': 'build'} 14:52:04 INFO - ##### 14:52:04 INFO - ##### Running clobber step. 14:52:04 INFO - ##### 14:52:04 INFO - Running pre-action listener: _resource_record_pre_action 14:52:04 INFO - Running main action method: clobber 14:52:04 INFO - rmtree: /builds/slave/test/build 14:52:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:52:04 INFO - Running post-action listener: _resource_record_post_action 14:52:04 INFO - ##### 14:52:04 INFO - ##### Finished clobber step (success) 14:52:04 INFO - ##### 14:52:04 INFO - ##### 14:52:04 INFO - ##### Running read-buildbot-config step. 14:52:04 INFO - ##### 14:52:04 INFO - Running pre-action listener: _resource_record_pre_action 14:52:04 INFO - Running main action method: read_buildbot_config 14:52:04 INFO - Using buildbot properties: 14:52:04 INFO - { 14:52:04 INFO - "project": "", 14:52:04 INFO - "product": "firefox", 14:52:04 INFO - "script_repo_revision": "production", 14:52:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:52:04 INFO - "repository": "", 14:52:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:52:04 INFO - "buildid": "20160609113016", 14:52:04 INFO - "pgo_build": "True", 14:52:04 INFO - "basedir": "/builds/slave/test", 14:52:04 INFO - "buildnumber": 549, 14:52:04 INFO - "slavename": "talos-linux64-ix-053", 14:52:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:52:04 INFO - "platform": "ubuntu64_hw", 14:52:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:52:04 INFO - "branch": "fx-team", 14:52:04 INFO - "repo_path": "integration/fx-team", 14:52:04 INFO - "revision": "afc529c199066e9c9d8a88318f24f631a7678d53", 14:52:04 INFO - "stage_platform": "linux64-pgo", 14:52:04 INFO - "builduid": "8e4747667347419d9e7e78983d3bed2a", 14:52:04 INFO - "slavebuilddir": "test" 14:52:04 INFO - } 14:52:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:52:04 INFO - Running post-action listener: _resource_record_post_action 14:52:04 INFO - ##### 14:52:04 INFO - ##### Finished read-buildbot-config step (success) 14:52:04 INFO - ##### 14:52:04 INFO - ##### 14:52:04 INFO - ##### Running download-and-extract step. 14:52:04 INFO - ##### 14:52:04 INFO - Running pre-action listener: _resource_record_pre_action 14:52:04 INFO - Running main action method: download_and_extract 14:52:04 INFO - mkdir: /builds/slave/test/build/tests 14:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:04 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:52:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:52:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:52:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:05 INFO - Downloaded 1361 bytes. 14:52:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:52:05 INFO - Using the following test package requirements: 14:52:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:52:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:52:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'jsshell-linux-x86_64.zip'], 14:52:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:52:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:52:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:52:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:52:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:52:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:52:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:52:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:05 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:52:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:52:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:52:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:06 INFO - Downloaded 24452351 bytes. 14:52:06 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'] 14:52:06 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 14:52:07 INFO - Return code: 0 14:52:07 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 14:52: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')]} 14:52:07 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:52:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:52:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:52:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:08 INFO - Downloaded 24452351 bytes. 14:52:08 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'] 14:52:08 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 14:52:10 INFO - Return code: 0 14:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:10 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:52:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:52:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:11 INFO - Downloaded 10833377 bytes. 14:52:11 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'] 14:52:11 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 14:52:11 INFO - Return code: 0 14:52: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')]} 14:52:11 INFO - https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:52:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:52:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:52:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dXGP61gpQAadwRWaadHjxg/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 14:52:13 INFO - Downloaded 59291515 bytes. 14:52:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:52:13 INFO - mkdir: /builds/slave/test/properties 14:52:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:52:13 INFO - Writing to file /builds/slave/test/properties/build_url 14:52:13 INFO - Contents: 14:52:13 INFO - build_url:https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:52:13 INFO - Running post-action listener: _resource_record_post_action 14:52:13 INFO - Running post-action listener: set_extra_try_arguments 14:52:13 INFO - ##### 14:52:13 INFO - ##### Finished download-and-extract step (success) 14:52:13 INFO - ##### 14:52:13 INFO - ##### 14:52:13 INFO - ##### Running populate-webroot step. 14:52:13 INFO - ##### 14:52:13 INFO - Running pre-action listener: _resource_record_pre_action 14:52:13 INFO - Running main action method: populate_webroot 14:52:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:52:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:52:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:52:13 INFO - '--tppagecycles', 14:52:13 INFO - '7'], 14:52:13 INFO - 'tests': ['tsvgm']}}, 14:52:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:52:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:52:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:52:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:52:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:52:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['damp', 'tps']}, 14:52:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'tests': ['damp', 'tps']}, 14:52:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['dromaeo_dom']}, 14:52:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:52:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['a11yr', 14:52:13 INFO - 'ts_paint', 14:52:13 INFO - 'tpaint', 14:52:13 INFO - 'sessionrestore', 14:52:13 INFO - 'sessionrestore_no_auto_restore', 14:52:13 INFO - 'tabpaint']}, 14:52:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:52:13 INFO - 'ts_paint', 14:52:13 INFO - 'tpaint', 14:52:13 INFO - 'sessionrestore', 14:52:13 INFO - 'sessionrestore_no_auto_restore', 14:52:13 INFO - 'tabpaint']}, 14:52:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:52:13 INFO - 'ts_paint', 14:52:13 INFO - 'tpaint', 14:52:13 INFO - 'sessionrestore', 14:52:13 INFO - 'sessionrestore_no_auto_restore', 14:52:13 INFO - 'tabpaint']}, 14:52:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:52:13 INFO - 'ts_paint', 14:52:13 INFO - 'tpaint', 14:52:13 INFO - 'sessionrestore', 14:52:13 INFO - 'sessionrestore_no_auto_restore', 14:52:13 INFO - 'tabpaint']}, 14:52:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['a11yr', 14:52:13 INFO - 'ts_paint', 14:52:13 INFO - 'tpaint', 14:52:13 INFO - 'sessionrestore', 14:52:13 INFO - 'sessionrestore_no_auto_restore', 14:52:13 INFO - 'tabpaint']}, 14:52:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['a11yr', 14:52:13 INFO - 'ts_paint', 14:52:13 INFO - 'tpaint', 14:52:13 INFO - 'sessionrestore', 14:52:13 INFO - 'sessionrestore_no_auto_restore', 14:52:13 INFO - 'tabpaint']}, 14:52:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['tsvgx', 14:52:13 INFO - 'tsvgr_opacity', 14:52:13 INFO - 'tart', 14:52:13 INFO - 'tscrollx', 14:52:13 INFO - 'cart']}, 14:52:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:52:13 INFO - 'tsvgr_opacity', 14:52:13 INFO - 'tart', 14:52:13 INFO - 'tscrollx', 14:52:13 INFO - 'cart']}, 14:52:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'talos_options': ['--disable-e10s'], 14:52:13 INFO - 'tests': ['tp5o']}, 14:52:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'tests': ['tp5o']}, 14:52:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'talos_options': ['--disable-e10s', 14:52:13 INFO - '--xperf_path', 14:52:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:13 INFO - 'tests': ['tp5n']}, 14:52:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:52:13 INFO - 'talos_options': ['--xperf_path', 14:52:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:52:13 INFO - 'tests': ['tp5n']}}, 14:52:13 INFO - 'talos.zip': {'path': '', 14:52:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:52:13 INFO - Running post-action listener: _resource_record_post_action 14:52:13 INFO - ##### 14:52:13 INFO - ##### Finished populate-webroot step (success) 14:52:13 INFO - ##### 14:52:13 INFO - ##### 14:52:13 INFO - ##### Running create-virtualenv step. 14:52:13 INFO - ##### 14:52:13 INFO - Running pre-action listener: _resource_record_pre_action 14:52:13 INFO - Running main action method: create_virtualenv 14:52:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:52:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:52:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:52:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:52:13 INFO - Using real prefix '/usr' 14:52:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:52:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:52:16 INFO - Installing pip.................done. 14:52:16 INFO - Return code: 0 14:52:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:52:16 INFO - Using env: {'DISPLAY': ':0', 14:52:16 INFO - 'HOME': '/home/cltbld', 14:52:16 INFO - 'LANG': 'en_US.UTF-8', 14:52:16 INFO - 'LANGUAGE': 'en_US:en', 14:52:16 INFO - 'LOGNAME': 'cltbld', 14:52:16 INFO - 'MAIL': '/var/mail/cltbld', 14:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:16 INFO - 'MOZ_NO_REMOTE': '1', 14:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:16 INFO - 'NO_EM_RESTART': '1', 14:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:16 INFO - 'PWD': '/builds/slave/test', 14:52:16 INFO - 'SHELL': '/bin/bash', 14:52:16 INFO - 'SHLVL': '1', 14:52:16 INFO - 'TERM': 'linux', 14:52:16 INFO - 'TMOUT': '86400', 14:52:16 INFO - 'USER': 'cltbld', 14:52:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:16 INFO - '_': '/tools/buildbot/bin/python'} 14:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:52:16 INFO - Cleaning up... 14:52:16 INFO - Return code: 0 14:52:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:52:16 INFO - Using env: {'DISPLAY': ':0', 14:52:16 INFO - 'HOME': '/home/cltbld', 14:52:16 INFO - 'LANG': 'en_US.UTF-8', 14:52:16 INFO - 'LANGUAGE': 'en_US:en', 14:52:16 INFO - 'LOGNAME': 'cltbld', 14:52:16 INFO - 'MAIL': '/var/mail/cltbld', 14:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:16 INFO - 'MOZ_NO_REMOTE': '1', 14:52:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:16 INFO - 'NO_EM_RESTART': '1', 14:52:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:16 INFO - 'PWD': '/builds/slave/test', 14:52:16 INFO - 'SHELL': '/bin/bash', 14:52:16 INFO - 'SHLVL': '1', 14:52:16 INFO - 'TERM': 'linux', 14:52:16 INFO - 'TMOUT': '86400', 14:52:16 INFO - 'USER': 'cltbld', 14:52:16 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:16 INFO - '_': '/tools/buildbot/bin/python'} 14:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:16 INFO - Downloading/unpacking psutil>=3.1.1 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:52:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:18 INFO - Installing collected packages: psutil 14:52:18 INFO - Running setup.py install for psutil 14:52:18 INFO - building 'psutil._psutil_linux' extension 14:52:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:52:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:52:19 INFO - building 'psutil._psutil_posix' extension 14:52:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:52:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:52:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:52:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:52:19 INFO - Successfully installed psutil 14:52:19 INFO - Cleaning up... 14:52:19 INFO - Return code: 0 14:52:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:52:19 INFO - Using env: {'DISPLAY': ':0', 14:52:19 INFO - 'HOME': '/home/cltbld', 14:52:19 INFO - 'LANG': 'en_US.UTF-8', 14:52:19 INFO - 'LANGUAGE': 'en_US:en', 14:52:19 INFO - 'LOGNAME': 'cltbld', 14:52:19 INFO - 'MAIL': '/var/mail/cltbld', 14:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:19 INFO - 'MOZ_NO_REMOTE': '1', 14:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:19 INFO - 'NO_EM_RESTART': '1', 14:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:19 INFO - 'PWD': '/builds/slave/test', 14:52:19 INFO - 'SHELL': '/bin/bash', 14:52:19 INFO - 'SHLVL': '1', 14:52:19 INFO - 'TERM': 'linux', 14:52:19 INFO - 'TMOUT': '86400', 14:52:19 INFO - 'USER': 'cltbld', 14:52:19 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:19 INFO - '_': '/tools/buildbot/bin/python'} 14:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:52:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:52:21 INFO - Installing collected packages: mozsystemmonitor 14:52:21 INFO - Running setup.py install for mozsystemmonitor 14:52:21 INFO - Successfully installed mozsystemmonitor 14:52:21 INFO - Cleaning up... 14:52:21 INFO - Return code: 0 14:52:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:21 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 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:52:21 INFO - Using env: {'DISPLAY': ':0', 14:52:21 INFO - 'HOME': '/home/cltbld', 14:52:21 INFO - 'LANG': 'en_US.UTF-8', 14:52:21 INFO - 'LANGUAGE': 'en_US:en', 14:52:21 INFO - 'LOGNAME': 'cltbld', 14:52:21 INFO - 'MAIL': '/var/mail/cltbld', 14:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:21 INFO - 'MOZ_NO_REMOTE': '1', 14:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:21 INFO - 'NO_EM_RESTART': '1', 14:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:21 INFO - 'PWD': '/builds/slave/test', 14:52:21 INFO - 'SHELL': '/bin/bash', 14:52:21 INFO - 'SHLVL': '1', 14:52:21 INFO - 'TERM': 'linux', 14:52:21 INFO - 'TMOUT': '86400', 14:52:21 INFO - 'USER': 'cltbld', 14:52:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:21 INFO - '_': '/tools/buildbot/bin/python'} 14:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:21 INFO - Downloading/unpacking jsonschema==2.5.1 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52: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 14:52:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:52:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:24 INFO - Downloading functools32-3.2.3-2.tar.gz 14:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:52:24 INFO - warning: no files found matching '*.txt' 14:52:24 INFO - no previously-included directories found matching 'build' 14:52:24 INFO - no previously-included directories found matching 'dist' 14:52:24 INFO - no previously-included directories found matching '.git*' 14:52:24 INFO - Installing collected packages: jsonschema, functools32 14:52:24 INFO - Running setup.py install for functools32 14:52:24 INFO - warning: no files found matching '*.txt' 14:52:24 INFO - no previously-included directories found matching 'build' 14:52:24 INFO - no previously-included directories found matching 'dist' 14:52:24 INFO - no previously-included directories found matching '.git*' 14:52:24 INFO - Successfully installed jsonschema functools32 14:52:24 INFO - Cleaning up... 14:52:24 INFO - Return code: 0 14:52:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:52:24 INFO - Using env: {'DISPLAY': ':0', 14:52:24 INFO - 'HOME': '/home/cltbld', 14:52:24 INFO - 'LANG': 'en_US.UTF-8', 14:52:24 INFO - 'LANGUAGE': 'en_US:en', 14:52:24 INFO - 'LOGNAME': 'cltbld', 14:52:24 INFO - 'MAIL': '/var/mail/cltbld', 14:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:24 INFO - 'MOZ_NO_REMOTE': '1', 14:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:24 INFO - 'NO_EM_RESTART': '1', 14:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:24 INFO - 'PWD': '/builds/slave/test', 14:52:24 INFO - 'SHELL': '/bin/bash', 14:52:24 INFO - 'SHLVL': '1', 14:52:24 INFO - 'TERM': 'linux', 14:52:24 INFO - 'TMOUT': '86400', 14:52:24 INFO - 'USER': 'cltbld', 14:52:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:24 INFO - '_': '/tools/buildbot/bin/python'} 14:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:24 INFO - Downloading/unpacking blobuploader==1.2.4 14:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:26 INFO - Downloading blobuploader-1.2.4.tar.gz 14:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:52:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:52:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:27 INFO - Downloading docopt-0.6.1.tar.gz 14:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:52:27 INFO - Installing collected packages: blobuploader, requests, docopt 14:52:27 INFO - Running setup.py install for blobuploader 14:52:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:52:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:52:27 INFO - Running setup.py install for requests 14:52:27 INFO - Running setup.py install for docopt 14:52:27 INFO - Successfully installed blobuploader requests docopt 14:52:27 INFO - Cleaning up... 14:52:27 INFO - Return code: 0 14:52:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:27 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 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:52:27 INFO - Using env: {'DISPLAY': ':0', 14:52:27 INFO - 'HOME': '/home/cltbld', 14:52:27 INFO - 'LANG': 'en_US.UTF-8', 14:52:27 INFO - 'LANGUAGE': 'en_US:en', 14:52:27 INFO - 'LOGNAME': 'cltbld', 14:52:27 INFO - 'MAIL': '/var/mail/cltbld', 14:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:27 INFO - 'MOZ_NO_REMOTE': '1', 14:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:27 INFO - 'NO_EM_RESTART': '1', 14:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:27 INFO - 'PWD': '/builds/slave/test', 14:52:27 INFO - 'SHELL': '/bin/bash', 14:52:27 INFO - 'SHLVL': '1', 14:52:27 INFO - 'TERM': 'linux', 14:52:27 INFO - 'TMOUT': '86400', 14:52:27 INFO - 'USER': 'cltbld', 14:52:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:27 INFO - '_': '/tools/buildbot/bin/python'} 14:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:28 INFO - Running setup.py (path:/tmp/pip-IOL9MA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:28 INFO - Running setup.py (path:/tmp/pip-m2QzQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:28 INFO - Running setup.py (path:/tmp/pip-0f3AjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:28 INFO - Running setup.py (path:/tmp/pip-QBqXQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:28 INFO - Running setup.py (path:/tmp/pip-7fPUFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:28 INFO - Running setup.py (path:/tmp/pip-nxvwur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:28 INFO - Running setup.py (path:/tmp/pip-D2pYOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:28 INFO - Running setup.py (path:/tmp/pip-GCHacb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:28 INFO - Running setup.py (path:/tmp/pip-9dsscw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:28 INFO - Running setup.py (path:/tmp/pip-KyRgHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:28 INFO - Running setup.py (path:/tmp/pip-sypp6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:28 INFO - Running setup.py (path:/tmp/pip-Y4gteR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:28 INFO - Running setup.py (path:/tmp/pip-cO80F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:29 INFO - Running setup.py (path:/tmp/pip-lZjGgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:29 INFO - Running setup.py (path:/tmp/pip-W4Z0au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:29 INFO - Running setup.py (path:/tmp/pip-lLZplA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:29 INFO - Running setup.py (path:/tmp/pip-OecPN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:52:29 INFO - Running setup.py install for manifestparser 14:52:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:52:29 INFO - Running setup.py install for mozcrash 14:52:29 INFO - Running setup.py install for mozdebug 14:52:29 INFO - Running setup.py install for mozdevice 14:52:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:52:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:52:29 INFO - Running setup.py install for mozfile 14:52:29 INFO - Running setup.py install for mozhttpd 14:52:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:52:29 INFO - Running setup.py install for mozinfo 14:52:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Running setup.py install for mozInstall 14:52:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Running setup.py install for mozleak 14:52:30 INFO - Running setup.py install for mozlog 14:52:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Running setup.py install for moznetwork 14:52:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Running setup.py install for mozprocess 14:52:30 INFO - Running setup.py install for mozprofile 14:52:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Running setup.py install for mozrunner 14:52:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:52:30 INFO - Running setup.py install for mozscreenshot 14:52:30 INFO - Running setup.py install for moztest 14:52:30 INFO - Running setup.py install for mozversion 14:52:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:52:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:52:31 INFO - Cleaning up... 14:52:31 INFO - Return code: 0 14:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:52:31 INFO - Using env: {'DISPLAY': ':0', 14:52:31 INFO - 'HOME': '/home/cltbld', 14:52:31 INFO - 'LANG': 'en_US.UTF-8', 14:52:31 INFO - 'LANGUAGE': 'en_US:en', 14:52:31 INFO - 'LOGNAME': 'cltbld', 14:52:31 INFO - 'MAIL': '/var/mail/cltbld', 14:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:31 INFO - 'MOZ_NO_REMOTE': '1', 14:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:31 INFO - 'NO_EM_RESTART': '1', 14:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:31 INFO - 'PWD': '/builds/slave/test', 14:52:31 INFO - 'SHELL': '/bin/bash', 14:52:31 INFO - 'SHLVL': '1', 14:52:31 INFO - 'TERM': 'linux', 14:52:31 INFO - 'TMOUT': '86400', 14:52:31 INFO - 'USER': 'cltbld', 14:52:31 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:31 INFO - '_': '/tools/buildbot/bin/python'} 14:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:52:31 INFO - Running setup.py (path:/tmp/pip-34ewH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:52:31 INFO - Running setup.py (path:/tmp/pip-Nf7tkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:52:31 INFO - Running setup.py (path:/tmp/pip-xvGzv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:52:31 INFO - Running setup.py (path:/tmp/pip-Cg_quM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:52:31 INFO - Running setup.py (path:/tmp/pip-mpDtdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:52:31 INFO - Running setup.py (path:/tmp/pip-lAHKxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:52:31 INFO - Running setup.py (path:/tmp/pip-32189j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:52:31 INFO - Running setup.py (path:/tmp/pip-VOX1v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:52:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:52:31 INFO - Running setup.py (path:/tmp/pip-djVbY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:52:32 INFO - Running setup.py (path:/tmp/pip-cVaaa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:52:32 INFO - Running setup.py (path:/tmp/pip-0inPU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:52:32 INFO - Running setup.py (path:/tmp/pip-zUNYpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:52:32 INFO - Running setup.py (path:/tmp/pip-vrLv9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:52:32 INFO - Running setup.py (path:/tmp/pip-8UTYZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:32 INFO - Running setup.py (path:/tmp/pip-b8TbVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:52:32 INFO - Running setup.py (path:/tmp/pip-Vx5gnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:52:32 INFO - Running setup.py (path:/tmp/pip-oOeyXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:52:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:35 INFO - Downloading blessings-1.6.tar.gz 14:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:52:35 INFO - Installing collected packages: blessings 14:52:35 INFO - Running setup.py install for blessings 14:52:35 INFO - Successfully installed blessings 14:52:35 INFO - Cleaning up... 14:52:35 INFO - Return code: 0 14:52:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:35 INFO - Reading from file tmpfile_stdout 14:52:35 INFO - Current package versions: 14:52:35 INFO - argparse == 1.2.1 14:52:35 INFO - blessings == 1.6 14:52:35 INFO - blobuploader == 1.2.4 14:52:35 INFO - docopt == 0.6.1 14:52:35 INFO - functools32 == 3.2.3-2 14:52:35 INFO - jsonschema == 2.5.1 14:52:35 INFO - manifestparser == 1.1 14:52:35 INFO - mozInstall == 1.12 14:52:35 INFO - mozcrash == 0.17 14:52:35 INFO - mozdebug == 0.1 14:52:35 INFO - mozdevice == 0.48 14:52:35 INFO - mozfile == 1.2 14:52:35 INFO - mozhttpd == 0.7 14:52:35 INFO - mozinfo == 0.9 14:52:35 INFO - mozleak == 0.1 14:52:35 INFO - mozlog == 3.2 14:52:35 INFO - moznetwork == 0.27 14:52:35 INFO - mozprocess == 0.22 14:52:35 INFO - mozprofile == 0.28 14:52:35 INFO - mozrunner == 6.11 14:52:35 INFO - mozscreenshot == 0.1 14:52:35 INFO - mozsystemmonitor == 0.3 14:52:35 INFO - moztest == 0.7 14:52:35 INFO - mozversion == 1.4 14:52:35 INFO - psutil == 3.1.1 14:52:35 INFO - requests == 1.2.3 14:52:35 INFO - wsgiref == 0.1.2 14:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:52:35 INFO - Using env: {'DISPLAY': ':0', 14:52:35 INFO - 'HOME': '/home/cltbld', 14:52:35 INFO - 'LANG': 'en_US.UTF-8', 14:52:35 INFO - 'LANGUAGE': 'en_US:en', 14:52:35 INFO - 'LOGNAME': 'cltbld', 14:52:35 INFO - 'MAIL': '/var/mail/cltbld', 14:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:35 INFO - 'MOZ_NO_REMOTE': '1', 14:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:35 INFO - 'NO_EM_RESTART': '1', 14:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:35 INFO - 'PWD': '/builds/slave/test', 14:52:35 INFO - 'SHELL': '/bin/bash', 14:52:35 INFO - 'SHLVL': '1', 14:52:35 INFO - 'TERM': 'linux', 14:52:35 INFO - 'TMOUT': '86400', 14:52:35 INFO - 'USER': 'cltbld', 14:52:35 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:35 INFO - '_': '/tools/buildbot/bin/python'} 14:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:52:36 INFO - Cleaning up... 14:52:36 INFO - Return code: 0 14:52:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:52: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')]} 14:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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')]} 14:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:36 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 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:52:36 INFO - Using env: {'DISPLAY': ':0', 14:52:36 INFO - 'HOME': '/home/cltbld', 14:52:36 INFO - 'LANG': 'en_US.UTF-8', 14:52:36 INFO - 'LANGUAGE': 'en_US:en', 14:52:36 INFO - 'LOGNAME': 'cltbld', 14:52:36 INFO - 'MAIL': '/var/mail/cltbld', 14:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:36 INFO - 'MOZ_NO_REMOTE': '1', 14:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:36 INFO - 'NO_EM_RESTART': '1', 14:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:36 INFO - 'PWD': '/builds/slave/test', 14:52:36 INFO - 'SHELL': '/bin/bash', 14:52:36 INFO - 'SHLVL': '1', 14:52:36 INFO - 'TERM': 'linux', 14:52:36 INFO - 'TMOUT': '86400', 14:52:36 INFO - 'USER': 'cltbld', 14:52:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:36 INFO - '_': '/tools/buildbot/bin/python'} 14:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:52:36 INFO - Cleaning up... 14:52:36 INFO - Return code: 0 14:52:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:52: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')]} 14:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52: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')]} 14:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:52:36 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 0x7fc5b0bf7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x166f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, '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': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:52:36 INFO - Using env: {'DISPLAY': ':0', 14:52:36 INFO - 'HOME': '/home/cltbld', 14:52:36 INFO - 'LANG': 'en_US.UTF-8', 14:52:36 INFO - 'LANGUAGE': 'en_US:en', 14:52:36 INFO - 'LOGNAME': 'cltbld', 14:52:36 INFO - 'MAIL': '/var/mail/cltbld', 14:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:36 INFO - 'MOZ_NO_REMOTE': '1', 14:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:36 INFO - 'NO_EM_RESTART': '1', 14:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:36 INFO - 'PWD': '/builds/slave/test', 14:52:36 INFO - 'SHELL': '/bin/bash', 14:52:36 INFO - 'SHLVL': '1', 14:52:36 INFO - 'TERM': 'linux', 14:52:36 INFO - 'TMOUT': '86400', 14:52:36 INFO - 'USER': 'cltbld', 14:52:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:36 INFO - '_': '/tools/buildbot/bin/python'} 14:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:52:36 INFO - Downloading/unpacking flake8 14:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:52:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:52:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:52:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:52:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:52:39 INFO - no previously-included directories found matching 'docs/_build' 14:52:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:52:39 INFO - Running setup.py install for pep8 14:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:52:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:52:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:52:39 INFO - no previously-included directories found matching 'docs/_build' 14:52:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:52:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:52:39 INFO - Cleaning up... 14:52:39 INFO - Return code: 0 14:52:39 INFO - Running post-action listener: _resource_record_post_action 14:52:39 INFO - Running post-action listener: _start_resource_monitoring 14:52:39 INFO - Starting resource monitoring. 14:52:39 INFO - ##### 14:52:39 INFO - ##### Finished create-virtualenv step (success) 14:52:39 INFO - ##### 14:52:39 INFO - ##### 14:52:39 INFO - ##### Running install step. 14:52:39 INFO - ##### 14:52:39 INFO - Running pre-action listener: _resource_record_pre_action 14:52:39 INFO - Running main action method: install 14:52:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:52:39 INFO - Reading from file tmpfile_stdout 14:52:39 INFO - Detecting whether we're running mozinstall >=1.0... 14:52:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:52:39 INFO - Reading from file tmpfile_stdout 14:52:39 INFO - Output received: 14:52:39 INFO - Usage: mozinstall [options] installer 14:52:39 INFO - Options: 14:52:39 INFO - -h, --help show this help message and exit 14:52:39 INFO - -d DEST, --destination=DEST 14:52:39 INFO - Directory to install application into. [default: 14:52:39 INFO - "/builds/slave/test"] 14:52:39 INFO - --app=APP Application being installed. [default: firefox] 14:52:39 INFO - mkdir: /builds/slave/test/build/application 14:52:39 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'] 14:52:39 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 14:52:56 INFO - Reading from file tmpfile_stdout 14:52:56 INFO - Output received: 14:52:56 INFO - /builds/slave/test/build/application/firefox/firefox 14:52:56 INFO - Running post-action listener: _resource_record_post_action 14:52:56 INFO - ##### 14:52:56 INFO - ##### Finished install step (success) 14:52:56 INFO - ##### 14:52:56 INFO - ##### 14:52:56 INFO - ##### Running run-tests step. 14:52:56 INFO - ##### 14:52:56 INFO - Running pre-action listener: _resource_record_pre_action 14:52:56 INFO - Running main action method: run_tests 14:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:52:56 INFO - Python 2.7.3 14:52:56 INFO - Return code: 0 14:52:56 INFO - grabbing minidump binary from tooltool 14:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:52:56 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 0x16fe1c0>, '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 0x16ff0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ff550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:52:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:52:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:52:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:52:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:52:56 INFO - Return code: 0 14:52:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:52:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:52:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:52:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:52:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:52:57 INFO - Return code: 0 14:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 14:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 14:52:57 INFO - Using env: {'DISPLAY': ':0', 14:52:57 INFO - 'HOME': '/home/cltbld', 14:52:57 INFO - 'LANG': 'en_US.UTF-8', 14:52:57 INFO - 'LANGUAGE': 'en_US:en', 14:52:57 INFO - 'LOGNAME': 'cltbld', 14:52:57 INFO - 'MAIL': '/var/mail/cltbld', 14:52:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:52:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:52:57 INFO - 'MOZ_NO_REMOTE': '1', 14:52:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:52:57 INFO - 'NO_EM_RESTART': '1', 14:52:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:52:57 INFO - 'PWD': '/builds/slave/test', 14:52:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:52:57 INFO - 'SHELL': '/bin/bash', 14:52:57 INFO - 'SHLVL': '1', 14:52:57 INFO - 'TERM': 'linux', 14:52:57 INFO - 'TMOUT': '86400', 14:52:57 INFO - 'USER': 'cltbld', 14:52:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507', 14:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:52:57 INFO - '_': '/tools/buildbot/bin/python'} 14:52:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 14:52:57 INFO - mozversion application_buildid: 20160609113016 14:52:57 INFO - mozversion application_changeset: afc529c199066e9c9d8a88318f24f631a7678d53 14:52:57 INFO - mozversion application_display_name: Nightly 14:52:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:52:57 INFO - mozversion application_name: Firefox 14:52:57 INFO - mozversion application_remotingname: firefox 14:52:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:52:57 INFO - mozversion application_vendor: Mozilla 14:52:57 INFO - mozversion application_version: 50.0a1 14:52:57 INFO - mozversion platform_buildid: 20160609113016 14:52:57 INFO - mozversion platform_changeset: afc529c199066e9c9d8a88318f24f631a7678d53 14:52:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:52:57 INFO - mozversion platform_version: 50.0a1 14:52:57 INFO - using testdate: 1465509177 14:52:57 INFO - actual date: 1465509177 14:52:57 INFO - starting webserver on 'localhost:33642' 14:52:57 INFO - SUITE-START | Running 2 tests 14:52:57 INFO - TEST-START | dromaeo_css 14:52:57 INFO - operating with platform_type : linux_ 14:52:57 INFO - Initialising browser for dromaeo_css test... 14:52:57 INFO - TEST-INFO | started process 21448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk94t8q/profile http://localhost:33642/getInfo.html) 14:53:02 INFO - PROCESS | 21448 | __metrics Screen width/height:1600/1200 14:53:02 INFO - PROCESS | 21448 | colorDepth:24 14:53:02 INFO - PROCESS | 21448 | Browser inner width/height: 1024/697 14:53:02 INFO - PROCESS | 21448 | __metrics 14:53:04 ERROR - PROCESS | 21448 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:53:04 INFO - TEST-INFO | 21448: exit 0 14:53:04 INFO - Browser initialized. 14:53:04 INFO - Running cycle 1/1 for dromaeo_css test... 14:53:04 INFO - TEST-INFO | started process 21567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk94t8q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:53:16 INFO - PROCESS | 21567 | RSS: Main: 184242176 14:53:16 INFO - PROCESS | 21567 | 14:54:06 INFO - PROCESS | 21567 | 1465509246523 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:56:14 INFO - PROCESS | 21567 | Cycle 1(1): loaded http://localhost:33642/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33642/tests/dromaeo/cssquery-ext.html) 14:56:15 INFO - PROCESS | 21567 | RSS: Main: 187318272 14:56:15 INFO - PROCESS | 21567 | 14:59:17 INFO - PROCESS | 21567 | Cycle 1(1): loaded http://localhost:33642/tests/dromaeo/cssquery-ext.html (next: http://localhost:33642/tests/dromaeo/cssquery-jquery.html) 14:59:18 INFO - PROCESS | 21567 | RSS: Main: 186863616 14:59:18 INFO - PROCESS | 21567 | 15:02:20 INFO - PROCESS | 21567 | Cycle 1(1): loaded http://localhost:33642/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33642/tests/dromaeo/cssquery-mootools.html) 15:02:20 INFO - PROCESS | 21567 | RSS: Main: 188268544 15:02:20 INFO - PROCESS | 21567 | 15:05:22 INFO - PROCESS | 21567 | Cycle 1(1): loaded http://localhost:33642/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33642/tests/dromaeo/cssquery-prototype.html) 15:05:23 INFO - PROCESS | 21567 | RSS: Main: 185860096 15:05:23 INFO - PROCESS | 21567 | 15:08:25 INFO - PROCESS | 21567 | Cycle 1(1): loaded http://localhost:33642/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33642/tests/dromaeo/cssquery-yui.html) 15:08:26 INFO - PROCESS | 21567 | RSS: Main: 187981824 15:08:26 INFO - PROCESS | 21567 | 15:11:28 INFO - PROCESS | 21567 | Cycle 1(1): loaded http://localhost:33642/tests/dromaeo/cssquery-yui.html (next: http://localhost:33642/tests/dromaeo/cssquery-dojo.html) 15:11:29 INFO - PROCESS | 21567 | RSS: Main: 189145088 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | __start_tp_report 15:11:29 INFO - PROCESS | 21567 | _x_x_mozilla_page_load 15:11:29 INFO - PROCESS | 21567 | _x_x_mozilla_page_load_details 15:11:29 INFO - PROCESS | 21567 | |i|pagename|runs| 15:11:29 INFO - PROCESS | 21567 | |0;dojo.html;3117.3765246950616;3133.702298281663;3139.0896639974408;3143.5599016137744;3145.370925814836;5354.491323324283;5365.195220716894;5420.837374878755;5500.4499550044975;5574.052411090114;5406.243125962358;5438.048341540234;5439.347278326606;5467.343918729748;5540.722963851801;4989.426215985162;5005.899882002358;5117.309163262968;5144.202648589475;5151.124308867502;5045.571126454238;5156.948430515703;5185.170372740362;5186.351706036746;5187.4034486034025;4985.40175178979;5055.368078990126;5067.417247016603;5072.26452164436;5076.416212135597;5022.824201152942;5027.2207807789855;5028.7737051832755;5030.849074527733;5095.515925987025;4976.054549635558;5003.5997120230295;5007.198848184309;5008.1486147355035;5026.623003274733;5542.528885044776;5582.413846546095;5600.803971860965;5627.577931655102;5640.210370548127;5985.700714964234;6013.067974463965;6047.848803779897;6049.213602231725;6066.696665166724;5839.883202335972;5879.32387775407;6108.694565271719;6126.264848218198;6129.448349648553;5500.889982200333;5520.227168196456;5531.8340449786165;5550.195221692832;5560.4161563036105;5959.970200149059;5981.551383646157;6004.609700369462;6008.969955150196;6032.909506357408;5726.3700992890745;5780.739866706008;5781.479666830005;5809.186713860063;5889.587728858939;6022.608530445595;6026.126211699279;6028.005379112397;6045.244344456943;6075.5747097703625;5651.858703532444;5682.971585142048;5823.621464604787;5976.133460648181;5983.371745966698;5664.8867022659315;5763.279590051244;5804.854878627983;5805.941940580625;5819.330776960704;4478.350639157369;4525.864224073283;4551.907542189851;4584.19776539111;4585.151746926763;4053.6554392876938;4055.4930633670792;4061.431399604058;4093.3450647896193;4105.0763578195265;5533.861653458695;5719.971400142973;5757.453041961007;5801.3328467225965;5802.332731735904;5975.850603734942;5994.730237139339;5994.790182343684;6046.788362407295;6051.636901785907;5672.14917762339;5695.401982791747;5709.8287051388525;5710.71446427677;5720.942790572041;4946.604271658259;5134.845954621367;5151.304573882553;5153.3300670913295;5163;6138.631682099089;6175.567710260329;6180.227471566054;6228.781992630236;6237.251529816361;6009.549283803644;6013.530693335866;6020.608660437058;6021.367756385692;6057.818265452043;5918.141869428995;6073.514118870568;6104.511639068775;6173.753049877954;6181.412765787243;5840.620359676607;5841.415858414124;5841.824745257649;5843;5886.764529418775;5958.433948775033;5959.940400595939;5975.671338076448;6029.698515074317;6036.124761909587;5623.268975033219;5823.097419899922;5855.648661080349;5865.354810970704;5871.530277577698;5692.601517893708;5708.200851880657;5751.942480575308;5777.508911742549;5834.38738932406;5691.146328050825;5697.173909783141;5704.942950570441;5710.600257981901;5751.626144300607;5694.06048002075;5772;5787.334456537552;5827.70861456917;5839.386864379179;5635.859103522281;5709.514691251124;5728.140778883201;5730.656160630376;5737.9139312911175 15:11:29 INFO - PROCESS | 21567 | |1;ext.html;590.3211306996953;629.3203340392374;640.497209690393;654.6105067484847;656.8423578341194;37204.81397593012;41642;41734.373984390186;42135.367969480445;42142;42936.57063429365;43228.78385608068;43351;43524;43764.781176094155;8767.16711912369;8868.201861832435;8915;8923.553822308892;8947.463152210888;8775.912240877606;8810.735677929672;8828;8829.117088291183;8832.249258813008;8838.86741698875;8864.113588641116;8876.6005529751;8893.599788009522;8935;8801.867971980426;8841.115888411172;8847.071057538962;8873.245774109208;8898.777530561756;8686.261667758185;8756.211940925346;8796.560171991376;8801.207891289814;8812.471251724917;34669;40764.79617601893;41181;41299.1740165198;41311;3270.198801293698;3439.6560343965652;3468.5664291963503;3526.929461410783;3527.0476971217627;31311.37377252442;31625.525617115763;31747.206319841956;31828.681713182803;32111.83944080288;4108.712390132692;4145.150244199962;4154.356074808409;4189.141226048683;4316.050468896838;281835;282484;283941;284254;284866;34282.657173428444;35096;35252.82373588115;35397.46903796445;35432.46851297233;34568.82715586406;36899.4465083024;37110;37171.62828371736;37221.81389093091;16052.117133557533;16080.517584472485;16160.67678646444;16193.433229836899;16234.431794887123;12375.69060773488;12440.502379904883;12448;12473.688157796129;12553.12128151039;8314.334853211729;8325;8439.071702112762;8452.704155354533;8472.915270847336;3238.659940706239;3271.9672803272138;3287.1263379873244;3308.9007329780147;3357.7649564530248;992.3053862296422;1039.378569431689;1097.1771171621283;1105.4417519152937;1183.5443354308654;32008.519872201934;32442.675573244436;32540.511892321632;32824.671753282164;32899.835500822344;1073.1039581949003;1114.1142791480631;1129.0910816792398;1133.3879704959395;1217.2513903949007;16674.582660473996;17460.30158793634;17506.737398939025;17539.473815785546;17576.648467030842;571998;574487;576189;578643;581164;61889.69055154786;62428.68785656043;62487.37512624906;62569;62777.68611156915;1339.8124262603244;1352.9864701353058;1385.2104300548792;1399.4542128569865;1401.824771903512;30383.392332153675;31391;31619.84190079035;31978.20054498656;32430;52040.219396709836;52998.73500632472;53036;53060.4693953071;53294.46705532895;484822;488523;491047;491646;494003;28873.278168045126;29172.416551669274;29210.56184157197;29299.7070029297;29323;50106;50260;51240.23139652983;51813;51814;41103.794481027406;42929.35605965851;43345.566544335416;43355.566444335156;44125.67622971316;42826.57173428226;43328.350074748276;43398.78300608477;43494.78252608717;43731.78134109309;41193.58806411897;41958.790206048776;42590.5740942599;43029;43075.56924430715;36196.45705314475;38596.22807543777;38636;39004.219915602094;39028.80485597554;28068;28127.296817579725;28349.291267717646;28489;28583.42833143284 15:11:29 INFO - PROCESS | 21567 | |2;jquery.html;388.281678894046;392.06296950288834;393.21553500765975;399.7581463214755;411.31721342571336;17985.730214046784;18900.149493272802;19589.608207835834;19598.020098995046;19886.40340789775;18685.532861678465;18714.25142994282;18945.14746836392;19520.023998800076;19677.803221967777;5609.411011843759;5667.659940403579;5796.159556864252;5824.504917082053;5849.327327357345;5755.424457554232;5771.769129234825;5775.711214439282;5787.826365209051;5793.420657934215;5537.390887002426;5774.797882074128;5780.971095144519;5787.392323806003;5804.303483581976;5536.2249285099715;5764.048931926227;5776.133579962997;5782.710864456782;5785.652860828342;5142.408623008327;5143.382794064699;5150.871228219287;5152.433232344439;5167.22491626259;22712;22768.316950491513;23061.53876922452;23162.884185579132;23231;2346.272655476808;2390.175389490623;2403.218953840009;2568.8972441102333;2949.8820047198087;9352.251819854395;9898.10917017472;9934.90065099347;10346.172306215485;14674.779878301833;1839.1264149529;1879.8872067675848;1883.6703576873992;1885.632301701169;1956.0806420982115;79828;81189;81841.59079204565;83207.16792832054;85069;10783.029527342576;10886.346819190874;10955.17836162291;10994.395308258123;11095.83356249657;15301.158436285888;15314.463993760164;15451.84548154504;15497.535073947574;15507.457238996582;8055.315298199602;8129.674813007532;8404.411691181558;8547.487150770974;8560.186782255676;8109.594520273963;8162;8258.25675689191;8282;8552.144785521523;4553.658475614276;4595.609373203315;4700.435947686299;4709.529047095263;4880.707157570557;1890.328933228684;1918.8177123173555;1948.2109745553073;1956.2859556261863;1963.4011626453782;946.7491114854569;952.8475443928938;1025.0671888581355;1025.9692209233735;1072.951717172729;18636.906815465834;19052.333168339042;19895.701564476545;19963.500912477015;20029.49926251826;1011.2819897872592;1011.9190464762949;1039.3140527251978;1053.2206167436043;1073.7798751255973;10645.414502202453;11222.382768947624;11229.3262404256;11297.548098075986;11338.546458141582;471729;472284;476844;480687;506850;57417.71291143518;65908.6704566474;93275;93397;95224.52387738155;998.381003777648;1000.7147962830704;1017.7913527726798;1030.469308306208;1031.7162780235494;17404.651906962044;17474.12629368552;17722.73415898737;17779.555511112325;17932.91033544876;42168.78915605402;42661.36007959945;43078.78460607677;43833.12333753243;44537.777311113234;58855.411445884994;59013.40986590251;59576.40423595709;60571.69714151401;61265;7099.716011359695;7462.850742985219;7490.588017659081;8415.11641277657;8592.312614990911;9221.815563688555;12517.248965062125;12644;12822;13248.735025299633;11078.667639970814;11373.20387572862;11592.36242006664;11615.941920290345;11996;11740.295582265091;11804.527818887149;11878.46546905374;11946.940265298617;12215.26708397499;10052.497375131068;10136;11873.821892671443;12250.387480625755;12319.076069295019;7252.202257751537;7279.745208917874;7285.490015698851;7332.49683814806;7380.409567234716;9256.120668536478;9532.761680958032;9674.129328360481;9687;9859.901400985898 15:11:29 INFO - PROCESS | 21567 | |3;mootools.html;1462.8829693624511;1484.5323723027245;1580.2809721576684;1691.6213286171776;1701.5490894912857;7714.305712485875;8338.332933365331;8456.450330728498;9013.053629368913;9053.909460905388;8515.105913879032;8714.564271786418;8779.473231606107;8818.559072046388;8864.113588641132;2264.1056782570877;2302.1942320187886;2305.4351683837485;2309.688192094071;2322.5703244899664;2306.319635707462;2339.415146213447;2382.9046838126455;2387.6418537219383;2388.653645221442;2369.7748713872156;2379.393254720044;2389.199618127929;2413.4811015631635;2413.963790543143;2270.386995511219;2280.5096904165603;2290.862548247102;2290.89690963907;2351.870647114408;2268.092762894839;2286.6570014497793;2311.410590299463;2311.6070268054305;2313.1325752842686;8845.601947912295;8973.10268973104;8996.235319997742;9054.230390416822;9068.957069936976;5074.517920797518;5153.871153221162;5187.325647665817;5190.4550022247495;5201.141811601081;3180.6024246969127;3220.29153586213;3299.736021118305;3343.7157841583253;3345.6821601947777;1079.3254216114929;1085.918556108295;1086.625114335553;1090.7218659241921;1102.5148934468807;12869.09916305859;12963.48146074156;13019.153755005895;13045.086843921024;13072.1503102299;4733.171381553148;4777.3072904429355;4826.1795494765975;4870.512948705101;4872.660018494942;10222.693319200436;10295.279330446796;10316.123129533924;10404.635837745795;10417.635382761568;5016.272640467112;5141.665791723526;5225.50357716024;5241.659292145999;5266.710330931835;4336.284513055373;4776.617870570346;4831.613470922318;4955.975220123876;4961.727105009187;3953.189596132786;4030.334994725896;4093.038136038029;4105.117399759066;4154.003039270553;1280.3406245783428;1296.1898813241723;1302.7655022096114;1305.3277562055548;1316.6774140335488;833.3291700181412;921.3964853021282;924.1636319131063;953.756792018031;988.658912675126;6141.508679305645;6301.243850737941;6303.117563541108;6306.243250809932;6435.581687190318;443.9800208990603;450.6755136301857;450.9932351014737;453.8751843243069;461.1675924955488;4072.75563466193;4169.145325208325;4180.205760905418;4220.831166753357;4247.10810729744;10286.177105831515;10538.525766340534;10608.946955265328;10624;10636.627718029831;10352.5341359639;10374.792504150026;10379.065884070318;10397.168226541859;10480.371177729361;7781.610919454005;8066.274035336731;8080.757577272691;8116.513009219466;8133.186681331819;5816.2438882946635;6007.669578173242;6044.576879618385;6070.332263450929;6145.231846019247;9492.810143796947;9819;9899.851502227328;9905.55425005862;9928.205743540355;9916.652917147865;10058.547365368722;10105.5452504636;10115.241356898408;10254.6410875619;7082.787516374517;7483.289087536676;7710.151883292721;7769.417293703108;7823.413244006836;8564.05795362522;8585.484870907765;8628.137186281572;8643.135686431306;8674.132586741276;7539.32146106853;7770.883436748566;7781.766547003599;7871.094824095302;7906.683732650629;7593.544387336778;7663.961680191564;7695.92304076952;7732.8453430932195;7879.606019699107;6734.292899245509;6767.086443330284;6780.32196780318;6784.559003664746;6817.318268173143;5051.722155281494;5105.387353517602;5158.303629010035;5272.920906186334;5280.947190528045;5277.20841873722;5280.049591073644;5332.520073193431;5340.973295133499;5369.5167434931045 15:11:29 INFO - PROCESS | 21567 | |4;prototype.html;331.4845415379086;335.4733069081542;340.87217293514925;341.8205442142876;344.26327658810135;5586.078297080977;5640.858978525539;5695.430456954303;5696.718238396364;5732.369439361667;5575.414581468948;5579.80034292627;5595.132754423061;5599.1041433370665;5600.96382169299;4121.608447197512;4178.623923846853;4275.657947364219;4289.5924887135825;4313.676474264443;4296.763677997709;4313.1158112587;4357.564243575633;4368.759718215497;4381.474223093217;4330.653547716175;4340.609345158935;4361.171377438292;4367.1265746850595;4372.23485889968;4183.828528012146;4343.652507799368;4360.280553708666;4367.323064924942;4368.3884256204;3834.328992426342;3837.827297771579;3843.1160833008566;3845.288621605012;3859.2281543691092;5488.506034456918;5506.91739623906;5508.862278443031;5513.4562322549755;5525.364583072957;4958.2481722643915;4998.600111991032;5036.924446133311;5050.646454748169;5066.847994560169;5857.7949771757785;5882.735276912506;5903.9668058089665;5928.170056192136;5990.041593345044;4266.402703621496;4284.828606855722;4285.185814695198;4318.82724691012;4322.654187665011;5952.226210592638;6020.6989650517735;6048.7882924097885;6057.454829065406;6069.6054756441135;4313.705888233518;4327.2643650579475;4361.498427680794;4373.431453910971;4378.978105109518;4307.7415355078165;4318.596456151763;4329.545397733255;4332;4420.425344705168;4815.30178124177;4907.803687852517;4920.803167873245;4927.359443272351;4977.1538838397555;5893.764249430061;5901.17383566301;5905.881882362329;5933.792317268875;5934.584579079423;1480;1481.525911708243;1505.8720008799376;1506.239349128683;1511.833698293187;972.4262685015875;976.5800705696477;979.8584648884113;984.8965858584888;1015.2740790334798;5530.364008139035;5574.526165275997;5577.386487486373;5622.97188514063;5626.887462250732;5976.73104710289;5986.491148252448;5992.733959991728;6004.8799024020145;6027.854707605541;5350.8662283442445;5544.1960915667005;5573.804916827973;5583.944160558423;5610.27066481363;3166.2717574957887;3175.967810461609;3183.4588120019653;3184.7420268994083;3212.9678703213135;5935.851603709855;6187.3503282154725;6212.9378706213265;6216.409441103178;6227.847848148107;6080.8783824324155;6122.938770612326;6193.938060619336;6197.287311959182;6201.379862013762;6167.907481387693;6212.353726262544;6215.9378406215355;6216.502679785606;6225.066240063936;5750.9424905752085;5926.1999630049395;5956.285245770362;5982.52139828804;5998.790042348497;5949.583529152917;5964.731587078505;5990.2212712348855;6018.668973206516;6049.879002420015;5931.288245410578;6122.602030867979;6204.472619827185;6232.906506402317;6253;4296.871093867189;4360.127974405195;4365.148795984879;4379.627731642719;4389.385486031894;6043.607165534227;6082.513398928164;6094.3545242785085;6108.969455152695;6117.143599896107;5704.801991581814;5735.369109398046;5865.970670146622;5873.588848780715;5881.823545293648;5811.970940145272;5832.154337621106;5836.358000620014;5840.591158618856;5892.970535147297;5303.893922121613;5643.633163844337;5684.488396044376;5689.601727879009;5732.856678583069;5821.243238378984;5824.767009319579;5860.853478663067;5941.58408911372;5986.760529578768;5773.509251713652;5789.189513468202;5790.712668496005;5795.565332599987;5836.562257830595 15:11:29 INFO - PROCESS | 21567 | |5;yui.html;720.6180724216167;784.3999340504515;805.4804651000105;807.6850028488894;843.890284276177;14700.558983230494;15613.531594052169;15763.290651920677;15788.526344209664;16297.674046519078;14883.18142502162;14963.551093467186;14994.62513437162;15109.471168509104;15138.470153544627;677.1366507702669;804.3926835239386;818.8935438393;822.8601137806558;830.0122853803985;815.3314282288496;817.2481317188171;820.9096999330069;821.5317269156583;821.6549049399237;868.7089824908663;874.9343799215053;875.2647775868301;875.6322344615245;877.1404024056428;863.4258218284864;865.3034307382586;868.5006121480143;873.9563021848882;874.9387542872001;630.3286999345682;632.1466020871832;634.6667999300358;635.1742734445203;639.6034458635629;14870.256487175706;14982.62543436412;15013.774793378108;15027.09837409759;15103.32035058425;15522.922385388114;15630.531084067496;15737.52787416368;15775.92112039444;16068.919655401765;12266.877331226662;12366.690832729164;12391.318477483735;12550.874491255061;12645.241285522807;3803.2013277211818;3827.0623697194087;3828.3109040372724;3957.7427467214825;3975.4831871856763;74300.62849685771;74927;75602;76704.61647691781;77100;11887.821682674767;12045.397730113635;12111.333876636869;12209.807357255158;12370.195937264049;22894.31317060491;22894.885525572598;22973.19593814242;22998;23003.309900703007;8254;8387.748367548984;8392.832143357098;8651.78370540729;8692.608832602547;4789.736564488917;4870.1233777920315;4942.431620363633;5002.374703162105;5058;3811.676007539335;4055.878323650295;4063.593640635913;4068.898277543085;4073.796310184479;665.7270519087151;676.8307923019245;679.358006683689;702.2801628331001;704.2112833626371;750.6884642873256;753.1451802204538;758.6510205305511;773.5783997721255;788.8501184774874;10176.643817466353;10183.490825458697;10245.84631230532;10277.794444111225;10357.844632330522;740.4372676765697;741.3994664321916;779.8557266905641;789.6486063701713;794.8251384695358;5044.495550444926;5187.455317191716;5260.631755777059;5319.46805319465;5320.733963301819;71450.2854971454;71966.64016679882;79792;118132;124795;62698;65315;80106.59946700229;99719.00842974722;105782;85545;86738.56630716806;89198.55400722956;89394;89468;9930.602775888883;10029.247806414694;10151.746206344606;10174.643887463903;10242.948785256027;37995.81002094972;48890.75554622204;52613.21080183724;52948.47051529436;53188.4681153199;71299;71673.84978450654;77881.61059194895;78987;80442;12807.423665934868;12938.611841644766;12977.740445191232;13232.272225027717;13334.599962001155;14256.714865702836;14283.64290892736;14288.142711437347;14354.928225358806;15403.61490962735;13468.326583670972;13629.63999440291;13835.239061851695;13844.930775346058;13976.371063302378;12966.935165324114;13003.739925201255;13193.472261109831;13659.317034148451;13713.931430342784;13280.269585172908;13314.46742130304;13536;13572.253526056162;14156.787648185491;10113;10494.265401421828;10519;11047.668569942914;11089.174070417952;10462.110720588531;10573.577056917637;10675.786484270116;10761.677149685522;10785.191110666889 15:11:29 INFO - PROCESS | 21567 | __end_tp_report 15:11:29 INFO - PROCESS | 21567 | __start_cc_report 15:11:29 INFO - PROCESS | 21567 | _x_x_mozilla_cycle_collect,351 15:11:29 INFO - PROCESS | 21567 | __end_cc_report 15:11:29 INFO - PROCESS | 21567 | __startTimestamp1465510289188__endTimestamp 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | ------- Summary: start ------- 15:11:29 INFO - PROCESS | 21567 | Number of tests: 6 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | [#0] dojo.html Cycles:165 Average:5516.92 Median:5710.71 stddev:635.94 (11.1%) stddev-sans-first:609.39 15:11:29 INFO - PROCESS | 21567 | Values: 3117.4 3133.7 3139.1 3143.6 3145.4 5354.5 5365.2 5420.8 5500.4 5574.1 5406.2 5438.0 5439.3 5467.3 5540.7 4989.4 5005.9 5117.3 5144.2 5151.1 5045.6 5156.9 5185.2 5186.4 5187.4 4985.4 5055.4 5067.4 5072.3 5076.4 5022.8 5027.2 5028.8 5030.8 5095.5 4976.1 5003.6 5007.2 5008.1 5026.6 5542.5 5582.4 5600.8 5627.6 5640.2 5985.7 6013.1 6047.8 6049.2 6066.7 5839.9 5879.3 6108.7 6126.3 6129.4 5500.9 5520.2 5531.8 5550.2 5560.4 5960.0 5981.6 6004.6 6009.0 6032.9 5726.4 5780.7 5781.5 5809.2 5889.6 6022.6 6026.1 6028.0 6045.2 6075.6 5651.9 5683.0 5823.6 5976.1 5983.4 5664.9 5763.3 5804.9 5805.9 5819.3 4478.4 4525.9 4551.9 4584.2 4585.2 4053.7 4055.5 4061.4 4093.3 4105.1 5533.9 5720.0 5757.5 5801.3 5802.3 5975.9 5994.7 5994.8 6046.8 6051.6 5672.1 5695.4 5709.8 5710.7 5720.9 4946.6 5134.8 5151.3 5153.3 5163.0 6138.6 6175.6 6180.2 6228.8 6237.3 6009.5 6013.5 6020.6 6021.4 6057.8 5918.1 6073.5 6104.5 6173.8 6181.4 5840.6 5841.4 5841.8 5843.0 5886.8 5958.4 5959.9 5975.7 6029.7 6036.1 5623.3 5823.1 5855.6 5865.4 5871.5 5692.6 5708.2 5751.9 5777.5 5834.4 5691.1 5697.2 5704.9 5710.6 5751.6 5694.1 5772.0 5787.3 5827.7 5839.4 5635.9 5709.5 5728.1 5730.7 5737.9 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | [#1] ext.html Cycles:180 Average:59617.60 Median:41246.38 stddev:124492.49 (301.8%) stddev-sans-first:124762.84 15:11:29 INFO - PROCESS | 21567 | Values: 590.3 629.3 640.5 654.6 656.8 37204.8 41642.0 41734.4 42135.4 42142.0 42936.6 43228.8 43351.0 43524.0 43764.8 8767.2 8868.2 8915.0 8923.6 8947.5 8775.9 8810.7 8828.0 8829.1 8832.2 8838.9 8864.1 8876.6 8893.6 8935.0 8801.9 8841.1 8847.1 8873.2 8898.8 8686.3 8756.2 8796.6 8801.2 8812.5 34669.0 40764.8 41181.0 41299.2 41311.0 3270.2 3439.7 3468.6 3526.9 3527.0 31311.4 31625.5 31747.2 31828.7 32111.8 4108.7 4145.2 4154.4 4189.1 4316.1 281835.0 282484.0 283941.0 284254.0 284866.0 34282.7 35096.0 35252.8 35397.5 35432.5 34568.8 36899.4 37110.0 37171.6 37221.8 16052.1 16080.5 16160.7 16193.4 16234.4 12375.7 12440.5 12448.0 12473.7 12553.1 8314.3 8325.0 8439.1 8452.7 8472.9 3238.7 3272.0 3287.1 3308.9 3357.8 992.3 1039.4 1097.2 1105.4 1183.5 32008.5 32442.7 32540.5 32824.7 32899.8 1073.1 1114.1 1129.1 1133.4 1217.3 16674.6 17460.3 17506.7 17539.5 17576.6 571998.0 574487.0 576189.0 578643.0 581164.0 61889.7 62428.7 62487.4 62569.0 62777.7 1339.8 1353.0 1385.2 1399.5 1401.8 30383.4 31391.0 31619.8 31978.2 32430.0 52040.2 52998.7 53036.0 53060.5 53294.5 484822.0 488523.0 491047.0 491646.0 494003.0 28873.3 29172.4 29210.6 29299.7 29323.0 50106.0 50260.0 51240.2 51813.0 51814.0 41103.8 42929.4 43345.6 43355.6 44125.7 42826.6 43328.4 43398.8 43494.8 43731.8 41193.6 41958.8 42590.6 43029.0 43075.6 36196.5 38596.2 38636.0 39004.2 39028.8 28068.0 28127.3 28349.3 28489.0 28583.4 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | [#2] jquery.html Cycles:180 Average:28492.07 Median:396.49 stddev:79393.53 (20024.3%) stddev-sans-first:79588.21 15:11:29 INFO - PROCESS | 21567 | Values: 388.3 392.1 393.2 399.8 411.3 17985.7 18900.1 19589.6 19598.0 19886.4 18685.5 18714.3 18945.1 19520.0 19677.8 5609.4 5667.7 5796.2 5824.5 5849.3 5755.4 5771.8 5775.7 5787.8 5793.4 5537.4 5774.8 5781.0 5787.4 5804.3 5536.2 5764.0 5776.1 5782.7 5785.7 5142.4 5143.4 5150.9 5152.4 5167.2 22712.0 22768.3 23061.5 23162.9 23231.0 2346.3 2390.2 2403.2 2568.9 2949.9 9352.3 9898.1 9934.9 10346.2 14674.8 1839.1 1879.9 1883.7 1885.6 1956.1 79828.0 81189.0 81841.6 83207.2 85069.0 10783.0 10886.3 10955.2 10994.4 11095.8 15301.2 15314.5 15451.8 15497.5 15507.5 8055.3 8129.7 8404.4 8547.5 8560.2 8109.6 8162.0 8258.3 8282.0 8552.1 4553.7 4595.6 4700.4 4709.5 4880.7 1890.3 1918.8 1948.2 1956.3 1963.4 946.7 952.8 1025.1 1026.0 1073.0 18636.9 19052.3 19895.7 19963.5 20029.5 1011.3 1011.9 1039.3 1053.2 1073.8 10645.4 11222.4 11229.3 11297.5 11338.5 471729.0 472284.0 476844.0 480687.0 506850.0 57417.7 65908.7 93275.0 93397.0 95224.5 998.4 1000.7 1017.8 1030.5 1031.7 17404.7 17474.1 17722.7 17779.6 17932.9 42168.8 42661.4 43078.8 43833.1 44537.8 58855.4 59013.4 59576.4 60571.7 61265.0 7099.7 7462.9 7490.6 8415.1 8592.3 9221.8 12517.2 12644.0 12822.0 13248.7 11078.7 11373.2 11592.4 11615.9 11996.0 11740.3 11804.5 11878.5 11946.9 12215.3 10052.5 10136.0 11873.8 12250.4 12319.1 7252.2 7279.7 7285.5 7332.5 7380.4 9256.1 9532.8 9674.1 9687.0 9859.9 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | [#3] mootools.html Cycles:180 Average:5782.03 Median:4871.59 stddev:3301.47 (67.8%) stddev-sans-first:3294.77 15:11:29 INFO - PROCESS | 21567 | Values: 1462.9 1484.5 1580.3 1691.6 1701.5 7714.3 8338.3 8456.5 9013.1 9053.9 8515.1 8714.6 8779.5 8818.6 8864.1 2264.1 2302.2 2305.4 2309.7 2322.6 2306.3 2339.4 2382.9 2387.6 2388.7 2369.8 2379.4 2389.2 2413.5 2414.0 2270.4 2280.5 2290.9 2290.9 2351.9 2268.1 2286.7 2311.4 2311.6 2313.1 8845.6 8973.1 8996.2 9054.2 9069.0 5074.5 5153.9 5187.3 5190.5 5201.1 3180.6 3220.3 3299.7 3343.7 3345.7 1079.3 1085.9 1086.6 1090.7 1102.5 12869.1 12963.5 13019.2 13045.1 13072.2 4733.2 4777.3 4826.2 4870.5 4872.7 10222.7 10295.3 10316.1 10404.6 10417.6 5016.3 5141.7 5225.5 5241.7 5266.7 4336.3 4776.6 4831.6 4956.0 4961.7 3953.2 4030.3 4093.0 4105.1 4154.0 1280.3 1296.2 1302.8 1305.3 1316.7 833.3 921.4 924.2 953.8 988.7 6141.5 6301.2 6303.1 6306.2 6435.6 444.0 450.7 451.0 453.9 461.2 4072.8 4169.1 4180.2 4220.8 4247.1 10286.2 10538.5 10608.9 10624.0 10636.6 10352.5 10374.8 10379.1 10397.2 10480.4 7781.6 8066.3 8080.8 8116.5 8133.2 5816.2 6007.7 6044.6 6070.3 6145.2 9492.8 9819.0 9899.9 9905.6 9928.2 9916.7 10058.5 10105.5 10115.2 10254.6 7082.8 7483.3 7710.2 7769.4 7823.4 8564.1 8585.5 8628.1 8643.1 8674.1 7539.3 7770.9 7781.8 7871.1 7906.7 7593.5 7664.0 7695.9 7732.8 7879.6 6734.3 6767.1 6780.3 6784.6 6817.3 5051.7 5105.4 5158.3 5272.9 5280.9 5277.2 5280.0 5332.5 5341.0 5369.5 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | [#4] prototype.html Cycles:180 Average:4937.72 Median:5616.62 stddev:1451.58 (25.8%) stddev-sans-first:1413.88 15:11:29 INFO - PROCESS | 21567 | Values: 331.5 335.5 340.9 341.8 344.3 5586.1 5640.9 5695.4 5696.7 5732.4 5575.4 5579.8 5595.1 5599.1 5601.0 4121.6 4178.6 4275.7 4289.6 4313.7 4296.8 4313.1 4357.6 4368.8 4381.5 4330.7 4340.6 4361.2 4367.1 4372.2 4183.8 4343.7 4360.3 4367.3 4368.4 3834.3 3837.8 3843.1 3845.3 3859.2 5488.5 5506.9 5508.9 5513.5 5525.4 4958.2 4998.6 5036.9 5050.6 5066.8 5857.8 5882.7 5904.0 5928.2 5990.0 4266.4 4284.8 4285.2 4318.8 4322.7 5952.2 6020.7 6048.8 6057.5 6069.6 4313.7 4327.3 4361.5 4373.4 4379.0 4307.7 4318.6 4329.5 4332.0 4420.4 4815.3 4907.8 4920.8 4927.4 4977.2 5893.8 5901.2 5905.9 5933.8 5934.6 1480.0 1481.5 1505.9 1506.2 1511.8 972.4 976.6 979.9 984.9 1015.3 5530.4 5574.5 5577.4 5623.0 5626.9 5976.7 5986.5 5992.7 6004.9 6027.9 5350.9 5544.2 5573.8 5583.9 5610.3 3166.3 3176.0 3183.5 3184.7 3213.0 5935.9 6187.4 6212.9 6216.4 6227.8 6080.9 6122.9 6193.9 6197.3 6201.4 6167.9 6212.4 6215.9 6216.5 6225.1 5750.9 5926.2 5956.3 5982.5 5998.8 5949.6 5964.7 5990.2 6018.7 6049.9 5931.3 6122.6 6204.5 6232.9 6253.0 4296.9 4360.1 4365.1 4379.6 4389.4 6043.6 6082.5 6094.4 6109.0 6117.1 5704.8 5735.4 5866.0 5873.6 5881.8 5812.0 5832.2 5836.4 5840.6 5893.0 5303.9 5643.6 5684.5 5689.6 5732.9 5821.2 5824.8 5860.9 5941.6 5986.8 5773.5 5789.2 5790.7 5795.6 5836.6 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - PROCESS | 21567 | [#5] yui.html Cycles:180 Average:19923.41 Median:4066.25 stddev:27530.97 (677.1%) stddev-sans-first:27570.44 15:11:29 INFO - PROCESS | 21567 | Values: 720.6 784.4 805.5 807.7 843.9 14700.6 15613.5 15763.3 15788.5 16297.7 14883.2 14963.6 14994.6 15109.5 15138.5 677.1 804.4 818.9 822.9 830.0 815.3 817.2 820.9 821.5 821.7 868.7 874.9 875.3 875.6 877.1 863.4 865.3 868.5 874.0 874.9 630.3 632.1 634.7 635.2 639.6 14870.3 14982.6 15013.8 15027.1 15103.3 15522.9 15630.5 15737.5 15775.9 16068.9 12266.9 12366.7 12391.3 12550.9 12645.2 3803.2 3827.1 3828.3 3957.7 3975.5 74300.6 74927.0 75602.0 76704.6 77100.0 11887.8 12045.4 12111.3 12209.8 12370.2 22894.3 22894.9 22973.2 22998.0 23003.3 8254.0 8387.7 8392.8 8651.8 8692.6 4789.7 4870.1 4942.4 5002.4 5058.0 3811.7 4055.9 4063.6 4068.9 4073.8 665.7 676.8 679.4 702.3 704.2 750.7 753.1 758.7 773.6 788.9 10176.6 10183.5 10245.8 10277.8 10357.8 740.4 741.4 779.9 789.6 794.8 5044.5 5187.5 5260.6 5319.5 5320.7 71450.3 71966.6 79792.0 118132.0 124795.0 62698.0 65315.0 80106.6 99719.0 105782.0 85545.0 86738.6 89198.6 89394.0 89468.0 9930.6 10029.2 10151.7 10174.6 10242.9 37995.8 48890.8 52613.2 52948.5 53188.5 71299.0 71673.8 77881.6 78987.0 80442.0 12807.4 12938.6 12977.7 13232.3 13334.6 14256.7 14283.6 14288.1 14354.9 15403.6 13468.3 13629.6 13835.2 13844.9 13976.4 12966.9 13003.7 13193.5 13659.3 13713.9 13280.3 13314.5 13536.0 13572.3 14156.8 10113.0 10494.3 10519.0 11047.7 11089.2 10462.1 10573.6 10675.8 10761.7 10785.2 15:11:29 INFO - PROCESS | 21567 | -------- Summary: end -------- 15:11:29 INFO - PROCESS | 21567 | 15:11:29 INFO - TEST-INFO | 21567: exit 0 15:11:29 INFO - TEST-OK | dromaeo_css | took 1112066ms 15:11:29 INFO - TEST-START | kraken 15:11:29 INFO - operating with platform_type : linux_ 15:11:29 INFO - Initialising browser for kraken test... 15:11:29 INFO - TEST-INFO | started process 21805 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH9xD7a/profile http://localhost:33642/getInfo.html) 15:11:34 INFO - PROCESS | 21805 | __metrics Screen width/height:1600/1200 15:11:34 INFO - PROCESS | 21805 | colorDepth:24 15:11:34 INFO - PROCESS | 21805 | Browser inner width/height: 1024/697 15:11:34 INFO - PROCESS | 21805 | __metrics 15:11:35 ERROR - PROCESS | 21805 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 15:11:36 INFO - TEST-INFO | 21805: exit 0 15:11:36 INFO - Browser initialized. 15:11:36 INFO - Running cycle 1/1 for kraken test... 15:11:36 INFO - TEST-INFO | started process 21921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH9xD7a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:48 INFO - PROCESS | 21921 | RSS: Main: 185044992 15:11:48 INFO - PROCESS | 21921 | 15:11:50 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33642/tests/kraken/driver.html?testName=audio-beat-detection) 15:11:51 INFO - PROCESS | 21921 | RSS: Main: 190496768 15:11:51 INFO - PROCESS | 21921 | 15:11:54 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33642/tests/kraken/driver.html?testName=audio-dft) 15:11:55 INFO - PROCESS | 21921 | RSS: Main: 189497344 15:11:55 INFO - PROCESS | 21921 | 15:11:58 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33642/tests/kraken/driver.html?testName=audio-fft) 15:11:58 INFO - PROCESS | 21921 | RSS: Main: 184418304 15:11:58 INFO - PROCESS | 21921 | 15:12:01 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33642/tests/kraken/driver.html?testName=audio-oscillator) 15:12:01 INFO - PROCESS | 21921 | RSS: Main: 184872960 15:12:01 INFO - PROCESS | 21921 | 15:12:03 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33642/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:12:04 INFO - PROCESS | 21921 | RSS: Main: 185065472 15:12:04 INFO - PROCESS | 21921 | 15:12:07 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33642/tests/kraken/driver.html?testName=imaging-darkroom) 15:12:08 INFO - PROCESS | 21921 | RSS: Main: 186146816 15:12:08 INFO - PROCESS | 21921 | 15:12:11 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33642/tests/kraken/driver.html?testName=imaging-desaturate) 15:12:12 INFO - PROCESS | 21921 | RSS: Main: 183939072 15:12:12 INFO - PROCESS | 21921 | 15:12:15 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33642/tests/kraken/driver.html?testName=json-parse-financial) 15:12:15 INFO - PROCESS | 21921 | RSS: Main: 184209408 15:12:15 INFO - PROCESS | 21921 | 15:12:17 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33642/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:12:18 INFO - PROCESS | 21921 | RSS: Main: 184729600 15:12:18 INFO - PROCESS | 21921 | 15:12:19 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:12:20 INFO - PROCESS | 21921 | RSS: Main: 185057280 15:12:20 INFO - PROCESS | 21921 | 15:12:22 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:12:23 INFO - PROCESS | 21921 | RSS: Main: 185749504 15:12:23 INFO - PROCESS | 21921 | 15:12:25 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:12:26 INFO - PROCESS | 21921 | RSS: Main: 185823232 15:12:26 INFO - PROCESS | 21921 | 15:12:29 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:12:29 INFO - PROCESS | 21921 | RSS: Main: 185372672 15:12:29 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | Cycle 1(1): loaded http://localhost:33642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33642/tests/kraken/driver.html?testName=ai-astar) 15:12:31 INFO - PROCESS | 21921 | RSS: Main: 185888768 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | __start_tp_report 15:12:31 INFO - PROCESS | 21921 | _x_x_mozilla_page_load 15:12:31 INFO - PROCESS | 21921 | _x_x_mozilla_page_load_details 15:12:31 INFO - PROCESS | 21921 | |i|pagename|runs| 15:12:31 INFO - PROCESS | 21921 | |0;ai-astar;111;107;110;111;112;112;110;113;109;112 15:12:31 INFO - PROCESS | 21921 | |1;audio-beat-detection;168;134;157;176;133;153;163;128;181;124 15:12:31 INFO - PROCESS | 21921 | |2;audio-dft;162;163;163;162;166;172;161;163;163;162 15:12:31 INFO - PROCESS | 21921 | |3;audio-fft;75;76;75;162;75;75;75;75;172;76 15:12:31 INFO - PROCESS | 21921 | |4;audio-oscillator;86;86;145;85;85;86;153;86;87;147 15:12:31 INFO - PROCESS | 21921 | |5;imaging-gaussian-blur;117;118;117;118;117;117;118;120;117;117 15:12:31 INFO - PROCESS | 21921 | |6;imaging-darkroom;153;159;158;157;158;155;163;155;159;157 15:12:31 INFO - PROCESS | 21921 | |7;imaging-desaturate;96;95;95;95;96;96;96;96;97;95 15:12:31 INFO - PROCESS | 21921 | |8;json-parse-financial;56;55;54;55;55;57;55;54;54;54 15:12:31 INFO - PROCESS | 21921 | |9;json-stringify-tinderbox;61;61;62;62;62;62;61;61;61;62 15:12:31 INFO - PROCESS | 21921 | |10;stanford-crypto-aes;81;80;86;82;81;81;82;84;105;82 15:12:31 INFO - PROCESS | 21921 | |11;stanford-crypto-ccm;135;129;133;132;123;132;135;130;134;127 15:12:31 INFO - PROCESS | 21921 | |12;stanford-crypto-pbkdf2;162;163;167;163;163;163;180;170;162;165 15:12:31 INFO - PROCESS | 21921 | |13;stanford-crypto-sha256-iterative;64;72;65;65;64;64;66;64;66;63 15:12:31 INFO - PROCESS | 21921 | __end_tp_report 15:12:31 INFO - PROCESS | 21921 | __start_cc_report 15:12:31 INFO - PROCESS | 21921 | _x_x_mozilla_cycle_collect,895 15:12:31 INFO - PROCESS | 21921 | __end_cc_report 15:12:31 INFO - PROCESS | 21921 | __startTimestamp1465510351798__endTimestamp 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | ------- Summary: start ------- 15:12:31 INFO - PROCESS | 21921 | Number of tests: 14 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:1.77 (1.6%) stddev-sans-first:1.87 15:12:31 INFO - PROCESS | 21921 | Values: 111.0 107.0 110.0 111.0 112.0 112.0 110.0 113.0 109.0 112.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:160.00 stddev:20.72 (13.0%) stddev-sans-first:21.12 15:12:31 INFO - PROCESS | 21921 | Values: 168.0 134.0 157.0 176.0 133.0 153.0 163.0 128.0 181.0 124.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.20 (2.0%) stddev-sans-first:3.33 15:12:31 INFO - PROCESS | 21921 | Values: 162.0 163.0 163.0 162.0 166.0 172.0 161.0 163.0 163.0 162.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#3] audio-fft Cycles:10 Average:93.60 Median:75.00 stddev:38.76 (51.7%) stddev-sans-first:40.52 15:12:31 INFO - PROCESS | 21921 | Values: 75.0 76.0 75.0 162.0 75.0 75.0 75.0 75.0 172.0 76.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:86.00 stddev:30.25 (35.2%) stddev-sans-first:31.32 15:12:31 INFO - PROCESS | 21921 | Values: 86.0 86.0 145.0 85.0 85.0 86.0 153.0 86.0 87.0 147.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.00 15:12:31 INFO - PROCESS | 21921 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 118.0 120.0 117.0 117.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#6] imaging-darkroom Cycles:10 Average:157.40 Median:158.00 stddev:2.76 (1.7%) stddev-sans-first:2.42 15:12:31 INFO - PROCESS | 21921 | Values: 153.0 159.0 158.0 157.0 158.0 155.0 163.0 155.0 159.0 157.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:12:31 INFO - PROCESS | 21921 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 97.0 95.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:0.97 15:12:31 INFO - PROCESS | 21921 | Values: 56.0 55.0 54.0 55.0 55.0 57.0 55.0 54.0 54.0 54.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 15:12:31 INFO - PROCESS | 21921 | Values: 61.0 61.0 62.0 62.0 62.0 62.0 61.0 61.0 61.0 62.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:82.00 stddev:7.44 (9.1%) stddev-sans-first:7.79 15:12:31 INFO - PROCESS | 21921 | Values: 81.0 80.0 86.0 82.0 81.0 81.0 82.0 84.0 105.0 82.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:132.50 stddev:3.83 (2.9%) stddev-sans-first:3.78 15:12:31 INFO - PROCESS | 21921 | Values: 135.0 129.0 133.0 132.0 123.0 132.0 135.0 130.0 134.0 127.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:164.00 stddev:5.59 (3.4%) stddev-sans-first:5.76 15:12:31 INFO - PROCESS | 21921 | Values: 162.0 163.0 167.0 163.0 163.0 163.0 180.0 170.0 162.0 165.0 15:12:31 INFO - PROCESS | 21921 | 15:12:31 INFO - PROCESS | 21921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:2.54 (3.9%) stddev-sans-first:2.65 15:12:31 INFO - PROCESS | 21921 | Values: 64.0 72.0 65.0 65.0 64.0 64.0 66.0 64.0 66.0 63.0 15:12:31 INFO - PROCESS | 21921 | -------- Summary: end -------- 15:12:31 INFO - PROCESS | 21921 | 15:12:32 INFO - TEST-INFO | 21921: exit 0 15:12:32 INFO - TEST-OK | kraken | took 62930ms 15:12:32 INFO - SUITE-END | took 1174s 15:12:32 INFO - Completed test suite (00:19:35) 15:12:32 INFO - javascript benchmark 15:12:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7261.259840444578, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.3765246950616, 3133.702298281663, 3139.0896639974408, 3143.5599016137744, 3145.370925814836, 5354.491323324283, 5365.195220716894, 5420.837374878755, 5500.4499550044975, 5574.052411090114, 5406.243125962358, 5438.048341540234, 5439.347278326606, 5467.343918729748, 5540.722963851801, 4989.426215985162, 5005.899882002358, 5117.309163262968, 5144.202648589475, 5151.124308867502, 5045.571126454238, 5156.948430515703, 5185.170372740362, 5186.351706036746, 5187.4034486034025, 4985.40175178979, 5055.368078990126, 5067.417247016603, 5072.26452164436, 5076.416212135597, 5022.824201152942, 5027.2207807789855, 5028.7737051832755, 5030.849074527733, 5095.515925987025, 4976.054549635558, 5003.5997120230295, 5007.198848184309, 5008.1486147355035, 5026.623003274733, 5542.528885044776, 5582.413846546095, 5600.803971860965, 5627.577931655102, 5640.210370548127, 5985.700714964234, 6013.067974463965, 6047.848803779897, 6049.213602231725, 6066.696665166724, 5839.883202335972, 5879.32387775407, 6108.694565271719, 6126.264848218198, 6129.448349648553, 5500.889982200333, 5520.227168196456, 5531.8340449786165, 5550.195221692832, 5560.4161563036105, 5959.970200149059, 5981.551383646157, 6004.609700369462, 6008.969955150196, 6032.909506357408, 5726.3700992890745, 5780.739866706008, 5781.479666830005, 5809.186713860063, 5889.587728858939, 6022.608530445595, 6026.126211699279, 6028.005379112397, 6045.244344456943, 6075.5747097703625, 5651.858703532444, 5682.971585142048, 5823.621464604787, 5976.133460648181, 5983.371745966698, 5664.8867022659315, 5763.279590051244, 5804.854878627983, 5805.941940580625, 5819.330776960704, 4478.350639157369, 4525.864224073283, 4551.907542189851, 4584.19776539111, 4585.151746926763, 4053.6554392876938, 4055.4930633670792, 4061.431399604058, 4093.3450647896193, 4105.0763578195265, 5533.861653458695, 5719.971400142973, 5757.453041961007, 5801.3328467225965, 5802.332731735904, 5975.850603734942, 5994.730237139339, 5994.790182343684, 6046.788362407295, 6051.636901785907, 5672.14917762339, 5695.401982791747, 5709.8287051388525, 5710.71446427677, 5720.942790572041, 4946.604271658259, 5134.845954621367, 5151.304573882553, 5153.3300670913295, 5163.0, 6138.631682099089, 6175.567710260329, 6180.227471566054, 6228.781992630236, 6237.251529816361, 6009.549283803644, 6013.530693335866, 6020.608660437058, 6021.367756385692, 6057.818265452043, 5918.141869428995, 6073.514118870568, 6104.511639068775, 6173.753049877954, 6181.412765787243, 5840.620359676607, 5841.415858414124, 5841.824745257649, 5843.0, 5886.764529418775, 5958.433948775033, 5959.940400595939, 5975.671338076448, 6029.698515074317, 6036.124761909587, 5623.268975033219, 5823.097419899922, 5855.648661080349, 5865.354810970704, 5871.530277577698, 5692.601517893708, 5708.200851880657, 5751.942480575308, 5777.508911742549, 5834.38738932406, 5691.146328050825, 5697.173909783141, 5704.942950570441, 5710.600257981901, 5751.626144300607, 5694.06048002075, 5772.0, 5787.334456537552, 5827.70861456917, 5839.386864379179, 5635.859103522281, 5709.514691251124, 5728.140778883201, 5730.656160630376, 5737.9139312911175], "value": 5472.966561917599, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.3211306996953, 629.3203340392374, 640.497209690393, 654.6105067484847, 656.8423578341194, 37204.81397593012, 41642.0, 41734.373984390186, 42135.367969480445, 42142.0, 42936.57063429365, 43228.78385608068, 43351.0, 43524.0, 43764.781176094155, 8767.16711912369, 8868.201861832435, 8915.0, 8923.553822308892, 8947.463152210888, 8775.912240877606, 8810.735677929672, 8828.0, 8829.117088291183, 8832.249258813008, 8838.86741698875, 8864.113588641116, 8876.6005529751, 8893.599788009522, 8935.0, 8801.867971980426, 8841.115888411172, 8847.071057538962, 8873.245774109208, 8898.777530561756, 8686.261667758185, 8756.211940925346, 8796.560171991376, 8801.207891289814, 8812.471251724917, 34669.0, 40764.79617601893, 41181.0, 41299.1740165198, 41311.0, 3270.198801293698, 3439.6560343965652, 3468.5664291963503, 3526.929461410783, 3527.0476971217627, 31311.37377252442, 31625.525617115763, 31747.206319841956, 31828.681713182803, 32111.83944080288, 4108.712390132692, 4145.150244199962, 4154.356074808409, 4189.141226048683, 4316.050468896838, 281835.0, 282484.0, 283941.0, 284254.0, 284866.0, 34282.657173428444, 35096.0, 35252.82373588115, 35397.46903796445, 35432.46851297233, 34568.82715586406, 36899.4465083024, 37110.0, 37171.62828371736, 37221.81389093091, 16052.117133557533, 16080.517584472485, 16160.67678646444, 16193.433229836899, 16234.431794887123, 12375.69060773488, 12440.502379904883, 12448.0, 12473.688157796129, 12553.12128151039, 8314.334853211729, 8325.0, 8439.071702112762, 8452.704155354533, 8472.915270847336, 3238.659940706239, 3271.9672803272138, 3287.1263379873244, 3308.9007329780147, 3357.7649564530248, 992.3053862296422, 1039.378569431689, 1097.1771171621283, 1105.4417519152937, 1183.5443354308654, 32008.519872201934, 32442.675573244436, 32540.511892321632, 32824.671753282164, 32899.835500822344, 1073.1039581949003, 1114.1142791480631, 1129.0910816792398, 1133.3879704959395, 1217.2513903949007, 16674.582660473996, 17460.30158793634, 17506.737398939025, 17539.473815785546, 17576.648467030842, 571998.0, 574487.0, 576189.0, 578643.0, 581164.0, 61889.69055154786, 62428.68785656043, 62487.37512624906, 62569.0, 62777.68611156915, 1339.8124262603244, 1352.9864701353058, 1385.2104300548792, 1399.4542128569865, 1401.824771903512, 30383.392332153675, 31391.0, 31619.84190079035, 31978.20054498656, 32430.0, 52040.219396709836, 52998.73500632472, 53036.0, 53060.4693953071, 53294.46705532895, 484822.0, 488523.0, 491047.0, 491646.0, 494003.0, 28873.278168045126, 29172.416551669274, 29210.56184157197, 29299.7070029297, 29323.0, 50106.0, 50260.0, 51240.23139652983, 51813.0, 51814.0, 41103.794481027406, 42929.35605965851, 43345.566544335416, 43355.566444335156, 44125.67622971316, 42826.57173428226, 43328.350074748276, 43398.78300608477, 43494.78252608717, 43731.78134109309, 41193.58806411897, 41958.790206048776, 42590.5740942599, 43029.0, 43075.56924430715, 36196.45705314475, 38596.22807543777, 38636.0, 39004.219915602094, 39028.80485597554, 28068.0, 28127.296817579725, 28349.291267717646, 28489.0, 28583.42833143284], "value": 18845.364538090485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.281678894046, 392.06296950288834, 393.21553500765975, 399.7581463214755, 411.31721342571336, 17985.730214046784, 18900.149493272802, 19589.608207835834, 19598.020098995046, 19886.40340789775, 18685.532861678465, 18714.25142994282, 18945.14746836392, 19520.023998800076, 19677.803221967777, 5609.411011843759, 5667.659940403579, 5796.159556864252, 5824.504917082053, 5849.327327357345, 5755.424457554232, 5771.769129234825, 5775.711214439282, 5787.826365209051, 5793.420657934215, 5537.390887002426, 5774.797882074128, 5780.971095144519, 5787.392323806003, 5804.303483581976, 5536.2249285099715, 5764.048931926227, 5776.133579962997, 5782.710864456782, 5785.652860828342, 5142.408623008327, 5143.382794064699, 5150.871228219287, 5152.433232344439, 5167.22491626259, 22712.0, 22768.316950491513, 23061.53876922452, 23162.884185579132, 23231.0, 2346.272655476808, 2390.175389490623, 2403.218953840009, 2568.8972441102333, 2949.8820047198087, 9352.251819854395, 9898.10917017472, 9934.90065099347, 10346.172306215485, 14674.779878301833, 1839.1264149529, 1879.8872067675848, 1883.6703576873992, 1885.632301701169, 1956.0806420982115, 79828.0, 81189.0, 81841.59079204565, 83207.16792832054, 85069.0, 10783.029527342576, 10886.346819190874, 10955.17836162291, 10994.395308258123, 11095.83356249657, 15301.158436285888, 15314.463993760164, 15451.84548154504, 15497.535073947574, 15507.457238996582, 8055.315298199602, 8129.674813007532, 8404.411691181558, 8547.487150770974, 8560.186782255676, 8109.594520273963, 8162.0, 8258.25675689191, 8282.0, 8552.144785521523, 4553.658475614276, 4595.609373203315, 4700.435947686299, 4709.529047095263, 4880.707157570557, 1890.328933228684, 1918.8177123173555, 1948.2109745553073, 1956.2859556261863, 1963.4011626453782, 946.7491114854569, 952.8475443928938, 1025.0671888581355, 1025.9692209233735, 1072.951717172729, 18636.906815465834, 19052.333168339042, 19895.701564476545, 19963.500912477015, 20029.49926251826, 1011.2819897872592, 1011.9190464762949, 1039.3140527251978, 1053.2206167436043, 1073.7798751255973, 10645.414502202453, 11222.382768947624, 11229.3262404256, 11297.548098075986, 11338.546458141582, 471729.0, 472284.0, 476844.0, 480687.0, 506850.0, 57417.71291143518, 65908.6704566474, 93275.0, 93397.0, 95224.52387738155, 998.381003777648, 1000.7147962830704, 1017.7913527726798, 1030.469308306208, 1031.7162780235494, 17404.651906962044, 17474.12629368552, 17722.73415898737, 17779.555511112325, 17932.91033544876, 42168.78915605402, 42661.36007959945, 43078.78460607677, 43833.12333753243, 44537.777311113234, 58855.411445884994, 59013.40986590251, 59576.40423595709, 60571.69714151401, 61265.0, 7099.716011359695, 7462.850742985219, 7490.588017659081, 8415.11641277657, 8592.312614990911, 9221.815563688555, 12517.248965062125, 12644.0, 12822.0, 13248.735025299633, 11078.667639970814, 11373.20387572862, 11592.36242006664, 11615.941920290345, 11996.0, 11740.295582265091, 11804.527818887149, 11878.46546905374, 11946.940265298617, 12215.26708397499, 10052.497375131068, 10136.0, 11873.821892671443, 12250.387480625755, 12319.076069295019, 7252.202257751537, 7279.745208917874, 7285.490015698851, 7332.49683814806, 7380.409567234716, 9256.120668536478, 9532.761680958032, 9674.129328360481, 9687.0, 9859.901400985898], "value": 9118.912679401923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.8829693624511, 1484.5323723027245, 1580.2809721576684, 1691.6213286171776, 1701.5490894912857, 7714.305712485875, 8338.332933365331, 8456.450330728498, 9013.053629368913, 9053.909460905388, 8515.105913879032, 8714.564271786418, 8779.473231606107, 8818.559072046388, 8864.113588641132, 2264.1056782570877, 2302.1942320187886, 2305.4351683837485, 2309.688192094071, 2322.5703244899664, 2306.319635707462, 2339.415146213447, 2382.9046838126455, 2387.6418537219383, 2388.653645221442, 2369.7748713872156, 2379.393254720044, 2389.199618127929, 2413.4811015631635, 2413.963790543143, 2270.386995511219, 2280.5096904165603, 2290.862548247102, 2290.89690963907, 2351.870647114408, 2268.092762894839, 2286.6570014497793, 2311.410590299463, 2311.6070268054305, 2313.1325752842686, 8845.601947912295, 8973.10268973104, 8996.235319997742, 9054.230390416822, 9068.957069936976, 5074.517920797518, 5153.871153221162, 5187.325647665817, 5190.4550022247495, 5201.141811601081, 3180.6024246969127, 3220.29153586213, 3299.736021118305, 3343.7157841583253, 3345.6821601947777, 1079.3254216114929, 1085.918556108295, 1086.625114335553, 1090.7218659241921, 1102.5148934468807, 12869.09916305859, 12963.48146074156, 13019.153755005895, 13045.086843921024, 13072.1503102299, 4733.171381553148, 4777.3072904429355, 4826.1795494765975, 4870.512948705101, 4872.660018494942, 10222.693319200436, 10295.279330446796, 10316.123129533924, 10404.635837745795, 10417.635382761568, 5016.272640467112, 5141.665791723526, 5225.50357716024, 5241.659292145999, 5266.710330931835, 4336.284513055373, 4776.617870570346, 4831.613470922318, 4955.975220123876, 4961.727105009187, 3953.189596132786, 4030.334994725896, 4093.038136038029, 4105.117399759066, 4154.003039270553, 1280.3406245783428, 1296.1898813241723, 1302.7655022096114, 1305.3277562055548, 1316.6774140335488, 833.3291700181412, 921.3964853021282, 924.1636319131063, 953.756792018031, 988.658912675126, 6141.508679305645, 6301.243850737941, 6303.117563541108, 6306.243250809932, 6435.581687190318, 443.9800208990603, 450.6755136301857, 450.9932351014737, 453.8751843243069, 461.1675924955488, 4072.75563466193, 4169.145325208325, 4180.205760905418, 4220.831166753357, 4247.10810729744, 10286.177105831515, 10538.525766340534, 10608.946955265328, 10624.0, 10636.627718029831, 10352.5341359639, 10374.792504150026, 10379.065884070318, 10397.168226541859, 10480.371177729361, 7781.610919454005, 8066.274035336731, 8080.757577272691, 8116.513009219466, 8133.186681331819, 5816.2438882946635, 6007.669578173242, 6044.576879618385, 6070.332263450929, 6145.231846019247, 9492.810143796947, 9819.0, 9899.851502227328, 9905.55425005862, 9928.205743540355, 9916.652917147865, 10058.547365368722, 10105.5452504636, 10115.241356898408, 10254.6410875619, 7082.787516374517, 7483.289087536676, 7710.151883292721, 7769.417293703108, 7823.413244006836, 8564.05795362522, 8585.484870907765, 8628.137186281572, 8643.135686431306, 8674.132586741276, 7539.32146106853, 7770.883436748566, 7781.766547003599, 7871.094824095302, 7906.683732650629, 7593.544387336778, 7663.961680191564, 7695.92304076952, 7732.8453430932195, 7879.606019699107, 6734.292899245509, 6767.086443330284, 6780.32196780318, 6784.559003664746, 6817.318268173143, 5051.722155281494, 5105.387353517602, 5158.303629010035, 5272.920906186334, 5280.947190528045, 5277.20841873722, 5280.049591073644, 5332.520073193431, 5340.973295133499, 5369.5167434931045], "value": 4547.453742593809, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.4845415379086, 335.4733069081542, 340.87217293514925, 341.8205442142876, 344.26327658810135, 5586.078297080977, 5640.858978525539, 5695.430456954303, 5696.718238396364, 5732.369439361667, 5575.414581468948, 5579.80034292627, 5595.132754423061, 5599.1041433370665, 5600.96382169299, 4121.608447197512, 4178.623923846853, 4275.657947364219, 4289.5924887135825, 4313.676474264443, 4296.763677997709, 4313.1158112587, 4357.564243575633, 4368.759718215497, 4381.474223093217, 4330.653547716175, 4340.609345158935, 4361.171377438292, 4367.1265746850595, 4372.23485889968, 4183.828528012146, 4343.652507799368, 4360.280553708666, 4367.323064924942, 4368.3884256204, 3834.328992426342, 3837.827297771579, 3843.1160833008566, 3845.288621605012, 3859.2281543691092, 5488.506034456918, 5506.91739623906, 5508.862278443031, 5513.4562322549755, 5525.364583072957, 4958.2481722643915, 4998.600111991032, 5036.924446133311, 5050.646454748169, 5066.847994560169, 5857.7949771757785, 5882.735276912506, 5903.9668058089665, 5928.170056192136, 5990.041593345044, 4266.402703621496, 4284.828606855722, 4285.185814695198, 4318.82724691012, 4322.654187665011, 5952.226210592638, 6020.6989650517735, 6048.7882924097885, 6057.454829065406, 6069.6054756441135, 4313.705888233518, 4327.2643650579475, 4361.498427680794, 4373.431453910971, 4378.978105109518, 4307.7415355078165, 4318.596456151763, 4329.545397733255, 4332.0, 4420.425344705168, 4815.30178124177, 4907.803687852517, 4920.803167873245, 4927.359443272351, 4977.1538838397555, 5893.764249430061, 5901.17383566301, 5905.881882362329, 5933.792317268875, 5934.584579079423, 1480.0, 1481.525911708243, 1505.8720008799376, 1506.239349128683, 1511.833698293187, 972.4262685015875, 976.5800705696477, 979.8584648884113, 984.8965858584888, 1015.2740790334798, 5530.364008139035, 5574.526165275997, 5577.386487486373, 5622.97188514063, 5626.887462250732, 5976.73104710289, 5986.491148252448, 5992.733959991728, 6004.8799024020145, 6027.854707605541, 5350.8662283442445, 5544.1960915667005, 5573.804916827973, 5583.944160558423, 5610.27066481363, 3166.2717574957887, 3175.967810461609, 3183.4588120019653, 3184.7420268994083, 3212.9678703213135, 5935.851603709855, 6187.3503282154725, 6212.9378706213265, 6216.409441103178, 6227.847848148107, 6080.8783824324155, 6122.938770612326, 6193.938060619336, 6197.287311959182, 6201.379862013762, 6167.907481387693, 6212.353726262544, 6215.9378406215355, 6216.502679785606, 6225.066240063936, 5750.9424905752085, 5926.1999630049395, 5956.285245770362, 5982.52139828804, 5998.790042348497, 5949.583529152917, 5964.731587078505, 5990.2212712348855, 6018.668973206516, 6049.879002420015, 5931.288245410578, 6122.602030867979, 6204.472619827185, 6232.906506402317, 6253.0, 4296.871093867189, 4360.127974405195, 4365.148795984879, 4379.627731642719, 4389.385486031894, 6043.607165534227, 6082.513398928164, 6094.3545242785085, 6108.969455152695, 6117.143599896107, 5704.801991581814, 5735.369109398046, 5865.970670146622, 5873.588848780715, 5881.823545293648, 5811.970940145272, 5832.154337621106, 5836.358000620014, 5840.591158618856, 5892.970535147297, 5303.893922121613, 5643.633163844337, 5684.488396044376, 5689.601727879009, 5732.856678583069, 5821.243238378984, 5824.767009319579, 5860.853478663067, 5941.58408911372, 5986.760529578768, 5773.509251713652, 5789.189513468202, 5790.712668496005, 5795.565332599987, 5836.562257830595], "value": 4469.945732239999, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.6180724216167, 784.3999340504515, 805.4804651000105, 807.6850028488894, 843.890284276177, 14700.558983230494, 15613.531594052169, 15763.290651920677, 15788.526344209664, 16297.674046519078, 14883.18142502162, 14963.551093467186, 14994.62513437162, 15109.471168509104, 15138.470153544627, 677.1366507702669, 804.3926835239386, 818.8935438393, 822.8601137806558, 830.0122853803985, 815.3314282288496, 817.2481317188171, 820.9096999330069, 821.5317269156583, 821.6549049399237, 868.7089824908663, 874.9343799215053, 875.2647775868301, 875.6322344615245, 877.1404024056428, 863.4258218284864, 865.3034307382586, 868.5006121480143, 873.9563021848882, 874.9387542872001, 630.3286999345682, 632.1466020871832, 634.6667999300358, 635.1742734445203, 639.6034458635629, 14870.256487175706, 14982.62543436412, 15013.774793378108, 15027.09837409759, 15103.32035058425, 15522.922385388114, 15630.531084067496, 15737.52787416368, 15775.92112039444, 16068.919655401765, 12266.877331226662, 12366.690832729164, 12391.318477483735, 12550.874491255061, 12645.241285522807, 3803.2013277211818, 3827.0623697194087, 3828.3109040372724, 3957.7427467214825, 3975.4831871856763, 74300.62849685771, 74927.0, 75602.0, 76704.61647691781, 77100.0, 11887.821682674767, 12045.397730113635, 12111.333876636869, 12209.807357255158, 12370.195937264049, 22894.31317060491, 22894.885525572598, 22973.19593814242, 22998.0, 23003.309900703007, 8254.0, 8387.748367548984, 8392.832143357098, 8651.78370540729, 8692.608832602547, 4789.736564488917, 4870.1233777920315, 4942.431620363633, 5002.374703162105, 5058.0, 3811.676007539335, 4055.878323650295, 4063.593640635913, 4068.898277543085, 4073.796310184479, 665.7270519087151, 676.8307923019245, 679.358006683689, 702.2801628331001, 704.2112833626371, 750.6884642873256, 753.1451802204538, 758.6510205305511, 773.5783997721255, 788.8501184774874, 10176.643817466353, 10183.490825458697, 10245.84631230532, 10277.794444111225, 10357.844632330522, 740.4372676765697, 741.3994664321916, 779.8557266905641, 789.6486063701713, 794.8251384695358, 5044.495550444926, 5187.455317191716, 5260.631755777059, 5319.46805319465, 5320.733963301819, 71450.2854971454, 71966.64016679882, 79792.0, 118132.0, 124795.0, 62698.0, 65315.0, 80106.59946700229, 99719.00842974722, 105782.0, 85545.0, 86738.56630716806, 89198.55400722956, 89394.0, 89468.0, 9930.602775888883, 10029.247806414694, 10151.746206344606, 10174.643887463903, 10242.948785256027, 37995.81002094972, 48890.75554622204, 52613.21080183724, 52948.47051529436, 53188.4681153199, 71299.0, 71673.84978450654, 77881.61059194895, 78987.0, 80442.0, 12807.423665934868, 12938.611841644766, 12977.740445191232, 13232.272225027717, 13334.599962001155, 14256.714865702836, 14283.64290892736, 14288.142711437347, 14354.928225358806, 15403.61490962735, 13468.326583670972, 13629.63999440291, 13835.239061851695, 13844.930775346058, 13976.371063302378, 12966.935165324114, 13003.739925201255, 13193.472261109831, 13659.317034148451, 13713.931430342784, 13280.269585172908, 13314.46742130304, 13536.0, 13572.253526056162, 14156.787648185491, 10113.0, 10494.265401421828, 10519.0, 11047.668569942914, 11089.174070417952, 10462.110720588531, 10573.577056917637, 10675.786484270116, 10761.677149685522, 10785.191110666889], "value": 7666.382229540126, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 110.0, 111.0, 112.0, 112.0, 110.0, 113.0, 109.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 134.0, 157.0, 176.0, 133.0, 153.0, 163.0, 128.0, 181.0, 124.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 162.0, 166.0, 172.0, 161.0, 163.0, 163.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 162.0, 75.0, 75.0, 75.0, 75.0, 172.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 145.0, 85.0, 85.0, 86.0, 153.0, 86.0, 87.0, 147.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 120.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 159.0, 158.0, 157.0, 158.0, 155.0, 163.0, 155.0, 159.0, 157.0], "value": 157.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 54.0, 55.0, 55.0, 57.0, 55.0, 54.0, 54.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 86.0, 82.0, 81.0, 81.0, 82.0, 84.0, 105.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 133.0, 132.0, 123.0, 132.0, 135.0, 130.0, 134.0, 127.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 167.0, 163.0, 163.0, 163.0, 180.0, 170.0, 162.0, 165.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 65.0, 65.0, 64.0, 64.0, 66.0, 64.0, 66.0, 63.0], "value": 65.3, "unit": "score"}]}]} 15:12:33 INFO - Return code: 0 15:12:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:12:33 ERROR - # TBPL SUCCESS # 15:12:33 INFO - Running post-action listener: _resource_record_post_action 15:12:33 INFO - ##### 15:12:33 INFO - ##### Finished run-tests step (success) 15:12:33 INFO - ##### 15:12:33 INFO - Running post-run listener: _resource_record_post_run 15:12:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541179904; Read time: 20; Write time: 589488 15:12:33 INFO - TinderboxPrint: CPU usage
13.5% 15:12:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 15:12:33 INFO - TinderboxPrint: I/O write bytes / time
541,179,904 / 589,488 15:12:33 INFO - TinderboxPrint: CPU idle
8,231.4 (86.5%) 15:12:33 INFO - TinderboxPrint: CPU user
1,224.5 (12.9%) 15:12:33 INFO - TinderboxPrint: Swap in / out
0 / 0 15:12:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248086528; Read time: 0; Write time: 292000 15:12:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293093376; Read time: 20; Write time: 297488 15:12:33 INFO - Running post-run listener: _upload_blobber_files 15:12:33 INFO - Blob upload gear active. 15:12:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:12:33 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 15:12:33 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:12:33 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:12:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:12:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:34 INFO - (blobuploader) - INFO - Done attempting. 15:12:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:12:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:12:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:35 INFO - (blobuploader) - INFO - Done attempting. 15:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:12:39 INFO - (blobuploader) - INFO - Done attempting. 15:12:39 INFO - (blobuploader) - INFO - Iteration through files over. 15:12:39 INFO - Return code: 0 15:12:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:12:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:12:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0295c8d77682d0f1ae33d45a62e31a05e7d99cf1eb5f0210ff9e75760cf39e81ce2189bcaa903d7c12a233c09c623fa1886ec76416d0a84c9bfcf74fb9bb6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa1215ef4d684e68176a5bd6e1bf4e919ea202408b2ab118ba7fc21e10e4ddaf56ffa67d755c55ba8c609bcaf59f56eee52c33e9607010c43aaab7580b2130d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19f136fd44957caa621a963b5f77195f818d55b1109edfdb8c2bbc130b70551c84553186605413fa5379b047dcbdc06bc6fab42febe2367a525c46f4b658919d"} 15:12:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:12:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:12:39 INFO - Contents: 15:12:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b0295c8d77682d0f1ae33d45a62e31a05e7d99cf1eb5f0210ff9e75760cf39e81ce2189bcaa903d7c12a233c09c623fa1886ec76416d0a84c9bfcf74fb9bb6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa1215ef4d684e68176a5bd6e1bf4e919ea202408b2ab118ba7fc21e10e4ddaf56ffa67d755c55ba8c609bcaf59f56eee52c33e9607010c43aaab7580b2130d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19f136fd44957caa621a963b5f77195f818d55b1109edfdb8c2bbc130b70551c84553186605413fa5379b047dcbdc06bc6fab42febe2367a525c46f4b658919d"} 15:12:39 INFO - Running post-run listener: copy_logs_to_upload_dir 15:12:39 INFO - Copying logs to upload dir... 15:12:39 INFO - mkdir: /builds/slave/test/build/upload/logs 15:12:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.176728 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-09 15:12:38.782105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 15:12:38.786678) ========= 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=920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507 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/sha512/b0295c8d77682d0f1ae33d45a62e31a05e7d99cf1eb5f0210ff9e75760cf39e81ce2189bcaa903d7c12a233c09c623fa1886ec76416d0a84c9bfcf74fb9bb6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa1215ef4d684e68176a5bd6e1bf4e919ea202408b2ab118ba7fc21e10e4ddaf56ffa67d755c55ba8c609bcaf59f56eee52c33e9607010c43aaab7580b2130d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19f136fd44957caa621a963b5f77195f818d55b1109edfdb8c2bbc130b70551c84553186605413fa5379b047dcbdc06bc6fab42febe2367a525c46f4b658919d"} build_url:https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/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/sha512/b0295c8d77682d0f1ae33d45a62e31a05e7d99cf1eb5f0210ff9e75760cf39e81ce2189bcaa903d7c12a233c09c623fa1886ec76416d0a84c9bfcf74fb9bb6a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fa1215ef4d684e68176a5bd6e1bf4e919ea202408b2ab118ba7fc21e10e4ddaf56ffa67d755c55ba8c609bcaf59f56eee52c33e9607010c43aaab7580b2130d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/19f136fd44957caa621a963b5f77195f818d55b1109edfdb8c2bbc130b70551c84553186605413fa5379b047dcbdc06bc6fab42febe2367a525c46f4b658919d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 15:12:38.820536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:12:38.820919) ========= 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=920470bf432669ad7e3a5387000001ca-1465509122.577779-395407507 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 15:12:38.903208) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 15:12:38.903531) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 15:12:38.903819) ========= ========= Total master_lag: 0.19 =========