builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1465248860.11 results: success (0) buildid: 20160606131227 builduid: e0f66f89dcb54b798a51ac463e3f1034 revision: 396b577b98e64fe95223cfce095f84fe0a67da01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.109400) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.110735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.111303) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.146977) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.147276) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 14:34:20-- 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% 222M=0s 2016-06-06 14:34:20 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.289173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.289524) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018998 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.346719) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:20.347360) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 396b577b98e64fe95223cfce095f84fe0a67da01 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 396b577b98e64fe95223cfce095f84fe0a67da01 --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=20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 14:34:20,468 truncating revision to first 12 chars 2016-06-06 14:34:20,468 Setting DEBUG logging. 2016-06-06 14:34:20,468 attempt 1/10 2016-06-06 14:34:20,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/396b577b98e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 14:34:20,807 unpacking tar archive at: mozilla-central-396b577b98e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.676621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:21.038741) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:21.039096) ========= script_repo_revision: 396b577b98e64fe95223cfce095f84fe0a67da01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:21.039624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:21.039960) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:34:21.050755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-06 14:34:21.051103) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:34:21 INFO - MultiFileLogger online at 20160606 14:34:21 in /builds/slave/test 14:34:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:34:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:21 INFO - {'append_to_log': False, 14:34:21 INFO - 'base_work_dir': '/builds/slave/test', 14:34:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:34:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:21 INFO - 'branch': 'Firefox-Non-PGO', 14:34:21 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:21 INFO - 'config_files': ('talos/linux_config.py',), 14:34:21 INFO - 'default_actions': ('clobber', 14:34:21 INFO - 'read-buildbot-config', 14:34:21 INFO - 'download-and-extract', 14:34:21 INFO - 'populate-webroot', 14:34:21 INFO - 'create-virtualenv', 14:34:21 INFO - 'install', 14:34:21 INFO - 'run-tests'), 14:34:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:21 INFO - 'download_minidump_stackwalk': True, 14:34:21 INFO - 'download_symbols': 'ondemand', 14:34:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:21 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:21 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:21 INFO - 'installer_path': 'installer.exe', 14:34:21 INFO - 'log_level': 'info', 14:34:21 INFO - 'log_name': 'talos', 14:34:21 INFO - 'log_to_console': True, 14:34:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:34:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:34:21 INFO - 'opt_config_files': (), 14:34:21 INFO - 'pip_index': False, 14:34:21 INFO - 'sps_profile': False, 14:34:21 INFO - 'sps_profile_interval': 0, 14:34:21 INFO - 'suite': 'dromaeojs-e10s', 14:34:21 INFO - 'system_bits': '32', 14:34:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:21 INFO - 'title': 'talos-linux64-ix-015', 14:34:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:21 INFO - 'use_talos_json': True, 14:34:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:21 INFO - 'work_dir': 'build'} 14:34:21 INFO - ##### 14:34:21 INFO - ##### Running clobber step. 14:34:21 INFO - ##### 14:34:21 INFO - Running pre-action listener: _resource_record_pre_action 14:34:21 INFO - Running main action method: clobber 14:34:21 INFO - rmtree: /builds/slave/test/build 14:34:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:22 INFO - Running post-action listener: _resource_record_post_action 14:34:22 INFO - ##### 14:34:22 INFO - ##### Finished clobber step (success) 14:34:22 INFO - ##### 14:34:22 INFO - ##### 14:34:22 INFO - ##### Running read-buildbot-config step. 14:34:22 INFO - ##### 14:34:22 INFO - Running pre-action listener: _resource_record_pre_action 14:34:22 INFO - Running main action method: read_buildbot_config 14:34:22 INFO - Using buildbot properties: 14:34:22 INFO - { 14:34:22 INFO - "project": "", 14:34:22 INFO - "product": "firefox", 14:34:22 INFO - "script_repo_revision": "production", 14:34:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:34:22 INFO - "repository": "", 14:34:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:34:22 INFO - "buildid": "20160606131227", 14:34:22 INFO - "pgo_build": "False", 14:34:22 INFO - "basedir": "/builds/slave/test", 14:34:22 INFO - "buildnumber": 368, 14:34:22 INFO - "slavename": "talos-linux64-ix-015", 14:34:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:34:22 INFO - "platform": "ubuntu64_hw", 14:34:22 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:34:22 INFO - "branch": "mozilla-central", 14:34:22 INFO - "repo_path": "mozilla-central", 14:34:22 INFO - "revision": "396b577b98e64fe95223cfce095f84fe0a67da01", 14:34:22 INFO - "stage_platform": "linux64", 14:34:22 INFO - "builduid": "e0f66f89dcb54b798a51ac463e3f1034", 14:34:22 INFO - "slavebuilddir": "test" 14:34:22 INFO - } 14:34:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:34:22 INFO - Running post-action listener: _resource_record_post_action 14:34:22 INFO - ##### 14:34:22 INFO - ##### Finished read-buildbot-config step (success) 14:34:22 INFO - ##### 14:34:22 INFO - ##### 14:34:22 INFO - ##### Running download-and-extract step. 14:34:22 INFO - ##### 14:34:22 INFO - Running pre-action listener: _resource_record_pre_action 14:34:22 INFO - Running main action method: download_and_extract 14:34:22 INFO - mkdir: /builds/slave/test/build/tests 14:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:22 INFO - https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:34:25 INFO - Downloaded 1361 bytes. 14:34:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:34:25 INFO - Using the following test package requirements: 14:34:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:34:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:34:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:34:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'jsshell-linux-x86_64.zip'], 14:34:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:34:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:34:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:34:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:34:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:34:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:34:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:34:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:25 INFO - https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:34:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:34:27 INFO - Downloaded 22870975 bytes. 14:34:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:34:28 INFO - Return code: 0 14:34:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:28 INFO - https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:34:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:34:30 INFO - Downloaded 22870975 bytes. 14:34:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:34:32 INFO - Return code: 0 14:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:32 INFO - https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:34:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:34:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:34:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:34:33 INFO - Downloaded 10833369 bytes. 14:34:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:34:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:34:33 INFO - Return code: 0 14:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:33 INFO - https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:34:34 INFO - Downloaded 55196290 bytes. 14:34:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:34 INFO - mkdir: /builds/slave/test/properties 14:34:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:34:34 INFO - Writing to file /builds/slave/test/properties/build_url 14:34:34 INFO - Contents: 14:34:34 INFO - build_url:https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:34:35 INFO - Running post-action listener: _resource_record_post_action 14:34:35 INFO - Running post-action listener: set_extra_try_arguments 14:34:35 INFO - ##### 14:34:35 INFO - ##### Finished download-and-extract step (success) 14:34:35 INFO - ##### 14:34:35 INFO - ##### 14:34:35 INFO - ##### Running populate-webroot step. 14:34:35 INFO - ##### 14:34:35 INFO - Running pre-action listener: _resource_record_pre_action 14:34:35 INFO - Running main action method: populate_webroot 14:34:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:35 INFO - '--tppagecycles', 14:34:35 INFO - '7'], 14:34:35 INFO - 'tests': ['tsvgm']}}, 14:34:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:34:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:34:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:34:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['damp', 'tps']}, 14:34:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'tests': ['damp', 'tps']}, 14:34:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['dromaeo_dom']}, 14:34:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['a11yr', 14:34:35 INFO - 'ts_paint', 14:34:35 INFO - 'tpaint', 14:34:35 INFO - 'sessionrestore', 14:34:35 INFO - 'sessionrestore_no_auto_restore', 14:34:35 INFO - 'tabpaint']}, 14:34:35 INFO - 'other-e10s': {'tests': ['a11yr', 14:34:35 INFO - 'ts_paint', 14:34:35 INFO - 'tpaint', 14:34:35 INFO - 'sessionrestore', 14:34:35 INFO - 'sessionrestore_no_auto_restore', 14:34:35 INFO - 'tabpaint']}, 14:34:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:34:35 INFO - 'ts_paint', 14:34:35 INFO - 'tpaint', 14:34:35 INFO - 'sessionrestore', 14:34:35 INFO - 'sessionrestore_no_auto_restore', 14:34:35 INFO - 'tabpaint']}, 14:34:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:34:35 INFO - 'ts_paint', 14:34:35 INFO - 'tpaint', 14:34:35 INFO - 'sessionrestore', 14:34:35 INFO - 'sessionrestore_no_auto_restore', 14:34:35 INFO - 'tabpaint']}, 14:34:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['a11yr', 14:34:35 INFO - 'ts_paint', 14:34:35 INFO - 'tpaint', 14:34:35 INFO - 'sessionrestore', 14:34:35 INFO - 'sessionrestore_no_auto_restore', 14:34:35 INFO - 'tabpaint']}, 14:34:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['a11yr', 14:34:35 INFO - 'ts_paint', 14:34:35 INFO - 'tpaint', 14:34:35 INFO - 'sessionrestore', 14:34:35 INFO - 'sessionrestore_no_auto_restore', 14:34:35 INFO - 'tabpaint']}, 14:34:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['tsvgx', 14:34:35 INFO - 'tsvgr_opacity', 14:34:35 INFO - 'tart', 14:34:35 INFO - 'tscrollx', 14:34:35 INFO - 'cart']}, 14:34:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:34:35 INFO - 'tsvgr_opacity', 14:34:35 INFO - 'tart', 14:34:35 INFO - 'tscrollx', 14:34:35 INFO - 'cart']}, 14:34:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'talos_options': ['--disable-e10s'], 14:34:35 INFO - 'tests': ['tp5o']}, 14:34:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'tests': ['tp5o']}, 14:34:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'talos_options': ['--disable-e10s', 14:34:35 INFO - '--xperf_path', 14:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:35 INFO - 'tests': ['tp5n']}, 14:34:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:35 INFO - 'talos_options': ['--xperf_path', 14:34:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:35 INFO - 'tests': ['tp5n']}}, 14:34:35 INFO - 'talos.zip': {'path': '', 14:34:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:35 INFO - Running post-action listener: _resource_record_post_action 14:34:35 INFO - ##### 14:34:35 INFO - ##### Finished populate-webroot step (success) 14:34:35 INFO - ##### 14:34:35 INFO - ##### 14:34:35 INFO - ##### Running create-virtualenv step. 14:34:35 INFO - ##### 14:34:35 INFO - Running pre-action listener: _resource_record_pre_action 14:34:35 INFO - Running main action method: create_virtualenv 14:34:35 INFO - Creating virtualenv /builds/slave/test/build/venv 14:34:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:34:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:34:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:35 INFO - Using real prefix '/usr' 14:34:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:34:36 INFO - Installing distribute.............................................................................................................................................................................................done. 14:34:38 INFO - Installing pip.................done. 14:34:38 INFO - Return code: 0 14:34:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:38 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:34:38 INFO - Using env: {'DISPLAY': ':0', 14:34:38 INFO - 'HOME': '/home/cltbld', 14:34:38 INFO - 'LANG': 'en_US.UTF-8', 14:34:38 INFO - 'LANGUAGE': 'en_US:en', 14:34:38 INFO - 'LOGNAME': 'cltbld', 14:34:38 INFO - 'MAIL': '/var/mail/cltbld', 14:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:38 INFO - 'MOZ_NO_REMOTE': '1', 14:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:38 INFO - 'NO_EM_RESTART': '1', 14:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:38 INFO - 'PWD': '/builds/slave/test', 14:34:38 INFO - 'SHELL': '/bin/bash', 14:34:38 INFO - 'SHLVL': '1', 14:34:38 INFO - 'TERM': 'linux', 14:34:38 INFO - 'TMOUT': '86400', 14:34:38 INFO - 'USER': 'cltbld', 14:34:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:38 INFO - '_': '/tools/buildbot/bin/python'} 14:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:34:38 INFO - Cleaning up... 14:34:38 INFO - Return code: 0 14:34:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:38 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:34:38 INFO - Using env: {'DISPLAY': ':0', 14:34:38 INFO - 'HOME': '/home/cltbld', 14:34:38 INFO - 'LANG': 'en_US.UTF-8', 14:34:38 INFO - 'LANGUAGE': 'en_US:en', 14:34:38 INFO - 'LOGNAME': 'cltbld', 14:34:38 INFO - 'MAIL': '/var/mail/cltbld', 14:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:38 INFO - 'MOZ_NO_REMOTE': '1', 14:34:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:38 INFO - 'NO_EM_RESTART': '1', 14:34:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:38 INFO - 'PWD': '/builds/slave/test', 14:34:38 INFO - 'SHELL': '/bin/bash', 14:34:38 INFO - 'SHLVL': '1', 14:34:38 INFO - 'TERM': 'linux', 14:34:38 INFO - 'TMOUT': '86400', 14:34:38 INFO - 'USER': 'cltbld', 14:34:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:38 INFO - '_': '/tools/buildbot/bin/python'} 14:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:38 INFO - Downloading/unpacking psutil>=3.1.1 14:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:34:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:40 INFO - Installing collected packages: psutil 14:34:40 INFO - Running setup.py install for psutil 14:34:40 INFO - building 'psutil._psutil_linux' extension 14:34:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:34:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:34:40 INFO - building 'psutil._psutil_posix' extension 14:34:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:34:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:34:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:41 INFO - Successfully installed psutil 14:34:41 INFO - Cleaning up... 14:34:41 INFO - Return code: 0 14:34:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:41 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:34:41 INFO - Using env: {'DISPLAY': ':0', 14:34:41 INFO - 'HOME': '/home/cltbld', 14:34:41 INFO - 'LANG': 'en_US.UTF-8', 14:34:41 INFO - 'LANGUAGE': 'en_US:en', 14:34:41 INFO - 'LOGNAME': 'cltbld', 14:34:41 INFO - 'MAIL': '/var/mail/cltbld', 14:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:41 INFO - 'MOZ_NO_REMOTE': '1', 14:34:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:41 INFO - 'NO_EM_RESTART': '1', 14:34:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:41 INFO - 'PWD': '/builds/slave/test', 14:34:41 INFO - 'SHELL': '/bin/bash', 14:34:41 INFO - 'SHLVL': '1', 14:34:41 INFO - 'TERM': 'linux', 14:34:41 INFO - 'TMOUT': '86400', 14:34:41 INFO - 'USER': 'cltbld', 14:34:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:41 INFO - '_': '/tools/buildbot/bin/python'} 14:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:34:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:34:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:34:43 INFO - Installing collected packages: mozsystemmonitor 14:34:43 INFO - Running setup.py install for mozsystemmonitor 14:34:43 INFO - Successfully installed mozsystemmonitor 14:34:43 INFO - Cleaning up... 14:34:43 INFO - Return code: 0 14:34:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:43 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:34:43 INFO - Using env: {'DISPLAY': ':0', 14:34:43 INFO - 'HOME': '/home/cltbld', 14:34:43 INFO - 'LANG': 'en_US.UTF-8', 14:34:43 INFO - 'LANGUAGE': 'en_US:en', 14:34:43 INFO - 'LOGNAME': 'cltbld', 14:34:43 INFO - 'MAIL': '/var/mail/cltbld', 14:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:43 INFO - 'MOZ_NO_REMOTE': '1', 14:34:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:43 INFO - 'NO_EM_RESTART': '1', 14:34:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:43 INFO - 'PWD': '/builds/slave/test', 14:34:43 INFO - 'SHELL': '/bin/bash', 14:34:43 INFO - 'SHLVL': '1', 14:34:43 INFO - 'TERM': 'linux', 14:34:43 INFO - 'TMOUT': '86400', 14:34:43 INFO - 'USER': 'cltbld', 14:34:43 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:43 INFO - '_': '/tools/buildbot/bin/python'} 14:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:43 INFO - Downloading/unpacking jsonschema==2.5.1 14:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:34:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:45 INFO - Downloading functools32-3.2.3-2.tar.gz 14:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:34:45 INFO - warning: no files found matching '*.txt' 14:34:45 INFO - no previously-included directories found matching 'build' 14:34:45 INFO - no previously-included directories found matching 'dist' 14:34:45 INFO - no previously-included directories found matching '.git*' 14:34:45 INFO - Installing collected packages: jsonschema, functools32 14:34:45 INFO - Running setup.py install for functools32 14:34:46 INFO - warning: no files found matching '*.txt' 14:34:46 INFO - no previously-included directories found matching 'build' 14:34:46 INFO - no previously-included directories found matching 'dist' 14:34:46 INFO - no previously-included directories found matching '.git*' 14:34:46 INFO - Successfully installed jsonschema functools32 14:34:46 INFO - Cleaning up... 14:34:46 INFO - Return code: 0 14:34:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:46 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:34:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:34:46 INFO - Using env: {'DISPLAY': ':0', 14:34:46 INFO - 'HOME': '/home/cltbld', 14:34:46 INFO - 'LANG': 'en_US.UTF-8', 14:34:46 INFO - 'LANGUAGE': 'en_US:en', 14:34:46 INFO - 'LOGNAME': 'cltbld', 14:34:46 INFO - 'MAIL': '/var/mail/cltbld', 14:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:46 INFO - 'MOZ_NO_REMOTE': '1', 14:34:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:46 INFO - 'NO_EM_RESTART': '1', 14:34:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:46 INFO - 'PWD': '/builds/slave/test', 14:34:46 INFO - 'SHELL': '/bin/bash', 14:34:46 INFO - 'SHLVL': '1', 14:34:46 INFO - 'TERM': 'linux', 14:34:46 INFO - 'TMOUT': '86400', 14:34:46 INFO - 'USER': 'cltbld', 14:34:46 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:46 INFO - '_': '/tools/buildbot/bin/python'} 14:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:48 INFO - Downloading blobuploader-1.2.4.tar.gz 14:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:34:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:48 INFO - Downloading docopt-0.6.1.tar.gz 14:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:34:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:34:48 INFO - Running setup.py install for blobuploader 14:34:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:34:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:34:49 INFO - Running setup.py install for requests 14:34:49 INFO - Running setup.py install for docopt 14:34:49 INFO - Successfully installed blobuploader requests docopt 14:34:49 INFO - Cleaning up... 14:34:49 INFO - Return code: 0 14:34:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:49 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:34:49 INFO - Using env: {'DISPLAY': ':0', 14:34:49 INFO - 'HOME': '/home/cltbld', 14:34:49 INFO - 'LANG': 'en_US.UTF-8', 14:34:49 INFO - 'LANGUAGE': 'en_US:en', 14:34:49 INFO - 'LOGNAME': 'cltbld', 14:34:49 INFO - 'MAIL': '/var/mail/cltbld', 14:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:49 INFO - 'MOZ_NO_REMOTE': '1', 14:34:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:49 INFO - 'NO_EM_RESTART': '1', 14:34:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:49 INFO - 'PWD': '/builds/slave/test', 14:34:49 INFO - 'SHELL': '/bin/bash', 14:34:49 INFO - 'SHLVL': '1', 14:34:49 INFO - 'TERM': 'linux', 14:34:49 INFO - 'TMOUT': '86400', 14:34:49 INFO - 'USER': 'cltbld', 14:34:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:49 INFO - '_': '/tools/buildbot/bin/python'} 14:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:49 INFO - Running setup.py (path:/tmp/pip-Nt1B9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:49 INFO - Running setup.py (path:/tmp/pip-dqcuZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:49 INFO - Running setup.py (path:/tmp/pip-a4ycYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:49 INFO - Running setup.py (path:/tmp/pip-pmptdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:50 INFO - Running setup.py (path:/tmp/pip-YaH9CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:50 INFO - Running setup.py (path:/tmp/pip-ZvOHg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:50 INFO - Running setup.py (path:/tmp/pip-9sdb7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:50 INFO - Running setup.py (path:/tmp/pip-4vgpqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:50 INFO - Running setup.py (path:/tmp/pip-LuhG4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:50 INFO - Running setup.py (path:/tmp/pip-JEUJxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:50 INFO - Running setup.py (path:/tmp/pip-D5AIcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:50 INFO - Running setup.py (path:/tmp/pip-S4I8Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:50 INFO - Running setup.py (path:/tmp/pip-Ajanof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:50 INFO - Running setup.py (path:/tmp/pip-7Pdv3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:50 INFO - Running setup.py (path:/tmp/pip-8Yx14z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:50 INFO - Running setup.py (path:/tmp/pip-HFQ9mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:50 INFO - Running setup.py (path:/tmp/pip-1c9y7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:34:50 INFO - Running setup.py install for manifestparser 14:34:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Running setup.py install for mozcrash 14:34:51 INFO - Running setup.py install for mozdebug 14:34:51 INFO - Running setup.py install for mozdevice 14:34:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Running setup.py install for mozfile 14:34:51 INFO - Running setup.py install for mozhttpd 14:34:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Running setup.py install for mozinfo 14:34:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Running setup.py install for mozInstall 14:34:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Running setup.py install for mozleak 14:34:51 INFO - Running setup.py install for mozlog 14:34:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:34:51 INFO - Running setup.py install for moznetwork 14:34:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:34:52 INFO - Running setup.py install for mozprocess 14:34:52 INFO - Running setup.py install for mozprofile 14:34:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:34:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:34:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:34:52 INFO - Running setup.py install for mozrunner 14:34:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:34:52 INFO - Running setup.py install for mozscreenshot 14:34:52 INFO - Running setup.py install for moztest 14:34:52 INFO - Running setup.py install for mozversion 14:34:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:34:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:34:52 INFO - Cleaning up... 14:34:52 INFO - Return code: 0 14:34:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:52 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:34:52 INFO - Using env: {'DISPLAY': ':0', 14:34:52 INFO - 'HOME': '/home/cltbld', 14:34:52 INFO - 'LANG': 'en_US.UTF-8', 14:34:52 INFO - 'LANGUAGE': 'en_US:en', 14:34:52 INFO - 'LOGNAME': 'cltbld', 14:34:52 INFO - 'MAIL': '/var/mail/cltbld', 14:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:52 INFO - 'MOZ_NO_REMOTE': '1', 14:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:52 INFO - 'NO_EM_RESTART': '1', 14:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:52 INFO - 'PWD': '/builds/slave/test', 14:34:52 INFO - 'SHELL': '/bin/bash', 14:34:52 INFO - 'SHLVL': '1', 14:34:52 INFO - 'TERM': 'linux', 14:34:52 INFO - 'TMOUT': '86400', 14:34:52 INFO - 'USER': 'cltbld', 14:34:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:52 INFO - '_': '/tools/buildbot/bin/python'} 14:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:52 INFO - Running setup.py (path:/tmp/pip-y0LIw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:53 INFO - Running setup.py (path:/tmp/pip-mvSOxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:53 INFO - Running setup.py (path:/tmp/pip-1WzRJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:53 INFO - Running setup.py (path:/tmp/pip-iAkWK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:53 INFO - Running setup.py (path:/tmp/pip-EU3Fex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:53 INFO - Running setup.py (path:/tmp/pip-IK5w37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:53 INFO - Running setup.py (path:/tmp/pip-LNQJNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:53 INFO - Running setup.py (path:/tmp/pip-gvuhOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:53 INFO - Running setup.py (path:/tmp/pip-BPIMhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:53 INFO - Running setup.py (path:/tmp/pip-5vwcKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:53 INFO - Running setup.py (path:/tmp/pip-F5k79v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:53 INFO - Running setup.py (path:/tmp/pip-mTlhu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:53 INFO - Running setup.py (path:/tmp/pip-g_G8Cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:53 INFO - Running setup.py (path:/tmp/pip-jlNLUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:53 INFO - Running setup.py (path:/tmp/pip-6fnPJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:54 INFO - Running setup.py (path:/tmp/pip-7OZZgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:54 INFO - Running setup.py (path:/tmp/pip-Ttlpuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:34:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:34:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:56 INFO - Downloading blessings-1.6.tar.gz 14:34:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:34:56 INFO - Installing collected packages: blessings 14:34:56 INFO - Running setup.py install for blessings 14:34:56 INFO - Successfully installed blessings 14:34:56 INFO - Cleaning up... 14:34:56 INFO - Return code: 0 14:34:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:34:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:56 INFO - Reading from file tmpfile_stdout 14:34:56 INFO - Current package versions: 14:34:56 INFO - argparse == 1.2.1 14:34:56 INFO - blessings == 1.6 14:34:56 INFO - blobuploader == 1.2.4 14:34:56 INFO - docopt == 0.6.1 14:34:56 INFO - functools32 == 3.2.3-2 14:34:56 INFO - jsonschema == 2.5.1 14:34:56 INFO - manifestparser == 1.1 14:34:56 INFO - mozInstall == 1.12 14:34:56 INFO - mozcrash == 0.17 14:34:56 INFO - mozdebug == 0.1 14:34:56 INFO - mozdevice == 0.48 14:34:56 INFO - mozfile == 1.2 14:34:56 INFO - mozhttpd == 0.7 14:34:56 INFO - mozinfo == 0.9 14:34:56 INFO - mozleak == 0.1 14:34:56 INFO - mozlog == 3.2 14:34:56 INFO - moznetwork == 0.27 14:34:56 INFO - mozprocess == 0.22 14:34:56 INFO - mozprofile == 0.28 14:34:56 INFO - mozrunner == 6.11 14:34:56 INFO - mozscreenshot == 0.1 14:34:56 INFO - mozsystemmonitor == 0.3 14:34:56 INFO - moztest == 0.7 14:34:56 INFO - mozversion == 1.4 14:34:56 INFO - psutil == 3.1.1 14:34:56 INFO - requests == 1.2.3 14:34:56 INFO - wsgiref == 0.1.2 14:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:56 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:34:56 INFO - Using env: {'DISPLAY': ':0', 14:34:56 INFO - 'HOME': '/home/cltbld', 14:34:56 INFO - 'LANG': 'en_US.UTF-8', 14:34:56 INFO - 'LANGUAGE': 'en_US:en', 14:34:56 INFO - 'LOGNAME': 'cltbld', 14:34:56 INFO - 'MAIL': '/var/mail/cltbld', 14:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:56 INFO - 'MOZ_NO_REMOTE': '1', 14:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:56 INFO - 'NO_EM_RESTART': '1', 14:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:56 INFO - 'PWD': '/builds/slave/test', 14:34:56 INFO - 'SHELL': '/bin/bash', 14:34:56 INFO - 'SHLVL': '1', 14:34:56 INFO - 'TERM': 'linux', 14:34:56 INFO - 'TMOUT': '86400', 14:34:56 INFO - 'USER': 'cltbld', 14:34:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:56 INFO - '_': '/tools/buildbot/bin/python'} 14:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:34:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:34:56 INFO - Cleaning up... 14:34:56 INFO - Return code: 0 14:34:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:56 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:34:56 INFO - Using env: {'DISPLAY': ':0', 14:34:56 INFO - 'HOME': '/home/cltbld', 14:34:56 INFO - 'LANG': 'en_US.UTF-8', 14:34:56 INFO - 'LANGUAGE': 'en_US:en', 14:34:56 INFO - 'LOGNAME': 'cltbld', 14:34:56 INFO - 'MAIL': '/var/mail/cltbld', 14:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:56 INFO - 'MOZ_NO_REMOTE': '1', 14:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:56 INFO - 'NO_EM_RESTART': '1', 14:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:56 INFO - 'PWD': '/builds/slave/test', 14:34:56 INFO - 'SHELL': '/bin/bash', 14:34:56 INFO - 'SHLVL': '1', 14:34:56 INFO - 'TERM': 'linux', 14:34:56 INFO - 'TMOUT': '86400', 14:34:56 INFO - 'USER': 'cltbld', 14:34:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:56 INFO - '_': '/tools/buildbot/bin/python'} 14:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:34:57 INFO - Cleaning up... 14:34:57 INFO - Return code: 0 14:34:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:57 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 0x7f4e9720df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c7b350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:34:57 INFO - Using env: {'DISPLAY': ':0', 14:34:57 INFO - 'HOME': '/home/cltbld', 14:34:57 INFO - 'LANG': 'en_US.UTF-8', 14:34:57 INFO - 'LANGUAGE': 'en_US:en', 14:34:57 INFO - 'LOGNAME': 'cltbld', 14:34:57 INFO - 'MAIL': '/var/mail/cltbld', 14:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:57 INFO - 'MOZ_NO_REMOTE': '1', 14:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:34:57 INFO - 'NO_EM_RESTART': '1', 14:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:57 INFO - 'PWD': '/builds/slave/test', 14:34:57 INFO - 'SHELL': '/bin/bash', 14:34:57 INFO - 'SHLVL': '1', 14:34:57 INFO - 'TERM': 'linux', 14:34:57 INFO - 'TMOUT': '86400', 14:34:57 INFO - 'USER': 'cltbld', 14:34:57 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:57 INFO - '_': '/tools/buildbot/bin/python'} 14:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:57 INFO - Downloading/unpacking flake8 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:34:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:34:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:34:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:34:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:34:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:34:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:34:59 INFO - no previously-included directories found matching 'docs/_build' 14:34:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:34:59 INFO - Running setup.py install for pep8 14:35:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:35:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:35:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:35:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:35:00 INFO - no previously-included directories found matching 'docs/_build' 14:35:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:35:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:35:00 INFO - Cleaning up... 14:35:00 INFO - Return code: 0 14:35:00 INFO - Running post-action listener: _resource_record_post_action 14:35:00 INFO - Running post-action listener: _start_resource_monitoring 14:35:00 INFO - Starting resource monitoring. 14:35:00 INFO - ##### 14:35:00 INFO - ##### Finished create-virtualenv step (success) 14:35:00 INFO - ##### 14:35:00 INFO - ##### 14:35:00 INFO - ##### Running install step. 14:35:00 INFO - ##### 14:35:00 INFO - Running pre-action listener: _resource_record_pre_action 14:35:00 INFO - Running main action method: install 14:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:00 INFO - Reading from file tmpfile_stdout 14:35:00 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:00 INFO - Reading from file tmpfile_stdout 14:35:00 INFO - Output received: 14:35:00 INFO - Usage: mozinstall [options] installer 14:35:00 INFO - Options: 14:35:00 INFO - -h, --help show this help message and exit 14:35:00 INFO - -d DEST, --destination=DEST 14:35:00 INFO - Directory to install application into. [default: 14:35:00 INFO - "/builds/slave/test"] 14:35:00 INFO - --app=APP Application being installed. [default: firefox] 14:35:00 INFO - mkdir: /builds/slave/test/build/application 14:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:35:16 INFO - Reading from file tmpfile_stdout 14:35:16 INFO - Output received: 14:35:16 INFO - /builds/slave/test/build/application/firefox/firefox 14:35:16 INFO - Running post-action listener: _resource_record_post_action 14:35:16 INFO - ##### 14:35:16 INFO - ##### Finished install step (success) 14:35:16 INFO - ##### 14:35:16 INFO - ##### 14:35:16 INFO - ##### Running run-tests step. 14:35:16 INFO - ##### 14:35:16 INFO - Running pre-action listener: _resource_record_pre_action 14:35:16 INFO - Running main action method: run_tests 14:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:35:16 INFO - Python 2.7.3 14:35:16 INFO - Return code: 0 14:35:16 INFO - grabbing minidump binary from tooltool 14:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:16 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 0x1d0a1c0>, '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 0x1d0b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:35:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:35:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:35:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:35:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:16 INFO - Return code: 0 14:35:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:35:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:35:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:35:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:35:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:35:17 INFO - Return code: 0 14:35:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:35:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:35:17 INFO - Using env: {'DISPLAY': ':0', 14:35:17 INFO - 'HOME': '/home/cltbld', 14:35:17 INFO - 'LANG': 'en_US.UTF-8', 14:35:17 INFO - 'LANGUAGE': 'en_US:en', 14:35:17 INFO - 'LOGNAME': 'cltbld', 14:35:17 INFO - 'MAIL': '/var/mail/cltbld', 14:35:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:35:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:17 INFO - 'MOZ_NO_REMOTE': '1', 14:35:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:35:17 INFO - 'NO_EM_RESTART': '1', 14:35:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:17 INFO - 'PWD': '/builds/slave/test', 14:35:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:35:17 INFO - 'SHELL': '/bin/bash', 14:35:17 INFO - 'SHLVL': '1', 14:35:17 INFO - 'TERM': 'linux', 14:35:17 INFO - 'TMOUT': '86400', 14:35:17 INFO - 'USER': 'cltbld', 14:35:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478', 14:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:17 INFO - '_': '/tools/buildbot/bin/python'} 14:35:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:35:17 INFO - mozversion application_buildid: 20160606131227 14:35:17 INFO - mozversion application_changeset: 396b577b98e64fe95223cfce095f84fe0a67da01 14:35:17 INFO - mozversion application_display_name: Nightly 14:35:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:17 INFO - mozversion application_name: Firefox 14:35:17 INFO - mozversion application_remotingname: firefox 14:35:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:35:17 INFO - mozversion application_vendor: Mozilla 14:35:17 INFO - mozversion application_version: 50.0a1 14:35:17 INFO - mozversion platform_buildid: 20160606131227 14:35:17 INFO - mozversion platform_changeset: 396b577b98e64fe95223cfce095f84fe0a67da01 14:35:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:35:17 INFO - mozversion platform_version: 50.0a1 14:35:17 INFO - using testdate: 1465248917 14:35:17 INFO - actual date: 1465248917 14:35:17 INFO - starting webserver on 'localhost:57077' 14:35:17 INFO - SUITE-START | Running 2 tests 14:35:17 INFO - TEST-START | dromaeo_css 14:35:17 INFO - operating with platform_type : linux_ 14:35:17 INFO - Initialising browser for dromaeo_css test... 14:35:17 INFO - TEST-INFO | started process 2198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphRC_eQ/profile http://localhost:57077/getInfo.html) 14:35:22 INFO - PROCESS | 2198 | __metrics Screen width/height:1600/1200 14:35:22 INFO - PROCESS | 2198 | colorDepth:24 14:35:22 INFO - PROCESS | 2198 | Browser inner width/height: 1024/697 14:35:22 INFO - PROCESS | 2198 | __metrics 14:35:23 ERROR - PROCESS | 2198 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 14:35:24 INFO - TEST-INFO | 2198: exit 0 14:35:24 INFO - Browser initialized. 14:35:24 INFO - Running cycle 1/1 for dromaeo_css test... 14:35:24 INFO - TEST-INFO | started process 2315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphRC_eQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:36 INFO - PROCESS | 2315 | RSS: Main: 168169472 14:35:36 INFO - PROCESS | 2315 | 14:36:25 INFO - PROCESS | 2315 | 1465248985590 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:38:36 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57077/tests/dromaeo/cssquery-ext.html) 14:38:37 INFO - PROCESS | 2315 | RSS: Main: 170954752 14:38:37 INFO - PROCESS | 2315 | 14:41:40 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57077/tests/dromaeo/cssquery-ext.html (next: http://localhost:57077/tests/dromaeo/cssquery-jquery.html) 14:41:40 INFO - PROCESS | 2315 | RSS: Main: 170037248 14:41:40 INFO - PROCESS | 2315 | 14:44:42 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57077/tests/dromaeo/cssquery-mootools.html) 14:44:43 INFO - PROCESS | 2315 | RSS: Main: 171196416 14:44:43 INFO - PROCESS | 2315 | 14:47:45 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57077/tests/dromaeo/cssquery-prototype.html) 14:47:45 INFO - PROCESS | 2315 | RSS: Main: 168927232 14:47:45 INFO - PROCESS | 2315 | 14:50:48 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57077/tests/dromaeo/cssquery-yui.html) 14:50:48 INFO - PROCESS | 2315 | RSS: Main: 170393600 14:50:48 INFO - PROCESS | 2315 | 14:53:51 INFO - PROCESS | 2315 | Cycle 1(1): loaded http://localhost:57077/tests/dromaeo/cssquery-yui.html (next: http://localhost:57077/tests/dromaeo/cssquery-dojo.html) 14:53:52 INFO - PROCESS | 2315 | RSS: Main: 171950080 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | __start_tp_report 14:53:52 INFO - PROCESS | 2315 | _x_x_mozilla_page_load 14:53:52 INFO - PROCESS | 2315 | _x_x_mozilla_page_load_details 14:53:52 INFO - PROCESS | 2315 | |i|pagename|runs| 14:53:52 INFO - PROCESS | 2315 | |0;dojo.html;2676.0232515131975;2726.522858499762;2729.576915578085;2736.356956115314;2744.7529722324985;4721.5986641135505;4751.216049351857;4793.089313030522;4845.370101886759;4901.1177987962155;4748.07412554552;4789.592884604813;4792.137415265251;4826.1554228010045;4839.685420447669;4377.562243775629;4424.201047496121;4544.454665440152;4554.954450455502;4555.567221113989;519.5472266355288;4364.716293440932;4450.599446049855;4479.9552004479865;4505.3242013698045;4433.2685106957315;4434.957784920541;4482;4500.707454015511;4501.3022981437925;4395.340698895159;4469.44131983502;4478.910421791578;4493.528179541134;4509.143262780061;4402.823887044515;4423.911521769579;4440.24515832306;4473.351364052227;4485.596296333313;4705.623550115983;4712.363830882856;4737.218358970766;4756.857294281177;4797.592204662608;5016.54851063406;5151.381834179922;5192.58459323257;5194.194899790538;5242.501962313574;5230.8169214077325;5235.869103272448;5237.214417837316;5238.659487133325;5273.683578985273;4872.366592342973;4887.7311747853855;4894.26586012094;4897.804087836518;4940.382452193476;5148.9485105149215;5218.869528261824;5219.686818790885;5297.602679799031;5375.81184658535;5068.923966140511;5150.742462876841;5160.870978225499;5178.300929374562;5183.97408012965;5251.4485978972425;5257.263983042377;5258.868528286747;5261.394939581921;5265.341832270966;5049.772760225798;5159.922601160985;5162.225666150108;5211.9478805211465;5222.451642577551;4930.876728081755;5021.297018417425;5071.670341427869;5075.086484432837;5120.385553733501;4390.868273951786;4402.889927751768;4424.402705634762;4429.955700443019;4464.598186163196;3828.8085595720104;3842.3275926712713;3844.1350696093155;3848.6536211741077;3855.7879316637855;4458.464984201916;4464.910701785946;4475.552444755498;4511.413516242933;4521.434820647419;5201.29782479368;5235.345581802275;5258.079836028756;5261.5264626183825;5311.229871668664;4281.37920001598;4396.538363471854;4435.223835828717;4439.089986552749;4465.285554311295;4679.321498382716;4682.695624784378;4683.484816670163;4689.507601701772;4712.95287047132;4855.44162421319;4855.732934688626;4855.854324370274;4857.222844344888;4908.288298196741;5042.29407882904;5214.035403450373;5224.242484839753;5274.789008439773;5283.049051170826;4925.38432695913;4936.185529387611;4951.603871690184;4958.42978057528;4997.675151115312;4916.655834091579;5187.403448603459;5196.740162991911;5198.142306519382;5202.843914682566;5194.922076168785;5245.89508209826;5250.606204534752;5252.107141785982;5270.4202537721585;5078.111330517218;5094.541491265803;5098.1842905135;5113.463086376026;5150.768215430239;4917.975410123069;5051.974740126276;5083.745812709276;5096.668716533413;5098.133317335987;4855.878603034952;4908.828191013297;4963.478834722302;4966.726830024383;5089.821856235162;5105.132127538253;5132.897342053213;5135.717535535581;5138.76875540609;5182.714950677749;4763.118823017753;4976.5023497649945;4980.750962451791;4983.651144419856;4991.875203119951 14:53:52 INFO - PROCESS | 2315 | |1;ext.html;546.784561956602;584.5498965796337;593.967331796751;599.4275466929083;605.8455093951042;35059;38953.415698764504;39029;39049;39142.41286380707;39814;40020.39969400461;40273;40289.395659065136;40328.991775205635;7712.421568382366;7834.412419068564;7935.444518883681;7943.285104340608;7948.841023179533;7743.225677432268;7797.532148071105;7799.298063174313;7805.7658270251695;7820.608969551528;7767.9611601941915;7781.805454863617;7809.60951952403;7816.413768967322;7828.334591559725;7754.922450775504;7778.261065198797;7817.140114587391;7823.2176782321885;7828.217178282183;7724.420668449832;7794.142644309121;7824.687012519493;7844.372450204027;7851.882221766678;35426.29147417063;35443.1139221519;35651.61309675577;35736.285274294365;35827.4625880612;3094.90715278542;3200.727938125262;3229.418704633165;3437.656234376567;3695.7228207884245;29683;30059.398812023635;30149.397012059857;30149.547756783664;30877.691223087706;3385.5112858671678;3432.622411534729;3436.7250619950346;3459.6021457532456;3476.8087755173456;238736;239641;240525;240693;241415;28617.85691071573;54961.450385496435;54981;55148;55327.17009244864;34485.65514344875;34700.30599387998;34726.47910281348;34742.82628586841;34788.478172827425;13501.594952151254;13647.181169129884;13691.041627086008;13714.382852771649;13735;11172.329660220414;11217.831732523855;11235.83146252807;11246.49390777417;11251.606193783178;8003.719869804529;8006.599670016476;8021.398395120389;8036;8085.757427277191;3117.4700300948894;3145.9528107078413;3176.857041433141;3179.2210908327147;3186.824724640167;879.6745204274459;912.1425859691868;916.1388295002677;960.4285450157146;995.1690338567232;25290.367740806258;25724.614130788053;25769.871150644125;25845.22464326073;25987.350316242246;896.3994123936848;960.851068084448;1017.389566260238;1028.2596530498029;1067.1729409707539;14537.491187808377;14647;14765.926170369294;14811.481598144013;14928.776068358984;394639;394748;395895;398206;398343;48360.516394836304;49218.26172607342;49221.753891231034;49756.253656195186;49813.25280120801;1153.1927650644582;1169.8245263210586;1200.0579545057262;1208.172401904698;1216.5802798034663;26354.736452635996;27065.59401608938;27256.318592035357;27945.580816287365;27994.86002569974;42081.57918420777;42146.57853421426;42238.155236894476;42442.15115697731;42597.1480570393;279129;280656;339764;340654;340726;24971.12601058954;25511.489770204862;26043.218703438928;26192.73807261979;27365.589516156877;41890.79054604707;42115.57394166623;42185;42488.15023699571;42588.36117458178;36583;36585.268294634494;36710.63289367072;36969.260614788094;37562.24875502529;34740.652593473744;36320;36729.816350918074;36768.63231367759;37040.81479592585;36230;36406.81796591;37016;37061.25877482489;37095.62904370922;31629.525557117122;32924.67075329216;32953.67046329506;32984.83507582447;33413.33173336568;25403.74596254014;25701.61447578325;25705.714714264584;25867.354047652254;26240.8687956559 14:53:52 INFO - PROCESS | 2315 | |2;jquery.html;351.1642291346595;361.1494929441166;364.8321771984887;373.1138545953361;376.92838360711465;15475.84524154758;16028;16947.406840760577;17084.743728844078;17106.059166745825;13661.863381366184;16550.503484895442;16697.582560435996;16700.58248543787;16761.15627280998;4815.398075240603;5027.396712394518;5049.722265275408;5054.595632349403;5059.848204553869;3399.065257054305;4963.652544321899;5590.86022849428;5856.41435856413;5909;5942.316633587128;5946.881062378749;5953.940460595382;5976.223090998186;5976.312724036748;5785;5891.293044834626;5942.702864856761;5950.256217972754;5964;4486.573775491356;5157.896842063138;5169.302144210521;5172.27588137661;5176.948230517684;11092.169791984314;11479.196456248066;11570.595029174023;11580.073594112451;11627.709307267385;1816.1464111867401;1851.574137948266;1855.9072046397625;1891.7729872415398;1950.229659284589;8404;8532.274756645693;8730.825383492294;8785.472871627722;8804.823903521958;1673.9330426782915;1801.5946412057313;1832.1663643042384;1928.3250862198258;1962.0876292524044;65825;67878.32121678769;68168.31831681669;68426.31573684249;68568.31431685669;8151.83696326082;8310.626021829032;8505.362097842686;8539.103394143649;8541.957290213633;10939;10944.726381840359;11002.33985960829;11055.889441105646;11146.609868654721;6419.2296924369375;6517.739290428424;6540.444062254666;6674.466042716571;6676.499262555328;6456.192975878015;6587.63767992765;6646.634435106019;6765.391114799593;6783.287754785775;3500.632433594487;3513.8243087846017;3528.5236493073107;3561.28774245152;3561.7506774526055;1503.9699206015819;1694.8559372453233;1742;1780.1722199177445;1806;816.4040250616964;821.1542111625035;847.2713466418875;849.2017503546647;925.796324808541;15817.209139542976;16114.838851611334;16316.988608221893;16352.672946541003;16463.588410289838;829.707278481015;871.6687658689784;871.9956400218085;874.2394117118148;908.4776253654176;9195.310351723647;9260.953695231481;9290.256779457628;9310.86033709495;9377;284227;284595;390347;390668;393488;81736.18263817404;82720.58639706763;82930;83240;84171.15828841756;972.1590823937385;981.5435822342645;981.959123329259;1041;1043.7077618266896;15459.536213913601;15485.612859678598;15605.765913511534;15637.92181039133;15909.363625454853;35024.47463288002;35660.64339356677;36095;36409.63590364062;37519.06202344963;47808.282875756195;48233.5176648229;49273;50155.49844501654;50460.243096354316;7419.703211871681;7466.925330746623;7533.698652053857;7546.735864244725;7551;8123.67505299805;11260.324380537195;11969.042476602026;11996.880031199576;12046.51813927433;10029.14752246038;10280.331778434378;10354.689359319233;10404.271700981162;10444.63443779464;4666.416697912761;8743.38796284254;9783.85324220123;10447.216458765472;10490.527926243185;7141.750038748827;10085.949570252102;10225.181985440999;10315.690529284133;10373.236549786705;7374.557526548424;7405.888911666437;7447.218042105717;7511.136219334847;7540.0951885771865;9803.264755143251;10137.189024877845;10252.58989640406;10513.894861051598;10550.630727924487 14:53:52 INFO - PROCESS | 2315 | |3;mootools.html;1421.303561254985;1429.9918557417018;1564.2022568490074;1751.2994802079174;1751.351999760089;6951.443884489241;7699.692012319508;7705.8844117338285;8196.672133114684;8205.056418511873;7818.296353328199;8048.718294859681;8061.3550915926735;8114.026316841972;8161.714339998086;2202.845800793941;2219.511707424364;2239.3393948785065;2240.5630901974123;2241.932742017742;2157.5037741319506;2172.750133734625;2179.2372669565602;2199.83501237407;2205.2171479124922;2183.0285522942295;2202.7907348801837;2203.1077413647417;2207.0509680837313;2242.551489702058;2155.91376344946;2160.3734916874087;2160.7839216078346;2163.177992362908;2163.621366260898;2124.936251912445;2162.1243396424475;2180.4766855954617;2184.1263494602126;2204.0742887986926;8060.274575288252;8071.394645401619;8076.798080047987;8079.919200807975;8080.555569443678;4321.82712691492;4401.757903315316;4432.601065904084;4442.111577684444;4452.354408610766;2689.1125928443566;2752.8073034887566;2805.1304095730184;2818.7604053655464;2870.3398218409884;820.4379999700164;820.6635279535421;824.9711260105868;840.0213750980101;842.5239739547136;10197.184225262035;10200.3369780964;10203.744906377326;10246.59013639461;10247.487625618689;4093.3450647896193;4121.711480196417;4226.344916537942;4234.661227101825;4252.510961239497;8746.56267186638;8802;8846.955765221133;8873;8881.955590222136;4454.57681520255;4520.480144783326;4524.909501809945;4536.206163921301;4540.318952157203;3614.7831130132276;3900.4539364488996;4056.6957478188665;4087.1212689271947;4123.195976784498;3638.9636103639154;3724.571674257441;3839.9424008639894;3847.634474724897;3862.942055869164;1165.3532289579196;1180.4451907603413;1188.061431469147;1190.2501424102934;1197.550918405598;733.0873063036554;791.1811275330006;835.6197929941862;863.1713554987157;867.089555966233;5355.036093503207;5587.3015873015875;5635.380108188096;5754.165645981393;5835;852.9445586036887;857.8069934264865;866.3026263857529;910.8314961732101;920.604140219712;3756.398976163801;3960.9009774755286;4061.3095773718537;4103.7948102594755;4186.623203911662;9291.256699464027;9565.04349565038;9624.51877406127;9630.903690963001;9634.566444510014;9480.478573678376;9487.288453366025;9509.096635819586;9580.56887440067;9587.280953928483;6896.069030680894;7219.639018049076;7224.0608720867;7224.927750722425;7236.529625574321;5276.15581506957;5288.9735551322;5300.5759539236;5367.543758780391;5395.622306438511;8286.544240066854;8311.501309921425;8317.875231871405;8361.080281169188;8430.578471076544;8293.543855088028;8476.915230847613;8676.479411235347;8704.477731336141;8827.293816494794;6248.312685604671;6591.176102987127;6764.729410823709;6862;6950.270221626656;6990.300969902969;7037.225905150327;7060;7079;7116.359527642537;6495.090687303876;6750.594964301961;6772.762953296611;6786.253512113763;6798.218204906499;6612.107365505595;6672.399484046459;6766.560173588701;6844.657767111525;6881.071055407456;6219.937800621936;6231.626102433868;6251.156093927261;6266.592671476339;6266.592671476339;4542.88642783933;4545.931811022771;4616.492185859485;4639.257718764981;4689.226277664284;4781.163296423042;4829.879253018703;4857.732824694534;4913.410390753133;4981.153203955409 14:53:52 INFO - PROCESS | 2315 | |4;prototype.html;280.1930440331844;286.624521876342;288.4418649912419;290.638155496407;292.5713829240163;4864.7567621618955;4945.950540494594;5011.3986321641405;5077.873053173668;5114.258432527281;5010.749462526877;5021.623378246628;5043;5049.929528893154;5060.569851562622;3902.6682731967676;3917.843286268546;3927.9803600982027;3928.430377595247;3937.803109844511;3665.7433979621437;3925.6663183629425;3944.881653550384;3947.8223479943326;3964.8612298569556;3822.8279727412196;3851.42228665701;3856.5179352580926;3861.9420708689254;3872.8838134856;3782.978595779124;3826.617338266165;3835.42468629705;3855.9228815423535;3860.4595356650093;3309.4870295104297;3335.6497567755277;3345.59852817661;3346.130006198406;3350.79895206286;4748.406449193851;4837.274408838667;4888.728930478102;4894.580571634222;4900.779464924087;4393.8462153824785;4417.823287068545;4422.783734473013;4426.601605855489;4434.312681534335;5271.235670827747;5277.155655095205;5278.181881808326;5278.709670968095;5284.418713941502;3510.1751088494184;3577.982110089433;3640.854365825364;3660.9267814643827;3665.725070619714;5483.945160548384;5486.670799752028;5529.612927095105;5549.750261238254;5567.638103523299;3667.908302292464;3668.4680721295795;3693.9445908311395;3704.407294832814;3721.1627383838418;3725.2177042820767;3736.1406876418578;3737.3085979093953;3773.6981041516615;3805.1058001369656;4200.978995105066;4387.890302742457;4398.64810815134;4404;4409.801558929856;5305.867353316198;5316.494932981361;5331.226972089025;5338.279332290091;5345.786168553214;1216.227695413401;1250.4685508658783;1275.7193417448148;1277.3166355999497;1282.2883299768719;793.714262865368;796.4464697035505;815.38031096366;828.349745449819;829.3738227638095;4148.543660197376;4178.26880295947;4183.518895327015;4190.224808410454;4208.410822484854;4775.450823155312;4790.030181287624;4832.9275060874115;4840.782164802592;4895.6083513318845;4164.541900390955;4167.249895018865;4189.183109293658;4189.706720529594;4193.937090943638;2508.2600632813364;2514.4091138582417;2545.4145546524405;2588.2494076717917;2595.610658401255;4475.373447717322;4503.842365517256;4521.434820647419;4538.978729785772;4560.693497214493;4859.22638237041;4897.461279259279;4924.162892308316;4927.876803079952;4999.150314383702;4537.977310113428;4846.830360937351;5208.8437346879655;5210.739463026834;5217.739113044408;5571.972140139435;5580.353795630218;5586.52514536269;5590.413006634245;5590.636608620427;5251.973740131275;5375.6023433906685;5390.299261096033;5438.15708565173;5454.8909021818545;5169.121249387538;5170.302009228856;5198.610104242121;5202.323697919246;5217.973910130425;3699.6300369962787;3712.533549247978;3713.424419214918;3718.944215836819;3723.5345581802276;5329.360476742816;5487.6158668894395;5492.286002819608;5535.529479994246;5536.197251398444;5328.413874473727;5346.117890548016;5357.874846282324;5397.8110766123;5424.972875135599;5337.386200586982;5343.957928203963;5363.115086010765;5371.731413429391;5394.730263486731;5155.32980712505;5273.630845840754;5296.867578310573;5303.7082960436;5315.149576067965;5344.54571361423;5388.892222155613;5395.78416863321;5399.190121481809;5414.160805075062;5261.789528418821;5285.365756109138;5286.955479058446;5289.7355132242465;5291.8677033072945 14:53:52 INFO - PROCESS | 2315 | |5;yui.html;697.9162500499938;702.8453740177162;718.0665135324077;722.3931897206348;758.5069704691952;11715.297082175075;12300.630981070572;12595.937020314908;12654.557090501847;12906.935465322684;13743.10669806462;14394.712105757879;14452.855471445282;14455;14466.059706119095;626.7994241842612;769.3614300130906;774.7598244544181;782.3467404717068;784.568487331968;765.185077892046;788.917163697812;789.5617932047711;791.8337149198675;794.3883209928381;830.0371568979984;831.2934006094831;832.2551316571664;832.5088197963231;832.9292010179142;822.2024636102971;823.1151512124491;825.5088222507599;825.9008918929707;826.450410477032;606.8573885136989;607.9148919151322;608.3764141754692;608.5557542993639;609.3449541742644;12753.298568578724;12856.292903890282;12858.549950751678;12867.678308042281;12887.420066097047;13016.544420945316;13179.670508237275;13202.968101381903;13382.330883455885;13588.32058397086;10485.633002844865;10564.894351056468;10744.876451858887;10769.407682577455;10810.621628242974;3263.396271689745;3301.669833016679;3320.5019247112887;3353.496975453677;3410.181556426465;63450;64042;64177.35822641761;64253.03620445697;64723;9543.236541076698;9972.351797133164;10365.481725913674;10618.415987120783;10625.149988000941;18277.360292389967;18654.626907461774;18674.066296685112;18753.437396878115;18825.435236942914;6401.839954001187;7047.647617619201;7162.856742865113;7228.566286022856;7259.6370181491775;3777.131259810259;3854.094287842355;3866.6326698963553;3876.96123038766;4012.799360031987;2952.601398811133;3055.1292881528657;3063.433264846011;3065.693430656961;3065.754739620825;520.6433592988815;525.5559052600623;530.191458026505;533.6637918111643;540.4892376704056;529.4149964289481;581.9796307129315;584.1763114009311;587.5358466811172;621.5493767018875;8783.560821959005;8923.561280583232;8929.642814287487;8939.463632182089;9228.35401521887;521.2494008627564;616.8735409241095;624.5877720704405;631.6652174347603;632.1181951178173;4036.2734707752297;4076.9184616307507;4081.6326530612387;4165.812538435717;4199.223143718422;83219;84985.57507212424;88718.55640721755;88791;89451;64092.35907640864;76154.61922690351;78054.60972695214;78978.21021789823;79534;68557;69357.30642693509;69737.3026269741;70020.64989675122;70531.2946870535;8338;8418.116097809887;8501.447405918596;8549.27331176857;8746.2128408441;43065.770067244455;43269.350959735;43347.783261083496;43465;43888.561114388445;60669;61828;61864.69067654633;61918.38081619126;62146.37853621406;10054.420554911256;10181.389116653025;10184.898151018395;10245.948770256102;10253.231007674603;11002.174836887105;11078.554763480057;11218.55125794959;11526.94236528812;11612.245204061708;10434.68695939123;10737;11612.593559225725;11645;11674.883251167379;11097.89021097916;11212;11555.653330400102;11803.704907377385;11816.40917954116;10930.45347732626;11056.336619802838;11523.13576481784;11698.590549330733;11754.118441117122;8053.852266082855;8478.3641226907;8539.487630742175;8592.699255526026;8639.179277968582;9620.567074481525;9680.370775899544;9787.314887958059;9835.544135699854;9868.703938881845 14:53:52 INFO - PROCESS | 2315 | __end_tp_report 14:53:52 INFO - PROCESS | 2315 | __start_cc_report 14:53:52 INFO - PROCESS | 2315 | _x_x_mozilla_cycle_collect,385 14:53:52 INFO - PROCESS | 2315 | __end_cc_report 14:53:52 INFO - PROCESS | 2315 | __startTimestamp1465250032153__endTimestamp 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | ------- Summary: start ------- 14:53:52 INFO - PROCESS | 2315 | Number of tests: 6 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | [#0] dojo.html Cycles:165 Average:4771.97 Median:4917.98 stddev:604.78 (12.3%) stddev-sans-first:583.86 14:53:52 INFO - PROCESS | 2315 | Values: 2676.0 2726.5 2729.6 2736.4 2744.8 4721.6 4751.2 4793.1 4845.4 4901.1 4748.1 4789.6 4792.1 4826.2 4839.7 4377.6 4424.2 4544.5 4555.0 4555.6 519.5 4364.7 4450.6 4480.0 4505.3 4433.3 4435.0 4482.0 4500.7 4501.3 4395.3 4469.4 4478.9 4493.5 4509.1 4402.8 4423.9 4440.2 4473.4 4485.6 4705.6 4712.4 4737.2 4756.9 4797.6 5016.5 5151.4 5192.6 5194.2 5242.5 5230.8 5235.9 5237.2 5238.7 5273.7 4872.4 4887.7 4894.3 4897.8 4940.4 5148.9 5218.9 5219.7 5297.6 5375.8 5068.9 5150.7 5160.9 5178.3 5184.0 5251.4 5257.3 5258.9 5261.4 5265.3 5049.8 5159.9 5162.2 5211.9 5222.5 4930.9 5021.3 5071.7 5075.1 5120.4 4390.9 4402.9 4424.4 4430.0 4464.6 3828.8 3842.3 3844.1 3848.7 3855.8 4458.5 4464.9 4475.6 4511.4 4521.4 5201.3 5235.3 5258.1 5261.5 5311.2 4281.4 4396.5 4435.2 4439.1 4465.3 4679.3 4682.7 4683.5 4689.5 4713.0 4855.4 4855.7 4855.9 4857.2 4908.3 5042.3 5214.0 5224.2 5274.8 5283.0 4925.4 4936.2 4951.6 4958.4 4997.7 4916.7 5187.4 5196.7 5198.1 5202.8 5194.9 5245.9 5250.6 5252.1 5270.4 5078.1 5094.5 5098.2 5113.5 5150.8 4918.0 5052.0 5083.7 5096.7 5098.1 4855.9 4908.8 4963.5 4966.7 5089.8 5105.1 5132.9 5135.7 5138.8 5182.7 4763.1 4976.5 4980.8 4983.7 4991.9 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | [#1] ext.html Cycles:180 Average:46200.73 Median:36275.00 stddev:85656.63 (236.1%) stddev-sans-first:85828.33 14:53:52 INFO - PROCESS | 2315 | Values: 546.8 584.5 594.0 599.4 605.8 35059.0 38953.4 39029.0 39049.0 39142.4 39814.0 40020.4 40273.0 40289.4 40329.0 7712.4 7834.4 7935.4 7943.3 7948.8 7743.2 7797.5 7799.3 7805.8 7820.6 7768.0 7781.8 7809.6 7816.4 7828.3 7754.9 7778.3 7817.1 7823.2 7828.2 7724.4 7794.1 7824.7 7844.4 7851.9 35426.3 35443.1 35651.6 35736.3 35827.5 3094.9 3200.7 3229.4 3437.7 3695.7 29683.0 30059.4 30149.4 30149.5 30877.7 3385.5 3432.6 3436.7 3459.6 3476.8 238736.0 239641.0 240525.0 240693.0 241415.0 28617.9 54961.5 54981.0 55148.0 55327.2 34485.7 34700.3 34726.5 34742.8 34788.5 13501.6 13647.2 13691.0 13714.4 13735.0 11172.3 11217.8 11235.8 11246.5 11251.6 8003.7 8006.6 8021.4 8036.0 8085.8 3117.5 3146.0 3176.9 3179.2 3186.8 879.7 912.1 916.1 960.4 995.2 25290.4 25724.6 25769.9 25845.2 25987.4 896.4 960.9 1017.4 1028.3 1067.2 14537.5 14647.0 14765.9 14811.5 14928.8 394639.0 394748.0 395895.0 398206.0 398343.0 48360.5 49218.3 49221.8 49756.3 49813.3 1153.2 1169.8 1200.1 1208.2 1216.6 26354.7 27065.6 27256.3 27945.6 27994.9 42081.6 42146.6 42238.2 42442.2 42597.1 279129.0 280656.0 339764.0 340654.0 340726.0 24971.1 25511.5 26043.2 26192.7 27365.6 41890.8 42115.6 42185.0 42488.2 42588.4 36583.0 36585.3 36710.6 36969.3 37562.2 34740.7 36320.0 36729.8 36768.6 37040.8 36230.0 36406.8 37016.0 37061.3 37095.6 31629.5 32924.7 32953.7 32984.8 33413.3 25403.7 25701.6 25705.7 25867.4 26240.9 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | [#2] jquery.html Cycles:180 Average:22648.49 Median:26524.46 stddev:58727.13 (221.4%) stddev-sans-first:58868.01 14:53:52 INFO - PROCESS | 2315 | Values: 351.2 361.1 364.8 373.1 376.9 15475.8 16028.0 16947.4 17084.7 17106.1 13661.9 16550.5 16697.6 16700.6 16761.2 4815.4 5027.4 5049.7 5054.6 5059.8 3399.1 4963.7 5590.9 5856.4 5909.0 5942.3 5946.9 5953.9 5976.2 5976.3 5785.0 5891.3 5942.7 5950.3 5964.0 4486.6 5157.9 5169.3 5172.3 5176.9 11092.2 11479.2 11570.6 11580.1 11627.7 1816.1 1851.6 1855.9 1891.8 1950.2 8404.0 8532.3 8730.8 8785.5 8804.8 1673.9 1801.6 1832.2 1928.3 1962.1 65825.0 67878.3 68168.3 68426.3 68568.3 8151.8 8310.6 8505.4 8539.1 8542.0 10939.0 10944.7 11002.3 11055.9 11146.6 6419.2 6517.7 6540.4 6674.5 6676.5 6456.2 6587.6 6646.6 6765.4 6783.3 3500.6 3513.8 3528.5 3561.3 3561.8 1504.0 1694.9 1742.0 1780.2 1806.0 816.4 821.2 847.3 849.2 925.8 15817.2 16114.8 16317.0 16352.7 16463.6 829.7 871.7 872.0 874.2 908.5 9195.3 9261.0 9290.3 9310.9 9377.0 284227.0 284595.0 390347.0 390668.0 393488.0 81736.2 82720.6 82930.0 83240.0 84171.2 972.2 981.5 982.0 1041.0 1043.7 15459.5 15485.6 15605.8 15637.9 15909.4 35024.5 35660.6 36095.0 36409.6 37519.1 47808.3 48233.5 49273.0 50155.5 50460.2 7419.7 7466.9 7533.7 7546.7 7551.0 8123.7 11260.3 11969.0 11996.9 12046.5 10029.1 10280.3 10354.7 10404.3 10444.6 4666.4 8743.4 9783.9 10447.2 10490.5 7141.8 10085.9 10225.2 10315.7 10373.2 7374.6 7405.9 7447.2 7511.1 7540.1 9803.3 10137.2 10252.6 10513.9 10550.6 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | [#3] mootools.html Cycles:180 Average:5108.14 Median:5491.46 stddev:2800.75 (51.0%) stddev-sans-first:2794.90 14:53:52 INFO - PROCESS | 2315 | Values: 1421.3 1430.0 1564.2 1751.3 1751.4 6951.4 7699.7 7705.9 8196.7 8205.1 7818.3 8048.7 8061.4 8114.0 8161.7 2202.8 2219.5 2239.3 2240.6 2241.9 2157.5 2172.8 2179.2 2199.8 2205.2 2183.0 2202.8 2203.1 2207.1 2242.6 2155.9 2160.4 2160.8 2163.2 2163.6 2124.9 2162.1 2180.5 2184.1 2204.1 8060.3 8071.4 8076.8 8079.9 8080.6 4321.8 4401.8 4432.6 4442.1 4452.4 2689.1 2752.8 2805.1 2818.8 2870.3 820.4 820.7 825.0 840.0 842.5 10197.2 10200.3 10203.7 10246.6 10247.5 4093.3 4121.7 4226.3 4234.7 4252.5 8746.6 8802.0 8847.0 8873.0 8882.0 4454.6 4520.5 4524.9 4536.2 4540.3 3614.8 3900.5 4056.7 4087.1 4123.2 3639.0 3724.6 3839.9 3847.6 3862.9 1165.4 1180.4 1188.1 1190.3 1197.6 733.1 791.2 835.6 863.2 867.1 5355.0 5587.3 5635.4 5754.2 5835.0 852.9 857.8 866.3 910.8 920.6 3756.4 3960.9 4061.3 4103.8 4186.6 9291.3 9565.0 9624.5 9630.9 9634.6 9480.5 9487.3 9509.1 9580.6 9587.3 6896.1 7219.6 7224.1 7224.9 7236.5 5276.2 5289.0 5300.6 5367.5 5395.6 8286.5 8311.5 8317.9 8361.1 8430.6 8293.5 8476.9 8676.5 8704.5 8827.3 6248.3 6591.2 6764.7 6862.0 6950.3 6990.3 7037.2 7060.0 7079.0 7116.4 6495.1 6750.6 6772.8 6786.3 6798.2 6612.1 6672.4 6766.6 6844.7 6881.1 6219.9 6231.6 6251.2 6266.6 6266.6 4542.9 4545.9 4616.5 4639.3 4689.2 4781.2 4829.9 4857.7 4913.4 4981.2 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | [#4] prototype.html Cycles:180 Average:4285.11 Median:4839.03 stddev:1297.86 (26.8%) stddev-sans-first:1266.21 14:53:52 INFO - PROCESS | 2315 | Values: 280.2 286.6 288.4 290.6 292.6 4864.8 4946.0 5011.4 5077.9 5114.3 5010.7 5021.6 5043.0 5049.9 5060.6 3902.7 3917.8 3928.0 3928.4 3937.8 3665.7 3925.7 3944.9 3947.8 3964.9 3822.8 3851.4 3856.5 3861.9 3872.9 3783.0 3826.6 3835.4 3855.9 3860.5 3309.5 3335.6 3345.6 3346.1 3350.8 4748.4 4837.3 4888.7 4894.6 4900.8 4393.8 4417.8 4422.8 4426.6 4434.3 5271.2 5277.2 5278.2 5278.7 5284.4 3510.2 3578.0 3640.9 3660.9 3665.7 5483.9 5486.7 5529.6 5549.8 5567.6 3667.9 3668.5 3693.9 3704.4 3721.2 3725.2 3736.1 3737.3 3773.7 3805.1 4201.0 4387.9 4398.6 4404.0 4409.8 5305.9 5316.5 5331.2 5338.3 5345.8 1216.2 1250.5 1275.7 1277.3 1282.3 793.7 796.4 815.4 828.3 829.4 4148.5 4178.3 4183.5 4190.2 4208.4 4775.5 4790.0 4832.9 4840.8 4895.6 4164.5 4167.2 4189.2 4189.7 4193.9 2508.3 2514.4 2545.4 2588.2 2595.6 4475.4 4503.8 4521.4 4539.0 4560.7 4859.2 4897.5 4924.2 4927.9 4999.2 4538.0 4846.8 5208.8 5210.7 5217.7 5572.0 5580.4 5586.5 5590.4 5590.6 5252.0 5375.6 5390.3 5438.2 5454.9 5169.1 5170.3 5198.6 5202.3 5218.0 3699.6 3712.5 3713.4 3718.9 3723.5 5329.4 5487.6 5492.3 5535.5 5536.2 5328.4 5346.1 5357.9 5397.8 5425.0 5337.4 5344.0 5363.1 5371.7 5394.7 5155.3 5273.6 5296.9 5303.7 5315.1 5344.5 5388.9 5395.8 5399.2 5414.2 5261.8 5285.4 5287.0 5289.7 5291.9 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - PROCESS | 2315 | [#5] yui.html Cycles:180 Average:17014.95 Median:583.08 stddev:23538.72 (4037.0%) stddev-sans-first:23572.87 14:53:52 INFO - PROCESS | 2315 | Values: 697.9 702.8 718.1 722.4 758.5 11715.3 12300.6 12595.9 12654.6 12906.9 13743.1 14394.7 14452.9 14455.0 14466.1 626.8 769.4 774.8 782.3 784.6 765.2 788.9 789.6 791.8 794.4 830.0 831.3 832.3 832.5 832.9 822.2 823.1 825.5 825.9 826.5 606.9 607.9 608.4 608.6 609.3 12753.3 12856.3 12858.5 12867.7 12887.4 13016.5 13179.7 13203.0 13382.3 13588.3 10485.6 10564.9 10744.9 10769.4 10810.6 3263.4 3301.7 3320.5 3353.5 3410.2 63450.0 64042.0 64177.4 64253.0 64723.0 9543.2 9972.4 10365.5 10618.4 10625.1 18277.4 18654.6 18674.1 18753.4 18825.4 6401.8 7047.6 7162.9 7228.6 7259.6 3777.1 3854.1 3866.6 3877.0 4012.8 2952.6 3055.1 3063.4 3065.7 3065.8 520.6 525.6 530.2 533.7 540.5 529.4 582.0 584.2 587.5 621.5 8783.6 8923.6 8929.6 8939.5 9228.4 521.2 616.9 624.6 631.7 632.1 4036.3 4076.9 4081.6 4165.8 4199.2 83219.0 84985.6 88718.6 88791.0 89451.0 64092.4 76154.6 78054.6 78978.2 79534.0 68557.0 69357.3 69737.3 70020.6 70531.3 8338.0 8418.1 8501.4 8549.3 8746.2 43065.8 43269.4 43347.8 43465.0 43888.6 60669.0 61828.0 61864.7 61918.4 62146.4 10054.4 10181.4 10184.9 10245.9 10253.2 11002.2 11078.6 11218.6 11526.9 11612.2 10434.7 10737.0 11612.6 11645.0 11674.9 11097.9 11212.0 11555.7 11803.7 11816.4 10930.5 11056.3 11523.1 11698.6 11754.1 8053.9 8478.4 8539.5 8592.7 8639.2 9620.6 9680.4 9787.3 9835.5 9868.7 14:53:52 INFO - PROCESS | 2315 | -------- Summary: end -------- 14:53:52 INFO - PROCESS | 2315 | 14:53:52 INFO - TEST-INFO | 2315: exit 0 14:53:52 INFO - TEST-OK | dromaeo_css | took 1115362ms 14:53:52 INFO - TEST-START | kraken 14:53:52 INFO - operating with platform_type : linux_ 14:53:52 INFO - Initialising browser for kraken test... 14:53:52 INFO - TEST-INFO | started process 2635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYGeoc/profile http://localhost:57077/getInfo.html) 14:53:57 INFO - PROCESS | 2635 | __metrics Screen width/height:1600/1200 14:53:57 INFO - PROCESS | 2635 | colorDepth:24 14:53:57 INFO - PROCESS | 2635 | Browser inner width/height: 1024/697 14:53:57 INFO - PROCESS | 2635 | __metrics 14:53:58 ERROR - PROCESS | 2635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 14:53:59 INFO - TEST-INFO | 2635: exit 0 14:53:59 INFO - Browser initialized. 14:53:59 INFO - Running cycle 1/1 for kraken test... 14:53:59 INFO - TEST-INFO | started process 2828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYGeoc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:11 INFO - PROCESS | 2828 | RSS: Main: 168624128 14:54:11 INFO - PROCESS | 2828 | 14:54:13 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57077/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:14 INFO - PROCESS | 2828 | RSS: Main: 172732416 14:54:14 INFO - PROCESS | 2828 | 14:54:17 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57077/tests/kraken/driver.html?testName=audio-dft) 14:54:18 INFO - PROCESS | 2828 | RSS: Main: 172191744 14:54:18 INFO - PROCESS | 2828 | 14:54:21 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57077/tests/kraken/driver.html?testName=audio-fft) 14:54:21 INFO - PROCESS | 2828 | RSS: Main: 167755776 14:54:21 INFO - PROCESS | 2828 | 14:54:24 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57077/tests/kraken/driver.html?testName=audio-oscillator) 14:54:24 INFO - PROCESS | 2828 | RSS: Main: 168693760 14:54:24 INFO - PROCESS | 2828 | 14:54:26 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:27 INFO - PROCESS | 2828 | RSS: Main: 169005056 14:54:27 INFO - PROCESS | 2828 | 14:54:30 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57077/tests/kraken/driver.html?testName=imaging-darkroom) 14:54:31 INFO - PROCESS | 2828 | RSS: Main: 169119744 14:54:31 INFO - PROCESS | 2828 | 14:54:34 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57077/tests/kraken/driver.html?testName=imaging-desaturate) 14:54:35 INFO - PROCESS | 2828 | RSS: Main: 166838272 14:54:35 INFO - PROCESS | 2828 | 14:54:38 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57077/tests/kraken/driver.html?testName=json-parse-financial) 14:54:39 INFO - PROCESS | 2828 | RSS: Main: 167837696 14:54:39 INFO - PROCESS | 2828 | 14:54:40 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:41 INFO - PROCESS | 2828 | RSS: Main: 168140800 14:54:41 INFO - PROCESS | 2828 | 14:54:43 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:44 INFO - PROCESS | 2828 | RSS: Main: 168787968 14:54:44 INFO - PROCESS | 2828 | 14:54:46 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:47 INFO - PROCESS | 2828 | RSS: Main: 169021440 14:54:47 INFO - PROCESS | 2828 | 14:54:49 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:54:50 INFO - PROCESS | 2828 | RSS: Main: 169385984 14:54:50 INFO - PROCESS | 2828 | 14:54:53 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:54:54 INFO - PROCESS | 2828 | RSS: Main: 168894464 14:54:54 INFO - PROCESS | 2828 | 14:54:55 INFO - PROCESS | 2828 | Cycle 1(1): loaded http://localhost:57077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57077/tests/kraken/driver.html?testName=ai-astar) 14:54:56 INFO - PROCESS | 2828 | RSS: Main: 169652224 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | __start_tp_report 14:54:56 INFO - PROCESS | 2828 | _x_x_mozilla_page_load 14:54:56 INFO - PROCESS | 2828 | _x_x_mozilla_page_load_details 14:54:56 INFO - PROCESS | 2828 | |i|pagename|runs| 14:54:56 INFO - PROCESS | 2828 | |0;ai-astar;114;109;113;116;113;114;113;112;114;113 14:54:56 INFO - PROCESS | 2828 | |1;audio-beat-detection;165;132;154;191;134;170;164;133;198;132 14:54:56 INFO - PROCESS | 2828 | |2;audio-dft;164;165;164;177;163;164;163;166;163;162 14:54:56 INFO - PROCESS | 2828 | |3;audio-fft;76;75;77;178;77;76;76;75;160;77 14:54:56 INFO - PROCESS | 2828 | |4;audio-oscillator;86;86;156;87;87;87;138;87;87;134 14:54:56 INFO - PROCESS | 2828 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;118;117;118 14:54:56 INFO - PROCESS | 2828 | |6;imaging-darkroom;148;148;148;147;148;148;147;147;148;147 14:54:56 INFO - PROCESS | 2828 | |7;imaging-desaturate;95;95;96;96;96;95;95;102;96;96 14:54:56 INFO - PROCESS | 2828 | |8;json-parse-financial;65;64;65;65;65;65;65;67;65;65 14:54:56 INFO - PROCESS | 2828 | |9;json-stringify-tinderbox;65;66;65;71;67;65;66;65;65;65 14:54:56 INFO - PROCESS | 2828 | |10;stanford-crypto-aes;83;83;82;86;84;85;91;87;116;86 14:54:56 INFO - PROCESS | 2828 | |11;stanford-crypto-ccm;139;141;141;134;149;134;137;147;151;134 14:54:56 INFO - PROCESS | 2828 | |12;stanford-crypto-pbkdf2;173;176;176;169;171;173;172;178;176;172 14:54:56 INFO - PROCESS | 2828 | |13;stanford-crypto-sha256-iterative;67;68;69;66;67;69;68;68;68;67 14:54:56 INFO - PROCESS | 2828 | __end_tp_report 14:54:56 INFO - PROCESS | 2828 | __start_cc_report 14:54:56 INFO - PROCESS | 2828 | _x_x_mozilla_cycle_collect,989 14:54:56 INFO - PROCESS | 2828 | __end_cc_report 14:54:56 INFO - PROCESS | 2828 | __startTimestamp1465250096007__endTimestamp 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | ------- Summary: start ------- 14:54:56 INFO - PROCESS | 2828 | Number of tests: 14 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.50 stddev:1.79 (1.6%) stddev-sans-first:1.87 14:54:56 INFO - PROCESS | 2828 | Values: 114.0 109.0 113.0 116.0 113.0 114.0 113.0 112.0 114.0 113.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#1] audio-beat-detection Cycles:10 Average:157.30 Median:164.50 stddev:24.68 (15.0%) stddev-sans-first:26.02 14:54:56 INFO - PROCESS | 2828 | Values: 165.0 132.0 154.0 191.0 134.0 170.0 164.0 133.0 198.0 132.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.33 (2.6%) stddev-sans-first:4.58 14:54:56 INFO - PROCESS | 2828 | Values: 164.0 165.0 164.0 177.0 163.0 164.0 163.0 166.0 163.0 162.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#3] audio-fft Cycles:10 Average:94.70 Median:76.00 stddev:39.40 (51.8%) stddev-sans-first:41.20 14:54:56 INFO - PROCESS | 2828 | Values: 76.0 75.0 77.0 178.0 77.0 76.0 76.0 75.0 160.0 77.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#4] audio-oscillator Cycles:10 Average:103.50 Median:87.00 stddev:27.59 (31.7%) stddev-sans-first:28.53 14:54:56 INFO - PROCESS | 2828 | Values: 86.0 86.0 156.0 87.0 87.0 87.0 138.0 87.0 87.0 134.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:54:56 INFO - PROCESS | 2828 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 14:54:56 INFO - PROCESS | 2828 | Values: 148.0 148.0 148.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:2.10 (2.2%) stddev-sans-first:2.18 14:54:56 INFO - PROCESS | 2828 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 102.0 96.0 96.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 14:54:56 INFO - PROCESS | 2828 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 65.0 67.0 65.0 65.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.50 stddev:1.89 (2.9%) stddev-sans-first:1.96 14:54:56 INFO - PROCESS | 2828 | Values: 65.0 66.0 65.0 71.0 67.0 65.0 66.0 65.0 65.0 65.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:85.50 stddev:10.07 (11.8%) stddev-sans-first:10.49 14:54:56 INFO - PROCESS | 2828 | Values: 83.0 83.0 82.0 86.0 84.0 85.0 91.0 87.0 116.0 86.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:141.00 stddev:6.38 (4.5%) stddev-sans-first:6.74 14:54:56 INFO - PROCESS | 2828 | Values: 139.0 141.0 141.0 134.0 149.0 134.0 137.0 147.0 151.0 134.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.50 stddev:2.80 (1.6%) stddev-sans-first:2.96 14:54:56 INFO - PROCESS | 2828 | Values: 173.0 176.0 176.0 169.0 171.0 173.0 172.0 178.0 176.0 172.0 14:54:56 INFO - PROCESS | 2828 | 14:54:56 INFO - PROCESS | 2828 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 14:54:56 INFO - PROCESS | 2828 | Values: 67.0 68.0 69.0 66.0 67.0 69.0 68.0 68.0 68.0 67.0 14:54:56 INFO - PROCESS | 2828 | -------- Summary: end -------- 14:54:56 INFO - PROCESS | 2828 | 14:54:57 INFO - TEST-INFO | 2828: exit 0 14:54:57 INFO - TEST-OK | kraken | took 64135ms 14:54:57 INFO - SUITE-END | took 1179s 14:54:57 INFO - Completed test suite (00:19:39) 14:54:57 INFO - javascript benchmark 14:54:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6313.941251249112, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2676.0232515131975, 2726.522858499762, 2729.576915578085, 2736.356956115314, 2744.7529722324985, 4721.5986641135505, 4751.216049351857, 4793.089313030522, 4845.370101886759, 4901.1177987962155, 4748.07412554552, 4789.592884604813, 4792.137415265251, 4826.1554228010045, 4839.685420447669, 4377.562243775629, 4424.201047496121, 4544.454665440152, 4554.954450455502, 4555.567221113989, 519.5472266355288, 4364.716293440932, 4450.599446049855, 4479.9552004479865, 4505.3242013698045, 4433.2685106957315, 4434.957784920541, 4482.0, 4500.707454015511, 4501.3022981437925, 4395.340698895159, 4469.44131983502, 4478.910421791578, 4493.528179541134, 4509.143262780061, 4402.823887044515, 4423.911521769579, 4440.24515832306, 4473.351364052227, 4485.596296333313, 4705.623550115983, 4712.363830882856, 4737.218358970766, 4756.857294281177, 4797.592204662608, 5016.54851063406, 5151.381834179922, 5192.58459323257, 5194.194899790538, 5242.501962313574, 5230.8169214077325, 5235.869103272448, 5237.214417837316, 5238.659487133325, 5273.683578985273, 4872.366592342973, 4887.7311747853855, 4894.26586012094, 4897.804087836518, 4940.382452193476, 5148.9485105149215, 5218.869528261824, 5219.686818790885, 5297.602679799031, 5375.81184658535, 5068.923966140511, 5150.742462876841, 5160.870978225499, 5178.300929374562, 5183.97408012965, 5251.4485978972425, 5257.263983042377, 5258.868528286747, 5261.394939581921, 5265.341832270966, 5049.772760225798, 5159.922601160985, 5162.225666150108, 5211.9478805211465, 5222.451642577551, 4930.876728081755, 5021.297018417425, 5071.670341427869, 5075.086484432837, 5120.385553733501, 4390.868273951786, 4402.889927751768, 4424.402705634762, 4429.955700443019, 4464.598186163196, 3828.8085595720104, 3842.3275926712713, 3844.1350696093155, 3848.6536211741077, 3855.7879316637855, 4458.464984201916, 4464.910701785946, 4475.552444755498, 4511.413516242933, 4521.434820647419, 5201.29782479368, 5235.345581802275, 5258.079836028756, 5261.5264626183825, 5311.229871668664, 4281.37920001598, 4396.538363471854, 4435.223835828717, 4439.089986552749, 4465.285554311295, 4679.321498382716, 4682.695624784378, 4683.484816670163, 4689.507601701772, 4712.95287047132, 4855.44162421319, 4855.732934688626, 4855.854324370274, 4857.222844344888, 4908.288298196741, 5042.29407882904, 5214.035403450373, 5224.242484839753, 5274.789008439773, 5283.049051170826, 4925.38432695913, 4936.185529387611, 4951.603871690184, 4958.42978057528, 4997.675151115312, 4916.655834091579, 5187.403448603459, 5196.740162991911, 5198.142306519382, 5202.843914682566, 5194.922076168785, 5245.89508209826, 5250.606204534752, 5252.107141785982, 5270.4202537721585, 5078.111330517218, 5094.541491265803, 5098.1842905135, 5113.463086376026, 5150.768215430239, 4917.975410123069, 5051.974740126276, 5083.745812709276, 5096.668716533413, 5098.133317335987, 4855.878603034952, 4908.828191013297, 4963.478834722302, 4966.726830024383, 5089.821856235162, 5105.132127538253, 5132.897342053213, 5135.717535535581, 5138.76875540609, 5182.714950677749, 4763.118823017753, 4976.5023497649945, 4980.750962451791, 4983.651144419856, 4991.875203119951], "value": 4735.605065667483, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.784561956602, 584.5498965796337, 593.967331796751, 599.4275466929083, 605.8455093951042, 35059.0, 38953.415698764504, 39029.0, 39049.0, 39142.41286380707, 39814.0, 40020.39969400461, 40273.0, 40289.395659065136, 40328.991775205635, 7712.421568382366, 7834.412419068564, 7935.444518883681, 7943.285104340608, 7948.841023179533, 7743.225677432268, 7797.532148071105, 7799.298063174313, 7805.7658270251695, 7820.608969551528, 7767.9611601941915, 7781.805454863617, 7809.60951952403, 7816.413768967322, 7828.334591559725, 7754.922450775504, 7778.261065198797, 7817.140114587391, 7823.2176782321885, 7828.217178282183, 7724.420668449832, 7794.142644309121, 7824.687012519493, 7844.372450204027, 7851.882221766678, 35426.29147417063, 35443.1139221519, 35651.61309675577, 35736.285274294365, 35827.4625880612, 3094.90715278542, 3200.727938125262, 3229.418704633165, 3437.656234376567, 3695.7228207884245, 29683.0, 30059.398812023635, 30149.397012059857, 30149.547756783664, 30877.691223087706, 3385.5112858671678, 3432.622411534729, 3436.7250619950346, 3459.6021457532456, 3476.8087755173456, 238736.0, 239641.0, 240525.0, 240693.0, 241415.0, 28617.85691071573, 54961.450385496435, 54981.0, 55148.0, 55327.17009244864, 34485.65514344875, 34700.30599387998, 34726.47910281348, 34742.82628586841, 34788.478172827425, 13501.594952151254, 13647.181169129884, 13691.041627086008, 13714.382852771649, 13735.0, 11172.329660220414, 11217.831732523855, 11235.83146252807, 11246.49390777417, 11251.606193783178, 8003.719869804529, 8006.599670016476, 8021.398395120389, 8036.0, 8085.757427277191, 3117.4700300948894, 3145.9528107078413, 3176.857041433141, 3179.2210908327147, 3186.824724640167, 879.6745204274459, 912.1425859691868, 916.1388295002677, 960.4285450157146, 995.1690338567232, 25290.367740806258, 25724.614130788053, 25769.871150644125, 25845.22464326073, 25987.350316242246, 896.3994123936848, 960.851068084448, 1017.389566260238, 1028.2596530498029, 1067.1729409707539, 14537.491187808377, 14647.0, 14765.926170369294, 14811.481598144013, 14928.776068358984, 394639.0, 394748.0, 395895.0, 398206.0, 398343.0, 48360.516394836304, 49218.26172607342, 49221.753891231034, 49756.253656195186, 49813.25280120801, 1153.1927650644582, 1169.8245263210586, 1200.0579545057262, 1208.172401904698, 1216.5802798034663, 26354.736452635996, 27065.59401608938, 27256.318592035357, 27945.580816287365, 27994.86002569974, 42081.57918420777, 42146.57853421426, 42238.155236894476, 42442.15115697731, 42597.1480570393, 279129.0, 280656.0, 339764.0, 340654.0, 340726.0, 24971.12601058954, 25511.489770204862, 26043.218703438928, 26192.73807261979, 27365.589516156877, 41890.79054604707, 42115.57394166623, 42185.0, 42488.15023699571, 42588.36117458178, 36583.0, 36585.268294634494, 36710.63289367072, 36969.260614788094, 37562.24875502529, 34740.652593473744, 36320.0, 36729.816350918074, 36768.63231367759, 37040.81479592585, 36230.0, 36406.81796591, 37016.0, 37061.25877482489, 37095.62904370922, 31629.525557117122, 32924.67075329216, 32953.67046329506, 32984.83507582447, 33413.33173336568, 25403.74596254014, 25701.61447578325, 25705.714714264584, 25867.354047652254, 26240.8687956559], "value": 16527.044649964515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1642291346595, 361.1494929441166, 364.8321771984887, 373.1138545953361, 376.92838360711465, 15475.84524154758, 16028.0, 16947.406840760577, 17084.743728844078, 17106.059166745825, 13661.863381366184, 16550.503484895442, 16697.582560435996, 16700.58248543787, 16761.15627280998, 4815.398075240603, 5027.396712394518, 5049.722265275408, 5054.595632349403, 5059.848204553869, 3399.065257054305, 4963.652544321899, 5590.86022849428, 5856.41435856413, 5909.0, 5942.316633587128, 5946.881062378749, 5953.940460595382, 5976.223090998186, 5976.312724036748, 5785.0, 5891.293044834626, 5942.702864856761, 5950.256217972754, 5964.0, 4486.573775491356, 5157.896842063138, 5169.302144210521, 5172.27588137661, 5176.948230517684, 11092.169791984314, 11479.196456248066, 11570.595029174023, 11580.073594112451, 11627.709307267385, 1816.1464111867401, 1851.574137948266, 1855.9072046397625, 1891.7729872415398, 1950.229659284589, 8404.0, 8532.274756645693, 8730.825383492294, 8785.472871627722, 8804.823903521958, 1673.9330426782915, 1801.5946412057313, 1832.1663643042384, 1928.3250862198258, 1962.0876292524044, 65825.0, 67878.32121678769, 68168.31831681669, 68426.31573684249, 68568.31431685669, 8151.83696326082, 8310.626021829032, 8505.362097842686, 8539.103394143649, 8541.957290213633, 10939.0, 10944.726381840359, 11002.33985960829, 11055.889441105646, 11146.609868654721, 6419.2296924369375, 6517.739290428424, 6540.444062254666, 6674.466042716571, 6676.499262555328, 6456.192975878015, 6587.63767992765, 6646.634435106019, 6765.391114799593, 6783.287754785775, 3500.632433594487, 3513.8243087846017, 3528.5236493073107, 3561.28774245152, 3561.7506774526055, 1503.9699206015819, 1694.8559372453233, 1742.0, 1780.1722199177445, 1806.0, 816.4040250616964, 821.1542111625035, 847.2713466418875, 849.2017503546647, 925.796324808541, 15817.209139542976, 16114.838851611334, 16316.988608221893, 16352.672946541003, 16463.588410289838, 829.707278481015, 871.6687658689784, 871.9956400218085, 874.2394117118148, 908.4776253654176, 9195.310351723647, 9260.953695231481, 9290.256779457628, 9310.86033709495, 9377.0, 284227.0, 284595.0, 390347.0, 390668.0, 393488.0, 81736.18263817404, 82720.58639706763, 82930.0, 83240.0, 84171.15828841756, 972.1590823937385, 981.5435822342645, 981.959123329259, 1041.0, 1043.7077618266896, 15459.536213913601, 15485.612859678598, 15605.765913511534, 15637.92181039133, 15909.363625454853, 35024.47463288002, 35660.64339356677, 36095.0, 36409.63590364062, 37519.06202344963, 47808.282875756195, 48233.5176648229, 49273.0, 50155.49844501654, 50460.243096354316, 7419.703211871681, 7466.925330746623, 7533.698652053857, 7546.735864244725, 7551.0, 8123.67505299805, 11260.324380537195, 11969.042476602026, 11996.880031199576, 12046.51813927433, 10029.14752246038, 10280.331778434378, 10354.689359319233, 10404.271700981162, 10444.63443779464, 4666.416697912761, 8743.38796284254, 9783.85324220123, 10447.216458765472, 10490.527926243185, 7141.750038748827, 10085.949570252102, 10225.181985440999, 10315.690529284133, 10373.236549786705, 7374.557526548424, 7405.888911666437, 7447.218042105717, 7511.136219334847, 7540.0951885771865, 9803.264755143251, 10137.189024877845, 10252.58989640406, 10513.894861051598, 10550.630727924487], "value": 7792.614745405532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.303561254985, 1429.9918557417018, 1564.2022568490074, 1751.2994802079174, 1751.351999760089, 6951.443884489241, 7699.692012319508, 7705.8844117338285, 8196.672133114684, 8205.056418511873, 7818.296353328199, 8048.718294859681, 8061.3550915926735, 8114.026316841972, 8161.714339998086, 2202.845800793941, 2219.511707424364, 2239.3393948785065, 2240.5630901974123, 2241.932742017742, 2157.5037741319506, 2172.750133734625, 2179.2372669565602, 2199.83501237407, 2205.2171479124922, 2183.0285522942295, 2202.7907348801837, 2203.1077413647417, 2207.0509680837313, 2242.551489702058, 2155.91376344946, 2160.3734916874087, 2160.7839216078346, 2163.177992362908, 2163.621366260898, 2124.936251912445, 2162.1243396424475, 2180.4766855954617, 2184.1263494602126, 2204.0742887986926, 8060.274575288252, 8071.394645401619, 8076.798080047987, 8079.919200807975, 8080.555569443678, 4321.82712691492, 4401.757903315316, 4432.601065904084, 4442.111577684444, 4452.354408610766, 2689.1125928443566, 2752.8073034887566, 2805.1304095730184, 2818.7604053655464, 2870.3398218409884, 820.4379999700164, 820.6635279535421, 824.9711260105868, 840.0213750980101, 842.5239739547136, 10197.184225262035, 10200.3369780964, 10203.744906377326, 10246.59013639461, 10247.487625618689, 4093.3450647896193, 4121.711480196417, 4226.344916537942, 4234.661227101825, 4252.510961239497, 8746.56267186638, 8802.0, 8846.955765221133, 8873.0, 8881.955590222136, 4454.57681520255, 4520.480144783326, 4524.909501809945, 4536.206163921301, 4540.318952157203, 3614.7831130132276, 3900.4539364488996, 4056.6957478188665, 4087.1212689271947, 4123.195976784498, 3638.9636103639154, 3724.571674257441, 3839.9424008639894, 3847.634474724897, 3862.942055869164, 1165.3532289579196, 1180.4451907603413, 1188.061431469147, 1190.2501424102934, 1197.550918405598, 733.0873063036554, 791.1811275330006, 835.6197929941862, 863.1713554987157, 867.089555966233, 5355.036093503207, 5587.3015873015875, 5635.380108188096, 5754.165645981393, 5835.0, 852.9445586036887, 857.8069934264865, 866.3026263857529, 910.8314961732101, 920.604140219712, 3756.398976163801, 3960.9009774755286, 4061.3095773718537, 4103.7948102594755, 4186.623203911662, 9291.256699464027, 9565.04349565038, 9624.51877406127, 9630.903690963001, 9634.566444510014, 9480.478573678376, 9487.288453366025, 9509.096635819586, 9580.56887440067, 9587.280953928483, 6896.069030680894, 7219.639018049076, 7224.0608720867, 7224.927750722425, 7236.529625574321, 5276.15581506957, 5288.9735551322, 5300.5759539236, 5367.543758780391, 5395.622306438511, 8286.544240066854, 8311.501309921425, 8317.875231871405, 8361.080281169188, 8430.578471076544, 8293.543855088028, 8476.915230847613, 8676.479411235347, 8704.477731336141, 8827.293816494794, 6248.312685604671, 6591.176102987127, 6764.729410823709, 6862.0, 6950.270221626656, 6990.300969902969, 7037.225905150327, 7060.0, 7079.0, 7116.359527642537, 6495.090687303876, 6750.594964301961, 6772.762953296611, 6786.253512113763, 6798.218204906499, 6612.107365505595, 6672.399484046459, 6766.560173588701, 6844.657767111525, 6881.071055407456, 6219.937800621936, 6231.626102433868, 6251.156093927261, 6266.592671476339, 6266.592671476339, 4542.88642783933, 4545.931811022771, 4616.492185859485, 4639.257718764981, 4689.226277664284, 4781.163296423042, 4829.879253018703, 4857.732824694534, 4913.410390753133, 4981.153203955409], "value": 4131.500632408474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.1930440331844, 286.624521876342, 288.4418649912419, 290.638155496407, 292.5713829240163, 4864.7567621618955, 4945.950540494594, 5011.3986321641405, 5077.873053173668, 5114.258432527281, 5010.749462526877, 5021.623378246628, 5043.0, 5049.929528893154, 5060.569851562622, 3902.6682731967676, 3917.843286268546, 3927.9803600982027, 3928.430377595247, 3937.803109844511, 3665.7433979621437, 3925.6663183629425, 3944.881653550384, 3947.8223479943326, 3964.8612298569556, 3822.8279727412196, 3851.42228665701, 3856.5179352580926, 3861.9420708689254, 3872.8838134856, 3782.978595779124, 3826.617338266165, 3835.42468629705, 3855.9228815423535, 3860.4595356650093, 3309.4870295104297, 3335.6497567755277, 3345.59852817661, 3346.130006198406, 3350.79895206286, 4748.406449193851, 4837.274408838667, 4888.728930478102, 4894.580571634222, 4900.779464924087, 4393.8462153824785, 4417.823287068545, 4422.783734473013, 4426.601605855489, 4434.312681534335, 5271.235670827747, 5277.155655095205, 5278.181881808326, 5278.709670968095, 5284.418713941502, 3510.1751088494184, 3577.982110089433, 3640.854365825364, 3660.9267814643827, 3665.725070619714, 5483.945160548384, 5486.670799752028, 5529.612927095105, 5549.750261238254, 5567.638103523299, 3667.908302292464, 3668.4680721295795, 3693.9445908311395, 3704.407294832814, 3721.1627383838418, 3725.2177042820767, 3736.1406876418578, 3737.3085979093953, 3773.6981041516615, 3805.1058001369656, 4200.978995105066, 4387.890302742457, 4398.64810815134, 4404.0, 4409.801558929856, 5305.867353316198, 5316.494932981361, 5331.226972089025, 5338.279332290091, 5345.786168553214, 1216.227695413401, 1250.4685508658783, 1275.7193417448148, 1277.3166355999497, 1282.2883299768719, 793.714262865368, 796.4464697035505, 815.38031096366, 828.349745449819, 829.3738227638095, 4148.543660197376, 4178.26880295947, 4183.518895327015, 4190.224808410454, 4208.410822484854, 4775.450823155312, 4790.030181287624, 4832.9275060874115, 4840.782164802592, 4895.6083513318845, 4164.541900390955, 4167.249895018865, 4189.183109293658, 4189.706720529594, 4193.937090943638, 2508.2600632813364, 2514.4091138582417, 2545.4145546524405, 2588.2494076717917, 2595.610658401255, 4475.373447717322, 4503.842365517256, 4521.434820647419, 4538.978729785772, 4560.693497214493, 4859.22638237041, 4897.461279259279, 4924.162892308316, 4927.876803079952, 4999.150314383702, 4537.977310113428, 4846.830360937351, 5208.8437346879655, 5210.739463026834, 5217.739113044408, 5571.972140139435, 5580.353795630218, 5586.52514536269, 5590.413006634245, 5590.636608620427, 5251.973740131275, 5375.6023433906685, 5390.299261096033, 5438.15708565173, 5454.8909021818545, 5169.121249387538, 5170.302009228856, 5198.610104242121, 5202.323697919246, 5217.973910130425, 3699.6300369962787, 3712.533549247978, 3713.424419214918, 3718.944215836819, 3723.5345581802276, 5329.360476742816, 5487.6158668894395, 5492.286002819608, 5535.529479994246, 5536.197251398444, 5328.413874473727, 5346.117890548016, 5357.874846282324, 5397.8110766123, 5424.972875135599, 5337.386200586982, 5343.957928203963, 5363.115086010765, 5371.731413429391, 5394.730263486731, 5155.32980712505, 5273.630845840754, 5296.867578310573, 5303.7082960436, 5315.149576067965, 5344.54571361423, 5388.892222155613, 5395.78416863321, 5399.190121481809, 5414.160805075062, 5261.789528418821, 5285.365756109138, 5286.955479058446, 5289.7355132242465, 5291.8677033072945], "value": 3862.347936418132, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.9162500499938, 702.8453740177162, 718.0665135324077, 722.3931897206348, 758.5069704691952, 11715.297082175075, 12300.630981070572, 12595.937020314908, 12654.557090501847, 12906.935465322684, 13743.10669806462, 14394.712105757879, 14452.855471445282, 14455.0, 14466.059706119095, 626.7994241842612, 769.3614300130906, 774.7598244544181, 782.3467404717068, 784.568487331968, 765.185077892046, 788.917163697812, 789.5617932047711, 791.8337149198675, 794.3883209928381, 830.0371568979984, 831.2934006094831, 832.2551316571664, 832.5088197963231, 832.9292010179142, 822.2024636102971, 823.1151512124491, 825.5088222507599, 825.9008918929707, 826.450410477032, 606.8573885136989, 607.9148919151322, 608.3764141754692, 608.5557542993639, 609.3449541742644, 12753.298568578724, 12856.292903890282, 12858.549950751678, 12867.678308042281, 12887.420066097047, 13016.544420945316, 13179.670508237275, 13202.968101381903, 13382.330883455885, 13588.32058397086, 10485.633002844865, 10564.894351056468, 10744.876451858887, 10769.407682577455, 10810.621628242974, 3263.396271689745, 3301.669833016679, 3320.5019247112887, 3353.496975453677, 3410.181556426465, 63450.0, 64042.0, 64177.35822641761, 64253.03620445697, 64723.0, 9543.236541076698, 9972.351797133164, 10365.481725913674, 10618.415987120783, 10625.149988000941, 18277.360292389967, 18654.626907461774, 18674.066296685112, 18753.437396878115, 18825.435236942914, 6401.839954001187, 7047.647617619201, 7162.856742865113, 7228.566286022856, 7259.6370181491775, 3777.131259810259, 3854.094287842355, 3866.6326698963553, 3876.96123038766, 4012.799360031987, 2952.601398811133, 3055.1292881528657, 3063.433264846011, 3065.693430656961, 3065.754739620825, 520.6433592988815, 525.5559052600623, 530.191458026505, 533.6637918111643, 540.4892376704056, 529.4149964289481, 581.9796307129315, 584.1763114009311, 587.5358466811172, 621.5493767018875, 8783.560821959005, 8923.561280583232, 8929.642814287487, 8939.463632182089, 9228.35401521887, 521.2494008627564, 616.8735409241095, 624.5877720704405, 631.6652174347603, 632.1181951178173, 4036.2734707752297, 4076.9184616307507, 4081.6326530612387, 4165.812538435717, 4199.223143718422, 83219.0, 84985.57507212424, 88718.55640721755, 88791.0, 89451.0, 64092.35907640864, 76154.61922690351, 78054.60972695214, 78978.21021789823, 79534.0, 68557.0, 69357.30642693509, 69737.3026269741, 70020.64989675122, 70531.2946870535, 8338.0, 8418.116097809887, 8501.447405918596, 8549.27331176857, 8746.2128408441, 43065.770067244455, 43269.350959735, 43347.783261083496, 43465.0, 43888.561114388445, 60669.0, 61828.0, 61864.69067654633, 61918.38081619126, 62146.37853621406, 10054.420554911256, 10181.389116653025, 10184.898151018395, 10245.948770256102, 10253.231007674603, 11002.174836887105, 11078.554763480057, 11218.55125794959, 11526.94236528812, 11612.245204061708, 10434.68695939123, 10737.0, 11612.593559225725, 11645.0, 11674.883251167379, 11097.89021097916, 11212.0, 11555.653330400102, 11803.704907377385, 11816.40917954116, 10930.45347732626, 11056.336619802838, 11523.13576481784, 11698.590549330733, 11754.118441117122, 8053.852266082855, 8478.3641226907, 8539.487630742175, 8592.699255526026, 8639.179277968582, 9620.567074481525, 9680.370775899544, 9787.314887958059, 9835.544135699854, 9868.703938881845], "value": 6509.458122076869, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 113.0, 116.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 154.0, 191.0, 134.0, 170.0, 164.0, 133.0, 198.0, 132.0], "value": 157.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 177.0, 163.0, 164.0, 163.0, 166.0, 163.0, 162.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 178.0, 77.0, 76.0, 76.0, 75.0, 160.0, 77.0], "value": 94.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 156.0, 87.0, 87.0, 87.0, 138.0, 87.0, 87.0, 134.0], "value": 103.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 102.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 71.0, 67.0, 65.0, 66.0, 65.0, 65.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 86.0, 84.0, 85.0, 91.0, 87.0, 116.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 141.0, 134.0, 149.0, 134.0, 137.0, 147.0, 151.0, 134.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 176.0, 176.0, 169.0, 171.0, 173.0, 172.0, 178.0, 176.0, 172.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 66.0, 67.0, 69.0, 68.0, 68.0, 68.0, 67.0], "value": 67.7, "unit": "score"}]}]} 14:54:57 INFO - Return code: 0 14:54:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:54:57 ERROR - # TBPL SUCCESS # 14:54:57 INFO - Running post-action listener: _resource_record_post_action 14:54:57 INFO - ##### 14:54:57 INFO - ##### Finished run-tests step (success) 14:54:57 INFO - ##### 14:54:57 INFO - Running post-run listener: _resource_record_post_run 14:54:57 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553668608; Read time: 20; Write time: 612336 14:54:57 INFO - TinderboxPrint: CPU usage
13.5% 14:54:57 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:54:57 INFO - TinderboxPrint: I/O write bytes / time
553,668,608 / 612,336 14:54:57 INFO - TinderboxPrint: CPU idle
8,262.8 (86.5%) 14:54:57 INFO - TinderboxPrint: CPU user
1,231.1 (12.9%) 14:54:57 INFO - TinderboxPrint: Swap in / out
0 / 0 14:54:57 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237498368; Read time: 0; Write time: 316008 14:54:57 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 298188800; Read time: 20; Write time: 291044 14:54:57 INFO - Running post-run listener: _upload_blobber_files 14:54:57 INFO - Blob upload gear active. 14:54:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:54:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:54:57 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:54:57 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:54:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:54:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:54:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:54:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:54:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:54:59 INFO - (blobuploader) - INFO - Done attempting. 14:54:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:54:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:54:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:03 INFO - (blobuploader) - INFO - Done attempting. 14:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:04 INFO - (blobuploader) - INFO - Done attempting. 14:55:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:55:04 INFO - Return code: 0 14:55:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:55:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:55:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e019fe25140ebe178f9335e060fafc706a3c554df40320f6a208a357304b584b3fde4fb8607e0a9448fcff6187e4879bf8ff257c34a462ce4958da7bea549790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e75dd2cb7b8ccf814a3228601f5d5676076c0d2c231bdb7a475d04fce35391e65907ece706502fd7b6803d7dfece12beaf7b061b5c90aaa420fd762404a177a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a34f857f0e014650bbfec837f64353cea3c77fe44c73a0bf12055b43182f9e3fbbe9e7ee70762b97e1eff17351b46e68bd1212398edd3808afa8535e3b8e9"} 14:55:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:55:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:55:04 INFO - Contents: 14:55:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e019fe25140ebe178f9335e060fafc706a3c554df40320f6a208a357304b584b3fde4fb8607e0a9448fcff6187e4879bf8ff257c34a462ce4958da7bea549790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e75dd2cb7b8ccf814a3228601f5d5676076c0d2c231bdb7a475d04fce35391e65907ece706502fd7b6803d7dfece12beaf7b061b5c90aaa420fd762404a177a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a34f857f0e014650bbfec837f64353cea3c77fe44c73a0bf12055b43182f9e3fbbe9e7ee70762b97e1eff17351b46e68bd1212398edd3808afa8535e3b8e9"} 14:55:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:55:04 INFO - Copying logs to upload dir... 14:55:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:55:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.973926 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-06-06 14:55:04.043764) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:55:04.047064) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e019fe25140ebe178f9335e060fafc706a3c554df40320f6a208a357304b584b3fde4fb8607e0a9448fcff6187e4879bf8ff257c34a462ce4958da7bea549790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e75dd2cb7b8ccf814a3228601f5d5676076c0d2c231bdb7a475d04fce35391e65907ece706502fd7b6803d7dfece12beaf7b061b5c90aaa420fd762404a177a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a34f857f0e014650bbfec837f64353cea3c77fe44c73a0bf12055b43182f9e3fbbe9e7ee70762b97e1eff17351b46e68bd1212398edd3808afa8535e3b8e9"} build_url:https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/FXZXbEsYSs6rzcRtzSo_eg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e019fe25140ebe178f9335e060fafc706a3c554df40320f6a208a357304b584b3fde4fb8607e0a9448fcff6187e4879bf8ff257c34a462ce4958da7bea549790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e75dd2cb7b8ccf814a3228601f5d5676076c0d2c231bdb7a475d04fce35391e65907ece706502fd7b6803d7dfece12beaf7b061b5c90aaa420fd762404a177a6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/105a34f857f0e014650bbfec837f64353cea3c77fe44c73a0bf12055b43182f9e3fbbe9e7ee70762b97e1eff17351b46e68bd1212398edd3808afa8535e3b8e9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:55:04.071620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:55:04.071931) ========= 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=20e666a3d4cfbb71505a330e000001b4-1465248455.14361-2003602478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:55:04.157407) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:55:04.157798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:55:04.158112) ========= ========= Total master_lag: 0.18 =========