builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-035 starttime: 1465507907.89 results: success (0) buildid: 20160609113016 builduid: 8e4747667347419d9e7e78983d3bed2a revision: afc529c199066e9c9d8a88318f24f631a7678d53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:47.891833) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:47.892559) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:47.893036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:47.908899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:47.909187) ========= 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=ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 14:31:47-- 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% 51.0M=0s 2016-06-09 14:31:48 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114062 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.037348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.037836) ========= 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=ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020593 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.089087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.089606) ========= 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=ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 14:31:48,208 truncating revision to first 12 chars 2016-06-09 14:31:48,208 Setting DEBUG logging. 2016-06-09 14:31:48,208 attempt 1/10 2016-06-09 14:31:48,208 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:31:48,523 unpacking tar archive at: fx-team-afc529c19906/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676004 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.779682) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.780010) ========= script_repo_revision: afc529c199066e9c9d8a88318f24f631a7678d53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.780418) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.780712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 14:31:48.790333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-09 14:31:48.790680) ========= /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=ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:31:48 INFO - MultiFileLogger online at 20160609 14:31:48 in /builds/slave/test 14:31:48 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:31:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:31:48 INFO - {'append_to_log': False, 14:31:48 INFO - 'base_work_dir': '/builds/slave/test', 14:31:48 INFO - 'blob_upload_branch': 'Fx-Team', 14:31:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:31:48 INFO - 'branch': 'Fx-Team', 14:31:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:31:48 INFO - 'config_files': ('talos/linux_config.py',), 14:31:48 INFO - 'default_actions': ('clobber', 14:31:48 INFO - 'read-buildbot-config', 14:31:48 INFO - 'download-and-extract', 14:31:48 INFO - 'populate-webroot', 14:31:48 INFO - 'create-virtualenv', 14:31:48 INFO - 'install', 14:31:48 INFO - 'run-tests'), 14:31:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:31:48 INFO - 'download_minidump_stackwalk': True, 14:31:48 INFO - 'download_symbols': 'ondemand', 14:31:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:31:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:31:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:31:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:31:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:31:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:31:48 INFO - 'installer_path': 'installer.exe', 14:31:48 INFO - 'log_level': 'info', 14:31:48 INFO - 'log_name': 'talos', 14:31:48 INFO - 'log_to_console': True, 14:31:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:31:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:31:48 INFO - 'opt_config_files': (), 14:31:48 INFO - 'pip_index': False, 14:31:48 INFO - 'sps_profile': False, 14:31:48 INFO - 'sps_profile_interval': 0, 14:31:48 INFO - 'suite': 'dromaeojs-e10s', 14:31:48 INFO - 'system_bits': '32', 14:31:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:31:48 INFO - 'title': 'talos-linux64-ix-035', 14:31:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:31:48 INFO - 'use_talos_json': True, 14:31:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:31:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:31:48 INFO - 'work_dir': 'build'} 14:31:48 INFO - ##### 14:31:48 INFO - ##### Running clobber step. 14:31:48 INFO - ##### 14:31:48 INFO - Running pre-action listener: _resource_record_pre_action 14:31:48 INFO - Running main action method: clobber 14:31:48 INFO - rmtree: /builds/slave/test/build 14:31:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:31:49 INFO - Running post-action listener: _resource_record_post_action 14:31:49 INFO - ##### 14:31:49 INFO - ##### Finished clobber step (success) 14:31:49 INFO - ##### 14:31:49 INFO - ##### 14:31:49 INFO - ##### Running read-buildbot-config step. 14:31:49 INFO - ##### 14:31:49 INFO - Running pre-action listener: _resource_record_pre_action 14:31:49 INFO - Running main action method: read_buildbot_config 14:31:49 INFO - Using buildbot properties: 14:31:49 INFO - { 14:31:49 INFO - "project": "", 14:31:49 INFO - "product": "firefox", 14:31:49 INFO - "script_repo_revision": "production", 14:31:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:31:49 INFO - "repository": "", 14:31:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:31:49 INFO - "buildid": "20160609113016", 14:31:49 INFO - "pgo_build": "True", 14:31:49 INFO - "basedir": "/builds/slave/test", 14:31:49 INFO - "buildnumber": 450, 14:31:49 INFO - "slavename": "talos-linux64-ix-035", 14:31:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:31:49 INFO - "platform": "ubuntu64_hw", 14:31:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:31:49 INFO - "branch": "fx-team", 14:31:49 INFO - "repo_path": "integration/fx-team", 14:31:49 INFO - "revision": "afc529c199066e9c9d8a88318f24f631a7678d53", 14:31:49 INFO - "stage_platform": "linux64-pgo", 14:31:49 INFO - "builduid": "8e4747667347419d9e7e78983d3bed2a", 14:31:49 INFO - "slavebuilddir": "test" 14:31:49 INFO - } 14:31:49 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:31:49 INFO - Running post-action listener: _resource_record_post_action 14:31:49 INFO - ##### 14:31:49 INFO - ##### Finished read-buildbot-config step (success) 14:31:49 INFO - ##### 14:31:49 INFO - ##### 14:31:49 INFO - ##### Running download-and-extract step. 14:31:49 INFO - ##### 14:31:49 INFO - Running pre-action listener: _resource_record_pre_action 14:31:49 INFO - Running main action method: download_and_extract 14:31:49 INFO - mkdir: /builds/slave/test/build/tests 14:31:49 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:31:49 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:31:49 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:31:49 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:31:49 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:31:49 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:31:50 INFO - Downloaded 1361 bytes. 14:31:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:31:50 INFO - Using the following test package requirements: 14:31:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:31:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:31:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'jsshell-linux-x86_64.zip'], 14:31:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:31:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:31:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:31:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:31:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:31:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:31:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:31:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:50 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:31:50 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:31:50 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:31:50 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:31:50 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:31:51 INFO - Downloaded 24452351 bytes. 14:31:51 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:31:51 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:31:53 INFO - Return code: 0 14:31:53 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:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:53 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:31:53 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:31:53 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:31:53 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:31:53 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:31:55 INFO - Downloaded 24452351 bytes. 14:31:55 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:31:55 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:31:56 INFO - Return code: 0 14:31: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:31:56 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:31:56 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:31:56 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:31:56 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:31:56 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:31:58 INFO - Downloaded 10833377 bytes. 14:31:58 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:31:58 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:31:58 INFO - Return code: 0 14:31:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:31:58 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:31:58 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:31:58 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:31:58 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:31:58 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:31:59 INFO - Downloaded 59291515 bytes. 14:31:59 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:31:59 INFO - mkdir: /builds/slave/test/properties 14:31:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:31:59 INFO - Writing to file /builds/slave/test/properties/build_url 14:31:59 INFO - Contents: 14:31:59 INFO - build_url:https://queue.taskcluster.net/v1/task/dXGP61gpQAadwRWaadHjxg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:32:00 INFO - Running post-action listener: _resource_record_post_action 14:32:00 INFO - Running post-action listener: set_extra_try_arguments 14:32:00 INFO - ##### 14:32:00 INFO - ##### Finished download-and-extract step (success) 14:32:00 INFO - ##### 14:32:00 INFO - ##### 14:32:00 INFO - ##### Running populate-webroot step. 14:32:00 INFO - ##### 14:32:00 INFO - Running pre-action listener: _resource_record_pre_action 14:32:00 INFO - Running main action method: populate_webroot 14:32:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:32:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:32:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:32:00 INFO - '--tppagecycles', 14:32:00 INFO - '7'], 14:32:00 INFO - 'tests': ['tsvgm']}}, 14:32:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:32:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:32:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:32:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:32:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:32:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['damp', 'tps']}, 14:32:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'tests': ['damp', 'tps']}, 14:32:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['dromaeo_dom']}, 14:32:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:32:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other-e10s': {'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['a11yr', 14:32:00 INFO - 'ts_paint', 14:32:00 INFO - 'tpaint', 14:32:00 INFO - 'sessionrestore', 14:32:00 INFO - 'sessionrestore_no_auto_restore', 14:32:00 INFO - 'tabpaint']}, 14:32:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['tsvgx', 14:32:00 INFO - 'tsvgr_opacity', 14:32:00 INFO - 'tart', 14:32:00 INFO - 'tscrollx', 14:32:00 INFO - 'cart']}, 14:32:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:32:00 INFO - 'tsvgr_opacity', 14:32:00 INFO - 'tart', 14:32:00 INFO - 'tscrollx', 14:32:00 INFO - 'cart']}, 14:32:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--disable-e10s'], 14:32:00 INFO - 'tests': ['tp5o']}, 14:32:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'tests': ['tp5o']}, 14:32:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--disable-e10s', 14:32:00 INFO - '--xperf_path', 14:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:00 INFO - 'tests': ['tp5n']}, 14:32:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:32:00 INFO - 'talos_options': ['--xperf_path', 14:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:32:00 INFO - 'tests': ['tp5n']}}, 14:32:00 INFO - 'talos.zip': {'path': '', 14:32:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:32:00 INFO - Running post-action listener: _resource_record_post_action 14:32:00 INFO - ##### 14:32:00 INFO - ##### Finished populate-webroot step (success) 14:32:00 INFO - ##### 14:32:00 INFO - ##### 14:32:00 INFO - ##### Running create-virtualenv step. 14:32:00 INFO - ##### 14:32:00 INFO - Running pre-action listener: _resource_record_pre_action 14:32:00 INFO - Running main action method: create_virtualenv 14:32:00 INFO - Creating virtualenv /builds/slave/test/build/venv 14:32:00 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:32:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:32:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:32:00 INFO - Using real prefix '/usr' 14:32:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:32:01 INFO - Installing distribute.............................................................................................................................................................................................done. 14:32:03 INFO - Installing pip.................done. 14:32:03 INFO - Return code: 0 14:32:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:32:03 INFO - Using env: {'DISPLAY': ':0', 14:32:03 INFO - 'HOME': '/home/cltbld', 14:32:03 INFO - 'LANG': 'en_US.UTF-8', 14:32:03 INFO - 'LANGUAGE': 'en_US:en', 14:32:03 INFO - 'LOGNAME': 'cltbld', 14:32:03 INFO - 'MAIL': '/var/mail/cltbld', 14:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:03 INFO - 'MOZ_NO_REMOTE': '1', 14:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:03 INFO - 'NO_EM_RESTART': '1', 14:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:03 INFO - 'PWD': '/builds/slave/test', 14:32:03 INFO - 'SHELL': '/bin/bash', 14:32:03 INFO - 'SHLVL': '1', 14:32:03 INFO - 'TERM': 'linux', 14:32:03 INFO - 'TMOUT': '86400', 14:32:03 INFO - 'USER': 'cltbld', 14:32:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:03 INFO - '_': '/tools/buildbot/bin/python'} 14:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:03 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:32:03 INFO - Cleaning up... 14:32:03 INFO - Return code: 0 14:32:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:32:03 INFO - Using env: {'DISPLAY': ':0', 14:32:03 INFO - 'HOME': '/home/cltbld', 14:32:03 INFO - 'LANG': 'en_US.UTF-8', 14:32:03 INFO - 'LANGUAGE': 'en_US:en', 14:32:03 INFO - 'LOGNAME': 'cltbld', 14:32:03 INFO - 'MAIL': '/var/mail/cltbld', 14:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:03 INFO - 'MOZ_NO_REMOTE': '1', 14:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:03 INFO - 'NO_EM_RESTART': '1', 14:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:03 INFO - 'PWD': '/builds/slave/test', 14:32:03 INFO - 'SHELL': '/bin/bash', 14:32:03 INFO - 'SHLVL': '1', 14:32:03 INFO - 'TERM': 'linux', 14:32:03 INFO - 'TMOUT': '86400', 14:32:03 INFO - 'USER': 'cltbld', 14:32:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:03 INFO - '_': '/tools/buildbot/bin/python'} 14:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:03 INFO - Downloading/unpacking psutil>=3.1.1 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:05 INFO - Installing collected packages: psutil 14:32:05 INFO - Running setup.py install for psutil 14:32:05 INFO - building 'psutil._psutil_linux' extension 14:32:05 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:32:05 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:32:05 INFO - building 'psutil._psutil_posix' extension 14:32:05 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:32:05 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:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:32:06 INFO - Successfully installed psutil 14:32:06 INFO - Cleaning up... 14:32:06 INFO - Return code: 0 14:32:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:06 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 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:06 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:32:06 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:32:06 INFO - Using env: {'DISPLAY': ':0', 14:32:06 INFO - 'HOME': '/home/cltbld', 14:32:06 INFO - 'LANG': 'en_US.UTF-8', 14:32:06 INFO - 'LANGUAGE': 'en_US:en', 14:32:06 INFO - 'LOGNAME': 'cltbld', 14:32:06 INFO - 'MAIL': '/var/mail/cltbld', 14:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:06 INFO - 'MOZ_NO_REMOTE': '1', 14:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:06 INFO - 'NO_EM_RESTART': '1', 14:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:06 INFO - 'PWD': '/builds/slave/test', 14:32:06 INFO - 'SHELL': '/bin/bash', 14:32:06 INFO - 'SHLVL': '1', 14:32:06 INFO - 'TERM': 'linux', 14:32:06 INFO - 'TMOUT': '86400', 14:32:06 INFO - 'USER': 'cltbld', 14:32:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:06 INFO - '_': '/tools/buildbot/bin/python'} 14:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:32:08 INFO - Installing collected packages: mozsystemmonitor 14:32:08 INFO - Running setup.py install for mozsystemmonitor 14:32:08 INFO - Successfully installed mozsystemmonitor 14:32:08 INFO - Cleaning up... 14:32:08 INFO - Return code: 0 14:32:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:08 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 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:08 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:32:08 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:32:08 INFO - Using env: {'DISPLAY': ':0', 14:32:08 INFO - 'HOME': '/home/cltbld', 14:32:08 INFO - 'LANG': 'en_US.UTF-8', 14:32:08 INFO - 'LANGUAGE': 'en_US:en', 14:32:08 INFO - 'LOGNAME': 'cltbld', 14:32:08 INFO - 'MAIL': '/var/mail/cltbld', 14:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:08 INFO - 'MOZ_NO_REMOTE': '1', 14:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:08 INFO - 'NO_EM_RESTART': '1', 14:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:08 INFO - 'PWD': '/builds/slave/test', 14:32:08 INFO - 'SHELL': '/bin/bash', 14:32:08 INFO - 'SHLVL': '1', 14:32:08 INFO - 'TERM': 'linux', 14:32:08 INFO - 'TMOUT': '86400', 14:32:08 INFO - 'USER': 'cltbld', 14:32:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:08 INFO - '_': '/tools/buildbot/bin/python'} 14:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:08 INFO - Downloading/unpacking jsonschema==2.5.1 14:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:32:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:10 INFO - Downloading functools32-3.2.3-2.tar.gz 14:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:32:10 INFO - warning: no files found matching '*.txt' 14:32:10 INFO - no previously-included directories found matching 'build' 14:32:10 INFO - no previously-included directories found matching 'dist' 14:32:10 INFO - no previously-included directories found matching '.git*' 14:32:10 INFO - Installing collected packages: jsonschema, functools32 14:32:10 INFO - Running setup.py install for functools32 14:32:10 INFO - warning: no files found matching '*.txt' 14:32:10 INFO - no previously-included directories found matching 'build' 14:32:10 INFO - no previously-included directories found matching 'dist' 14:32:10 INFO - no previously-included directories found matching '.git*' 14:32:10 INFO - Successfully installed jsonschema functools32 14:32:10 INFO - Cleaning up... 14:32:10 INFO - Return code: 0 14:32:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:32: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:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:32:10 INFO - Using env: {'DISPLAY': ':0', 14:32:10 INFO - 'HOME': '/home/cltbld', 14:32:10 INFO - 'LANG': 'en_US.UTF-8', 14:32:10 INFO - 'LANGUAGE': 'en_US:en', 14:32:10 INFO - 'LOGNAME': 'cltbld', 14:32:10 INFO - 'MAIL': '/var/mail/cltbld', 14:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:10 INFO - 'MOZ_NO_REMOTE': '1', 14:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:10 INFO - 'NO_EM_RESTART': '1', 14:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:10 INFO - 'PWD': '/builds/slave/test', 14:32:10 INFO - 'SHELL': '/bin/bash', 14:32:10 INFO - 'SHLVL': '1', 14:32:10 INFO - 'TERM': 'linux', 14:32:10 INFO - 'TMOUT': '86400', 14:32:10 INFO - 'USER': 'cltbld', 14:32:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:10 INFO - '_': '/tools/buildbot/bin/python'} 14:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:11 INFO - Downloading/unpacking blobuploader==1.2.4 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:13 INFO - Downloading blobuploader-1.2.4.tar.gz 14:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:32:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:32:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:13 INFO - Downloading docopt-0.6.1.tar.gz 14:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:32:13 INFO - Installing collected packages: blobuploader, requests, docopt 14:32:13 INFO - Running setup.py install for blobuploader 14:32:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:32:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:32:13 INFO - Running setup.py install for requests 14:32:14 INFO - Running setup.py install for docopt 14:32:14 INFO - Successfully installed blobuploader requests docopt 14:32:14 INFO - Cleaning up... 14:32:14 INFO - Return code: 0 14:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:14 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 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:14 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:32:14 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:32:14 INFO - Using env: {'DISPLAY': ':0', 14:32:14 INFO - 'HOME': '/home/cltbld', 14:32:14 INFO - 'LANG': 'en_US.UTF-8', 14:32:14 INFO - 'LANGUAGE': 'en_US:en', 14:32:14 INFO - 'LOGNAME': 'cltbld', 14:32:14 INFO - 'MAIL': '/var/mail/cltbld', 14:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:14 INFO - 'MOZ_NO_REMOTE': '1', 14:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:14 INFO - 'NO_EM_RESTART': '1', 14:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:14 INFO - 'PWD': '/builds/slave/test', 14:32:14 INFO - 'SHELL': '/bin/bash', 14:32:14 INFO - 'SHLVL': '1', 14:32:14 INFO - 'TERM': 'linux', 14:32:14 INFO - 'TMOUT': '86400', 14:32:14 INFO - 'USER': 'cltbld', 14:32:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:14 INFO - '_': '/tools/buildbot/bin/python'} 14:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:14 INFO - Running setup.py (path:/tmp/pip-WHYqN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:14 INFO - Running setup.py (path:/tmp/pip-x2i_q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:14 INFO - Running setup.py (path:/tmp/pip-JP7cQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:14 INFO - Running setup.py (path:/tmp/pip-vH2ZRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:14 INFO - Running setup.py (path:/tmp/pip-jUrdsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:15 INFO - Running setup.py (path:/tmp/pip-At7SBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:15 INFO - Running setup.py (path:/tmp/pip-t4fkCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:15 INFO - Running setup.py (path:/tmp/pip-BpAPsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:15 INFO - Running setup.py (path:/tmp/pip-OJSDum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:15 INFO - Running setup.py (path:/tmp/pip-buf2GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:15 INFO - Running setup.py (path:/tmp/pip-flr6WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:15 INFO - Running setup.py (path:/tmp/pip-B0LvbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:15 INFO - Running setup.py (path:/tmp/pip-y9sVyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:15 INFO - Running setup.py (path:/tmp/pip-51qN6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:15 INFO - Running setup.py (path:/tmp/pip-kIHdEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:15 INFO - Running setup.py (path:/tmp/pip-mgsYll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:15 INFO - Running setup.py (path:/tmp/pip-xM25vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:32:15 INFO - Running setup.py install for manifestparser 14:32:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:32:15 INFO - Running setup.py install for mozcrash 14:32:16 INFO - Running setup.py install for mozdebug 14:32:16 INFO - Running setup.py install for mozdevice 14:32:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Running setup.py install for mozfile 14:32:16 INFO - Running setup.py install for mozhttpd 14:32:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Running setup.py install for mozinfo 14:32:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Running setup.py install for mozInstall 14:32:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Running setup.py install for mozleak 14:32:16 INFO - Running setup.py install for mozlog 14:32:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:32:16 INFO - Running setup.py install for moznetwork 14:32:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:32:17 INFO - Running setup.py install for mozprocess 14:32:17 INFO - Running setup.py install for mozprofile 14:32:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:32:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:32:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:32:17 INFO - Running setup.py install for mozrunner 14:32:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:32:17 INFO - Running setup.py install for mozscreenshot 14:32:17 INFO - Running setup.py install for moztest 14:32:17 INFO - Running setup.py install for mozversion 14:32:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:32:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:32:17 INFO - Cleaning up... 14:32:17 INFO - Return code: 0 14:32:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:17 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 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:17 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:32:17 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:32:17 INFO - Using env: {'DISPLAY': ':0', 14:32:17 INFO - 'HOME': '/home/cltbld', 14:32:17 INFO - 'LANG': 'en_US.UTF-8', 14:32:17 INFO - 'LANGUAGE': 'en_US:en', 14:32:17 INFO - 'LOGNAME': 'cltbld', 14:32:17 INFO - 'MAIL': '/var/mail/cltbld', 14:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:17 INFO - 'MOZ_NO_REMOTE': '1', 14:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:17 INFO - 'NO_EM_RESTART': '1', 14:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:17 INFO - 'PWD': '/builds/slave/test', 14:32:17 INFO - 'SHELL': '/bin/bash', 14:32:17 INFO - 'SHLVL': '1', 14:32:17 INFO - 'TERM': 'linux', 14:32:17 INFO - 'TMOUT': '86400', 14:32:17 INFO - 'USER': 'cltbld', 14:32:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:17 INFO - '_': '/tools/buildbot/bin/python'} 14:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:32:17 INFO - Running setup.py (path:/tmp/pip-OryNEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:32:17 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:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:32:17 INFO - Running setup.py (path:/tmp/pip-cezNEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:32:18 INFO - Running setup.py (path:/tmp/pip-QtpDqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:32:18 INFO - Running setup.py (path:/tmp/pip-D4z6qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:32:18 INFO - Running setup.py (path:/tmp/pip-vPyI3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:32:18 INFO - Running setup.py (path:/tmp/pip-XIhtT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:32:18 INFO - Running setup.py (path:/tmp/pip-R5Ucpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:32:18 INFO - Running setup.py (path:/tmp/pip-yWn_zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:32:18 INFO - Running setup.py (path:/tmp/pip-7rx4Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:32:18 INFO - Running setup.py (path:/tmp/pip-jLngrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:32:18 INFO - Running setup.py (path:/tmp/pip-rEo7sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:32:18 INFO - Running setup.py (path:/tmp/pip-73fY7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:32:18 INFO - Running setup.py (path:/tmp/pip-BSJPke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:32:18 INFO - Running setup.py (path:/tmp/pip-ALudTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:32:18 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:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:18 INFO - Running setup.py (path:/tmp/pip-RV73lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:32:19 INFO - Running setup.py (path:/tmp/pip-C2hO6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:32:19 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:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:32:19 INFO - Running setup.py (path:/tmp/pip-iHEdxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 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:32:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:32: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:32: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:32: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:32: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:32: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:32: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:32:21 INFO - Downloading blessings-1.6.tar.gz 14:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:32:21 INFO - Installing collected packages: blessings 14:32:21 INFO - Running setup.py install for blessings 14:32:21 INFO - Successfully installed blessings 14:32:21 INFO - Cleaning up... 14:32:21 INFO - Return code: 0 14:32:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:21 INFO - Reading from file tmpfile_stdout 14:32:21 INFO - Current package versions: 14:32:21 INFO - argparse == 1.2.1 14:32:21 INFO - blessings == 1.6 14:32:21 INFO - blobuploader == 1.2.4 14:32:21 INFO - docopt == 0.6.1 14:32:21 INFO - functools32 == 3.2.3-2 14:32:21 INFO - jsonschema == 2.5.1 14:32:21 INFO - manifestparser == 1.1 14:32:21 INFO - mozInstall == 1.12 14:32:21 INFO - mozcrash == 0.17 14:32:21 INFO - mozdebug == 0.1 14:32:21 INFO - mozdevice == 0.48 14:32:21 INFO - mozfile == 1.2 14:32:21 INFO - mozhttpd == 0.7 14:32:21 INFO - mozinfo == 0.9 14:32:21 INFO - mozleak == 0.1 14:32:21 INFO - mozlog == 3.2 14:32:21 INFO - moznetwork == 0.27 14:32:21 INFO - mozprocess == 0.22 14:32:21 INFO - mozprofile == 0.28 14:32:21 INFO - mozrunner == 6.11 14:32:21 INFO - mozscreenshot == 0.1 14:32:21 INFO - mozsystemmonitor == 0.3 14:32:21 INFO - moztest == 0.7 14:32:21 INFO - mozversion == 1.4 14:32:21 INFO - psutil == 3.1.1 14:32:21 INFO - requests == 1.2.3 14:32:21 INFO - wsgiref == 0.1.2 14:32:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:32: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:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32:21 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 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32:21 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:32:21 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:32:21 INFO - Using env: {'DISPLAY': ':0', 14:32:21 INFO - 'HOME': '/home/cltbld', 14:32:21 INFO - 'LANG': 'en_US.UTF-8', 14:32:21 INFO - 'LANGUAGE': 'en_US:en', 14:32:21 INFO - 'LOGNAME': 'cltbld', 14:32:21 INFO - 'MAIL': '/var/mail/cltbld', 14:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:21 INFO - 'MOZ_NO_REMOTE': '1', 14:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:21 INFO - 'NO_EM_RESTART': '1', 14:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:21 INFO - 'PWD': '/builds/slave/test', 14:32:21 INFO - 'SHELL': '/bin/bash', 14:32:21 INFO - 'SHLVL': '1', 14:32:21 INFO - 'TERM': 'linux', 14:32:21 INFO - 'TMOUT': '86400', 14:32:21 INFO - 'USER': 'cltbld', 14:32:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:21 INFO - '_': '/tools/buildbot/bin/python'} 14:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 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:32:21 INFO - Cleaning up... 14:32:21 INFO - Return code: 0 14:32:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:32: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:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32: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'] in /builds/slave/test/build 14:32: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 14:32:21 INFO - Using env: {'DISPLAY': ':0', 14:32:21 INFO - 'HOME': '/home/cltbld', 14:32:21 INFO - 'LANG': 'en_US.UTF-8', 14:32:21 INFO - 'LANGUAGE': 'en_US:en', 14:32:21 INFO - 'LOGNAME': 'cltbld', 14:32:21 INFO - 'MAIL': '/var/mail/cltbld', 14:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:21 INFO - 'MOZ_NO_REMOTE': '1', 14:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:21 INFO - 'NO_EM_RESTART': '1', 14:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:21 INFO - 'PWD': '/builds/slave/test', 14:32:21 INFO - 'SHELL': '/bin/bash', 14:32:21 INFO - 'SHLVL': '1', 14:32:21 INFO - 'TERM': 'linux', 14:32:21 INFO - 'TMOUT': '86400', 14:32:21 INFO - 'USER': 'cltbld', 14:32:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:21 INFO - '_': '/tools/buildbot/bin/python'} 14:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:32:21 INFO - Cleaning up... 14:32:21 INFO - Return code: 0 14:32:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:32: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:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:32: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1be7e24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, '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': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', '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:32: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', 'flake8'] in /builds/slave/test/build 14:32: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 flake8 14:32:21 INFO - Using env: {'DISPLAY': ':0', 14:32:21 INFO - 'HOME': '/home/cltbld', 14:32:21 INFO - 'LANG': 'en_US.UTF-8', 14:32:21 INFO - 'LANGUAGE': 'en_US:en', 14:32:21 INFO - 'LOGNAME': 'cltbld', 14:32:21 INFO - 'MAIL': '/var/mail/cltbld', 14:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:21 INFO - 'MOZ_NO_REMOTE': '1', 14:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:21 INFO - 'NO_EM_RESTART': '1', 14:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:21 INFO - 'PWD': '/builds/slave/test', 14:32:21 INFO - 'SHELL': '/bin/bash', 14:32:21 INFO - 'SHLVL': '1', 14:32:21 INFO - 'TERM': 'linux', 14:32:21 INFO - 'TMOUT': '86400', 14:32:21 INFO - 'USER': 'cltbld', 14:32:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:21 INFO - '_': '/tools/buildbot/bin/python'} 14:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:32:22 INFO - Downloading/unpacking flake8 14:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:32:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:32:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:32: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:32: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:32: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:32: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:32: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:32: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:32:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:32:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:32: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:32: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:32: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:32: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:32: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:32: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:32:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:32: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:32: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:32: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:32: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:32: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:32: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:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:24 INFO - no previously-included directories found matching 'docs/_build' 14:32:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:32:24 INFO - Running setup.py install for pep8 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:32:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:32:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:32:24 INFO - no previously-included directories found matching 'docs/_build' 14:32:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:32:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:32:24 INFO - Cleaning up... 14:32:25 INFO - Return code: 0 14:32:25 INFO - Running post-action listener: _resource_record_post_action 14:32:25 INFO - Running post-action listener: _start_resource_monitoring 14:32:25 INFO - Starting resource monitoring. 14:32:25 INFO - ##### 14:32:25 INFO - ##### Finished create-virtualenv step (success) 14:32:25 INFO - ##### 14:32:25 INFO - ##### 14:32:25 INFO - ##### Running install step. 14:32:25 INFO - ##### 14:32:25 INFO - Running pre-action listener: _resource_record_pre_action 14:32:25 INFO - Running main action method: install 14:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:32:25 INFO - Reading from file tmpfile_stdout 14:32:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:32:25 INFO - Reading from file tmpfile_stdout 14:32:25 INFO - Output received: 14:32:25 INFO - Usage: mozinstall [options] installer 14:32:25 INFO - Options: 14:32:25 INFO - -h, --help show this help message and exit 14:32:25 INFO - -d DEST, --destination=DEST 14:32:25 INFO - Directory to install application into. [default: 14:32:25 INFO - "/builds/slave/test"] 14:32:25 INFO - --app=APP Application being installed. [default: firefox] 14:32:25 INFO - mkdir: /builds/slave/test/build/application 14:32:25 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:32:25 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:32:42 INFO - Reading from file tmpfile_stdout 14:32:42 INFO - Output received: 14:32:42 INFO - /builds/slave/test/build/application/firefox/firefox 14:32:42 INFO - Running post-action listener: _resource_record_post_action 14:32:42 INFO - ##### 14:32:42 INFO - ##### Finished install step (success) 14:32:42 INFO - ##### 14:32:42 INFO - ##### 14:32:42 INFO - ##### Running run-tests step. 14:32:42 INFO - ##### 14:32:42 INFO - Running pre-action listener: _resource_record_pre_action 14:32:42 INFO - Running main action method: run_tests 14:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:32:42 INFO - Python 2.7.3 14:32:42 INFO - Return code: 0 14:32:42 INFO - grabbing minidump binary from tooltool 14:32:42 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:32:42 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 0x11971c0>, '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 0x11980c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:32:42 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:32:42 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:32:42 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:32:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:32:42 INFO - Return code: 0 14:32:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:32:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:32:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:32:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:32:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:32:43 INFO - Return code: 0 14:32:43 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-035', '--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:32:43 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-035 --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:32:43 INFO - Using env: {'DISPLAY': ':0', 14:32:43 INFO - 'HOME': '/home/cltbld', 14:32:43 INFO - 'LANG': 'en_US.UTF-8', 14:32:43 INFO - 'LANGUAGE': 'en_US:en', 14:32:43 INFO - 'LOGNAME': 'cltbld', 14:32:43 INFO - 'MAIL': '/var/mail/cltbld', 14:32:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:32:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:32:43 INFO - 'MOZ_NO_REMOTE': '1', 14:32:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:32:43 INFO - 'NO_EM_RESTART': '1', 14:32:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:32:43 INFO - 'PWD': '/builds/slave/test', 14:32:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:32:43 INFO - 'SHELL': '/bin/bash', 14:32:43 INFO - 'SHLVL': '1', 14:32:43 INFO - 'TERM': 'linux', 14:32:43 INFO - 'TMOUT': '86400', 14:32:43 INFO - 'USER': 'cltbld', 14:32:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259', 14:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:32:43 INFO - '_': '/tools/buildbot/bin/python'} 14:32:43 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-035', '--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:32:43 INFO - mozversion application_buildid: 20160609113016 14:32:43 INFO - mozversion application_changeset: afc529c199066e9c9d8a88318f24f631a7678d53 14:32:43 INFO - mozversion application_display_name: Nightly 14:32:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:32:43 INFO - mozversion application_name: Firefox 14:32:43 INFO - mozversion application_remotingname: firefox 14:32:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:32:43 INFO - mozversion application_vendor: Mozilla 14:32:43 INFO - mozversion application_version: 50.0a1 14:32:43 INFO - mozversion platform_buildid: 20160609113016 14:32:43 INFO - mozversion platform_changeset: afc529c199066e9c9d8a88318f24f631a7678d53 14:32:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:32:43 INFO - mozversion platform_version: 50.0a1 14:32:43 INFO - using testdate: 1465507963 14:32:43 INFO - actual date: 1465507963 14:32:43 INFO - starting webserver on 'localhost:46988' 14:32:43 INFO - SUITE-START | Running 2 tests 14:32:43 INFO - TEST-START | dromaeo_css 14:32:43 INFO - operating with platform_type : linux_ 14:32:43 INFO - Initialising browser for dromaeo_css test... 14:32:43 INFO - TEST-INFO | started process 19500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsSpC2M/profile http://localhost:46988/getInfo.html) 14:32:48 INFO - PROCESS | 19500 | __metrics Screen width/height:1600/1200 14:32:48 INFO - PROCESS | 19500 | colorDepth:24 14:32:48 INFO - PROCESS | 19500 | Browser inner width/height: 1024/697 14:32:48 INFO - PROCESS | 19500 | __metrics 14:32:48 ERROR - PROCESS | 19500 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:32:49 INFO - TEST-INFO | 19500: exit 0 14:32:49 INFO - Browser initialized. 14:32:49 INFO - Running cycle 1/1 for dromaeo_css test... 14:32:49 INFO - TEST-INFO | started process 19622 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsSpC2M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:33:01 INFO - PROCESS | 19622 | RSS: Main: 184815616 14:33:01 INFO - PROCESS | 19622 | 14:33:51 INFO - PROCESS | 19622 | 1465508031031 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:35:58 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46988/tests/dromaeo/cssquery-ext.html) 14:35:59 INFO - PROCESS | 19622 | RSS: Main: 188452864 14:35:59 INFO - PROCESS | 19622 | 14:39:02 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-ext.html (next: http://localhost:46988/tests/dromaeo/cssquery-jquery.html) 14:39:02 INFO - PROCESS | 19622 | RSS: Main: 187052032 14:39:02 INFO - PROCESS | 19622 | 14:42:04 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46988/tests/dromaeo/cssquery-mootools.html) 14:42:05 INFO - PROCESS | 19622 | RSS: Main: 188215296 14:42:05 INFO - PROCESS | 19622 | 14:45:06 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46988/tests/dromaeo/cssquery-prototype.html) 14:45:07 INFO - PROCESS | 19622 | RSS: Main: 186327040 14:45:07 INFO - PROCESS | 19622 | 14:48:09 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46988/tests/dromaeo/cssquery-yui.html) 14:48:10 INFO - PROCESS | 19622 | RSS: Main: 187711488 14:48:10 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | Cycle 1(1): loaded http://localhost:46988/tests/dromaeo/cssquery-yui.html (next: http://localhost:46988/tests/dromaeo/cssquery-dojo.html) 14:51:13 INFO - PROCESS | 19622 | RSS: Main: 189657088 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | __start_tp_report 14:51:13 INFO - PROCESS | 19622 | _x_x_mozilla_page_load 14:51:13 INFO - PROCESS | 19622 | _x_x_mozilla_page_load_details 14:51:13 INFO - PROCESS | 19622 | |i|pagename|runs| 14:51:13 INFO - PROCESS | 19622 | |0;dojo.html;3123.812571245725;3150.1022208670533;3161.2413020874983;3165.35110302388;3191.904242872715;5558.916616250759;5576.86057848554;5602;5610.354809196943;5639.887202255953;5370.113931201347;5505.752241149148;5508.476694714006;5520.282363292767;5535.059039963206;4957.603391728662;4983.825566105187;5092.312537807404;5121.923171152435;5178.5339319461245;137.14069330249373;5009.524095210949;5104.310918026074;5127.077126117298;5141.588672906178;4950.381202349707;4951.405831300249;4982.60139188864;4984.725840078812;5026.145555255615;4877.3903262092235;4970.6520543561965;4972.328735620681;5004.299398084271;5010.674306170124;4889.046635906;4903.509649035103;4947.6289278304275;4975.800967961277;4994.250862370637;5438.238646589481;5461.826688606492;5495.917561236544;5503;5571.721413929287;5765.048766953448;5822.679752613604;5855.912161317584;5858.941410585925;5868.9413105868825;5911.290645122613;5975.551833612496;6018.2778066631845;6030.8190754277;6043.062057675621;5584.497395234448;5609.74756135979;5612.102063669793;5613;5626.971865140648;5873.353931067579;5991.370906054889;6049.848753781191;6063;6064.332923378425;5883.794067207627;5884.970575147183;5887.175795388649;5891.263592050994;5938.346781853993;5959.106134079922;5968.582199246098;5976.043832986788;5979.820605381846;5980;5782.913256301159;5835.562332825055;5846.912296315559;5879.323877754113;5904.76380944766;5714.885702286014;5817.127430885401;5837.416258374129;5860.677662728505;5874.383189765099;4511.526289739596;4523.638108951276;4532.79602417892;4538.387317712132;4561.977190114028;3952.565217826037;4005.919881602352;4024.557298697141;4031.1534577738416;4059.3099173140636;5732.398098199629;5736.5123964462655;5739.110437882135;5745.454181852718;5752.050911599623;5995.760169593167;6042.969785151046;6049.485793707584;6060.303065147476;6074.574779765374;5542.889142217133;5549.944500554942;5589.329280486368;5621.747021384048;5639.464250896158;5083.72039537829;5108.310378098983;5121.667091639031;5126.077306084941;5134.307550598765;5981.401859814071;6088.056351265561;6093.268807743099;6102.633841969496;6127.927612667854;5963.522918166623;6008.54935879802;6021.488173505126;6064.575479716377;6075.756969721162;6169.074638804215;6182.969085154546;6185.041318595625;6187.84530386744;6208.844778880564;5709.172170035238;5782.335031471434;5923.378045305353;5931.614445061057;5933.940660593339;5895.29256489224;5924.289085309791;5939.227900372924;5954.345022047658;6014.127951447103;5724.484796368347;5748.511376533042;5797;5806.593538452436;5820.214271073351;5571.415001424954;5671.574631902541;5692.430756924275;5797.449242321973;5803.506701930383;5582.748776305158;5607.719614019201;5621.353544342453;5669.688167150846;5702.030654788613;5792.855178620568;5842.2405087338375;5854.707264636836;5855.3266374367495;5859.062549991981;5543.805966791143;5673.773049078156;5715.685637289823;5726.455986681259;5745.6552606843725 14:51:13 INFO - PROCESS | 19622 | |1;ext.html;539.6923753460529;596.2755252368372;614.7817524778703;646.9838254043651;659.0443856408207;42861.78569107154;44350.11299774006;44375.3343699844;44398.778006110006;47312.526874731244;45354;45712.77143614286;45963;46001;46177;8845.601947912359;9006.144416280476;9012.098790121001;9021.684241051564;9030.096990300983;8806.911930880673;8812.427192232484;8823.867641985375;8851.95574022129;8879.600417981206;8948.239399651038;8957.731268061936;8959.731208063737;8966.775830604254;9016;8878.511681857495;8893.28853691703;8897.199252067345;8925.642974281021;8963.417377870417;8858.911410885938;8929.508877011762;8952.507612081334;8987.101289871025;9019.278457723432;43344.13311733748;43432;43815.56184438147;43831.34252986208;43855.561444385465;3450.3271861986923;3561.786292822413;3640.581333146669;3803.5625903020955;3932.46911666927;30559.541606875915;30598.082057538308;32553.51169732456;32694.83652581722;33988;4276.700630955835;4360.897749632937;4381.496127945264;4384.254676704968;4451.666125040635;350333;351497;352206;352423;352740.99999999744;60754.69622651947;60782.69608651928;61155.38844611586;61327.6933615338;61357.69321153365;36358.27283454316;37164;37301.25397492035;38212.42681359782;38448;16375.181240937905;16392.098434585972;16416.67166656684;16455.341786328412;16479.34082636705;13515;13583.728325433634;13675.726485470434;13693.452261909611;13704.794428083587;19575.314863979977;19682.8031719681;19767.604647906963;19845.206191752455;20083.196672133243;7070.540414873017;7081.716731330792;7217.9639101805205;7373.88939165913;7387.187409384964;969.2585172343163;1005.406809982114;1042.2599954032721;1052.8157572424948;1108.6119858049617;33110.66889331124;33305.50041749376;33385.66614333874;33561.496577551356;34006.14984625404;1092.9781404372027;1123.7359220583319;1128.8316592326903;1137.6075254037344;1222.706550427891;17517.7372339415;17565.560860978323;17753.822461775475;17864.46406607804;17909.58220640197;567937;569807;575941;577391;578021;59885.401145987984;61397.38602613917;61555;61827.6908615463;61865.69067154726;1335.1855368225374;1346.3672074125145;1348.2786709110578;1355.728854229158;1376.0711519724146;29120.708792912646;30222;30522.542161868034;30601.54097688492;30981;53393;54083.72958135184;54311.45688543222;54370;54537.454625454826;438053;442875;445406;446298;449262;29214.70785292205;29372.853135734185;29430.705692942796;29501.85249073741;29618.40763184681;50060.99878002347;51130;51213;52239.47760522346;52430;42158.36762448627;43825;44022.339664905696;44188.55811441973;45076.32385514154;41702.16595668009;42087.789561052;42771.35842962296;43004.78497607617;43028.35457468203;41862.372064419666;42180.78909605432;42526;43175.136497270505;43540.56459435365;37653.2469350606;38536.73636490755;38655.42016869693;38882.416763748;39343.80328098341;29003.564946525395;29064.564031539965;29114.27214319659;29232.415351692423;29335.973240936466 14:51:13 INFO - PROCESS | 19622 | |2;jquery.html;373.89904725724074;385.56046107437516;389.7466646679656;392.3114933292072;405.663299461447;16845.578860528494;18682.719759203625;19049.904750476246;19163.23347066119;19305.420837374884;17143.399981000668;17959.10204489777;18696.626067478643;18983.95588242646;18986.810131898677;5014.348134742479;5043.445221025693;5192.688438693672;5206.817761378353;5215;5128.666636668605;5130.846074617767;5141.1003074462005;5167.844964651066;5176.171812509999;5131.846044618667;5132.486751324875;5140.511651393112;5155.226715992593;5164.406093299281;5316.813911513098;5573.164025396202;5598.972005139969;5641.435856414326;5646.237757902672;5439.700816455093;5454.53636440903;5713.285839270091;5722.656640601577;5744.281964754406;12714.237145771283;13118.803217951738;13282.86717132826;18442.35451759182;22647.09411623533;2122.4375540481783;2212.6902233687297;2231.062953559509;2267.104493724986;2327.6043072677685;10074.194064474825;10096.34373765703;10185.490725463771;10244.436555989418;10293.485325733684;1862.6367858267643;1878.101514454354;1891.9527011824678;1924.2976313645559;1928.8746231494908;78874.60562697207;80139.5993020037;81374.59312703398;83601.58199209026;84267;10700.839487407695;10811.56753729842;10913.072388847037;11088.778224435466;11097.44512774358;15298.923505382625;15316.463923762838;15384.615384615474;15391.923040384727;15421.845781542266;7752;7883.172266911892;7923.247291507298;7984.760457186294;8058.0733215679775;7340.376068034277;7364.189939106694;7452.85094298111;7645.503042302344;7645.923540764521;4566.406367172246;4683.648726345537;4691.695039822401;4764.6426518011285;4912.680675756136;1963.1067864122076;1981.30654271004;1988.3836010836687;1989.3136867780593;2028.3914825552276;897.7486303834937;973.1679414100984;1042.8435734639713;1044;1091.4379094766202;16929.661406771796;18482.630347393246;18918.43244702661;18944.336948206746;19045.7143142853;968.4528241543505;973.8733964584559;992.2855544008303;1011.3780025284544;1023.1150055202196;10254;10705.304155229886;10761.56953721858;10771.515281812337;10772.192085593611;446518;448755.7562212168;457988;463975;465510;72668.63665681638;95768.52115739517;96372;96740.51629741806;101304.49347753215;965.5220665770488;973.9366941148803;997.7954519323521;999.4752754803641;1033.617561502249;17451.04019278901;17561.56096097608;17636.911815440842;17770.555736106184;17781.91109044498;41135.588644114374;41622.1675566493;41622.37566436445;42203.57796421996;42315.78842105893;57711.71144144252;58935.41064589299;59855.70072149786;60304.39695602988;60994.390056100645;8376.32989360862;8435.873461897954;8689.6089675966;8712.303015758851;8928.419652722552;10856.782864342827;11895.940520297343;12107.576234831738;12629.494820207088;12929.741405172032;11344.546218151181;11539;11779.587714429954;11782.17524773292;11791.941040295087;11488.597899073493;11498.885011149781;11584;11598.652040438801;11666.416679165837;11694.590689325832;11815.40922953866;11959.342236176746;12205.877941220475;12367.62897113088;7272.127344718668;8328.208820162075;8360.205780450848;8471;8813.911860881566;10228.846567301645;11946.34295113777;12092.274463532216;12127.939360303142;12307.26156430617 14:51:13 INFO - PROCESS | 19622 | |3;mootools.html;1468.7209430208259;1504.6012806606252;1591.2441590244628;1748.5628592851788;1763.4445149777819;7724.806879828007;8265.42142050056;8397.202265784756;8784.736457906258;8796.384253102286;8483.787905302355;8736.563171841415;8761.737147885573;8810.515421651806;8830.293576513879;2344.1678204237505;2365.82256330775;2373.52529494101;2378.904843806254;2380.27401642499;2280.950762649183;2301.413139649387;2357.7406485286606;2358.9410264743346;2370.6681064650875;2331.184085570054;2348.049040138738;2354.846934949223;2386.522695460906;2391;2282.657601359793;2304.2511183865145;2333;2334.8482348647285;2352.4001379648253;2286.634138537843;2293.415179129328;2297.2993237062688;2301.5051763870847;2308.1921327535397;8832.558372081434;8868.600912958933;8897.822043559157;8898.599563019616;8935.597898094602;5145.408278048035;5154.098032844275;5196.636235463519;5232.633715639907;5384.40771515133;3228.950591057892;3308.718758905496;3338.4157772389735;3355.0941245863723;3391.745619078579;1144.8339990701386;1152.8097863852454;1174.5654107980017;1205.4153735438306;1211.485118824496;12527.686807829878;12661.74676506474;12729.809052864215;12781.936090319581;12789.872101278961;4642.373279607277;4724;4826.58973987215;4860.8784780380065;4862.7325497098;10132.290739648153;10155;10177.949110254402;10180.796384072277;10187.490625468698;5354.223637572531;5355.946440535623;5366.838994830161;5393.406725260218;5397.082495975615;4373.431453910971;4683.976580117078;4811.08589368019;4901.754912254373;4943.752812359367;4063.6139566741113;4080.18396320737;4097.82539316243;4137.8758637240935;4163.084121493267;1322.365264672943;1331.6204881608694;1331.8468376136868;1342.1074985134971;1350.419319692522;794.9443538952218;920.3281604428804;930.3115694386106;1016.8220561401725;1021.6322124035341;6130.938690613037;6171.56799024073;6236.314005459396;6350.364963503705;6428.19647544057;916.0656130746601;916.4501299220415;922.2990527199242;978.8531720241879;995.5271246158162;4237.745735255895;4338.717983331074;4360.869173924787;4373.606375426227;4386.978065109718;10822.512986915608;10837.512311945982;10892.346459212473;11031.724206894893;11065.668029959113;10866.619668311729;10890.836637450444;10922.344659320466;10944.17918656104;10946;8020.43856930021;8053.59732013397;8208.794780130425;8261.256486916087;8273.048599411024;5967.582269241111;6082.178905847654;6089.177960975212;6134.2332208473945;6172.783952561639;10032.949835250776;10037.749056273651;10048.09567138961;10048.648297309559;10125.64560240388;9697.854532182164;10020.24848136378;10051.396916185053;10330.380177189392;10381.688549343531;7084.46866485026;7637.427192960661;7679.462437629312;7838.294553490213;7861.764147075597;8615.095414981337;8621.655133794578;8648.654053837776;8677.305815534615;8714.346424018097;7594.8860767087435;7767.4562780607075;7832.295093441618;7841.118131648477;7928.960355198187;7534.321911028033;7590.354819840375;7638;7757.418193635387;7761.068671759425;6576.210854697276;6646;6649.401553860176;6668.199816022108;6672.199336079701;5117.590592752496;5157;5261.973690131525;5300.814471493479;5343.706096164593;5053.494650534917;5118.795248190031;5161.406438259648;5191.662541934762;5222.947770522246 14:51:13 INFO - PROCESS | 19622 | |4;prototype.html;323.3113468312494;333.8531046339611;334.88279102314186;335.5956072932117;340.07669178181266;5511.145772405279;5665.348484924235;5668.829935101943;5684.45997630225;5736.971315143423;5565.499105080542;5572.554195664347;5587.38538760736;5593.216949627055;5600.215969764236;4362.323839804827;4365.3451982202605;4390.429244198266;4397.12057588482;4425.601695847373;4260.31834906415;4317.071829556645;4322.805473753673;4373.2565463871215;4446.15523050621;4295.269804133305;4299.634531064863;4324.97837510812;4344.3917851500655;4346.434963454746;4362.890927726817;4365.890852728708;4385.276429389147;4389.275769498045;4397.098594788061;3793.108619474421;3841.2125514269505;3858.3440815061226;3894.7468414552964;3920.137569734654;5456.836294911159;5501.312335958005;5503.394626591112;5518.255035570227;5540.667559946376;4968.2299243616935;4992.575631071363;4998.850034498934;5001.324821149135;5006.173981293082;5760.942390576082;5809.854753631151;5845.415458454163;5855.180274761537;5933.3473317934995;4071.75569465833;4126.546079931205;4180.686448516373;4241;4244.5967633075115;5918.940810591882;6061.666433384692;6090.847728806771;6098.298695650013;6200.410960958701;4209.894752631209;4210.389493523422;4214.1150358425075;4224.683148763855;4228.9154216915485;4284.6572274218615;4286.249906266391;4290.399344091829;4299.591538803808;4299.763513006815;4857.271409288564;4933.802647894116;4942.950570494249;4942.9752851236235;4950.554450099508;5875.588708790429;5876.823695289148;5885.558583106199;5887.735051922588;5915.792947246826;1453.7601295786076;1454.5854431486975;1457.9927100364641;1462.9341679624442;1472.2785834940803;892.1925657280042;925.7546750111226;926.4441335198961;938.7795865374985;938.7842743646994;5063.240513922941;5072;5090.440051594322;5108.438071812097;5128.79484820603;5363.570914326844;5369.704666243316;5390.730463476811;5408.945910540844;5409.29679141709;4906.8773280668265;4993.650444468853;5004.174311238678;5013.39839219296;5044.571211447068;2844.630198074237;2863.599096126544;2866.512692842222;2876.7267109624554;2877.1656219696056;5446.183072539151;5487.5884308677005;5503.477169668875;5535.612507124543;5552.91670624941;5189.131912511493;5296.811845561178;5432.402435732066;5451.427600102012;5495.290678791799;5443.292371991695;5472.674113501826;5503.569072041298;5526.917096243559;5532.834014979557;4992.400911890596;5302.655327403706;5319.430767923549;5341.465853414783;5359.866003349792;5221.295125158055;5227.843164705065;5228.451012643618;5261.500157485033;5288.8413347599635;5967.687108836049;6253.437190652863;6270.5924114934205;6273.874522509433;6342;4201.978990105152;4264.360345948133;4282.272013757731;4286;4288.120935208337;5744.798932037359;6068.120122582289;6074.997625391761;6096.29892562361;6152.50779937595;5876.882462350814;5901.970490147522;5907.881842363043;5913.319968203539;5931.970340148272;5883.235179426647;5907.586468947133;5921.822345329647;5935.673537955281;5955.302738719617;5483.013057649502;5802.535797136304;5807.970960145172;5808.751118509541;5812.331581868139;5907.675077870758;5929.407059294036;5947.256592925884;5948.910766338422;5949.434803693643;5705.828825135252;5711.457411545896;5755.453231942959;5812.447817457335;5813.244278243801 14:51:13 INFO - PROCESS | 19622 | |5;yui.html;766.8772996320587;774.5662429039735;775.1550809617515;794.6940427935245;824.2787560884226;14863.554093377203;15601.609959751011;15856.682866342695;15858.524244272661;16106.033637981714;14886.925565372185;14922.403103875859;14926.477573284938;14937.775933361008;14958.850411495909;670.4904272752694;793.7698067560401;809.9797505062362;810.9270165685087;812.1878121878092;799.3525244551931;800.9719659811908;804.9074356448996;805.2149154574272;805.9032916050082;866.6446756829702;869.0570730757105;871.507598207011;872.8821609082788;873.275181599271;861.4701958295666;862.4997501449144;865.7922098696331;867.7743786615493;868.1882439918664;629.3643420145686;630.6342321453546;631.4884943196026;631.5231999840137;634.3307810260173;15037.699246015018;15097.3206205721;15144.167070811101;15145.924270378688;15156.090634561851;15439.53681389549;15478.458253961056;15661.295241714037;15667.92166039174;15821.446249381217;12597.181183223152;12745.87254127456;12765.361731913366;13047.739045219043;13054.2820144892;3935.5670876203594;3957.9010524736823;4032.83047916104;4076.714629975903;4136.21411931732;75252.6237368815;76086;76169.61915190444;79064;79887.6005619974;11836.763264734656;11923;12022.579209727617;12057.397130143458;12343.753124937452;22906.083756649547;22923.42691432694;23008.769912301;23037.654435183485;23075.19236826703;8672.479651220947;8733.51965641883;8948.284137269133;8958.462492250486;9051.14014168653;4733.171694953369;4798.95201047992;4833.275008748716;4913.1893237615395;4927.507249275044;3477.2176260341726;3523.436250199956;3587.6232995535615;3588.1747198144053;3598.712103031751;631.7251995382023;644.8516841126474;646.6443456099221;654.9553462227739;655.5411212151513;713.3080911515822;720.1718024272129;722.22000239742;723.9674214660353;740.0933856026325;9158.313126515539;9496.952515237517;9604.567794449267;9647.239644016901;9783.107070948758;535.2613393516922;550.9586780991361;573.1202604002835;676.9458443324522;703.7290643102442;4696.459907110726;5374.193870919394;5488.121900495981;5500.944990550043;5697.202391665171;114817;119644;120567;122723;122898;67433;68017.65991170112;68371;100726.49636751915;103869.48065259625;60957;93791;93948.83281419451;94368;95372.52313738526;10300;10442.164626829683;10457.16342692598;10494.108000820015;10595.470226488798;44873.55126448694;45151.54848451474;45661.31508027316;50117.74941125271;50427.388811544035;49911.25133122934;50253.748731257576;56198.7190064047;73016;74503;12629.179103358252;13320.33398330099;13458.865411346153;13531.323433828466;13570.525031623845;15130;15241.314140863466;15336.463223787114;15430.305636246172;15588.454404095803;14572.781408279096;14796.408143674564;14999.925000374928;15136.848631513543;15179.16514591708;14323.85676143267;14564.344604493035;14700.926495367456;14840.703185936005;15365.078095314317;13766.31168441594;14160;14317.212553309668;14344.282785860874;14458.277086145861;11865.762684746429;11934.343611101473;12078.939605301917;12328.876711232773;12510.687232819253;10671.94664026675;10915.781684366428;11863.347515886364;12018.639440816789;12385.380730963236 14:51:13 INFO - PROCESS | 19622 | __end_tp_report 14:51:13 INFO - PROCESS | 19622 | __start_cc_report 14:51:13 INFO - PROCESS | 19622 | _x_x_mozilla_cycle_collect,352 14:51:13 INFO - PROCESS | 19622 | __end_cc_report 14:51:13 INFO - PROCESS | 19622 | __startTimestamp1465509073295__endTimestamp 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | ------- Summary: start ------- 14:51:13 INFO - PROCESS | 19622 | Number of tests: 6 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | [#0] dojo.html Cycles:165 Average:5471.58 Median:5715.69 stddev:762.23 (13.3%) stddev-sans-first:741.98 14:51:13 INFO - PROCESS | 19622 | Values: 3123.8 3150.1 3161.2 3165.4 3191.9 5558.9 5576.9 5602.0 5610.4 5639.9 5370.1 5505.8 5508.5 5520.3 5535.1 4957.6 4983.8 5092.3 5121.9 5178.5 137.1 5009.5 5104.3 5127.1 5141.6 4950.4 4951.4 4982.6 4984.7 5026.1 4877.4 4970.7 4972.3 5004.3 5010.7 4889.0 4903.5 4947.6 4975.8 4994.3 5438.2 5461.8 5495.9 5503.0 5571.7 5765.0 5822.7 5855.9 5858.9 5868.9 5911.3 5975.6 6018.3 6030.8 6043.1 5584.5 5609.7 5612.1 5613.0 5627.0 5873.4 5991.4 6049.8 6063.0 6064.3 5883.8 5885.0 5887.2 5891.3 5938.3 5959.1 5968.6 5976.0 5979.8 5980.0 5782.9 5835.6 5846.9 5879.3 5904.8 5714.9 5817.1 5837.4 5860.7 5874.4 4511.5 4523.6 4532.8 4538.4 4562.0 3952.6 4005.9 4024.6 4031.2 4059.3 5732.4 5736.5 5739.1 5745.5 5752.1 5995.8 6043.0 6049.5 6060.3 6074.6 5542.9 5549.9 5589.3 5621.7 5639.5 5083.7 5108.3 5121.7 5126.1 5134.3 5981.4 6088.1 6093.3 6102.6 6127.9 5963.5 6008.5 6021.5 6064.6 6075.8 6169.1 6183.0 6185.0 6187.8 6208.8 5709.2 5782.3 5923.4 5931.6 5933.9 5895.3 5924.3 5939.2 5954.3 6014.1 5724.5 5748.5 5797.0 5806.6 5820.2 5571.4 5671.6 5692.4 5797.4 5803.5 5582.7 5607.7 5621.4 5669.7 5702.0 5792.9 5842.2 5854.7 5855.3 5859.1 5543.8 5673.8 5715.7 5726.5 5745.7 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | [#1] ext.html Cycles:180 Average:61759.11 Median:43259.63 stddev:123633.02 (285.8%) stddev-sans-first:123894.40 14:51:13 INFO - PROCESS | 19622 | Values: 539.7 596.3 614.8 647.0 659.0 42861.8 44350.1 44375.3 44398.8 47312.5 45354.0 45712.8 45963.0 46001.0 46177.0 8845.6 9006.1 9012.1 9021.7 9030.1 8806.9 8812.4 8823.9 8852.0 8879.6 8948.2 8957.7 8959.7 8966.8 9016.0 8878.5 8893.3 8897.2 8925.6 8963.4 8858.9 8929.5 8952.5 8987.1 9019.3 43344.1 43432.0 43815.6 43831.3 43855.6 3450.3 3561.8 3640.6 3803.6 3932.5 30559.5 30598.1 32553.5 32694.8 33988.0 4276.7 4360.9 4381.5 4384.3 4451.7 350333.0 351497.0 352206.0 352423.0 352741.0 60754.7 60782.7 61155.4 61327.7 61357.7 36358.3 37164.0 37301.3 38212.4 38448.0 16375.2 16392.1 16416.7 16455.3 16479.3 13515.0 13583.7 13675.7 13693.5 13704.8 19575.3 19682.8 19767.6 19845.2 20083.2 7070.5 7081.7 7218.0 7373.9 7387.2 969.3 1005.4 1042.3 1052.8 1108.6 33110.7 33305.5 33385.7 33561.5 34006.1 1093.0 1123.7 1128.8 1137.6 1222.7 17517.7 17565.6 17753.8 17864.5 17909.6 567937.0 569807.0 575941.0 577391.0 578021.0 59885.4 61397.4 61555.0 61827.7 61865.7 1335.2 1346.4 1348.3 1355.7 1376.1 29120.7 30222.0 30522.5 30601.5 30981.0 53393.0 54083.7 54311.5 54370.0 54537.5 438053.0 442875.0 445406.0 446298.0 449262.0 29214.7 29372.9 29430.7 29501.9 29618.4 50061.0 51130.0 51213.0 52239.5 52430.0 42158.4 43825.0 44022.3 44188.6 45076.3 41702.2 42087.8 42771.4 43004.8 43028.4 41862.4 42180.8 42526.0 43175.1 43540.6 37653.2 38536.7 38655.4 38882.4 39343.8 29003.6 29064.6 29114.3 29232.4 29336.0 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | [#2] jquery.html Cycles:180 Average:27791.72 Median:2297.35 stddev:75607.74 (3291.1%) stddev-sans-first:75791.82 14:51:13 INFO - PROCESS | 19622 | Values: 373.9 385.6 389.7 392.3 405.7 16845.6 18682.7 19049.9 19163.2 19305.4 17143.4 17959.1 18696.6 18984.0 18986.8 5014.3 5043.4 5192.7 5206.8 5215.0 5128.7 5130.8 5141.1 5167.8 5176.2 5131.8 5132.5 5140.5 5155.2 5164.4 5316.8 5573.2 5599.0 5641.4 5646.2 5439.7 5454.5 5713.3 5722.7 5744.3 12714.2 13118.8 13282.9 18442.4 22647.1 2122.4 2212.7 2231.1 2267.1 2327.6 10074.2 10096.3 10185.5 10244.4 10293.5 1862.6 1878.1 1892.0 1924.3 1928.9 78874.6 80139.6 81374.6 83601.6 84267.0 10700.8 10811.6 10913.1 11088.8 11097.4 15298.9 15316.5 15384.6 15391.9 15421.8 7752.0 7883.2 7923.2 7984.8 8058.1 7340.4 7364.2 7452.9 7645.5 7645.9 4566.4 4683.6 4691.7 4764.6 4912.7 1963.1 1981.3 1988.4 1989.3 2028.4 897.7 973.2 1042.8 1044.0 1091.4 16929.7 18482.6 18918.4 18944.3 19045.7 968.5 973.9 992.3 1011.4 1023.1 10254.0 10705.3 10761.6 10771.5 10772.2 446518.0 448755.8 457988.0 463975.0 465510.0 72668.6 95768.5 96372.0 96740.5 101304.5 965.5 973.9 997.8 999.5 1033.6 17451.0 17561.6 17636.9 17770.6 17781.9 41135.6 41622.2 41622.4 42203.6 42315.8 57711.7 58935.4 59855.7 60304.4 60994.4 8376.3 8435.9 8689.6 8712.3 8928.4 10856.8 11895.9 12107.6 12629.5 12929.7 11344.5 11539.0 11779.6 11782.2 11791.9 11488.6 11498.9 11584.0 11598.7 11666.4 11694.6 11815.4 11959.3 12205.9 12367.6 7272.1 8328.2 8360.2 8471.0 8813.9 10228.8 11946.3 12092.3 12127.9 12307.3 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | [#3] mootools.html Cycles:180 Average:5825.78 Median:4818.84 stddev:3287.82 (68.2%) stddev-sans-first:3280.74 14:51:13 INFO - PROCESS | 19622 | Values: 1468.7 1504.6 1591.2 1748.6 1763.4 7724.8 8265.4 8397.2 8784.7 8796.4 8483.8 8736.6 8761.7 8810.5 8830.3 2344.2 2365.8 2373.5 2378.9 2380.3 2281.0 2301.4 2357.7 2358.9 2370.7 2331.2 2348.0 2354.8 2386.5 2391.0 2282.7 2304.3 2333.0 2334.8 2352.4 2286.6 2293.4 2297.3 2301.5 2308.2 8832.6 8868.6 8897.8 8898.6 8935.6 5145.4 5154.1 5196.6 5232.6 5384.4 3229.0 3308.7 3338.4 3355.1 3391.7 1144.8 1152.8 1174.6 1205.4 1211.5 12527.7 12661.7 12729.8 12781.9 12789.9 4642.4 4724.0 4826.6 4860.9 4862.7 10132.3 10155.0 10177.9 10180.8 10187.5 5354.2 5355.9 5366.8 5393.4 5397.1 4373.4 4684.0 4811.1 4901.8 4943.8 4063.6 4080.2 4097.8 4137.9 4163.1 1322.4 1331.6 1331.8 1342.1 1350.4 794.9 920.3 930.3 1016.8 1021.6 6130.9 6171.6 6236.3 6350.4 6428.2 916.1 916.5 922.3 978.9 995.5 4237.7 4338.7 4360.9 4373.6 4387.0 10822.5 10837.5 10892.3 11031.7 11065.7 10866.6 10890.8 10922.3 10944.2 10946.0 8020.4 8053.6 8208.8 8261.3 8273.0 5967.6 6082.2 6089.2 6134.2 6172.8 10032.9 10037.7 10048.1 10048.6 10125.6 9697.9 10020.2 10051.4 10330.4 10381.7 7084.5 7637.4 7679.5 7838.3 7861.8 8615.1 8621.7 8648.7 8677.3 8714.3 7594.9 7767.5 7832.3 7841.1 7929.0 7534.3 7590.4 7638.0 7757.4 7761.1 6576.2 6646.0 6649.4 6668.2 6672.2 5117.6 5157.0 5262.0 5300.8 5343.7 5053.5 5118.8 5161.4 5191.7 5222.9 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | [#4] prototype.html Cycles:180 Average:4782.28 Median:5350.67 stddev:1398.38 (26.1%) stddev-sans-first:1361.66 14:51:13 INFO - PROCESS | 19622 | Values: 323.3 333.9 334.9 335.6 340.1 5511.1 5665.3 5668.8 5684.5 5737.0 5565.5 5572.6 5587.4 5593.2 5600.2 4362.3 4365.3 4390.4 4397.1 4425.6 4260.3 4317.1 4322.8 4373.3 4446.2 4295.3 4299.6 4325.0 4344.4 4346.4 4362.9 4365.9 4385.3 4389.3 4397.1 3793.1 3841.2 3858.3 3894.7 3920.1 5456.8 5501.3 5503.4 5518.3 5540.7 4968.2 4992.6 4998.9 5001.3 5006.2 5760.9 5809.9 5845.4 5855.2 5933.3 4071.8 4126.5 4180.7 4241.0 4244.6 5918.9 6061.7 6090.8 6098.3 6200.4 4209.9 4210.4 4214.1 4224.7 4228.9 4284.7 4286.2 4290.4 4299.6 4299.8 4857.3 4933.8 4943.0 4943.0 4950.6 5875.6 5876.8 5885.6 5887.7 5915.8 1453.8 1454.6 1458.0 1462.9 1472.3 892.2 925.8 926.4 938.8 938.8 5063.2 5072.0 5090.4 5108.4 5128.8 5363.6 5369.7 5390.7 5408.9 5409.3 4906.9 4993.7 5004.2 5013.4 5044.6 2844.6 2863.6 2866.5 2876.7 2877.2 5446.2 5487.6 5503.5 5535.6 5552.9 5189.1 5296.8 5432.4 5451.4 5495.3 5443.3 5472.7 5503.6 5526.9 5532.8 4992.4 5302.7 5319.4 5341.5 5359.9 5221.3 5227.8 5228.5 5261.5 5288.8 5967.7 6253.4 6270.6 6273.9 6342.0 4202.0 4264.4 4282.3 4286.0 4288.1 5744.8 6068.1 6075.0 6096.3 6152.5 5876.9 5902.0 5907.9 5913.3 5932.0 5883.2 5907.6 5921.8 5935.7 5955.3 5483.0 5802.5 5808.0 5808.8 5812.3 5907.7 5929.4 5947.3 5948.9 5949.4 5705.8 5711.5 5755.5 5812.4 5813.2 14:51:13 INFO - PROCESS | 19622 | 14:51:13 INFO - PROCESS | 19622 | [#5] yui.html Cycles:180 Average:20378.49 Median:4106.46 stddev:28862.53 (702.9%) stddev-sans-first:28905.93 14:51:13 INFO - PROCESS | 19622 | Values: 766.9 774.6 775.2 794.7 824.3 14863.6 15601.6 15856.7 15858.5 16106.0 14886.9 14922.4 14926.5 14937.8 14958.9 670.5 793.8 810.0 810.9 812.2 799.4 801.0 804.9 805.2 805.9 866.6 869.1 871.5 872.9 873.3 861.5 862.5 865.8 867.8 868.2 629.4 630.6 631.5 631.5 634.3 15037.7 15097.3 15144.2 15145.9 15156.1 15439.5 15478.5 15661.3 15667.9 15821.4 12597.2 12745.9 12765.4 13047.7 13054.3 3935.6 3957.9 4032.8 4076.7 4136.2 75252.6 76086.0 76169.6 79064.0 79887.6 11836.8 11923.0 12022.6 12057.4 12343.8 22906.1 22923.4 23008.8 23037.7 23075.2 8672.5 8733.5 8948.3 8958.5 9051.1 4733.2 4799.0 4833.3 4913.2 4927.5 3477.2 3523.4 3587.6 3588.2 3598.7 631.7 644.9 646.6 655.0 655.5 713.3 720.2 722.2 724.0 740.1 9158.3 9497.0 9604.6 9647.2 9783.1 535.3 551.0 573.1 676.9 703.7 4696.5 5374.2 5488.1 5500.9 5697.2 114817.0 119644.0 120567.0 122723.0 122898.0 67433.0 68017.7 68371.0 100726.5 103869.5 60957.0 93791.0 93948.8 94368.0 95372.5 10300.0 10442.2 10457.2 10494.1 10595.5 44873.6 45151.5 45661.3 50117.7 50427.4 49911.3 50253.7 56198.7 73016.0 74503.0 12629.2 13320.3 13458.9 13531.3 13570.5 15130.0 15241.3 15336.5 15430.3 15588.5 14572.8 14796.4 14999.9 15136.8 15179.2 14323.9 14564.3 14700.9 14840.7 15365.1 13766.3 14160.0 14317.2 14344.3 14458.3 11865.8 11934.3 12078.9 12328.9 12510.7 10671.9 10915.8 11863.3 12018.6 12385.4 14:51:13 INFO - PROCESS | 19622 | -------- Summary: end -------- 14:51:13 INFO - PROCESS | 19622 | 14:51:14 INFO - TEST-INFO | 19622: exit 0 14:51:14 INFO - TEST-OK | dromaeo_css | took 1110655ms 14:51:14 INFO - TEST-START | kraken 14:51:14 INFO - operating with platform_type : linux_ 14:51:14 INFO - Initialising browser for kraken test... 14:51:14 INFO - TEST-INFO | started process 19860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ivC_y/profile http://localhost:46988/getInfo.html) 14:51:18 INFO - PROCESS | 19860 | __metrics Screen width/height:1600/1200 14:51:18 INFO - PROCESS | 19860 | colorDepth:24 14:51:18 INFO - PROCESS | 19860 | Browser inner width/height: 1024/697 14:51:18 INFO - PROCESS | 19860 | __metrics 14:51:19 ERROR - PROCESS | 19860 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:51:20 INFO - TEST-INFO | 19860: exit 0 14:51:20 INFO - Browser initialized. 14:51:20 INFO - Running cycle 1/1 for kraken test... 14:51:20 INFO - TEST-INFO | started process 19979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ivC_y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:32 INFO - PROCESS | 19979 | RSS: Main: 184909824 14:51:32 INFO - PROCESS | 19979 | 14:51:34 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-beat-detection) 14:51:35 INFO - PROCESS | 19979 | RSS: Main: 191172608 14:51:35 INFO - PROCESS | 19979 | 14:51:38 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-dft) 14:51:38 INFO - PROCESS | 19979 | RSS: Main: 189894656 14:51:38 INFO - PROCESS | 19979 | 14:51:41 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-fft) 14:51:42 INFO - PROCESS | 19979 | RSS: Main: 185339904 14:51:42 INFO - PROCESS | 19979 | 14:51:44 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46988/tests/kraken/driver.html?testName=audio-oscillator) 14:51:44 INFO - PROCESS | 19979 | RSS: Main: 185405440 14:51:44 INFO - PROCESS | 19979 | 14:51:47 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:51:47 INFO - PROCESS | 19979 | RSS: Main: 185511936 14:51:47 INFO - PROCESS | 19979 | 14:51:50 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46988/tests/kraken/driver.html?testName=imaging-darkroom) 14:51:51 INFO - PROCESS | 19979 | RSS: Main: 185733120 14:51:51 INFO - PROCESS | 19979 | 14:51:54 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46988/tests/kraken/driver.html?testName=imaging-desaturate) 14:51:55 INFO - PROCESS | 19979 | RSS: Main: 183664640 14:51:55 INFO - PROCESS | 19979 | 14:51:58 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46988/tests/kraken/driver.html?testName=json-parse-financial) 14:51:59 INFO - PROCESS | 19979 | RSS: Main: 185028608 14:51:59 INFO - PROCESS | 19979 | 14:52:00 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:52:01 INFO - PROCESS | 19979 | RSS: Main: 185573376 14:52:01 INFO - PROCESS | 19979 | 14:52:03 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:52:03 INFO - PROCESS | 19979 | RSS: Main: 185827328 14:52:03 INFO - PROCESS | 19979 | 14:52:05 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:52:06 INFO - PROCESS | 19979 | RSS: Main: 186040320 14:52:06 INFO - PROCESS | 19979 | 14:52:09 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:52:09 INFO - PROCESS | 19979 | RSS: Main: 186060800 14:52:09 INFO - PROCESS | 19979 | 14:52:12 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:52:13 INFO - PROCESS | 19979 | RSS: Main: 185958400 14:52:13 INFO - PROCESS | 19979 | 14:52:14 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:46988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46988/tests/kraken/driver.html?testName=ai-astar) 14:52:15 INFO - PROCESS | 19979 | RSS: Main: 186548224 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | __start_tp_report 14:52:15 INFO - PROCESS | 19979 | _x_x_mozilla_page_load 14:52:15 INFO - PROCESS | 19979 | _x_x_mozilla_page_load_details 14:52:15 INFO - PROCESS | 19979 | |i|pagename|runs| 14:52:15 INFO - PROCESS | 19979 | |0;ai-astar;111;104;111;110;113;112;111;111;112;112 14:52:15 INFO - PROCESS | 19979 | |1;audio-beat-detection;165;124;157;179;128;152;161;127;180;137 14:52:15 INFO - PROCESS | 19979 | |2;audio-dft;162;163;162;162;164;178;160;164;161;161 14:52:15 INFO - PROCESS | 19979 | |3;audio-fft;75;75;76;154;76;77;77;75;163;77 14:52:15 INFO - PROCESS | 19979 | |4;audio-oscillator;84;86;143;86;85;85;145;85;86;140 14:52:15 INFO - PROCESS | 19979 | |5;imaging-gaussian-blur;117;118;117;118;118;117;117;118;117;117 14:52:15 INFO - PROCESS | 19979 | |6;imaging-darkroom;159;159;157;162;162;161;156;158;152;154 14:52:15 INFO - PROCESS | 19979 | |7;imaging-desaturate;96;96;95;95;96;96;95;95;96;95 14:52:15 INFO - PROCESS | 19979 | |8;json-parse-financial;57;55;58;53;55;56;55;56;55;56 14:52:15 INFO - PROCESS | 19979 | |9;json-stringify-tinderbox;63;62;61;61;61;61;62;61;61;61 14:52:15 INFO - PROCESS | 19979 | |10;stanford-crypto-aes;80;85;79;84;86;81;83;86;106;88 14:52:15 INFO - PROCESS | 19979 | |11;stanford-crypto-ccm;130;138;134;141;135;127;124;134;133;144 14:52:15 INFO - PROCESS | 19979 | |12;stanford-crypto-pbkdf2;165;164;164;175;176;162;161;162;164;166 14:52:15 INFO - PROCESS | 19979 | |13;stanford-crypto-sha256-iterative;69;67;67;64;64;63;63;66;65;64 14:52:15 INFO - PROCESS | 19979 | __end_tp_report 14:52:15 INFO - PROCESS | 19979 | __start_cc_report 14:52:15 INFO - PROCESS | 19979 | _x_x_mozilla_cycle_collect,873 14:52:15 INFO - PROCESS | 19979 | __end_cc_report 14:52:15 INFO - PROCESS | 19979 | __startTimestamp1465509135100__endTimestamp 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | ------- Summary: start ------- 14:52:15 INFO - PROCESS | 19979 | Number of tests: 14 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:2.50 (2.2%) stddev-sans-first:2.65 14:52:15 INFO - PROCESS | 19979 | Values: 111.0 104.0 111.0 110.0 113.0 112.0 111.0 111.0 112.0 112.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:159.00 stddev:21.05 (13.2%) stddev-sans-first:21.71 14:52:15 INFO - PROCESS | 19979 | Values: 165.0 124.0 157.0 179.0 128.0 152.0 161.0 127.0 180.0 137.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.50 stddev:5.19 (3.2%) stddev-sans-first:5.46 14:52:15 INFO - PROCESS | 19979 | Values: 162.0 163.0 162.0 162.0 164.0 178.0 160.0 164.0 161.0 161.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.00 stddev:34.86 (45.9%) stddev-sans-first:36.39 14:52:15 INFO - PROCESS | 19979 | Values: 75.0 75.0 76.0 154.0 76.0 77.0 77.0 75.0 163.0 77.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:27.75 (32.6%) stddev-sans-first:28.61 14:52:15 INFO - PROCESS | 19979 | Values: 84.0 86.0 143.0 86.0 85.0 85.0 145.0 85.0 86.0 140.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:52:15 INFO - PROCESS | 19979 | Values: 117.0 118.0 117.0 118.0 118.0 117.0 117.0 118.0 117.0 117.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#6] imaging-darkroom Cycles:10 Average:158.00 Median:159.00 stddev:3.33 (2.1%) stddev-sans-first:3.52 14:52:15 INFO - PROCESS | 19979 | Values: 159.0 159.0 157.0 162.0 162.0 161.0 156.0 158.0 152.0 154.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:52:15 INFO - PROCESS | 19979 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.35 (2.4%) stddev-sans-first:1.33 14:52:15 INFO - PROCESS | 19979 | Values: 57.0 55.0 58.0 53.0 55.0 56.0 55.0 56.0 55.0 56.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.44 14:52:15 INFO - PROCESS | 19979 | Values: 63.0 62.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 61.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:84.50 stddev:7.66 (9.1%) stddev-sans-first:7.83 14:52:15 INFO - PROCESS | 19979 | Values: 80.0 85.0 79.0 84.0 86.0 81.0 83.0 86.0 106.0 88.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:134.50 stddev:6.07 (4.5%) stddev-sans-first:6.27 14:52:15 INFO - PROCESS | 19979 | Values: 130.0 138.0 134.0 141.0 135.0 127.0 124.0 134.0 133.0 144.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:164.50 stddev:5.28 (3.2%) stddev-sans-first:5.59 14:52:15 INFO - PROCESS | 19979 | Values: 165.0 164.0 164.0 175.0 176.0 162.0 161.0 162.0 164.0 166.0 14:52:15 INFO - PROCESS | 19979 | 14:52:15 INFO - PROCESS | 19979 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.99 (3.0%) stddev-sans-first:1.56 14:52:15 INFO - PROCESS | 19979 | Values: 69.0 67.0 67.0 64.0 64.0 63.0 63.0 66.0 65.0 64.0 14:52:15 INFO - PROCESS | 19979 | -------- Summary: end -------- 14:52:15 INFO - PROCESS | 19979 | 14:52:16 INFO - TEST-INFO | 19979: exit 0 14:52:16 INFO - TEST-OK | kraken | took 62062ms 14:52:16 INFO - SUITE-END | took 1172s 14:52:16 INFO - Completed test suite (00:19:32) 14:52:16 INFO - javascript benchmark 14:52:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7319.292868122603, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.812571245725, 3150.1022208670533, 3161.2413020874983, 3165.35110302388, 3191.904242872715, 5558.916616250759, 5576.86057848554, 5602.0, 5610.354809196943, 5639.887202255953, 5370.113931201347, 5505.752241149148, 5508.476694714006, 5520.282363292767, 5535.059039963206, 4957.603391728662, 4983.825566105187, 5092.312537807404, 5121.923171152435, 5178.5339319461245, 137.14069330249373, 5009.524095210949, 5104.310918026074, 5127.077126117298, 5141.588672906178, 4950.381202349707, 4951.405831300249, 4982.60139188864, 4984.725840078812, 5026.145555255615, 4877.3903262092235, 4970.6520543561965, 4972.328735620681, 5004.299398084271, 5010.674306170124, 4889.046635906, 4903.509649035103, 4947.6289278304275, 4975.800967961277, 4994.250862370637, 5438.238646589481, 5461.826688606492, 5495.917561236544, 5503.0, 5571.721413929287, 5765.048766953448, 5822.679752613604, 5855.912161317584, 5858.941410585925, 5868.9413105868825, 5911.290645122613, 5975.551833612496, 6018.2778066631845, 6030.8190754277, 6043.062057675621, 5584.497395234448, 5609.74756135979, 5612.102063669793, 5613.0, 5626.971865140648, 5873.353931067579, 5991.370906054889, 6049.848753781191, 6063.0, 6064.332923378425, 5883.794067207627, 5884.970575147183, 5887.175795388649, 5891.263592050994, 5938.346781853993, 5959.106134079922, 5968.582199246098, 5976.043832986788, 5979.820605381846, 5980.0, 5782.913256301159, 5835.562332825055, 5846.912296315559, 5879.323877754113, 5904.76380944766, 5714.885702286014, 5817.127430885401, 5837.416258374129, 5860.677662728505, 5874.383189765099, 4511.526289739596, 4523.638108951276, 4532.79602417892, 4538.387317712132, 4561.977190114028, 3952.565217826037, 4005.919881602352, 4024.557298697141, 4031.1534577738416, 4059.3099173140636, 5732.398098199629, 5736.5123964462655, 5739.110437882135, 5745.454181852718, 5752.050911599623, 5995.760169593167, 6042.969785151046, 6049.485793707584, 6060.303065147476, 6074.574779765374, 5542.889142217133, 5549.944500554942, 5589.329280486368, 5621.747021384048, 5639.464250896158, 5083.72039537829, 5108.310378098983, 5121.667091639031, 5126.077306084941, 5134.307550598765, 5981.401859814071, 6088.056351265561, 6093.268807743099, 6102.633841969496, 6127.927612667854, 5963.522918166623, 6008.54935879802, 6021.488173505126, 6064.575479716377, 6075.756969721162, 6169.074638804215, 6182.969085154546, 6185.041318595625, 6187.84530386744, 6208.844778880564, 5709.172170035238, 5782.335031471434, 5923.378045305353, 5931.614445061057, 5933.940660593339, 5895.29256489224, 5924.289085309791, 5939.227900372924, 5954.345022047658, 6014.127951447103, 5724.484796368347, 5748.511376533042, 5797.0, 5806.593538452436, 5820.214271073351, 5571.415001424954, 5671.574631902541, 5692.430756924275, 5797.449242321973, 5803.506701930383, 5582.748776305158, 5607.719614019201, 5621.353544342453, 5669.688167150846, 5702.030654788613, 5792.855178620568, 5842.2405087338375, 5854.707264636836, 5855.3266374367495, 5859.062549991981, 5543.805966791143, 5673.773049078156, 5715.685637289823, 5726.455986681259, 5745.6552606843725], "value": 5421.65533958896, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.6923753460529, 596.2755252368372, 614.7817524778703, 646.9838254043651, 659.0443856408207, 42861.78569107154, 44350.11299774006, 44375.3343699844, 44398.778006110006, 47312.526874731244, 45354.0, 45712.77143614286, 45963.0, 46001.0, 46177.0, 8845.601947912359, 9006.144416280476, 9012.098790121001, 9021.684241051564, 9030.096990300983, 8806.911930880673, 8812.427192232484, 8823.867641985375, 8851.95574022129, 8879.600417981206, 8948.239399651038, 8957.731268061936, 8959.731208063737, 8966.775830604254, 9016.0, 8878.511681857495, 8893.28853691703, 8897.199252067345, 8925.642974281021, 8963.417377870417, 8858.911410885938, 8929.508877011762, 8952.507612081334, 8987.101289871025, 9019.278457723432, 43344.13311733748, 43432.0, 43815.56184438147, 43831.34252986208, 43855.561444385465, 3450.3271861986923, 3561.786292822413, 3640.581333146669, 3803.5625903020955, 3932.46911666927, 30559.541606875915, 30598.082057538308, 32553.51169732456, 32694.83652581722, 33988.0, 4276.700630955835, 4360.897749632937, 4381.496127945264, 4384.254676704968, 4451.666125040635, 350333.0, 351497.0, 352206.0, 352423.0, 352740.99999999744, 60754.69622651947, 60782.69608651928, 61155.38844611586, 61327.6933615338, 61357.69321153365, 36358.27283454316, 37164.0, 37301.25397492035, 38212.42681359782, 38448.0, 16375.181240937905, 16392.098434585972, 16416.67166656684, 16455.341786328412, 16479.34082636705, 13515.0, 13583.728325433634, 13675.726485470434, 13693.452261909611, 13704.794428083587, 19575.314863979977, 19682.8031719681, 19767.604647906963, 19845.206191752455, 20083.196672133243, 7070.540414873017, 7081.716731330792, 7217.9639101805205, 7373.88939165913, 7387.187409384964, 969.2585172343163, 1005.406809982114, 1042.2599954032721, 1052.8157572424948, 1108.6119858049617, 33110.66889331124, 33305.50041749376, 33385.66614333874, 33561.496577551356, 34006.14984625404, 1092.9781404372027, 1123.7359220583319, 1128.8316592326903, 1137.6075254037344, 1222.706550427891, 17517.7372339415, 17565.560860978323, 17753.822461775475, 17864.46406607804, 17909.58220640197, 567937.0, 569807.0, 575941.0, 577391.0, 578021.0, 59885.401145987984, 61397.38602613917, 61555.0, 61827.6908615463, 61865.69067154726, 1335.1855368225374, 1346.3672074125145, 1348.2786709110578, 1355.728854229158, 1376.0711519724146, 29120.708792912646, 30222.0, 30522.542161868034, 30601.54097688492, 30981.0, 53393.0, 54083.72958135184, 54311.45688543222, 54370.0, 54537.454625454826, 438053.0, 442875.0, 445406.0, 446298.0, 449262.0, 29214.70785292205, 29372.853135734185, 29430.705692942796, 29501.85249073741, 29618.40763184681, 50060.99878002347, 51130.0, 51213.0, 52239.47760522346, 52430.0, 42158.36762448627, 43825.0, 44022.339664905696, 44188.55811441973, 45076.32385514154, 41702.16595668009, 42087.789561052, 42771.35842962296, 43004.78497607617, 43028.35457468203, 41862.372064419666, 42180.78909605432, 42526.0, 43175.136497270505, 43540.56459435365, 37653.2469350606, 38536.73636490755, 38655.42016869693, 38882.416763748, 39343.80328098341, 29003.564946525395, 29064.564031539965, 29114.27214319659, 29232.415351692423, 29335.973240936466], "value": 20384.963147244365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.89904725724074, 385.56046107437516, 389.7466646679656, 392.3114933292072, 405.663299461447, 16845.578860528494, 18682.719759203625, 19049.904750476246, 19163.23347066119, 19305.420837374884, 17143.399981000668, 17959.10204489777, 18696.626067478643, 18983.95588242646, 18986.810131898677, 5014.348134742479, 5043.445221025693, 5192.688438693672, 5206.817761378353, 5215.0, 5128.666636668605, 5130.846074617767, 5141.1003074462005, 5167.844964651066, 5176.171812509999, 5131.846044618667, 5132.486751324875, 5140.511651393112, 5155.226715992593, 5164.406093299281, 5316.813911513098, 5573.164025396202, 5598.972005139969, 5641.435856414326, 5646.237757902672, 5439.700816455093, 5454.53636440903, 5713.285839270091, 5722.656640601577, 5744.281964754406, 12714.237145771283, 13118.803217951738, 13282.86717132826, 18442.35451759182, 22647.09411623533, 2122.4375540481783, 2212.6902233687297, 2231.062953559509, 2267.104493724986, 2327.6043072677685, 10074.194064474825, 10096.34373765703, 10185.490725463771, 10244.436555989418, 10293.485325733684, 1862.6367858267643, 1878.101514454354, 1891.9527011824678, 1924.2976313645559, 1928.8746231494908, 78874.60562697207, 80139.5993020037, 81374.59312703398, 83601.58199209026, 84267.0, 10700.839487407695, 10811.56753729842, 10913.072388847037, 11088.778224435466, 11097.44512774358, 15298.923505382625, 15316.463923762838, 15384.615384615474, 15391.923040384727, 15421.845781542266, 7752.0, 7883.172266911892, 7923.247291507298, 7984.760457186294, 8058.0733215679775, 7340.376068034277, 7364.189939106694, 7452.85094298111, 7645.503042302344, 7645.923540764521, 4566.406367172246, 4683.648726345537, 4691.695039822401, 4764.6426518011285, 4912.680675756136, 1963.1067864122076, 1981.30654271004, 1988.3836010836687, 1989.3136867780593, 2028.3914825552276, 897.7486303834937, 973.1679414100984, 1042.8435734639713, 1044.0, 1091.4379094766202, 16929.661406771796, 18482.630347393246, 18918.43244702661, 18944.336948206746, 19045.7143142853, 968.4528241543505, 973.8733964584559, 992.2855544008303, 1011.3780025284544, 1023.1150055202196, 10254.0, 10705.304155229886, 10761.56953721858, 10771.515281812337, 10772.192085593611, 446518.0, 448755.7562212168, 457988.0, 463975.0, 465510.0, 72668.63665681638, 95768.52115739517, 96372.0, 96740.51629741806, 101304.49347753215, 965.5220665770488, 973.9366941148803, 997.7954519323521, 999.4752754803641, 1033.617561502249, 17451.04019278901, 17561.56096097608, 17636.911815440842, 17770.555736106184, 17781.91109044498, 41135.588644114374, 41622.1675566493, 41622.37566436445, 42203.57796421996, 42315.78842105893, 57711.71144144252, 58935.41064589299, 59855.70072149786, 60304.39695602988, 60994.390056100645, 8376.32989360862, 8435.873461897954, 8689.6089675966, 8712.303015758851, 8928.419652722552, 10856.782864342827, 11895.940520297343, 12107.576234831738, 12629.494820207088, 12929.741405172032, 11344.546218151181, 11539.0, 11779.587714429954, 11782.17524773292, 11791.941040295087, 11488.597899073493, 11498.885011149781, 11584.0, 11598.652040438801, 11666.416679165837, 11694.590689325832, 11815.40922953866, 11959.342236176746, 12205.877941220475, 12367.62897113088, 7272.127344718668, 8328.208820162075, 8360.205780450848, 8471.0, 8813.911860881566, 10228.846567301645, 11946.34295113777, 12092.274463532216, 12127.939360303142, 12307.26156430617], "value": 8941.801567992314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1468.7209430208259, 1504.6012806606252, 1591.2441590244628, 1748.5628592851788, 1763.4445149777819, 7724.806879828007, 8265.42142050056, 8397.202265784756, 8784.736457906258, 8796.384253102286, 8483.787905302355, 8736.563171841415, 8761.737147885573, 8810.515421651806, 8830.293576513879, 2344.1678204237505, 2365.82256330775, 2373.52529494101, 2378.904843806254, 2380.27401642499, 2280.950762649183, 2301.413139649387, 2357.7406485286606, 2358.9410264743346, 2370.6681064650875, 2331.184085570054, 2348.049040138738, 2354.846934949223, 2386.522695460906, 2391.0, 2282.657601359793, 2304.2511183865145, 2333.0, 2334.8482348647285, 2352.4001379648253, 2286.634138537843, 2293.415179129328, 2297.2993237062688, 2301.5051763870847, 2308.1921327535397, 8832.558372081434, 8868.600912958933, 8897.822043559157, 8898.599563019616, 8935.597898094602, 5145.408278048035, 5154.098032844275, 5196.636235463519, 5232.633715639907, 5384.40771515133, 3228.950591057892, 3308.718758905496, 3338.4157772389735, 3355.0941245863723, 3391.745619078579, 1144.8339990701386, 1152.8097863852454, 1174.5654107980017, 1205.4153735438306, 1211.485118824496, 12527.686807829878, 12661.74676506474, 12729.809052864215, 12781.936090319581, 12789.872101278961, 4642.373279607277, 4724.0, 4826.58973987215, 4860.8784780380065, 4862.7325497098, 10132.290739648153, 10155.0, 10177.949110254402, 10180.796384072277, 10187.490625468698, 5354.223637572531, 5355.946440535623, 5366.838994830161, 5393.406725260218, 5397.082495975615, 4373.431453910971, 4683.976580117078, 4811.08589368019, 4901.754912254373, 4943.752812359367, 4063.6139566741113, 4080.18396320737, 4097.82539316243, 4137.8758637240935, 4163.084121493267, 1322.365264672943, 1331.6204881608694, 1331.8468376136868, 1342.1074985134971, 1350.419319692522, 794.9443538952218, 920.3281604428804, 930.3115694386106, 1016.8220561401725, 1021.6322124035341, 6130.938690613037, 6171.56799024073, 6236.314005459396, 6350.364963503705, 6428.19647544057, 916.0656130746601, 916.4501299220415, 922.2990527199242, 978.8531720241879, 995.5271246158162, 4237.745735255895, 4338.717983331074, 4360.869173924787, 4373.606375426227, 4386.978065109718, 10822.512986915608, 10837.512311945982, 10892.346459212473, 11031.724206894893, 11065.668029959113, 10866.619668311729, 10890.836637450444, 10922.344659320466, 10944.17918656104, 10946.0, 8020.43856930021, 8053.59732013397, 8208.794780130425, 8261.256486916087, 8273.048599411024, 5967.582269241111, 6082.178905847654, 6089.177960975212, 6134.2332208473945, 6172.783952561639, 10032.949835250776, 10037.749056273651, 10048.09567138961, 10048.648297309559, 10125.64560240388, 9697.854532182164, 10020.24848136378, 10051.396916185053, 10330.380177189392, 10381.688549343531, 7084.46866485026, 7637.427192960661, 7679.462437629312, 7838.294553490213, 7861.764147075597, 8615.095414981337, 8621.655133794578, 8648.654053837776, 8677.305815534615, 8714.346424018097, 7594.8860767087435, 7767.4562780607075, 7832.295093441618, 7841.118131648477, 7928.960355198187, 7534.321911028033, 7590.354819840375, 7638.0, 7757.418193635387, 7761.068671759425, 6576.210854697276, 6646.0, 6649.401553860176, 6668.199816022108, 6672.199336079701, 5117.590592752496, 5157.0, 5261.973690131525, 5300.814471493479, 5343.706096164593, 5053.494650534917, 5118.795248190031, 5161.406438259648, 5191.662541934762, 5222.947770522246], "value": 4678.0663595982205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.3113468312494, 333.8531046339611, 334.88279102314186, 335.5956072932117, 340.07669178181266, 5511.145772405279, 5665.348484924235, 5668.829935101943, 5684.45997630225, 5736.971315143423, 5565.499105080542, 5572.554195664347, 5587.38538760736, 5593.216949627055, 5600.215969764236, 4362.323839804827, 4365.3451982202605, 4390.429244198266, 4397.12057588482, 4425.601695847373, 4260.31834906415, 4317.071829556645, 4322.805473753673, 4373.2565463871215, 4446.15523050621, 4295.269804133305, 4299.634531064863, 4324.97837510812, 4344.3917851500655, 4346.434963454746, 4362.890927726817, 4365.890852728708, 4385.276429389147, 4389.275769498045, 4397.098594788061, 3793.108619474421, 3841.2125514269505, 3858.3440815061226, 3894.7468414552964, 3920.137569734654, 5456.836294911159, 5501.312335958005, 5503.394626591112, 5518.255035570227, 5540.667559946376, 4968.2299243616935, 4992.575631071363, 4998.850034498934, 5001.324821149135, 5006.173981293082, 5760.942390576082, 5809.854753631151, 5845.415458454163, 5855.180274761537, 5933.3473317934995, 4071.75569465833, 4126.546079931205, 4180.686448516373, 4241.0, 4244.5967633075115, 5918.940810591882, 6061.666433384692, 6090.847728806771, 6098.298695650013, 6200.410960958701, 4209.894752631209, 4210.389493523422, 4214.1150358425075, 4224.683148763855, 4228.9154216915485, 4284.6572274218615, 4286.249906266391, 4290.399344091829, 4299.591538803808, 4299.763513006815, 4857.271409288564, 4933.802647894116, 4942.950570494249, 4942.9752851236235, 4950.554450099508, 5875.588708790429, 5876.823695289148, 5885.558583106199, 5887.735051922588, 5915.792947246826, 1453.7601295786076, 1454.5854431486975, 1457.9927100364641, 1462.9341679624442, 1472.2785834940803, 892.1925657280042, 925.7546750111226, 926.4441335198961, 938.7795865374985, 938.7842743646994, 5063.240513922941, 5072.0, 5090.440051594322, 5108.438071812097, 5128.79484820603, 5363.570914326844, 5369.704666243316, 5390.730463476811, 5408.945910540844, 5409.29679141709, 4906.8773280668265, 4993.650444468853, 5004.174311238678, 5013.39839219296, 5044.571211447068, 2844.630198074237, 2863.599096126544, 2866.512692842222, 2876.7267109624554, 2877.1656219696056, 5446.183072539151, 5487.5884308677005, 5503.477169668875, 5535.612507124543, 5552.91670624941, 5189.131912511493, 5296.811845561178, 5432.402435732066, 5451.427600102012, 5495.290678791799, 5443.292371991695, 5472.674113501826, 5503.569072041298, 5526.917096243559, 5532.834014979557, 4992.400911890596, 5302.655327403706, 5319.430767923549, 5341.465853414783, 5359.866003349792, 5221.295125158055, 5227.843164705065, 5228.451012643618, 5261.500157485033, 5288.8413347599635, 5967.687108836049, 6253.437190652863, 6270.5924114934205, 6273.874522509433, 6342.0, 4201.978990105152, 4264.360345948133, 4282.272013757731, 4286.0, 4288.120935208337, 5744.798932037359, 6068.120122582289, 6074.997625391761, 6096.29892562361, 6152.50779937595, 5876.882462350814, 5901.970490147522, 5907.881842363043, 5913.319968203539, 5931.970340148272, 5883.235179426647, 5907.586468947133, 5921.822345329647, 5935.673537955281, 5955.302738719617, 5483.013057649502, 5802.535797136304, 5807.970960145172, 5808.751118509541, 5812.331581868139, 5907.675077870758, 5929.407059294036, 5947.256592925884, 5948.910766338422, 5949.434803693643, 5705.828825135252, 5711.457411545896, 5755.453231942959, 5812.447817457335, 5813.244278243801], "value": 4330.248934524734, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.8772996320587, 774.5662429039735, 775.1550809617515, 794.6940427935245, 824.2787560884226, 14863.554093377203, 15601.609959751011, 15856.682866342695, 15858.524244272661, 16106.033637981714, 14886.925565372185, 14922.403103875859, 14926.477573284938, 14937.775933361008, 14958.850411495909, 670.4904272752694, 793.7698067560401, 809.9797505062362, 810.9270165685087, 812.1878121878092, 799.3525244551931, 800.9719659811908, 804.9074356448996, 805.2149154574272, 805.9032916050082, 866.6446756829702, 869.0570730757105, 871.507598207011, 872.8821609082788, 873.275181599271, 861.4701958295666, 862.4997501449144, 865.7922098696331, 867.7743786615493, 868.1882439918664, 629.3643420145686, 630.6342321453546, 631.4884943196026, 631.5231999840137, 634.3307810260173, 15037.699246015018, 15097.3206205721, 15144.167070811101, 15145.924270378688, 15156.090634561851, 15439.53681389549, 15478.458253961056, 15661.295241714037, 15667.92166039174, 15821.446249381217, 12597.181183223152, 12745.87254127456, 12765.361731913366, 13047.739045219043, 13054.2820144892, 3935.5670876203594, 3957.9010524736823, 4032.83047916104, 4076.714629975903, 4136.21411931732, 75252.6237368815, 76086.0, 76169.61915190444, 79064.0, 79887.6005619974, 11836.763264734656, 11923.0, 12022.579209727617, 12057.397130143458, 12343.753124937452, 22906.083756649547, 22923.42691432694, 23008.769912301, 23037.654435183485, 23075.19236826703, 8672.479651220947, 8733.51965641883, 8948.284137269133, 8958.462492250486, 9051.14014168653, 4733.171694953369, 4798.95201047992, 4833.275008748716, 4913.1893237615395, 4927.507249275044, 3477.2176260341726, 3523.436250199956, 3587.6232995535615, 3588.1747198144053, 3598.712103031751, 631.7251995382023, 644.8516841126474, 646.6443456099221, 654.9553462227739, 655.5411212151513, 713.3080911515822, 720.1718024272129, 722.22000239742, 723.9674214660353, 740.0933856026325, 9158.313126515539, 9496.952515237517, 9604.567794449267, 9647.239644016901, 9783.107070948758, 535.2613393516922, 550.9586780991361, 573.1202604002835, 676.9458443324522, 703.7290643102442, 4696.459907110726, 5374.193870919394, 5488.121900495981, 5500.944990550043, 5697.202391665171, 114817.0, 119644.0, 120567.0, 122723.0, 122898.0, 67433.0, 68017.65991170112, 68371.0, 100726.49636751915, 103869.48065259625, 60957.0, 93791.0, 93948.83281419451, 94368.0, 95372.52313738526, 10300.0, 10442.164626829683, 10457.16342692598, 10494.108000820015, 10595.470226488798, 44873.55126448694, 45151.54848451474, 45661.31508027316, 50117.74941125271, 50427.388811544035, 49911.25133122934, 50253.748731257576, 56198.7190064047, 73016.0, 74503.0, 12629.179103358252, 13320.33398330099, 13458.865411346153, 13531.323433828466, 13570.525031623845, 15130.0, 15241.314140863466, 15336.463223787114, 15430.305636246172, 15588.454404095803, 14572.781408279096, 14796.408143674564, 14999.925000374928, 15136.848631513543, 15179.16514591708, 14323.85676143267, 14564.344604493035, 14700.926495367456, 14840.703185936005, 15365.078095314317, 13766.31168441594, 14160.0, 14317.212553309668, 14344.282785860874, 14458.277086145861, 11865.762684746429, 11934.343611101473, 12078.939605301917, 12328.876711232773, 12510.687232819253, 10671.94664026675, 10915.781684366428, 11863.347515886364, 12018.639440816789, 12385.380730963236], "value": 7679.3596737275775, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 110.0, 113.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 124.0, 157.0, 179.0, 128.0, 152.0, 161.0, 127.0, 180.0, 137.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 164.0, 178.0, 160.0, 164.0, 161.0, 161.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 154.0, 76.0, 77.0, 77.0, 75.0, 163.0, 77.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 143.0, 86.0, 85.0, 85.0, 145.0, 85.0, 86.0, 140.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 157.0, 162.0, 162.0, 161.0, 156.0, 158.0, 152.0, 154.0], "value": 158.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 58.0, 53.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 79.0, 84.0, 86.0, 81.0, 83.0, 86.0, 106.0, 88.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 138.0, 134.0, 141.0, 135.0, 127.0, 124.0, 134.0, 133.0, 144.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 175.0, 176.0, 162.0, 161.0, 162.0, 164.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 64.0, 64.0, 63.0, 63.0, 66.0, 65.0, 64.0], "value": 65.2, "unit": "score"}]}]} 14:52:16 INFO - Return code: 0 14:52:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:52:16 ERROR - # TBPL SUCCESS # 14:52:16 INFO - Running post-action listener: _resource_record_post_action 14:52:16 INFO - ##### 14:52:16 INFO - ##### Finished run-tests step (success) 14:52:16 INFO - ##### 14:52:16 INFO - Running post-run listener: _resource_record_post_run 14:52:16 INFO - Total resource usage - Wall time: 1191s; CPU: 14.0%; Read bytes: 8192; Write bytes: 542601216; Read time: 164; Write time: 397980 14:52:16 INFO - TinderboxPrint: CPU usage
13.5% 14:52:16 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 164 14:52:16 INFO - TinderboxPrint: I/O write bytes / time
542,601,216 / 397,980 14:52:16 INFO - TinderboxPrint: CPU idle
8,214.0 (86.5%) 14:52:16 INFO - TinderboxPrint: CPU user
1,229.7 (12.9%) 14:52:16 INFO - TinderboxPrint: Swap in / out
0 / 0 14:52:16 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248844288; Read time: 0; Write time: 254260 14:52:16 INFO - run-tests - Wall time: 1174s; CPU: 14.0%; Read bytes: 8192; Write bytes: 293756928; Read time: 164; Write time: 143720 14:52:17 INFO - Running post-run listener: _upload_blobber_files 14:52:17 INFO - Blob upload gear active. 14:52:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:52:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:52:17 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'] 14:52:17 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 14:52:17 INFO - (blobuploader) - INFO - Open directory for files ... 14:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:18 INFO - (blobuploader) - INFO - Done attempting. 14:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:52:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:22 INFO - (blobuploader) - INFO - Done attempting. 14:52:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:52:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:52:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:52:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:52:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:52:23 INFO - (blobuploader) - INFO - Done attempting. 14:52:23 INFO - (blobuploader) - INFO - Iteration through files over. 14:52:23 INFO - Return code: 0 14:52:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:52:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:52:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6b4f68471e9ba03eb40c6f2faeecb582e1df05fc3e8be95828f5aa9c5ceb27d4034bc9b2f105e6a535675db5760565c16136422e0216c7820651a18987ada33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb0b78bb4a2462b4487873c69a9e9679e625a959df6c5a58f4e148cd16fe06b7ff111519b88d6cc54459e3e3c2abfb35f67b61254c1883745e382cd09aa8987b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8809d43bb447e6961c0ac42a9b92bdfaf28b8942c38ede4f375a0affa64a0dc86e01c6c654ec06f3c89867c6203ecc3f72fd6fa7d64d70c9f9a715e2bb20fe8"} 14:52:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:52:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:52:23 INFO - Contents: 14:52:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d6b4f68471e9ba03eb40c6f2faeecb582e1df05fc3e8be95828f5aa9c5ceb27d4034bc9b2f105e6a535675db5760565c16136422e0216c7820651a18987ada33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb0b78bb4a2462b4487873c69a9e9679e625a959df6c5a58f4e148cd16fe06b7ff111519b88d6cc54459e3e3c2abfb35f67b61254c1883745e382cd09aa8987b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8809d43bb447e6961c0ac42a9b92bdfaf28b8942c38ede4f375a0affa64a0dc86e01c6c654ec06f3c89867c6203ecc3f72fd6fa7d64d70c9f9a715e2bb20fe8"} 14:52:23 INFO - Running post-run listener: copy_logs_to_upload_dir 14:52:23 INFO - Copying logs to upload dir... 14:52:23 INFO - mkdir: /builds/slave/test/build/upload/logs 14:52:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.740738 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-09 14:52:23.545248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:23.549038) ========= 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=ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259 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/d6b4f68471e9ba03eb40c6f2faeecb582e1df05fc3e8be95828f5aa9c5ceb27d4034bc9b2f105e6a535675db5760565c16136422e0216c7820651a18987ada33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb0b78bb4a2462b4487873c69a9e9679e625a959df6c5a58f4e148cd16fe06b7ff111519b88d6cc54459e3e3c2abfb35f67b61254c1883745e382cd09aa8987b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8809d43bb447e6961c0ac42a9b92bdfaf28b8942c38ede4f375a0affa64a0dc86e01c6c654ec06f3c89867c6203ecc3f72fd6fa7d64d70c9f9a715e2bb20fe8"} 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.011367 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/d6b4f68471e9ba03eb40c6f2faeecb582e1df05fc3e8be95828f5aa9c5ceb27d4034bc9b2f105e6a535675db5760565c16136422e0216c7820651a18987ada33", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb0b78bb4a2462b4487873c69a9e9679e625a959df6c5a58f4e148cd16fe06b7ff111519b88d6cc54459e3e3c2abfb35f67b61254c1883745e382cd09aa8987b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8809d43bb447e6961c0ac42a9b92bdfaf28b8942c38ede4f375a0affa64a0dc86e01c6c654ec06f3c89867c6203ecc3f72fd6fa7d64d70c9f9a715e2bb20fe8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:23.575939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:23.576386) ========= 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=ed14279e38b05397cf4aa391000001a4-1465507907.107478-1990856259 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 14:52:23.660001) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:52:23.660373) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 14:52:23.660740) ========= ========= Total master_lag: 0.17 =========