builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1465041992.99 results: success (0) buildid: 20160604023008 builduid: b00c519d82954b4fa1ae72a7bd5a5204 revision: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:32.991958) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:32.992358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:32.992642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:33.016866) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:33.017121) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 05:06:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-04 05:06:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072697 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:33.103089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:33.103367) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022366 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:33.152839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-04 05:06:33.153154) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe --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 e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe --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=78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 05:06:33,698 truncating revision to first 12 chars 2016-06-04 05:06:33,699 Setting DEBUG logging. 2016-06-04 05:06:33,699 attempt 1/10 2016-06-04 05:06:33,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e1fb7ee96e4e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 05:06:34,714 unpacking tar archive at: fx-team-e1fb7ee96e4e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.383008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-04 05:06:34.549380) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:34.549703) ========= script_repo_revision: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:34.550110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:34.550387) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 05:06:34.558603) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-04 05:06:34.558880) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:06:35 INFO - MultiFileLogger online at 20160604 05:06:35 in /builds/slave/test 05:06:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:35 INFO - {'append_to_log': False, 05:06:35 INFO - 'base_work_dir': '/builds/slave/test', 05:06:35 INFO - 'blob_upload_branch': 'Fx-Team', 05:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:35 INFO - 'branch': 'Fx-Team', 05:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:35 INFO - 'config_files': ('talos/linux_config.py',), 05:06:35 INFO - 'default_actions': ('clobber', 05:06:35 INFO - 'read-buildbot-config', 05:06:35 INFO - 'download-and-extract', 05:06:35 INFO - 'populate-webroot', 05:06:35 INFO - 'create-virtualenv', 05:06:35 INFO - 'install', 05:06:35 INFO - 'run-tests'), 05:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:35 INFO - 'download_minidump_stackwalk': True, 05:06:35 INFO - 'download_symbols': 'ondemand', 05:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:35 INFO - 'installer_path': 'installer.exe', 05:06:35 INFO - 'log_level': 'info', 05:06:35 INFO - 'log_name': 'talos', 05:06:35 INFO - 'log_to_console': True, 05:06:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:06:35 INFO - 'opt_config_files': (), 05:06:35 INFO - 'pip_index': False, 05:06:35 INFO - 'sps_profile': False, 05:06:35 INFO - 'sps_profile_interval': 0, 05:06:35 INFO - 'suite': 'dromaeojs', 05:06:35 INFO - 'system_bits': '32', 05:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:35 INFO - 'title': 'talos-linux64-ix-019', 05:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:35 INFO - 'use_talos_json': True, 05:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:35 INFO - 'work_dir': 'build'} 05:06:35 INFO - ##### 05:06:35 INFO - ##### Running clobber step. 05:06:35 INFO - ##### 05:06:35 INFO - Running pre-action listener: _resource_record_pre_action 05:06:35 INFO - Running main action method: clobber 05:06:35 INFO - rmtree: /builds/slave/test/build 05:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:35 INFO - Running post-action listener: _resource_record_post_action 05:06:35 INFO - ##### 05:06:35 INFO - ##### Finished clobber step (success) 05:06:35 INFO - ##### 05:06:35 INFO - ##### 05:06:35 INFO - ##### Running read-buildbot-config step. 05:06:35 INFO - ##### 05:06:35 INFO - Running pre-action listener: _resource_record_pre_action 05:06:35 INFO - Running main action method: read_buildbot_config 05:06:35 INFO - Using buildbot properties: 05:06:35 INFO - { 05:06:35 INFO - "project": "", 05:06:35 INFO - "product": "firefox", 05:06:35 INFO - "script_repo_revision": "production", 05:06:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:06:35 INFO - "repository": "", 05:06:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:06:35 INFO - "buildid": "20160604023008", 05:06:35 INFO - "pgo_build": "True", 05:06:35 INFO - "basedir": "/builds/slave/test", 05:06:35 INFO - "buildnumber": 765, 05:06:35 INFO - "slavename": "talos-linux64-ix-019", 05:06:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:06:35 INFO - "platform": "ubuntu64_hw", 05:06:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:06:35 INFO - "branch": "fx-team", 05:06:35 INFO - "repo_path": "integration/fx-team", 05:06:35 INFO - "revision": "e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe", 05:06:35 INFO - "stage_platform": "linux64-pgo", 05:06:35 INFO - "builduid": "b00c519d82954b4fa1ae72a7bd5a5204", 05:06:35 INFO - "slavebuilddir": "test" 05:06:35 INFO - } 05:06:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:06:35 INFO - Running post-action listener: _resource_record_post_action 05:06:35 INFO - ##### 05:06:35 INFO - ##### Finished read-buildbot-config step (success) 05:06:35 INFO - ##### 05:06:35 INFO - ##### 05:06:35 INFO - ##### Running download-and-extract step. 05:06:35 INFO - ##### 05:06:35 INFO - Running pre-action listener: _resource_record_pre_action 05:06:35 INFO - Running main action method: download_and_extract 05:06:35 INFO - mkdir: /builds/slave/test/build/tests 05:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:35 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:06:36 INFO - Downloaded 1361 bytes. 05:06:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:06:36 INFO - Using the following test package requirements: 05:06:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:06:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:06:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'jsshell-linux-x86_64.zip'], 05:06:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:06:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:06:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:06:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:06:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:06:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:06:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:06:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:36 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:37 INFO - Downloaded 24440840 bytes. 05:06:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:06:38 INFO - Return code: 0 05:06:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:38 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:06:43 INFO - Downloaded 24440840 bytes. 05:06:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:06:44 INFO - Return code: 0 05:06:44 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')]} 05:06:44 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:06:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:06:45 INFO - Downloaded 10833369 bytes. 05:06:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:06:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:06:45 INFO - Return code: 0 05:06: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')]} 05:06:45 INFO - https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:06:47 INFO - Downloaded 59083666 bytes. 05:06:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:47 INFO - mkdir: /builds/slave/test/properties 05:06:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:47 INFO - Contents: 05:06:47 INFO - build_url:https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:06:47 INFO - Running post-action listener: _resource_record_post_action 05:06:47 INFO - Running post-action listener: set_extra_try_arguments 05:06:47 INFO - ##### 05:06:47 INFO - ##### Finished download-and-extract step (success) 05:06:47 INFO - ##### 05:06:47 INFO - ##### 05:06:47 INFO - ##### Running populate-webroot step. 05:06:47 INFO - ##### 05:06:47 INFO - Running pre-action listener: _resource_record_pre_action 05:06:47 INFO - Running main action method: populate_webroot 05:06:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:47 INFO - '--tppagecycles', 05:06:47 INFO - '7'], 05:06:47 INFO - 'tests': ['tsvgm']}}, 05:06:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['damp', 'tps']}, 05:06:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'tests': ['damp', 'tps']}, 05:06:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['dromaeo_dom']}, 05:06:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['a11yr', 05:06:47 INFO - 'ts_paint', 05:06:47 INFO - 'tpaint', 05:06:47 INFO - 'sessionrestore', 05:06:47 INFO - 'sessionrestore_no_auto_restore', 05:06:47 INFO - 'tabpaint']}, 05:06:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:47 INFO - 'ts_paint', 05:06:47 INFO - 'tpaint', 05:06:47 INFO - 'sessionrestore', 05:06:47 INFO - 'sessionrestore_no_auto_restore', 05:06:47 INFO - 'tabpaint']}, 05:06:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:47 INFO - 'ts_paint', 05:06:47 INFO - 'tpaint', 05:06:47 INFO - 'sessionrestore', 05:06:47 INFO - 'sessionrestore_no_auto_restore', 05:06:47 INFO - 'tabpaint']}, 05:06:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:47 INFO - 'ts_paint', 05:06:47 INFO - 'tpaint', 05:06:47 INFO - 'sessionrestore', 05:06:47 INFO - 'sessionrestore_no_auto_restore', 05:06:47 INFO - 'tabpaint']}, 05:06:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['a11yr', 05:06:47 INFO - 'ts_paint', 05:06:47 INFO - 'tpaint', 05:06:47 INFO - 'sessionrestore', 05:06:47 INFO - 'sessionrestore_no_auto_restore', 05:06:47 INFO - 'tabpaint']}, 05:06:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['a11yr', 05:06:47 INFO - 'ts_paint', 05:06:47 INFO - 'tpaint', 05:06:47 INFO - 'sessionrestore', 05:06:47 INFO - 'sessionrestore_no_auto_restore', 05:06:47 INFO - 'tabpaint']}, 05:06:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['tsvgx', 05:06:47 INFO - 'tsvgr_opacity', 05:06:47 INFO - 'tart', 05:06:47 INFO - 'tscrollx', 05:06:47 INFO - 'cart']}, 05:06:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:47 INFO - 'tsvgr_opacity', 05:06:47 INFO - 'tart', 05:06:47 INFO - 'tscrollx', 05:06:47 INFO - 'cart']}, 05:06:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'talos_options': ['--disable-e10s'], 05:06:47 INFO - 'tests': ['tp5o']}, 05:06:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'tests': ['tp5o']}, 05:06:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'talos_options': ['--disable-e10s', 05:06:47 INFO - '--xperf_path', 05:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:47 INFO - 'tests': ['tp5n']}, 05:06:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:47 INFO - 'talos_options': ['--xperf_path', 05:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:47 INFO - 'tests': ['tp5n']}}, 05:06:47 INFO - 'talos.zip': {'path': '', 05:06:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:47 INFO - Running post-action listener: _resource_record_post_action 05:06:47 INFO - ##### 05:06:47 INFO - ##### Finished populate-webroot step (success) 05:06:47 INFO - ##### 05:06:47 INFO - ##### 05:06:47 INFO - ##### Running create-virtualenv step. 05:06:47 INFO - ##### 05:06:47 INFO - Running pre-action listener: _resource_record_pre_action 05:06:47 INFO - Running main action method: create_virtualenv 05:06:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:47 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 05:06:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:48 INFO - Using real prefix '/usr' 05:06:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:50 INFO - Installing pip.................done. 05:06:50 INFO - Return code: 0 05:06:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:50 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:06:50 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 05:06:50 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 05:06:50 INFO - Using env: {'DISPLAY': ':0', 05:06:50 INFO - 'HOME': '/home/cltbld', 05:06:50 INFO - 'LANG': 'en_US.UTF-8', 05:06:50 INFO - 'LANGUAGE': 'en_US:en', 05:06:50 INFO - 'LOGNAME': 'cltbld', 05:06:50 INFO - 'MAIL': '/var/mail/cltbld', 05:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:50 INFO - 'MOZ_NO_REMOTE': '1', 05:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:50 INFO - 'NO_EM_RESTART': '1', 05:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:50 INFO - 'PWD': '/builds/slave/test', 05:06:50 INFO - 'SHELL': '/bin/bash', 05:06:50 INFO - 'SHLVL': '1', 05:06:50 INFO - 'TERM': 'linux', 05:06:50 INFO - 'TMOUT': '86400', 05:06:50 INFO - 'USER': 'cltbld', 05:06:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:50 INFO - '_': '/tools/buildbot/bin/python'} 05:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:50 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 05:06:50 INFO - Cleaning up... 05:06:50 INFO - Return code: 0 05:06:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:50 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:06:50 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 05:06:50 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 05:06:50 INFO - Using env: {'DISPLAY': ':0', 05:06:50 INFO - 'HOME': '/home/cltbld', 05:06:50 INFO - 'LANG': 'en_US.UTF-8', 05:06:50 INFO - 'LANGUAGE': 'en_US:en', 05:06:50 INFO - 'LOGNAME': 'cltbld', 05:06:50 INFO - 'MAIL': '/var/mail/cltbld', 05:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:50 INFO - 'MOZ_NO_REMOTE': '1', 05:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:50 INFO - 'NO_EM_RESTART': '1', 05:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:50 INFO - 'PWD': '/builds/slave/test', 05:06:50 INFO - 'SHELL': '/bin/bash', 05:06:50 INFO - 'SHLVL': '1', 05:06:50 INFO - 'TERM': 'linux', 05:06:50 INFO - 'TMOUT': '86400', 05:06:50 INFO - 'USER': 'cltbld', 05:06:50 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:50 INFO - '_': '/tools/buildbot/bin/python'} 05:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:51 INFO - Downloading/unpacking psutil>=3.1.1 05:06:51 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 05:06:51 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 05:06:51 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 05:06:51 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 05:06:51 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 05:06:51 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 05:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:53 INFO - Installing collected packages: psutil 05:06:53 INFO - Running setup.py install for psutil 05:06:53 INFO - building 'psutil._psutil_linux' extension 05:06:53 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 05:06:53 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 05:06:53 INFO - building 'psutil._psutil_posix' extension 05:06:53 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 05:06:53 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 05:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:53 INFO - Successfully installed psutil 05:06:53 INFO - Cleaning up... 05:06:53 INFO - Return code: 0 05:06:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:53 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:06:53 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 05:06:53 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 05:06:53 INFO - Using env: {'DISPLAY': ':0', 05:06:53 INFO - 'HOME': '/home/cltbld', 05:06:53 INFO - 'LANG': 'en_US.UTF-8', 05:06:53 INFO - 'LANGUAGE': 'en_US:en', 05:06:53 INFO - 'LOGNAME': 'cltbld', 05:06:53 INFO - 'MAIL': '/var/mail/cltbld', 05:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:53 INFO - 'MOZ_NO_REMOTE': '1', 05:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:53 INFO - 'NO_EM_RESTART': '1', 05:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:53 INFO - 'PWD': '/builds/slave/test', 05:06:53 INFO - 'SHELL': '/bin/bash', 05:06:53 INFO - 'SHLVL': '1', 05:06:53 INFO - 'TERM': 'linux', 05:06:53 INFO - 'TMOUT': '86400', 05:06:53 INFO - 'USER': 'cltbld', 05:06:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:53 INFO - '_': '/tools/buildbot/bin/python'} 05:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:06:53 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 05:06:53 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 05:06:53 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 05:06:53 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 05:06:53 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 05:06:53 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 05:06:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:55 INFO - Installing collected packages: mozsystemmonitor 05:06:55 INFO - Running setup.py install for mozsystemmonitor 05:06:55 INFO - Successfully installed mozsystemmonitor 05:06:55 INFO - Cleaning up... 05:06:55 INFO - Return code: 0 05:06:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:55 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:06:55 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 05:06:55 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 05:06:55 INFO - Using env: {'DISPLAY': ':0', 05:06:55 INFO - 'HOME': '/home/cltbld', 05:06:55 INFO - 'LANG': 'en_US.UTF-8', 05:06:55 INFO - 'LANGUAGE': 'en_US:en', 05:06:55 INFO - 'LOGNAME': 'cltbld', 05:06:55 INFO - 'MAIL': '/var/mail/cltbld', 05:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:55 INFO - 'MOZ_NO_REMOTE': '1', 05:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:55 INFO - 'NO_EM_RESTART': '1', 05:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:55 INFO - 'PWD': '/builds/slave/test', 05:06:55 INFO - 'SHELL': '/bin/bash', 05:06:55 INFO - 'SHLVL': '1', 05:06:55 INFO - 'TERM': 'linux', 05:06:55 INFO - 'TMOUT': '86400', 05:06:55 INFO - 'USER': 'cltbld', 05:06:55 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:55 INFO - '_': '/tools/buildbot/bin/python'} 05:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:06:56 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 05:06:56 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 05:06:56 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 05:06:56 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 05:06:56 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 05:06:56 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 05:06:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:06:57 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 05:06:57 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 05:06:57 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 05:06:57 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 05:06:57 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 05:06:57 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 05:06:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:58 INFO - warning: no files found matching '*.txt' 05:06:58 INFO - no previously-included directories found matching 'build' 05:06:58 INFO - no previously-included directories found matching 'dist' 05:06:58 INFO - no previously-included directories found matching '.git*' 05:06:58 INFO - Installing collected packages: jsonschema, functools32 05:06:58 INFO - Running setup.py install for functools32 05:06:58 INFO - warning: no files found matching '*.txt' 05:06:58 INFO - no previously-included directories found matching 'build' 05:06:58 INFO - no previously-included directories found matching 'dist' 05:06:58 INFO - no previously-included directories found matching '.git*' 05:06:58 INFO - Successfully installed jsonschema functools32 05:06:58 INFO - Cleaning up... 05:06:58 INFO - Return code: 0 05:06:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:06:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:06:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:06:58 INFO - Using env: {'DISPLAY': ':0', 05:06:58 INFO - 'HOME': '/home/cltbld', 05:06:58 INFO - 'LANG': 'en_US.UTF-8', 05:06:58 INFO - 'LANGUAGE': 'en_US:en', 05:06:58 INFO - 'LOGNAME': 'cltbld', 05:06:58 INFO - 'MAIL': '/var/mail/cltbld', 05:06:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:58 INFO - 'MOZ_NO_REMOTE': '1', 05:06:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:58 INFO - 'NO_EM_RESTART': '1', 05:06:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:58 INFO - 'PWD': '/builds/slave/test', 05:06:58 INFO - 'SHELL': '/bin/bash', 05:06:58 INFO - 'SHLVL': '1', 05:06:58 INFO - 'TERM': 'linux', 05:06:58 INFO - 'TMOUT': '86400', 05:06:58 INFO - 'USER': 'cltbld', 05:06:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:06:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:58 INFO - '_': '/tools/buildbot/bin/python'} 05:06:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:58 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 05:06:58 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 05:06:58 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 05:06:58 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 05:06:58 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 05:06:58 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 05:07:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:00 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 05:07:00 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 05:07:00 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 05:07:00 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 05:07:00 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 05:07:00 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 05:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:01 INFO - Downloading docopt-0.6.1.tar.gz 05:07:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:01 INFO - Running setup.py install for blobuploader 05:07:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:01 INFO - Running setup.py install for requests 05:07:01 INFO - Running setup.py install for docopt 05:07:01 INFO - Successfully installed blobuploader requests docopt 05:07:01 INFO - Cleaning up... 05:07:02 INFO - Return code: 0 05:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:02 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:07:02 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 05:07:02 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 05:07:02 INFO - Using env: {'DISPLAY': ':0', 05:07:02 INFO - 'HOME': '/home/cltbld', 05:07:02 INFO - 'LANG': 'en_US.UTF-8', 05:07:02 INFO - 'LANGUAGE': 'en_US:en', 05:07:02 INFO - 'LOGNAME': 'cltbld', 05:07:02 INFO - 'MAIL': '/var/mail/cltbld', 05:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:02 INFO - 'MOZ_NO_REMOTE': '1', 05:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:02 INFO - 'NO_EM_RESTART': '1', 05:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:02 INFO - 'PWD': '/builds/slave/test', 05:07:02 INFO - 'SHELL': '/bin/bash', 05:07:02 INFO - 'SHLVL': '1', 05:07:02 INFO - 'TERM': 'linux', 05:07:02 INFO - 'TMOUT': '86400', 05:07:02 INFO - 'USER': 'cltbld', 05:07:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:02 INFO - '_': '/tools/buildbot/bin/python'} 05:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:02 INFO - Running setup.py (path:/tmp/pip-_sxXHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:02 INFO - Running setup.py (path:/tmp/pip-XZ65a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:02 INFO - Running setup.py (path:/tmp/pip-U7tS9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:02 INFO - Running setup.py (path:/tmp/pip-wtTTiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:02 INFO - Running setup.py (path:/tmp/pip-4DGt_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:02 INFO - Running setup.py (path:/tmp/pip-Cndu9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:02 INFO - Running setup.py (path:/tmp/pip-XB7Z6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:02 INFO - Running setup.py (path:/tmp/pip-JzoiVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:02 INFO - Running setup.py (path:/tmp/pip-0sXhKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:02 INFO - Running setup.py (path:/tmp/pip-G_4S0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:02 INFO - Running setup.py (path:/tmp/pip-exvQMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:03 INFO - Running setup.py (path:/tmp/pip-Ww3sw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:03 INFO - Running setup.py (path:/tmp/pip-lqQqAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:03 INFO - Running setup.py (path:/tmp/pip-BIoeZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:03 INFO - Running setup.py (path:/tmp/pip-t8LAgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:03 INFO - Running setup.py (path:/tmp/pip-MA4iq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:03 INFO - Running setup.py (path:/tmp/pip-vBzStL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:03 INFO - Running setup.py install for manifestparser 05:07:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:03 INFO - Running setup.py install for mozcrash 05:07:03 INFO - Running setup.py install for mozdebug 05:07:03 INFO - Running setup.py install for mozdevice 05:07:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:03 INFO - Running setup.py install for mozfile 05:07:03 INFO - Running setup.py install for mozhttpd 05:07:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Running setup.py install for mozinfo 05:07:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Running setup.py install for mozInstall 05:07:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Running setup.py install for mozleak 05:07:04 INFO - Running setup.py install for mozlog 05:07:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Running setup.py install for moznetwork 05:07:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Running setup.py install for mozprocess 05:07:04 INFO - Running setup.py install for mozprofile 05:07:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Running setup.py install for mozrunner 05:07:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:04 INFO - Running setup.py install for mozscreenshot 05:07:05 INFO - Running setup.py install for moztest 05:07:05 INFO - Running setup.py install for mozversion 05:07:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:05 INFO - Cleaning up... 05:07:05 INFO - Return code: 0 05:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:05 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:07:05 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 05:07:05 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 05:07:05 INFO - Using env: {'DISPLAY': ':0', 05:07:05 INFO - 'HOME': '/home/cltbld', 05:07:05 INFO - 'LANG': 'en_US.UTF-8', 05:07:05 INFO - 'LANGUAGE': 'en_US:en', 05:07:05 INFO - 'LOGNAME': 'cltbld', 05:07:05 INFO - 'MAIL': '/var/mail/cltbld', 05:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:05 INFO - 'MOZ_NO_REMOTE': '1', 05:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:05 INFO - 'NO_EM_RESTART': '1', 05:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:05 INFO - 'PWD': '/builds/slave/test', 05:07:05 INFO - 'SHELL': '/bin/bash', 05:07:05 INFO - 'SHLVL': '1', 05:07:05 INFO - 'TERM': 'linux', 05:07:05 INFO - 'TMOUT': '86400', 05:07:05 INFO - 'USER': 'cltbld', 05:07:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:05 INFO - '_': '/tools/buildbot/bin/python'} 05:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:05 INFO - Running setup.py (path:/tmp/pip-CWiymE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:05 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)) 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:05 INFO - Running setup.py (path:/tmp/pip-M5m4sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:05 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)) 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:05 INFO - Running setup.py (path:/tmp/pip-MkRTb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:05 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)) 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:05 INFO - Running setup.py (path:/tmp/pip-tJULEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:05 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)) 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:05 INFO - Running setup.py (path:/tmp/pip-uY8ePq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:05 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)) 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:05 INFO - Running setup.py (path:/tmp/pip-DpJuwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:05 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)) 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:05 INFO - Running setup.py (path:/tmp/pip-1Nry6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:05 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)) 05:07:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:05 INFO - Running setup.py (path:/tmp/pip-4gRMeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:06 INFO - Running setup.py (path:/tmp/pip-d1z8gE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:06 INFO - Running setup.py (path:/tmp/pip-4tiguI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:06 INFO - Running setup.py (path:/tmp/pip-nKnMsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:06 INFO - Running setup.py (path:/tmp/pip-1XUxZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:06 INFO - Running setup.py (path:/tmp/pip-W1VlbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:06 INFO - Running setup.py (path:/tmp/pip-4ZzxIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:06 INFO - Running setup.py (path:/tmp/pip-Da2QOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:06 INFO - Running setup.py (path:/tmp/pip-95avvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:06 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)) 05:07:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:06 INFO - Running setup.py (path:/tmp/pip-LDgkqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:06 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)) 05:07:06 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)) 05:07:06 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)) 05:07:06 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)) 05:07:06 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)) 05:07:06 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)) 05:07:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:08 INFO - Downloading blessings-1.6.tar.gz 05:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:08 INFO - Installing collected packages: blessings 05:07:08 INFO - Running setup.py install for blessings 05:07:08 INFO - Successfully installed blessings 05:07:08 INFO - Cleaning up... 05:07:08 INFO - Return code: 0 05:07:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:09 INFO - Reading from file tmpfile_stdout 05:07:09 INFO - Current package versions: 05:07:09 INFO - argparse == 1.2.1 05:07:09 INFO - blessings == 1.6 05:07:09 INFO - blobuploader == 1.2.4 05:07:09 INFO - docopt == 0.6.1 05:07:09 INFO - functools32 == 3.2.3-2 05:07:09 INFO - jsonschema == 2.5.1 05:07:09 INFO - manifestparser == 1.1 05:07:09 INFO - mozInstall == 1.12 05:07:09 INFO - mozcrash == 0.17 05:07:09 INFO - mozdebug == 0.1 05:07:09 INFO - mozdevice == 0.48 05:07:09 INFO - mozfile == 1.2 05:07:09 INFO - mozhttpd == 0.7 05:07:09 INFO - mozinfo == 0.9 05:07:09 INFO - mozleak == 0.1 05:07:09 INFO - mozlog == 3.2 05:07:09 INFO - moznetwork == 0.27 05:07:09 INFO - mozprocess == 0.22 05:07:09 INFO - mozprofile == 0.28 05:07:09 INFO - mozrunner == 6.11 05:07:09 INFO - mozscreenshot == 0.1 05:07:09 INFO - mozsystemmonitor == 0.3 05:07:09 INFO - moztest == 0.7 05:07:09 INFO - mozversion == 1.4 05:07:09 INFO - psutil == 3.1.1 05:07:09 INFO - requests == 1.2.3 05:07:09 INFO - wsgiref == 0.1.2 05:07:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:09 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')]} 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 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')]} 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:07:09 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 05:07:09 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 05:07:09 INFO - Using env: {'DISPLAY': ':0', 05:07:09 INFO - 'HOME': '/home/cltbld', 05:07:09 INFO - 'LANG': 'en_US.UTF-8', 05:07:09 INFO - 'LANGUAGE': 'en_US:en', 05:07:09 INFO - 'LOGNAME': 'cltbld', 05:07:09 INFO - 'MAIL': '/var/mail/cltbld', 05:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:09 INFO - 'MOZ_NO_REMOTE': '1', 05:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:09 INFO - 'NO_EM_RESTART': '1', 05:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:09 INFO - 'PWD': '/builds/slave/test', 05:07:09 INFO - 'SHELL': '/bin/bash', 05:07:09 INFO - 'SHLVL': '1', 05:07:09 INFO - 'TERM': 'linux', 05:07:09 INFO - 'TMOUT': '86400', 05:07:09 INFO - 'USER': 'cltbld', 05:07:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:09 INFO - '_': '/tools/buildbot/bin/python'} 05:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 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)) 05:07:09 INFO - Cleaning up... 05:07:09 INFO - Return code: 0 05:07:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07:09 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')]} 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 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')]} 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:07:09 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 05:07:09 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 05:07:09 INFO - Using env: {'DISPLAY': ':0', 05:07:09 INFO - 'HOME': '/home/cltbld', 05:07:09 INFO - 'LANG': 'en_US.UTF-8', 05:07:09 INFO - 'LANGUAGE': 'en_US:en', 05:07:09 INFO - 'LOGNAME': 'cltbld', 05:07:09 INFO - 'MAIL': '/var/mail/cltbld', 05:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:09 INFO - 'MOZ_NO_REMOTE': '1', 05:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:09 INFO - 'NO_EM_RESTART': '1', 05:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:09 INFO - 'PWD': '/builds/slave/test', 05:07:09 INFO - 'SHELL': '/bin/bash', 05:07:09 INFO - 'SHLVL': '1', 05:07:09 INFO - 'TERM': 'linux', 05:07:09 INFO - 'TMOUT': '86400', 05:07:09 INFO - 'USER': 'cltbld', 05:07:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:09 INFO - '_': '/tools/buildbot/bin/python'} 05:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:07:09 INFO - Cleaning up... 05:07:09 INFO - Return code: 0 05:07:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:07:09 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')]} 05:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 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')]} 05:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:09 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 0x7f052ec9bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21ff350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', '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 05:07:09 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 05:07:09 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 05:07:09 INFO - Using env: {'DISPLAY': ':0', 05:07:09 INFO - 'HOME': '/home/cltbld', 05:07:09 INFO - 'LANG': 'en_US.UTF-8', 05:07:09 INFO - 'LANGUAGE': 'en_US:en', 05:07:09 INFO - 'LOGNAME': 'cltbld', 05:07:09 INFO - 'MAIL': '/var/mail/cltbld', 05:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:09 INFO - 'MOZ_NO_REMOTE': '1', 05:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:09 INFO - 'NO_EM_RESTART': '1', 05:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:09 INFO - 'PWD': '/builds/slave/test', 05:07:09 INFO - 'SHELL': '/bin/bash', 05:07:09 INFO - 'SHLVL': '1', 05:07:09 INFO - 'TERM': 'linux', 05:07:09 INFO - 'TMOUT': '86400', 05:07:09 INFO - 'USER': 'cltbld', 05:07:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:09 INFO - '_': '/tools/buildbot/bin/python'} 05:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:09 INFO - Downloading/unpacking flake8 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:07:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:07:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:12 INFO - no previously-included directories found matching 'docs/_build' 05:07:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:07:12 INFO - Running setup.py install for pep8 05:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:07:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:07:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:07:12 INFO - no previously-included directories found matching 'docs/_build' 05:07:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:07:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:07:12 INFO - Cleaning up... 05:07:12 INFO - Return code: 0 05:07:12 INFO - Running post-action listener: _resource_record_post_action 05:07:12 INFO - Running post-action listener: _start_resource_monitoring 05:07:12 INFO - Starting resource monitoring. 05:07:12 INFO - ##### 05:07:12 INFO - ##### Finished create-virtualenv step (success) 05:07:12 INFO - ##### 05:07:12 INFO - ##### 05:07:12 INFO - ##### Running install step. 05:07:12 INFO - ##### 05:07:12 INFO - Running pre-action listener: _resource_record_pre_action 05:07:12 INFO - Running main action method: install 05:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:12 INFO - Reading from file tmpfile_stdout 05:07:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:12 INFO - Reading from file tmpfile_stdout 05:07:12 INFO - Output received: 05:07:12 INFO - Usage: mozinstall [options] installer 05:07:12 INFO - Options: 05:07:12 INFO - -h, --help show this help message and exit 05:07:12 INFO - -d DEST, --destination=DEST 05:07:12 INFO - Directory to install application into. [default: 05:07:12 INFO - "/builds/slave/test"] 05:07:12 INFO - --app=APP Application being installed. [default: firefox] 05:07:12 INFO - mkdir: /builds/slave/test/build/application 05:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:07:29 INFO - Reading from file tmpfile_stdout 05:07:29 INFO - Output received: 05:07:29 INFO - /builds/slave/test/build/application/firefox/firefox 05:07:29 INFO - Running post-action listener: _resource_record_post_action 05:07:29 INFO - ##### 05:07:29 INFO - ##### Finished install step (success) 05:07:29 INFO - ##### 05:07:29 INFO - ##### 05:07:29 INFO - ##### Running run-tests step. 05:07:29 INFO - ##### 05:07:29 INFO - Running pre-action listener: _resource_record_pre_action 05:07:29 INFO - Running main action method: run_tests 05:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:07:29 INFO - Python 2.7.3 05:07:29 INFO - Return code: 0 05:07:29 INFO - grabbing minidump binary from tooltool 05:07:29 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')]} 05:07:29 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 0x228e1c0>, '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 0x228f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x228f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:07:29 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 05:07:29 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 05:07:29 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 05:07:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:07:29 INFO - Return code: 0 05:07:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:07:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:07:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:07:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:07:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:07:30 INFO - Return code: 0 05:07:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:07:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:07:30 INFO - Using env: {'DISPLAY': ':0', 05:07:30 INFO - 'HOME': '/home/cltbld', 05:07:30 INFO - 'LANG': 'en_US.UTF-8', 05:07:30 INFO - 'LANGUAGE': 'en_US:en', 05:07:30 INFO - 'LOGNAME': 'cltbld', 05:07:30 INFO - 'MAIL': '/var/mail/cltbld', 05:07:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:07:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:30 INFO - 'MOZ_NO_REMOTE': '1', 05:07:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:07:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:30 INFO - 'NO_EM_RESTART': '1', 05:07:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:30 INFO - 'PWD': '/builds/slave/test', 05:07:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:07:30 INFO - 'SHELL': '/bin/bash', 05:07:30 INFO - 'SHLVL': '1', 05:07:30 INFO - 'TERM': 'linux', 05:07:30 INFO - 'TMOUT': '86400', 05:07:30 INFO - 'USER': 'cltbld', 05:07:30 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545', 05:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:30 INFO - '_': '/tools/buildbot/bin/python'} 05:07:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:07:30 INFO - mozversion application_buildid: 20160604023008 05:07:30 INFO - mozversion application_changeset: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe 05:07:30 INFO - mozversion application_display_name: Nightly 05:07:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:07:30 INFO - mozversion application_name: Firefox 05:07:30 INFO - mozversion application_remotingname: firefox 05:07:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:07:30 INFO - mozversion application_vendor: Mozilla 05:07:30 INFO - mozversion application_version: 49.0a1 05:07:30 INFO - mozversion platform_buildid: 20160604023008 05:07:30 INFO - mozversion platform_changeset: e1fb7ee96e4e54f8e5d1ed308914730e2f7d41fe 05:07:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:07:30 INFO - mozversion platform_version: 49.0a1 05:07:30 INFO - using testdate: 1465042050 05:07:30 INFO - actual date: 1465042050 05:07:30 INFO - starting webserver on 'localhost:34779' 05:07:30 INFO - SUITE-START | Running 2 tests 05:07:30 INFO - TEST-START | dromaeo_css 05:07:30 INFO - operating with platform_type : linux_ 05:07:30 INFO - Initialising browser for dromaeo_css test... 05:07:30 INFO - TEST-INFO | started process 30111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOSznoM/profile http://localhost:34779/getInfo.html) 05:07:35 INFO - PROCESS | 30111 | __metrics Screen width/height:1600/1200 05:07:35 INFO - PROCESS | 30111 | colorDepth:24 05:07:35 INFO - PROCESS | 30111 | Browser inner width/height: 1024/697 05:07:35 INFO - PROCESS | 30111 | __metrics 05:07:36 ERROR - PROCESS | 30111 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:07:37 INFO - TEST-INFO | 30111: exit 0 05:07:37 INFO - Browser initialized. 05:07:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:07:37 INFO - TEST-INFO | started process 30193 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOSznoM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:48 INFO - PROCESS | 30193 | RSS: Main: 156512256 05:07:48 INFO - PROCESS | 30193 | 05:08:39 INFO - PROCESS | 30193 | 1465042119915 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] 05:10:47 INFO - PROCESS | 30193 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34779/tests/dromaeo/cssquery-ext.html) 05:10:48 INFO - PROCESS | 30193 | RSS: Main: 252817408 05:10:48 INFO - PROCESS | 30193 | 05:13:51 INFO - PROCESS | 30193 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-ext.html (next: http://localhost:34779/tests/dromaeo/cssquery-jquery.html) 05:13:51 INFO - PROCESS | 30193 | RSS: Main: 250560512 05:13:51 INFO - PROCESS | 30193 | 05:16:53 INFO - PROCESS | 30193 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34779/tests/dromaeo/cssquery-mootools.html) 05:16:54 INFO - PROCESS | 30193 | RSS: Main: 238043136 05:16:54 INFO - PROCESS | 30193 | 05:19:56 INFO - PROCESS | 30193 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34779/tests/dromaeo/cssquery-prototype.html) 05:19:56 INFO - PROCESS | 30193 | RSS: Main: 239026176 05:19:56 INFO - PROCESS | 30193 | 05:22:59 INFO - PROCESS | 30193 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34779/tests/dromaeo/cssquery-yui.html) 05:23:00 INFO - PROCESS | 30193 | RSS: Main: 203313152 05:23:00 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | Cycle 1(1): loaded http://localhost:34779/tests/dromaeo/cssquery-yui.html (next: http://localhost:34779/tests/dromaeo/cssquery-dojo.html) 05:26:03 INFO - PROCESS | 30193 | RSS: Main: 270020608 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | __start_tp_report 05:26:03 INFO - PROCESS | 30193 | _x_x_mozilla_page_load 05:26:03 INFO - PROCESS | 30193 | _x_x_mozilla_page_load_details 05:26:03 INFO - PROCESS | 30193 | |i|pagename|runs| 05:26:03 INFO - PROCESS | 30193 | |0;dojo.html;3119.9376012479747;3120.734737547308;3143.4027534768393;3162.225254812571;3181.093388384311;5173.793048278064;5241.371035475739;5257.658252213609;5340.7863685452585;5342.599305052122;5307.044731948247;5311.362636483617;5315.840524784253;5356.11624082027;5388.91916621251;4785.928211076845;4852.126617208901;4868.707877527342;4880.511948805127;5001.724905130216;4925.064237794825;4952.3561936948145;4976.751162441863;4997.15048441764;5005.0990821652085;4708.387909571751;4738.360321356625;4793.784279707439;4796.088743138827;4805.8558243252755;4795.088933102699;4809.254565542346;4880.511948805127;4889.144399730033;4938.950610493885;4712.764361781931;4840.975795121002;4853.902921941577;4870.293807397943;4901.044296362211;5148.227765835118;5242.318498595197;5248.632595718302;5311.442298558634;5317.867053323659;5685.4883060524335;5711.62874413166;5730.283714535683;5736.1682556029145;5742.799002034951;5467.835964921019;5651.8304450866535;5780.942190578083;5814.418558144194;5817.505512031483;5360.2763626910255;5434.157705555645;5460.208269800856;5464.26232458621;5473.17902314652;5969.462748352582;5978.222831032025;5978.671173085435;5979.521638268928;5982.252218472691;5378.784848606012;5536.363318218457;5620.100783874561;5709.74306156224;5724.713764311851;5754;5760.135979603093;5798.159266906275;5816.156657284755;5817.447342502455;5709.600327977002;5719.571032172604;5720.971395143081;5721.485066344049;5732.054211055212;5463.2078348639225;5551.111822108443;5624.3250809903075;5644.8024319148635;5721.256236689203;4315.115401342718;4315.438992930899;4316.978415107905;4318.460192475941;4351.10802285537;3842.711796615209;3854.4603755474254;3887.5334959805004;3906.8046597670004;3910.139769250817;5217.6347655664495;5225.372955245395;5319.042572336939;5376.650517716336;5380.91928621071;5726.1410788381245;5743.827685169452;5750.022496175577;5784.855378615484;5785.681787501728;5365.222042803772;5393.6763794172475;5398.109311963561;5399.919001214985;5407.161889907071;4707.670463067621;4857.757112144379;4918.0901533216465;4920.75396230187;4922.950770492321;5950.315713692894;5953.672548009815;5953.79161729346;5954.7320370582565;5957.285125784847;5752.741126649395;5764.164196191613;5769.913451298318;5776.826695199151;5780.132980053026;5700.914486282792;5801.912971305518;5874.441928017002;5886.23478947734;5914.290285165807;5576.302962129734;5605.887882242251;5609.915851262316;5622.5783066271015;5624.268845050117;5438.184272359178;5693.4875861172695;5694.202811606461;5710.942890571041;5714.228579141929;5417.349918009706;5480.123180291134;5485.396606373375;5500.42245564226;5513.8345849624575;5464.016477034013;5493.560515158858;5515;5518.834434966958;5519.558435325084;5315.3621565412395;5384.811531596532;5412.188171774265;5414.7021913795115;5481.287432633732;5585.301837270341;5652.123920792284;5652.5477961762135;5660.122680984454;5675.177099320493;5448.427915068861;5495.258140151029;5503.532199762904;5556.027695153412;5560.610757246954 05:26:03 INFO - PROCESS | 30193 | |1;ext.html;601.2994860986951;604.525447523694;623.1276213301378;626.110922490064;637.773590375417;32865.17837054075;35659.46510802337;43326.99999999996;44246.557534424646;44306;43424.348634770424;43848.56151438485;43933.340999884946;43968.3404748929;44022.339664905056;8094.231048050456;8568.742937711862;8744.387892847502;8754.255888249507;8756.69351572695;10369.481525923673;10671.19966002549;10698.893011069867;11111.83332250017;11124;10764.13886889047;10900.618478353259;10914.23600347976;10924.453777311142;10933.945330273338;8169.428140030141;10386.79226415475;10674.839877401846;10696.358218506875;10774.138068954464;10527.368357898551;10631.84052239217;10633.78732425355;10650.946745266225;10653.25427220095;41808.58191418108;42116.368254476205;42210.36684449736;42218.36672449916;42280;3605.94591081134;3791.3554695701796;3944.861929832442;4217.599328063829;4317.870463886088;31755.364892702248;32076.358472830412;32099.6790032099;32182.678173218435;32600.67399326;4237.618614324695;4289.110414127897;4394.187075391031;4535.682502224846;4546.022605139878;365361;365401;366263;366744.16627916956;366983;57641.711791441616;57677.71161144167;57793.42206577965;57987.13019304714;58011.709941450026;60321.69839150776;60405.39594603998;60483.69758151181;60549.39450605526;60550.69724651437;17180.91409542944;17428.912855435894;17434.12829358527;17436.738448923275;17438.215280312415;11894.643160705193;11922.344271065002;11924;11925.045996320274;11993.940030299967;15107.622309442351;16138;16177.977752780902;16198.75701864473;16257.187140643156;5721.342045664718;6544.345565443417;6564.474842012628;6593.011048342787;6688.431483323972;969.340848223215;1046.2048842879467;1124.4265424633331;1129.5989923577013;1219.4756254810516;31461.37077258442;32888.50667239993;33334;33612.49581256283;35567.82216088903;1111.188832152517;1145.570411095839;1151.7523732397408;1209.3771707570609;1230.9199902006342;16355.264013119438;16870.240839162267;17551.473455796346;18388.17253223608;18526.16632251552;570756;572243;573843;575795;576934;59471.70264148738;59532.404675953556;59808.401915980285;59831;59865;1272.2557303977092;1398.5454727213696;1401.614555997109;1414.4483651375972;1426.572028391499;30109.698903011566;32336.191595209366;32398;32638.673613263563;33042.17394565059;49318.50681493139;49324.2601360987;49586.75206623944;49644.503554965435;49715.50284497109;421278;422561;424866;424872;426258;24308.75691243065;26154.86922565375;27138.050168244015;27226.319342015817;28192.15423537297;45473;46080.53919460763;47234.29148562843;47677;47838.76080619574;38722.80638596789;38822;39723;39887.800560997006;39997.60002400055;38919;39113;39746.40380394238;40110.79944600258;40502.59497404988;40160.1967960645;40514.79742601268;40590.59409405868;41188.794056029525;42343.57656423396;33670;35085.649143508235;35956.46065309075;35983;36140.819295903355;27912;28342.43315133727;28412.57381139326;28475.572866406605;28534.42931141407 05:26:03 INFO - PROCESS | 30193 | |2;jquery.html;389.6512621204022;397.4415945596438;402.1855742122204;411.17969650547155;419.3164444754312;14004.22976736279;17677.7348339775;17724.91137544312;19172.466202703785;19222.13500392482;15229.543113706606;17933.91033044836;18655.720164197548;18766.343177988772;19587.902060489712;5508.6970216638165;5681.403452637475;5684.687342196177;5685.033544297458;5714.971425142869;4102.528209255929;5598.356189038252;5646.774129034834;5913.733881975321;6257.030160325156;6264.749410023594;6297.3387794281625;6303.117563541108;6303.684815759217;6318.368163183668;6211.3167551569295;6213.099100630383;6276.937230627681;6288.4026017528495;6292.905606415908;4885.36490256268;5541.224228607998;5586.888262234773;5611.663300202001;5613.943860561383;13031.674208144872;13473.652634736545;13790.379432925542;13809.171449713049;13814.516491922734;2125.6386414309604;2206.172685243034;2279.430142464384;2297.4026753044327;2401.7598240176017;9641.710748677551;9696.418214907128;10155.238357123171;10174.542145603391;10366.792664146675;1775.1213149490954;1856.4894653970132;1880.7178923161498;1926.1139875657213;2009.6382651122792;79187;85190.88854668678;86517;87221.99999999936;87353;10826.56693732242;10982;11077.390743509022;11147.38689372076;11254.718632034264;15374.846251537565;15439.459618913284;15502.30239639219;15548.22258887051;15550.144742039296;8221.79445513855;8389.748307550783;8468.915310846813;8571.742847714579;8595.054544000155;8180.754577362689;8218.274162425958;8284.378671599654;8470.322374210049;8481.194286542768;4255.957440425618;4453.131639330364;4684.297355396718;4844.055409195244;4892.584130348889;1952.277657266792;1995.8103980121866;2005.889676067801;2021.9696704549444;2049.846261530391;971.4171497101682;1061.1192710050793;1065.2543219746208;1068.6847380022912;1092.6012005617893;18601.627967440574;18816.811831881507;18830.3409380671;19122;19707.211711531665;996.5415908682088;1027.1525991057258;1041.146260066753;1042.775803202315;1043.1029314789275;10398.948005259925;10876.619318323821;10887.292325998786;10897.891021089847;10898.455077246264;499221;505703;514466;516061;517821;89481.55259223793;94384.0561594389;94518;95179;97439;1007.1841808135288;1022.0545994954489;1029.1149611334247;1048.9895101049044;1052.1319911073394;16844;16940.491785246464;17195.398161064302;17259;17529.649407012043;31491.52762708607;39616.60383396244;40959.79520102381;43398.56601433945;43708.34437483504;58609.4139058604;59341.109883350924;59397;59489;60227.698861505414;8515;8586.356023298402;8593.183647553473;8638.963324401113;8839.292856571588;9368.812623747623;12718.618441446772;12719.55481558141;12992.67518312012;13017.544385946447;11225.607103751656;11288;11293.548258069584;11403.600873969372;11452.141089418494;11047.72380690489;11057.723556911142;11134.777304454028;11147;11394.088472922313;11060.723481912695;11078.667639970492;11527.481263343001;11639.941800290944;12059.57791477294;8298.128696487023;8455.281301089477;8472.237498625153;8518.74443766688;8546.78633034179;8729.869051964099;10984.286021408903;11524.769504609692;11735.530578777094;11967.940160299142 05:26:03 INFO - PROCESS | 30193 | |3;mootools.html;1337.2244098422916;1506.7965824613677;1527.961800954976;1643.707262614382;1773.042557019209;8430.789230269238;8770.780730481742;8773.605187766558;9042.050584688595;9049.049849765779;8729.781755456117;8908.19826215642;8918.464892106478;8922.77693057674;8936.821263574724;2395.4370722880108;2421.685180926486;2427.2960841355984;2429;2429.6598476213344;2338.8362814602983;2372.1578839511985;2401.5317013182434;2403.435192729707;2406.3382569793357;2399.8320117591775;2410.301012706313;2413.1192114878118;2445.7187423446353;2453.33759884831;2326.2904814031713;2368.2066507719933;2370.928872133839;2373.3473294843884;2373.774491423321;2301.9309420717404;2366.396568874926;2370.9525809483885;2371.5019845832394;2373.3829204406807;7561.735339263154;8429.367797415218;8866.246369058637;8923.643054277822;8929.151730585649;5155.74221288934;5395.271638328853;5407.215953686733;5409.350877894639;5420.756065977041;3320.6015278166774;3371.0729549373873;3387.627360990289;3418.8632454701783;3429.639887811769;1088.9074428673573;1106.2090605217227;1108.5676586131415;1113.7549739057395;1119.3843386137592;11657.825132623017;11721.94139029308;11793.705157371049;11799.52801887915;11833.822492662617;4582.702124361906;4648.233041548175;4713.151632706145;4718.905621887543;4744.810207591727;9988.60045598168;10007.549660265306;10031.598736050622;10059.346142500714;10141.18870490359;5138.126518491866;5138.2292656101135;5139.280500729901;5147.176451767774;5156.5616922562;4596.563326483979;4697.459792123881;4750.049990001944;4892.3884514435695;4898.583620392235;3863.9034024149623;3908.843646254175;3913.373860182357;3988.2821092203103;4002.2995975704134;1194.5401020607128;1196.1686627793774;1197.21582363552;1212.8544574651098;1236.9443375048145;970.9174720148725;973.2943615878573;985.9211263099078;998.6354980432089;1007.5768177365524;6024.728887199999;6029.6683682397015;6078.665673387918;6098.847528811815;6271.62370257786;449.62905602877754;461.69758807980827;469.7580745915856;470.2053529535075;472.8203282752532;3942.56631770505;4066.1054567994993;4072.9185416291507;4105.404716316118;4111.773852438085;10657.73355666099;11022.173336999596;11030.558777648805;11078.612248571422;11098.889011109946;10781.191410644233;10861.728456788644;10862.511186996604;10874.184436167161;10887.074598659045;7955.960220198862;8276.379271554657;8294.087650358455;8295.95852020736;8298.460600060977;5535.501804837584;5607.607467477237;5694.487496125369;5804.709764511673;5844.064949608042;9665.420074795535;10051.346662466916;10054.8491772622;10198;10321.690349289533;10107.848382274125;10320.019598138166;10372.844407333745;10535.946405359402;10542.57829686804;7791.337736292478;7858.724944626911;7942.761717148494;7949.880751788844;7951.085625153181;8381.874271886049;8495.447795893248;8556.529390883561;8574.09971952961;8574.356923230658;7353.227911069261;7542.509736867086;7652.961735191511;7755.418343624138;7957.204279572228;7517.210692877388;7578.810529736801;7696;7809.960950195213;7820.960895195488;6458.967705161444;6563.803085907431;6640.136782218474;6650.20197576294;6654.667266636746;5193.272941788077;5247.921281180862;5325.813596524103;5339.279197308314;5361.571074313967;4562.657800664897;5186.325777648882;5316.521513063843;5325.387580428301;5412.56699464034 05:26:03 INFO - PROCESS | 30193 | |4;prototype.html;326.8683929600483;335.06015626168596;341.1182094286269;342.3204938197677;342.9950245779864;5153.866149447125;5242.475752424765;5280.815171468999;5320.281761962139;5395.89208215836;5261.500157485033;5280.577553795697;5294.1529355303155;5299.443558426367;5300.814471493499;4160.294279345469;4164.917121548389;4176.3317869140865;4194.97902510487;4211.368294755795;3964.9603503965022;4002.8398864045403;4194.406125672255;4200.558941311149;4213.894652633693;4097.79511024449;4126.463559737245;4133.9173216535655;4162.4598898407485;4163.479565054368;4124.1957818225455;4133.2146892090705;4137.54487006429;4137.834486620532;4146.150039241948;3437.4843773433936;3668.981655091734;3691.3909204981146;3696.685781708558;3700.278445703089;5069.949300506984;5100.974495127538;5133.6919784813035;5162.148245539482;5184.429712731597;4677.158111539921;4687.835925742583;4699.224627936386;4700.694454860423;4716.457607375161;5353.304070470814;5468.0977638689565;5522.116461366202;5524.281843360378;5535.778568857241;3975.5428125765616;3981.402789581557;3988.561258261589;4014.8394064237395;4015.277250094982;5758.165066065397;5761.683107429089;5787.1608616750755;5812;5819.156222347779;3926.9018274542796;4021.055052062763;4047.696422768245;4052.7365721228025;4053.6488836475364;4073.674106071507;4090.2228576570355;4094.897627559335;4113.773742444194;4114.629683328455;4677.742724150136;4687.765611719468;4691.132140554008;4702.482726900038;4715.528447155326;5533.253010843485;5550.195221692913;5559.388467268597;5560.193771903132;5567;1352.7970804379422;1408.9154650720989;1410.4146779086768;1410.75311820431;1417.5038736442368;884.5444596033049;893.9061398553058;909.6088681866728;910.913463220993;915.7115508614766;4763.0235801661265;4793.976030119897;4820.276958456189;4855.300644774371;4870.6103511718975;4988.90022199554;5032.622553308516;5085.389753229636;5106.106431374495;5108.514691104339;4815.001774263711;4816.662833601615;4832.565069143794;4850.854474365775;5006.599472042228;3019.855902309341;3034.453798316324;3042.83264420459;3045.1473587395567;3051.160930744019;5936.643801371932;5942.72231470236;5952.166696662471;5954.642721436728;5963.701814909237;5638.464345887216;5768.4808367246305;5826.271716035496;5845.620034697731;5872;5906.616069955439;5924.674142922095;5931.169636250928;5932.436418540232;5940.227770389822;5511.862203444946;5605.383407825218;5647.011772939637;5666.886662266814;5670.476637896261;5616.971915140398;5624.1563765433875;5631.324241091095;5649.039663257338;5689.7439615218245;5864.179014937827;5898.262717160355;5916.704164791657;5959.344472108151;5980.820575382745;3737.2525494900583;3878.96121038786;4063.674906007453;4064.6992962251798;4092.9795351023054;5646.560127167546;5664.830055098354;5757.251557297524;5765.4811067004175;5774.335951365647;5465.715556844218;5527.972360138174;5539.556835453073;5548.916766248429;5563.610547261815;5418.566514678738;5552.58355623338;5654.886902262014;5655.179998900054;5663.093904975184;5507.5593952482905;5516.310461192351;5528.806491772769;5536.169574563686;5544.695041772741;5369.147644062792;5664.85837854057;5666;5677.403872593318;5700.033488446479;5515.518016892334;5538;5542.8337149885565;5547.44525547442;5553.222548843246 05:26:03 INFO - PROCESS | 30193 | |5;yui.html;751.9248075192481;753.111328632214;790.4743345675126;794.2534018023058;794.9403794715398;14695.26523673816;14814.185219812905;14868.107913525182;15532.767008494882;16624.085675287854;14421.5673529794;14596.416143354252;14616.561503154895;14623;14650;681.3459079283894;806.7095845495617;812.9187081291883;824.0688022534528;828.9668413263462;820.7578764264526;822.7326119011316;823.0493779684474;823.798169448486;826.7519744076783;860.2601762484259;861.134559767436;862.5471627395605;862.8576284912982;863.0161615758041;711.5908352697194;723.9565626062426;726.8655298769745;834.9039860416069;861.8017855893148;627.3381582430534;628.22100595262;632.4181752787447;633.1168020611221;633.3191818794768;15341.232938353149;15446.922765386102;15450.845491545053;15465;15472.613184670361;14511.492097776527;14765.18791466469;14874.925625371912;14934.32795524204;15198.164100974442;13232.13991090576;13347.065705400626;13453.327333633377;13615.31923403826;13653.180809151483;4475.59719625232;4516.096780643885;4523.050159466516;4590.565774527185;4782.976085119587;80768.19231807666;81282.59358703227;82303;83015.58492207501;83437.58281208616;11328.94335528317;11607.59373421943;11637.418129093512;11736.119791015708;12051.517939282507;19218.13518391676;19323.710144347846;19383.612327753646;19493.122809473607;19537.511562211057;8721.171488708562;8877.511736854405;8970.820583588422;8991.775205619912;9024.684136055206;4761.595264402565;4774.880627984328;4828.565429111327;4829.396325459317;5076.898462030813;3546.308469848355;3637.399829028234;3665.7617254878883;3668.944965825515;3669.9633003669624;624.0639041437843;629.6505439481132;639.8496353356958;640.4524131867187;644.4361183964031;596.8030549918517;644.9484041276687;664.1598378051768;673.9730410783612;676.9932300677028;9083.863742043743;9091.136342047495;9101.40840845343;9239.950781370671;9314.115159059878;608.6165715599144;652.47475781995;692.3675896581248;699.0772180721399;711.9394851437686;4316.158349121891;4482.350059241457;4533.478649955297;4555.567221113989;4563.475200351935;74045;102338;113351;121198;121526;102660;106279.46860265649;107580.46209768901;107821.46089269503;108926.45536772265;88188;91755;91842.54078729564;93313.53343233376;95873.9999999986;8742.169493898069;8786.121387861163;8879.191387821937;8885.289176865965;9019.864702029343;55120.72439637776;55419;55813.72093139508;57638;58001.41998580129;80885.59557202176;82714;82850;84790.57604711936;84864.51354864711;11976.640700778991;12193.268403895794;12212.145149839425;12240.081993850676;12778.808317875053;12372.690682732644;13445.798313025509;13643.386047627682;13725.519606814112;13778.311084445939;12244.142909996215;12365.567205147776;12483.74641923029;12502;12746.808797868225;12828.422720977393;12872.871271287542;13013.089083764045;13086.14940028895;13140.934295328461;12065.064210714412;12152.21010634306;12310.138290319592;12456.688582785502;12623.368831558202;9303.488308143116;9396.248300135836;9469.763255918657;9786.217102631916;9975.750606234902;8396.832063358821;10097.062274996437;10498.160147188359;10803.189760768131;11189.552417903193 05:26:03 INFO - PROCESS | 30193 | __end_tp_report 05:26:03 INFO - PROCESS | 30193 | __start_cc_report 05:26:03 INFO - PROCESS | 30193 | _x_x_mozilla_cycle_collect,868 05:26:03 INFO - PROCESS | 30193 | __end_cc_report 05:26:03 INFO - PROCESS | 30193 | __startTimestamp1465043163294__endTimestamp 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | ------- Summary: start ------- 05:26:03 INFO - PROCESS | 30193 | Number of tests: 6 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | [#0] dojo.html Cycles:165 Average:5295.52 Median:5464.02 stddev:602.79 (11.0%) stddev-sans-first:579.97 05:26:03 INFO - PROCESS | 30193 | Values: 3119.9 3120.7 3143.4 3162.2 3181.1 5173.8 5241.4 5257.7 5340.8 5342.6 5307.0 5311.4 5315.8 5356.1 5388.9 4785.9 4852.1 4868.7 4880.5 5001.7 4925.1 4952.4 4976.8 4997.2 5005.1 4708.4 4738.4 4793.8 4796.1 4805.9 4795.1 4809.3 4880.5 4889.1 4939.0 4712.8 4841.0 4853.9 4870.3 4901.0 5148.2 5242.3 5248.6 5311.4 5317.9 5685.5 5711.6 5730.3 5736.2 5742.8 5467.8 5651.8 5780.9 5814.4 5817.5 5360.3 5434.2 5460.2 5464.3 5473.2 5969.5 5978.2 5978.7 5979.5 5982.3 5378.8 5536.4 5620.1 5709.7 5724.7 5754.0 5760.1 5798.2 5816.2 5817.4 5709.6 5719.6 5721.0 5721.5 5732.1 5463.2 5551.1 5624.3 5644.8 5721.3 4315.1 4315.4 4317.0 4318.5 4351.1 3842.7 3854.5 3887.5 3906.8 3910.1 5217.6 5225.4 5319.0 5376.7 5380.9 5726.1 5743.8 5750.0 5784.9 5785.7 5365.2 5393.7 5398.1 5399.9 5407.2 4707.7 4857.8 4918.1 4920.8 4923.0 5950.3 5953.7 5953.8 5954.7 5957.3 5752.7 5764.2 5769.9 5776.8 5780.1 5700.9 5801.9 5874.4 5886.2 5914.3 5576.3 5605.9 5609.9 5622.6 5624.3 5438.2 5693.5 5694.2 5710.9 5714.2 5417.3 5480.1 5485.4 5500.4 5513.8 5464.0 5493.6 5515.0 5518.8 5519.6 5315.4 5384.8 5412.2 5414.7 5481.3 5585.3 5652.1 5652.5 5660.1 5675.2 5448.4 5495.3 5503.5 5556.0 5560.6 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | [#1] ext.html Cycles:180 Average:61260.07 Median:185387.18 stddev:122930.54 (66.3%) stddev-sans-first:123191.03 05:26:03 INFO - PROCESS | 30193 | Values: 601.3 604.5 623.1 626.1 637.8 32865.2 35659.5 43327.0 44246.6 44306.0 43424.3 43848.6 43933.3 43968.3 44022.3 8094.2 8568.7 8744.4 8754.3 8756.7 10369.5 10671.2 10698.9 11111.8 11124.0 10764.1 10900.6 10914.2 10924.5 10933.9 8169.4 10386.8 10674.8 10696.4 10774.1 10527.4 10631.8 10633.8 10650.9 10653.3 41808.6 42116.4 42210.4 42218.4 42280.0 3605.9 3791.4 3944.9 4217.6 4317.9 31755.4 32076.4 32099.7 32182.7 32600.7 4237.6 4289.1 4394.2 4535.7 4546.0 365361.0 365401.0 366263.0 366744.2 366983.0 57641.7 57677.7 57793.4 57987.1 58011.7 60321.7 60405.4 60483.7 60549.4 60550.7 17180.9 17428.9 17434.1 17436.7 17438.2 11894.6 11922.3 11924.0 11925.0 11993.9 15107.6 16138.0 16178.0 16198.8 16257.2 5721.3 6544.3 6564.5 6593.0 6688.4 969.3 1046.2 1124.4 1129.6 1219.5 31461.4 32888.5 33334.0 33612.5 35567.8 1111.2 1145.6 1151.8 1209.4 1230.9 16355.3 16870.2 17551.5 18388.2 18526.2 570756.0 572243.0 573843.0 575795.0 576934.0 59471.7 59532.4 59808.4 59831.0 59865.0 1272.3 1398.5 1401.6 1414.4 1426.6 30109.7 32336.2 32398.0 32638.7 33042.2 49318.5 49324.3 49586.8 49644.5 49715.5 421278.0 422561.0 424866.0 424872.0 426258.0 24308.8 26154.9 27138.1 27226.3 28192.2 45473.0 46080.5 47234.3 47677.0 47838.8 38722.8 38822.0 39723.0 39887.8 39997.6 38919.0 39113.0 39746.4 40110.8 40502.6 40160.2 40514.8 40590.6 41188.8 42343.6 33670.0 35085.6 35956.5 35983.0 36140.8 27912.0 28342.4 28412.6 28475.6 28534.4 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | [#2] jquery.html Cycles:180 Average:29342.46 Median:2242.80 stddev:84281.66 (3757.9%) stddev-sans-first:84490.05 05:26:03 INFO - PROCESS | 30193 | Values: 389.7 397.4 402.2 411.2 419.3 14004.2 17677.7 17724.9 19172.5 19222.1 15229.5 17933.9 18655.7 18766.3 19587.9 5508.7 5681.4 5684.7 5685.0 5715.0 4102.5 5598.4 5646.8 5913.7 6257.0 6264.7 6297.3 6303.1 6303.7 6318.4 6211.3 6213.1 6276.9 6288.4 6292.9 4885.4 5541.2 5586.9 5611.7 5613.9 13031.7 13473.7 13790.4 13809.2 13814.5 2125.6 2206.2 2279.4 2297.4 2401.8 9641.7 9696.4 10155.2 10174.5 10366.8 1775.1 1856.5 1880.7 1926.1 2009.6 79187.0 85190.9 86517.0 87222.0 87353.0 10826.6 10982.0 11077.4 11147.4 11254.7 15374.8 15439.5 15502.3 15548.2 15550.1 8221.8 8389.7 8468.9 8571.7 8595.1 8180.8 8218.3 8284.4 8470.3 8481.2 4256.0 4453.1 4684.3 4844.1 4892.6 1952.3 1995.8 2005.9 2022.0 2049.8 971.4 1061.1 1065.3 1068.7 1092.6 18601.6 18816.8 18830.3 19122.0 19707.2 996.5 1027.2 1041.1 1042.8 1043.1 10398.9 10876.6 10887.3 10897.9 10898.5 499221.0 505703.0 514466.0 516061.0 517821.0 89481.6 94384.1 94518.0 95179.0 97439.0 1007.2 1022.1 1029.1 1049.0 1052.1 16844.0 16940.5 17195.4 17259.0 17529.6 31491.5 39616.6 40959.8 43398.6 43708.3 58609.4 59341.1 59397.0 59489.0 60227.7 8515.0 8586.4 8593.2 8639.0 8839.3 9368.8 12718.6 12719.6 12992.7 13017.5 11225.6 11288.0 11293.5 11403.6 11452.1 11047.7 11057.7 11134.8 11147.0 11394.1 11060.7 11078.7 11527.5 11639.9 12059.6 8298.1 8455.3 8472.2 8518.7 8546.8 8729.9 10984.3 11524.8 11735.5 11967.9 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | [#3] mootools.html Cycles:180 Average:5770.47 Median:2583.61 stddev:3274.95 (126.8%) stddev-sans-first:3267.19 05:26:03 INFO - PROCESS | 30193 | Values: 1337.2 1506.8 1528.0 1643.7 1773.0 8430.8 8770.8 8773.6 9042.1 9049.0 8729.8 8908.2 8918.5 8922.8 8936.8 2395.4 2421.7 2427.3 2429.0 2429.7 2338.8 2372.2 2401.5 2403.4 2406.3 2399.8 2410.3 2413.1 2445.7 2453.3 2326.3 2368.2 2370.9 2373.3 2373.8 2301.9 2366.4 2371.0 2371.5 2373.4 7561.7 8429.4 8866.2 8923.6 8929.2 5155.7 5395.3 5407.2 5409.4 5420.8 3320.6 3371.1 3387.6 3418.9 3429.6 1088.9 1106.2 1108.6 1113.8 1119.4 11657.8 11721.9 11793.7 11799.5 11833.8 4582.7 4648.2 4713.2 4718.9 4744.8 9988.6 10007.5 10031.6 10059.3 10141.2 5138.1 5138.2 5139.3 5147.2 5156.6 4596.6 4697.5 4750.0 4892.4 4898.6 3863.9 3908.8 3913.4 3988.3 4002.3 1194.5 1196.2 1197.2 1212.9 1236.9 970.9 973.3 985.9 998.6 1007.6 6024.7 6029.7 6078.7 6098.8 6271.6 449.6 461.7 469.8 470.2 472.8 3942.6 4066.1 4072.9 4105.4 4111.8 10657.7 11022.2 11030.6 11078.6 11098.9 10781.2 10861.7 10862.5 10874.2 10887.1 7956.0 8276.4 8294.1 8296.0 8298.5 5535.5 5607.6 5694.5 5804.7 5844.1 9665.4 10051.3 10054.8 10198.0 10321.7 10107.8 10320.0 10372.8 10535.9 10542.6 7791.3 7858.7 7942.8 7949.9 7951.1 8381.9 8495.4 8556.5 8574.1 8574.4 7353.2 7542.5 7653.0 7755.4 7957.2 7517.2 7578.8 7696.0 7810.0 7821.0 6459.0 6563.8 6640.1 6650.2 6654.7 5193.3 5247.9 5325.8 5339.3 5361.6 4562.7 5186.3 5316.5 5325.4 5412.6 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | [#4] prototype.html Cycles:180 Average:4638.95 Median:5213.45 stddev:1369.07 (26.3%) stddev-sans-first:1334.10 05:26:03 INFO - PROCESS | 30193 | Values: 326.9 335.1 341.1 342.3 343.0 5153.9 5242.5 5280.8 5320.3 5395.9 5261.5 5280.6 5294.2 5299.4 5300.8 4160.3 4164.9 4176.3 4195.0 4211.4 3965.0 4002.8 4194.4 4200.6 4213.9 4097.8 4126.5 4133.9 4162.5 4163.5 4124.2 4133.2 4137.5 4137.8 4146.2 3437.5 3669.0 3691.4 3696.7 3700.3 5069.9 5101.0 5133.7 5162.1 5184.4 4677.2 4687.8 4699.2 4700.7 4716.5 5353.3 5468.1 5522.1 5524.3 5535.8 3975.5 3981.4 3988.6 4014.8 4015.3 5758.2 5761.7 5787.2 5812.0 5819.2 3926.9 4021.1 4047.7 4052.7 4053.6 4073.7 4090.2 4094.9 4113.8 4114.6 4677.7 4687.8 4691.1 4702.5 4715.5 5533.3 5550.2 5559.4 5560.2 5567.0 1352.8 1408.9 1410.4 1410.8 1417.5 884.5 893.9 909.6 910.9 915.7 4763.0 4794.0 4820.3 4855.3 4870.6 4988.9 5032.6 5085.4 5106.1 5108.5 4815.0 4816.7 4832.6 4850.9 5006.6 3019.9 3034.5 3042.8 3045.1 3051.2 5936.6 5942.7 5952.2 5954.6 5963.7 5638.5 5768.5 5826.3 5845.6 5872.0 5906.6 5924.7 5931.2 5932.4 5940.2 5511.9 5605.4 5647.0 5666.9 5670.5 5617.0 5624.2 5631.3 5649.0 5689.7 5864.2 5898.3 5916.7 5959.3 5980.8 3737.3 3879.0 4063.7 4064.7 4093.0 5646.6 5664.8 5757.3 5765.5 5774.3 5465.7 5528.0 5539.6 5548.9 5563.6 5418.6 5552.6 5654.9 5655.2 5663.1 5507.6 5516.3 5528.8 5536.2 5544.7 5369.1 5664.9 5666.0 5677.4 5700.0 5515.5 5538.0 5542.8 5547.4 5553.2 05:26:03 INFO - PROCESS | 30193 | 05:26:03 INFO - PROCESS | 30193 | [#5] yui.html Cycles:180 Average:21282.81 Median:4828.98 stddev:31277.15 (647.7%) stddev-sans-first:31326.90 05:26:03 INFO - PROCESS | 30193 | Values: 751.9 753.1 790.5 794.3 794.9 14695.3 14814.2 14868.1 15532.8 16624.1 14421.6 14596.4 14616.6 14623.0 14650.0 681.3 806.7 812.9 824.1 829.0 820.8 822.7 823.0 823.8 826.8 860.3 861.1 862.5 862.9 863.0 711.6 724.0 726.9 834.9 861.8 627.3 628.2 632.4 633.1 633.3 15341.2 15446.9 15450.8 15465.0 15472.6 14511.5 14765.2 14874.9 14934.3 15198.2 13232.1 13347.1 13453.3 13615.3 13653.2 4475.6 4516.1 4523.1 4590.6 4783.0 80768.2 81282.6 82303.0 83015.6 83437.6 11328.9 11607.6 11637.4 11736.1 12051.5 19218.1 19323.7 19383.6 19493.1 19537.5 8721.2 8877.5 8970.8 8991.8 9024.7 4761.6 4774.9 4828.6 4829.4 5076.9 3546.3 3637.4 3665.8 3668.9 3670.0 624.1 629.7 639.8 640.5 644.4 596.8 644.9 664.2 674.0 677.0 9083.9 9091.1 9101.4 9240.0 9314.1 608.6 652.5 692.4 699.1 711.9 4316.2 4482.4 4533.5 4555.6 4563.5 74045.0 102338.0 113351.0 121198.0 121526.0 102660.0 106279.5 107580.5 107821.5 108926.5 88188.0 91755.0 91842.5 93313.5 95874.0 8742.2 8786.1 8879.2 8885.3 9019.9 55120.7 55419.0 55813.7 57638.0 58001.4 80885.6 82714.0 82850.0 84790.6 84864.5 11976.6 12193.3 12212.1 12240.1 12778.8 12372.7 13445.8 13643.4 13725.5 13778.3 12244.1 12365.6 12483.7 12502.0 12746.8 12828.4 12872.9 13013.1 13086.1 13140.9 12065.1 12152.2 12310.1 12456.7 12623.4 9303.5 9396.2 9469.8 9786.2 9975.8 8396.8 10097.1 10498.2 10803.2 11189.6 05:26:03 INFO - PROCESS | 30193 | -------- Summary: end -------- 05:26:03 INFO - PROCESS | 30193 | 05:26:04 INFO - TEST-INFO | 30193: exit 0 05:26:04 INFO - TEST-OK | dromaeo_css | took 1113221ms 05:26:04 INFO - TEST-START | kraken 05:26:04 INFO - operating with platform_type : linux_ 05:26:04 INFO - Initialising browser for kraken test... 05:26:04 INFO - TEST-INFO | started process 30375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2ezN6F/profile http://localhost:34779/getInfo.html) 05:26:08 INFO - PROCESS | 30375 | __metrics Screen width/height:1600/1200 05:26:08 INFO - PROCESS | 30375 | colorDepth:24 05:26:08 INFO - PROCESS | 30375 | Browser inner width/height: 1024/697 05:26:08 INFO - PROCESS | 30375 | __metrics 05:26:09 ERROR - PROCESS | 30375 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:26:10 INFO - TEST-INFO | 30375: exit 0 05:26:10 INFO - Browser initialized. 05:26:10 INFO - Running cycle 1/1 for kraken test... 05:26:10 INFO - TEST-INFO | started process 30457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2ezN6F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:21 INFO - PROCESS | 30457 | RSS: Main: 156045312 05:26:21 INFO - PROCESS | 30457 | 05:26:24 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-beat-detection) 05:26:25 INFO - PROCESS | 30457 | RSS: Main: 214364160 05:26:25 INFO - PROCESS | 30457 | 05:26:27 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-dft) 05:26:28 INFO - PROCESS | 30457 | RSS: Main: 202866688 05:26:28 INFO - PROCESS | 30457 | 05:26:31 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-fft) 05:26:32 INFO - PROCESS | 30457 | RSS: Main: 268152832 05:26:32 INFO - PROCESS | 30457 | 05:26:34 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34779/tests/kraken/driver.html?testName=audio-oscillator) 05:26:34 INFO - PROCESS | 30457 | RSS: Main: 179187712 05:26:34 INFO - PROCESS | 30457 | 05:26:37 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:37 INFO - PROCESS | 30457 | RSS: Main: 183287808 05:26:37 INFO - PROCESS | 30457 | 05:26:40 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34779/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:41 INFO - PROCESS | 30457 | RSS: Main: 217780224 05:26:41 INFO - PROCESS | 30457 | 05:26:44 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34779/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:45 INFO - PROCESS | 30457 | RSS: Main: 220053504 05:26:45 INFO - PROCESS | 30457 | 05:26:48 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34779/tests/kraken/driver.html?testName=json-parse-financial) 05:26:48 INFO - PROCESS | 30457 | RSS: Main: 220758016 05:26:48 INFO - PROCESS | 30457 | 05:26:50 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:50 INFO - PROCESS | 30457 | RSS: Main: 206053376 05:26:50 INFO - PROCESS | 30457 | 05:26:52 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:53 INFO - PROCESS | 30457 | RSS: Main: 210735104 05:26:53 INFO - PROCESS | 30457 | 05:26:55 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:55 INFO - PROCESS | 30457 | RSS: Main: 216535040 05:26:55 INFO - PROCESS | 30457 | 05:26:58 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:59 INFO - PROCESS | 30457 | RSS: Main: 224301056 05:26:59 INFO - PROCESS | 30457 | 05:27:01 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:02 INFO - PROCESS | 30457 | RSS: Main: 224354304 05:27:02 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | Cycle 1(1): loaded http://localhost:34779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34779/tests/kraken/driver.html?testName=ai-astar) 05:27:04 INFO - PROCESS | 30457 | RSS: Main: 266211328 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | __start_tp_report 05:27:04 INFO - PROCESS | 30457 | _x_x_mozilla_page_load 05:27:04 INFO - PROCESS | 30457 | _x_x_mozilla_page_load_details 05:27:04 INFO - PROCESS | 30457 | |i|pagename|runs| 05:27:04 INFO - PROCESS | 30457 | |0;ai-astar;111;108;113;109;112;111;109;112;109;109 05:27:04 INFO - PROCESS | 30457 | |1;audio-beat-detection;157;123;130;188;126;126;151;124;156;124 05:27:04 INFO - PROCESS | 30457 | |2;audio-dft;161;161;160;161;158;160;164;162;162;160 05:27:04 INFO - PROCESS | 30457 | |3;audio-fft;74;74;76;131;75;76;75;75;102;74 05:27:04 INFO - PROCESS | 30457 | |4;audio-oscillator;85;85;110;86;86;85;130;85;86;129 05:27:04 INFO - PROCESS | 30457 | |5;imaging-gaussian-blur;117;116;116;116;116;117;117;116;116;117 05:27:04 INFO - PROCESS | 30457 | |6;imaging-darkroom;146;146;145;146;145;145;145;146;145;146 05:27:04 INFO - PROCESS | 30457 | |7;imaging-desaturate;94;94;95;94;96;95;95;95;95;95 05:27:04 INFO - PROCESS | 30457 | |8;json-parse-financial;59;65;56;57;58;57;56;56;57;57 05:27:04 INFO - PROCESS | 30457 | |9;json-stringify-tinderbox;63;62;62;62;62;62;62;62;62;62 05:27:04 INFO - PROCESS | 30457 | |10;stanford-crypto-aes;80;84;81;81;84;80;80;84;108;80 05:27:04 INFO - PROCESS | 30457 | |11;stanford-crypto-ccm;126;120;122;131;120;121;119;121;135;129 05:27:04 INFO - PROCESS | 30457 | |12;stanford-crypto-pbkdf2;160;161;162;162;162;157;161;163;165;166 05:27:04 INFO - PROCESS | 30457 | |13;stanford-crypto-sha256-iterative;63;65;63;63;62;63;64;62;64;61 05:27:04 INFO - PROCESS | 30457 | __end_tp_report 05:27:04 INFO - PROCESS | 30457 | __start_cc_report 05:27:04 INFO - PROCESS | 30457 | _x_x_mozilla_cycle_collect,1618 05:27:04 INFO - PROCESS | 30457 | __end_cc_report 05:27:04 INFO - PROCESS | 30457 | __startTimestamp1465043224294__endTimestamp 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | ------- Summary: start ------- 05:27:04 INFO - PROCESS | 30457 | Number of tests: 14 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.70 (1.5%) stddev-sans-first:1.79 05:27:04 INFO - PROCESS | 30457 | Values: 111.0 108.0 113.0 109.0 112.0 111.0 109.0 112.0 109.0 109.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:140.50 stddev:21.76 (15.5%) stddev-sans-first:22.24 05:27:04 INFO - PROCESS | 30457 | Values: 157.0 123.0 130.0 188.0 126.0 126.0 151.0 124.0 156.0 124.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.60 (1.0%) stddev-sans-first:1.69 05:27:04 INFO - PROCESS | 30457 | Values: 161.0 161.0 160.0 161.0 158.0 160.0 164.0 162.0 162.0 160.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:18.85 (25.1%) stddev-sans-first:19.70 05:27:04 INFO - PROCESS | 30457 | Values: 74.0 74.0 76.0 131.0 75.0 76.0 75.0 75.0 102.0 74.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:85.00 stddev:18.92 (22.3%) stddev-sans-first:19.58 05:27:04 INFO - PROCESS | 30457 | Values: 85.0 85.0 110.0 86.0 86.0 85.0 130.0 85.0 86.0 129.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 05:27:04 INFO - PROCESS | 30457 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 05:27:04 INFO - PROCESS | 30457 | Values: 146.0 146.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 05:27:04 INFO - PROCESS | 30457 | Values: 94.0 94.0 95.0 94.0 96.0 95.0 95.0 95.0 95.0 95.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:2.70 (4.7%) stddev-sans-first:2.83 05:27:04 INFO - PROCESS | 30457 | Values: 59.0 65.0 56.0 57.0 58.0 57.0 56.0 56.0 57.0 57.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 05:27:04 INFO - PROCESS | 30457 | Values: 63.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 62.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:81.00 stddev:8.55 (10.6%) stddev-sans-first:8.93 05:27:04 INFO - PROCESS | 30457 | Values: 80.0 84.0 81.0 81.0 84.0 80.0 80.0 84.0 108.0 80.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:124.00 stddev:5.54 (4.5%) stddev-sans-first:5.85 05:27:04 INFO - PROCESS | 30457 | Values: 126.0 120.0 122.0 131.0 120.0 121.0 119.0 121.0 135.0 129.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.00 stddev:2.51 (1.6%) stddev-sans-first:2.57 05:27:04 INFO - PROCESS | 30457 | Values: 160.0 161.0 162.0 162.0 162.0 157.0 161.0 163.0 165.0 166.0 05:27:04 INFO - PROCESS | 30457 | 05:27:04 INFO - PROCESS | 30457 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.15 (1.8%) stddev-sans-first:1.22 05:27:04 INFO - PROCESS | 30457 | Values: 63.0 65.0 63.0 63.0 62.0 63.0 64.0 62.0 64.0 61.0 05:27:04 INFO - PROCESS | 30457 | -------- Summary: end -------- 05:27:04 INFO - PROCESS | 30457 | 05:27:05 INFO - TEST-INFO | 30457: exit 0 05:27:05 INFO - TEST-OK | kraken | took 61199ms 05:27:05 INFO - SUITE-END | took 1174s 05:27:05 INFO - Completed test suite (00:19:34) 05:27:05 INFO - javascript benchmark 05:27:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.9376012479747, 3120.734737547308, 3143.4027534768393, 3162.225254812571, 3181.093388384311, 5173.793048278064, 5241.371035475739, 5257.658252213609, 5340.7863685452585, 5342.599305052122, 5307.044731948247, 5311.362636483617, 5315.840524784253, 5356.11624082027, 5388.91916621251, 4785.928211076845, 4852.126617208901, 4868.707877527342, 4880.511948805127, 5001.724905130216, 4925.064237794825, 4952.3561936948145, 4976.751162441863, 4997.15048441764, 5005.0990821652085, 4708.387909571751, 4738.360321356625, 4793.784279707439, 4796.088743138827, 4805.8558243252755, 4795.088933102699, 4809.254565542346, 4880.511948805127, 4889.144399730033, 4938.950610493885, 4712.764361781931, 4840.975795121002, 4853.902921941577, 4870.293807397943, 4901.044296362211, 5148.227765835118, 5242.318498595197, 5248.632595718302, 5311.442298558634, 5317.867053323659, 5685.4883060524335, 5711.62874413166, 5730.283714535683, 5736.1682556029145, 5742.799002034951, 5467.835964921019, 5651.8304450866535, 5780.942190578083, 5814.418558144194, 5817.505512031483, 5360.2763626910255, 5434.157705555645, 5460.208269800856, 5464.26232458621, 5473.17902314652, 5969.462748352582, 5978.222831032025, 5978.671173085435, 5979.521638268928, 5982.252218472691, 5378.784848606012, 5536.363318218457, 5620.100783874561, 5709.74306156224, 5724.713764311851, 5754.0, 5760.135979603093, 5798.159266906275, 5816.156657284755, 5817.447342502455, 5709.600327977002, 5719.571032172604, 5720.971395143081, 5721.485066344049, 5732.054211055212, 5463.2078348639225, 5551.111822108443, 5624.3250809903075, 5644.8024319148635, 5721.256236689203, 4315.115401342718, 4315.438992930899, 4316.978415107905, 4318.460192475941, 4351.10802285537, 3842.711796615209, 3854.4603755474254, 3887.5334959805004, 3906.8046597670004, 3910.139769250817, 5217.6347655664495, 5225.372955245395, 5319.042572336939, 5376.650517716336, 5380.91928621071, 5726.1410788381245, 5743.827685169452, 5750.022496175577, 5784.855378615484, 5785.681787501728, 5365.222042803772, 5393.6763794172475, 5398.109311963561, 5399.919001214985, 5407.161889907071, 4707.670463067621, 4857.757112144379, 4918.0901533216465, 4920.75396230187, 4922.950770492321, 5950.315713692894, 5953.672548009815, 5953.79161729346, 5954.7320370582565, 5957.285125784847, 5752.741126649395, 5764.164196191613, 5769.913451298318, 5776.826695199151, 5780.132980053026, 5700.914486282792, 5801.912971305518, 5874.441928017002, 5886.23478947734, 5914.290285165807, 5576.302962129734, 5605.887882242251, 5609.915851262316, 5622.5783066271015, 5624.268845050117, 5438.184272359178, 5693.4875861172695, 5694.202811606461, 5710.942890571041, 5714.228579141929, 5417.349918009706, 5480.123180291134, 5485.396606373375, 5500.42245564226, 5513.8345849624575, 5464.016477034013, 5493.560515158858, 5515.0, 5518.834434966958, 5519.558435325084, 5315.3621565412395, 5384.811531596532, 5412.188171774265, 5414.7021913795115, 5481.287432633732, 5585.301837270341, 5652.123920792284, 5652.5477961762135, 5660.122680984454, 5675.177099320493, 5448.427915068861, 5495.258140151029, 5503.532199762904, 5556.027695153412, 5560.610757246954], "value": 5255.326876224971, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.2994860986951, 604.525447523694, 623.1276213301378, 626.110922490064, 637.773590375417, 32865.17837054075, 35659.46510802337, 43326.99999999996, 44246.557534424646, 44306.0, 43424.348634770424, 43848.56151438485, 43933.340999884946, 43968.3404748929, 44022.339664905056, 8094.231048050456, 8568.742937711862, 8744.387892847502, 8754.255888249507, 8756.69351572695, 10369.481525923673, 10671.19966002549, 10698.893011069867, 11111.83332250017, 11124.0, 10764.13886889047, 10900.618478353259, 10914.23600347976, 10924.453777311142, 10933.945330273338, 8169.428140030141, 10386.79226415475, 10674.839877401846, 10696.358218506875, 10774.138068954464, 10527.368357898551, 10631.84052239217, 10633.78732425355, 10650.946745266225, 10653.25427220095, 41808.58191418108, 42116.368254476205, 42210.36684449736, 42218.36672449916, 42280.0, 3605.94591081134, 3791.3554695701796, 3944.861929832442, 4217.599328063829, 4317.870463886088, 31755.364892702248, 32076.358472830412, 32099.6790032099, 32182.678173218435, 32600.67399326, 4237.618614324695, 4289.110414127897, 4394.187075391031, 4535.682502224846, 4546.022605139878, 365361.0, 365401.0, 366263.0, 366744.16627916956, 366983.0, 57641.711791441616, 57677.71161144167, 57793.42206577965, 57987.13019304714, 58011.709941450026, 60321.69839150776, 60405.39594603998, 60483.69758151181, 60549.39450605526, 60550.69724651437, 17180.91409542944, 17428.912855435894, 17434.12829358527, 17436.738448923275, 17438.215280312415, 11894.643160705193, 11922.344271065002, 11924.0, 11925.045996320274, 11993.940030299967, 15107.622309442351, 16138.0, 16177.977752780902, 16198.75701864473, 16257.187140643156, 5721.342045664718, 6544.345565443417, 6564.474842012628, 6593.011048342787, 6688.431483323972, 969.340848223215, 1046.2048842879467, 1124.4265424633331, 1129.5989923577013, 1219.4756254810516, 31461.37077258442, 32888.50667239993, 33334.0, 33612.49581256283, 35567.82216088903, 1111.188832152517, 1145.570411095839, 1151.7523732397408, 1209.3771707570609, 1230.9199902006342, 16355.264013119438, 16870.240839162267, 17551.473455796346, 18388.17253223608, 18526.16632251552, 570756.0, 572243.0, 573843.0, 575795.0, 576934.0, 59471.70264148738, 59532.404675953556, 59808.401915980285, 59831.0, 59865.0, 1272.2557303977092, 1398.5454727213696, 1401.614555997109, 1414.4483651375972, 1426.572028391499, 30109.698903011566, 32336.191595209366, 32398.0, 32638.673613263563, 33042.17394565059, 49318.50681493139, 49324.2601360987, 49586.75206623944, 49644.503554965435, 49715.50284497109, 421278.0, 422561.0, 424866.0, 424872.0, 426258.0, 24308.75691243065, 26154.86922565375, 27138.050168244015, 27226.319342015817, 28192.15423537297, 45473.0, 46080.53919460763, 47234.29148562843, 47677.0, 47838.76080619574, 38722.80638596789, 38822.0, 39723.0, 39887.800560997006, 39997.60002400055, 38919.0, 39113.0, 39746.40380394238, 40110.79944600258, 40502.59497404988, 40160.1967960645, 40514.79742601268, 40590.59409405868, 41188.794056029525, 42343.57656423396, 33670.0, 35085.649143508235, 35956.46065309075, 35983.0, 36140.819295903355, 27912.0, 28342.43315133727, 28412.57381139326, 28475.572866406605, 28534.42931141407], "value": 20427.086660723173, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.6512621204022, 397.4415945596438, 402.1855742122204, 411.17969650547155, 419.3164444754312, 14004.22976736279, 17677.7348339775, 17724.91137544312, 19172.466202703785, 19222.13500392482, 15229.543113706606, 17933.91033044836, 18655.720164197548, 18766.343177988772, 19587.902060489712, 5508.6970216638165, 5681.403452637475, 5684.687342196177, 5685.033544297458, 5714.971425142869, 4102.528209255929, 5598.356189038252, 5646.774129034834, 5913.733881975321, 6257.030160325156, 6264.749410023594, 6297.3387794281625, 6303.117563541108, 6303.684815759217, 6318.368163183668, 6211.3167551569295, 6213.099100630383, 6276.937230627681, 6288.4026017528495, 6292.905606415908, 4885.36490256268, 5541.224228607998, 5586.888262234773, 5611.663300202001, 5613.943860561383, 13031.674208144872, 13473.652634736545, 13790.379432925542, 13809.171449713049, 13814.516491922734, 2125.6386414309604, 2206.172685243034, 2279.430142464384, 2297.4026753044327, 2401.7598240176017, 9641.710748677551, 9696.418214907128, 10155.238357123171, 10174.542145603391, 10366.792664146675, 1775.1213149490954, 1856.4894653970132, 1880.7178923161498, 1926.1139875657213, 2009.6382651122792, 79187.0, 85190.88854668678, 86517.0, 87221.99999999936, 87353.0, 10826.56693732242, 10982.0, 11077.390743509022, 11147.38689372076, 11254.718632034264, 15374.846251537565, 15439.459618913284, 15502.30239639219, 15548.22258887051, 15550.144742039296, 8221.79445513855, 8389.748307550783, 8468.915310846813, 8571.742847714579, 8595.054544000155, 8180.754577362689, 8218.274162425958, 8284.378671599654, 8470.322374210049, 8481.194286542768, 4255.957440425618, 4453.131639330364, 4684.297355396718, 4844.055409195244, 4892.584130348889, 1952.277657266792, 1995.8103980121866, 2005.889676067801, 2021.9696704549444, 2049.846261530391, 971.4171497101682, 1061.1192710050793, 1065.2543219746208, 1068.6847380022912, 1092.6012005617893, 18601.627967440574, 18816.811831881507, 18830.3409380671, 19122.0, 19707.211711531665, 996.5415908682088, 1027.1525991057258, 1041.146260066753, 1042.775803202315, 1043.1029314789275, 10398.948005259925, 10876.619318323821, 10887.292325998786, 10897.891021089847, 10898.455077246264, 499221.0, 505703.0, 514466.0, 516061.0, 517821.0, 89481.55259223793, 94384.0561594389, 94518.0, 95179.0, 97439.0, 1007.1841808135288, 1022.0545994954489, 1029.1149611334247, 1048.9895101049044, 1052.1319911073394, 16844.0, 16940.491785246464, 17195.398161064302, 17259.0, 17529.649407012043, 31491.52762708607, 39616.60383396244, 40959.79520102381, 43398.56601433945, 43708.34437483504, 58609.4139058604, 59341.109883350924, 59397.0, 59489.0, 60227.698861505414, 8515.0, 8586.356023298402, 8593.183647553473, 8638.963324401113, 8839.292856571588, 9368.812623747623, 12718.618441446772, 12719.55481558141, 12992.67518312012, 13017.544385946447, 11225.607103751656, 11288.0, 11293.548258069584, 11403.600873969372, 11452.141089418494, 11047.72380690489, 11057.723556911142, 11134.777304454028, 11147.0, 11394.088472922313, 11060.723481912695, 11078.667639970492, 11527.481263343001, 11639.941800290944, 12059.57791477294, 8298.128696487023, 8455.281301089477, 8472.237498625153, 8518.74443766688, 8546.78633034179, 8729.869051964099, 10984.286021408903, 11524.769504609692, 11735.530578777094, 11967.940160299142], "value": 9072.92040175847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.2244098422916, 1506.7965824613677, 1527.961800954976, 1643.707262614382, 1773.042557019209, 8430.789230269238, 8770.780730481742, 8773.605187766558, 9042.050584688595, 9049.049849765779, 8729.781755456117, 8908.19826215642, 8918.464892106478, 8922.77693057674, 8936.821263574724, 2395.4370722880108, 2421.685180926486, 2427.2960841355984, 2429.0, 2429.6598476213344, 2338.8362814602983, 2372.1578839511985, 2401.5317013182434, 2403.435192729707, 2406.3382569793357, 2399.8320117591775, 2410.301012706313, 2413.1192114878118, 2445.7187423446353, 2453.33759884831, 2326.2904814031713, 2368.2066507719933, 2370.928872133839, 2373.3473294843884, 2373.774491423321, 2301.9309420717404, 2366.396568874926, 2370.9525809483885, 2371.5019845832394, 2373.3829204406807, 7561.735339263154, 8429.367797415218, 8866.246369058637, 8923.643054277822, 8929.151730585649, 5155.74221288934, 5395.271638328853, 5407.215953686733, 5409.350877894639, 5420.756065977041, 3320.6015278166774, 3371.0729549373873, 3387.627360990289, 3418.8632454701783, 3429.639887811769, 1088.9074428673573, 1106.2090605217227, 1108.5676586131415, 1113.7549739057395, 1119.3843386137592, 11657.825132623017, 11721.94139029308, 11793.705157371049, 11799.52801887915, 11833.822492662617, 4582.702124361906, 4648.233041548175, 4713.151632706145, 4718.905621887543, 4744.810207591727, 9988.60045598168, 10007.549660265306, 10031.598736050622, 10059.346142500714, 10141.18870490359, 5138.126518491866, 5138.2292656101135, 5139.280500729901, 5147.176451767774, 5156.5616922562, 4596.563326483979, 4697.459792123881, 4750.049990001944, 4892.3884514435695, 4898.583620392235, 3863.9034024149623, 3908.843646254175, 3913.373860182357, 3988.2821092203103, 4002.2995975704134, 1194.5401020607128, 1196.1686627793774, 1197.21582363552, 1212.8544574651098, 1236.9443375048145, 970.9174720148725, 973.2943615878573, 985.9211263099078, 998.6354980432089, 1007.5768177365524, 6024.728887199999, 6029.6683682397015, 6078.665673387918, 6098.847528811815, 6271.62370257786, 449.62905602877754, 461.69758807980827, 469.7580745915856, 470.2053529535075, 472.8203282752532, 3942.56631770505, 4066.1054567994993, 4072.9185416291507, 4105.404716316118, 4111.773852438085, 10657.73355666099, 11022.173336999596, 11030.558777648805, 11078.612248571422, 11098.889011109946, 10781.191410644233, 10861.728456788644, 10862.511186996604, 10874.184436167161, 10887.074598659045, 7955.960220198862, 8276.379271554657, 8294.087650358455, 8295.95852020736, 8298.460600060977, 5535.501804837584, 5607.607467477237, 5694.487496125369, 5804.709764511673, 5844.064949608042, 9665.420074795535, 10051.346662466916, 10054.8491772622, 10198.0, 10321.690349289533, 10107.848382274125, 10320.019598138166, 10372.844407333745, 10535.946405359402, 10542.57829686804, 7791.337736292478, 7858.724944626911, 7942.761717148494, 7949.880751788844, 7951.085625153181, 8381.874271886049, 8495.447795893248, 8556.529390883561, 8574.09971952961, 8574.356923230658, 7353.227911069261, 7542.509736867086, 7652.961735191511, 7755.418343624138, 7957.204279572228, 7517.210692877388, 7578.810529736801, 7696.0, 7809.960950195213, 7820.960895195488, 6458.967705161444, 6563.803085907431, 6640.136782218474, 6650.20197576294, 6654.667266636746, 5193.272941788077, 5247.921281180862, 5325.813596524103, 5339.279197308314, 5361.571074313967, 4562.657800664897, 5186.325777648882, 5316.521513063843, 5325.387580428301, 5412.56699464034], "value": 4552.484311285823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.8683929600483, 335.06015626168596, 341.1182094286269, 342.3204938197677, 342.9950245779864, 5153.866149447125, 5242.475752424765, 5280.815171468999, 5320.281761962139, 5395.89208215836, 5261.500157485033, 5280.577553795697, 5294.1529355303155, 5299.443558426367, 5300.814471493499, 4160.294279345469, 4164.917121548389, 4176.3317869140865, 4194.97902510487, 4211.368294755795, 3964.9603503965022, 4002.8398864045403, 4194.406125672255, 4200.558941311149, 4213.894652633693, 4097.79511024449, 4126.463559737245, 4133.9173216535655, 4162.4598898407485, 4163.479565054368, 4124.1957818225455, 4133.2146892090705, 4137.54487006429, 4137.834486620532, 4146.150039241948, 3437.4843773433936, 3668.981655091734, 3691.3909204981146, 3696.685781708558, 3700.278445703089, 5069.949300506984, 5100.974495127538, 5133.6919784813035, 5162.148245539482, 5184.429712731597, 4677.158111539921, 4687.835925742583, 4699.224627936386, 4700.694454860423, 4716.457607375161, 5353.304070470814, 5468.0977638689565, 5522.116461366202, 5524.281843360378, 5535.778568857241, 3975.5428125765616, 3981.402789581557, 3988.561258261589, 4014.8394064237395, 4015.277250094982, 5758.165066065397, 5761.683107429089, 5787.1608616750755, 5812.0, 5819.156222347779, 3926.9018274542796, 4021.055052062763, 4047.696422768245, 4052.7365721228025, 4053.6488836475364, 4073.674106071507, 4090.2228576570355, 4094.897627559335, 4113.773742444194, 4114.629683328455, 4677.742724150136, 4687.765611719468, 4691.132140554008, 4702.482726900038, 4715.528447155326, 5533.253010843485, 5550.195221692913, 5559.388467268597, 5560.193771903132, 5567.0, 1352.7970804379422, 1408.9154650720989, 1410.4146779086768, 1410.75311820431, 1417.5038736442368, 884.5444596033049, 893.9061398553058, 909.6088681866728, 910.913463220993, 915.7115508614766, 4763.0235801661265, 4793.976030119897, 4820.276958456189, 4855.300644774371, 4870.6103511718975, 4988.90022199554, 5032.622553308516, 5085.389753229636, 5106.106431374495, 5108.514691104339, 4815.001774263711, 4816.662833601615, 4832.565069143794, 4850.854474365775, 5006.599472042228, 3019.855902309341, 3034.453798316324, 3042.83264420459, 3045.1473587395567, 3051.160930744019, 5936.643801371932, 5942.72231470236, 5952.166696662471, 5954.642721436728, 5963.701814909237, 5638.464345887216, 5768.4808367246305, 5826.271716035496, 5845.620034697731, 5872.0, 5906.616069955439, 5924.674142922095, 5931.169636250928, 5932.436418540232, 5940.227770389822, 5511.862203444946, 5605.383407825218, 5647.011772939637, 5666.886662266814, 5670.476637896261, 5616.971915140398, 5624.1563765433875, 5631.324241091095, 5649.039663257338, 5689.7439615218245, 5864.179014937827, 5898.262717160355, 5916.704164791657, 5959.344472108151, 5980.820575382745, 3737.2525494900583, 3878.96121038786, 4063.674906007453, 4064.6992962251798, 4092.9795351023054, 5646.560127167546, 5664.830055098354, 5757.251557297524, 5765.4811067004175, 5774.335951365647, 5465.715556844218, 5527.972360138174, 5539.556835453073, 5548.916766248429, 5563.610547261815, 5418.566514678738, 5552.58355623338, 5654.886902262014, 5655.179998900054, 5663.093904975184, 5507.5593952482905, 5516.310461192351, 5528.806491772769, 5536.169574563686, 5544.695041772741, 5369.147644062792, 5664.85837854057, 5666.0, 5677.403872593318, 5700.033488446479, 5515.518016892334, 5538.0, 5542.8337149885565, 5547.44525547442, 5553.222548843246], "value": 4202.866871671274, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.9248075192481, 753.111328632214, 790.4743345675126, 794.2534018023058, 794.9403794715398, 14695.26523673816, 14814.185219812905, 14868.107913525182, 15532.767008494882, 16624.085675287854, 14421.5673529794, 14596.416143354252, 14616.561503154895, 14623.0, 14650.0, 681.3459079283894, 806.7095845495617, 812.9187081291883, 824.0688022534528, 828.9668413263462, 820.7578764264526, 822.7326119011316, 823.0493779684474, 823.798169448486, 826.7519744076783, 860.2601762484259, 861.134559767436, 862.5471627395605, 862.8576284912982, 863.0161615758041, 711.5908352697194, 723.9565626062426, 726.8655298769745, 834.9039860416069, 861.8017855893148, 627.3381582430534, 628.22100595262, 632.4181752787447, 633.1168020611221, 633.3191818794768, 15341.232938353149, 15446.922765386102, 15450.845491545053, 15465.0, 15472.613184670361, 14511.492097776527, 14765.18791466469, 14874.925625371912, 14934.32795524204, 15198.164100974442, 13232.13991090576, 13347.065705400626, 13453.327333633377, 13615.31923403826, 13653.180809151483, 4475.59719625232, 4516.096780643885, 4523.050159466516, 4590.565774527185, 4782.976085119587, 80768.19231807666, 81282.59358703227, 82303.0, 83015.58492207501, 83437.58281208616, 11328.94335528317, 11607.59373421943, 11637.418129093512, 11736.119791015708, 12051.517939282507, 19218.13518391676, 19323.710144347846, 19383.612327753646, 19493.122809473607, 19537.511562211057, 8721.171488708562, 8877.511736854405, 8970.820583588422, 8991.775205619912, 9024.684136055206, 4761.595264402565, 4774.880627984328, 4828.565429111327, 4829.396325459317, 5076.898462030813, 3546.308469848355, 3637.399829028234, 3665.7617254878883, 3668.944965825515, 3669.9633003669624, 624.0639041437843, 629.6505439481132, 639.8496353356958, 640.4524131867187, 644.4361183964031, 596.8030549918517, 644.9484041276687, 664.1598378051768, 673.9730410783612, 676.9932300677028, 9083.863742043743, 9091.136342047495, 9101.40840845343, 9239.950781370671, 9314.115159059878, 608.6165715599144, 652.47475781995, 692.3675896581248, 699.0772180721399, 711.9394851437686, 4316.158349121891, 4482.350059241457, 4533.478649955297, 4555.567221113989, 4563.475200351935, 74045.0, 102338.0, 113351.0, 121198.0, 121526.0, 102660.0, 106279.46860265649, 107580.46209768901, 107821.46089269503, 108926.45536772265, 88188.0, 91755.0, 91842.54078729564, 93313.53343233376, 95873.9999999986, 8742.169493898069, 8786.121387861163, 8879.191387821937, 8885.289176865965, 9019.864702029343, 55120.72439637776, 55419.0, 55813.72093139508, 57638.0, 58001.41998580129, 80885.59557202176, 82714.0, 82850.0, 84790.57604711936, 84864.51354864711, 11976.640700778991, 12193.268403895794, 12212.145149839425, 12240.081993850676, 12778.808317875053, 12372.690682732644, 13445.798313025509, 13643.386047627682, 13725.519606814112, 13778.311084445939, 12244.142909996215, 12365.567205147776, 12483.74641923029, 12502.0, 12746.808797868225, 12828.422720977393, 12872.871271287542, 13013.089083764045, 13086.14940028895, 13140.934295328461, 12065.064210714412, 12152.21010634306, 12310.138290319592, 12456.688582785502, 12623.368831558202, 9303.488308143116, 9396.248300135836, 9469.763255918657, 9786.217102631916, 9975.750606234902, 8396.832063358821, 10097.062274996437, 10498.160147188359, 10803.189760768131, 11189.552417903193], "value": 7499.695355959879, "unit": "score"}], "name": "dromaeo_css", "value": 7203.987381817756, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 113.0, 109.0, 112.0, 111.0, 109.0, 112.0, 109.0, 109.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 130.0, 188.0, 126.0, 126.0, 151.0, 124.0, 156.0, 124.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 158.0, 160.0, 164.0, 162.0, 162.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 131.0, 75.0, 76.0, 75.0, 75.0, 102.0, 74.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 110.0, 86.0, 86.0, 85.0, 130.0, 85.0, 86.0, 129.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 65.0, 56.0, 57.0, 58.0, 57.0, 56.0, 56.0, 57.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 81.0, 81.0, 84.0, 80.0, 80.0, 84.0, 108.0, 80.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 120.0, 122.0, 131.0, 120.0, 121.0, 119.0, 121.0, 135.0, 129.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 162.0, 162.0, 157.0, 161.0, 163.0, 165.0, 166.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 63.0, 62.0, 63.0, 64.0, 62.0, 64.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1501.7, "alertThreshold": 2.0}]} 05:27:05 INFO - Return code: 0 05:27:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:05 ERROR - # TBPL SUCCESS # 05:27:05 INFO - Running post-action listener: _resource_record_post_action 05:27:05 INFO - ##### 05:27:05 INFO - ##### Finished run-tests step (success) 05:27:05 INFO - ##### 05:27:05 INFO - Running post-run listener: _resource_record_post_run 05:27:05 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 550629376; Read time: 0; Write time: 579364 05:27:05 INFO - TinderboxPrint: CPU usage
13.2% 05:27:05 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:27:05 INFO - TinderboxPrint: I/O write bytes / time
550,629,376 / 579,364 05:27:05 INFO - TinderboxPrint: CPU idle
8,258.8 (86.8%) 05:27:05 INFO - TinderboxPrint: CPU user
1,207.9 (12.7%) 05:27:05 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 243134464; Read time: 0; Write time: 281864 05:27:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 291864576; Read time: 0; Write time: 295636 05:27:06 INFO - Running post-run listener: _upload_blobber_files 05:27:06 INFO - Blob upload gear active. 05:27:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:06 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 05:27:06 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'] 05:27:06 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 05:27:06 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:07 INFO - (blobuploader) - INFO - Done attempting. 05:27:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:27:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:08 INFO - (blobuploader) - INFO - Done attempting. 05:27:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:12 INFO - (blobuploader) - INFO - Done attempting. 05:27:12 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:12 INFO - Return code: 0 05:27:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b01e2d43e38caa2eca003fd4f5db3a6872bcef924bc36302bc14b1895eada41111892cff95d5a051640674104712b7cf300f0eacf98bdae75f05947c7a7595f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad8ed756f61041e46c73ee2a5e1f16965423f33be1229194b9e96ac4d551a3091db4a66a322d6236f37d801976ce8238e2988a94adde49b978483cf2c9fda63c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d2ffb52622cd5ee95810d0b98398fd6db4fdc206501d397c956331f71086b8f621548290d03d1d694f2e577e4b02707f2b6ae81afc2e455154f2a769152f1c6"} 05:27:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:12 INFO - Contents: 05:27:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b01e2d43e38caa2eca003fd4f5db3a6872bcef924bc36302bc14b1895eada41111892cff95d5a051640674104712b7cf300f0eacf98bdae75f05947c7a7595f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad8ed756f61041e46c73ee2a5e1f16965423f33be1229194b9e96ac4d551a3091db4a66a322d6236f37d801976ce8238e2988a94adde49b978483cf2c9fda63c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d2ffb52622cd5ee95810d0b98398fd6db4fdc206501d397c956331f71086b8f621548290d03d1d694f2e577e4b02707f2b6ae81afc2e455154f2a769152f1c6"} 05:27:12 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:12 INFO - Copying logs to upload dir... 05:27:12 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.369084 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-04 05:27:11.944526) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 05:27:11.947920) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b01e2d43e38caa2eca003fd4f5db3a6872bcef924bc36302bc14b1895eada41111892cff95d5a051640674104712b7cf300f0eacf98bdae75f05947c7a7595f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad8ed756f61041e46c73ee2a5e1f16965423f33be1229194b9e96ac4d551a3091db4a66a322d6236f37d801976ce8238e2988a94adde49b978483cf2c9fda63c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d2ffb52622cd5ee95810d0b98398fd6db4fdc206501d397c956331f71086b8f621548290d03d1d694f2e577e4b02707f2b6ae81afc2e455154f2a769152f1c6"} build_url:https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011431 build_url: 'https://queue.taskcluster.net/v1/task/AtD6E9_JT9W_0gd1_lOi2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b01e2d43e38caa2eca003fd4f5db3a6872bcef924bc36302bc14b1895eada41111892cff95d5a051640674104712b7cf300f0eacf98bdae75f05947c7a7595f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad8ed756f61041e46c73ee2a5e1f16965423f33be1229194b9e96ac4d551a3091db4a66a322d6236f37d801976ce8238e2988a94adde49b978483cf2c9fda63c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d2ffb52622cd5ee95810d0b98398fd6db4fdc206501d397c956331f71086b8f621548290d03d1d694f2e577e4b02707f2b6ae81afc2e455154f2a769152f1c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 05:27:11.973820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:27:11.974185) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465039702.16056-1196253545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 05:27:12.058602) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 05:27:12.058983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 05:27:12.059288) ========= ========= Total master_lag: 0.16 =========