builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1466190818.97 results: success (0) buildid: 20160617092425 builduid: 8a937aa855e741658bb29aaed982b09c revision: 530e96008b7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:38.971273) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:38.973685) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:38.974167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:39.045629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:39.045975) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 12:13:39-- 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% 19.5M=0.001s 2016-06-17 12:13:39 (19.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.234984 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:39.309510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:39.309805) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.083688 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:39.408134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:39.408518) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 530e96008b7e --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 530e96008b7e --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=03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 12:13:39,498 Setting DEBUG logging. 2016-06-17 12:13:39,498 attempt 1/10 2016-06-17 12:13:39,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/530e96008b7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 12:13:39,782 unpacking tar archive at: fx-team-530e96008b7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:40.042201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:40.042520) ========= script_repo_revision: 530e96008b7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:40.042928) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:40.043194) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 12:13:40.053422) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-17 12:13:40.053733) ========= /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=03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:13:40 INFO - MultiFileLogger online at 20160617 12:13:40 in /builds/slave/test 12:13:40 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 12:13:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:13:40 INFO - {'append_to_log': False, 12:13:40 INFO - 'base_work_dir': '/builds/slave/test', 12:13:40 INFO - 'blob_upload_branch': 'Fx-Team', 12:13:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:13:40 INFO - 'branch': 'Fx-Team', 12:13:40 INFO - 'buildbot_json_path': 'buildprops.json', 12:13:40 INFO - 'config_files': ('talos/linux_config.py',), 12:13:40 INFO - 'default_actions': ('clobber', 12:13:40 INFO - 'read-buildbot-config', 12:13:40 INFO - 'download-and-extract', 12:13:40 INFO - 'populate-webroot', 12:13:40 INFO - 'create-virtualenv', 12:13:40 INFO - 'install', 12:13:40 INFO - 'run-tests'), 12:13:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:13:40 INFO - 'download_minidump_stackwalk': True, 12:13:40 INFO - 'download_symbols': 'ondemand', 12:13:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:13:40 INFO - 'tooltool.py': '/tools/tooltool.py', 12:13:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:13:40 INFO - '/tools/misc-python/virtualenv.py')}, 12:13:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:13:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:13:40 INFO - 'installer_path': 'installer.exe', 12:13:40 INFO - 'log_level': 'info', 12:13:40 INFO - 'log_name': 'talos', 12:13:40 INFO - 'log_to_console': True, 12:13:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:13:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:13:40 INFO - 'opt_config_files': (), 12:13:40 INFO - 'pip_index': False, 12:13:40 INFO - 'sps_profile': False, 12:13:40 INFO - 'sps_profile_interval': 0, 12:13:40 INFO - 'suite': 'dromaeojs-e10s', 12:13:40 INFO - 'system_bits': '32', 12:13:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:13:40 INFO - 'title': 'talos-linux64-ix-047', 12:13:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:13:40 INFO - 'use_talos_json': True, 12:13:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:13:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:13:40 INFO - 'work_dir': 'build'} 12:13:40 INFO - ##### 12:13:40 INFO - ##### Running clobber step. 12:13:40 INFO - ##### 12:13:40 INFO - Running pre-action listener: _resource_record_pre_action 12:13:40 INFO - Running main action method: clobber 12:13:40 INFO - rmtree: /builds/slave/test/build 12:13:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:13:41 INFO - Running post-action listener: _resource_record_post_action 12:13:41 INFO - ##### 12:13:41 INFO - ##### Finished clobber step (success) 12:13:41 INFO - ##### 12:13:41 INFO - ##### 12:13:41 INFO - ##### Running read-buildbot-config step. 12:13:41 INFO - ##### 12:13:41 INFO - Running pre-action listener: _resource_record_pre_action 12:13:41 INFO - Running main action method: read_buildbot_config 12:13:41 INFO - Using buildbot properties: 12:13:41 INFO - { 12:13:41 INFO - "project": "", 12:13:41 INFO - "product": "firefox", 12:13:41 INFO - "script_repo_revision": "production", 12:13:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:13:41 INFO - "repository": "", 12:13:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:13:41 INFO - "buildid": "20160617092425", 12:13:41 INFO - "pgo_build": "True", 12:13:41 INFO - "basedir": "/builds/slave/test", 12:13:41 INFO - "buildnumber": 841, 12:13:41 INFO - "slavename": "talos-linux64-ix-047", 12:13:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:13:41 INFO - "platform": "ubuntu64_hw", 12:13:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:13:41 INFO - "branch": "fx-team", 12:13:41 INFO - "repo_path": "integration/fx-team", 12:13:41 INFO - "revision": "530e96008b7e", 12:13:41 INFO - "stage_platform": "linux64-pgo", 12:13:41 INFO - "builduid": "8a937aa855e741658bb29aaed982b09c", 12:13:41 INFO - "slavebuilddir": "test" 12:13:41 INFO - } 12:13:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:13:41 INFO - Running post-action listener: _resource_record_post_action 12:13:41 INFO - ##### 12:13:41 INFO - ##### Finished read-buildbot-config step (success) 12:13:41 INFO - ##### 12:13:41 INFO - ##### 12:13:41 INFO - ##### Running download-and-extract step. 12:13:41 INFO - ##### 12:13:41 INFO - Running pre-action listener: _resource_record_pre_action 12:13:41 INFO - Running main action method: download_and_extract 12:13:41 INFO - mkdir: /builds/slave/test/build/tests 12:13:41 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')]} 12:13:41 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:43 INFO - Downloaded 1361 bytes. 12:13:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:43 INFO - Using the following test package requirements: 12:13:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:13:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:13:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'jsshell-linux-x86_64.zip'], 12:13:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:13:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:13:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:13:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:13:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:13:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:43 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:44 INFO - Downloaded 24220995 bytes. 12:13:44 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'] 12:13:44 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 12:13:45 INFO - Return code: 0 12:13:45 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 12:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:45 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:50 INFO - Downloaded 24220995 bytes. 12:13:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:13:51 INFO - Return code: 0 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:53 INFO - Downloaded 14405384 bytes. 12:13:53 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'] 12:13:53 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 12:13:53 INFO - Return code: 0 12:13: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')]} 12:13:53 INFO - https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:13:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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 12:13:57 INFO - Downloaded 59400986 bytes. 12:13:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:57 INFO - mkdir: /builds/slave/test/properties 12:13:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:13:57 INFO - Writing to file /builds/slave/test/properties/build_url 12:13:57 INFO - Contents: 12:13:57 INFO - build_url:https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:58 INFO - Running post-action listener: _resource_record_post_action 12:13:58 INFO - Running post-action listener: set_extra_try_arguments 12:13:58 INFO - ##### 12:13:58 INFO - ##### Finished download-and-extract step (success) 12:13:58 INFO - ##### 12:13:58 INFO - ##### 12:13:58 INFO - ##### Running populate-webroot step. 12:13:58 INFO - ##### 12:13:58 INFO - Running pre-action listener: _resource_record_pre_action 12:13:58 INFO - Running main action method: populate_webroot 12:13:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:13:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:13:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:13:58 INFO - '--tppagecycles', 12:13:58 INFO - '7'], 12:13:58 INFO - 'tests': ['tsvgm']}}, 12:13:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:13:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:13:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:13:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:13:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['damp', 'tps']}, 12:13:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'tests': ['damp', 'tps']}, 12:13:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['dromaeo_dom']}, 12:13:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:13:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['basic_compositor_video']}, 12:13:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:13:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['a11yr', 12:13:58 INFO - 'ts_paint', 12:13:58 INFO - 'tpaint', 12:13:58 INFO - 'sessionrestore', 12:13:58 INFO - 'sessionrestore_no_auto_restore', 12:13:58 INFO - 'tabpaint']}, 12:13:58 INFO - 'other-e10s': {'tests': ['a11yr', 12:13:58 INFO - 'ts_paint', 12:13:58 INFO - 'tpaint', 12:13:58 INFO - 'sessionrestore', 12:13:58 INFO - 'sessionrestore_no_auto_restore', 12:13:58 INFO - 'tabpaint']}, 12:13:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:13:58 INFO - 'ts_paint', 12:13:58 INFO - 'tpaint', 12:13:58 INFO - 'sessionrestore', 12:13:58 INFO - 'sessionrestore_no_auto_restore', 12:13:58 INFO - 'tabpaint']}, 12:13:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:13:58 INFO - 'ts_paint', 12:13:58 INFO - 'tpaint', 12:13:58 INFO - 'sessionrestore', 12:13:58 INFO - 'sessionrestore_no_auto_restore', 12:13:58 INFO - 'tabpaint']}, 12:13:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['a11yr', 12:13:58 INFO - 'ts_paint', 12:13:58 INFO - 'tpaint', 12:13:58 INFO - 'sessionrestore', 12:13:58 INFO - 'sessionrestore_no_auto_restore', 12:13:58 INFO - 'tabpaint']}, 12:13:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['a11yr', 12:13:58 INFO - 'ts_paint', 12:13:58 INFO - 'tpaint', 12:13:58 INFO - 'sessionrestore', 12:13:58 INFO - 'sessionrestore_no_auto_restore', 12:13:58 INFO - 'tabpaint']}, 12:13:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['tsvgx', 12:13:58 INFO - 'tsvgr_opacity', 12:13:58 INFO - 'tart', 12:13:58 INFO - 'tscrollx', 12:13:58 INFO - 'cart']}, 12:13:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:13:58 INFO - 'tsvgr_opacity', 12:13:58 INFO - 'tart', 12:13:58 INFO - 'tscrollx', 12:13:58 INFO - 'cart']}, 12:13:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'talos_options': ['--disable-e10s'], 12:13:58 INFO - 'tests': ['tp5o']}, 12:13:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'tests': ['tp5o']}, 12:13:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'talos_options': ['--disable-e10s', 12:13:58 INFO - '--xperf_path', 12:13:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:58 INFO - 'tests': ['tp5n']}, 12:13:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:58 INFO - 'talos_options': ['--xperf_path', 12:13:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:58 INFO - 'tests': ['tp5n']}}, 12:13:58 INFO - 'talos.zip': {'path': '', 12:13:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:13:58 INFO - Running post-action listener: _resource_record_post_action 12:13:58 INFO - ##### 12:13:58 INFO - ##### Finished populate-webroot step (success) 12:13:58 INFO - ##### 12:13:58 INFO - ##### 12:13:58 INFO - ##### Running create-virtualenv step. 12:13:58 INFO - ##### 12:13:58 INFO - Running pre-action listener: _resource_record_pre_action 12:13:58 INFO - Running main action method: create_virtualenv 12:13:58 INFO - Creating virtualenv /builds/slave/test/build/venv 12:13:58 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 12:13:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:13:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:13:58 INFO - Using real prefix '/usr' 12:13:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:13:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:00 INFO - Installing pip.................done. 12:14:00 INFO - Return code: 0 12:14:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:00 INFO - Using env: {'DISPLAY': ':0', 12:14:00 INFO - 'HOME': '/home/cltbld', 12:14:00 INFO - 'LANG': 'en_US.UTF-8', 12:14:00 INFO - 'LANGUAGE': 'en_US:en', 12:14:00 INFO - 'LOGNAME': 'cltbld', 12:14:00 INFO - 'MAIL': '/var/mail/cltbld', 12:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:00 INFO - 'MOZ_NO_REMOTE': '1', 12:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:00 INFO - 'NO_EM_RESTART': '1', 12:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:00 INFO - 'PWD': '/builds/slave/test', 12:14:00 INFO - 'SHELL': '/bin/bash', 12:14:00 INFO - 'SHLVL': '1', 12:14:00 INFO - 'TERM': 'linux', 12:14:00 INFO - 'TMOUT': '86400', 12:14:00 INFO - 'USER': 'cltbld', 12:14:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:00 INFO - '_': '/tools/buildbot/bin/python'} 12:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:01 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 12:14:01 INFO - Cleaning up... 12:14:01 INFO - Return code: 0 12:14:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14:01 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')]} 12:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:01 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')]} 12:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:01 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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:01 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 12:14:01 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 12:14:01 INFO - Using env: {'DISPLAY': ':0', 12:14:01 INFO - 'HOME': '/home/cltbld', 12:14:01 INFO - 'LANG': 'en_US.UTF-8', 12:14:01 INFO - 'LANGUAGE': 'en_US:en', 12:14:01 INFO - 'LOGNAME': 'cltbld', 12:14:01 INFO - 'MAIL': '/var/mail/cltbld', 12:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:01 INFO - 'MOZ_NO_REMOTE': '1', 12:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:01 INFO - 'NO_EM_RESTART': '1', 12:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:01 INFO - 'PWD': '/builds/slave/test', 12:14:01 INFO - 'SHELL': '/bin/bash', 12:14:01 INFO - 'SHLVL': '1', 12:14:01 INFO - 'TERM': 'linux', 12:14:01 INFO - 'TMOUT': '86400', 12:14:01 INFO - 'USER': 'cltbld', 12:14:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:01 INFO - '_': '/tools/buildbot/bin/python'} 12:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:01 INFO - Downloading/unpacking psutil>=3.1.1 12:14:01 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 12:14:01 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 12:14:01 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 12:14:01 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 12:14:01 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 12:14:01 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 12:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:03 INFO - Installing collected packages: psutil 12:14:03 INFO - Running setup.py install for psutil 12:14:03 INFO - building 'psutil._psutil_linux' extension 12:14:03 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 12:14:04 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 12:14:04 INFO - building 'psutil._psutil_posix' extension 12:14:04 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 12:14: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 12:14:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:05 INFO - Successfully installed psutil 12:14:05 INFO - Cleaning up... 12:14:05 INFO - Return code: 0 12:14:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:14:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:14:05 INFO - Using env: {'DISPLAY': ':0', 12:14:05 INFO - 'HOME': '/home/cltbld', 12:14:05 INFO - 'LANG': 'en_US.UTF-8', 12:14:05 INFO - 'LANGUAGE': 'en_US:en', 12:14:05 INFO - 'LOGNAME': 'cltbld', 12:14:05 INFO - 'MAIL': '/var/mail/cltbld', 12:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:05 INFO - 'MOZ_NO_REMOTE': '1', 12:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:05 INFO - 'NO_EM_RESTART': '1', 12:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:05 INFO - 'PWD': '/builds/slave/test', 12:14:05 INFO - 'SHELL': '/bin/bash', 12:14:05 INFO - 'SHLVL': '1', 12:14:05 INFO - 'TERM': 'linux', 12:14:05 INFO - 'TMOUT': '86400', 12:14:05 INFO - 'USER': 'cltbld', 12:14:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:05 INFO - '_': '/tools/buildbot/bin/python'} 12:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:07 INFO - Installing collected packages: mozsystemmonitor 12:14:07 INFO - Running setup.py install for mozsystemmonitor 12:14:07 INFO - Successfully installed mozsystemmonitor 12:14:07 INFO - Cleaning up... 12:14:07 INFO - Return code: 0 12:14:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:14:07 INFO - Using env: {'DISPLAY': ':0', 12:14:07 INFO - 'HOME': '/home/cltbld', 12:14:07 INFO - 'LANG': 'en_US.UTF-8', 12:14:07 INFO - 'LANGUAGE': 'en_US:en', 12:14:07 INFO - 'LOGNAME': 'cltbld', 12:14:07 INFO - 'MAIL': '/var/mail/cltbld', 12:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:07 INFO - 'MOZ_NO_REMOTE': '1', 12:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:07 INFO - 'NO_EM_RESTART': '1', 12:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:07 INFO - 'PWD': '/builds/slave/test', 12:14:07 INFO - 'SHELL': '/bin/bash', 12:14:07 INFO - 'SHLVL': '1', 12:14:07 INFO - 'TERM': 'linux', 12:14:07 INFO - 'TMOUT': '86400', 12:14:07 INFO - 'USER': 'cltbld', 12:14:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:07 INFO - '_': '/tools/buildbot/bin/python'} 12:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:07 INFO - Downloading/unpacking jsonschema==2.5.1 12:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:14:09 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 12:14:09 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 12:14:09 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 12:14:09 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 12:14:09 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 12:14:09 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 12:14:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:09 INFO - warning: no files found matching '*.txt' 12:14:09 INFO - no previously-included directories found matching 'build' 12:14:09 INFO - no previously-included directories found matching 'dist' 12:14:09 INFO - no previously-included directories found matching '.git*' 12:14:09 INFO - Installing collected packages: jsonschema, functools32 12:14:09 INFO - Running setup.py install for functools32 12:14:10 INFO - warning: no files found matching '*.txt' 12:14:10 INFO - no previously-included directories found matching 'build' 12:14:10 INFO - no previously-included directories found matching 'dist' 12:14:10 INFO - no previously-included directories found matching '.git*' 12:14:10 INFO - Successfully installed jsonschema functools32 12:14:10 INFO - Cleaning up... 12:14:10 INFO - Return code: 0 12:14:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14: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 12:14: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 12:14:10 INFO - Using env: {'DISPLAY': ':0', 12:14:10 INFO - 'HOME': '/home/cltbld', 12:14:10 INFO - 'LANG': 'en_US.UTF-8', 12:14:10 INFO - 'LANGUAGE': 'en_US:en', 12:14:10 INFO - 'LOGNAME': 'cltbld', 12:14:10 INFO - 'MAIL': '/var/mail/cltbld', 12:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:10 INFO - 'MOZ_NO_REMOTE': '1', 12:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:10 INFO - 'NO_EM_RESTART': '1', 12:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:10 INFO - 'PWD': '/builds/slave/test', 12:14:10 INFO - 'SHELL': '/bin/bash', 12:14:10 INFO - 'SHLVL': '1', 12:14:10 INFO - 'TERM': 'linux', 12:14:10 INFO - 'TMOUT': '86400', 12:14:10 INFO - 'USER': 'cltbld', 12:14:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:10 INFO - '_': '/tools/buildbot/bin/python'} 12:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:10 INFO - Downloading/unpacking blobuploader==1.2.4 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14: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 12:14:12 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 INFO - Downloading docopt-0.6.1.tar.gz 12:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:13 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:13 INFO - Running setup.py install for blobuploader 12:14:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:13 INFO - Running setup.py install for requests 12:14:13 INFO - Running setup.py install for docopt 12:14:13 INFO - Successfully installed blobuploader requests docopt 12:14:13 INFO - Cleaning up... 12:14:13 INFO - Return code: 0 12:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:13 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')]} 12:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:13 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')]} 12:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:13 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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:13 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 12:14:13 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 12:14:13 INFO - Using env: {'DISPLAY': ':0', 12:14:13 INFO - 'HOME': '/home/cltbld', 12:14:13 INFO - 'LANG': 'en_US.UTF-8', 12:14:13 INFO - 'LANGUAGE': 'en_US:en', 12:14:13 INFO - 'LOGNAME': 'cltbld', 12:14:13 INFO - 'MAIL': '/var/mail/cltbld', 12:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:13 INFO - 'MOZ_NO_REMOTE': '1', 12:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:13 INFO - 'NO_EM_RESTART': '1', 12:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:13 INFO - 'PWD': '/builds/slave/test', 12:14:13 INFO - 'SHELL': '/bin/bash', 12:14:13 INFO - 'SHLVL': '1', 12:14:13 INFO - 'TERM': 'linux', 12:14:13 INFO - 'TMOUT': '86400', 12:14:13 INFO - 'USER': 'cltbld', 12:14:13 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:13 INFO - '_': '/tools/buildbot/bin/python'} 12:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:13 INFO - Running setup.py (path:/tmp/pip-x8Kpu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:13 INFO - Running setup.py (path:/tmp/pip-ZEHeso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:14 INFO - Running setup.py (path:/tmp/pip-GPsi2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:14 INFO - Running setup.py (path:/tmp/pip-8eDGZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:14 INFO - Running setup.py (path:/tmp/pip-GShmYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:14 INFO - Running setup.py (path:/tmp/pip-gJpXwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:14 INFO - Running setup.py (path:/tmp/pip-mbCT5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:14 INFO - Running setup.py (path:/tmp/pip-o5zbAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:14 INFO - Running setup.py (path:/tmp/pip-fsakfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:14 INFO - Running setup.py (path:/tmp/pip-Ocohyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:14 INFO - Running setup.py (path:/tmp/pip-_7w2DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:14 INFO - Running setup.py (path:/tmp/pip-YSF3TV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:14 INFO - Running setup.py (path:/tmp/pip-ZvY9EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:14 INFO - Running setup.py (path:/tmp/pip-jkSyuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:14 INFO - Running setup.py (path:/tmp/pip-AADyxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:14 INFO - Running setup.py (path:/tmp/pip-3TUTGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:15 INFO - Running setup.py (path:/tmp/pip-OBbczP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:15 INFO - Running setup.py install for manifestparser 12:14:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Running setup.py install for mozcrash 12:14:15 INFO - Running setup.py install for mozdebug 12:14:15 INFO - Running setup.py install for mozdevice 12:14:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Running setup.py install for mozfile 12:14:15 INFO - Running setup.py install for mozhttpd 12:14:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Running setup.py install for mozinfo 12:14:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Running setup.py install for mozInstall 12:14:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:15 INFO - Running setup.py install for mozleak 12:14:15 INFO - Running setup.py install for mozlog 12:14:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:16 INFO - Running setup.py install for moznetwork 12:14:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:16 INFO - Running setup.py install for mozprocess 12:14:16 INFO - Running setup.py install for mozprofile 12:14:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:16 INFO - Running setup.py install for mozrunner 12:14:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:16 INFO - Running setup.py install for mozscreenshot 12:14:16 INFO - Running setup.py install for moztest 12:14:16 INFO - Running setup.py install for mozversion 12:14:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:16 INFO - Cleaning up... 12:14:16 INFO - Return code: 0 12:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:16 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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:16 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 12:14:16 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 12:14:16 INFO - Using env: {'DISPLAY': ':0', 12:14:16 INFO - 'HOME': '/home/cltbld', 12:14:16 INFO - 'LANG': 'en_US.UTF-8', 12:14:16 INFO - 'LANGUAGE': 'en_US:en', 12:14:16 INFO - 'LOGNAME': 'cltbld', 12:14:16 INFO - 'MAIL': '/var/mail/cltbld', 12:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:16 INFO - 'MOZ_NO_REMOTE': '1', 12:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:16 INFO - 'NO_EM_RESTART': '1', 12:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:16 INFO - 'PWD': '/builds/slave/test', 12:14:16 INFO - 'SHELL': '/bin/bash', 12:14:16 INFO - 'SHLVL': '1', 12:14:16 INFO - 'TERM': 'linux', 12:14:16 INFO - 'TMOUT': '86400', 12:14:16 INFO - 'USER': 'cltbld', 12:14:16 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:16 INFO - '_': '/tools/buildbot/bin/python'} 12:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:17 INFO - Running setup.py (path:/tmp/pip-uXfyl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14: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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:17 INFO - Running setup.py (path:/tmp/pip-UtxqTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:17 INFO - Running setup.py (path:/tmp/pip-zaVlXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:17 INFO - Running setup.py (path:/tmp/pip-uuGZon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:17 INFO - Running setup.py (path:/tmp/pip-QCYTFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:17 INFO - Running setup.py (path:/tmp/pip-CDezoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:17 INFO - Running setup.py (path:/tmp/pip-0tVOVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:17 INFO - Running setup.py (path:/tmp/pip-4K3Pgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:17 INFO - Running setup.py (path:/tmp/pip-_7stoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:17 INFO - Running setup.py (path:/tmp/pip-hW9kv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:17 INFO - Running setup.py (path:/tmp/pip-UsTsQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:17 INFO - Running setup.py (path:/tmp/pip-iV1_SR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:17 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)) 12:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:17 INFO - Running setup.py (path:/tmp/pip-f9ZyXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14: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)) 12:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:18 INFO - Running setup.py (path:/tmp/pip-uUqxZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14: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)) 12:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:18 INFO - Running setup.py (path:/tmp/pip-u6dQWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:18 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)) 12:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:18 INFO - Running setup.py (path:/tmp/pip-8acMta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:18 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)) 12:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:18 INFO - Running setup.py (path:/tmp/pip-Ueqzbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:18 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)) 12:14:18 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)) 12:14:18 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)) 12:14:18 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)) 12:14:18 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)) 12:14:18 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)) 12:14:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:18 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 12:14:18 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 12:14:18 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 12:14:18 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 12:14:18 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 12:14:18 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 12:14:20 INFO - Downloading blessings-1.6.tar.gz 12:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:20 INFO - Installing collected packages: blessings 12:14:20 INFO - Running setup.py install for blessings 12:14:20 INFO - Successfully installed blessings 12:14:20 INFO - Cleaning up... 12:14:20 INFO - Return code: 0 12:14:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:20 INFO - Reading from file tmpfile_stdout 12:14:20 INFO - Current package versions: 12:14:20 INFO - argparse == 1.2.1 12:14:20 INFO - blessings == 1.6 12:14:20 INFO - blobuploader == 1.2.4 12:14:20 INFO - docopt == 0.6.1 12:14:20 INFO - functools32 == 3.2.3-2 12:14:20 INFO - jsonschema == 2.5.1 12:14:20 INFO - manifestparser == 1.1 12:14:20 INFO - mozInstall == 1.12 12:14:20 INFO - mozcrash == 0.17 12:14:20 INFO - mozdebug == 0.1 12:14:20 INFO - mozdevice == 0.48 12:14:20 INFO - mozfile == 1.2 12:14:20 INFO - mozhttpd == 0.7 12:14:20 INFO - mozinfo == 0.9 12:14:20 INFO - mozleak == 0.1 12:14:20 INFO - mozlog == 3.2 12:14:20 INFO - moznetwork == 0.27 12:14:20 INFO - mozprocess == 0.22 12:14:20 INFO - mozprofile == 0.28 12:14:20 INFO - mozrunner == 6.11 12:14:20 INFO - mozscreenshot == 0.1 12:14:20 INFO - mozsystemmonitor == 0.3 12:14:20 INFO - moztest == 0.7 12:14:20 INFO - mozversion == 1.4 12:14:20 INFO - psutil == 3.1.1 12:14:20 INFO - requests == 1.2.3 12:14:20 INFO - wsgiref == 0.1.2 12:14:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:20 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')]} 12:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:20 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')]} 12:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:20 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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:20 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 12:14:20 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 12:14:20 INFO - Using env: {'DISPLAY': ':0', 12:14:20 INFO - 'HOME': '/home/cltbld', 12:14:20 INFO - 'LANG': 'en_US.UTF-8', 12:14:20 INFO - 'LANGUAGE': 'en_US:en', 12:14:20 INFO - 'LOGNAME': 'cltbld', 12:14:20 INFO - 'MAIL': '/var/mail/cltbld', 12:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:20 INFO - 'MOZ_NO_REMOTE': '1', 12:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:20 INFO - 'NO_EM_RESTART': '1', 12:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:20 INFO - 'PWD': '/builds/slave/test', 12:14:20 INFO - 'SHELL': '/bin/bash', 12:14:20 INFO - 'SHLVL': '1', 12:14:20 INFO - 'TERM': 'linux', 12:14:20 INFO - 'TMOUT': '86400', 12:14:20 INFO - 'USER': 'cltbld', 12:14:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:20 INFO - '_': '/tools/buildbot/bin/python'} 12:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 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)) 12:14:20 INFO - Cleaning up... 12:14:20 INFO - Return code: 0 12:14:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14:20 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')]} 12:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:20 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')]} 12:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:20 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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14:20 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 12:14:20 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 12:14:20 INFO - Using env: {'DISPLAY': ':0', 12:14:20 INFO - 'HOME': '/home/cltbld', 12:14:20 INFO - 'LANG': 'en_US.UTF-8', 12:14:20 INFO - 'LANGUAGE': 'en_US:en', 12:14:20 INFO - 'LOGNAME': 'cltbld', 12:14:20 INFO - 'MAIL': '/var/mail/cltbld', 12:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:20 INFO - 'MOZ_NO_REMOTE': '1', 12:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:20 INFO - 'NO_EM_RESTART': '1', 12:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:20 INFO - 'PWD': '/builds/slave/test', 12:14:20 INFO - 'SHELL': '/bin/bash', 12:14:20 INFO - 'SHLVL': '1', 12:14:20 INFO - 'TERM': 'linux', 12:14:20 INFO - 'TMOUT': '86400', 12:14:20 INFO - 'USER': 'cltbld', 12:14:20 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:20 INFO - '_': '/tools/buildbot/bin/python'} 12:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:14:21 INFO - Cleaning up... 12:14:21 INFO - Return code: 0 12:14:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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 0x7fbb8c952f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f3c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', '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 12:14: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 12:14: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 12:14:21 INFO - Using env: {'DISPLAY': ':0', 12:14:21 INFO - 'HOME': '/home/cltbld', 12:14:21 INFO - 'LANG': 'en_US.UTF-8', 12:14:21 INFO - 'LANGUAGE': 'en_US:en', 12:14:21 INFO - 'LOGNAME': 'cltbld', 12:14:21 INFO - 'MAIL': '/var/mail/cltbld', 12:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:21 INFO - 'MOZ_NO_REMOTE': '1', 12:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:21 INFO - 'NO_EM_RESTART': '1', 12:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:21 INFO - 'PWD': '/builds/slave/test', 12:14:21 INFO - 'SHELL': '/bin/bash', 12:14:21 INFO - 'SHLVL': '1', 12:14:21 INFO - 'TERM': 'linux', 12:14:21 INFO - 'TMOUT': '86400', 12:14:21 INFO - 'USER': 'cltbld', 12:14:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:21 INFO - '_': '/tools/buildbot/bin/python'} 12:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:21 INFO - Downloading/unpacking flake8 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:14:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:14:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:14:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:23 INFO - no previously-included directories found matching 'docs/_build' 12:14:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:14:24 INFO - Running setup.py install for pep8 12:14:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:14:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:14:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:14:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:14:24 INFO - no previously-included directories found matching 'docs/_build' 12:14:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:14:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:14:24 INFO - Cleaning up... 12:14:24 INFO - Return code: 0 12:14:24 INFO - Running post-action listener: _resource_record_post_action 12:14:24 INFO - Running post-action listener: _start_resource_monitoring 12:14:24 INFO - Starting resource monitoring. 12:14:24 INFO - ##### 12:14:24 INFO - ##### Finished create-virtualenv step (success) 12:14:24 INFO - ##### 12:14:24 INFO - ##### 12:14:24 INFO - ##### Running install step. 12:14:24 INFO - ##### 12:14:24 INFO - Running pre-action listener: _resource_record_pre_action 12:14:24 INFO - Running main action method: install 12:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:24 INFO - Reading from file tmpfile_stdout 12:14:24 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:24 INFO - Reading from file tmpfile_stdout 12:14:24 INFO - Output received: 12:14:24 INFO - Usage: mozinstall [options] installer 12:14:24 INFO - Options: 12:14:24 INFO - -h, --help show this help message and exit 12:14:24 INFO - -d DEST, --destination=DEST 12:14:24 INFO - Directory to install application into. [default: 12:14:24 INFO - "/builds/slave/test"] 12:14:24 INFO - --app=APP Application being installed. [default: firefox] 12:14:24 INFO - mkdir: /builds/slave/test/build/application 12:14:24 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'] 12:14:24 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 12:14:41 INFO - Reading from file tmpfile_stdout 12:14:41 INFO - Output received: 12:14:41 INFO - /builds/slave/test/build/application/firefox/firefox 12:14:41 INFO - Running post-action listener: _resource_record_post_action 12:14:41 INFO - ##### 12:14:41 INFO - ##### Finished install step (success) 12:14:41 INFO - ##### 12:14:41 INFO - ##### 12:14:41 INFO - ##### Running run-tests step. 12:14:41 INFO - ##### 12:14:41 INFO - Running pre-action listener: _resource_record_pre_action 12:14:41 INFO - Running main action method: run_tests 12:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:14:41 INFO - Python 2.7.3 12:14:41 INFO - Return code: 0 12:14:41 INFO - grabbing minidump binary from tooltool 12:14:41 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')]} 12:14:41 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 0x1fcb1c0>, '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 0x1fcc0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fcc550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:14:41 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 12:14:41 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 12:14:41 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 12:14:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:14:41 INFO - Return code: 0 12:14:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:14:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:14:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:14:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:14:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:14:42 INFO - Return code: 0 12:14:42 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/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 12:14:42 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/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 12:14:42 INFO - Using env: {'DISPLAY': ':0', 12:14:42 INFO - 'HOME': '/home/cltbld', 12:14:42 INFO - 'LANG': 'en_US.UTF-8', 12:14:42 INFO - 'LANGUAGE': 'en_US:en', 12:14:42 INFO - 'LOGNAME': 'cltbld', 12:14:42 INFO - 'MAIL': '/var/mail/cltbld', 12:14:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:14:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:42 INFO - 'MOZ_NO_REMOTE': '1', 12:14:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:42 INFO - 'NO_EM_RESTART': '1', 12:14:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:42 INFO - 'PWD': '/builds/slave/test', 12:14:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:14:42 INFO - 'SHELL': '/bin/bash', 12:14:42 INFO - 'SHLVL': '1', 12:14:42 INFO - 'TERM': 'linux', 12:14:42 INFO - 'TMOUT': '86400', 12:14:42 INFO - 'USER': 'cltbld', 12:14:42 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514', 12:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:42 INFO - '_': '/tools/buildbot/bin/python'} 12:14:42 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/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 12:14:43 INFO - mozversion application_buildid: 20160617092425 12:14:43 INFO - mozversion application_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 12:14:43 INFO - mozversion application_display_name: Nightly 12:14:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:14:43 INFO - mozversion application_name: Firefox 12:14:43 INFO - mozversion application_remotingname: firefox 12:14:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:14:43 INFO - mozversion application_vendor: Mozilla 12:14:43 INFO - mozversion application_version: 50.0a1 12:14:43 INFO - mozversion platform_buildid: 20160617092425 12:14:43 INFO - mozversion platform_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 12:14:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:14:43 INFO - mozversion platform_version: 50.0a1 12:14:43 INFO - using testdate: 1466190883 12:14:43 INFO - actual date: 1466190883 12:14:43 INFO - starting webserver on 'localhost:58272' 12:14:43 INFO - SUITE-START | Running 2 tests 12:14:43 INFO - TEST-START | dromaeo_css 12:14:43 INFO - operating with platform_type : linux_ 12:14:43 INFO - Initialising browser for dromaeo_css test... 12:14:43 INFO - TEST-INFO | started process 3361 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikwSK5/profile http://localhost:58272/getInfo.html) 12:14:49 INFO - PROCESS | 3361 | __metrics Screen width/height:1600/1200 12:14:49 INFO - PROCESS | 3361 | colorDepth:24 12:14:49 INFO - PROCESS | 3361 | Browser inner width/height: 1024/697 12:14:49 INFO - PROCESS | 3361 | __metrics 12:14:50 ERROR - PROCESS | 3361 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 12:14:50 INFO - TEST-INFO | 3361: exit 0 12:14:50 INFO - Browser initialized. 12:14:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:14:50 INFO - TEST-INFO | started process 3483 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpikwSK5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:02 INFO - PROCESS | 3483 | RSS: Main: 185585664 12:15:02 INFO - PROCESS | 3483 | 12:15:52 INFO - PROCESS | 3483 | 1466190952443 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] 12:18:00 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:58272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58272/tests/dromaeo/cssquery-ext.html) 12:18:01 INFO - PROCESS | 3483 | RSS: Main: 189583360 12:18:01 INFO - PROCESS | 3483 | 12:21:03 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:58272/tests/dromaeo/cssquery-ext.html (next: http://localhost:58272/tests/dromaeo/cssquery-jquery.html) 12:21:04 INFO - PROCESS | 3483 | RSS: Main: 187686912 12:21:04 INFO - PROCESS | 3483 | 12:24:06 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:58272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58272/tests/dromaeo/cssquery-mootools.html) 12:24:06 INFO - PROCESS | 3483 | RSS: Main: 188928000 12:24:06 INFO - PROCESS | 3483 | 12:27:08 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:58272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58272/tests/dromaeo/cssquery-prototype.html) 12:27:09 INFO - PROCESS | 3483 | RSS: Main: 186212352 12:27:09 INFO - PROCESS | 3483 | 12:30:11 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:58272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58272/tests/dromaeo/cssquery-yui.html) 12:30:12 INFO - PROCESS | 3483 | RSS: Main: 188358656 12:30:12 INFO - PROCESS | 3483 | 12:33:14 INFO - PROCESS | 3483 | Cycle 1(1): loaded http://localhost:58272/tests/dromaeo/cssquery-yui.html (next: http://localhost:58272/tests/dromaeo/cssquery-dojo.html) 12:33:15 INFO - PROCESS | 3483 | RSS: Main: 189640704 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | __start_tp_report 12:33:15 INFO - PROCESS | 3483 | _x_x_mozilla_page_load 12:33:15 INFO - PROCESS | 3483 | _x_x_mozilla_page_load_details 12:33:15 INFO - PROCESS | 3483 | |i|pagename|runs| 12:33:15 INFO - PROCESS | 3483 | |0;dojo.html;3105.518644610085;3107.8135311881274;3134.0754477429155;3148.65364809871;3154.842257887105;5286.7356632168385;5287.048331300364;5398.3521977362725;5441.075017247068;5451.836444906659;5265.684058956465;5285.365756109262;5292.603054770889;5385.111456609655;5463.5902307327015;4780.498047704993;4790.449098353699;4879.170541008037;4933.506649335073;4981.178105612569;843.2939248482569;4818.686785358958;4886.535779100997;4914.582260507861;4930.359053323063;4983.651144419892;5002.699838009695;5009.599232061426;5010.323606313155;5070.898582028376;4912.557869791736;5011.649184557046;5019.623528235397;5043.142665746832;5081.415637201695;4903.705777653352;4915.852524424273;4919.901601967977;4939.580135688435;4979.925301120486;5413.864653383657;5473.042217611902;5487.835364939058;5495.752691128909;5545.473180047889;5756.424357564252;5836.883262334772;5879.588428809985;5889.793857214977;5894.410558944114;5854.121881717734;5881.823545293648;5895.410458954113;5899.498542623882;5934.792282270143;5454.236406903036;5508.752106155192;5511.366192887829;5513.09034009388;5514.834554963358;5797.826065218051;5883.411658834082;5923.585349025613;5940.168376427304;5989.1914591529585;5724.79963201286;5747.971260143672;5754.424557544212;5755.194272801811;5758.88482230353;5818.8254352369495;5820.970895145497;5824.388439213906;5828.475437210672;5834.854128646818;5598.888022239614;5723.513501352431;5752.712364381764;5767.538596912237;5780.739866706008;5665.688387138664;5777.913331300034;5791.507721843691;5809.506191973645;5844.211031510777;4435.068635586563;4439.844605438794;4441.244988351988;4454.10917816438;4499.370088187657;3906.7655940643654;3964.5440774310746;3974.940375894364;4000.699947503949;4003.459532963071;5558.166275058693;5631.746571404296;5650;5681.886362272731;5732.16883551891;5656.519195868315;5808.332041815245;5848.736806843703;5854.912176317359;5896.292444906639;5401.702906340189;5461.754221060062;5493.395726470085;5494.120940649477;5498.95519851227;4807.399075115611;4841.225403935354;4895.143349913751;4903.117438861039;4909.140900342426;6035.969820150871;6059.394060593905;6070.362611925772;6079.75680972765;6084.878302433926;5695.117256825199;5915.645061296336;5918.822435326947;5920.348761636303;5938.61399009063;5968.70156492165;6011.128386384037;6030.065339872327;6042.728077236447;6043.667598282137;5714.628549144292;5715.485606295453;5775.884482310246;5776.826695199151;5793;5737.827865164052;5800.419958004166;5877.911831322619;5886.911696324473;5897.970510147422;5679.630823996427;5694.544436445157;5697.57268204878;5711.371749107678;5789.2763404574425;5672.971635141798;5690.601657883908;5712.685802280915;5723.971380143073;5724.227229324155;5494.697791621499;5554.861128471821;5560.360558535658;5606.327240731139;5620.325560932714;5738.885222295614;5754.223179870663;5758.165066065313;5766.4233576642;5767.538596912321;5616.354119276172;5617.634853734494;5629.831105066854;5630.155476678367;5634.971825140848 12:33:15 INFO - PROCESS | 3483 | |1;ext.html;574.4944448884983;595.4313630482889;617.7251123250155;623.2832242920643;632.7532262417657;40360.39459408107;40977.59022409775;41008.79495602525;41480.79259603701;43970.560294397044;39008.414873776914;39089.218215635745;39148.21703565927;39310.21379572414;39480.80259598698;8820.250278726317;8842.336824738139;8851.070637583058;8936.106389361044;8978.910210897873;8657.523836189008;8733;8738.126187381275;8756.781080473007;8766.868496972551;8703.825923481527;8719.258862996652;8769;8775.078616745246;8829;8738.475691458532;8797.252233560155;8826.779330516789;8908.242799362062;8915.955420222923;8586.914130858673;8592;8686.174813392781;8687.826243475096;8693.21761041503;38470.61529384698;38632.227355452735;38748.41877371842;38783;39023.414648780294;3118.797278176934;3135.357251763383;3194.4250034993693;3243.756718246141;3673.651003154696;29328.8533557333;29435;29455;29519.409611807645;30734.538981915066;4396.626286765629;4397.274449715793;4414.139242847614;4543.750093744843;4614.700044497097;311074;314349;315452;318280;318669;30077.699223007927;30789;30922.845385772926;49827;50514.49485505098;32517.837410812794;32641.51037734436;32677;32697.836510817295;33163.83418082894;14038.1577105374;14089.436422542984;14093.295335233197;14268.500602478864;14299.142051476945;11380.374079425712;11382.715432114097;11405.543778248943;11421.486033128363;11438.256513326607;8222.712205072794;8283.29591984676;8340.332773378115;8393.454425462325;8449.95775021121;3058.1590062732926;3074.200707815984;3099.4575949208797;3130.9824307100284;3142.968570314313;1006.6778630838062;1011;1032.2361452525076;1036.828923227659;1106.3748981825242;29627;29996.55005174924;30074.54888176679;30088.69911300903;30262.84868575643;1029.7580068683853;1085.3270971997254;1112.3103675720943;1151.5336288803048;1166.2302880099094;15999.760003599955;16078.356865725475;16100.919495402448;16167.35330586787;16279.755803662954;484751;486390;491390;492467;493228;55320.446795532334;55426.445735542125;55483.722581386835;55765;56156;1293.1077556486182;1341.557286095586;1354.9932250338686;1359.7688392973218;1387.9653008674863;30702.692973070876;31172.22069448191;31586;31722.206944826565;31825.5226171603;50552;50853.23720144127;50973;51103.48896511136;51127.2330915044;393887;394321;398402;398490;399032;28233.57649635216;28499.857500712365;28614.42771144607;28717.71282287234;28719.42561148807;46384.7680761594;47149.76425117852;47440.2883956734;48266.27600586064;48610;40060.59939400685;41618.79190604028;41697.79151104225;41792.16415671731;42373.15253694847;39824.60175398209;40030.5752340605;40185.39721904115;40763.1847363057;41286.79356603198;37624;39666.206675866895;39874.2025159501;39914.401283981344;40739;34505.309893802485;36510.8174459126;36666.8166659165;36668.44997324989;36763.26473470462;27957.44085118327;28166.29584260328;28252.43495130127;28402.573961390182;28409.57385639176 12:33:15 INFO - PROCESS | 3483 | |2;jquery.html;345.85474100877644;354.17123930003794;354.4629885723129;370.1265014565626;378.5495260639838;17849.464516064505;18344.541386465327;18549.721754173683;19032.9048354758;19112.713309300372;15236.923815380907;15658.765118523232;16122.193890305467;16133.919330403362;16667.49997500077;5183.455737147602;5357.276767636377;5361.892762144775;5367.812126575571;5373.81191658292;5282.920756188661;5304.681719096847;5321.467853214686;5344;5357.598180136486;5141.614378921578;5223.608229382811;5275;5333.653312534673;5347.331583552056;5243.082460569385;5243.6853788772605;5270.262163297141;5273.604479664041;5295.973520132375;5132.769025393829;5160.297101956346;5175.353080864892;5177.741112944338;5191.558717509016;13384.130031547918;13397.196168229937;14007.509737159253;14012.369443374972;14021.369038393195;2346.8709220992837;2438.2685194441774;2714.1450443110357;2720.2331058156833;2985.2965226052966;10095.596176153018;10138.290319677626;10187.643432479828;10369.118624916891;10378.896211037869;1878.5021969178179;1966.4985428715586;1996.091778240897;1997.810208030235;2057.5781964697353;67823;74101.62949185274;80799;81677.59161204156;83521.58239208825;10635.52140153695;10691.83962240567;11096;11258.155638327158;11455.885441145649;15141.318640661197;15172.089674619558;15192.316345764468;15271.770923436157;15279.847201527842;7601.885971710429;7906.446548741533;7942.523448593103;7975.322097621767;8061.113277539466;7455.142658594331;7476.25237476248;7548;7559.735409260649;7625;4762.690425122356;4807.18277892759;4829.782659780319;4838.709677419366;4874.341963834908;1962.2935743132462;1964.4499540128786;1973.6447439461035;1979.4061781465502;1987.5726718755536;850.6767428377177;883.3551507399634;891.0910870911633;898.285862739124;951.9190868776232;18729.719054214198;19413.708794368096;19859.702104468444;19862.404127876187;20311;867.3928250224868;884.3411658314468;911.6763548940163;940.2431043010306;958.1951161024773;10227.539760710637;10878.564857405774;11022.779544409066;11043.337399756041;11245;446530;449549;450510;463695;471701;56819;90414.54792726126;91272;91337;93613.99999999863;898.1781669772085;955.3408148377736;961.697065424403;963.0417734354222;976.799756050008;17864.91067544654;18211.54471138179;18231.45305640833;18231.726524101883;18340.816591834446;37876.43185352277;38918.221635567694;42723;43272.56727432685;43927.12145757131;54070;54121.45878541164;54981.17528236999;57183;63259.36740632535;8461.95769021151;8613.956930215309;8658.090900455614;8658.307335413027;8760.167784060504;7299.671514781741;9925.702228933143;11366.715832104264;12711.936440317739;13304.800427993781;10374.481275936323;11399.544018239509;11570.710732231762;11813.468393922121;11954.58158964467;11083.778324433628;11713.1800773945;11757.235779674294;11820.881791181979;12066.095042871995;11671.066314694634;11838.28970261787;11866.228695134789;12047.51809927593;12063.879361206276;8354.368617844775;8558.957205213934;8783.692570759993;8858.73423797287;8935;10844.511996960313;10917.617883374043;11566.710832229262;11569.942150289195;11977 12:33:15 INFO - PROCESS | 3483 | |3;mootools.html;1247.644421339918;1293.2240655606633;1480.1341215388998;1719.277903280622;1720.4494561740241;7682.807929801757;7994.880076798838;8097.230763077506;8628;8679.479231246121;7979.720709775159;8265.297449716767;8324.209200125993;8342.082370939192;8344.165583441652;2247.1685476373764;2266.8639881607073;2286.977130228693;2288.164819840763;2290.267114523353;2243.573720993006;2260.7965283124518;2262.6266666000092;2272.988635056831;2279.1453205048106;2219.2038032079613;2231.5871563760757;2250.313654335427;2305.1125316753087;2307.3654744945106;2183.858049226795;2187.0704950396016;2195.209724499179;2195.7913998170147;2196.527746534495;2182.694422780812;2190.0692205812466;2193.14467357729;2204.250554811356;2204.713387259646;8279.461834980768;8412.663493460253;8415.621297041587;8429.494230346138;8432.789180270482;4975.477574854624;5058.822941197041;5078.7968481260705;5081.822136225214;5102.132637451642;3192.154079169022;3260.625028121749;3396.83015849209;3424.383610950028;3447.9827600862086;1144.8511693479877;1149.2989276541387;1152.9942350288195;1161.541191229468;1167.8014737494645;12453.937730311382;12475.750484990249;12490.313032783193;12527.624171274876;12572.937135314356;4434.7560884151035;4686.95313046872;4722.905541889143;4791.281307803788;4795.592374648124;10501.107405870587;10555.050045495942;10558.577656893638;10575.788484230272;10580.153587712965;5261.394939581997;5270.5256526912;5271.604629652791;5283.418823929364;5290.867728306823;4177.081042170717;4605.769711514411;4754.643401744883;4791.808327666854;4808.663393562487;3894.357431023906;3915.4126880967515;3982.104026594051;3983.980080099581;4018.618231268025;1282.0961222338228;1313.3039489070616;1313.770090234205;1317.3544962968076;1325.5559387605067;787.4802630263998;792.5126047480873;798.5528104261632;837.1042984007054;875.3434923807145;5816.94183058164;5836.88326233473;5864.266966629171;5911.881762364728;5922.8815423691285;435.42958724071565;439.2532694419436;444.36677734228596;449.5571861716207;450.85572616762323;3887.902802429962;3888.7861167635488;3927.8428862845167;3944.4674968878835;3967.8016099194924;10763.730906727238;11005.449727513753;11266.493007814668;11295;11349.886501135048;11061.778764424667;11083.556657733761;11138.94430527842;11143.275687080313;11171.497282622302;7792.2986931176465;8098.797530061795;8177.05963814169;8340.958295208606;8385.371097167737;5765.4811067004175;5842.561807864342;5931.510717240327;5944.197533332945;6056.182415373868;10196.3372380795;10389.584416623553;10413.583456661649;10444.63443779464;10482.37105773656;10368.274220804773;10404.375737455777;10432.68701938943;10610.681679549625;10680.252382333161;7004.4396448283;7482.850342993219;7685.807854803675;7718.961405192938;7799.220077992155;8187.5087494750505;8243.299319557666;8281.171882811912;8301.335893128657;8301.916980830114;7499.212582678741;7703.537787732754;7784.455088143775;7851.568163751049;7890.881636775568;7556.65995030214;7560.773176804704;7577.242275772379;7626.733064342721;7718.614069296625;6929.064576282138;6999.930000699927;7001.894971575329;7048.577085374894;7049.753258635923;4972.477889821661;4985.152524070844;5099.821506247264;5139.100657385017;5139.4603566626465;4820.276958456119;5075.187969924795;5104.438511763628;5136.5377116059735;5256.842294731164 12:33:15 INFO - PROCESS | 3483 | |4;prototype.html;309.2840075225852;312.6420248815107;316.92076980754814;319.32303516544926;322.1671977937033;5504.889902201953;5515.806946756859;5556.249906262653;5575.749091290892;5595.944040559593;5539.556835453164;5562.221289019541;5567.944320556793;5600.215969764236;5643.943560564393;4144.751314921099;4157.355609880466;4255.9787201063955;4301.881510807181;4306.418633484486;4304.849330273441;4315.978420107895;4327.307630779076;4363.498197707273;4370.3007518797;4319.784010799463;4322.379107834562;4328.610425061744;4332.415123958257;4350.2387082260475;4097.508299004109;4294.871153865389;4307.741535507848;4323.502797178333;4332.870013899588;3761.5298087739034;3765.0963768695315;3789.829457674384;3796.886093417202;3809.8095095245126;5488.341399032141;5521.723913804293;5595.076812325961;5609.242752228479;5618.719064046782;4816.349792777965;4856.417229932431;4907.190313598252;4932.4081110267;4954.999999999964;5804.59367844251;5850.6782126983;5866.0935196061455;5924.9703751480965;5926.140709597127;4153.1486045360625;4165.791710414467;4198.979005104986;4200.075983283673;4204.306289462235;5829.5605592700085;6076.3316035236085;6082.513398928075;6088.5996220869;6104.816855494342;4215.388768628593;4232.259354612992;4251.851185208565;4283.100548884707;4312.417823593774;4243.8090285937205;4275.828966841354;4285.142971405731;4286.957130428718;4287.3140297552245;4853.247746599282;4921.7785199666105;4932.408111026628;4973.452920178777;4981.551660350586;5739.827805165852;5777.508911742549;5873.4126587340925;5920.105566218855;5957.493613042853;1442.776369662704;1469.5077149154938;1476.859698328657;1498.715244103617;1508.7585986242368;926.2960150285832;935.2284365398573;943.0946291560042;951.1534734086669;953.6662168241198;4980.7011579304635;5083.491650834961;5097.413797413345;5141.511556402136;5162.432132465426;5363.168708850135;5369.48989845964;5373.516383525502;5379.569634429315;5398.758285594256;5022;5078.289039534468;5247.763850626731;5687.687177205294;5745;3231.159898426426;3246.756493263015;3254.8372581370836;3260.8695652173647;3261.787983781094;6203.906941395882;6297.1813664223355;6298.527610429236;6321.336259692758;6332;6076.756929722762;6113.724882380304;6136;6205.355580771099;6248.593841400385;6226.62640241587;6234.376562343729;6246.125542424064;6255.437010669061;6287.654179020106;5837.532997360286;6128.816135515942;6131.877362452815;6173.938260617337;6178.351273116438;6036.8188954331445;6037.305709843425;6082.574219804571;6090.756369745338;6097.451229389376;5955.464008239279;6142.94211439155;6203.100550420254;6224.502039836711;6269.843253918689;4255.4042434059875;4259.890280095609;4278.44380230568;4296.91406171881;4309.892252693582;5806.883862322815;5979.910301345396;6076.301225358963;6097.17688112117;6097.35371449715;5837.978353787985;5849.034909239927;5856.297244330537;5871.7651293947765;5924.081767326072;5650.23721797552;5858.853528661817;5881.029854998453;5883.176075483706;5934.169216309634;5793.536517078708;5807.245058142584;5820.854478638068;5852.092925596539;5862.794802181903;5880.705964701662;5938.287405511366;5970.820875373745;5991.340952495135;5997.880042399215;5686.630369026;5686.715664216856;5703.173039909273;5718.313802343745;5746.012073721725 12:33:15 INFO - PROCESS | 3483 | |5;yui.html;651.120986667998;675.1155985658787;688.4939569416478;701.5615240474704;711.5623891306847;15758.133302668362;16820.07489588072;17060.40288589898;17643;17770.11149442526;15179.468718594851;15227.543173704778;15234.314455849486;15286.770698439504;15340.079595224295;584.6083124306725;794.7814351053448;799.5522507395877;799.7720649614861;801.8596745569531;600.8347704381287;607.8085403098032;607.9574429789916;609.3571282297174;609.515435228994;824.3364091906013;829.2453866981049;836.786619412049;838.7106448275335;840.197611281228;622.2501885228289;622.8847663182326;623.1742940603673;624.3974564545213;625.6371304643296;608.4402349838159;608.6926102318301;609.4423602403796;610.972506237216;611.7552978808468;16423.260953257133;16426.671466570722;16500.75248871268;16530;16532.75200871976;14344.64138396538;14801.259937003108;14906;14954;15015.77476337845;12041.578544750892;12160.452779624939;12339;12436.440360183722;12437.875621243762;3869.5743468218475;3893.396523538856;4000.3399439092514;4060.4924384451942;4062.471878655756;82988;83615.58192209061;83971.58014209951;84612.15387846105;84753.57623211844;10588.258821882548;10949;10989.560417583207;11118.221724479208;11227.887721122685;20663;20752.273670421764;20844;20890.47773805667;20892;8570.571471426403;8579.356548258906;8634.740957771277;8767.317372498781;8927.687530936386;4523.6881304422;4562.087582483517;4653.255479123324;4660.300954856799;4794.2808578712775;3623.3115708015393;3713.7771733696063;3725.8695945642316;3728.7949162795762;3737.5141231639714;599.3616798109999;609.3419107364036;618.8731310081422;628.8616504369031;634.8603307272392;570.7564259728929;631.564220687724;657.6448717692488;660.1088530483809;662.2615783401473;8678.305735541142;9323.90676093244;9521.381110227812;9548.618055277711;9633.710988670351;623.2458724942779;625.8654389306321;644.5423749138164;656.0945894665331;659.9769008084694;4319.568043195655;4497.820087196541;4505.7296562206375;4538.6369090473345;4602;127131.45737085206;128060;131608.3419582896;132692;133142;113596;114202.42898785452;114553;114856;115798.42100789442;96422.51788741011;97369.51315243378;98887;101947.4902625482;103393.48303258586;8707.3034157266;9011.549422528979;9025.81948361016;9031.187193152648;9048.230900373543;55904.44095559155;56314;57078;57496.425035749104;57655.13517297328;72768;82238.58880705558;82247;84627.5768621153;85357;10858.294210876267;11371.715707107389;11450.198486105892;11938.28370297785;12191.51233950632;13409.463621455032;13580.44989163724;13729.794053089412;13778.311084445537;13834;11831.585894493996;12161.33112678811;12172.513099475922;12757.043221758591;12768.36158192068;12315.445804938978;12395.938020310201;12435.186572756098;12464.189827661536;12613.30626815534;11556.479958401724;11804;12002.75994480123;12016.098792590765;12242.816357754462;10080.193584513368;10188.754025266287;10239.539220734936;10324.122449591569;10421.739456513344;9979.850302245617;10323.174146068146;10620.52207650673;10713.35719856811;10739.46302684847 12:33:15 INFO - PROCESS | 3483 | __end_tp_report 12:33:15 INFO - PROCESS | 3483 | __start_cc_report 12:33:15 INFO - PROCESS | 3483 | _x_x_mozilla_cycle_collect,358 12:33:15 INFO - PROCESS | 3483 | __end_cc_report 12:33:15 INFO - PROCESS | 3483 | __startTimestamp1466191995223__endTimestamp 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | ------- Summary: start ------- 12:33:15 INFO - PROCESS | 3483 | Number of tests: 6 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | [#0] dojo.html Cycles:165 Average:5382.50 Median:5650.00 stddev:717.40 (12.7%) stddev-sans-first:697.01 12:33:15 INFO - PROCESS | 3483 | Values: 3105.5 3107.8 3134.1 3148.7 3154.8 5286.7 5287.0 5398.4 5441.1 5451.8 5265.7 5285.4 5292.6 5385.1 5463.6 4780.5 4790.4 4879.2 4933.5 4981.2 843.3 4818.7 4886.5 4914.6 4930.4 4983.7 5002.7 5009.6 5010.3 5070.9 4912.6 5011.6 5019.6 5043.1 5081.4 4903.7 4915.9 4919.9 4939.6 4979.9 5413.9 5473.0 5487.8 5495.8 5545.5 5756.4 5836.9 5879.6 5889.8 5894.4 5854.1 5881.8 5895.4 5899.5 5934.8 5454.2 5508.8 5511.4 5513.1 5514.8 5797.8 5883.4 5923.6 5940.2 5989.2 5724.8 5748.0 5754.4 5755.2 5758.9 5818.8 5821.0 5824.4 5828.5 5834.9 5598.9 5723.5 5752.7 5767.5 5780.7 5665.7 5777.9 5791.5 5809.5 5844.2 4435.1 4439.8 4441.2 4454.1 4499.4 3906.8 3964.5 3974.9 4000.7 4003.5 5558.2 5631.7 5650.0 5681.9 5732.2 5656.5 5808.3 5848.7 5854.9 5896.3 5401.7 5461.8 5493.4 5494.1 5499.0 4807.4 4841.2 4895.1 4903.1 4909.1 6036.0 6059.4 6070.4 6079.8 6084.9 5695.1 5915.6 5918.8 5920.3 5938.6 5968.7 6011.1 6030.1 6042.7 6043.7 5714.6 5715.5 5775.9 5776.8 5793.0 5737.8 5800.4 5877.9 5886.9 5898.0 5679.6 5694.5 5697.6 5711.4 5789.3 5673.0 5690.6 5712.7 5724.0 5724.2 5494.7 5554.9 5560.4 5606.3 5620.3 5738.9 5754.2 5758.2 5766.4 5767.5 5616.4 5617.6 5629.8 5630.2 5635.0 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | [#1] ext.html Cycles:180 Average:54479.92 Median:39118.72 stddev:107932.00 (275.9%) stddev-sans-first:108158.89 12:33:15 INFO - PROCESS | 3483 | Values: 574.5 595.4 617.7 623.3 632.8 40360.4 40977.6 41008.8 41480.8 43970.6 39008.4 39089.2 39148.2 39310.2 39480.8 8820.3 8842.3 8851.1 8936.1 8978.9 8657.5 8733.0 8738.1 8756.8 8766.9 8703.8 8719.3 8769.0 8775.1 8829.0 8738.5 8797.3 8826.8 8908.2 8916.0 8586.9 8592.0 8686.2 8687.8 8693.2 38470.6 38632.2 38748.4 38783.0 39023.4 3118.8 3135.4 3194.4 3243.8 3673.7 29328.9 29435.0 29455.0 29519.4 30734.5 4396.6 4397.3 4414.1 4543.8 4614.7 311074.0 314349.0 315452.0 318280.0 318669.0 30077.7 30789.0 30922.8 49827.0 50514.5 32517.8 32641.5 32677.0 32697.8 33163.8 14038.2 14089.4 14093.3 14268.5 14299.1 11380.4 11382.7 11405.5 11421.5 11438.3 8222.7 8283.3 8340.3 8393.5 8450.0 3058.2 3074.2 3099.5 3131.0 3143.0 1006.7 1011.0 1032.2 1036.8 1106.4 29627.0 29996.6 30074.5 30088.7 30262.8 1029.8 1085.3 1112.3 1151.5 1166.2 15999.8 16078.4 16100.9 16167.4 16279.8 484751.0 486390.0 491390.0 492467.0 493228.0 55320.4 55426.4 55483.7 55765.0 56156.0 1293.1 1341.6 1355.0 1359.8 1388.0 30702.7 31172.2 31586.0 31722.2 31825.5 50552.0 50853.2 50973.0 51103.5 51127.2 393887.0 394321.0 398402.0 398490.0 399032.0 28233.6 28499.9 28614.4 28717.7 28719.4 46384.8 47149.8 47440.3 48266.3 48610.0 40060.6 41618.8 41697.8 41792.2 42373.2 39824.6 40030.6 40185.4 40763.2 41286.8 37624.0 39666.2 39874.2 39914.4 40739.0 34505.3 36510.8 36666.8 36668.4 36763.3 27957.4 28166.3 28252.4 28402.6 28409.6 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | [#2] jquery.html Cycles:180 Average:27254.47 Median:42997.78 stddev:75341.07 (175.2%) stddev-sans-first:75525.33 12:33:15 INFO - PROCESS | 3483 | Values: 345.9 354.2 354.5 370.1 378.5 17849.5 18344.5 18549.7 19032.9 19112.7 15236.9 15658.8 16122.2 16133.9 16667.5 5183.5 5357.3 5361.9 5367.8 5373.8 5282.9 5304.7 5321.5 5344.0 5357.6 5141.6 5223.6 5275.0 5333.7 5347.3 5243.1 5243.7 5270.3 5273.6 5296.0 5132.8 5160.3 5175.4 5177.7 5191.6 13384.1 13397.2 14007.5 14012.4 14021.4 2346.9 2438.3 2714.1 2720.2 2985.3 10095.6 10138.3 10187.6 10369.1 10378.9 1878.5 1966.5 1996.1 1997.8 2057.6 67823.0 74101.6 80799.0 81677.6 83521.6 10635.5 10691.8 11096.0 11258.2 11455.9 15141.3 15172.1 15192.3 15271.8 15279.8 7601.9 7906.4 7942.5 7975.3 8061.1 7455.1 7476.3 7548.0 7559.7 7625.0 4762.7 4807.2 4829.8 4838.7 4874.3 1962.3 1964.4 1973.6 1979.4 1987.6 850.7 883.4 891.1 898.3 951.9 18729.7 19413.7 19859.7 19862.4 20311.0 867.4 884.3 911.7 940.2 958.2 10227.5 10878.6 11022.8 11043.3 11245.0 446530.0 449549.0 450510.0 463695.0 471701.0 56819.0 90414.5 91272.0 91337.0 93614.0 898.2 955.3 961.7 963.0 976.8 17864.9 18211.5 18231.5 18231.7 18340.8 37876.4 38918.2 42723.0 43272.6 43927.1 54070.0 54121.5 54981.2 57183.0 63259.4 8462.0 8614.0 8658.1 8658.3 8760.2 7299.7 9925.7 11366.7 12711.9 13304.8 10374.5 11399.5 11570.7 11813.5 11954.6 11083.8 11713.2 11757.2 11820.9 12066.1 11671.1 11838.3 11866.2 12047.5 12063.9 8354.4 8559.0 8783.7 8858.7 8935.0 10844.5 10917.6 11566.7 11569.9 11977.0 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | [#3] mootools.html Cycles:180 Average:5738.59 Median:450.21 stddev:3360.56 (746.4%) stddev-sans-first:3353.04 12:33:15 INFO - PROCESS | 3483 | Values: 1247.6 1293.2 1480.1 1719.3 1720.4 7682.8 7994.9 8097.2 8628.0 8679.5 7979.7 8265.3 8324.2 8342.1 8344.2 2247.2 2266.9 2287.0 2288.2 2290.3 2243.6 2260.8 2262.6 2273.0 2279.1 2219.2 2231.6 2250.3 2305.1 2307.4 2183.9 2187.1 2195.2 2195.8 2196.5 2182.7 2190.1 2193.1 2204.3 2204.7 8279.5 8412.7 8415.6 8429.5 8432.8 4975.5 5058.8 5078.8 5081.8 5102.1 3192.2 3260.6 3396.8 3424.4 3448.0 1144.9 1149.3 1153.0 1161.5 1167.8 12453.9 12475.8 12490.3 12527.6 12572.9 4434.8 4687.0 4722.9 4791.3 4795.6 10501.1 10555.1 10558.6 10575.8 10580.2 5261.4 5270.5 5271.6 5283.4 5290.9 4177.1 4605.8 4754.6 4791.8 4808.7 3894.4 3915.4 3982.1 3984.0 4018.6 1282.1 1313.3 1313.8 1317.4 1325.6 787.5 792.5 798.6 837.1 875.3 5816.9 5836.9 5864.3 5911.9 5922.9 435.4 439.3 444.4 449.6 450.9 3887.9 3888.8 3927.8 3944.5 3967.8 10763.7 11005.4 11266.5 11295.0 11349.9 11061.8 11083.6 11138.9 11143.3 11171.5 7792.3 8098.8 8177.1 8341.0 8385.4 5765.5 5842.6 5931.5 5944.2 6056.2 10196.3 10389.6 10413.6 10444.6 10482.4 10368.3 10404.4 10432.7 10610.7 10680.3 7004.4 7482.9 7685.8 7719.0 7799.2 8187.5 8243.3 8281.2 8301.3 8301.9 7499.2 7703.5 7784.5 7851.6 7890.9 7556.7 7560.8 7577.2 7626.7 7718.6 6929.1 6999.9 7001.9 7048.6 7049.8 4972.5 4985.2 5099.8 5139.1 5139.5 4820.3 5075.2 5104.4 5136.5 5256.8 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | [#4] prototype.html Cycles:180 Average:4896.86 Median:5571.85 stddev:1457.70 (26.2%) stddev-sans-first:1420.54 12:33:15 INFO - PROCESS | 3483 | Values: 309.3 312.6 316.9 319.3 322.2 5504.9 5515.8 5556.2 5575.7 5595.9 5539.6 5562.2 5567.9 5600.2 5643.9 4144.8 4157.4 4256.0 4301.9 4306.4 4304.8 4316.0 4327.3 4363.5 4370.3 4319.8 4322.4 4328.6 4332.4 4350.2 4097.5 4294.9 4307.7 4323.5 4332.9 3761.5 3765.1 3789.8 3796.9 3809.8 5488.3 5521.7 5595.1 5609.2 5618.7 4816.3 4856.4 4907.2 4932.4 4955.0 5804.6 5850.7 5866.1 5925.0 5926.1 4153.1 4165.8 4199.0 4200.1 4204.3 5829.6 6076.3 6082.5 6088.6 6104.8 4215.4 4232.3 4251.9 4283.1 4312.4 4243.8 4275.8 4285.1 4287.0 4287.3 4853.2 4921.8 4932.4 4973.5 4981.6 5739.8 5777.5 5873.4 5920.1 5957.5 1442.8 1469.5 1476.9 1498.7 1508.8 926.3 935.2 943.1 951.2 953.7 4980.7 5083.5 5097.4 5141.5 5162.4 5363.2 5369.5 5373.5 5379.6 5398.8 5022.0 5078.3 5247.8 5687.7 5745.0 3231.2 3246.8 3254.8 3260.9 3261.8 6203.9 6297.2 6298.5 6321.3 6332.0 6076.8 6113.7 6136.0 6205.4 6248.6 6226.6 6234.4 6246.1 6255.4 6287.7 5837.5 6128.8 6131.9 6173.9 6178.4 6036.8 6037.3 6082.6 6090.8 6097.5 5955.5 6142.9 6203.1 6224.5 6269.8 4255.4 4259.9 4278.4 4296.9 4309.9 5806.9 5979.9 6076.3 6097.2 6097.4 5838.0 5849.0 5856.3 5871.8 5924.1 5650.2 5858.9 5881.0 5883.2 5934.2 5793.5 5807.2 5820.9 5852.1 5862.8 5880.7 5938.3 5970.8 5991.3 5997.9 5686.6 5686.7 5703.2 5718.3 5746.0 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - PROCESS | 3483 | [#5] yui.html Cycles:180 Average:22421.27 Median:4191.02 stddev:34241.48 (817.0%) stddev-sans-first:34298.52 12:33:15 INFO - PROCESS | 3483 | Values: 651.1 675.1 688.5 701.6 711.6 15758.1 16820.1 17060.4 17643.0 17770.1 15179.5 15227.5 15234.3 15286.8 15340.1 584.6 794.8 799.6 799.8 801.9 600.8 607.8 608.0 609.4 609.5 824.3 829.2 836.8 838.7 840.2 622.3 622.9 623.2 624.4 625.6 608.4 608.7 609.4 611.0 611.8 16423.3 16426.7 16500.8 16530.0 16532.8 14344.6 14801.3 14906.0 14954.0 15015.8 12041.6 12160.5 12339.0 12436.4 12437.9 3869.6 3893.4 4000.3 4060.5 4062.5 82988.0 83615.6 83971.6 84612.2 84753.6 10588.3 10949.0 10989.6 11118.2 11227.9 20663.0 20752.3 20844.0 20890.5 20892.0 8570.6 8579.4 8634.7 8767.3 8927.7 4523.7 4562.1 4653.3 4660.3 4794.3 3623.3 3713.8 3725.9 3728.8 3737.5 599.4 609.3 618.9 628.9 634.9 570.8 631.6 657.6 660.1 662.3 8678.3 9323.9 9521.4 9548.6 9633.7 623.2 625.9 644.5 656.1 660.0 4319.6 4497.8 4505.7 4538.6 4602.0 127131.5 128060.0 131608.3 132692.0 133142.0 113596.0 114202.4 114553.0 114856.0 115798.4 96422.5 97369.5 98887.0 101947.5 103393.5 8707.3 9011.5 9025.8 9031.2 9048.2 55904.4 56314.0 57078.0 57496.4 57655.1 72768.0 82238.6 82247.0 84627.6 85357.0 10858.3 11371.7 11450.2 11938.3 12191.5 13409.5 13580.4 13729.8 13778.3 13834.0 11831.6 12161.3 12172.5 12757.0 12768.4 12315.4 12395.9 12435.2 12464.2 12613.3 11556.5 11804.0 12002.8 12016.1 12242.8 10080.2 10188.8 10239.5 10324.1 10421.7 9979.9 10323.2 10620.5 10713.4 10739.5 12:33:15 INFO - PROCESS | 3483 | -------- Summary: end -------- 12:33:15 INFO - PROCESS | 3483 | 12:33:15 INFO - TEST-INFO | 3483: exit 0 12:33:15 INFO - TEST-OK | dromaeo_css | took 1112886ms 12:33:15 INFO - TEST-START | kraken 12:33:15 INFO - operating with platform_type : linux_ 12:33:15 INFO - Initialising browser for kraken test... 12:33:15 INFO - TEST-INFO | started process 3730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmR7lA1/profile http://localhost:58272/getInfo.html) 12:33:20 INFO - PROCESS | 3730 | __metrics Screen width/height:1600/1200 12:33:20 INFO - PROCESS | 3730 | colorDepth:24 12:33:20 INFO - PROCESS | 3730 | Browser inner width/height: 1024/697 12:33:20 INFO - PROCESS | 3730 | __metrics 12:33:21 ERROR - PROCESS | 3730 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 12:33:21 INFO - TEST-INFO | 3730: exit 0 12:33:21 INFO - Browser initialized. 12:33:21 INFO - Running cycle 1/1 for kraken test... 12:33:21 INFO - TEST-INFO | started process 3850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmR7lA1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:34 INFO - PROCESS | 3850 | RSS: Main: 184737792 12:33:34 INFO - PROCESS | 3850 | 12:33:36 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58272/tests/kraken/driver.html?testName=audio-beat-detection) 12:33:37 INFO - PROCESS | 3850 | RSS: Main: 189517824 12:33:37 INFO - PROCESS | 3850 | 12:33:40 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58272/tests/kraken/driver.html?testName=audio-dft) 12:33:40 INFO - PROCESS | 3850 | RSS: Main: 188801024 12:33:40 INFO - PROCESS | 3850 | 12:33:43 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58272/tests/kraken/driver.html?testName=audio-fft) 12:33:44 INFO - PROCESS | 3850 | RSS: Main: 184963072 12:33:44 INFO - PROCESS | 3850 | 12:33:46 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58272/tests/kraken/driver.html?testName=audio-oscillator) 12:33:47 INFO - PROCESS | 3850 | RSS: Main: 186142720 12:33:47 INFO - PROCESS | 3850 | 12:33:49 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:33:50 INFO - PROCESS | 3850 | RSS: Main: 186060800 12:33:50 INFO - PROCESS | 3850 | 12:33:53 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58272/tests/kraken/driver.html?testName=imaging-darkroom) 12:33:53 INFO - PROCESS | 3850 | RSS: Main: 186662912 12:33:53 INFO - PROCESS | 3850 | 12:33:57 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58272/tests/kraken/driver.html?testName=imaging-desaturate) 12:33:57 INFO - PROCESS | 3850 | RSS: Main: 186744832 12:33:57 INFO - PROCESS | 3850 | 12:34:00 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58272/tests/kraken/driver.html?testName=json-parse-financial) 12:34:01 INFO - PROCESS | 3850 | RSS: Main: 186445824 12:34:01 INFO - PROCESS | 3850 | 12:34:02 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:03 INFO - PROCESS | 3850 | RSS: Main: 187269120 12:34:03 INFO - PROCESS | 3850 | 12:34:05 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:05 INFO - PROCESS | 3850 | RSS: Main: 187138048 12:34:05 INFO - PROCESS | 3850 | 12:34:07 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:08 INFO - PROCESS | 3850 | RSS: Main: 187326464 12:34:08 INFO - PROCESS | 3850 | 12:34:11 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:11 INFO - PROCESS | 3850 | RSS: Main: 188067840 12:34:11 INFO - PROCESS | 3850 | 12:34:14 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:15 INFO - PROCESS | 3850 | RSS: Main: 187088896 12:34:15 INFO - PROCESS | 3850 | 12:34:16 INFO - PROCESS | 3850 | Cycle 1(1): loaded http://localhost:58272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58272/tests/kraken/driver.html?testName=ai-astar) 12:34:17 INFO - PROCESS | 3850 | RSS: Main: 187965440 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | __start_tp_report 12:34:17 INFO - PROCESS | 3850 | _x_x_mozilla_page_load 12:34:17 INFO - PROCESS | 3850 | _x_x_mozilla_page_load_details 12:34:17 INFO - PROCESS | 3850 | |i|pagename|runs| 12:34:17 INFO - PROCESS | 3850 | |0;ai-astar;111;106;112;112;113;112;111;110;112;111 12:34:17 INFO - PROCESS | 3850 | |1;audio-beat-detection;166;125;150;179;127;151;154;129;191;127 12:34:17 INFO - PROCESS | 3850 | |2;audio-dft;161;163;163;167;170;165;160;163;162;161 12:34:17 INFO - PROCESS | 3850 | |3;audio-fft;75;75;74;158;76;76;73;74;160;75 12:34:17 INFO - PROCESS | 3850 | |4;audio-oscillator;84;86;150;84;86;85;147;85;85;140 12:34:17 INFO - PROCESS | 3850 | |5;imaging-gaussian-blur;117;119;118;117;117;118;118;117;118;118 12:34:17 INFO - PROCESS | 3850 | |6;imaging-darkroom;147;147;148;149;148;147;147;147;146;147 12:34:17 INFO - PROCESS | 3850 | |7;imaging-desaturate;96;96;96;95;96;95;96;96;96;95 12:34:17 INFO - PROCESS | 3850 | |8;json-parse-financial;56;57;54;53;55;54;55;53;54;54 12:34:17 INFO - PROCESS | 3850 | |9;json-stringify-tinderbox;62;62;61;62;62;62;62;62;63;63 12:34:17 INFO - PROCESS | 3850 | |10;stanford-crypto-aes;80;86;84;81;86;84;80;80;113;81 12:34:17 INFO - PROCESS | 3850 | |11;stanford-crypto-ccm;146;128;132;137;129;139;122;131;129;120 12:34:17 INFO - PROCESS | 3850 | |12;stanford-crypto-pbkdf2;161;162;162;163;165;159;158;168;161;159 12:34:17 INFO - PROCESS | 3850 | |13;stanford-crypto-sha256-iterative;67;63;71;64;64;68;62;63;65;66 12:34:17 INFO - PROCESS | 3850 | __end_tp_report 12:34:17 INFO - PROCESS | 3850 | __start_cc_report 12:34:17 INFO - PROCESS | 3850 | _x_x_mozilla_cycle_collect,902 12:34:17 INFO - PROCESS | 3850 | __end_cc_report 12:34:17 INFO - PROCESS | 3850 | __startTimestamp1466192057160__endTimestamp 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | ------- Summary: start ------- 12:34:17 INFO - PROCESS | 3850 | Number of tests: 14 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:1.94 (1.7%) stddev-sans-first:2.06 12:34:17 INFO - PROCESS | 3850 | Values: 111.0 106.0 112.0 112.0 113.0 112.0 111.0 110.0 112.0 111.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:152.50 stddev:23.38 (15.3%) stddev-sans-first:24.06 12:34:17 INFO - PROCESS | 3850 | Values: 166.0 125.0 150.0 179.0 127.0 151.0 154.0 129.0 191.0 127.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:3.06 (1.9%) stddev-sans-first:3.11 12:34:17 INFO - PROCESS | 3850 | Values: 161.0 163.0 163.0 167.0 170.0 165.0 160.0 163.0 162.0 161.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#3] audio-fft Cycles:10 Average:91.60 Median:75.00 stddev:35.54 (47.4%) stddev-sans-first:37.18 12:34:17 INFO - PROCESS | 3850 | Values: 75.0 75.0 74.0 158.0 76.0 76.0 73.0 74.0 160.0 75.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:29.41 (34.6%) stddev-sans-first:30.36 12:34:17 INFO - PROCESS | 3850 | Values: 84.0 86.0 150.0 84.0 86.0 85.0 147.0 85.0 85.0 140.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 12:34:17 INFO - PROCESS | 3850 | Values: 117.0 119.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 118.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 12:34:17 INFO - PROCESS | 3850 | Values: 147.0 147.0 148.0 149.0 148.0 147.0 147.0 147.0 146.0 147.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:34:17 INFO - PROCESS | 3850 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.50 stddev:1.27 (2.3%) stddev-sans-first:1.22 12:34:17 INFO - PROCESS | 3850 | Values: 56.0 57.0 54.0 53.0 55.0 54.0 55.0 53.0 54.0 54.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 12:34:17 INFO - PROCESS | 3850 | Values: 62.0 62.0 61.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:82.50 stddev:9.96 (12.1%) stddev-sans-first:10.36 12:34:17 INFO - PROCESS | 3850 | Values: 80.0 86.0 84.0 81.0 86.0 84.0 80.0 80.0 113.0 81.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:131.50 stddev:7.78 (5.9%) stddev-sans-first:6.16 12:34:17 INFO - PROCESS | 3850 | Values: 146.0 128.0 132.0 137.0 129.0 139.0 122.0 131.0 129.0 120.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.80 Median:162.00 stddev:3.01 (1.9%) stddev-sans-first:3.18 12:34:17 INFO - PROCESS | 3850 | Values: 161.0 162.0 162.0 163.0 165.0 159.0 158.0 168.0 161.0 159.0 12:34:17 INFO - PROCESS | 3850 | 12:34:17 INFO - PROCESS | 3850 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:2.75 (4.2%) stddev-sans-first:2.85 12:34:17 INFO - PROCESS | 3850 | Values: 67.0 63.0 71.0 64.0 64.0 68.0 62.0 63.0 65.0 66.0 12:34:17 INFO - PROCESS | 3850 | -------- Summary: end -------- 12:34:17 INFO - PROCESS | 3850 | 12:34:18 INFO - TEST-INFO | 3850: exit 0 12:34:18 INFO - TEST-OK | kraken | took 62240ms 12:34:18 INFO - SUITE-END | took 1175s 12:34:18 INFO - Completed test suite (00:19:35) 12:34:18 INFO - javascript benchmark 12:34:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7057.997538910818, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3105.518644610085, 3107.8135311881274, 3134.0754477429155, 3148.65364809871, 3154.842257887105, 5286.7356632168385, 5287.048331300364, 5398.3521977362725, 5441.075017247068, 5451.836444906659, 5265.684058956465, 5285.365756109262, 5292.603054770889, 5385.111456609655, 5463.5902307327015, 4780.498047704993, 4790.449098353699, 4879.170541008037, 4933.506649335073, 4981.178105612569, 843.2939248482569, 4818.686785358958, 4886.535779100997, 4914.582260507861, 4930.359053323063, 4983.651144419892, 5002.699838009695, 5009.599232061426, 5010.323606313155, 5070.898582028376, 4912.557869791736, 5011.649184557046, 5019.623528235397, 5043.142665746832, 5081.415637201695, 4903.705777653352, 4915.852524424273, 4919.901601967977, 4939.580135688435, 4979.925301120486, 5413.864653383657, 5473.042217611902, 5487.835364939058, 5495.752691128909, 5545.473180047889, 5756.424357564252, 5836.883262334772, 5879.588428809985, 5889.793857214977, 5894.410558944114, 5854.121881717734, 5881.823545293648, 5895.410458954113, 5899.498542623882, 5934.792282270143, 5454.236406903036, 5508.752106155192, 5511.366192887829, 5513.09034009388, 5514.834554963358, 5797.826065218051, 5883.411658834082, 5923.585349025613, 5940.168376427304, 5989.1914591529585, 5724.79963201286, 5747.971260143672, 5754.424557544212, 5755.194272801811, 5758.88482230353, 5818.8254352369495, 5820.970895145497, 5824.388439213906, 5828.475437210672, 5834.854128646818, 5598.888022239614, 5723.513501352431, 5752.712364381764, 5767.538596912237, 5780.739866706008, 5665.688387138664, 5777.913331300034, 5791.507721843691, 5809.506191973645, 5844.211031510777, 4435.068635586563, 4439.844605438794, 4441.244988351988, 4454.10917816438, 4499.370088187657, 3906.7655940643654, 3964.5440774310746, 3974.940375894364, 4000.699947503949, 4003.459532963071, 5558.166275058693, 5631.746571404296, 5650.0, 5681.886362272731, 5732.16883551891, 5656.519195868315, 5808.332041815245, 5848.736806843703, 5854.912176317359, 5896.292444906639, 5401.702906340189, 5461.754221060062, 5493.395726470085, 5494.120940649477, 5498.95519851227, 4807.399075115611, 4841.225403935354, 4895.143349913751, 4903.117438861039, 4909.140900342426, 6035.969820150871, 6059.394060593905, 6070.362611925772, 6079.75680972765, 6084.878302433926, 5695.117256825199, 5915.645061296336, 5918.822435326947, 5920.348761636303, 5938.61399009063, 5968.70156492165, 6011.128386384037, 6030.065339872327, 6042.728077236447, 6043.667598282137, 5714.628549144292, 5715.485606295453, 5775.884482310246, 5776.826695199151, 5793.0, 5737.827865164052, 5800.419958004166, 5877.911831322619, 5886.911696324473, 5897.970510147422, 5679.630823996427, 5694.544436445157, 5697.57268204878, 5711.371749107678, 5789.2763404574425, 5672.971635141798, 5690.601657883908, 5712.685802280915, 5723.971380143073, 5724.227229324155, 5494.697791621499, 5554.861128471821, 5560.360558535658, 5606.327240731139, 5620.325560932714, 5738.885222295614, 5754.223179870663, 5758.165066065313, 5766.4233576642, 5767.538596912321, 5616.354119276172, 5617.634853734494, 5629.831105066854, 5630.155476678367, 5634.971825140848], "value": 5334.786138471936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.4944448884983, 595.4313630482889, 617.7251123250155, 623.2832242920643, 632.7532262417657, 40360.39459408107, 40977.59022409775, 41008.79495602525, 41480.79259603701, 43970.560294397044, 39008.414873776914, 39089.218215635745, 39148.21703565927, 39310.21379572414, 39480.80259598698, 8820.250278726317, 8842.336824738139, 8851.070637583058, 8936.106389361044, 8978.910210897873, 8657.523836189008, 8733.0, 8738.126187381275, 8756.781080473007, 8766.868496972551, 8703.825923481527, 8719.258862996652, 8769.0, 8775.078616745246, 8829.0, 8738.475691458532, 8797.252233560155, 8826.779330516789, 8908.242799362062, 8915.955420222923, 8586.914130858673, 8592.0, 8686.174813392781, 8687.826243475096, 8693.21761041503, 38470.61529384698, 38632.227355452735, 38748.41877371842, 38783.0, 39023.414648780294, 3118.797278176934, 3135.357251763383, 3194.4250034993693, 3243.756718246141, 3673.651003154696, 29328.8533557333, 29435.0, 29455.0, 29519.409611807645, 30734.538981915066, 4396.626286765629, 4397.274449715793, 4414.139242847614, 4543.750093744843, 4614.700044497097, 311074.0, 314349.0, 315452.0, 318280.0, 318669.0, 30077.699223007927, 30789.0, 30922.845385772926, 49827.0, 50514.49485505098, 32517.837410812794, 32641.51037734436, 32677.0, 32697.836510817295, 33163.83418082894, 14038.1577105374, 14089.436422542984, 14093.295335233197, 14268.500602478864, 14299.142051476945, 11380.374079425712, 11382.715432114097, 11405.543778248943, 11421.486033128363, 11438.256513326607, 8222.712205072794, 8283.29591984676, 8340.332773378115, 8393.454425462325, 8449.95775021121, 3058.1590062732926, 3074.200707815984, 3099.4575949208797, 3130.9824307100284, 3142.968570314313, 1006.6778630838062, 1011.0, 1032.2361452525076, 1036.828923227659, 1106.3748981825242, 29627.0, 29996.55005174924, 30074.54888176679, 30088.69911300903, 30262.84868575643, 1029.7580068683853, 1085.3270971997254, 1112.3103675720943, 1151.5336288803048, 1166.2302880099094, 15999.760003599955, 16078.356865725475, 16100.919495402448, 16167.35330586787, 16279.755803662954, 484751.0, 486390.0, 491390.0, 492467.0, 493228.0, 55320.446795532334, 55426.445735542125, 55483.722581386835, 55765.0, 56156.0, 1293.1077556486182, 1341.557286095586, 1354.9932250338686, 1359.7688392973218, 1387.9653008674863, 30702.692973070876, 31172.22069448191, 31586.0, 31722.206944826565, 31825.5226171603, 50552.0, 50853.23720144127, 50973.0, 51103.48896511136, 51127.2330915044, 393887.0, 394321.0, 398402.0, 398490.0, 399032.0, 28233.57649635216, 28499.857500712365, 28614.42771144607, 28717.71282287234, 28719.42561148807, 46384.7680761594, 47149.76425117852, 47440.2883956734, 48266.27600586064, 48610.0, 40060.59939400685, 41618.79190604028, 41697.79151104225, 41792.16415671731, 42373.15253694847, 39824.60175398209, 40030.5752340605, 40185.39721904115, 40763.1847363057, 41286.79356603198, 37624.0, 39666.206675866895, 39874.2025159501, 39914.401283981344, 40739.0, 34505.309893802485, 36510.8174459126, 36666.8166659165, 36668.44997324989, 36763.26473470462, 27957.44085118327, 28166.29584260328, 28252.43495130127, 28402.573961390182, 28409.57385639176], "value": 18055.513271577594, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.85474100877644, 354.17123930003794, 354.4629885723129, 370.1265014565626, 378.5495260639838, 17849.464516064505, 18344.541386465327, 18549.721754173683, 19032.9048354758, 19112.713309300372, 15236.923815380907, 15658.765118523232, 16122.193890305467, 16133.919330403362, 16667.49997500077, 5183.455737147602, 5357.276767636377, 5361.892762144775, 5367.812126575571, 5373.81191658292, 5282.920756188661, 5304.681719096847, 5321.467853214686, 5344.0, 5357.598180136486, 5141.614378921578, 5223.608229382811, 5275.0, 5333.653312534673, 5347.331583552056, 5243.082460569385, 5243.6853788772605, 5270.262163297141, 5273.604479664041, 5295.973520132375, 5132.769025393829, 5160.297101956346, 5175.353080864892, 5177.741112944338, 5191.558717509016, 13384.130031547918, 13397.196168229937, 14007.509737159253, 14012.369443374972, 14021.369038393195, 2346.8709220992837, 2438.2685194441774, 2714.1450443110357, 2720.2331058156833, 2985.2965226052966, 10095.596176153018, 10138.290319677626, 10187.643432479828, 10369.118624916891, 10378.896211037869, 1878.5021969178179, 1966.4985428715586, 1996.091778240897, 1997.810208030235, 2057.5781964697353, 67823.0, 74101.62949185274, 80799.0, 81677.59161204156, 83521.58239208825, 10635.52140153695, 10691.83962240567, 11096.0, 11258.155638327158, 11455.885441145649, 15141.318640661197, 15172.089674619558, 15192.316345764468, 15271.770923436157, 15279.847201527842, 7601.885971710429, 7906.446548741533, 7942.523448593103, 7975.322097621767, 8061.113277539466, 7455.142658594331, 7476.25237476248, 7548.0, 7559.735409260649, 7625.0, 4762.690425122356, 4807.18277892759, 4829.782659780319, 4838.709677419366, 4874.341963834908, 1962.2935743132462, 1964.4499540128786, 1973.6447439461035, 1979.4061781465502, 1987.5726718755536, 850.6767428377177, 883.3551507399634, 891.0910870911633, 898.285862739124, 951.9190868776232, 18729.719054214198, 19413.708794368096, 19859.702104468444, 19862.404127876187, 20311.0, 867.3928250224868, 884.3411658314468, 911.6763548940163, 940.2431043010306, 958.1951161024773, 10227.539760710637, 10878.564857405774, 11022.779544409066, 11043.337399756041, 11245.0, 446530.0, 449549.0, 450510.0, 463695.0, 471701.0, 56819.0, 90414.54792726126, 91272.0, 91337.0, 93613.99999999863, 898.1781669772085, 955.3408148377736, 961.697065424403, 963.0417734354222, 976.799756050008, 17864.91067544654, 18211.54471138179, 18231.45305640833, 18231.726524101883, 18340.816591834446, 37876.43185352277, 38918.221635567694, 42723.0, 43272.56727432685, 43927.12145757131, 54070.0, 54121.45878541164, 54981.17528236999, 57183.0, 63259.36740632535, 8461.95769021151, 8613.956930215309, 8658.090900455614, 8658.307335413027, 8760.167784060504, 7299.671514781741, 9925.702228933143, 11366.715832104264, 12711.936440317739, 13304.800427993781, 10374.481275936323, 11399.544018239509, 11570.710732231762, 11813.468393922121, 11954.58158964467, 11083.778324433628, 11713.1800773945, 11757.235779674294, 11820.881791181979, 12066.095042871995, 11671.066314694634, 11838.28970261787, 11866.228695134789, 12047.51809927593, 12063.879361206276, 8354.368617844775, 8558.957205213934, 8783.692570759993, 8858.73423797287, 8935.0, 10844.511996960313, 10917.617883374043, 11566.710832229262, 11569.942150289195, 11977.0], "value": 8789.445249335133, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.644421339918, 1293.2240655606633, 1480.1341215388998, 1719.277903280622, 1720.4494561740241, 7682.807929801757, 7994.880076798838, 8097.230763077506, 8628.0, 8679.479231246121, 7979.720709775159, 8265.297449716767, 8324.209200125993, 8342.082370939192, 8344.165583441652, 2247.1685476373764, 2266.8639881607073, 2286.977130228693, 2288.164819840763, 2290.267114523353, 2243.573720993006, 2260.7965283124518, 2262.6266666000092, 2272.988635056831, 2279.1453205048106, 2219.2038032079613, 2231.5871563760757, 2250.313654335427, 2305.1125316753087, 2307.3654744945106, 2183.858049226795, 2187.0704950396016, 2195.209724499179, 2195.7913998170147, 2196.527746534495, 2182.694422780812, 2190.0692205812466, 2193.14467357729, 2204.250554811356, 2204.713387259646, 8279.461834980768, 8412.663493460253, 8415.621297041587, 8429.494230346138, 8432.789180270482, 4975.477574854624, 5058.822941197041, 5078.7968481260705, 5081.822136225214, 5102.132637451642, 3192.154079169022, 3260.625028121749, 3396.83015849209, 3424.383610950028, 3447.9827600862086, 1144.8511693479877, 1149.2989276541387, 1152.9942350288195, 1161.541191229468, 1167.8014737494645, 12453.937730311382, 12475.750484990249, 12490.313032783193, 12527.624171274876, 12572.937135314356, 4434.7560884151035, 4686.95313046872, 4722.905541889143, 4791.281307803788, 4795.592374648124, 10501.107405870587, 10555.050045495942, 10558.577656893638, 10575.788484230272, 10580.153587712965, 5261.394939581997, 5270.5256526912, 5271.604629652791, 5283.418823929364, 5290.867728306823, 4177.081042170717, 4605.769711514411, 4754.643401744883, 4791.808327666854, 4808.663393562487, 3894.357431023906, 3915.4126880967515, 3982.104026594051, 3983.980080099581, 4018.618231268025, 1282.0961222338228, 1313.3039489070616, 1313.770090234205, 1317.3544962968076, 1325.5559387605067, 787.4802630263998, 792.5126047480873, 798.5528104261632, 837.1042984007054, 875.3434923807145, 5816.94183058164, 5836.88326233473, 5864.266966629171, 5911.881762364728, 5922.8815423691285, 435.42958724071565, 439.2532694419436, 444.36677734228596, 449.5571861716207, 450.85572616762323, 3887.902802429962, 3888.7861167635488, 3927.8428862845167, 3944.4674968878835, 3967.8016099194924, 10763.730906727238, 11005.449727513753, 11266.493007814668, 11295.0, 11349.886501135048, 11061.778764424667, 11083.556657733761, 11138.94430527842, 11143.275687080313, 11171.497282622302, 7792.2986931176465, 8098.797530061795, 8177.05963814169, 8340.958295208606, 8385.371097167737, 5765.4811067004175, 5842.561807864342, 5931.510717240327, 5944.197533332945, 6056.182415373868, 10196.3372380795, 10389.584416623553, 10413.583456661649, 10444.63443779464, 10482.37105773656, 10368.274220804773, 10404.375737455777, 10432.68701938943, 10610.681679549625, 10680.252382333161, 7004.4396448283, 7482.850342993219, 7685.807854803675, 7718.961405192938, 7799.220077992155, 8187.5087494750505, 8243.299319557666, 8281.171882811912, 8301.335893128657, 8301.916980830114, 7499.212582678741, 7703.537787732754, 7784.455088143775, 7851.568163751049, 7890.881636775568, 7556.65995030214, 7560.773176804704, 7577.242275772379, 7626.733064342721, 7718.614069296625, 6929.064576282138, 6999.930000699927, 7001.894971575329, 7048.577085374894, 7049.753258635923, 4972.477889821661, 4985.152524070844, 5099.821506247264, 5139.100657385017, 5139.4603566626465, 4820.276958456119, 5075.187969924795, 5104.438511763628, 5136.5377116059735, 5256.842294731164], "value": 4472.914086280796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.2840075225852, 312.6420248815107, 316.92076980754814, 319.32303516544926, 322.1671977937033, 5504.889902201953, 5515.806946756859, 5556.249906262653, 5575.749091290892, 5595.944040559593, 5539.556835453164, 5562.221289019541, 5567.944320556793, 5600.215969764236, 5643.943560564393, 4144.751314921099, 4157.355609880466, 4255.9787201063955, 4301.881510807181, 4306.418633484486, 4304.849330273441, 4315.978420107895, 4327.307630779076, 4363.498197707273, 4370.3007518797, 4319.784010799463, 4322.379107834562, 4328.610425061744, 4332.415123958257, 4350.2387082260475, 4097.508299004109, 4294.871153865389, 4307.741535507848, 4323.502797178333, 4332.870013899588, 3761.5298087739034, 3765.0963768695315, 3789.829457674384, 3796.886093417202, 3809.8095095245126, 5488.341399032141, 5521.723913804293, 5595.076812325961, 5609.242752228479, 5618.719064046782, 4816.349792777965, 4856.417229932431, 4907.190313598252, 4932.4081110267, 4954.999999999964, 5804.59367844251, 5850.6782126983, 5866.0935196061455, 5924.9703751480965, 5926.140709597127, 4153.1486045360625, 4165.791710414467, 4198.979005104986, 4200.075983283673, 4204.306289462235, 5829.5605592700085, 6076.3316035236085, 6082.513398928075, 6088.5996220869, 6104.816855494342, 4215.388768628593, 4232.259354612992, 4251.851185208565, 4283.100548884707, 4312.417823593774, 4243.8090285937205, 4275.828966841354, 4285.142971405731, 4286.957130428718, 4287.3140297552245, 4853.247746599282, 4921.7785199666105, 4932.408111026628, 4973.452920178777, 4981.551660350586, 5739.827805165852, 5777.508911742549, 5873.4126587340925, 5920.105566218855, 5957.493613042853, 1442.776369662704, 1469.5077149154938, 1476.859698328657, 1498.715244103617, 1508.7585986242368, 926.2960150285832, 935.2284365398573, 943.0946291560042, 951.1534734086669, 953.6662168241198, 4980.7011579304635, 5083.491650834961, 5097.413797413345, 5141.511556402136, 5162.432132465426, 5363.168708850135, 5369.48989845964, 5373.516383525502, 5379.569634429315, 5398.758285594256, 5022.0, 5078.289039534468, 5247.763850626731, 5687.687177205294, 5745.0, 3231.159898426426, 3246.756493263015, 3254.8372581370836, 3260.8695652173647, 3261.787983781094, 6203.906941395882, 6297.1813664223355, 6298.527610429236, 6321.336259692758, 6332.0, 6076.756929722762, 6113.724882380304, 6136.0, 6205.355580771099, 6248.593841400385, 6226.62640241587, 6234.376562343729, 6246.125542424064, 6255.437010669061, 6287.654179020106, 5837.532997360286, 6128.816135515942, 6131.877362452815, 6173.938260617337, 6178.351273116438, 6036.8188954331445, 6037.305709843425, 6082.574219804571, 6090.756369745338, 6097.451229389376, 5955.464008239279, 6142.94211439155, 6203.100550420254, 6224.502039836711, 6269.843253918689, 4255.4042434059875, 4259.890280095609, 4278.44380230568, 4296.91406171881, 4309.892252693582, 5806.883862322815, 5979.910301345396, 6076.301225358963, 6097.17688112117, 6097.35371449715, 5837.978353787985, 5849.034909239927, 5856.297244330537, 5871.7651293947765, 5924.081767326072, 5650.23721797552, 5858.853528661817, 5881.029854998453, 5883.176075483706, 5934.169216309634, 5793.536517078708, 5807.245058142584, 5820.854478638068, 5852.092925596539, 5862.794802181903, 5880.705964701662, 5938.287405511366, 5970.820875373745, 5991.340952495135, 5997.880042399215, 5686.630369026, 5686.715664216856, 5703.173039909273, 5718.313802343745, 5746.012073721725], "value": 4419.830677830166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.120986667998, 675.1155985658787, 688.4939569416478, 701.5615240474704, 711.5623891306847, 15758.133302668362, 16820.07489588072, 17060.40288589898, 17643.0, 17770.11149442526, 15179.468718594851, 15227.543173704778, 15234.314455849486, 15286.770698439504, 15340.079595224295, 584.6083124306725, 794.7814351053448, 799.5522507395877, 799.7720649614861, 801.8596745569531, 600.8347704381287, 607.8085403098032, 607.9574429789916, 609.3571282297174, 609.515435228994, 824.3364091906013, 829.2453866981049, 836.786619412049, 838.7106448275335, 840.197611281228, 622.2501885228289, 622.8847663182326, 623.1742940603673, 624.3974564545213, 625.6371304643296, 608.4402349838159, 608.6926102318301, 609.4423602403796, 610.972506237216, 611.7552978808468, 16423.260953257133, 16426.671466570722, 16500.75248871268, 16530.0, 16532.75200871976, 14344.64138396538, 14801.259937003108, 14906.0, 14954.0, 15015.77476337845, 12041.578544750892, 12160.452779624939, 12339.0, 12436.440360183722, 12437.875621243762, 3869.5743468218475, 3893.396523538856, 4000.3399439092514, 4060.4924384451942, 4062.471878655756, 82988.0, 83615.58192209061, 83971.58014209951, 84612.15387846105, 84753.57623211844, 10588.258821882548, 10949.0, 10989.560417583207, 11118.221724479208, 11227.887721122685, 20663.0, 20752.273670421764, 20844.0, 20890.47773805667, 20892.0, 8570.571471426403, 8579.356548258906, 8634.740957771277, 8767.317372498781, 8927.687530936386, 4523.6881304422, 4562.087582483517, 4653.255479123324, 4660.300954856799, 4794.2808578712775, 3623.3115708015393, 3713.7771733696063, 3725.8695945642316, 3728.7949162795762, 3737.5141231639714, 599.3616798109999, 609.3419107364036, 618.8731310081422, 628.8616504369031, 634.8603307272392, 570.7564259728929, 631.564220687724, 657.6448717692488, 660.1088530483809, 662.2615783401473, 8678.305735541142, 9323.90676093244, 9521.381110227812, 9548.618055277711, 9633.710988670351, 623.2458724942779, 625.8654389306321, 644.5423749138164, 656.0945894665331, 659.9769008084694, 4319.568043195655, 4497.820087196541, 4505.7296562206375, 4538.6369090473345, 4602.0, 127131.45737085206, 128060.0, 131608.3419582896, 132692.0, 133142.0, 113596.0, 114202.42898785452, 114553.0, 114856.0, 115798.42100789442, 96422.51788741011, 97369.51315243378, 98887.0, 101947.4902625482, 103393.48303258586, 8707.3034157266, 9011.549422528979, 9025.81948361016, 9031.187193152648, 9048.230900373543, 55904.44095559155, 56314.0, 57078.0, 57496.425035749104, 57655.13517297328, 72768.0, 82238.58880705558, 82247.0, 84627.5768621153, 85357.0, 10858.294210876267, 11371.715707107389, 11450.198486105892, 11938.28370297785, 12191.51233950632, 13409.463621455032, 13580.44989163724, 13729.794053089412, 13778.311084445537, 13834.0, 11831.585894493996, 12161.33112678811, 12172.513099475922, 12757.043221758591, 12768.36158192068, 12315.445804938978, 12395.938020310201, 12435.186572756098, 12464.189827661536, 12613.30626815534, 11556.479958401724, 11804.0, 12002.75994480123, 12016.098792590765, 12242.816357754462, 10080.193584513368, 10188.754025266287, 10239.539220734936, 10324.122449591569, 10421.739456513344, 9979.850302245617, 10323.174146068146, 10620.52207650673, 10713.35719856811, 10739.46302684847], "value": 7385.241145925973, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 112.0, 112.0, 113.0, 112.0, 111.0, 110.0, 112.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 125.0, 150.0, 179.0, 127.0, 151.0, 154.0, 129.0, 191.0, 127.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 163.0, 167.0, 170.0, 165.0, 160.0, 163.0, 162.0, 161.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 158.0, 76.0, 76.0, 73.0, 74.0, 160.0, 75.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 150.0, 84.0, 86.0, 85.0, 147.0, 85.0, 85.0, 140.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 149.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 54.0, 53.0, 55.0, 54.0, 55.0, 53.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 86.0, 84.0, 81.0, 86.0, 84.0, 80.0, 80.0, 113.0, 81.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 128.0, 132.0, 137.0, 129.0, 139.0, 122.0, 131.0, 129.0, 120.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 165.0, 159.0, 158.0, 168.0, 161.0, 159.0], "value": 161.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 71.0, 64.0, 64.0, 68.0, 62.0, 63.0, 65.0, 66.0], "value": 65.3, "unit": "score"}]}]} 12:34:18 INFO - Return code: 0 12:34:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:34:18 ERROR - # TBPL SUCCESS # 12:34:18 INFO - Running post-action listener: _resource_record_post_action 12:34:18 INFO - ##### 12:34:18 INFO - ##### Finished run-tests step (success) 12:34:18 INFO - ##### 12:34:18 INFO - Running post-run listener: _resource_record_post_run 12:34:18 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7921664; Write bytes: 368467968; Read time: 2092; Write time: 426312 12:34:18 INFO - TinderboxPrint: CPU usage
13.4% 12:34:18 INFO - TinderboxPrint: I/O read bytes / time
7,921,664 / 2,092 12:34:18 INFO - TinderboxPrint: I/O write bytes / time
368,467,968 / 426,312 12:34:18 INFO - TinderboxPrint: CPU idle
8,241.6 (86.5%) 12:34:18 INFO - TinderboxPrint: CPU user
1,224.5 (12.9%) 12:34:18 INFO - TinderboxPrint: Swap in / out
0 / 0 12:34:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104505344; Read time: 0; Write time: 118992 12:34:18 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 6025216; Write bytes: 206602240; Read time: 1416; Write time: 235624 12:34:19 INFO - Running post-run listener: _upload_blobber_files 12:34:19 INFO - Blob upload gear active. 12:34:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:34:19 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 12:34:19 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'] 12:34:19 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 12:34:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:34:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:34:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:34:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:22 INFO - (blobuploader) - INFO - Done attempting. 12:34:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:34:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:34:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:23 INFO - (blobuploader) - INFO - Done attempting. 12:34:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:34:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:34:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:24 INFO - (blobuploader) - INFO - Done attempting. 12:34:24 INFO - (blobuploader) - INFO - Iteration through files over. 12:34:24 INFO - Return code: 0 12:34:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:34:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:34:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b9d2ceec84126277c297e551c23c7ececc828642f5ab5df3b1c063810381e64189eb95cfbcb65db4a027368c8b4a1ae9ad2fb1d62a6e2866cc9381b4f0335e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c64ca917341db5cfe6da0c8b82b8b65f64557bca5adb8e8fb9269aea470afa53db3e9ad6747a4f772a5123d1d58a5d1ecbbe9002b8ad03db912fd91a83961f11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c59d5f78d5b58fa0152a2b9db9b8d52e9b04470dcc8f60b023dda843cc46a95b18aca672c6646d03356b73e132392afc5a28ce2db730c131b1b086f07c5328"} 12:34:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:34:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:34:24 INFO - Contents: 12:34:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b9d2ceec84126277c297e551c23c7ececc828642f5ab5df3b1c063810381e64189eb95cfbcb65db4a027368c8b4a1ae9ad2fb1d62a6e2866cc9381b4f0335e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c64ca917341db5cfe6da0c8b82b8b65f64557bca5adb8e8fb9269aea470afa53db3e9ad6747a4f772a5123d1d58a5d1ecbbe9002b8ad03db912fd91a83961f11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c59d5f78d5b58fa0152a2b9db9b8d52e9b04470dcc8f60b023dda843cc46a95b18aca672c6646d03356b73e132392afc5a28ce2db730c131b1b086f07c5328"} 12:34:24 INFO - Running post-run listener: copy_logs_to_upload_dir 12:34:24 INFO - Copying logs to upload dir... 12:34:24 INFO - mkdir: /builds/slave/test/build/upload/logs 12:34:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.476143 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-17 12:34:24.566206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:24.569938) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514 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/7b9d2ceec84126277c297e551c23c7ececc828642f5ab5df3b1c063810381e64189eb95cfbcb65db4a027368c8b4a1ae9ad2fb1d62a6e2866cc9381b4f0335e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c64ca917341db5cfe6da0c8b82b8b65f64557bca5adb8e8fb9269aea470afa53db3e9ad6747a4f772a5123d1d58a5d1ecbbe9002b8ad03db912fd91a83961f11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c59d5f78d5b58fa0152a2b9db9b8d52e9b04470dcc8f60b023dda843cc46a95b18aca672c6646d03356b73e132392afc5a28ce2db730c131b1b086f07c5328"} build_url:https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/C0bFKEIVQUGT3Y-qpmpdUA/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/7b9d2ceec84126277c297e551c23c7ececc828642f5ab5df3b1c063810381e64189eb95cfbcb65db4a027368c8b4a1ae9ad2fb1d62a6e2866cc9381b4f0335e6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c64ca917341db5cfe6da0c8b82b8b65f64557bca5adb8e8fb9269aea470afa53db3e9ad6747a4f772a5123d1d58a5d1ecbbe9002b8ad03db912fd91a83961f11", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16c59d5f78d5b58fa0152a2b9db9b8d52e9b04470dcc8f60b023dda843cc46a95b18aca672c6646d03356b73e132392afc5a28ce2db730c131b1b086f07c5328"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:24.671424) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:24.671768) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466184017.881078-1117174514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 12:34:24.754717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 12:34:24.755049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 12:34:24.755351) ========= ========= Total master_lag: 0.26 =========