builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1467527017.62 results: success (0) buildid: 20160702004021 builduid: cba7f276d3d54b85ad6d3821d90a3962 revision: b59259518acd507a14c72a0f106f70158ef8d7c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.617727) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.618780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.619469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.636763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.637436) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:23:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-07-02 23:23:38 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.778282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.778995) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.830392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:37.830758) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b59259518acd507a14c72a0f106f70158ef8d7c6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b59259518acd507a14c72a0f106f70158ef8d7c6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:23:38,919 truncating revision to first 12 chars 2016-07-02 23:23:38,919 Setting DEBUG logging. 2016-07-02 23:23:38,920 attempt 1/10 2016-07-02 23:23:38,920 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b59259518acd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:23:39,246 unpacking tar archive at: mozilla-aurora-b59259518acd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671383 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:38.516443) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:38.516827) ========= script_repo_revision: b59259518acd507a14c72a0f106f70158ef8d7c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:38.517270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:38.517587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:23:38.528849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-02 23:23:38.529178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:23:39 INFO - MultiFileLogger online at 20160702 23:23:39 in /builds/slave/test 23:23:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:23:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:23:39 INFO - {'append_to_log': False, 23:23:39 INFO - 'base_work_dir': '/builds/slave/test', 23:23:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:23:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:23:39 INFO - 'branch': 'Mozilla-Aurora', 23:23:39 INFO - 'buildbot_json_path': 'buildprops.json', 23:23:39 INFO - 'config_files': ('talos/linux_config.py',), 23:23:39 INFO - 'default_actions': ('clobber', 23:23:39 INFO - 'read-buildbot-config', 23:23:39 INFO - 'download-and-extract', 23:23:39 INFO - 'populate-webroot', 23:23:39 INFO - 'create-virtualenv', 23:23:39 INFO - 'install', 23:23:39 INFO - 'run-tests'), 23:23:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:23:39 INFO - 'download_minidump_stackwalk': True, 23:23:39 INFO - 'download_symbols': 'ondemand', 23:23:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:23:39 INFO - 'tooltool.py': '/tools/tooltool.py', 23:23:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:23:39 INFO - '/tools/misc-python/virtualenv.py')}, 23:23:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:23:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:23:39 INFO - 'installer_path': 'installer.exe', 23:23:39 INFO - 'log_level': 'info', 23:23:39 INFO - 'log_name': 'talos', 23:23:39 INFO - 'log_to_console': True, 23:23:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:23:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:23:39 INFO - 'opt_config_files': (), 23:23:39 INFO - 'pip_index': False, 23:23:39 INFO - 'sps_profile': False, 23:23:39 INFO - 'sps_profile_interval': 0, 23:23:39 INFO - 'suite': 'dromaeojs', 23:23:39 INFO - 'system_bits': '32', 23:23:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:23:39 INFO - 'title': 'talos-linux64-ix-035', 23:23:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:23:39 INFO - 'use_talos_json': True, 23:23:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:23:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:23:39 INFO - 'work_dir': 'build'} 23:23:39 INFO - ##### 23:23:39 INFO - ##### Running clobber step. 23:23:39 INFO - ##### 23:23:39 INFO - Running pre-action listener: _resource_record_pre_action 23:23:39 INFO - Running main action method: clobber 23:23:39 INFO - rmtree: /builds/slave/test/build 23:23:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:23:40 INFO - Running post-action listener: _resource_record_post_action 23:23:40 INFO - ##### 23:23:40 INFO - ##### Finished clobber step (success) 23:23:40 INFO - ##### 23:23:40 INFO - ##### 23:23:40 INFO - ##### Running read-buildbot-config step. 23:23:40 INFO - ##### 23:23:40 INFO - Running pre-action listener: _resource_record_pre_action 23:23:40 INFO - Running main action method: read_buildbot_config 23:23:40 INFO - Using buildbot properties: 23:23:40 INFO - { 23:23:40 INFO - "project": "", 23:23:40 INFO - "product": "firefox", 23:23:40 INFO - "script_repo_revision": "production", 23:23:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:23:40 INFO - "repository": "", 23:23:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:23:40 INFO - "buildid": "20160702004021", 23:23:40 INFO - "stage_platform": "linux64-pgo", 23:23:40 INFO - "basedir": "/builds/slave/test", 23:23:40 INFO - "nightly_build": "True", 23:23:40 INFO - "buildnumber": 334, 23:23:40 INFO - "slavename": "talos-linux64-ix-035", 23:23:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:23:40 INFO - "platform": "ubuntu64_hw", 23:23:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:23:40 INFO - "branch": "mozilla-aurora", 23:23:40 INFO - "repo_path": "releases/mozilla-aurora", 23:23:40 INFO - "revision": "b59259518acd507a14c72a0f106f70158ef8d7c6", 23:23:40 INFO - "pgo_build": "True", 23:23:40 INFO - "builduid": "cba7f276d3d54b85ad6d3821d90a3962", 23:23:40 INFO - "slavebuilddir": "test" 23:23:40 INFO - } 23:23:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 23:23:40 INFO - Running post-action listener: _resource_record_post_action 23:23:40 INFO - ##### 23:23:40 INFO - ##### Finished read-buildbot-config step (success) 23:23:40 INFO - ##### 23:23:40 INFO - ##### 23:23:40 INFO - ##### Running download-and-extract step. 23:23:40 INFO - ##### 23:23:40 INFO - Running pre-action listener: _resource_record_pre_action 23:23:40 INFO - Running main action method: download_and_extract 23:23:40 INFO - mkdir: /builds/slave/test/build/tests 23:23:40 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')]} 23:23:40 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:23:40 INFO - Downloaded 1361 bytes. 23:23:40 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 23:23:40 INFO - Using the following test package requirements: 23:23:40 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:23:40 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:23:40 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:23:40 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'jsshell-linux-x86_64.zip'], 23:23:40 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:23:40 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 23:23:40 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:23:40 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:23:40 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:23:40 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 23:23:40 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:23:40 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:23:40 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')]} 23:23:40 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:23:41 INFO - Downloaded 24526247 bytes. 23:23:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:23:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:23:43 INFO - Return code: 0 23:23:43 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:23: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')]} 23:23:43 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 23:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:23:44 INFO - Downloaded 24526247 bytes. 23:23:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:23:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:23:45 INFO - Return code: 0 23:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:45 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:23:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:23:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:23:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 23:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:23:46 INFO - Downloaded 10833369 bytes. 23:23:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:23:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:23:46 INFO - Return code: 0 23:23: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')]} 23:23:46 INFO - https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:23:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:23:48 INFO - Downloaded 63606784 bytes. 23:23:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:48 INFO - mkdir: /builds/slave/test/properties 23:23:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:23:48 INFO - Writing to file /builds/slave/test/properties/build_url 23:23:48 INFO - Contents: 23:23:48 INFO - build_url:https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 23:23:48 INFO - Running post-action listener: _resource_record_post_action 23:23:48 INFO - Running post-action listener: set_extra_try_arguments 23:23:48 INFO - ##### 23:23:48 INFO - ##### Finished download-and-extract step (success) 23:23:48 INFO - ##### 23:23:48 INFO - ##### 23:23:48 INFO - ##### Running populate-webroot step. 23:23:48 INFO - ##### 23:23:48 INFO - Running pre-action listener: _resource_record_pre_action 23:23:48 INFO - Running main action method: populate_webroot 23:23:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:23:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:23:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:23:48 INFO - '--tppagecycles', 23:23:48 INFO - '7'], 23:23:48 INFO - 'tests': ['tsvgm']}}, 23:23:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:23:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:23:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:23:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:23:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:23:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:23:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['damp', 'tps']}, 23:23:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'tests': ['damp', 'tps']}, 23:23:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['dromaeo_dom']}, 23:23:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:23:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['a11yr', 23:23:48 INFO - 'ts_paint', 23:23:48 INFO - 'tpaint', 23:23:48 INFO - 'sessionrestore', 23:23:48 INFO - 'sessionrestore_no_auto_restore', 23:23:48 INFO - 'tabpaint']}, 23:23:48 INFO - 'other-e10s': {'tests': ['a11yr', 23:23:48 INFO - 'ts_paint', 23:23:48 INFO - 'tpaint', 23:23:48 INFO - 'sessionrestore', 23:23:48 INFO - 'sessionrestore_no_auto_restore', 23:23:48 INFO - 'tabpaint']}, 23:23:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:23:48 INFO - 'ts_paint', 23:23:48 INFO - 'tpaint', 23:23:48 INFO - 'sessionrestore', 23:23:48 INFO - 'sessionrestore_no_auto_restore', 23:23:48 INFO - 'tabpaint']}, 23:23:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:23:48 INFO - 'ts_paint', 23:23:48 INFO - 'tpaint', 23:23:48 INFO - 'sessionrestore', 23:23:48 INFO - 'sessionrestore_no_auto_restore', 23:23:48 INFO - 'tabpaint']}, 23:23:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['a11yr', 23:23:48 INFO - 'ts_paint', 23:23:48 INFO - 'tpaint', 23:23:48 INFO - 'sessionrestore', 23:23:48 INFO - 'sessionrestore_no_auto_restore', 23:23:48 INFO - 'tabpaint']}, 23:23:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['a11yr', 23:23:48 INFO - 'ts_paint', 23:23:48 INFO - 'tpaint', 23:23:48 INFO - 'sessionrestore', 23:23:48 INFO - 'sessionrestore_no_auto_restore', 23:23:48 INFO - 'tabpaint']}, 23:23:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['tsvgx', 23:23:48 INFO - 'tsvgr_opacity', 23:23:48 INFO - 'tart', 23:23:48 INFO - 'tscrollx', 23:23:48 INFO - 'cart']}, 23:23:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:23:48 INFO - 'tsvgr_opacity', 23:23:48 INFO - 'tart', 23:23:48 INFO - 'tscrollx', 23:23:48 INFO - 'cart']}, 23:23:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'talos_options': ['--disable-e10s'], 23:23:48 INFO - 'tests': ['tp5o']}, 23:23:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'tests': ['tp5o']}, 23:23:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'talos_options': ['--disable-e10s', 23:23:48 INFO - '--xperf_path', 23:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:23:48 INFO - 'tests': ['tp5n']}, 23:23:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:23:48 INFO - 'talos_options': ['--xperf_path', 23:23:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:23:48 INFO - 'tests': ['tp5n']}}, 23:23:48 INFO - 'talos.zip': {'path': '', 23:23:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:23:48 INFO - Running post-action listener: _resource_record_post_action 23:23:48 INFO - ##### 23:23:48 INFO - ##### Finished populate-webroot step (success) 23:23:48 INFO - ##### 23:23:48 INFO - ##### 23:23:48 INFO - ##### Running create-virtualenv step. 23:23:48 INFO - ##### 23:23:48 INFO - Running pre-action listener: _resource_record_pre_action 23:23:48 INFO - Running main action method: create_virtualenv 23:23:48 INFO - Creating virtualenv /builds/slave/test/build/venv 23:23:48 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 23:23:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:23:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:23:49 INFO - Using real prefix '/usr' 23:23:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:23:49 INFO - Installing distribute.............................................................................................................................................................................................done. 23:23:51 INFO - Installing pip.................done. 23:23:51 INFO - Return code: 0 23:23:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:51 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 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:23:51 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 23:23:51 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 23:23:51 INFO - Using env: {'DISPLAY': ':0', 23:23:51 INFO - 'HOME': '/home/cltbld', 23:23:51 INFO - 'LANG': 'en_US.UTF-8', 23:23:51 INFO - 'LANGUAGE': 'en_US:en', 23:23:51 INFO - 'LOGNAME': 'cltbld', 23:23:51 INFO - 'MAIL': '/var/mail/cltbld', 23:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:51 INFO - 'MOZ_NO_REMOTE': '1', 23:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:51 INFO - 'NO_EM_RESTART': '1', 23:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:51 INFO - 'PWD': '/builds/slave/test', 23:23:51 INFO - 'SHELL': '/bin/bash', 23:23:51 INFO - 'SHLVL': '1', 23:23:51 INFO - 'TERM': 'linux', 23:23:51 INFO - 'TMOUT': '86400', 23:23:51 INFO - 'USER': 'cltbld', 23:23:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:51 INFO - '_': '/tools/buildbot/bin/python'} 23:23:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:51 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 23:23:51 INFO - Cleaning up... 23:23:51 INFO - Return code: 0 23:23:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:23:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:51 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 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:23:51 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 23:23:51 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 23:23:51 INFO - Using env: {'DISPLAY': ':0', 23:23:51 INFO - 'HOME': '/home/cltbld', 23:23:51 INFO - 'LANG': 'en_US.UTF-8', 23:23:51 INFO - 'LANGUAGE': 'en_US:en', 23:23:51 INFO - 'LOGNAME': 'cltbld', 23:23:51 INFO - 'MAIL': '/var/mail/cltbld', 23:23:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:51 INFO - 'MOZ_NO_REMOTE': '1', 23:23:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:51 INFO - 'NO_EM_RESTART': '1', 23:23:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:51 INFO - 'PWD': '/builds/slave/test', 23:23:51 INFO - 'SHELL': '/bin/bash', 23:23:51 INFO - 'SHLVL': '1', 23:23:51 INFO - 'TERM': 'linux', 23:23:51 INFO - 'TMOUT': '86400', 23:23:51 INFO - 'USER': 'cltbld', 23:23:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:23:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:51 INFO - '_': '/tools/buildbot/bin/python'} 23:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:52 INFO - Downloading/unpacking psutil>=3.1.1 23:23:52 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 23:23:52 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 23:23:52 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 23:23:52 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 23:23:52 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 23:23:52 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 23:23:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:54 INFO - Installing collected packages: psutil 23:23:54 INFO - Running setup.py install for psutil 23:23:54 INFO - building 'psutil._psutil_linux' extension 23:23:54 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 23:23:54 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 23:23:54 INFO - building 'psutil._psutil_posix' extension 23:23:54 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 23:23:54 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 23:23:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:23:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:23:54 INFO - Successfully installed psutil 23:23:54 INFO - Cleaning up... 23:23:54 INFO - Return code: 0 23:23:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:23:54 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')]} 23:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:54 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')]} 23:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:54 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 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:23:54 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 23:23:54 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 23:23:54 INFO - Using env: {'DISPLAY': ':0', 23:23:54 INFO - 'HOME': '/home/cltbld', 23:23:54 INFO - 'LANG': 'en_US.UTF-8', 23:23:54 INFO - 'LANGUAGE': 'en_US:en', 23:23:54 INFO - 'LOGNAME': 'cltbld', 23:23:54 INFO - 'MAIL': '/var/mail/cltbld', 23:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:54 INFO - 'MOZ_NO_REMOTE': '1', 23:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:54 INFO - 'NO_EM_RESTART': '1', 23:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:54 INFO - 'PWD': '/builds/slave/test', 23:23:54 INFO - 'SHELL': '/bin/bash', 23:23:54 INFO - 'SHLVL': '1', 23:23:54 INFO - 'TERM': 'linux', 23:23:54 INFO - 'TMOUT': '86400', 23:23:54 INFO - 'USER': 'cltbld', 23:23:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:54 INFO - '_': '/tools/buildbot/bin/python'} 23:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:23:56 INFO - Installing collected packages: mozsystemmonitor 23:23:56 INFO - Running setup.py install for mozsystemmonitor 23:23:56 INFO - Successfully installed mozsystemmonitor 23:23:56 INFO - Cleaning up... 23:23:56 INFO - Return code: 0 23:23:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:23: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')]} 23:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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')]} 23:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:23: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==2.5.1'] in /builds/slave/test/build 23:23: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==2.5.1 23:23:56 INFO - Using env: {'DISPLAY': ':0', 23:23:56 INFO - 'HOME': '/home/cltbld', 23:23:56 INFO - 'LANG': 'en_US.UTF-8', 23:23:56 INFO - 'LANGUAGE': 'en_US:en', 23:23:56 INFO - 'LOGNAME': 'cltbld', 23:23:56 INFO - 'MAIL': '/var/mail/cltbld', 23:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:56 INFO - 'MOZ_NO_REMOTE': '1', 23:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:56 INFO - 'NO_EM_RESTART': '1', 23:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:56 INFO - 'PWD': '/builds/slave/test', 23:23:56 INFO - 'SHELL': '/bin/bash', 23:23:56 INFO - 'SHLVL': '1', 23:23:56 INFO - 'TERM': 'linux', 23:23:56 INFO - 'TMOUT': '86400', 23:23:56 INFO - 'USER': 'cltbld', 23:23:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:56 INFO - '_': '/tools/buildbot/bin/python'} 23:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:57 INFO - Downloading/unpacking jsonschema==2.5.1 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:23:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:23:59 INFO - Downloading functools32-3.2.3-2.tar.gz 23:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:23:59 INFO - warning: no files found matching '*.txt' 23:23:59 INFO - no previously-included directories found matching 'build' 23:23:59 INFO - no previously-included directories found matching 'dist' 23:23:59 INFO - no previously-included directories found matching '.git*' 23:23:59 INFO - Installing collected packages: jsonschema, functools32 23:23:59 INFO - Running setup.py install for functools32 23:23:59 INFO - warning: no files found matching '*.txt' 23:23:59 INFO - no previously-included directories found matching 'build' 23:23:59 INFO - no previously-included directories found matching 'dist' 23:23:59 INFO - no previously-included directories found matching '.git*' 23:23:59 INFO - Successfully installed jsonschema functools32 23:23:59 INFO - Cleaning up... 23:23:59 INFO - Return code: 0 23:23:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:23:59 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')]} 23:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:59 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')]} 23:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:23:59 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 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:23:59 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 23:23:59 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 23:23:59 INFO - Using env: {'DISPLAY': ':0', 23:23:59 INFO - 'HOME': '/home/cltbld', 23:23:59 INFO - 'LANG': 'en_US.UTF-8', 23:23:59 INFO - 'LANGUAGE': 'en_US:en', 23:23:59 INFO - 'LOGNAME': 'cltbld', 23:23:59 INFO - 'MAIL': '/var/mail/cltbld', 23:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:23:59 INFO - 'MOZ_NO_REMOTE': '1', 23:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:23:59 INFO - 'NO_EM_RESTART': '1', 23:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:23:59 INFO - 'PWD': '/builds/slave/test', 23:23:59 INFO - 'SHELL': '/bin/bash', 23:23:59 INFO - 'SHLVL': '1', 23:23:59 INFO - 'TERM': 'linux', 23:23:59 INFO - 'TMOUT': '86400', 23:23:59 INFO - 'USER': 'cltbld', 23:23:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:23:59 INFO - '_': '/tools/buildbot/bin/python'} 23:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:23:59 INFO - Downloading/unpacking blobuploader==1.2.4 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:23: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 23:24:01 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:02 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 23:24:02 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 23:24:02 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 23:24:02 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 23:24:02 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 23:24:02 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 23:24:02 INFO - Downloading docopt-0.6.1.tar.gz 23:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:02 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:02 INFO - Running setup.py install for blobuploader 23:24:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:02 INFO - Running setup.py install for requests 23:24:02 INFO - Running setup.py install for docopt 23:24:02 INFO - Successfully installed blobuploader requests docopt 23:24:02 INFO - Cleaning up... 23:24:02 INFO - Return code: 0 23:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:02 INFO - Using env: {'DISPLAY': ':0', 23:24:02 INFO - 'HOME': '/home/cltbld', 23:24:02 INFO - 'LANG': 'en_US.UTF-8', 23:24:02 INFO - 'LANGUAGE': 'en_US:en', 23:24:02 INFO - 'LOGNAME': 'cltbld', 23:24:02 INFO - 'MAIL': '/var/mail/cltbld', 23:24:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:02 INFO - 'MOZ_NO_REMOTE': '1', 23:24:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:02 INFO - 'NO_EM_RESTART': '1', 23:24:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:02 INFO - 'PWD': '/builds/slave/test', 23:24:02 INFO - 'SHELL': '/bin/bash', 23:24:02 INFO - 'SHLVL': '1', 23:24:02 INFO - 'TERM': 'linux', 23:24:02 INFO - 'TMOUT': '86400', 23:24:02 INFO - 'USER': 'cltbld', 23:24:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:24:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:02 INFO - '_': '/tools/buildbot/bin/python'} 23:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:03 INFO - Running setup.py (path:/tmp/pip-kgCEz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:03 INFO - Running setup.py (path:/tmp/pip-lFUZmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:03 INFO - Running setup.py (path:/tmp/pip-PqqHbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:03 INFO - Running setup.py (path:/tmp/pip-XMtKen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:03 INFO - Running setup.py (path:/tmp/pip-r3J5zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:03 INFO - Running setup.py (path:/tmp/pip-w8Kuyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:03 INFO - Running setup.py (path:/tmp/pip-mhulmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:03 INFO - Running setup.py (path:/tmp/pip-rBdEPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:03 INFO - Running setup.py (path:/tmp/pip-MGQNVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:03 INFO - Running setup.py (path:/tmp/pip-4uFbLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:03 INFO - Running setup.py (path:/tmp/pip-UOBoii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:03 INFO - Running setup.py (path:/tmp/pip-PwWxV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:04 INFO - Running setup.py (path:/tmp/pip-B07yH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:04 INFO - Running setup.py (path:/tmp/pip-8A_R9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:04 INFO - Running setup.py (path:/tmp/pip-R_g4xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:04 INFO - Running setup.py (path:/tmp/pip-AExCBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:04 INFO - Running setup.py (path:/tmp/pip-pwN6Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:24:04 INFO - Running setup.py install for manifestparser 23:24:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:24:04 INFO - Running setup.py install for mozcrash 23:24:04 INFO - Running setup.py install for mozdebug 23:24:04 INFO - Running setup.py install for mozdevice 23:24:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:24:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:24:04 INFO - Running setup.py install for mozfile 23:24:04 INFO - Running setup.py install for mozhttpd 23:24:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:24:04 INFO - Running setup.py install for mozinfo 23:24:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Running setup.py install for mozInstall 23:24:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Running setup.py install for mozleak 23:24:05 INFO - Running setup.py install for mozlog 23:24:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Running setup.py install for moznetwork 23:24:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Running setup.py install for mozprocess 23:24:05 INFO - Running setup.py install for mozprofile 23:24:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Running setup.py install for mozrunner 23:24:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:24:05 INFO - Running setup.py install for mozscreenshot 23:24:05 INFO - Running setup.py install for moztest 23:24:06 INFO - Running setup.py install for mozversion 23:24:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:24:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:24:06 INFO - Cleaning up... 23:24:06 INFO - Return code: 0 23:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:06 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 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:24:06 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 23:24:06 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 23:24:06 INFO - Using env: {'DISPLAY': ':0', 23:24:06 INFO - 'HOME': '/home/cltbld', 23:24:06 INFO - 'LANG': 'en_US.UTF-8', 23:24:06 INFO - 'LANGUAGE': 'en_US:en', 23:24:06 INFO - 'LOGNAME': 'cltbld', 23:24:06 INFO - 'MAIL': '/var/mail/cltbld', 23:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:06 INFO - 'MOZ_NO_REMOTE': '1', 23:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:06 INFO - 'NO_EM_RESTART': '1', 23:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:06 INFO - 'PWD': '/builds/slave/test', 23:24:06 INFO - 'SHELL': '/bin/bash', 23:24:06 INFO - 'SHLVL': '1', 23:24:06 INFO - 'TERM': 'linux', 23:24:06 INFO - 'TMOUT': '86400', 23:24:06 INFO - 'USER': 'cltbld', 23:24:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:06 INFO - '_': '/tools/buildbot/bin/python'} 23:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:06 INFO - Running setup.py (path:/tmp/pip-HrUtaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:06 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)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:06 INFO - Running setup.py (path:/tmp/pip-kp_KGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:06 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)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:06 INFO - Running setup.py (path:/tmp/pip-FpOTK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:06 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)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:06 INFO - Running setup.py (path:/tmp/pip-DqMztE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:06 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)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:06 INFO - Running setup.py (path:/tmp/pip-8vYhC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:06 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)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:06 INFO - Running setup.py (path:/tmp/pip-fHAsFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:06 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)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:06 INFO - Running setup.py (path:/tmp/pip-sbnKnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:06 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)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:06 INFO - Running setup.py (path:/tmp/pip-XlEtqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:06 INFO - Running setup.py (path:/tmp/pip-5WDQzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:07 INFO - Running setup.py (path:/tmp/pip-A0a7p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:07 INFO - Running setup.py (path:/tmp/pip-o7G1TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:07 INFO - Running setup.py (path:/tmp/pip-B5664g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:07 INFO - Running setup.py (path:/tmp/pip-u1dTg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:07 INFO - Running setup.py (path:/tmp/pip-XwGo8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:07 INFO - Running setup.py (path:/tmp/pip-2vj32O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:07 INFO - Running setup.py (path:/tmp/pip-5o5zfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:07 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)) 23:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:07 INFO - Running setup.py (path:/tmp/pip-2KpJmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:07 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)) 23:24:07 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)) 23:24:07 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)) 23:24:07 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)) 23:24:07 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)) 23:24:07 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)) 23:24:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:09 INFO - Downloading blessings-1.6.tar.gz 23:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:24:09 INFO - Installing collected packages: blessings 23:24:09 INFO - Running setup.py install for blessings 23:24:09 INFO - Successfully installed blessings 23:24:09 INFO - Cleaning up... 23:24:09 INFO - Return code: 0 23:24:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:09 INFO - Reading from file tmpfile_stdout 23:24:09 INFO - Current package versions: 23:24:09 INFO - argparse == 1.2.1 23:24:09 INFO - blessings == 1.6 23:24:09 INFO - blobuploader == 1.2.4 23:24:09 INFO - docopt == 0.6.1 23:24:09 INFO - functools32 == 3.2.3-2 23:24:09 INFO - jsonschema == 2.5.1 23:24:09 INFO - manifestparser == 1.1 23:24:09 INFO - mozInstall == 1.12 23:24:09 INFO - mozcrash == 0.17 23:24:09 INFO - mozdebug == 0.1 23:24:09 INFO - mozdevice == 0.48 23:24:09 INFO - mozfile == 1.2 23:24:09 INFO - mozhttpd == 0.7 23:24:09 INFO - mozinfo == 0.9 23:24:09 INFO - mozleak == 0.1 23:24:09 INFO - mozlog == 3.2 23:24:09 INFO - moznetwork == 0.27 23:24:09 INFO - mozprocess == 0.22 23:24:09 INFO - mozprofile == 0.28 23:24:09 INFO - mozrunner == 6.11 23:24:09 INFO - mozscreenshot == 0.1 23:24:09 INFO - mozsystemmonitor == 0.3 23:24:09 INFO - moztest == 0.7 23:24:09 INFO - mozversion == 1.4 23:24:09 INFO - psutil == 3.1.1 23:24:09 INFO - requests == 1.2.3 23:24:09 INFO - wsgiref == 0.1.2 23:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:09 INFO - Using env: {'DISPLAY': ':0', 23:24:09 INFO - 'HOME': '/home/cltbld', 23:24:09 INFO - 'LANG': 'en_US.UTF-8', 23:24:09 INFO - 'LANGUAGE': 'en_US:en', 23:24:09 INFO - 'LOGNAME': 'cltbld', 23:24:09 INFO - 'MAIL': '/var/mail/cltbld', 23:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:09 INFO - 'MOZ_NO_REMOTE': '1', 23:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:09 INFO - 'NO_EM_RESTART': '1', 23:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:09 INFO - 'PWD': '/builds/slave/test', 23:24:09 INFO - 'SHELL': '/bin/bash', 23:24:09 INFO - 'SHLVL': '1', 23:24:09 INFO - 'TERM': 'linux', 23:24:09 INFO - 'TMOUT': '86400', 23:24:09 INFO - 'USER': 'cltbld', 23:24:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:09 INFO - '_': '/tools/buildbot/bin/python'} 23:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 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)) 23:24:10 INFO - Cleaning up... 23:24:10 INFO - Return code: 0 23:24:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:24:10 INFO - Using env: {'DISPLAY': ':0', 23:24:10 INFO - 'HOME': '/home/cltbld', 23:24:10 INFO - 'LANG': 'en_US.UTF-8', 23:24:10 INFO - 'LANGUAGE': 'en_US:en', 23:24:10 INFO - 'LOGNAME': 'cltbld', 23:24:10 INFO - 'MAIL': '/var/mail/cltbld', 23:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:10 INFO - 'MOZ_NO_REMOTE': '1', 23:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:10 INFO - 'NO_EM_RESTART': '1', 23:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:10 INFO - 'PWD': '/builds/slave/test', 23:24:10 INFO - 'SHELL': '/bin/bash', 23:24:10 INFO - 'SHLVL': '1', 23:24:10 INFO - 'TERM': 'linux', 23:24:10 INFO - 'TMOUT': '86400', 23:24:10 INFO - 'USER': 'cltbld', 23:24:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:10 INFO - '_': '/tools/buildbot/bin/python'} 23:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:24:10 INFO - Cleaning up... 23:24:10 INFO - Return code: 0 23:24:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0dc2ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2851350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', '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 23:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:24:10 INFO - Using env: {'DISPLAY': ':0', 23:24:10 INFO - 'HOME': '/home/cltbld', 23:24:10 INFO - 'LANG': 'en_US.UTF-8', 23:24:10 INFO - 'LANGUAGE': 'en_US:en', 23:24:10 INFO - 'LOGNAME': 'cltbld', 23:24:10 INFO - 'MAIL': '/var/mail/cltbld', 23:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:10 INFO - 'MOZ_NO_REMOTE': '1', 23:24:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:10 INFO - 'NO_EM_RESTART': '1', 23:24:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:10 INFO - 'PWD': '/builds/slave/test', 23:24:10 INFO - 'SHELL': '/bin/bash', 23:24:10 INFO - 'SHLVL': '1', 23:24:10 INFO - 'TERM': 'linux', 23:24:10 INFO - 'TMOUT': '86400', 23:24:10 INFO - 'USER': 'cltbld', 23:24:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:10 INFO - '_': '/tools/buildbot/bin/python'} 23:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:10 INFO - Downloading/unpacking flake8 23:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:24:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:24:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:24:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:24:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:24:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:24:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:24:13 INFO - no previously-included directories found matching 'docs/_build' 23:24:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:24:13 INFO - Running setup.py install for pep8 23:24:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:24:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:24:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:24:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:24:13 INFO - no previously-included directories found matching 'docs/_build' 23:24:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:24:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:24:13 INFO - Cleaning up... 23:24:13 INFO - Return code: 0 23:24:13 INFO - Running post-action listener: _resource_record_post_action 23:24:13 INFO - Running post-action listener: _start_resource_monitoring 23:24:13 INFO - Starting resource monitoring. 23:24:13 INFO - ##### 23:24:13 INFO - ##### Finished create-virtualenv step (success) 23:24:13 INFO - ##### 23:24:13 INFO - ##### 23:24:13 INFO - ##### Running install step. 23:24:13 INFO - ##### 23:24:13 INFO - Running pre-action listener: _resource_record_pre_action 23:24:13 INFO - Running main action method: install 23:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:13 INFO - Reading from file tmpfile_stdout 23:24:13 INFO - Detecting whether we're running mozinstall >=1.0... 23:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:24:13 INFO - Reading from file tmpfile_stdout 23:24:13 INFO - Output received: 23:24:13 INFO - Usage: mozinstall [options] installer 23:24:13 INFO - Options: 23:24:13 INFO - -h, --help show this help message and exit 23:24:13 INFO - -d DEST, --destination=DEST 23:24:13 INFO - Directory to install application into. [default: 23:24:13 INFO - "/builds/slave/test"] 23:24:13 INFO - --app=APP Application being installed. [default: firefox] 23:24:13 INFO - mkdir: /builds/slave/test/build/application 23:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:24:29 INFO - Reading from file tmpfile_stdout 23:24:29 INFO - Output received: 23:24:29 INFO - /builds/slave/test/build/application/firefox/firefox 23:24:29 INFO - Running post-action listener: _resource_record_post_action 23:24:29 INFO - ##### 23:24:29 INFO - ##### Finished install step (success) 23:24:29 INFO - ##### 23:24:29 INFO - ##### 23:24:29 INFO - ##### Running run-tests step. 23:24:29 INFO - ##### 23:24:29 INFO - Running pre-action listener: _resource_record_pre_action 23:24:29 INFO - Running main action method: run_tests 23:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:24:29 INFO - Python 2.7.3 23:24:29 INFO - Return code: 0 23:24:29 INFO - grabbing minidump binary from tooltool 23:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:24:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e01c0>, '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 0x28e10c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e1550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:24:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:24:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:24:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:24:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:24:29 INFO - Return code: 0 23:24:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:24:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:24:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:24:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:24:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:24:30 INFO - Return code: 0 23:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:24:30 INFO - Using env: {'DISPLAY': ':0', 23:24:30 INFO - 'HOME': '/home/cltbld', 23:24:30 INFO - 'LANG': 'en_US.UTF-8', 23:24:30 INFO - 'LANGUAGE': 'en_US:en', 23:24:30 INFO - 'LOGNAME': 'cltbld', 23:24:30 INFO - 'MAIL': '/var/mail/cltbld', 23:24:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:24:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:30 INFO - 'MOZ_NO_REMOTE': '1', 23:24:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:24:30 INFO - 'NO_EM_RESTART': '1', 23:24:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:30 INFO - 'PWD': '/builds/slave/test', 23:24:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:24:30 INFO - 'SHELL': '/bin/bash', 23:24:30 INFO - 'SHLVL': '1', 23:24:30 INFO - 'TERM': 'linux', 23:24:30 INFO - 'TMOUT': '86400', 23:24:30 INFO - 'USER': 'cltbld', 23:24:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935', 23:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:30 INFO - '_': '/tools/buildbot/bin/python'} 23:24:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:24:30 INFO - mozversion application_buildid: 20160702004021 23:24:30 INFO - mozversion application_changeset: b59259518acd507a14c72a0f106f70158ef8d7c6 23:24:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:24:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:24:30 INFO - mozversion application_name: Firefox 23:24:30 INFO - mozversion application_remotingname: firefox-dev 23:24:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:24:30 INFO - mozversion application_vendor: Mozilla 23:24:30 INFO - mozversion application_version: 49.0a2 23:24:30 INFO - mozversion platform_buildid: 20160702004021 23:24:30 INFO - mozversion platform_changeset: b59259518acd507a14c72a0f106f70158ef8d7c6 23:24:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:24:30 INFO - mozversion platform_version: 49.0a2 23:24:30 INFO - using testdate: 1467527070 23:24:30 INFO - actual date: 1467527070 23:24:30 INFO - starting webserver on 'localhost:48204' 23:24:30 INFO - SUITE-START | Running 2 tests 23:24:30 INFO - TEST-START | dromaeo_css 23:24:30 INFO - operating with platform_type : linux_ 23:24:30 INFO - Initialising browser for dromaeo_css test... 23:24:30 INFO - TEST-INFO | started process 6589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyyVPlE/profile http://localhost:48204/getInfo.html) 23:24:34 INFO - PROCESS | 6589 | __metrics Screen width/height:1600/1200 23:24:34 INFO - PROCESS | 6589 | colorDepth:24 23:24:34 INFO - PROCESS | 6589 | Browser inner width/height: 1024/697 23:24:34 INFO - PROCESS | 6589 | __metrics 23:24:35 ERROR - PROCESS | 6589 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:24:36 INFO - TEST-INFO | 6589: exit 0 23:24:36 INFO - Browser initialized. 23:24:36 INFO - Running cycle 1/1 for dromaeo_css test... 23:24:36 INFO - TEST-INFO | started process 6680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyyVPlE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:24:48 INFO - PROCESS | 6680 | RSS: Main: 145174528 23:24:48 INFO - PROCESS | 6680 | 23:25:39 INFO - PROCESS | 6680 | 1467527139422 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] 23:27:47 INFO - PROCESS | 6680 | Cycle 1(1): loaded http://localhost:48204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48204/tests/dromaeo/cssquery-ext.html) 23:27:48 INFO - PROCESS | 6680 | RSS: Main: 253845504 23:27:48 INFO - PROCESS | 6680 | 23:30:50 INFO - PROCESS | 6680 | Cycle 1(1): loaded http://localhost:48204/tests/dromaeo/cssquery-ext.html (next: http://localhost:48204/tests/dromaeo/cssquery-jquery.html) 23:30:51 INFO - PROCESS | 6680 | RSS: Main: 232382464 23:30:51 INFO - PROCESS | 6680 | 23:33:53 INFO - PROCESS | 6680 | Cycle 1(1): loaded http://localhost:48204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48204/tests/dromaeo/cssquery-mootools.html) 23:33:53 INFO - PROCESS | 6680 | RSS: Main: 235040768 23:33:53 INFO - PROCESS | 6680 | 23:36:55 INFO - PROCESS | 6680 | Cycle 1(1): loaded http://localhost:48204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48204/tests/dromaeo/cssquery-prototype.html) 23:36:56 INFO - PROCESS | 6680 | RSS: Main: 221057024 23:36:56 INFO - PROCESS | 6680 | 23:39:59 INFO - PROCESS | 6680 | Cycle 1(1): loaded http://localhost:48204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48204/tests/dromaeo/cssquery-yui.html) 23:39:59 INFO - PROCESS | 6680 | RSS: Main: 206970880 23:39:59 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | Cycle 1(1): loaded http://localhost:48204/tests/dromaeo/cssquery-yui.html (next: http://localhost:48204/tests/dromaeo/cssquery-dojo.html) 23:43:02 INFO - PROCESS | 6680 | RSS: Main: 256696320 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | __start_tp_report 23:43:02 INFO - PROCESS | 6680 | _x_x_mozilla_page_load 23:43:02 INFO - PROCESS | 6680 | _x_x_mozilla_page_load_details 23:43:02 INFO - PROCESS | 6680 | |i|pagename|runs| 23:43:02 INFO - PROCESS | 6680 | |0;dojo.html;3305.1241421023424;3330.5836770403685;3330.90007299781;3359.07625403014;3372.1906742381834;5433.48381903719;5514.972425137868;5516.144997525385;5534.308211473566;5539.639923404976;5424.159255315422;5498.257735205756;5501.202325662776;5504.422035686245;5524.613277070606;4848.248521479177;4952.380952380943;4972.950270497285;5008.949910500903;5041.672291301072;4823.614110871139;4943.6539442239055;4987.700737955734;4989.3513843200335;4992.975035124819;4927.433345165316;4937.901241975158;4965.652404331699;4988.351514303135;4998.525140111702;5044.722540260284;5060.721660308682;5063.341765570489;5064.341635587387;5085.644004919657;4814.15752243356;4827.54138356859;4834.274858771212;4960.404751429852;4991.975040124812;5308.893822123575;5317.548008419289;5319.654222475527;5331.253624492535;5361.463853614647;5921.822345329647;5926.555508336849;5926.851828704273;5929.347771745104;5938.7030648467835;5810.82567522975;5826.271716035496;5865.618734782225;5897.528197744213;5919.644821310735;5510;5529.30883639541;5551.139573366135;5564.666120032811;5566.109422492382;5826.446487583673;6012.458878700938;6042.154098426224;6046.516278697693;6050.48570871472;5646.943530564724;5680.4319568042865;5701.857453563694;5757.740901659436;5786.247787787561;5825.0388685866355;5826.126081087786;5848.239728835224;5858.121281807677;5863.442972917566;5672.4894759471845;5704.515116215168;5810.4189581041555;5826.329972053268;5830.5044071254415;5719.542436605062;5818.0981947798155;5818.418158184232;5823.883522329615;5861.413858614104;4463.732176069446;4472;4476.4180656514445;4477.2164871147415;4500.8649740507835;3934.9803250983564;3990.4812374391145;3999.320115580358;4033.052232725307;4043.454133691973;5575.275214222125;5592.692401917852;5618;5620.606557540933;5651.265335506358;5920.733566989496;5931.792387266425;5934.525237980951;5935.495482884004;5971.104334349795;5467.589930755209;5525;5583.134614134816;5593.916091258634;5608.298962629671;4907.6564640475535;4922.630802689812;4935.432425271068;4937.333459982929;4957.950420495749;5975.342712301644;6041.939580604226;6044.486218671374;6045;6048.788292409745;5710.5717071219;5905.911411328748;5984.551158663205;5998.370171132143;6008.789692360747;6164.599301045418;6174.475169610633;6175.413335733098;6177.752889884354;6179.783707570214;5619.044762390322;5853.209816674695;5855.121731740273;5862.062070068769;5863.2670916135485;5798.507126894093;5809.419058094157;5848.298204215522;5895.764169433174;5896.557758168069;5761.855953601026;5771.826845194651;5772.220750198838;5773.566982476415;5773.6824474654295;5485.807996720096;5630.85922851932;5724;5738.713064346849;5746.051901436384;5569.443055694398;5670.9432905672065;5673.177389278614;5673.574481913791;5710.514606258348;5731.484166425042;5784;5812.651240925558;5821.214136091573;5828.504577110823;5442.836714898559;5592.161175823497;5629.0712032514175;5669.433056694297;5699.943000569941 23:43:02 INFO - PROCESS | 6680 | |1;ext.html;614.1156734302604;659.5976454362841;659.8251463362209;670.8356452669095;679.9728010879566;33940.15149621257;47062.294065589;47795.522044779544;47836.52163478364;47998;49612.50387496124;49622.75188624052;49793.50206497934;49838.252426213636;50041.49958500414;8401.873971890427;9154.130357616015;9364.34449588529;9368.250539956787;10834.241603087787;10631.255812093117;11180.776384472305;11190.38452885091;11191.552337906514;11198.608048718297;11039.72400689981;11121.888781112206;11131.72170695731;11162.274452160624;11225.045871100925;8556.657733690676;11014.944925275322;11103.83344249837;11255.380954047525;11265.211435199539;10555.102816260627;11179.66461006171;11183.944080279627;11188.440577971069;11191.66425007251;47903.52096479025;48504;48602.756986215194;48769;48870.26694599584;3681.44778283257;3857.61423857612;4011.799410029487;4348.760818155;4485.1254005468945;36441.72453964125;36490.81754591237;36856.63143368559;36910.44634330487;38074.42888356677;4743.596794272491;4759.357486739315;4772.832950846704;4791.664583479158;4887.413510378778;406755;408129;409217;410482.9475852632;411152;40065.59934400619;40821;40879.38680919789;71577.2842271581;72316.63841680864;42234.57765422307;42344.36483452751;42402;42434;42439.151216975486;15877;15987.920060399623;16069.678606427806;16080.195990200444;16091.275892584861;11911;12889.162204456681;12900.483980640856;12934.288614126126;13344.866551334557;9421;9434.528273586431;9458.621655133855;9488.857667134998;9499.905000949902;3540.4866294387684;3632.6185750496347;3662.908427289339;3686.060054686038;3707.5736290326417;1036.5542816588938;1064.5475672839013;1127.4700890581414;1156.5419396005882;1172.7302720374362;31494;32816.67183328184;33818.323633527194;33824.32351352959;33998.32003359968;1145.8453108830367;1175.2537138916678;1182.645206438065;1212.969675758113;1222.957196498136;17356.5362330344;18053.27786888536;18060.227295344615;18060.90969545144;18077.276908923497;661790;678608;678673;680601;683436;65069.674651627385;65096;65400;65669.34330656727;65768;1337.1776357540236;1432.58455048037;1463.2976171437556;1475.2771142140489;1488.8585584369469;32495;36407.817960910026;36588.81705591455;36632.633673663986;36677.63322366849;54675;56037;56105;56137;56218.71890640521;527680;527696;528458;529031;530856;30929.69070309358;31330.373392531565;31472.685273146977;31655.683443165275;33328.50007249942;53201;53614.19578706245;54116.72941635267;54728;54839;45188.322175166744;45278.32082518699;45287.320690189015;45437.545624544655;46989.295160571935;44451.77774111109;45018.549814501435;45030.77484612556;45688.771556142005;46216.537834621224;44172.55827441684;44841.551584485045;45641.543584563726;45664.771676141405;45769.77115114403;39787.2042559153;39820.40269396019;40155.006284038216;40322;41271.7936410316;29721.70278297276;29769.25576860596;29957.700422996364;30066.398672026873;30495.08514744561 23:43:02 INFO - PROCESS | 6680 | |2;jquery.html;425.59781006948407;432.1432246115856;432.67116991086766;435.63406738339796;437.16719649068534;19507.41477755666;19597.412077637695;20469.692954605674;20637.277695280667;20751.792482075176;16705.582360440996;18836.62326753464;19138.13878375473;19638.312659056937;19687.114079866406;5804.2744656917885;5995.6702381369005;6052.243469566304;6052.243469566304;6057.061155520902;4349.282368409209;5926.377730338317;5982.401759824004;6389.776357827477;6699.397054265115;6763.18841738992;6764.357386048342;6793.388595026447;6798.252192258848;6803.319668033207;6580.309067547886;6650.634215118166;6751.763688270887;6761.729530818761;6768.357006084414;3996.6003399660094;5594.0769772987405;5900.704964751745;5910.852228694317;6025;22483.77516224833;22524.662130068064;22562.43593910149;22942;22962;2252.132928822415;2285.1316499729996;2357.57563638545;2443.8044956403446;2472.0606169655416;10221.182305415548;10311.123554497877;10428.739281517946;10551.15590752738;10611.628592999208;2029.4216148397636;2067.266120527221;2104.8963234012804;2126.51090249242;2165.220520612578;87840.5607971956;88183.55908220418;90253.54873225658;91054.54472727593;92129.89863774259;11437.828432573519;11598.130140239517;11732.882671173349;11764.294142351486;11813.1140164488;16409.179541022902;16593.170341482877;16659.25033373501;16667.166641667867;16674.749878751827;7918.406119541058;8265.586720663943;8389.664413423394;8536;8648;8108.148644392372;8117.228863257981;8126.878096828434;8145.063317718538;8341.874871876928;5036.748162591855;5065.696058236444;5078.923816142761;5109.386873575195;5117.232415137684;1792.3031241177246;1959.3730006397816;2031.1672214392029;2045.5908818236412;2095.685647152939;979.7599588100961;1032.2940643091188;1073.1736562846565;1082.3884505254507;1107.9390633515072;19025.238990440503;19213.943233122314;19230.615387692447;19285.517862053563;19773.110210040293;1012.2003617142375;1053.4311471805293;1087.771567970735;1091.8307662312354;1140.5836869542723;10328.638497652697;10777.568897244022;10828.620998265023;10855.565777368975;10909.945450272699;569496;572893.3717005356;588875;594747;599793;100421;100904;102063.4896825526;103152;103335;1018.1498448795339;1020.9081182693593;1022.8925962773801;1034.8913364096811;1065.5684447798653;16710.24803883804;16963.830361696226;17034.403795867085;17089.230984605474;17198.742018869478;39407.80296098501;41269.793651031556;42460;43293.35059974166;44201;61013.69493152506;61280.69359653173;61951.6902415485;62314.68842655758;62315.6884215576;8496.490210587384;8822.985356683806;8921.420107692978;9006.684766033157;9058.728238152866;9898.604055837974;13322.800157997444;13619.114757540729;13685.726285474433;13694.315284235548;11522.654320370402;11688.70778230551;12051;12090.758184836079;12149.69625759363;11810.350430726392;12041.323837953789;12098.274103553815;12195.207311524722;12221.327826969602;11882.524699011943;11887.465064071965;12065.276083435023;12176.75646487083;12330.383480826102;8532.402731808963;8731.21419072261;8891.288696904361;9119.544022798966;9162.770930726785;9084.375592665538;12011.63965081049;12177.634670959886;12277.140600157903;12333.136680432643 23:43:02 INFO - PROCESS | 6680 | |3;mootools.html;1321.1676643714459;1513.243378310845;1584.6355338272197;1764.3383731100837;1901.420066879601;8723.47659140452;9029.322800789934;9036.141566551176;9345.439273643586;9359.251259899209;9031.142041506046;9217.585208665609;9224.769380765485;9231.815363692738;9240.353175277716;2133.349328454821;2333.428310064037;2394.4253379189045;2395.4849707312924;2441.011390386896;2481.813863960201;2500.612405077216;2500.762427569387;2502.074232533956;2505.34860936157;2320.3271051395077;2379.0721618568773;2398.568257713611;2400.939976500593;2402.2913240594066;2052.1073333100076;2269.375921621567;2327.2669109230537;2334.9883250583807;2378.452955820154;2403.1588943869506;2435.257246539805;2439.6706444630104;2441.2432146034785;2441.8901149448316;9089.545522723838;9136.360454768168;9147.496887671176;9153.176214140693;9160.267178625694;5364.544013758835;5501.422350653163;5503.449655034465;5504.559635229172;5505.889882202374;3321.368939901411;3389.6101948275773;3461.100113970386;3471.1495683557437;3493.91265218369;1201.4893670190133;1213.9210951288137;1224.2165014390796;1228.8648248692637;1247.6381849263703;12708.237505749685;12742.490300387974;12751.42618582166;12754.68113297175;12764.234145951272;4741.9567695107025;4856.757162141878;4887.120318342661;4892.951070489249;4900.754962251945;10762.892371076345;10779.461026948778;10812.35125892449;10819.83770243447;10834.404107773991;5555.694436805934;5556;5557.972210138923;5560.7219639017885;5561.4716601922755;4414.448193975753;4908.11653902301;5015.24771284303;5030.89938201234;5121.436641969381;4067.925358067407;4076.429299898017;4101.282275601818;4111.465509483748;4238.554951730086;1328.6080606221187;1345.569417786299;1346.3402932562974;1350.0482160077122;1351.4188898773425;946.966856160031;1017.3743147964096;1023.3143793658267;1053.72603123187;1054.362110922896;6367.554271200971;6435.871282574322;6466.482681385478;6497.350264973559;6624.900626490607;449.7346565526355;484.6704241116004;488.19447910946514;491.09883364026695;491.3342421019467;4396.27461468854;4396.978015109904;4403.977980110143;4405.735655860659;4422.226110430662;11228.775424491465;11560.595379161688;11617.76764464706;11644.53421863133;11670.474828632561;11260.380679062566;11262.436878156059;11266.324020558628;11331.32012079278;11435.771284574263;8566.61450234741;8776.60505277264;8812.515311657791;8826.55867206637;8829.381943264038;6322.683865806784;6457.838554035999;6554.967225164034;6558.04908288286;6581.440577550962;10346.896531034594;10603.098736607475;10706.357618542912;10709.410982396043;10852.403117828595;10847.40339281347;10874.836877447004;10989.175811813986;10993.560257589927;11007.06439952613;7367.447441441806;7988.600569971594;8123.918760812317;8346.874796878174;8595.52724600153;8646.135386461303;8923.107689231025;8990.460572365679;8991.100889910957;8991.23574496149;7636.732714354971;7676.078870535348;7687.807804804925;7855.057393112635;7902.407319450949;7680.039995000625;7788.766337009899;7903.288704016666;7931.391276663519;8014;7171.928280717126;7271.854562908818;7326.3040011198855;7338.302861228175;7345.6694448751;5220.190870415092;5413.7834486620095;5498.092814685532;5553.222548843084;5603.831885043455;5526.523441570984;5571.415001424792;5592.468715472024;5681.545476361798;5715.571332150189 23:43:02 INFO - PROCESS | 6680 | |4;prototype.html;351.35701665951314;353.14186526740014;353.5827723286524;354.9290141971606;361.79558549419573;5521.9171712424295;5553.805931724678;5574.581906357019;5581.972090139554;5586.916196257054;5437.918431223535;5453.536449401796;5460.945390546093;5481.794005318833;5523.475269849368;3983.7012224083164;4149.257311928997;4315.395844581761;4321.82712691492;4327.653787696992;4236.385724070008;4285.607177667255;4296.334068219431;4300.763458009808;4313.676474264427;4240.194363071022;4246.639035681956;4259.957400425987;4260.187132516411;4308.741475511463;4132.772697501636;4227.175700738358;4278.4438023056955;4307.763073030982;4312.439382880206;3799.9240015199543;3824.9235015299814;3830.5211848518934;3836.5396152461603;3840.8847734568008;5271.551918086929;5277.86805329866;5287.127623942045;5302.761375738101;5316.627836051478;4966.379202599675;4974.90050198994;4980.900381992376;4993.550580447741;5011;5690.48785609293;5693.658380497142;5790.536757059425;5811.476967072984;5828.825135245949;4087.1825634873144;4099.733517321394;4217.472815898012;4234.216669916044;4237.194932962727;5719.428057194289;5800.448957349087;5859.824205273849;5883.38224486427;5887.793927212527;4317.460317460317;4340.153670034313;4344.9565504344555;4345.391645169679;4353.390525326457;4131.690123240769;4314.288142456522;4321.395004699345;4321.5678432157165;4322.502912165079;4831.613470922318;4857.712706132877;4858.368412106403;4862.808611890039;4890.60617723947;5652.63847240891;5715.371309155989;5716.5140963017775;5741.425857414225;5764.971175144181;1464.8608382203674;1489.8453698383623;1490.6720521485256;1504.3456096598015;1505.5408100529226;933.4212788071303;935.7941252924346;956.4548207521646;967.7145242153582;975.6146322202832;4968.577670897942;4975.4278258000795;5026.597872170218;5048.924266136011;5089.796408143633;5126.923346097286;5162.5095615916425;5190.532852043259;5280.841574752763;5306.222415490776;4685.156671799041;4999.625028122905;5041.2438134280155;5074.720890351066;5137.174553995288;2858.628378310848;2862.3416614178855;2868.612737280482;2873.023172121447;2885.365219651673;5361;5444.128939369682;5511.696856672921;5526.06056970316;5532.3637781655625;5060.746962651926;5200.7139607321205;5264.842054738364;5324.760385782649;5325.440828712929;5350.491703288181;5378;5387.46125387466;5406.78372865081;5422.346184413792;5313.096773548584;5681.119426488901;5689.374168841507;5889.0283103287475;5926.555508336805;5801.012478573453;5815.883682326415;5820.854478638068;5825.76696932118;5832.241808565029;5795.8551036224435;6026.276846778414;6087.299960504599;6095.939040609537;6096.841600095968;4215.515215750228;4233.788310584397;4233.915321693487;4256.255155347863;4270.935935960901;5925.644461332334;5931.495822855106;5962.850928726816;5982.700864956648;5989.341172470938;5489.34127904654;5727.627704199213;5789.334226563999;5833.504152147115;5853.239078919713;5729.512991395778;5745.91381129275;5746.13807928814;5759.280089988752;5759.942400576108;5541.810984660956;5697.743601537858;5705.686187259741;5744.253247077853;5768.278965129359;5682;5781.710914454176;5828.562857785599;5838.824835254949;5871.794487192928;5707.286589176353;5707.429257074259;5757.971210143923;5790.7973220937065;5810.157527158453 23:43:02 INFO - PROCESS | 6680 | |5;yui.html;744.2668971063501;749.482856828788;753.7587971849007;758.8747856603661;794.0431779705456;15876.92061539692;17088.91455542722;17187.14064296783;17214.913925430355;17235.65528689427;14835.777463338058;15034.624134396645;15035.398584056624;15041.92479037606;15095.698086038272;714.1929619529924;836.4730219961416;863.9006514250848;865.1348651348651;867.9826403471927;854.1970547685187;859.2095272349422;863.404251066765;866.116561107673;867.0202670981781;752.7779305105007;908;909.2634965677789;909.9181073703365;910.3263584947158;864.9091845356241;886.1315910407804;887.4763889305309;890.314457867445;890.4523717913437;655.632845606462;657.5824351536809;657.6711644177911;658.0688326018678;658.2002866517205;15440.845591544054;15568.922155389151;16267;16298.429554965638;16356.672866542722;14970.47603333889;15097;15169.317380717894;15237.390504379811;15248.695026099416;13534.864651353459;13556.254406007665;13644.522441714493;13708.45166193351;14165.079269847427;4653.232216684243;4654.720716756971;4662.370579971728;4786.2581299898575;4790.209615413452;76548.23451765522;76715.23284767137;78992.60503697502;79257.60371198106;80877.19122808755;11135;11267.927036774312;11288.604898828502;11508.59719909799;11541.365224912543;20809.58380832375;20998;21033.474163146042;21115.683264751042;21154.365369038955;8294.668213271521;8372.832543349099;8504.957475212585;8554;8628.568571571397;4840.95159048405;4955.90088198234;4980.9252861207115;4986.102501549683;5050.242463630485;3513.80674062929;3648.1791596891017;3650.6896913762625;3662.926741465156;3664.193877346979;608.7230310208845;619.1455791008469;623.3517142172091;639.3318981664079;674.6626686656672;648.9967550162219;676.6177109932872;721.6427868205167;722.1334398721555;743.587309043486;9861.556229969668;10042.899571004342;10076.798464030679;10125.392476451436;10141.138003269658;733.5745267744695;743.6096049574016;747.9513831600929;750.1111183247868;755.3088923634922;4575.95424045762;4580.735336393133;4641.280601506772;4653.441587009513;4741.905161896742;74959.62520187364;77270.61364693141;107450;122117;136355;109017.45491272493;115921;116551;116572.41713791546;116667;78203;78720.60639696765;78937.21062789299;88970.55514722384;92165.5391723037;9185.77035574116;9331.906680933103;9658.75853103678;9681.37071090377;9908.256880734118;50551;51543.74228128835;52425.21362179494;53116;54026.72986635199;68599.31400685929;69375;80939;81201;82248;12714.300713460478;13199.370173202446;13579.185248885098;13592.66018349549;13622.659433514242;14425.738122595709;14905.478308259158;15262.847371526143;15590.454334098706;15609.453669121527;12950.611481655566;13045.217286962812;13091;13132.409041593342;13441.059125861097;14138.858611413754;14284.35720392564;14428.855711443171;14770.187639679922;14797.556073317817;13129.474821007434;13237.735245294847;13302.93348533251;13730.45078196861;14445.855541444871;10547.419891906018;11087.889121109009;11180.88819111831;11456.599019034295;11715.824262636237;9525.666601668909;9542.904570954479;9907.653232136841;10152.593896244067;11954.222975506564 23:43:02 INFO - PROCESS | 6680 | __end_tp_report 23:43:02 INFO - PROCESS | 6680 | __start_cc_report 23:43:02 INFO - PROCESS | 6680 | _x_x_mozilla_cycle_collect,940 23:43:02 INFO - PROCESS | 6680 | __end_cc_report 23:43:02 INFO - PROCESS | 6680 | __startTimestamp1467528182516__endTimestamp 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | ------- Summary: start ------- 23:43:02 INFO - PROCESS | 6680 | Number of tests: 6 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | [#0] dojo.html Cycles:165 Average:5447.29 Median:5651.27 stddev:610.36 (10.8%) stddev-sans-first:588.64 23:43:02 INFO - PROCESS | 6680 | Values: 3305.1 3330.6 3330.9 3359.1 3372.2 5433.5 5515.0 5516.1 5534.3 5539.6 5424.2 5498.3 5501.2 5504.4 5524.6 4848.2 4952.4 4973.0 5008.9 5041.7 4823.6 4943.7 4987.7 4989.4 4993.0 4927.4 4937.9 4965.7 4988.4 4998.5 5044.7 5060.7 5063.3 5064.3 5085.6 4814.2 4827.5 4834.3 4960.4 4992.0 5308.9 5317.5 5319.7 5331.3 5361.5 5921.8 5926.6 5926.9 5929.3 5938.7 5810.8 5826.3 5865.6 5897.5 5919.6 5510.0 5529.3 5551.1 5564.7 5566.1 5826.4 6012.5 6042.2 6046.5 6050.5 5646.9 5680.4 5701.9 5757.7 5786.2 5825.0 5826.1 5848.2 5858.1 5863.4 5672.5 5704.5 5810.4 5826.3 5830.5 5719.5 5818.1 5818.4 5823.9 5861.4 4463.7 4472.0 4476.4 4477.2 4500.9 3935.0 3990.5 3999.3 4033.1 4043.5 5575.3 5592.7 5618.0 5620.6 5651.3 5920.7 5931.8 5934.5 5935.5 5971.1 5467.6 5525.0 5583.1 5593.9 5608.3 4907.7 4922.6 4935.4 4937.3 4958.0 5975.3 6041.9 6044.5 6045.0 6048.8 5710.6 5905.9 5984.6 5998.4 6008.8 6164.6 6174.5 6175.4 6177.8 6179.8 5619.0 5853.2 5855.1 5862.1 5863.3 5798.5 5809.4 5848.3 5895.8 5896.6 5761.9 5771.8 5772.2 5773.6 5773.7 5485.8 5630.9 5724.0 5738.7 5746.1 5569.4 5670.9 5673.2 5673.6 5710.5 5731.5 5784.0 5812.7 5821.2 5828.5 5442.8 5592.2 5629.1 5669.4 5699.9 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | [#1] ext.html Cycles:180 Average:69419.27 Median:224475.00 stddev:146499.78 (65.3%) stddev-sans-first:146819.67 23:43:02 INFO - PROCESS | 6680 | Values: 614.1 659.6 659.8 670.8 680.0 33940.2 47062.3 47795.5 47836.5 47998.0 49612.5 49622.8 49793.5 49838.3 50041.5 8401.9 9154.1 9364.3 9368.3 10834.2 10631.3 11180.8 11190.4 11191.6 11198.6 11039.7 11121.9 11131.7 11162.3 11225.0 8556.7 11014.9 11103.8 11255.4 11265.2 10555.1 11179.7 11183.9 11188.4 11191.7 47903.5 48504.0 48602.8 48769.0 48870.3 3681.4 3857.6 4011.8 4348.8 4485.1 36441.7 36490.8 36856.6 36910.4 38074.4 4743.6 4759.4 4772.8 4791.7 4887.4 406755.0 408129.0 409217.0 410482.9 411152.0 40065.6 40821.0 40879.4 71577.3 72316.6 42234.6 42344.4 42402.0 42434.0 42439.2 15877.0 15987.9 16069.7 16080.2 16091.3 11911.0 12889.2 12900.5 12934.3 13344.9 9421.0 9434.5 9458.6 9488.9 9499.9 3540.5 3632.6 3662.9 3686.1 3707.6 1036.6 1064.5 1127.5 1156.5 1172.7 31494.0 32816.7 33818.3 33824.3 33998.3 1145.8 1175.3 1182.6 1213.0 1223.0 17356.5 18053.3 18060.2 18060.9 18077.3 661790.0 678608.0 678673.0 680601.0 683436.0 65069.7 65096.0 65400.0 65669.3 65768.0 1337.2 1432.6 1463.3 1475.3 1488.9 32495.0 36407.8 36588.8 36632.6 36677.6 54675.0 56037.0 56105.0 56137.0 56218.7 527680.0 527696.0 528458.0 529031.0 530856.0 30929.7 31330.4 31472.7 31655.7 33328.5 53201.0 53614.2 54116.7 54728.0 54839.0 45188.3 45278.3 45287.3 45437.5 46989.3 44451.8 45018.5 45030.8 45688.8 46216.5 44172.6 44841.6 45641.5 45664.8 45769.8 39787.2 39820.4 40155.0 40322.0 41271.8 29721.7 29769.3 29957.7 30066.4 30495.1 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | [#2] jquery.html Cycles:180 Average:32473.58 Median:2145.87 stddev:96374.53 (4491.2%) stddev-sans-first:96614.84 23:43:02 INFO - PROCESS | 6680 | Values: 425.6 432.1 432.7 435.6 437.2 19507.4 19597.4 20469.7 20637.3 20751.8 16705.6 18836.6 19138.1 19638.3 19687.1 5804.3 5995.7 6052.2 6052.2 6057.1 4349.3 5926.4 5982.4 6389.8 6699.4 6763.2 6764.4 6793.4 6798.3 6803.3 6580.3 6650.6 6751.8 6761.7 6768.4 3996.6 5594.1 5900.7 5910.9 6025.0 22483.8 22524.7 22562.4 22942.0 22962.0 2252.1 2285.1 2357.6 2443.8 2472.1 10221.2 10311.1 10428.7 10551.2 10611.6 2029.4 2067.3 2104.9 2126.5 2165.2 87840.6 88183.6 90253.5 91054.5 92129.9 11437.8 11598.1 11732.9 11764.3 11813.1 16409.2 16593.2 16659.3 16667.2 16674.7 7918.4 8265.6 8389.7 8536.0 8648.0 8108.1 8117.2 8126.9 8145.1 8341.9 5036.7 5065.7 5078.9 5109.4 5117.2 1792.3 1959.4 2031.2 2045.6 2095.7 979.8 1032.3 1073.2 1082.4 1107.9 19025.2 19213.9 19230.6 19285.5 19773.1 1012.2 1053.4 1087.8 1091.8 1140.6 10328.6 10777.6 10828.6 10855.6 10909.9 569496.0 572893.4 588875.0 594747.0 599793.0 100421.0 100904.0 102063.5 103152.0 103335.0 1018.1 1020.9 1022.9 1034.9 1065.6 16710.2 16963.8 17034.4 17089.2 17198.7 39407.8 41269.8 42460.0 43293.4 44201.0 61013.7 61280.7 61951.7 62314.7 62315.7 8496.5 8823.0 8921.4 9006.7 9058.7 9898.6 13322.8 13619.1 13685.7 13694.3 11522.7 11688.7 12051.0 12090.8 12149.7 11810.4 12041.3 12098.3 12195.2 12221.3 11882.5 11887.5 12065.3 12176.8 12330.4 8532.4 8731.2 8891.3 9119.5 9162.8 9084.4 12011.6 12177.6 12277.1 12333.1 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | [#3] mootools.html Cycles:180 Average:6068.61 Median:2595.85 stddev:3478.09 (134.0%) stddev-sans-first:3469.55 23:43:02 INFO - PROCESS | 6680 | Values: 1321.2 1513.2 1584.6 1764.3 1901.4 8723.5 9029.3 9036.1 9345.4 9359.3 9031.1 9217.6 9224.8 9231.8 9240.4 2133.3 2333.4 2394.4 2395.5 2441.0 2481.8 2500.6 2500.8 2502.1 2505.3 2320.3 2379.1 2398.6 2400.9 2402.3 2052.1 2269.4 2327.3 2335.0 2378.5 2403.2 2435.3 2439.7 2441.2 2441.9 9089.5 9136.4 9147.5 9153.2 9160.3 5364.5 5501.4 5503.4 5504.6 5505.9 3321.4 3389.6 3461.1 3471.1 3493.9 1201.5 1213.9 1224.2 1228.9 1247.6 12708.2 12742.5 12751.4 12754.7 12764.2 4742.0 4856.8 4887.1 4893.0 4900.8 10762.9 10779.5 10812.4 10819.8 10834.4 5555.7 5556.0 5558.0 5560.7 5561.5 4414.4 4908.1 5015.2 5030.9 5121.4 4067.9 4076.4 4101.3 4111.5 4238.6 1328.6 1345.6 1346.3 1350.0 1351.4 947.0 1017.4 1023.3 1053.7 1054.4 6367.6 6435.9 6466.5 6497.4 6624.9 449.7 484.7 488.2 491.1 491.3 4396.3 4397.0 4404.0 4405.7 4422.2 11228.8 11560.6 11617.8 11644.5 11670.5 11260.4 11262.4 11266.3 11331.3 11435.8 8566.6 8776.6 8812.5 8826.6 8829.4 6322.7 6457.8 6555.0 6558.0 6581.4 10346.9 10603.1 10706.4 10709.4 10852.4 10847.4 10874.8 10989.2 10993.6 11007.1 7367.4 7988.6 8123.9 8346.9 8595.5 8646.1 8923.1 8990.5 8991.1 8991.2 7636.7 7676.1 7687.8 7855.1 7902.4 7680.0 7788.8 7903.3 7931.4 8014.0 7171.9 7271.9 7326.3 7338.3 7345.7 5220.2 5413.8 5498.1 5553.2 5603.8 5526.5 5571.4 5592.5 5681.5 5715.6 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | [#4] prototype.html Cycles:180 Average:4738.72 Median:5304.49 stddev:1369.61 (25.8%) stddev-sans-first:1333.28 23:43:02 INFO - PROCESS | 6680 | Values: 351.4 353.1 353.6 354.9 361.8 5521.9 5553.8 5574.6 5582.0 5586.9 5437.9 5453.5 5460.9 5481.8 5523.5 3983.7 4149.3 4315.4 4321.8 4327.7 4236.4 4285.6 4296.3 4300.8 4313.7 4240.2 4246.6 4260.0 4260.2 4308.7 4132.8 4227.2 4278.4 4307.8 4312.4 3799.9 3824.9 3830.5 3836.5 3840.9 5271.6 5277.9 5287.1 5302.8 5316.6 4966.4 4974.9 4980.9 4993.6 5011.0 5690.5 5693.7 5790.5 5811.5 5828.8 4087.2 4099.7 4217.5 4234.2 4237.2 5719.4 5800.4 5859.8 5883.4 5887.8 4317.5 4340.2 4345.0 4345.4 4353.4 4131.7 4314.3 4321.4 4321.6 4322.5 4831.6 4857.7 4858.4 4862.8 4890.6 5652.6 5715.4 5716.5 5741.4 5765.0 1464.9 1489.8 1490.7 1504.3 1505.5 933.4 935.8 956.5 967.7 975.6 4968.6 4975.4 5026.6 5048.9 5089.8 5126.9 5162.5 5190.5 5280.8 5306.2 4685.2 4999.6 5041.2 5074.7 5137.2 2858.6 2862.3 2868.6 2873.0 2885.4 5361.0 5444.1 5511.7 5526.1 5532.4 5060.7 5200.7 5264.8 5324.8 5325.4 5350.5 5378.0 5387.5 5406.8 5422.3 5313.1 5681.1 5689.4 5889.0 5926.6 5801.0 5815.9 5820.9 5825.8 5832.2 5795.9 6026.3 6087.3 6095.9 6096.8 4215.5 4233.8 4233.9 4256.3 4270.9 5925.6 5931.5 5962.9 5982.7 5989.3 5489.3 5727.6 5789.3 5833.5 5853.2 5729.5 5745.9 5746.1 5759.3 5759.9 5541.8 5697.7 5705.7 5744.3 5768.3 5682.0 5781.7 5828.6 5838.8 5871.8 5707.3 5707.4 5758.0 5790.8 5810.2 23:43:02 INFO - PROCESS | 6680 | 23:43:02 INFO - PROCESS | 6680 | [#5] yui.html Cycles:180 Average:21179.91 Median:4702.14 stddev:30586.00 (650.5%) stddev-sans-first:30633.32 23:43:02 INFO - PROCESS | 6680 | Values: 744.3 749.5 753.8 758.9 794.0 15876.9 17088.9 17187.1 17214.9 17235.7 14835.8 15034.6 15035.4 15041.9 15095.7 714.2 836.5 863.9 865.1 868.0 854.2 859.2 863.4 866.1 867.0 752.8 908.0 909.3 909.9 910.3 864.9 886.1 887.5 890.3 890.5 655.6 657.6 657.7 658.1 658.2 15440.8 15568.9 16267.0 16298.4 16356.7 14970.5 15097.0 15169.3 15237.4 15248.7 13534.9 13556.3 13644.5 13708.5 14165.1 4653.2 4654.7 4662.4 4786.3 4790.2 76548.2 76715.2 78992.6 79257.6 80877.2 11135.0 11267.9 11288.6 11508.6 11541.4 20809.6 20998.0 21033.5 21115.7 21154.4 8294.7 8372.8 8505.0 8554.0 8628.6 4841.0 4955.9 4980.9 4986.1 5050.2 3513.8 3648.2 3650.7 3662.9 3664.2 608.7 619.1 623.4 639.3 674.7 649.0 676.6 721.6 722.1 743.6 9861.6 10042.9 10076.8 10125.4 10141.1 733.6 743.6 748.0 750.1 755.3 4576.0 4580.7 4641.3 4653.4 4741.9 74959.6 77270.6 107450.0 122117.0 136355.0 109017.5 115921.0 116551.0 116572.4 116667.0 78203.0 78720.6 78937.2 88970.6 92165.5 9185.8 9331.9 9658.8 9681.4 9908.3 50551.0 51543.7 52425.2 53116.0 54026.7 68599.3 69375.0 80939.0 81201.0 82248.0 12714.3 13199.4 13579.2 13592.7 13622.7 14425.7 14905.5 15262.8 15590.5 15609.5 12950.6 13045.2 13091.0 13132.4 13441.1 14138.9 14284.4 14428.9 14770.2 14797.6 13129.5 13237.7 13302.9 13730.5 14445.9 10547.4 11087.9 11180.9 11456.6 11715.8 9525.7 9542.9 9907.7 10152.6 11954.2 23:43:02 INFO - PROCESS | 6680 | -------- Summary: end -------- 23:43:02 INFO - PROCESS | 6680 | 23:43:03 INFO - TEST-INFO | 6680: exit 0 23:43:03 INFO - TEST-OK | dromaeo_css | took 1112353ms 23:43:03 INFO - TEST-START | kraken 23:43:03 INFO - operating with platform_type : linux_ 23:43:03 INFO - Initialising browser for kraken test... 23:43:03 INFO - TEST-INFO | started process 6868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJVmG4/profile http://localhost:48204/getInfo.html) 23:43:06 INFO - PROCESS | 6868 | __metrics Screen width/height:1600/1200 23:43:06 INFO - PROCESS | 6868 | colorDepth:24 23:43:06 INFO - PROCESS | 6868 | Browser inner width/height: 1024/697 23:43:06 INFO - PROCESS | 6868 | __metrics 23:43:07 ERROR - PROCESS | 6868 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:43:08 INFO - TEST-INFO | 6868: exit 0 23:43:08 INFO - Browser initialized. 23:43:08 INFO - Running cycle 1/1 for kraken test... 23:43:08 INFO - TEST-INFO | started process 6960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJVmG4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:20 INFO - PROCESS | 6960 | RSS: Main: 145829888 23:43:20 INFO - PROCESS | 6960 | 23:43:22 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48204/tests/kraken/driver.html?testName=audio-beat-detection) 23:43:23 INFO - PROCESS | 6960 | RSS: Main: 194457600 23:43:23 INFO - PROCESS | 6960 | 23:43:26 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48204/tests/kraken/driver.html?testName=audio-dft) 23:43:27 INFO - PROCESS | 6960 | RSS: Main: 193445888 23:43:27 INFO - PROCESS | 6960 | 23:43:29 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48204/tests/kraken/driver.html?testName=audio-fft) 23:43:30 INFO - PROCESS | 6960 | RSS: Main: 279171072 23:43:30 INFO - PROCESS | 6960 | 23:43:32 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48204/tests/kraken/driver.html?testName=audio-oscillator) 23:43:33 INFO - PROCESS | 6960 | RSS: Main: 187686912 23:43:33 INFO - PROCESS | 6960 | 23:43:35 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:43:35 INFO - PROCESS | 6960 | RSS: Main: 188649472 23:43:35 INFO - PROCESS | 6960 | 23:43:38 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48204/tests/kraken/driver.html?testName=imaging-darkroom) 23:43:39 INFO - PROCESS | 6960 | RSS: Main: 223346688 23:43:39 INFO - PROCESS | 6960 | 23:43:42 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48204/tests/kraken/driver.html?testName=imaging-desaturate) 23:43:43 INFO - PROCESS | 6960 | RSS: Main: 223641600 23:43:43 INFO - PROCESS | 6960 | 23:43:46 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48204/tests/kraken/driver.html?testName=json-parse-financial) 23:43:46 INFO - PROCESS | 6960 | RSS: Main: 222642176 23:43:46 INFO - PROCESS | 6960 | 23:43:48 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:43:48 INFO - PROCESS | 6960 | RSS: Main: 201408512 23:43:48 INFO - PROCESS | 6960 | 23:43:50 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:43:51 INFO - PROCESS | 6960 | RSS: Main: 201510912 23:43:51 INFO - PROCESS | 6960 | 23:43:53 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:43:53 INFO - PROCESS | 6960 | RSS: Main: 210436096 23:43:53 INFO - PROCESS | 6960 | 23:43:56 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:43:56 INFO - PROCESS | 6960 | RSS: Main: 215003136 23:43:56 INFO - PROCESS | 6960 | 23:43:59 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:00 INFO - PROCESS | 6960 | RSS: Main: 213950464 23:44:00 INFO - PROCESS | 6960 | 23:44:01 INFO - PROCESS | 6960 | Cycle 1(1): loaded http://localhost:48204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48204/tests/kraken/driver.html?testName=ai-astar) 23:44:02 INFO - PROCESS | 6960 | RSS: Main: 256913408 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | __start_tp_report 23:44:02 INFO - PROCESS | 6960 | _x_x_mozilla_page_load 23:44:02 INFO - PROCESS | 6960 | _x_x_mozilla_page_load_details 23:44:02 INFO - PROCESS | 6960 | |i|pagename|runs| 23:44:02 INFO - PROCESS | 6960 | |0;ai-astar;112;106;109;110;109;109;109;110;109;109 23:44:02 INFO - PROCESS | 6960 | |1;audio-beat-detection;164;136;125;177;133;131;146;128;155;135 23:44:02 INFO - PROCESS | 6960 | |2;audio-dft;161;162;161;161;160;163;160;161;161;161 23:44:02 INFO - PROCESS | 6960 | |3;audio-fft;75;75;76;124;78;76;75;75;102;75 23:44:02 INFO - PROCESS | 6960 | |4;audio-oscillator;84;85;122;85;85;86;122;85;86;133 23:44:02 INFO - PROCESS | 6960 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;116;116 23:44:02 INFO - PROCESS | 6960 | |6;imaging-darkroom;145;145;145;146;146;145;146;145;146;145 23:44:02 INFO - PROCESS | 6960 | |7;imaging-desaturate;94;95;94;102;95;94;94;94;95;94 23:44:02 INFO - PROCESS | 6960 | |8;json-parse-financial;50;50;50;50;50;51;52;51;51;51 23:44:02 INFO - PROCESS | 6960 | |9;json-stringify-tinderbox;63;59;59;59;59;58;60;59;59;59 23:44:02 INFO - PROCESS | 6960 | |10;stanford-crypto-aes;75;75;80;75;75;76;79;77;121;75 23:44:02 INFO - PROCESS | 6960 | |11;stanford-crypto-ccm;128;119;131;116;115;114;115;117;123;136 23:44:02 INFO - PROCESS | 6960 | |12;stanford-crypto-pbkdf2;155;161;153;153;154;152;153;155;156;160 23:44:02 INFO - PROCESS | 6960 | |13;stanford-crypto-sha256-iterative;61;62;61;60;61;61;61;60;64;60 23:44:02 INFO - PROCESS | 6960 | __end_tp_report 23:44:02 INFO - PROCESS | 6960 | __start_cc_report 23:44:02 INFO - PROCESS | 6960 | _x_x_mozilla_cycle_collect,1600 23:44:02 INFO - PROCESS | 6960 | __end_cc_report 23:44:02 INFO - PROCESS | 6960 | __startTimestamp1467528242116__endTimestamp 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | ------- Summary: start ------- 23:44:02 INFO - PROCESS | 6960 | Number of tests: 14 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.00 stddev:1.48 (1.4%) stddev-sans-first:1.17 23:44:02 INFO - PROCESS | 6960 | Values: 112.0 106.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:141.00 stddev:17.18 (12.2%) stddev-sans-first:16.45 23:44:02 INFO - PROCESS | 6960 | Values: 164.0 136.0 125.0 177.0 133.0 131.0 146.0 128.0 155.0 135.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 23:44:02 INFO - PROCESS | 6960 | Values: 161.0 162.0 161.0 161.0 160.0 163.0 160.0 161.0 161.0 161.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#3] audio-fft Cycles:10 Average:83.10 Median:75.00 stddev:16.62 (22.2%) stddev-sans-first:17.36 23:44:02 INFO - PROCESS | 6960 | Values: 75.0 75.0 76.0 124.0 78.0 76.0 75.0 75.0 102.0 75.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.00 stddev:19.81 (23.3%) stddev-sans-first:20.42 23:44:02 INFO - PROCESS | 6960 | Values: 84.0 85.0 122.0 85.0 85.0 86.0 122.0 85.0 86.0 133.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:44:02 INFO - PROCESS | 6960 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 116.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:44:02 INFO - PROCESS | 6960 | Values: 145.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:2.47 (2.6%) stddev-sans-first:2.59 23:44:02 INFO - PROCESS | 6960 | Values: 94.0 95.0 94.0 102.0 95.0 94.0 94.0 94.0 95.0 94.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.71 23:44:02 INFO - PROCESS | 6960 | Values: 50.0 50.0 50.0 50.0 50.0 51.0 52.0 51.0 51.0 51.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.35 (2.3%) stddev-sans-first:0.50 23:44:02 INFO - PROCESS | 6960 | Values: 63.0 59.0 59.0 59.0 59.0 58.0 60.0 59.0 59.0 59.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:75.50 stddev:14.24 (18.9%) stddev-sans-first:14.95 23:44:02 INFO - PROCESS | 6960 | Values: 75.0 75.0 80.0 75.0 75.0 76.0 79.0 77.0 121.0 75.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:121.00 stddev:7.76 (6.4%) stddev-sans-first:7.86 23:44:02 INFO - PROCESS | 6960 | Values: 128.0 119.0 131.0 116.0 115.0 114.0 115.0 117.0 123.0 136.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.00 stddev:3.05 (2.0%) stddev-sans-first:3.23 23:44:02 INFO - PROCESS | 6960 | Values: 155.0 161.0 153.0 153.0 154.0 152.0 153.0 155.0 156.0 160.0 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - PROCESS | 6960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:1.20 (2.0%) stddev-sans-first:1.27 23:44:02 INFO - PROCESS | 6960 | Values: 61.0 62.0 61.0 60.0 61.0 61.0 61.0 60.0 64.0 60.0 23:44:02 INFO - PROCESS | 6960 | -------- Summary: end -------- 23:44:02 INFO - PROCESS | 6960 | 23:44:02 INFO - TEST-INFO | 6960: exit 0 23:44:03 INFO - TEST-OK | kraken | took 59807ms 23:44:03 INFO - SUITE-END | took 1172s 23:44:03 INFO - Completed test suite (00:19:32) 23:44:03 INFO - javascript benchmark 23:44:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.1241421023424, 3330.5836770403685, 3330.90007299781, 3359.07625403014, 3372.1906742381834, 5433.48381903719, 5514.972425137868, 5516.144997525385, 5534.308211473566, 5539.639923404976, 5424.159255315422, 5498.257735205756, 5501.202325662776, 5504.422035686245, 5524.613277070606, 4848.248521479177, 4952.380952380943, 4972.950270497285, 5008.949910500903, 5041.672291301072, 4823.614110871139, 4943.6539442239055, 4987.700737955734, 4989.3513843200335, 4992.975035124819, 4927.433345165316, 4937.901241975158, 4965.652404331699, 4988.351514303135, 4998.525140111702, 5044.722540260284, 5060.721660308682, 5063.341765570489, 5064.341635587387, 5085.644004919657, 4814.15752243356, 4827.54138356859, 4834.274858771212, 4960.404751429852, 4991.975040124812, 5308.893822123575, 5317.548008419289, 5319.654222475527, 5331.253624492535, 5361.463853614647, 5921.822345329647, 5926.555508336849, 5926.851828704273, 5929.347771745104, 5938.7030648467835, 5810.82567522975, 5826.271716035496, 5865.618734782225, 5897.528197744213, 5919.644821310735, 5510.0, 5529.30883639541, 5551.139573366135, 5564.666120032811, 5566.109422492382, 5826.446487583673, 6012.458878700938, 6042.154098426224, 6046.516278697693, 6050.48570871472, 5646.943530564724, 5680.4319568042865, 5701.857453563694, 5757.740901659436, 5786.247787787561, 5825.0388685866355, 5826.126081087786, 5848.239728835224, 5858.121281807677, 5863.442972917566, 5672.4894759471845, 5704.515116215168, 5810.4189581041555, 5826.329972053268, 5830.5044071254415, 5719.542436605062, 5818.0981947798155, 5818.418158184232, 5823.883522329615, 5861.413858614104, 4463.732176069446, 4472.0, 4476.4180656514445, 4477.2164871147415, 4500.8649740507835, 3934.9803250983564, 3990.4812374391145, 3999.320115580358, 4033.052232725307, 4043.454133691973, 5575.275214222125, 5592.692401917852, 5618.0, 5620.606557540933, 5651.265335506358, 5920.733566989496, 5931.792387266425, 5934.525237980951, 5935.495482884004, 5971.104334349795, 5467.589930755209, 5525.0, 5583.134614134816, 5593.916091258634, 5608.298962629671, 4907.6564640475535, 4922.630802689812, 4935.432425271068, 4937.333459982929, 4957.950420495749, 5975.342712301644, 6041.939580604226, 6044.486218671374, 6045.0, 6048.788292409745, 5710.5717071219, 5905.911411328748, 5984.551158663205, 5998.370171132143, 6008.789692360747, 6164.599301045418, 6174.475169610633, 6175.413335733098, 6177.752889884354, 6179.783707570214, 5619.044762390322, 5853.209816674695, 5855.121731740273, 5862.062070068769, 5863.2670916135485, 5798.507126894093, 5809.419058094157, 5848.298204215522, 5895.764169433174, 5896.557758168069, 5761.855953601026, 5771.826845194651, 5772.220750198838, 5773.566982476415, 5773.6824474654295, 5485.807996720096, 5630.85922851932, 5724.0, 5738.713064346849, 5746.051901436384, 5569.443055694398, 5670.9432905672065, 5673.177389278614, 5673.574481913791, 5710.514606258348, 5731.484166425042, 5784.0, 5812.651240925558, 5821.214136091573, 5828.504577110823, 5442.836714898559, 5592.161175823497, 5629.0712032514175, 5669.433056694297, 5699.943000569941], "value": 5407.7398817390485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.1156734302604, 659.5976454362841, 659.8251463362209, 670.8356452669095, 679.9728010879566, 33940.15149621257, 47062.294065589, 47795.522044779544, 47836.52163478364, 47998.0, 49612.50387496124, 49622.75188624052, 49793.50206497934, 49838.252426213636, 50041.49958500414, 8401.873971890427, 9154.130357616015, 9364.34449588529, 9368.250539956787, 10834.241603087787, 10631.255812093117, 11180.776384472305, 11190.38452885091, 11191.552337906514, 11198.608048718297, 11039.72400689981, 11121.888781112206, 11131.72170695731, 11162.274452160624, 11225.045871100925, 8556.657733690676, 11014.944925275322, 11103.83344249837, 11255.380954047525, 11265.211435199539, 10555.102816260627, 11179.66461006171, 11183.944080279627, 11188.440577971069, 11191.66425007251, 47903.52096479025, 48504.0, 48602.756986215194, 48769.0, 48870.26694599584, 3681.44778283257, 3857.61423857612, 4011.799410029487, 4348.760818155, 4485.1254005468945, 36441.72453964125, 36490.81754591237, 36856.63143368559, 36910.44634330487, 38074.42888356677, 4743.596794272491, 4759.357486739315, 4772.832950846704, 4791.664583479158, 4887.413510378778, 406755.0, 408129.0, 409217.0, 410482.9475852632, 411152.0, 40065.59934400619, 40821.0, 40879.38680919789, 71577.2842271581, 72316.63841680864, 42234.57765422307, 42344.36483452751, 42402.0, 42434.0, 42439.151216975486, 15877.0, 15987.920060399623, 16069.678606427806, 16080.195990200444, 16091.275892584861, 11911.0, 12889.162204456681, 12900.483980640856, 12934.288614126126, 13344.866551334557, 9421.0, 9434.528273586431, 9458.621655133855, 9488.857667134998, 9499.905000949902, 3540.4866294387684, 3632.6185750496347, 3662.908427289339, 3686.060054686038, 3707.5736290326417, 1036.5542816588938, 1064.5475672839013, 1127.4700890581414, 1156.5419396005882, 1172.7302720374362, 31494.0, 32816.67183328184, 33818.323633527194, 33824.32351352959, 33998.32003359968, 1145.8453108830367, 1175.2537138916678, 1182.645206438065, 1212.969675758113, 1222.957196498136, 17356.5362330344, 18053.27786888536, 18060.227295344615, 18060.90969545144, 18077.276908923497, 661790.0, 678608.0, 678673.0, 680601.0, 683436.0, 65069.674651627385, 65096.0, 65400.0, 65669.34330656727, 65768.0, 1337.1776357540236, 1432.58455048037, 1463.2976171437556, 1475.2771142140489, 1488.8585584369469, 32495.0, 36407.817960910026, 36588.81705591455, 36632.633673663986, 36677.63322366849, 54675.0, 56037.0, 56105.0, 56137.0, 56218.71890640521, 527680.0, 527696.0, 528458.0, 529031.0, 530856.0, 30929.69070309358, 31330.373392531565, 31472.685273146977, 31655.683443165275, 33328.50007249942, 53201.0, 53614.19578706245, 54116.72941635267, 54728.0, 54839.0, 45188.322175166744, 45278.32082518699, 45287.320690189015, 45437.545624544655, 46989.295160571935, 44451.77774111109, 45018.549814501435, 45030.77484612556, 45688.771556142005, 46216.537834621224, 44172.55827441684, 44841.551584485045, 45641.543584563726, 45664.771676141405, 45769.77115114403, 39787.2042559153, 39820.40269396019, 40155.006284038216, 40322.0, 41271.7936410316, 29721.70278297276, 29769.25576860596, 29957.700422996364, 30066.398672026873, 30495.08514744561], "value": 21099.163749541698, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.59781006948407, 432.1432246115856, 432.67116991086766, 435.63406738339796, 437.16719649068534, 19507.41477755666, 19597.412077637695, 20469.692954605674, 20637.277695280667, 20751.792482075176, 16705.582360440996, 18836.62326753464, 19138.13878375473, 19638.312659056937, 19687.114079866406, 5804.2744656917885, 5995.6702381369005, 6052.243469566304, 6052.243469566304, 6057.061155520902, 4349.282368409209, 5926.377730338317, 5982.401759824004, 6389.776357827477, 6699.397054265115, 6763.18841738992, 6764.357386048342, 6793.388595026447, 6798.252192258848, 6803.319668033207, 6580.309067547886, 6650.634215118166, 6751.763688270887, 6761.729530818761, 6768.357006084414, 3996.6003399660094, 5594.0769772987405, 5900.704964751745, 5910.852228694317, 6025.0, 22483.77516224833, 22524.662130068064, 22562.43593910149, 22942.0, 22962.0, 2252.132928822415, 2285.1316499729996, 2357.57563638545, 2443.8044956403446, 2472.0606169655416, 10221.182305415548, 10311.123554497877, 10428.739281517946, 10551.15590752738, 10611.628592999208, 2029.4216148397636, 2067.266120527221, 2104.8963234012804, 2126.51090249242, 2165.220520612578, 87840.5607971956, 88183.55908220418, 90253.54873225658, 91054.54472727593, 92129.89863774259, 11437.828432573519, 11598.130140239517, 11732.882671173349, 11764.294142351486, 11813.1140164488, 16409.179541022902, 16593.170341482877, 16659.25033373501, 16667.166641667867, 16674.749878751827, 7918.406119541058, 8265.586720663943, 8389.664413423394, 8536.0, 8648.0, 8108.148644392372, 8117.228863257981, 8126.878096828434, 8145.063317718538, 8341.874871876928, 5036.748162591855, 5065.696058236444, 5078.923816142761, 5109.386873575195, 5117.232415137684, 1792.3031241177246, 1959.3730006397816, 2031.1672214392029, 2045.5908818236412, 2095.685647152939, 979.7599588100961, 1032.2940643091188, 1073.1736562846565, 1082.3884505254507, 1107.9390633515072, 19025.238990440503, 19213.943233122314, 19230.615387692447, 19285.517862053563, 19773.110210040293, 1012.2003617142375, 1053.4311471805293, 1087.771567970735, 1091.8307662312354, 1140.5836869542723, 10328.638497652697, 10777.568897244022, 10828.620998265023, 10855.565777368975, 10909.945450272699, 569496.0, 572893.3717005356, 588875.0, 594747.0, 599793.0, 100421.0, 100904.0, 102063.4896825526, 103152.0, 103335.0, 1018.1498448795339, 1020.9081182693593, 1022.8925962773801, 1034.8913364096811, 1065.5684447798653, 16710.24803883804, 16963.830361696226, 17034.403795867085, 17089.230984605474, 17198.742018869478, 39407.80296098501, 41269.793651031556, 42460.0, 43293.35059974166, 44201.0, 61013.69493152506, 61280.69359653173, 61951.6902415485, 62314.68842655758, 62315.6884215576, 8496.490210587384, 8822.985356683806, 8921.420107692978, 9006.684766033157, 9058.728238152866, 9898.604055837974, 13322.800157997444, 13619.114757540729, 13685.726285474433, 13694.315284235548, 11522.654320370402, 11688.70778230551, 12051.0, 12090.758184836079, 12149.69625759363, 11810.350430726392, 12041.323837953789, 12098.274103553815, 12195.207311524722, 12221.327826969602, 11882.524699011943, 11887.465064071965, 12065.276083435023, 12176.75646487083, 12330.383480826102, 8532.402731808963, 8731.21419072261, 8891.288696904361, 9119.544022798966, 9162.770930726785, 9084.375592665538, 12011.63965081049, 12177.634670959886, 12277.140600157903, 12333.136680432643], "value": 9638.332684449671, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.1676643714459, 1513.243378310845, 1584.6355338272197, 1764.3383731100837, 1901.420066879601, 8723.47659140452, 9029.322800789934, 9036.141566551176, 9345.439273643586, 9359.251259899209, 9031.142041506046, 9217.585208665609, 9224.769380765485, 9231.815363692738, 9240.353175277716, 2133.349328454821, 2333.428310064037, 2394.4253379189045, 2395.4849707312924, 2441.011390386896, 2481.813863960201, 2500.612405077216, 2500.762427569387, 2502.074232533956, 2505.34860936157, 2320.3271051395077, 2379.0721618568773, 2398.568257713611, 2400.939976500593, 2402.2913240594066, 2052.1073333100076, 2269.375921621567, 2327.2669109230537, 2334.9883250583807, 2378.452955820154, 2403.1588943869506, 2435.257246539805, 2439.6706444630104, 2441.2432146034785, 2441.8901149448316, 9089.545522723838, 9136.360454768168, 9147.496887671176, 9153.176214140693, 9160.267178625694, 5364.544013758835, 5501.422350653163, 5503.449655034465, 5504.559635229172, 5505.889882202374, 3321.368939901411, 3389.6101948275773, 3461.100113970386, 3471.1495683557437, 3493.91265218369, 1201.4893670190133, 1213.9210951288137, 1224.2165014390796, 1228.8648248692637, 1247.6381849263703, 12708.237505749685, 12742.490300387974, 12751.42618582166, 12754.68113297175, 12764.234145951272, 4741.9567695107025, 4856.757162141878, 4887.120318342661, 4892.951070489249, 4900.754962251945, 10762.892371076345, 10779.461026948778, 10812.35125892449, 10819.83770243447, 10834.404107773991, 5555.694436805934, 5556.0, 5557.972210138923, 5560.7219639017885, 5561.4716601922755, 4414.448193975753, 4908.11653902301, 5015.24771284303, 5030.89938201234, 5121.436641969381, 4067.925358067407, 4076.429299898017, 4101.282275601818, 4111.465509483748, 4238.554951730086, 1328.6080606221187, 1345.569417786299, 1346.3402932562974, 1350.0482160077122, 1351.4188898773425, 946.966856160031, 1017.3743147964096, 1023.3143793658267, 1053.72603123187, 1054.362110922896, 6367.554271200971, 6435.871282574322, 6466.482681385478, 6497.350264973559, 6624.900626490607, 449.7346565526355, 484.6704241116004, 488.19447910946514, 491.09883364026695, 491.3342421019467, 4396.27461468854, 4396.978015109904, 4403.977980110143, 4405.735655860659, 4422.226110430662, 11228.775424491465, 11560.595379161688, 11617.76764464706, 11644.53421863133, 11670.474828632561, 11260.380679062566, 11262.436878156059, 11266.324020558628, 11331.32012079278, 11435.771284574263, 8566.61450234741, 8776.60505277264, 8812.515311657791, 8826.55867206637, 8829.381943264038, 6322.683865806784, 6457.838554035999, 6554.967225164034, 6558.04908288286, 6581.440577550962, 10346.896531034594, 10603.098736607475, 10706.357618542912, 10709.410982396043, 10852.403117828595, 10847.40339281347, 10874.836877447004, 10989.175811813986, 10993.560257589927, 11007.06439952613, 7367.447441441806, 7988.600569971594, 8123.918760812317, 8346.874796878174, 8595.52724600153, 8646.135386461303, 8923.107689231025, 8990.460572365679, 8991.100889910957, 8991.23574496149, 7636.732714354971, 7676.078870535348, 7687.807804804925, 7855.057393112635, 7902.407319450949, 7680.039995000625, 7788.766337009899, 7903.288704016666, 7931.391276663519, 8014.0, 7171.928280717126, 7271.854562908818, 7326.3040011198855, 7338.302861228175, 7345.6694448751, 5220.190870415092, 5413.7834486620095, 5498.092814685532, 5553.222548843084, 5603.831885043455, 5526.523441570984, 5571.415001424792, 5592.468715472024, 5681.545476361798, 5715.571332150189], "value": 4767.482789153982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.35701665951314, 353.14186526740014, 353.5827723286524, 354.9290141971606, 361.79558549419573, 5521.9171712424295, 5553.805931724678, 5574.581906357019, 5581.972090139554, 5586.916196257054, 5437.918431223535, 5453.536449401796, 5460.945390546093, 5481.794005318833, 5523.475269849368, 3983.7012224083164, 4149.257311928997, 4315.395844581761, 4321.82712691492, 4327.653787696992, 4236.385724070008, 4285.607177667255, 4296.334068219431, 4300.763458009808, 4313.676474264427, 4240.194363071022, 4246.639035681956, 4259.957400425987, 4260.187132516411, 4308.741475511463, 4132.772697501636, 4227.175700738358, 4278.4438023056955, 4307.763073030982, 4312.439382880206, 3799.9240015199543, 3824.9235015299814, 3830.5211848518934, 3836.5396152461603, 3840.8847734568008, 5271.551918086929, 5277.86805329866, 5287.127623942045, 5302.761375738101, 5316.627836051478, 4966.379202599675, 4974.90050198994, 4980.900381992376, 4993.550580447741, 5011.0, 5690.48785609293, 5693.658380497142, 5790.536757059425, 5811.476967072984, 5828.825135245949, 4087.1825634873144, 4099.733517321394, 4217.472815898012, 4234.216669916044, 4237.194932962727, 5719.428057194289, 5800.448957349087, 5859.824205273849, 5883.38224486427, 5887.793927212527, 4317.460317460317, 4340.153670034313, 4344.9565504344555, 4345.391645169679, 4353.390525326457, 4131.690123240769, 4314.288142456522, 4321.395004699345, 4321.5678432157165, 4322.502912165079, 4831.613470922318, 4857.712706132877, 4858.368412106403, 4862.808611890039, 4890.60617723947, 5652.63847240891, 5715.371309155989, 5716.5140963017775, 5741.425857414225, 5764.971175144181, 1464.8608382203674, 1489.8453698383623, 1490.6720521485256, 1504.3456096598015, 1505.5408100529226, 933.4212788071303, 935.7941252924346, 956.4548207521646, 967.7145242153582, 975.6146322202832, 4968.577670897942, 4975.4278258000795, 5026.597872170218, 5048.924266136011, 5089.796408143633, 5126.923346097286, 5162.5095615916425, 5190.532852043259, 5280.841574752763, 5306.222415490776, 4685.156671799041, 4999.625028122905, 5041.2438134280155, 5074.720890351066, 5137.174553995288, 2858.628378310848, 2862.3416614178855, 2868.612737280482, 2873.023172121447, 2885.365219651673, 5361.0, 5444.128939369682, 5511.696856672921, 5526.06056970316, 5532.3637781655625, 5060.746962651926, 5200.7139607321205, 5264.842054738364, 5324.760385782649, 5325.440828712929, 5350.491703288181, 5378.0, 5387.46125387466, 5406.78372865081, 5422.346184413792, 5313.096773548584, 5681.119426488901, 5689.374168841507, 5889.0283103287475, 5926.555508336805, 5801.012478573453, 5815.883682326415, 5820.854478638068, 5825.76696932118, 5832.241808565029, 5795.8551036224435, 6026.276846778414, 6087.299960504599, 6095.939040609537, 6096.841600095968, 4215.515215750228, 4233.788310584397, 4233.915321693487, 4256.255155347863, 4270.935935960901, 5925.644461332334, 5931.495822855106, 5962.850928726816, 5982.700864956648, 5989.341172470938, 5489.34127904654, 5727.627704199213, 5789.334226563999, 5833.504152147115, 5853.239078919713, 5729.512991395778, 5745.91381129275, 5746.13807928814, 5759.280089988752, 5759.942400576108, 5541.810984660956, 5697.743601537858, 5705.686187259741, 5744.253247077853, 5768.278965129359, 5682.0, 5781.710914454176, 5828.562857785599, 5838.824835254949, 5871.794487192928, 5707.286589176353, 5707.429257074259, 5757.971210143923, 5790.7973220937065, 5810.157527158453], "value": 4307.013764310585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.2668971063501, 749.482856828788, 753.7587971849007, 758.8747856603661, 794.0431779705456, 15876.92061539692, 17088.91455542722, 17187.14064296783, 17214.913925430355, 17235.65528689427, 14835.777463338058, 15034.624134396645, 15035.398584056624, 15041.92479037606, 15095.698086038272, 714.1929619529924, 836.4730219961416, 863.9006514250848, 865.1348651348651, 867.9826403471927, 854.1970547685187, 859.2095272349422, 863.404251066765, 866.116561107673, 867.0202670981781, 752.7779305105007, 908.0, 909.2634965677789, 909.9181073703365, 910.3263584947158, 864.9091845356241, 886.1315910407804, 887.4763889305309, 890.314457867445, 890.4523717913437, 655.632845606462, 657.5824351536809, 657.6711644177911, 658.0688326018678, 658.2002866517205, 15440.845591544054, 15568.922155389151, 16267.0, 16298.429554965638, 16356.672866542722, 14970.47603333889, 15097.0, 15169.317380717894, 15237.390504379811, 15248.695026099416, 13534.864651353459, 13556.254406007665, 13644.522441714493, 13708.45166193351, 14165.079269847427, 4653.232216684243, 4654.720716756971, 4662.370579971728, 4786.2581299898575, 4790.209615413452, 76548.23451765522, 76715.23284767137, 78992.60503697502, 79257.60371198106, 80877.19122808755, 11135.0, 11267.927036774312, 11288.604898828502, 11508.59719909799, 11541.365224912543, 20809.58380832375, 20998.0, 21033.474163146042, 21115.683264751042, 21154.365369038955, 8294.668213271521, 8372.832543349099, 8504.957475212585, 8554.0, 8628.568571571397, 4840.95159048405, 4955.90088198234, 4980.9252861207115, 4986.102501549683, 5050.242463630485, 3513.80674062929, 3648.1791596891017, 3650.6896913762625, 3662.926741465156, 3664.193877346979, 608.7230310208845, 619.1455791008469, 623.3517142172091, 639.3318981664079, 674.6626686656672, 648.9967550162219, 676.6177109932872, 721.6427868205167, 722.1334398721555, 743.587309043486, 9861.556229969668, 10042.899571004342, 10076.798464030679, 10125.392476451436, 10141.138003269658, 733.5745267744695, 743.6096049574016, 747.9513831600929, 750.1111183247868, 755.3088923634922, 4575.95424045762, 4580.735336393133, 4641.280601506772, 4653.441587009513, 4741.905161896742, 74959.62520187364, 77270.61364693141, 107450.0, 122117.0, 136355.0, 109017.45491272493, 115921.0, 116551.0, 116572.41713791546, 116667.0, 78203.0, 78720.60639696765, 78937.21062789299, 88970.55514722384, 92165.5391723037, 9185.77035574116, 9331.906680933103, 9658.75853103678, 9681.37071090377, 9908.256880734118, 50551.0, 51543.74228128835, 52425.21362179494, 53116.0, 54026.72986635199, 68599.31400685929, 69375.0, 80939.0, 81201.0, 82248.0, 12714.300713460478, 13199.370173202446, 13579.185248885098, 13592.66018349549, 13622.659433514242, 14425.738122595709, 14905.478308259158, 15262.847371526143, 15590.454334098706, 15609.453669121527, 12950.611481655566, 13045.217286962812, 13091.0, 13132.409041593342, 13441.059125861097, 14138.858611413754, 14284.35720392564, 14428.855711443171, 14770.187639679922, 14797.556073317817, 13129.474821007434, 13237.735245294847, 13302.93348533251, 13730.45078196861, 14445.855541444871, 10547.419891906018, 11087.889121109009, 11180.88819111831, 11456.599019034295, 11715.824262636237, 9525.666601668909, 9542.904570954479, 9907.653232136841, 10152.593896244067, 11954.222975506564], "value": 7765.96723853413, "unit": "score"}], "name": "dromaeo_css", "value": 7481.664576373559, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 136.0, 125.0, 177.0, 133.0, 131.0, 146.0, 128.0, 155.0, 135.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 161.0, 160.0, 163.0, 160.0, 161.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 124.0, 78.0, 76.0, 75.0, 75.0, 102.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 122.0, 85.0, 85.0, 86.0, 122.0, 85.0, 86.0, 133.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 102.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 50.0, 51.0, 52.0, 51.0, 51.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 59.0, 59.0, 58.0, 60.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 80.0, 75.0, 75.0, 76.0, 79.0, 77.0, 121.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 131.0, 116.0, 115.0, 114.0, 115.0, 117.0, 123.0, 136.0], "value": 121.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 161.0, 153.0, 153.0, 154.0, 152.0, 153.0, 155.0, 156.0, 160.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 64.0, 60.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1479.3, "alertThreshold": 2.0}]} 23:44:03 INFO - Return code: 0 23:44:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:44:03 ERROR - # TBPL SUCCESS # 23:44:03 INFO - Running post-action listener: _resource_record_post_action 23:44:03 INFO - ##### 23:44:03 INFO - ##### Finished run-tests step (success) 23:44:03 INFO - ##### 23:44:03 INFO - Running post-run listener: _resource_record_post_run 23:44:03 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 270336; Write bytes: 507736064; Read time: 28; Write time: 373344 23:44:03 INFO - TinderboxPrint: CPU usage
13.1% 23:44:03 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 28 23:44:03 INFO - TinderboxPrint: I/O write bytes / time
507,736,064 / 373,344 23:44:03 INFO - TinderboxPrint: CPU idle
8,246.1 (86.9%) 23:44:03 INFO - TinderboxPrint: CPU user
1,201.7 (12.7%) 23:44:03 INFO - TinderboxPrint: Swap in / out
0 / 0 23:44:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 258818048; Read time: 0; Write time: 227484 23:44:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 270336; Write bytes: 248918016; Read time: 28; Write time: 145860 23:44:04 INFO - Running post-run listener: _upload_blobber_files 23:44:04 INFO - Blob upload gear active. 23:44:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:04 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 23:44:04 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:44:04 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:44:04 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:44:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:05 INFO - (blobuploader) - INFO - Done attempting. 23:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:44:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:08 INFO - (blobuploader) - INFO - Done attempting. 23:44:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:44:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:44:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:09 INFO - (blobuploader) - INFO - Done attempting. 23:44:09 INFO - (blobuploader) - INFO - Iteration through files over. 23:44:09 INFO - Return code: 0 23:44:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:44:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:44:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5119db35ff64a79773801d94cd07b4ef6ef4e16bb6af122417ba06ac81ec6098f66b48e935e8208972a1263b538a5bbcefb0e3ba9720fa86c93d2c917f45ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c9d5fd4d1bd27ee86268a3f966f1783155fbed06e38046b91c761345ccfd0812add4da5e849dceeb9891e3c7bff0ae46d95ac669556c431336af418865805e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86ea3475e750a8c9adbfdae64ace4c59d449c89b7d1d6f9c5fbdebd17de8b09be5e08a9432bd55c134d19bf3ab9f7ae58e4e57a0c84772947eec9722fbd9c00"} 23:44:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:44:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:44:09 INFO - Contents: 23:44:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5119db35ff64a79773801d94cd07b4ef6ef4e16bb6af122417ba06ac81ec6098f66b48e935e8208972a1263b538a5bbcefb0e3ba9720fa86c93d2c917f45ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c9d5fd4d1bd27ee86268a3f966f1783155fbed06e38046b91c761345ccfd0812add4da5e849dceeb9891e3c7bff0ae46d95ac669556c431336af418865805e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86ea3475e750a8c9adbfdae64ace4c59d449c89b7d1d6f9c5fbdebd17de8b09be5e08a9432bd55c134d19bf3ab9f7ae58e4e57a0c84772947eec9722fbd9c00"} 23:44:09 INFO - Running post-run listener: copy_logs_to_upload_dir 23:44:09 INFO - Copying logs to upload dir... 23:44:09 INFO - mkdir: /builds/slave/test/build/upload/logs 23:44:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.980070 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-02 23:44:08.520395) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:44:08.523970) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5119db35ff64a79773801d94cd07b4ef6ef4e16bb6af122417ba06ac81ec6098f66b48e935e8208972a1263b538a5bbcefb0e3ba9720fa86c93d2c917f45ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c9d5fd4d1bd27ee86268a3f966f1783155fbed06e38046b91c761345ccfd0812add4da5e849dceeb9891e3c7bff0ae46d95ac669556c431336af418865805e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86ea3475e750a8c9adbfdae64ace4c59d449c89b7d1d6f9c5fbdebd17de8b09be5e08a9432bd55c134d19bf3ab9f7ae58e4e57a0c84772947eec9722fbd9c00"} build_url:https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011161 build_url: 'https://queue.taskcluster.net/v1/task/FsxWn-duRhSsfHokcRpN0A/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5119db35ff64a79773801d94cd07b4ef6ef4e16bb6af122417ba06ac81ec6098f66b48e935e8208972a1263b538a5bbcefb0e3ba9720fa86c93d2c917f45ace", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/81c9d5fd4d1bd27ee86268a3f966f1783155fbed06e38046b91c761345ccfd0812add4da5e849dceeb9891e3c7bff0ae46d95ac669556c431336af418865805e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b86ea3475e750a8c9adbfdae64ace4c59d449c89b7d1d6f9c5fbdebd17de8b09be5e08a9432bd55c134d19bf3ab9f7ae58e4e57a0c84772947eec9722fbd9c00"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:44:08.549297) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:44:08.549668) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1467527017.959250-1410896935 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:44:08.631712) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:44:08.632031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:44:08.632369) ========= ========= Total master_lag: 0.17 =========