builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1465351414.25 results: success (0) buildid: 20160607175925 builduid: 0256be2a21c746358ff844f4828de7a7 revision: a7b31be0a19ae5413db3e10ad4e5251cac84b08d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:34.246497) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:34.246965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:34.247253) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:34.984585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:34.984927) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 19:03:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-06-07 19:03:35 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113557 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:35.112498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:35.112815) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014357 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:35.162266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 19:03:35.162676) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a7b31be0a19ae5413db3e10ad4e5251cac84b08d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a7b31be0a19ae5413db3e10ad4e5251cac84b08d --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=8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 19:03:35,676 truncating revision to first 12 chars 2016-06-07 19:03:35,676 Setting DEBUG logging. 2016-06-07 19:03:35,676 attempt 1/10 2016-06-07 19:03:35,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a7b31be0a19a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 19:03:36,846 unpacking tar archive at: fx-team-a7b31be0a19a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.512579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 19:03:36.688406) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:36.688741) ========= script_repo_revision: a7b31be0a19ae5413db3e10ad4e5251cac84b08d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:36.689120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:36.689404) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 19:03:36.699101) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 19:03:36.699386) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:03:37 INFO - MultiFileLogger online at 20160607 19:03:37 in /builds/slave/test 19:03:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:03:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:03:37 INFO - {'append_to_log': False, 19:03:37 INFO - 'base_work_dir': '/builds/slave/test', 19:03:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:03:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:03:37 INFO - 'branch': 'Fx-Team-Non-PGO', 19:03:37 INFO - 'buildbot_json_path': 'buildprops.json', 19:03:37 INFO - 'config_files': ('talos/linux_config.py',), 19:03:37 INFO - 'default_actions': ('clobber', 19:03:37 INFO - 'read-buildbot-config', 19:03:37 INFO - 'download-and-extract', 19:03:37 INFO - 'populate-webroot', 19:03:37 INFO - 'create-virtualenv', 19:03:37 INFO - 'install', 19:03:37 INFO - 'run-tests'), 19:03:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:03:37 INFO - 'download_minidump_stackwalk': True, 19:03:37 INFO - 'download_symbols': 'ondemand', 19:03:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:03:37 INFO - 'tooltool.py': '/tools/tooltool.py', 19:03:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:03:37 INFO - '/tools/misc-python/virtualenv.py')}, 19:03:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:03:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:03:37 INFO - 'installer_path': 'installer.exe', 19:03:37 INFO - 'log_level': 'info', 19:03:37 INFO - 'log_name': 'talos', 19:03:37 INFO - 'log_to_console': True, 19:03:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:03:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:03:37 INFO - 'opt_config_files': (), 19:03:37 INFO - 'pip_index': False, 19:03:37 INFO - 'sps_profile': False, 19:03:37 INFO - 'sps_profile_interval': 0, 19:03:37 INFO - 'suite': 'dromaeojs-e10s', 19:03:37 INFO - 'system_bits': '32', 19:03:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:03:37 INFO - 'title': 'talos-linux64-ix-041', 19:03:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:03:37 INFO - 'use_talos_json': True, 19:03:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:03:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:03:37 INFO - 'work_dir': 'build'} 19:03:37 INFO - ##### 19:03:37 INFO - ##### Running clobber step. 19:03:37 INFO - ##### 19:03:37 INFO - Running pre-action listener: _resource_record_pre_action 19:03:37 INFO - Running main action method: clobber 19:03:37 INFO - rmtree: /builds/slave/test/build 19:03:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:03:37 INFO - Running post-action listener: _resource_record_post_action 19:03:37 INFO - ##### 19:03:37 INFO - ##### Finished clobber step (success) 19:03:37 INFO - ##### 19:03:37 INFO - ##### 19:03:37 INFO - ##### Running read-buildbot-config step. 19:03:37 INFO - ##### 19:03:37 INFO - Running pre-action listener: _resource_record_pre_action 19:03:37 INFO - Running main action method: read_buildbot_config 19:03:37 INFO - Using buildbot properties: 19:03:37 INFO - { 19:03:37 INFO - "project": "", 19:03:37 INFO - "product": "firefox", 19:03:37 INFO - "script_repo_revision": "production", 19:03:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:03:37 INFO - "repository": "", 19:03:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:03:37 INFO - "buildid": "20160607175925", 19:03:37 INFO - "pgo_build": "False", 19:03:37 INFO - "basedir": "/builds/slave/test", 19:03:37 INFO - "buildnumber": 1379, 19:03:37 INFO - "slavename": "talos-linux64-ix-041", 19:03:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:03:37 INFO - "platform": "ubuntu64_hw", 19:03:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:03:37 INFO - "branch": "fx-team", 19:03:37 INFO - "repo_path": "integration/fx-team", 19:03:37 INFO - "revision": "a7b31be0a19ae5413db3e10ad4e5251cac84b08d", 19:03:37 INFO - "stage_platform": "linux64", 19:03:37 INFO - "builduid": "0256be2a21c746358ff844f4828de7a7", 19:03:37 INFO - "slavebuilddir": "test" 19:03:37 INFO - } 19:03:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:03:37 INFO - Running post-action listener: _resource_record_post_action 19:03:37 INFO - ##### 19:03:37 INFO - ##### Finished read-buildbot-config step (success) 19:03:37 INFO - ##### 19:03:37 INFO - ##### 19:03:37 INFO - ##### Running download-and-extract step. 19:03:37 INFO - ##### 19:03:37 INFO - Running pre-action listener: _resource_record_pre_action 19:03:37 INFO - Running main action method: download_and_extract 19:03:37 INFO - mkdir: /builds/slave/test/build/tests 19:03:37 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')]} 19:03:37 INFO - https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:03:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:03:38 INFO - Downloaded 1361 bytes. 19:03:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:03:38 INFO - Using the following test package requirements: 19:03:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:03:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:03:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:03:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'jsshell-linux-x86_64.zip'], 19:03:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:03:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:03:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:03:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:03:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:03:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:03:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:03:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:38 INFO - https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:03:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:03:39 INFO - Downloaded 22873851 bytes. 19:03:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:03:40 INFO - Return code: 0 19:03:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:03: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')]} 19:03:40 INFO - https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:03:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:03:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:03:41 INFO - Downloaded 22873851 bytes. 19:03:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 19:03:43 INFO - Return code: 0 19:03: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')]} 19:03:43 INFO - https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:03:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:03:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:03:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:03:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:03:44 INFO - Downloaded 10833369 bytes. 19:03:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:03:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 19:03:44 INFO - Return code: 0 19:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:44 INFO - https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:03:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:03:45 INFO - Downloaded 55200424 bytes. 19:03:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:45 INFO - mkdir: /builds/slave/test/properties 19:03:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:03:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:03:45 INFO - Contents: 19:03:45 INFO - build_url:https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:03:46 INFO - Running post-action listener: _resource_record_post_action 19:03:46 INFO - Running post-action listener: set_extra_try_arguments 19:03:46 INFO - ##### 19:03:46 INFO - ##### Finished download-and-extract step (success) 19:03:46 INFO - ##### 19:03:46 INFO - ##### 19:03:46 INFO - ##### Running populate-webroot step. 19:03:46 INFO - ##### 19:03:46 INFO - Running pre-action listener: _resource_record_pre_action 19:03:46 INFO - Running main action method: populate_webroot 19:03:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:03:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:03:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:03:46 INFO - '--tppagecycles', 19:03:46 INFO - '7'], 19:03:46 INFO - 'tests': ['tsvgm']}}, 19:03:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:03:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:03:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:03:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:03:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:03:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['damp', 'tps']}, 19:03:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'tests': ['damp', 'tps']}, 19:03:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['dromaeo_dom']}, 19:03:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:03:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['a11yr', 19:03:46 INFO - 'ts_paint', 19:03:46 INFO - 'tpaint', 19:03:46 INFO - 'sessionrestore', 19:03:46 INFO - 'sessionrestore_no_auto_restore', 19:03:46 INFO - 'tabpaint']}, 19:03:46 INFO - 'other-e10s': {'tests': ['a11yr', 19:03:46 INFO - 'ts_paint', 19:03:46 INFO - 'tpaint', 19:03:46 INFO - 'sessionrestore', 19:03:46 INFO - 'sessionrestore_no_auto_restore', 19:03:46 INFO - 'tabpaint']}, 19:03:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:03:46 INFO - 'ts_paint', 19:03:46 INFO - 'tpaint', 19:03:46 INFO - 'sessionrestore', 19:03:46 INFO - 'sessionrestore_no_auto_restore', 19:03:46 INFO - 'tabpaint']}, 19:03:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:03:46 INFO - 'ts_paint', 19:03:46 INFO - 'tpaint', 19:03:46 INFO - 'sessionrestore', 19:03:46 INFO - 'sessionrestore_no_auto_restore', 19:03:46 INFO - 'tabpaint']}, 19:03:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['a11yr', 19:03:46 INFO - 'ts_paint', 19:03:46 INFO - 'tpaint', 19:03:46 INFO - 'sessionrestore', 19:03:46 INFO - 'sessionrestore_no_auto_restore', 19:03:46 INFO - 'tabpaint']}, 19:03:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['a11yr', 19:03:46 INFO - 'ts_paint', 19:03:46 INFO - 'tpaint', 19:03:46 INFO - 'sessionrestore', 19:03:46 INFO - 'sessionrestore_no_auto_restore', 19:03:46 INFO - 'tabpaint']}, 19:03:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['tsvgx', 19:03:46 INFO - 'tsvgr_opacity', 19:03:46 INFO - 'tart', 19:03:46 INFO - 'tscrollx', 19:03:46 INFO - 'cart']}, 19:03:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:03:46 INFO - 'tsvgr_opacity', 19:03:46 INFO - 'tart', 19:03:46 INFO - 'tscrollx', 19:03:46 INFO - 'cart']}, 19:03:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'talos_options': ['--disable-e10s'], 19:03:46 INFO - 'tests': ['tp5o']}, 19:03:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'tests': ['tp5o']}, 19:03:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'talos_options': ['--disable-e10s', 19:03:46 INFO - '--xperf_path', 19:03:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:46 INFO - 'tests': ['tp5n']}, 19:03:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:03:46 INFO - 'talos_options': ['--xperf_path', 19:03:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:03:46 INFO - 'tests': ['tp5n']}}, 19:03:46 INFO - 'talos.zip': {'path': '', 19:03:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:03:46 INFO - Running post-action listener: _resource_record_post_action 19:03:46 INFO - ##### 19:03:46 INFO - ##### Finished populate-webroot step (success) 19:03:46 INFO - ##### 19:03:46 INFO - ##### 19:03:46 INFO - ##### Running create-virtualenv step. 19:03:46 INFO - ##### 19:03:46 INFO - Running pre-action listener: _resource_record_pre_action 19:03:46 INFO - Running main action method: create_virtualenv 19:03:46 INFO - Creating virtualenv /builds/slave/test/build/venv 19:03:46 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 19:03:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:03:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:03:46 INFO - Using real prefix '/usr' 19:03:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:03:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:03:49 INFO - Installing pip.................done. 19:03:49 INFO - Return code: 0 19:03:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:49 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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:03:49 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 19:03:49 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 19:03:49 INFO - Using env: {'DISPLAY': ':0', 19:03:49 INFO - 'HOME': '/home/cltbld', 19:03:49 INFO - 'LANG': 'en_US.UTF-8', 19:03:49 INFO - 'LANGUAGE': 'en_US:en', 19:03:49 INFO - 'LOGNAME': 'cltbld', 19:03:49 INFO - 'MAIL': '/var/mail/cltbld', 19:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:49 INFO - 'MOZ_NO_REMOTE': '1', 19:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:49 INFO - 'NO_EM_RESTART': '1', 19:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:49 INFO - 'PWD': '/builds/slave/test', 19:03:49 INFO - 'SHELL': '/bin/bash', 19:03:49 INFO - 'SHLVL': '1', 19:03:49 INFO - 'TERM': 'linux', 19:03:49 INFO - 'TMOUT': '86400', 19:03:49 INFO - 'USER': 'cltbld', 19:03:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:49 INFO - '_': '/tools/buildbot/bin/python'} 19:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:49 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 19:03:49 INFO - Cleaning up... 19:03:49 INFO - Return code: 0 19:03:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:49 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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:03:49 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 19:03:49 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 19:03:49 INFO - Using env: {'DISPLAY': ':0', 19:03:49 INFO - 'HOME': '/home/cltbld', 19:03:49 INFO - 'LANG': 'en_US.UTF-8', 19:03:49 INFO - 'LANGUAGE': 'en_US:en', 19:03:49 INFO - 'LOGNAME': 'cltbld', 19:03:49 INFO - 'MAIL': '/var/mail/cltbld', 19:03:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:49 INFO - 'MOZ_NO_REMOTE': '1', 19:03:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:49 INFO - 'NO_EM_RESTART': '1', 19:03:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:49 INFO - 'PWD': '/builds/slave/test', 19:03:49 INFO - 'SHELL': '/bin/bash', 19:03:49 INFO - 'SHLVL': '1', 19:03:49 INFO - 'TERM': 'linux', 19:03:49 INFO - 'TMOUT': '86400', 19:03:49 INFO - 'USER': 'cltbld', 19:03:49 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:03:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:49 INFO - '_': '/tools/buildbot/bin/python'} 19:03:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:49 INFO - Downloading/unpacking psutil>=3.1.1 19:03:49 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 19:03:49 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 19:03:49 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 19:03:49 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 19:03:49 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 19:03:49 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 19:03:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:03:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:51 INFO - Installing collected packages: psutil 19:03:51 INFO - Running setup.py install for psutil 19:03:51 INFO - building 'psutil._psutil_linux' extension 19:03:51 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 19:03:51 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 19:03:51 INFO - building 'psutil._psutil_posix' extension 19:03:51 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 19:03:52 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 19:03:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:03:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:03:52 INFO - Successfully installed psutil 19:03:52 INFO - Cleaning up... 19:03:52 INFO - Return code: 0 19:03:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:52 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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:03:52 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 19:03:52 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 19:03:52 INFO - Using env: {'DISPLAY': ':0', 19:03:52 INFO - 'HOME': '/home/cltbld', 19:03:52 INFO - 'LANG': 'en_US.UTF-8', 19:03:52 INFO - 'LANGUAGE': 'en_US:en', 19:03:52 INFO - 'LOGNAME': 'cltbld', 19:03:52 INFO - 'MAIL': '/var/mail/cltbld', 19:03:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:52 INFO - 'MOZ_NO_REMOTE': '1', 19:03:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:52 INFO - 'NO_EM_RESTART': '1', 19:03:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:52 INFO - 'PWD': '/builds/slave/test', 19:03:52 INFO - 'SHELL': '/bin/bash', 19:03:52 INFO - 'SHLVL': '1', 19:03:52 INFO - 'TERM': 'linux', 19:03:52 INFO - 'TMOUT': '86400', 19:03:52 INFO - 'USER': 'cltbld', 19:03:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:03:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:52 INFO - '_': '/tools/buildbot/bin/python'} 19:03:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:03:54 INFO - Installing collected packages: mozsystemmonitor 19:03:54 INFO - Running setup.py install for mozsystemmonitor 19:03:54 INFO - Successfully installed mozsystemmonitor 19:03:54 INFO - Cleaning up... 19:03:54 INFO - Return code: 0 19:03:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:03: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')]} 19:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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')]} 19:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03: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', '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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:03: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:03: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 jsonschema==2.5.1 19:03:54 INFO - Using env: {'DISPLAY': ':0', 19:03:54 INFO - 'HOME': '/home/cltbld', 19:03:54 INFO - 'LANG': 'en_US.UTF-8', 19:03:54 INFO - 'LANGUAGE': 'en_US:en', 19:03:54 INFO - 'LOGNAME': 'cltbld', 19:03:54 INFO - 'MAIL': '/var/mail/cltbld', 19:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:54 INFO - 'MOZ_NO_REMOTE': '1', 19:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:54 INFO - 'NO_EM_RESTART': '1', 19:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:54 INFO - 'PWD': '/builds/slave/test', 19:03:54 INFO - 'SHELL': '/bin/bash', 19:03:54 INFO - 'SHLVL': '1', 19:03:54 INFO - 'TERM': 'linux', 19:03:54 INFO - 'TMOUT': '86400', 19:03:54 INFO - 'USER': 'cltbld', 19:03:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:54 INFO - '_': '/tools/buildbot/bin/python'} 19:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:03:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:03:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:03:57 INFO - warning: no files found matching '*.txt' 19:03:57 INFO - no previously-included directories found matching 'build' 19:03:57 INFO - no previously-included directories found matching 'dist' 19:03:57 INFO - no previously-included directories found matching '.git*' 19:03:57 INFO - Installing collected packages: jsonschema, functools32 19:03:57 INFO - Running setup.py install for functools32 19:03:57 INFO - warning: no files found matching '*.txt' 19:03:57 INFO - no previously-included directories found matching 'build' 19:03:57 INFO - no previously-included directories found matching 'dist' 19:03:57 INFO - no previously-included directories found matching '.git*' 19:03:57 INFO - Successfully installed jsonschema functools32 19:03:57 INFO - Cleaning up... 19:03:57 INFO - Return code: 0 19:03:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:03:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:03:57 INFO - Using env: {'DISPLAY': ':0', 19:03:57 INFO - 'HOME': '/home/cltbld', 19:03:57 INFO - 'LANG': 'en_US.UTF-8', 19:03:57 INFO - 'LANGUAGE': 'en_US:en', 19:03:57 INFO - 'LOGNAME': 'cltbld', 19:03:57 INFO - 'MAIL': '/var/mail/cltbld', 19:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:03:57 INFO - 'MOZ_NO_REMOTE': '1', 19:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:03:57 INFO - 'NO_EM_RESTART': '1', 19:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:03:57 INFO - 'PWD': '/builds/slave/test', 19:03:57 INFO - 'SHELL': '/bin/bash', 19:03:57 INFO - 'SHLVL': '1', 19:03:57 INFO - 'TERM': 'linux', 19:03:57 INFO - 'TMOUT': '86400', 19:03:57 INFO - 'USER': 'cltbld', 19:03:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:03:57 INFO - '_': '/tools/buildbot/bin/python'} 19:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:03:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:03:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:03:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:03: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 19:04:00 INFO - Downloading docopt-0.6.1.tar.gz 19:04:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:04:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:04:00 INFO - Running setup.py install for blobuploader 19:04:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:04:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:04:00 INFO - Running setup.py install for requests 19:04:00 INFO - Running setup.py install for docopt 19:04:00 INFO - Successfully installed blobuploader requests docopt 19:04:00 INFO - Cleaning up... 19:04:00 INFO - Return code: 0 19:04:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:00 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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:04:00 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 19:04:00 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 19:04:00 INFO - Using env: {'DISPLAY': ':0', 19:04:00 INFO - 'HOME': '/home/cltbld', 19:04:00 INFO - 'LANG': 'en_US.UTF-8', 19:04:00 INFO - 'LANGUAGE': 'en_US:en', 19:04:00 INFO - 'LOGNAME': 'cltbld', 19:04:00 INFO - 'MAIL': '/var/mail/cltbld', 19:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:00 INFO - 'MOZ_NO_REMOTE': '1', 19:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:00 INFO - 'NO_EM_RESTART': '1', 19:04:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:00 INFO - 'PWD': '/builds/slave/test', 19:04:00 INFO - 'SHELL': '/bin/bash', 19:04:00 INFO - 'SHLVL': '1', 19:04:00 INFO - 'TERM': 'linux', 19:04:00 INFO - 'TMOUT': '86400', 19:04:00 INFO - 'USER': 'cltbld', 19:04:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:00 INFO - '_': '/tools/buildbot/bin/python'} 19:04:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:00 INFO - Running setup.py (path:/tmp/pip-OZ18oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:01 INFO - Running setup.py (path:/tmp/pip-TpwUlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:01 INFO - Running setup.py (path:/tmp/pip-MNtrji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:01 INFO - Running setup.py (path:/tmp/pip-_kdlYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:01 INFO - Running setup.py (path:/tmp/pip-SVfKGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:01 INFO - Running setup.py (path:/tmp/pip-LFxbfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:01 INFO - Running setup.py (path:/tmp/pip-bIIymO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:01 INFO - Running setup.py (path:/tmp/pip-7AaNgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:01 INFO - Running setup.py (path:/tmp/pip-TxGSlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:01 INFO - Running setup.py (path:/tmp/pip-v5lzj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:01 INFO - Running setup.py (path:/tmp/pip-uxD4X0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:01 INFO - Running setup.py (path:/tmp/pip-Ldhyat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:01 INFO - Running setup.py (path:/tmp/pip-v2isXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:01 INFO - Running setup.py (path:/tmp/pip-VidCNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:01 INFO - Running setup.py (path:/tmp/pip-53RAq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:02 INFO - Running setup.py (path:/tmp/pip-sTL04t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:02 INFO - Running setup.py (path:/tmp/pip-mGtMJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:04:02 INFO - Running setup.py install for manifestparser 19:04:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Running setup.py install for mozcrash 19:04:02 INFO - Running setup.py install for mozdebug 19:04:02 INFO - Running setup.py install for mozdevice 19:04:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Running setup.py install for mozfile 19:04:02 INFO - Running setup.py install for mozhttpd 19:04:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Running setup.py install for mozinfo 19:04:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Running setup.py install for mozInstall 19:04:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:04:02 INFO - Running setup.py install for mozleak 19:04:03 INFO - Running setup.py install for mozlog 19:04:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Running setup.py install for moznetwork 19:04:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Running setup.py install for mozprocess 19:04:03 INFO - Running setup.py install for mozprofile 19:04:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Running setup.py install for mozrunner 19:04:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Running setup.py install for mozscreenshot 19:04:03 INFO - Running setup.py install for moztest 19:04:03 INFO - Running setup.py install for mozversion 19:04:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:04:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:04:03 INFO - Cleaning up... 19:04:03 INFO - Return code: 0 19:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:03 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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:04:03 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 19:04:03 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 19:04:03 INFO - Using env: {'DISPLAY': ':0', 19:04:03 INFO - 'HOME': '/home/cltbld', 19:04:03 INFO - 'LANG': 'en_US.UTF-8', 19:04:03 INFO - 'LANGUAGE': 'en_US:en', 19:04:03 INFO - 'LOGNAME': 'cltbld', 19:04:03 INFO - 'MAIL': '/var/mail/cltbld', 19:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:03 INFO - 'MOZ_NO_REMOTE': '1', 19:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:03 INFO - 'NO_EM_RESTART': '1', 19:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:03 INFO - 'PWD': '/builds/slave/test', 19:04:03 INFO - 'SHELL': '/bin/bash', 19:04:03 INFO - 'SHLVL': '1', 19:04:03 INFO - 'TERM': 'linux', 19:04:03 INFO - 'TMOUT': '86400', 19:04:03 INFO - 'USER': 'cltbld', 19:04:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:03 INFO - '_': '/tools/buildbot/bin/python'} 19:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:04:04 INFO - Running setup.py (path:/tmp/pip-0S2UMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:04:04 INFO - Running setup.py (path:/tmp/pip-GE0dIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:04:04 INFO - Running setup.py (path:/tmp/pip-3__ICh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:04:04 INFO - Running setup.py (path:/tmp/pip-kXnPUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:04:04 INFO - Running setup.py (path:/tmp/pip-b5alb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:04:04 INFO - Running setup.py (path:/tmp/pip-vbJfkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:04:04 INFO - Running setup.py (path:/tmp/pip-xzpDog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:04:04 INFO - Running setup.py (path:/tmp/pip-H44nSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:04:04 INFO - Running setup.py (path:/tmp/pip-svSD6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:04:04 INFO - Running setup.py (path:/tmp/pip-tFo3u5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:04:04 INFO - Running setup.py (path:/tmp/pip-M0fm9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:04:04 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)) 19:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:04:04 INFO - Running setup.py (path:/tmp/pip-Ail5gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:04:05 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)) 19:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:04:05 INFO - Running setup.py (path:/tmp/pip-eyKXnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:04:05 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)) 19:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:04:05 INFO - Running setup.py (path:/tmp/pip-KD3Ju1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:04:05 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)) 19:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:05 INFO - Running setup.py (path:/tmp/pip-FO_Xxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:04:05 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)) 19:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:04:05 INFO - Running setup.py (path:/tmp/pip-JVBnov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:04:05 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)) 19:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:04:05 INFO - Running setup.py (path:/tmp/pip-Mk3Lxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:04:05 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)) 19:04:05 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)) 19:04:05 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)) 19:04:05 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)) 19:04:05 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)) 19:04:05 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)) 19:04:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:07 INFO - Downloading blessings-1.6.tar.gz 19:04:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:04:07 INFO - Installing collected packages: blessings 19:04:07 INFO - Running setup.py install for blessings 19:04:07 INFO - Successfully installed blessings 19:04:07 INFO - Cleaning up... 19:04:07 INFO - Return code: 0 19:04:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:04:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:07 INFO - Reading from file tmpfile_stdout 19:04:07 INFO - Current package versions: 19:04:07 INFO - argparse == 1.2.1 19:04:07 INFO - blessings == 1.6 19:04:07 INFO - blobuploader == 1.2.4 19:04:07 INFO - docopt == 0.6.1 19:04:07 INFO - functools32 == 3.2.3-2 19:04:07 INFO - jsonschema == 2.5.1 19:04:07 INFO - manifestparser == 1.1 19:04:07 INFO - mozInstall == 1.12 19:04:07 INFO - mozcrash == 0.17 19:04:07 INFO - mozdebug == 0.1 19:04:07 INFO - mozdevice == 0.48 19:04:07 INFO - mozfile == 1.2 19:04:07 INFO - mozhttpd == 0.7 19:04:07 INFO - mozinfo == 0.9 19:04:07 INFO - mozleak == 0.1 19:04:07 INFO - mozlog == 3.2 19:04:07 INFO - moznetwork == 0.27 19:04:07 INFO - mozprocess == 0.22 19:04:07 INFO - mozprofile == 0.28 19:04:07 INFO - mozrunner == 6.11 19:04:07 INFO - mozscreenshot == 0.1 19:04:07 INFO - mozsystemmonitor == 0.3 19:04:07 INFO - moztest == 0.7 19:04:07 INFO - mozversion == 1.4 19:04:07 INFO - psutil == 3.1.1 19:04:07 INFO - requests == 1.2.3 19:04:07 INFO - wsgiref == 0.1.2 19:04:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:07 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 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:04:07 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 19:04:07 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 19:04:07 INFO - Using env: {'DISPLAY': ':0', 19:04:07 INFO - 'HOME': '/home/cltbld', 19:04:07 INFO - 'LANG': 'en_US.UTF-8', 19:04:07 INFO - 'LANGUAGE': 'en_US:en', 19:04:07 INFO - 'LOGNAME': 'cltbld', 19:04:07 INFO - 'MAIL': '/var/mail/cltbld', 19:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:07 INFO - 'MOZ_NO_REMOTE': '1', 19:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:07 INFO - 'NO_EM_RESTART': '1', 19:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:07 INFO - 'PWD': '/builds/slave/test', 19:04:07 INFO - 'SHELL': '/bin/bash', 19:04:07 INFO - 'SHLVL': '1', 19:04:07 INFO - 'TERM': 'linux', 19:04:07 INFO - 'TMOUT': '86400', 19:04:07 INFO - 'USER': 'cltbld', 19:04:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:07 INFO - '_': '/tools/buildbot/bin/python'} 19:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 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)) 19:04:07 INFO - Cleaning up... 19:04:07 INFO - Return code: 0 19:04:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:04:07 INFO - Using env: {'DISPLAY': ':0', 19:04:07 INFO - 'HOME': '/home/cltbld', 19:04:07 INFO - 'LANG': 'en_US.UTF-8', 19:04:07 INFO - 'LANGUAGE': 'en_US:en', 19:04:07 INFO - 'LOGNAME': 'cltbld', 19:04:07 INFO - 'MAIL': '/var/mail/cltbld', 19:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:07 INFO - 'MOZ_NO_REMOTE': '1', 19:04:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:07 INFO - 'NO_EM_RESTART': '1', 19:04:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:07 INFO - 'PWD': '/builds/slave/test', 19:04:07 INFO - 'SHELL': '/bin/bash', 19:04:07 INFO - 'SHLVL': '1', 19:04:07 INFO - 'TERM': 'linux', 19:04:07 INFO - 'TMOUT': '86400', 19:04:07 INFO - 'USER': 'cltbld', 19:04:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:07 INFO - '_': '/tools/buildbot/bin/python'} 19:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:04:08 INFO - Cleaning up... 19:04:08 INFO - Return code: 0 19:04:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:04:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff760e37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1274020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', '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 19:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:04:08 INFO - Using env: {'DISPLAY': ':0', 19:04:08 INFO - 'HOME': '/home/cltbld', 19:04:08 INFO - 'LANG': 'en_US.UTF-8', 19:04:08 INFO - 'LANGUAGE': 'en_US:en', 19:04:08 INFO - 'LOGNAME': 'cltbld', 19:04:08 INFO - 'MAIL': '/var/mail/cltbld', 19:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:08 INFO - 'MOZ_NO_REMOTE': '1', 19:04:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:08 INFO - 'NO_EM_RESTART': '1', 19:04:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:08 INFO - 'PWD': '/builds/slave/test', 19:04:08 INFO - 'SHELL': '/bin/bash', 19:04:08 INFO - 'SHLVL': '1', 19:04:08 INFO - 'TERM': 'linux', 19:04:08 INFO - 'TMOUT': '86400', 19:04:08 INFO - 'USER': 'cltbld', 19:04:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:08 INFO - '_': '/tools/buildbot/bin/python'} 19:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:04:08 INFO - Downloading/unpacking flake8 19:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:04:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:04:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:04:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:04: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 19:04: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 19:04: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 19:04: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 19:04: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 19:04: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 19:04:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:04:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:04: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 19:04: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 19:04: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 19:04: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 19:04: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 19:04: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 19:04:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:04: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 19:04: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 19:04: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 19:04: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 19:04: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 19:04: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 19:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:04:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:04:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:04:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:04:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:04:11 INFO - no previously-included directories found matching 'docs/_build' 19:04:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:04:11 INFO - Running setup.py install for pep8 19:04:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:04:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:04:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:04:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:04:11 INFO - no previously-included directories found matching 'docs/_build' 19:04:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:04:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:04:11 INFO - Cleaning up... 19:04:11 INFO - Return code: 0 19:04:11 INFO - Running post-action listener: _resource_record_post_action 19:04:11 INFO - Running post-action listener: _start_resource_monitoring 19:04:11 INFO - Starting resource monitoring. 19:04:11 INFO - ##### 19:04:11 INFO - ##### Finished create-virtualenv step (success) 19:04:11 INFO - ##### 19:04:11 INFO - ##### 19:04:11 INFO - ##### Running install step. 19:04:11 INFO - ##### 19:04:11 INFO - Running pre-action listener: _resource_record_pre_action 19:04:11 INFO - Running main action method: install 19:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:04:11 INFO - Reading from file tmpfile_stdout 19:04:11 INFO - Detecting whether we're running mozinstall >=1.0... 19:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:04:11 INFO - Reading from file tmpfile_stdout 19:04:11 INFO - Output received: 19:04:11 INFO - Usage: mozinstall [options] installer 19:04:11 INFO - Options: 19:04:11 INFO - -h, --help show this help message and exit 19:04:11 INFO - -d DEST, --destination=DEST 19:04:11 INFO - Directory to install application into. [default: 19:04:11 INFO - "/builds/slave/test"] 19:04:11 INFO - --app=APP Application being installed. [default: firefox] 19:04:11 INFO - mkdir: /builds/slave/test/build/application 19:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:04:27 INFO - Reading from file tmpfile_stdout 19:04:27 INFO - Output received: 19:04:27 INFO - /builds/slave/test/build/application/firefox/firefox 19:04:27 INFO - Running post-action listener: _resource_record_post_action 19:04:27 INFO - ##### 19:04:27 INFO - ##### Finished install step (success) 19:04:27 INFO - ##### 19:04:27 INFO - ##### 19:04:27 INFO - ##### Running run-tests step. 19:04:27 INFO - ##### 19:04:27 INFO - Running pre-action listener: _resource_record_pre_action 19:04:27 INFO - Running main action method: run_tests 19:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:04:27 INFO - Python 2.7.3 19:04:27 INFO - Return code: 0 19:04:27 INFO - grabbing minidump binary from tooltool 19:04:27 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')]} 19:04:27 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 0x13062e0>, '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 0x1272140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12725d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:04:27 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 19:04:27 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 19:04:27 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 19:04:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:04:27 INFO - Return code: 0 19:04:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:04:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:04:28 INFO - Return code: 0 19:04:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:04:28 INFO - Using env: {'DISPLAY': ':0', 19:04:28 INFO - 'HOME': '/home/cltbld', 19:04:28 INFO - 'LANG': 'en_US.UTF-8', 19:04:28 INFO - 'LANGUAGE': 'en_US:en', 19:04:28 INFO - 'LOGNAME': 'cltbld', 19:04:28 INFO - 'MAIL': '/var/mail/cltbld', 19:04:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:04:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:04:28 INFO - 'MOZ_NO_REMOTE': '1', 19:04:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:04:28 INFO - 'NO_EM_RESTART': '1', 19:04:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:04:28 INFO - 'PWD': '/builds/slave/test', 19:04:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:04:28 INFO - 'SHELL': '/bin/bash', 19:04:28 INFO - 'SHLVL': '1', 19:04:28 INFO - 'TERM': 'linux', 19:04:28 INFO - 'TMOUT': '86400', 19:04:28 INFO - 'USER': 'cltbld', 19:04:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702', 19:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:04:28 INFO - '_': '/tools/buildbot/bin/python'} 19:04:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:04:28 INFO - mozversion application_buildid: 20160607175925 19:04:28 INFO - mozversion application_changeset: a7b31be0a19ae5413db3e10ad4e5251cac84b08d 19:04:28 INFO - mozversion application_display_name: Nightly 19:04:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:04:28 INFO - mozversion application_name: Firefox 19:04:28 INFO - mozversion application_remotingname: firefox 19:04:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:04:28 INFO - mozversion application_vendor: Mozilla 19:04:28 INFO - mozversion application_version: 50.0a1 19:04:28 INFO - mozversion platform_buildid: 20160607175925 19:04:28 INFO - mozversion platform_changeset: a7b31be0a19ae5413db3e10ad4e5251cac84b08d 19:04:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:04:28 INFO - mozversion platform_version: 50.0a1 19:04:28 INFO - using testdate: 1465351468 19:04:28 INFO - actual date: 1465351468 19:04:28 INFO - starting webserver on 'localhost:37639' 19:04:28 INFO - SUITE-START | Running 2 tests 19:04:28 INFO - TEST-START | dromaeo_css 19:04:28 INFO - operating with platform_type : linux_ 19:04:28 INFO - Initialising browser for dromaeo_css test... 19:04:28 INFO - TEST-INFO | started process 27079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcG8X07/profile http://localhost:37639/getInfo.html) 19:04:34 INFO - PROCESS | 27079 | __metrics Screen width/height:1600/1200 19:04:34 INFO - PROCESS | 27079 | colorDepth:24 19:04:34 INFO - PROCESS | 27079 | Browser inner width/height: 1024/697 19:04:34 INFO - PROCESS | 27079 | __metrics 19:04:35 ERROR - PROCESS | 27079 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:04:35 INFO - TEST-INFO | 27079: exit 0 19:04:35 INFO - Browser initialized. 19:04:35 INFO - Running cycle 1/1 for dromaeo_css test... 19:04:35 INFO - TEST-INFO | started process 27196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcG8X07/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:04:47 INFO - PROCESS | 27196 | RSS: Main: 168075264 19:04:47 INFO - PROCESS | 27196 | 19:05:37 INFO - PROCESS | 27196 | 1465351537548 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] 19:07:49 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37639/tests/dromaeo/cssquery-ext.html) 19:07:50 INFO - PROCESS | 27196 | RSS: Main: 170512384 19:07:50 INFO - PROCESS | 27196 | 19:10:52 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-ext.html (next: http://localhost:37639/tests/dromaeo/cssquery-jquery.html) 19:10:53 INFO - PROCESS | 27196 | RSS: Main: 170500096 19:10:53 INFO - PROCESS | 27196 | 19:13:55 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37639/tests/dromaeo/cssquery-mootools.html) 19:13:55 INFO - PROCESS | 27196 | RSS: Main: 171343872 19:13:55 INFO - PROCESS | 27196 | 19:16:57 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37639/tests/dromaeo/cssquery-prototype.html) 19:16:58 INFO - PROCESS | 27196 | RSS: Main: 168878080 19:16:58 INFO - PROCESS | 27196 | 19:20:00 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37639/tests/dromaeo/cssquery-yui.html) 19:20:01 INFO - PROCESS | 27196 | RSS: Main: 169873408 19:20:01 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | Cycle 1(1): loaded http://localhost:37639/tests/dromaeo/cssquery-yui.html (next: http://localhost:37639/tests/dromaeo/cssquery-dojo.html) 19:23:04 INFO - PROCESS | 27196 | RSS: Main: 172077056 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | __start_tp_report 19:23:04 INFO - PROCESS | 27196 | _x_x_mozilla_page_load 19:23:04 INFO - PROCESS | 27196 | _x_x_mozilla_page_load_details 19:23:04 INFO - PROCESS | 27196 | |i|pagename|runs| 19:23:04 INFO - PROCESS | 27196 | |0;dojo.html;2632.736726327367;2686.033028109881;2689.8789554470045;2695.2183866678665;2700.8784604692787;4710.387649605551;4735.550122738343;4764.3329933809255;4831.830885918994;4858.052679727454;4683.718976861391;4771.35586695796;4777.307290442884;4778.283257511375;4787.473377928433;4360.803763830635;4385.144896745136;4451.065276291983;4487.820487180509;4499.46006479223;4187.602177793105;4413.470383553962;4432.468103827529;4491.30384790358;4492.775361231942;4300.419443375135;4380.802863871101;4407.823687052514;4411.1618792429335;4474.082813023322;4406.779661016968;4415.2935530315;4443;4459.2865141577195;4473.150101480708;4446.377507149002;4459.955400445986;4477.597016268552;4495.258282383403;4504.1892459357305;4601.447826260836;4670.976645116787;4679.649026323005;4693.718376897397;4695.765211739434;5119.8208062717995;5131.435542090367;5145.742712864342;5160.7419629018395;5192;5092.79628814847;5143.588512918957;5160.767765450526;5164.974175129138;5165.819196328148;4802.831900883452;4808.951910480885;4813.302071199727;4819.542143496362;4854.757262136879;5234;5275;5278.630495865329;5279.551238144801;5293.814716484904;4935.333729946483;4953.281774142729;4966.180580204225;5012.523810238022;5023.447420783711;4892.559669629751;5080.74596270185;5085.771140298695;5109.591232701375;5151.793928242828;4856.1016212000895;4920.286558449076;4920.975395123073;4921.704697718077;4928.433230178503;4908.950910490921;4910.975445122752;4911.7298548580175;4916.459189489154;4921.409430868247;4201.789910504463;4215.852445164404;4224.978875105605;4305.590968857953;4341.522432532419;3724.3110024645525;3773.547174339042;3789.8484060637265;3831.5210598675167;3844.7308688391545;4452.154090722753;4478.843240486633;4501.279795232747;4511.593956543927;4549.545045495424;5210.322658054504;5212.270282160501;5219.660722053054;5222.060029194781;5229.032628963654;4310.4611923509565;4499.910001799945;4506.59440650343;4511.436070491189;4545.590896819236;4526.683132180716;4549.09018196362;4574.565416285448;4574.977125114419;4586.977065114653;4758.904821903542;4792.7603619819565;4796.712197268175;4801.991581767728;4857.392825896763;4995.225740010304;5107;5108.182690769608;5124.308218390619;5136.743162841768;4814.181589129927;4852.150873597036;4861.027794441196;4868.196747536616;4914.778834952507;5031.290723774549;5096.210087436453;5097;5104.719240441811;5146.176611742103;5097.515736005222;5102.821401250939;5128.076946149579;5160.922586161286;5168.715720635401;4967.726775027409;4970.900581988268;4972.254161875748;4987.675801072919;4994.1759609663995;4933.358663373739;4937.9012419752125;4955.306257123933;4956.330895329229;5036.269740887477;4718.0799744050955;4718.575328220477;4824.638152138534;4824.95175048245;4837.032593481247;4869.926951095666;4882.267659851051;4887.218045112765;4902.117618828645;4946.950530494649;4832.154372984784;4835.782389792397;4837.395325584302;4848.369711937426;4886.560209581155 19:23:04 INFO - PROCESS | 27196 | |1;ext.html;544.1508419506;575.3527281807966;585.1632166002614;586.5512882644776;587.988240235195;38879.416808747854;40451.19097618053;40476.96422768293;40637.3904391434;43751.56248437515;39892.401613975744;40731.79634101826;40874.59125408745;40957.38563921536;41041.17917641645;7629.160792312828;7794.805129871742;7815.374770018413;7823.139454660011;7828.9217107829045;7662.195469475709;7764.456488045839;7774.028246469192;7782.494137881048;7801.531908085504;7766.223377662245;7831.765047048598;7832.530048197098;7839.412044096715;7848.372130229596;7703.8844417333785;7749.992500974893;7773.766786996399;7788.1043679976965;7807.609619519001;7704.807379815494;7769.145394006655;7771.184025677336;7792.4155688323035;7798.337141342992;34664.13339666528;34959.82520087409;35029.47455788165;35070.123246918774;35073.29853402918;3070.7696922730884;3183.065930690039;3327;3797.9620203797886;3805.315043292206;28085.578716319273;28968.855155724297;28984.27539311513;29899.103026909226;30020.849895750598;3403.3533628610485;3410.3179364127272;3426;3447.931041379158;3501.0547152269;179082.10458947753;180617;181040;181266.09366953082;181501;31668;50961;51564.48435515672;51609;51652.48347516552;31720.206994824854;33492;33729;33795;33838.49242261368;13583.86416135826;13623.59129226105;13658.180509169482;13679.589612311647;13756.243406612732;11332.093432525378;11358.318500889807;11377.089832813355;11412.657620271406;11432.94283528577;7840.764777056697;7901.288884000468;7915.960420197862;7931.286184243446;7932.206779322021;3064.1420402287395;3115.3613509230554;3156.936861262762;3183.697548732867;3206.4709322961917;875.1205038935828;899.3524662243175;922.4834092907993;944.4097439100562;1051.81593221186;27402.625951757662;27496.312592185357;27671.58492622612;27895.860520697268;28472.857635712102;976.6972238606055;985.8091187343495;991.3853410885297;999.7250756042147;1009.6062535611118;14681.706365872622;14911.179885106207;15024.474143404928;15058.623534411727;15261.465848695465;121110;122036;122790.38604807097;392877;394372;48691;49090.26364604462;49352.25971610429;49353;49391.25913111306;1184.5202692909386;1219.741970032044;1226.564569577787;1238.7832129377323;1249.575144450891;25495.6175657369;26950.59574106351;27223.72776272212;27535.86232068827;27582.724172758015;41415;41694.374584380654;41755.373669395594;41792;41795.37306940337;261548;261580;264483;264668;264932;24720.50558988846;24907.128250511145;24953;25034.123805666713;25087.498250035263;40183.1963360737;40801.59198407978;40980.38529422002;41835.58164418317;41889;34504.48243276303;35257.29485410329;36078.8196059018;36142.277154456235;36496.81751591225;35385.64614353926;35530.11174720652;35549.466757999166;35664;35843.28313433665;34167.31665366729;35885.1028724284;36295.09262268359;36324;38336.233275333776;30032.24919377033;33043.66956330406;33469.15512181394;33536;33553.32893342168;24815.379615509035;24995.375115622253;25038.62442063334;25364.365890852878;25509.872450637627 19:23:04 INFO - PROCESS | 27196 | |2;jquery.html;365.5905385967716;370.4295385106935;372.54549449671407;385.28145009557187;389.5539607149814;15751.291191896364;15880.761788573167;16803;16940.830591694063;16981.83018169818;15577.610559735984;15645.608859778511;16503.91748041258;16516.339346426157;16550.83449165508;4983.3272508211385;5169.56058735008;5195.038917800219;5195.948040519603;5197.454267301917;4904.730239836807;5134.25553294772;5136.126858434075;5183.274341592161;5188.584913206953;4968.056069346831;4996.250562415648;4999.075171093341;5000.849974500771;5025.120603894322;4817.735024573647;4950.925736113961;4962.0820148272505;4972.825951091712;4974.552290293855;4513.548645135493;4563.703359281636;4565.269556870885;4571.3143028545655;4590.242609969351;18759.062046897736;19188.424347269603;19460.22159113634;19834.80165198344;19904.20383184671;1783.9821601783947;1894.4411398637435;2024.8785072895673;2046.2326627514683;2196.4618668426338;8527.914720852774;8843.955780221122;8998.235150012191;9110.726678199664;13001.349932503337;1748.2220411916703;1792.5249808800547;1804.6751584714746;1805.747195392646;1835.7363287258063;48176.27735583969;59862.40137598612;60406.697966509884;62849.371506284806;66328.3367166327;9462.29032822541;9547.570359333846;9948;10008.79982400348;10127.949360253298;13890.305484725723;13930;13965.720685586231;13972.650683732785;13984.230867302193;7331.3768329692575;7376.151742549569;7514.47398682087;7585.924140758632;7607.16321204667;6983.825404364931;7014.754483593049;7031.40233080194;7050.894236586455;7101.289871012961;4314.439122914064;4324.567543245713;4362.454693163355;4362.7715490536775;4395.406620106309;1838.7793464784045;1900.6388786130867;1905.7141428785792;1913.0817207740363;1918.673825449677;761.1741260732057;822.6010384963288;869.9434536755091;895.8880139982502;978.7504186432557;16171.919140404223;16247.837521624633;16504.17479126039;16709;16780;856.2850020233175;884.9823003539893;895.2614093372994;900.9279257659372;949.264320151874;6686.4985126115735;9280.489573073546;9362.578683959238;9398.342116051948;9448.527573621292;374269;420543;421066;421277;425423;67014.32985670178;79076.20923790804;86377.5681121603;86943.56528217318;87469;914.3919293669635;922.4834092907993;935.5976929920336;950.4344914775697;951.6526467839188;15089.773653395427;15112.244387780347;15113.31990060428;15287.923560382127;15743.842561574696;32214.83892580522;33564.32871342511;35319.646803531636;37092;37101.814490927376;50517;50594.241086383;51065.23402149045;51248.23127653163;51274.48725512697;7431.5912624804;7689.307962283421;7769;7803.687852485837;7819.218078192363;8548;11089.778204436028;12027.939860300643;12030.218035827644;12041.638750837488;9929.801403971736;10484.161267098461;10669.8933010672;10680.145588352758;10717.089047431056;10351.63769268072;10383.325083869524;10411.323263987817;10476.68569942903;10550.8417373741;10767.300125491818;10789.082927951213;10796.89203107959;10813.62152324665;11173.106151507698;7414;7479.925200747923;7520.398368130427;7528.887066694114;7932.682692692228;10613.522391492246;10628.84056739165;10631.787364252517;10723.19576031785;10742.19433542503 19:23:04 INFO - PROCESS | 27196 | |3;mootools.html;1296.3388671777393;1350.3518311210619;1402.4179965314395;1674.3972170018799;1691.086813120914;6393.328700486451;7316.963415182923;7442.255774422555;7833.764987050384;7855.214478552149;7486.401087912967;7614.4669873108905;7663.501872378291;7684.53892766433;7704.3451306639;2121.151539384247;2173.717416735822;2174.717286752728;2175.369142948543;2180.465785882453;2086.62440760663;2130.084063852543;2170.012644246872;2172.6523756199012;2172.945676358088;2170.8914554272224;2171.8055069711672;2177.2053200581754;2179.596774596697;2197.3627647982066;2114.587655407196;2117.1531387444993;2118.629239883014;2118.671605901088;2125.8405619578593;2062.1442101527846;2069.5240094778133;2079.241077006897;2082.875027498355;2098.3495116513927;7662.8084297893;7687.423443241779;7719.3052625264;7728.6908523658985;7754.030746156731;4180.310248808943;4287.48550173978;4302.204092242945;4303.784810759481;4326.697131200817;2780.9443811123665;2860.4851126797166;2870.1102658176032;2870.3111253299267;2906.7819913506573;884.1379654836483;896.9820603587891;932.1051790281338;939.1641439119189;942.0202988891613;9707.466089365082;9782.902170978341;9798.755031124208;9829.115379615869;9852.950735246279;3992.960070399317;4031.496062992126;4119.237940980928;4159.667226621863;4164.271252530855;8463;8556.27271681914;8571.357148213909;8577.78555536104;8590.484570925764;4355.847545335898;4411.602955733999;4418.668599855024;4530;4585.28928016158;3529.7705649133236;3958.2083583283456;4066.4916885389325;4080.2043601498017;4127.9587204128175;3495.1611613213154;3557.982210088933;3637.799921004317;3651.653092956165;3735.551733791908;1155.8439610652622;1199.9280043197436;1200.39980009995;1212.2484059882752;1214.732758793064;768.8308572114126;844.657913545003;867.6702852915978;875.2123089219754;899.4243684042218;5275.103232450492;5404.081306177881;5439.891202175934;5463.453654634584;5487.98472282629;377.06675976956814;380.3173303919416;384.4521556781575;384.45407521319794;393.1645253835599;3600.855965761393;3654.3422184007136;3704.608329387145;3724.5158129443;3748.11919198988;8857.3799834011;9417.058294170529;9483.620655173854;9487.810243795086;9497.287703422133;9220.124088211609;9273.907260927304;9317.11487408695;9320.813583728423;9395.765105872408;7095.50331476802;7171.282871712787;7195.604241766753;7223.89164162538;7226.024486694334;5063.291139240436;5068.9239661405845;5126.641135120506;5296;5317.707526086102;8798.956005219932;8821.382503224713;8833.602487887933;8844.425112367675;8858.424202426822;8732.912462096683;8913.821723565623;8965.462072275684;9058.818823623622;9066.863997040182;5587.552995760248;6203.658798766111;6385.329540398191;6459.257185423548;6489.286178520453;7207.891881621885;7227.313405226495;7265.09186351706;7278.308560686726;7283.380912622274;6366.745330186741;6448.613083215022;6500.837479062872;6647.5014373921185;6726.73093076291;6387.712552935036;6394.520410969289;6453.548251622341;6512.92536731434;6520.282768895323;6072.301685306246;6107.725152368065;6142.723577438936;6143.385661433821;6154.661493617715;4377.737335759864;4487.865364039084;4545.613622841963;4632.837850675211;4644.047970166041;4480.462344518679;4484.887877803081;4513.390692256635;4541.409616749801;4561.064981678682 19:23:04 INFO - PROCESS | 27196 | |4;prototype.html;285.8913612827125;292.4735476142944;294.27020987949885;297.7632781938359;301.6636450357852;5007.699538027721;5044.19292913134;5052.545270925621;5078.822241221558;5105.5149760772665;4968.180250258703;5002.924956125652;5029.497050294969;5029.5221953914315;5046.788770695034;3707.610700876403;3810.742454989847;3933.704972127102;3941.783201923893;3949.1311911379594;3912.726109172359;3915.314819906519;3930.76415415076;3939.2121575684832;3948.867611489792;3925.8429662813455;3944.349182384917;3950.841966321358;3961.7028722845757;3977.880663580097;3858.7491813032343;3918.3534716771983;3925.8625948091967;3952.367621180612;3957.6240257175523;3438.0574975138966;3454.844531996066;3464.497647841049;3467.2718729066673;3496.73774466916;4872.6832755870755;4877.487863774323;4882.145624515695;4908.01839632075;4928.310036594879;4347.934780978288;4529.320601909707;4553.817847286105;4564.360989461478;4599.678022538424;5272.499112584298;5294.92057619136;5301.946980530222;5319.9202011969855;5329.920051199235;3805.1438426354125;3809.8189561236104;3819.854043786853;3820.84716611338;3825.1967086911504;5311.176767601028;5551.111822108443;5556.388797232301;5575.8884822303735;5621.943780562183;3880;3882.5345905350305;3882.902927426837;3897.2010737798682;3899.863504777319;3941.3102707026155;3942.211557688474;3966.7619942803526;3968.9603103969166;3977.4033894915992;4520.276755719069;4520.304885667874;4539.500654927955;4549.158405694957;4557.567031132037;5234.18870075139;5285.497877701612;5322.3879253885525;5343.70609616467;5410.810621628303;1365.3752035078226;1382.260490637504;1383.8823699985412;1387.5708020738655;1391.471240928461;849.6006876767909;869.604330029835;882.9072947340437;891.3582220801013;892.8660601036647;4567.1779079765965;4626.86119416418;4712.575868171881;4714.222153344728;4733.195356789354;5467.660423196342;5472.425395333433;5476.452354764491;5499.642523235977;5536.695481748542;4530.343100250511;4692.061587682477;4700.506446823103;4719.339292499053;4727.810887564528;2885.249835042904;2936.8091074080116;2937.3537821679197;2943.8969636062634;2948.2334593005544;5138.794448222104;5157.174852023658;5166.457521960216;5169.948300517022;5191.714455704897;5386.245925570423;5591.552675785927;5594.608377413542;5630.577706672016;5689.715514224272;5129.769160387791;5129.820456284012;5137.460566640449;5143.1227601925775;5164.767585458589;5487.451254874481;5494.1758736189895;5495.2856128703015;5516.751746171351;5528.19841123043;5147.562457191031;5441.809536666197;5476.561875049907;5484.643498172606;5505.146702261156;5206;5227.738613069255;5237.685738855681;5238.76425560843;5255.290535777621;3923.4311024900658;3948.4669569607736;3948.763074215556;3954.723169378116;3971.980140099281;5427.375851777097;5451.264079349237;5499.340079190522;5514.2004409359615;5526.50261476469;5314.316270283637;5316.282301889196;5316.405078476519;5328.440513746001;5329.760160792851;5078.390593128848;5254.448282930391;5283.233931080049;5305.787768489217;5323.520883120537;5123.666961647481;5134.332536770196;5138.766695993009;5139.8715032123;5165.870853228549;5052.459000004887;5219.243209734491;5337.973310133424;5367.731613419235;5371.946280537145;5221.399539053057;5230.790768369223;5233.869153271199;5248.212768084818;5259.684418934876 19:23:04 INFO - PROCESS | 27196 | |5;yui.html;570.3697414357135;581.9272590926134;583.6352279825107;587.3744462147812;610.4536439886299;12510.124291299613;12922.676933076678;12968.157069790468;12973.286469244187;13685.521006764766;14257.287135643202;14767;14781.778273325908;14785.852141478583;14789.852101478982;624.7532224771213;794.5629903553023;794.996025019877;795.2087672765606;796.4265728675344;777.0946846923327;809.9797505062392;811.8254575266317;814.775936617429;815.7471183933;835.8829763833069;838.6310023589632;839.4585492357456;839.588601585225;841.3479553346144;829.6847198064727;830.6220669595319;832.305025303872;833.2750507058868;833.5873742497442;606.8270542895298;613.3284053960906;613.7882430561449;614.0666187395134;615.0497481391217;12891.613251602374;13024.609261722164;13026.088173827837;13051.347432628425;13091.279979601119;12296.815547766791;12693.701947974312;12770.872291277154;12804.935975320157;13133.737325253442;9466.242700583936;9659.613615455373;9677.37097088687;9727.513624318826;9827.803443931081;3267.803931764102;3341.816200108993;3369.2756057447523;3374.9325013499592;3440.3807314683345;57686.134707979414;58098.70950645262;58681;59042.70478647622;59052.704736476044;9405.623775049058;9851.113399794052;10202.234832387601;10232.079112879877;10526.684199474028;16945.576360590836;18356.08219589015;18686.197070439543;18761.34335298258;18863.24547018104;6510.707018184193;6531.934680653133;6727.899081513781;6730.697118629673;6920.7231710731;3233.805971641709;3272.3291725196277;3327.683870032343;3394.6775056369606;3435.0553597760318;2978.4489869374233;3089.7373723233327;3090.9381812363627;3098.3493466372315;3114.174743692923;505.06310793478303;509.1065180608009;512.6923845692554;523.5105176659836;527.2302438439845;584.2171490203148;608.7321578505444;629.3549112159981;644.2687549631203;652.4323838260743;7486.242549083971;8287.171282871665;8292.751217463485;8345.290650294794;8346;527.5225920541916;549.9092649712752;579.9913001304984;603.5563860562484;619.4239357397663;3727.6086010968456;3752.81235938202;3772.5098586058352;3809.4857194278416;3990.1221731219084;53792.95882244247;54145.72927135339;57597.42402576005;73612;90779.54610226907;35811.64188358135;36396;37797.62202377996;47876.7606161967;48647;69508.6524567384;73388.63305683545;73569.26430735624;74017;74953.62523187349;7154.785356439315;7253.709851605877;7356.816079597838;7371.299726525972;7382.815429614303;33901.49147762835;43773;43815.34276985784;43905.78047109744;45642.543574565156;59712.70143649254;60917.39082609117;61204.69397652983;61410;61691.69154154201;9499.097585729345;9720.222382209266;9771.902280977383;10077.294589378673;10290.796442490437;10760;10812.729681758019;10876;11120.3327800329;11221.046211072151;10152.593896244067;10214.285000049926;10279.280450368702;10361.948190259;10629.149668026694;9951.950240248752;10016;10363.844542332023;10453.414348960107;10581.788364232518;9242.306826988137;9998.950005249928;10035.297529172887;10062.849057264;11198.552057917592;9173.541322933694;9333.25333973267;9483.478408687588;9490.667826626035;9572.664956726481;9610.903890961;9938.950305248427;9967.700968970943;10017;10040.849387259052 19:23:04 INFO - PROCESS | 27196 | __end_tp_report 19:23:04 INFO - PROCESS | 27196 | __start_cc_report 19:23:04 INFO - PROCESS | 27196 | _x_x_mozilla_cycle_collect,388 19:23:04 INFO - PROCESS | 27196 | __end_cc_report 19:23:04 INFO - PROCESS | 27196 | __startTimestamp1465352584348__endTimestamp 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | ------- Summary: start ------- 19:23:04 INFO - PROCESS | 27196 | Number of tests: 6 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | [#0] dojo.html Cycles:165 Average:4713.83 Median:4832.15 stddev:484.62 (10.0%) stddev-sans-first:457.78 19:23:04 INFO - PROCESS | 27196 | Values: 2632.7 2686.0 2689.9 2695.2 2700.9 4710.4 4735.6 4764.3 4831.8 4858.1 4683.7 4771.4 4777.3 4778.3 4787.5 4360.8 4385.1 4451.1 4487.8 4499.5 4187.6 4413.5 4432.5 4491.3 4492.8 4300.4 4380.8 4407.8 4411.2 4474.1 4406.8 4415.3 4443.0 4459.3 4473.2 4446.4 4460.0 4477.6 4495.3 4504.2 4601.4 4671.0 4679.6 4693.7 4695.8 5119.8 5131.4 5145.7 5160.7 5192.0 5092.8 5143.6 5160.8 5165.0 5165.8 4802.8 4809.0 4813.3 4819.5 4854.8 5234.0 5275.0 5278.6 5279.6 5293.8 4935.3 4953.3 4966.2 5012.5 5023.4 4892.6 5080.7 5085.8 5109.6 5151.8 4856.1 4920.3 4921.0 4921.7 4928.4 4909.0 4911.0 4911.7 4916.5 4921.4 4201.8 4215.9 4225.0 4305.6 4341.5 3724.3 3773.5 3789.8 3831.5 3844.7 4452.2 4478.8 4501.3 4511.6 4549.5 5210.3 5212.3 5219.7 5222.1 5229.0 4310.5 4499.9 4506.6 4511.4 4545.6 4526.7 4549.1 4574.6 4575.0 4587.0 4758.9 4792.8 4796.7 4802.0 4857.4 4995.2 5107.0 5108.2 5124.3 5136.7 4814.2 4852.2 4861.0 4868.2 4914.8 5031.3 5096.2 5097.0 5104.7 5146.2 5097.5 5102.8 5128.1 5160.9 5168.7 4967.7 4970.9 4972.3 4987.7 4994.2 4933.4 4937.9 4955.3 4956.3 5036.3 4718.1 4718.6 4824.6 4825.0 4837.0 4869.9 4882.3 4887.2 4902.1 4947.0 4832.2 4835.8 4837.4 4848.4 4886.6 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | [#1] ext.html Cycles:180 Average:38302.95 Median:35165.30 stddev:63300.56 (180.0%) stddev-sans-first:63414.65 19:23:04 INFO - PROCESS | 27196 | Values: 544.2 575.4 585.2 586.6 588.0 38879.4 40451.2 40477.0 40637.4 43751.6 39892.4 40731.8 40874.6 40957.4 41041.2 7629.2 7794.8 7815.4 7823.1 7828.9 7662.2 7764.5 7774.0 7782.5 7801.5 7766.2 7831.8 7832.5 7839.4 7848.4 7703.9 7750.0 7773.8 7788.1 7807.6 7704.8 7769.1 7771.2 7792.4 7798.3 34664.1 34959.8 35029.5 35070.1 35073.3 3070.8 3183.1 3327.0 3798.0 3805.3 28085.6 28968.9 28984.3 29899.1 30020.8 3403.4 3410.3 3426.0 3447.9 3501.1 179082.1 180617.0 181040.0 181266.1 181501.0 31668.0 50961.0 51564.5 51609.0 51652.5 31720.2 33492.0 33729.0 33795.0 33838.5 13583.9 13623.6 13658.2 13679.6 13756.2 11332.1 11358.3 11377.1 11412.7 11432.9 7840.8 7901.3 7916.0 7931.3 7932.2 3064.1 3115.4 3156.9 3183.7 3206.5 875.1 899.4 922.5 944.4 1051.8 27402.6 27496.3 27671.6 27895.9 28472.9 976.7 985.8 991.4 999.7 1009.6 14681.7 14911.2 15024.5 15058.6 15261.5 121110.0 122036.0 122790.4 392877.0 394372.0 48691.0 49090.3 49352.3 49353.0 49391.3 1184.5 1219.7 1226.6 1238.8 1249.6 25495.6 26950.6 27223.7 27535.9 27582.7 41415.0 41694.4 41755.4 41792.0 41795.4 261548.0 261580.0 264483.0 264668.0 264932.0 24720.5 24907.1 24953.0 25034.1 25087.5 40183.2 40801.6 40980.4 41835.6 41889.0 34504.5 35257.3 36078.8 36142.3 36496.8 35385.6 35530.1 35549.5 35664.0 35843.3 34167.3 35885.1 36295.1 36324.0 38336.2 30032.2 33043.7 33469.2 33536.0 33553.3 24815.4 24995.4 25038.6 25364.4 25509.9 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | [#2] jquery.html Cycles:180 Average:24633.27 Median:4454.48 stddev:68016.94 (1526.9%) stddev-sans-first:68183.34 19:23:04 INFO - PROCESS | 27196 | Values: 365.6 370.4 372.5 385.3 389.6 15751.3 15880.8 16803.0 16940.8 16981.8 15577.6 15645.6 16503.9 16516.3 16550.8 4983.3 5169.6 5195.0 5195.9 5197.5 4904.7 5134.3 5136.1 5183.3 5188.6 4968.1 4996.3 4999.1 5000.8 5025.1 4817.7 4950.9 4962.1 4972.8 4974.6 4513.5 4563.7 4565.3 4571.3 4590.2 18759.1 19188.4 19460.2 19834.8 19904.2 1784.0 1894.4 2024.9 2046.2 2196.5 8527.9 8844.0 8998.2 9110.7 13001.3 1748.2 1792.5 1804.7 1805.7 1835.7 48176.3 59862.4 60406.7 62849.4 66328.3 9462.3 9547.6 9948.0 10008.8 10127.9 13890.3 13930.0 13965.7 13972.7 13984.2 7331.4 7376.2 7514.5 7585.9 7607.2 6983.8 7014.8 7031.4 7050.9 7101.3 4314.4 4324.6 4362.5 4362.8 4395.4 1838.8 1900.6 1905.7 1913.1 1918.7 761.2 822.6 869.9 895.9 978.8 16171.9 16247.8 16504.2 16709.0 16780.0 856.3 885.0 895.3 900.9 949.3 6686.5 9280.5 9362.6 9398.3 9448.5 374269.0 420543.0 421066.0 421277.0 425423.0 67014.3 79076.2 86377.6 86943.6 87469.0 914.4 922.5 935.6 950.4 951.7 15089.8 15112.2 15113.3 15287.9 15743.8 32214.8 33564.3 35319.6 37092.0 37101.8 50517.0 50594.2 51065.2 51248.2 51274.5 7431.6 7689.3 7769.0 7803.7 7819.2 8548.0 11089.8 12027.9 12030.2 12041.6 9929.8 10484.2 10669.9 10680.1 10717.1 10351.6 10383.3 10411.3 10476.7 10550.8 10767.3 10789.1 10796.9 10813.6 11173.1 7414.0 7479.9 7520.4 7528.9 7932.7 10613.5 10628.8 10631.8 10723.2 10742.2 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | [#3] mootools.html Cycles:180 Average:4982.64 Median:5360.89 stddev:2774.05 (51.7%) stddev-sans-first:2768.00 19:23:04 INFO - PROCESS | 27196 | Values: 1296.3 1350.4 1402.4 1674.4 1691.1 6393.3 7317.0 7442.3 7833.8 7855.2 7486.4 7614.5 7663.5 7684.5 7704.3 2121.2 2173.7 2174.7 2175.4 2180.5 2086.6 2130.1 2170.0 2172.7 2172.9 2170.9 2171.8 2177.2 2179.6 2197.4 2114.6 2117.2 2118.6 2118.7 2125.8 2062.1 2069.5 2079.2 2082.9 2098.3 7662.8 7687.4 7719.3 7728.7 7754.0 4180.3 4287.5 4302.2 4303.8 4326.7 2780.9 2860.5 2870.1 2870.3 2906.8 884.1 897.0 932.1 939.2 942.0 9707.5 9782.9 9798.8 9829.1 9853.0 3993.0 4031.5 4119.2 4159.7 4164.3 8463.0 8556.3 8571.4 8577.8 8590.5 4355.8 4411.6 4418.7 4530.0 4585.3 3529.8 3958.2 4066.5 4080.2 4128.0 3495.2 3558.0 3637.8 3651.7 3735.6 1155.8 1199.9 1200.4 1212.2 1214.7 768.8 844.7 867.7 875.2 899.4 5275.1 5404.1 5439.9 5463.5 5488.0 377.1 380.3 384.5 384.5 393.2 3600.9 3654.3 3704.6 3724.5 3748.1 8857.4 9417.1 9483.6 9487.8 9497.3 9220.1 9273.9 9317.1 9320.8 9395.8 7095.5 7171.3 7195.6 7223.9 7226.0 5063.3 5068.9 5126.6 5296.0 5317.7 8799.0 8821.4 8833.6 8844.4 8858.4 8732.9 8913.8 8965.5 9058.8 9066.9 5587.6 6203.7 6385.3 6459.3 6489.3 7207.9 7227.3 7265.1 7278.3 7283.4 6366.7 6448.6 6500.8 6647.5 6726.7 6387.7 6394.5 6453.5 6512.9 6520.3 6072.3 6107.7 6142.7 6143.4 6154.7 4377.7 4487.9 4545.6 4632.8 4644.0 4480.5 4484.9 4513.4 4541.4 4561.1 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | [#4] prototype.html Cycles:180 Average:4415.99 Median:5045.49 stddev:1283.71 (25.4%) stddev-sans-first:1249.32 19:23:04 INFO - PROCESS | 27196 | Values: 285.9 292.5 294.3 297.8 301.7 5007.7 5044.2 5052.5 5078.8 5105.5 4968.2 5002.9 5029.5 5029.5 5046.8 3707.6 3810.7 3933.7 3941.8 3949.1 3912.7 3915.3 3930.8 3939.2 3948.9 3925.8 3944.3 3950.8 3961.7 3977.9 3858.7 3918.4 3925.9 3952.4 3957.6 3438.1 3454.8 3464.5 3467.3 3496.7 4872.7 4877.5 4882.1 4908.0 4928.3 4347.9 4529.3 4553.8 4564.4 4599.7 5272.5 5294.9 5301.9 5319.9 5329.9 3805.1 3809.8 3819.9 3820.8 3825.2 5311.2 5551.1 5556.4 5575.9 5621.9 3880.0 3882.5 3882.9 3897.2 3899.9 3941.3 3942.2 3966.8 3969.0 3977.4 4520.3 4520.3 4539.5 4549.2 4557.6 5234.2 5285.5 5322.4 5343.7 5410.8 1365.4 1382.3 1383.9 1387.6 1391.5 849.6 869.6 882.9 891.4 892.9 4567.2 4626.9 4712.6 4714.2 4733.2 5467.7 5472.4 5476.5 5499.6 5536.7 4530.3 4692.1 4700.5 4719.3 4727.8 2885.2 2936.8 2937.4 2943.9 2948.2 5138.8 5157.2 5166.5 5169.9 5191.7 5386.2 5591.6 5594.6 5630.6 5689.7 5129.8 5129.8 5137.5 5143.1 5164.8 5487.5 5494.2 5495.3 5516.8 5528.2 5147.6 5441.8 5476.6 5484.6 5505.1 5206.0 5227.7 5237.7 5238.8 5255.3 3923.4 3948.5 3948.8 3954.7 3972.0 5427.4 5451.3 5499.3 5514.2 5526.5 5314.3 5316.3 5316.4 5328.4 5329.8 5078.4 5254.4 5283.2 5305.8 5323.5 5123.7 5134.3 5138.8 5139.9 5165.9 5052.5 5219.2 5338.0 5367.7 5371.9 5221.4 5230.8 5233.9 5248.2 5259.7 19:23:04 INFO - PROCESS | 27196 | 19:23:04 INFO - PROCESS | 27196 | [#5] yui.html Cycles:180 Average:15175.06 Median:29133.06 stddev:20111.34 (69.0%) stddev-sans-first:20137.86 19:23:04 INFO - PROCESS | 27196 | Values: 570.4 581.9 583.6 587.4 610.5 12510.1 12922.7 12968.2 12973.3 13685.5 14257.3 14767.0 14781.8 14785.9 14789.9 624.8 794.6 795.0 795.2 796.4 777.1 810.0 811.8 814.8 815.7 835.9 838.6 839.5 839.6 841.3 829.7 830.6 832.3 833.3 833.6 606.8 613.3 613.8 614.1 615.0 12891.6 13024.6 13026.1 13051.3 13091.3 12296.8 12693.7 12770.9 12804.9 13133.7 9466.2 9659.6 9677.4 9727.5 9827.8 3267.8 3341.8 3369.3 3374.9 3440.4 57686.1 58098.7 58681.0 59042.7 59052.7 9405.6 9851.1 10202.2 10232.1 10526.7 16945.6 18356.1 18686.2 18761.3 18863.2 6510.7 6531.9 6727.9 6730.7 6920.7 3233.8 3272.3 3327.7 3394.7 3435.1 2978.4 3089.7 3090.9 3098.3 3114.2 505.1 509.1 512.7 523.5 527.2 584.2 608.7 629.4 644.3 652.4 7486.2 8287.2 8292.8 8345.3 8346.0 527.5 549.9 580.0 603.6 619.4 3727.6 3752.8 3772.5 3809.5 3990.1 53793.0 54145.7 57597.4 73612.0 90779.5 35811.6 36396.0 37797.6 47876.8 48647.0 69508.7 73388.6 73569.3 74017.0 74953.6 7154.8 7253.7 7356.8 7371.3 7382.8 33901.5 43773.0 43815.3 43905.8 45642.5 59712.7 60917.4 61204.7 61410.0 61691.7 9499.1 9720.2 9771.9 10077.3 10290.8 10760.0 10812.7 10876.0 11120.3 11221.0 10152.6 10214.3 10279.3 10361.9 10629.1 9952.0 10016.0 10363.8 10453.4 10581.8 9242.3 9999.0 10035.3 10062.8 11198.6 9173.5 9333.3 9483.5 9490.7 9572.7 9610.9 9939.0 9967.7 10017.0 10040.8 19:23:04 INFO - PROCESS | 27196 | -------- Summary: end -------- 19:23:04 INFO - PROCESS | 27196 | 19:23:05 INFO - TEST-INFO | 27196: exit 0 19:23:05 INFO - TEST-OK | dromaeo_css | took 1116339ms 19:23:05 INFO - TEST-START | kraken 19:23:05 INFO - operating with platform_type : linux_ 19:23:05 INFO - Initialising browser for kraken test... 19:23:05 INFO - TEST-INFO | started process 27434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5l4KDt/profile http://localhost:37639/getInfo.html) 19:23:10 INFO - PROCESS | 27434 | __metrics Screen width/height:1600/1200 19:23:10 INFO - PROCESS | 27434 | colorDepth:24 19:23:10 INFO - PROCESS | 27434 | Browser inner width/height: 1024/697 19:23:10 INFO - PROCESS | 27434 | __metrics 19:23:11 ERROR - PROCESS | 27434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:23:12 INFO - TEST-INFO | 27434: exit 0 19:23:12 INFO - Browser initialized. 19:23:12 INFO - Running cycle 1/1 for kraken test... 19:23:12 INFO - TEST-INFO | started process 27553 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5l4KDt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:23:24 INFO - PROCESS | 27553 | RSS: Main: 168001536 19:23:24 INFO - PROCESS | 27553 | 19:23:26 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-beat-detection) 19:23:27 INFO - PROCESS | 27553 | RSS: Main: 173187072 19:23:27 INFO - PROCESS | 27553 | 19:23:30 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-dft) 19:23:31 INFO - PROCESS | 27553 | RSS: Main: 172756992 19:23:31 INFO - PROCESS | 27553 | 19:23:34 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-fft) 19:23:34 INFO - PROCESS | 27553 | RSS: Main: 167587840 19:23:34 INFO - PROCESS | 27553 | 19:23:36 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37639/tests/kraken/driver.html?testName=audio-oscillator) 19:23:37 INFO - PROCESS | 27553 | RSS: Main: 168247296 19:23:37 INFO - PROCESS | 27553 | 19:23:39 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37639/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:23:40 INFO - PROCESS | 27553 | RSS: Main: 168480768 19:23:40 INFO - PROCESS | 27553 | 19:23:43 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37639/tests/kraken/driver.html?testName=imaging-darkroom) 19:23:44 INFO - PROCESS | 27553 | RSS: Main: 168669184 19:23:44 INFO - PROCESS | 27553 | 19:23:47 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37639/tests/kraken/driver.html?testName=imaging-desaturate) 19:23:48 INFO - PROCESS | 27553 | RSS: Main: 166510592 19:23:48 INFO - PROCESS | 27553 | 19:23:51 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37639/tests/kraken/driver.html?testName=json-parse-financial) 19:23:52 INFO - PROCESS | 27553 | RSS: Main: 167559168 19:23:52 INFO - PROCESS | 27553 | 19:23:53 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37639/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:23:54 INFO - PROCESS | 27553 | RSS: Main: 167882752 19:23:54 INFO - PROCESS | 27553 | 19:23:56 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:23:56 INFO - PROCESS | 27553 | RSS: Main: 167981056 19:23:56 INFO - PROCESS | 27553 | 19:23:59 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:23:59 INFO - PROCESS | 27553 | RSS: Main: 168849408 19:23:59 INFO - PROCESS | 27553 | 19:24:02 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:24:03 INFO - PROCESS | 27553 | RSS: Main: 168620032 19:24:03 INFO - PROCESS | 27553 | 19:24:06 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:24:06 INFO - PROCESS | 27553 | RSS: Main: 168927232 19:24:06 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | Cycle 1(1): loaded http://localhost:37639/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37639/tests/kraken/driver.html?testName=ai-astar) 19:24:08 INFO - PROCESS | 27553 | RSS: Main: 169754624 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | __start_tp_report 19:24:08 INFO - PROCESS | 27553 | _x_x_mozilla_page_load 19:24:08 INFO - PROCESS | 27553 | _x_x_mozilla_page_load_details 19:24:08 INFO - PROCESS | 27553 | |i|pagename|runs| 19:24:08 INFO - PROCESS | 27553 | |0;ai-astar;116;111;119;115;115;116;115;117;117;114 19:24:08 INFO - PROCESS | 27553 | |1;audio-beat-detection;152;141;155;194;135;155;165;137;205;146 19:24:08 INFO - PROCESS | 27553 | |2;audio-dft;166;164;165;176;164;164;163;163;163;163 19:24:08 INFO - PROCESS | 27553 | |3;audio-fft;76;76;77;168;76;77;78;75;163;79 19:24:08 INFO - PROCESS | 27553 | |4;audio-oscillator;87;87;144;86;87;87;130;87;87;138 19:24:08 INFO - PROCESS | 27553 | |5;imaging-gaussian-blur;117;118;117;118;118;119;118;118;118;118 19:24:08 INFO - PROCESS | 27553 | |6;imaging-darkroom;148;148;149;147;148;148;148;147;148;148 19:24:08 INFO - PROCESS | 27553 | |7;imaging-desaturate;96;96;96;96;96;95;96;95;96;95 19:24:08 INFO - PROCESS | 27553 | |8;json-parse-financial;71;63;62;63;66;63;63;63;65;69 19:24:08 INFO - PROCESS | 27553 | |9;json-stringify-tinderbox;65;65;66;65;72;66;70;65;66;66 19:24:08 INFO - PROCESS | 27553 | |10;stanford-crypto-aes;84;85;84;86;87;85;86;85;108;84 19:24:08 INFO - PROCESS | 27553 | |11;stanford-crypto-ccm;137;144;147;136;138;137;149;132;146;138 19:24:08 INFO - PROCESS | 27553 | |12;stanford-crypto-pbkdf2;169;175;171;175;169;171;170;177;167;175 19:24:08 INFO - PROCESS | 27553 | |13;stanford-crypto-sha256-iterative;71;68;70;67;68;66;69;67;67;67 19:24:08 INFO - PROCESS | 27553 | __end_tp_report 19:24:08 INFO - PROCESS | 27553 | __start_cc_report 19:24:08 INFO - PROCESS | 27553 | _x_x_mozilla_cycle_collect,941 19:24:08 INFO - PROCESS | 27553 | __end_cc_report 19:24:08 INFO - PROCESS | 27553 | __startTimestamp1465352648818__endTimestamp 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | ------- Summary: start ------- 19:24:08 INFO - PROCESS | 27553 | Number of tests: 14 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:2.12 (1.8%) stddev-sans-first:2.24 19:24:08 INFO - PROCESS | 27553 | Values: 116.0 111.0 119.0 115.0 115.0 116.0 115.0 117.0 117.0 114.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#1] audio-beat-detection Cycles:10 Average:158.50 Median:155.00 stddev:23.59 (15.2%) stddev-sans-first:24.90 19:24:08 INFO - PROCESS | 27553 | Values: 152.0 141.0 155.0 194.0 135.0 155.0 165.0 137.0 205.0 146.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:3.96 (2.4%) stddev-sans-first:4.18 19:24:08 INFO - PROCESS | 27553 | Values: 166.0 164.0 165.0 176.0 164.0 164.0 163.0 163.0 163.0 163.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.50 stddev:37.46 (49.0%) stddev-sans-first:39.13 19:24:08 INFO - PROCESS | 27553 | Values: 76.0 76.0 77.0 168.0 76.0 77.0 78.0 75.0 163.0 79.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:87.00 stddev:24.61 (28.3%) stddev-sans-first:25.50 19:24:08 INFO - PROCESS | 27553 | Values: 87.0 87.0 144.0 86.0 87.0 87.0 130.0 87.0 87.0 138.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 19:24:08 INFO - PROCESS | 27553 | Values: 117.0 118.0 117.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 19:24:08 INFO - PROCESS | 27553 | Values: 148.0 148.0 149.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:24:08 INFO - PROCESS | 27553 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.00 stddev:3.01 (4.7%) stddev-sans-first:2.20 19:24:08 INFO - PROCESS | 27553 | Values: 71.0 63.0 62.0 63.0 66.0 63.0 63.0 63.0 65.0 69.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:66.00 stddev:2.41 (3.7%) stddev-sans-first:2.49 19:24:08 INFO - PROCESS | 27553 | Values: 65.0 65.0 66.0 65.0 72.0 66.0 70.0 65.0 66.0 66.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:85.00 stddev:7.31 (8.6%) stddev-sans-first:7.64 19:24:08 INFO - PROCESS | 27553 | Values: 84.0 85.0 84.0 86.0 87.0 85.0 86.0 85.0 108.0 84.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:141.00 stddev:5.64 (4.0%) stddev-sans-first:5.85 19:24:08 INFO - PROCESS | 27553 | Values: 137.0 144.0 147.0 136.0 138.0 137.0 149.0 132.0 146.0 138.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:173.00 stddev:3.35 (1.9%) stddev-sans-first:3.38 19:24:08 INFO - PROCESS | 27553 | Values: 169.0 175.0 171.0 175.0 169.0 171.0 170.0 177.0 167.0 175.0 19:24:08 INFO - PROCESS | 27553 | 19:24:08 INFO - PROCESS | 27553 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.56 (2.3%) stddev-sans-first:1.22 19:24:08 INFO - PROCESS | 27553 | Values: 71.0 68.0 70.0 67.0 68.0 66.0 69.0 67.0 67.0 67.0 19:24:08 INFO - PROCESS | 27553 | -------- Summary: end -------- 19:24:08 INFO - PROCESS | 27553 | 19:24:10 INFO - TEST-INFO | 27553: exit 0 19:24:10 INFO - TEST-OK | kraken | took 65027ms 19:24:10 INFO - SUITE-END | took 1181s 19:24:10 INFO - Completed test suite (00:19:41) 19:24:10 INFO - javascript benchmark 19:24:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6249.010218058702, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2632.736726327367, 2686.033028109881, 2689.8789554470045, 2695.2183866678665, 2700.8784604692787, 4710.387649605551, 4735.550122738343, 4764.3329933809255, 4831.830885918994, 4858.052679727454, 4683.718976861391, 4771.35586695796, 4777.307290442884, 4778.283257511375, 4787.473377928433, 4360.803763830635, 4385.144896745136, 4451.065276291983, 4487.820487180509, 4499.46006479223, 4187.602177793105, 4413.470383553962, 4432.468103827529, 4491.30384790358, 4492.775361231942, 4300.419443375135, 4380.802863871101, 4407.823687052514, 4411.1618792429335, 4474.082813023322, 4406.779661016968, 4415.2935530315, 4443.0, 4459.2865141577195, 4473.150101480708, 4446.377507149002, 4459.955400445986, 4477.597016268552, 4495.258282383403, 4504.1892459357305, 4601.447826260836, 4670.976645116787, 4679.649026323005, 4693.718376897397, 4695.765211739434, 5119.8208062717995, 5131.435542090367, 5145.742712864342, 5160.7419629018395, 5192.0, 5092.79628814847, 5143.588512918957, 5160.767765450526, 5164.974175129138, 5165.819196328148, 4802.831900883452, 4808.951910480885, 4813.302071199727, 4819.542143496362, 4854.757262136879, 5234.0, 5275.0, 5278.630495865329, 5279.551238144801, 5293.814716484904, 4935.333729946483, 4953.281774142729, 4966.180580204225, 5012.523810238022, 5023.447420783711, 4892.559669629751, 5080.74596270185, 5085.771140298695, 5109.591232701375, 5151.793928242828, 4856.1016212000895, 4920.286558449076, 4920.975395123073, 4921.704697718077, 4928.433230178503, 4908.950910490921, 4910.975445122752, 4911.7298548580175, 4916.459189489154, 4921.409430868247, 4201.789910504463, 4215.852445164404, 4224.978875105605, 4305.590968857953, 4341.522432532419, 3724.3110024645525, 3773.547174339042, 3789.8484060637265, 3831.5210598675167, 3844.7308688391545, 4452.154090722753, 4478.843240486633, 4501.279795232747, 4511.593956543927, 4549.545045495424, 5210.322658054504, 5212.270282160501, 5219.660722053054, 5222.060029194781, 5229.032628963654, 4310.4611923509565, 4499.910001799945, 4506.59440650343, 4511.436070491189, 4545.590896819236, 4526.683132180716, 4549.09018196362, 4574.565416285448, 4574.977125114419, 4586.977065114653, 4758.904821903542, 4792.7603619819565, 4796.712197268175, 4801.991581767728, 4857.392825896763, 4995.225740010304, 5107.0, 5108.182690769608, 5124.308218390619, 5136.743162841768, 4814.181589129927, 4852.150873597036, 4861.027794441196, 4868.196747536616, 4914.778834952507, 5031.290723774549, 5096.210087436453, 5097.0, 5104.719240441811, 5146.176611742103, 5097.515736005222, 5102.821401250939, 5128.076946149579, 5160.922586161286, 5168.715720635401, 4967.726775027409, 4970.900581988268, 4972.254161875748, 4987.675801072919, 4994.1759609663995, 4933.358663373739, 4937.9012419752125, 4955.306257123933, 4956.330895329229, 5036.269740887477, 4718.0799744050955, 4718.575328220477, 4824.638152138534, 4824.95175048245, 4837.032593481247, 4869.926951095666, 4882.267659851051, 4887.218045112765, 4902.117618828645, 4946.950530494649, 4832.154372984784, 4835.782389792397, 4837.395325584302, 4848.369711937426, 4886.560209581155], "value": 4683.4536276541085, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.1508419506, 575.3527281807966, 585.1632166002614, 586.5512882644776, 587.988240235195, 38879.416808747854, 40451.19097618053, 40476.96422768293, 40637.3904391434, 43751.56248437515, 39892.401613975744, 40731.79634101826, 40874.59125408745, 40957.38563921536, 41041.17917641645, 7629.160792312828, 7794.805129871742, 7815.374770018413, 7823.139454660011, 7828.9217107829045, 7662.195469475709, 7764.456488045839, 7774.028246469192, 7782.494137881048, 7801.531908085504, 7766.223377662245, 7831.765047048598, 7832.530048197098, 7839.412044096715, 7848.372130229596, 7703.8844417333785, 7749.992500974893, 7773.766786996399, 7788.1043679976965, 7807.609619519001, 7704.807379815494, 7769.145394006655, 7771.184025677336, 7792.4155688323035, 7798.337141342992, 34664.13339666528, 34959.82520087409, 35029.47455788165, 35070.123246918774, 35073.29853402918, 3070.7696922730884, 3183.065930690039, 3327.0, 3797.9620203797886, 3805.315043292206, 28085.578716319273, 28968.855155724297, 28984.27539311513, 29899.103026909226, 30020.849895750598, 3403.3533628610485, 3410.3179364127272, 3426.0, 3447.931041379158, 3501.0547152269, 179082.10458947753, 180617.0, 181040.0, 181266.09366953082, 181501.0, 31668.0, 50961.0, 51564.48435515672, 51609.0, 51652.48347516552, 31720.206994824854, 33492.0, 33729.0, 33795.0, 33838.49242261368, 13583.86416135826, 13623.59129226105, 13658.180509169482, 13679.589612311647, 13756.243406612732, 11332.093432525378, 11358.318500889807, 11377.089832813355, 11412.657620271406, 11432.94283528577, 7840.764777056697, 7901.288884000468, 7915.960420197862, 7931.286184243446, 7932.206779322021, 3064.1420402287395, 3115.3613509230554, 3156.936861262762, 3183.697548732867, 3206.4709322961917, 875.1205038935828, 899.3524662243175, 922.4834092907993, 944.4097439100562, 1051.81593221186, 27402.625951757662, 27496.312592185357, 27671.58492622612, 27895.860520697268, 28472.857635712102, 976.6972238606055, 985.8091187343495, 991.3853410885297, 999.7250756042147, 1009.6062535611118, 14681.706365872622, 14911.179885106207, 15024.474143404928, 15058.623534411727, 15261.465848695465, 121110.0, 122036.0, 122790.38604807097, 392877.0, 394372.0, 48691.0, 49090.26364604462, 49352.25971610429, 49353.0, 49391.25913111306, 1184.5202692909386, 1219.741970032044, 1226.564569577787, 1238.7832129377323, 1249.575144450891, 25495.6175657369, 26950.59574106351, 27223.72776272212, 27535.86232068827, 27582.724172758015, 41415.0, 41694.374584380654, 41755.373669395594, 41792.0, 41795.37306940337, 261548.0, 261580.0, 264483.0, 264668.0, 264932.0, 24720.50558988846, 24907.128250511145, 24953.0, 25034.123805666713, 25087.498250035263, 40183.1963360737, 40801.59198407978, 40980.38529422002, 41835.58164418317, 41889.0, 34504.48243276303, 35257.29485410329, 36078.8196059018, 36142.277154456235, 36496.81751591225, 35385.64614353926, 35530.11174720652, 35549.466757999166, 35664.0, 35843.28313433665, 34167.31665366729, 35885.1028724284, 36295.09262268359, 36324.0, 38336.233275333776, 30032.24919377033, 33043.66956330406, 33469.15512181394, 33536.0, 33553.32893342168, 24815.379615509035, 24995.375115622253, 25038.62442063334, 25364.365890852878, 25509.872450637627], "value": 16005.83652593734, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.5905385967716, 370.4295385106935, 372.54549449671407, 385.28145009557187, 389.5539607149814, 15751.291191896364, 15880.761788573167, 16803.0, 16940.830591694063, 16981.83018169818, 15577.610559735984, 15645.608859778511, 16503.91748041258, 16516.339346426157, 16550.83449165508, 4983.3272508211385, 5169.56058735008, 5195.038917800219, 5195.948040519603, 5197.454267301917, 4904.730239836807, 5134.25553294772, 5136.126858434075, 5183.274341592161, 5188.584913206953, 4968.056069346831, 4996.250562415648, 4999.075171093341, 5000.849974500771, 5025.120603894322, 4817.735024573647, 4950.925736113961, 4962.0820148272505, 4972.825951091712, 4974.552290293855, 4513.548645135493, 4563.703359281636, 4565.269556870885, 4571.3143028545655, 4590.242609969351, 18759.062046897736, 19188.424347269603, 19460.22159113634, 19834.80165198344, 19904.20383184671, 1783.9821601783947, 1894.4411398637435, 2024.8785072895673, 2046.2326627514683, 2196.4618668426338, 8527.914720852774, 8843.955780221122, 8998.235150012191, 9110.726678199664, 13001.349932503337, 1748.2220411916703, 1792.5249808800547, 1804.6751584714746, 1805.747195392646, 1835.7363287258063, 48176.27735583969, 59862.40137598612, 60406.697966509884, 62849.371506284806, 66328.3367166327, 9462.29032822541, 9547.570359333846, 9948.0, 10008.79982400348, 10127.949360253298, 13890.305484725723, 13930.0, 13965.720685586231, 13972.650683732785, 13984.230867302193, 7331.3768329692575, 7376.151742549569, 7514.47398682087, 7585.924140758632, 7607.16321204667, 6983.825404364931, 7014.754483593049, 7031.40233080194, 7050.894236586455, 7101.289871012961, 4314.439122914064, 4324.567543245713, 4362.454693163355, 4362.7715490536775, 4395.406620106309, 1838.7793464784045, 1900.6388786130867, 1905.7141428785792, 1913.0817207740363, 1918.673825449677, 761.1741260732057, 822.6010384963288, 869.9434536755091, 895.8880139982502, 978.7504186432557, 16171.919140404223, 16247.837521624633, 16504.17479126039, 16709.0, 16780.0, 856.2850020233175, 884.9823003539893, 895.2614093372994, 900.9279257659372, 949.264320151874, 6686.4985126115735, 9280.489573073546, 9362.578683959238, 9398.342116051948, 9448.527573621292, 374269.0, 420543.0, 421066.0, 421277.0, 425423.0, 67014.32985670178, 79076.20923790804, 86377.5681121603, 86943.56528217318, 87469.0, 914.3919293669635, 922.4834092907993, 935.5976929920336, 950.4344914775697, 951.6526467839188, 15089.773653395427, 15112.244387780347, 15113.31990060428, 15287.923560382127, 15743.842561574696, 32214.83892580522, 33564.32871342511, 35319.646803531636, 37092.0, 37101.814490927376, 50517.0, 50594.241086383, 51065.23402149045, 51248.23127653163, 51274.48725512697, 7431.5912624804, 7689.307962283421, 7769.0, 7803.687852485837, 7819.218078192363, 8548.0, 11089.778204436028, 12027.939860300643, 12030.218035827644, 12041.638750837488, 9929.801403971736, 10484.161267098461, 10669.8933010672, 10680.145588352758, 10717.089047431056, 10351.63769268072, 10383.325083869524, 10411.323263987817, 10476.68569942903, 10550.8417373741, 10767.300125491818, 10789.082927951213, 10796.89203107959, 10813.62152324665, 11173.106151507698, 7414.0, 7479.925200747923, 7520.398368130427, 7528.887066694114, 7932.682692692228, 10613.522391492246, 10628.84056739165, 10631.787364252517, 10723.19576031785, 10742.19433542503], "value": 8125.89828042136, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.3388671777393, 1350.3518311210619, 1402.4179965314395, 1674.3972170018799, 1691.086813120914, 6393.328700486451, 7316.963415182923, 7442.255774422555, 7833.764987050384, 7855.214478552149, 7486.401087912967, 7614.4669873108905, 7663.501872378291, 7684.53892766433, 7704.3451306639, 2121.151539384247, 2173.717416735822, 2174.717286752728, 2175.369142948543, 2180.465785882453, 2086.62440760663, 2130.084063852543, 2170.012644246872, 2172.6523756199012, 2172.945676358088, 2170.8914554272224, 2171.8055069711672, 2177.2053200581754, 2179.596774596697, 2197.3627647982066, 2114.587655407196, 2117.1531387444993, 2118.629239883014, 2118.671605901088, 2125.8405619578593, 2062.1442101527846, 2069.5240094778133, 2079.241077006897, 2082.875027498355, 2098.3495116513927, 7662.8084297893, 7687.423443241779, 7719.3052625264, 7728.6908523658985, 7754.030746156731, 4180.310248808943, 4287.48550173978, 4302.204092242945, 4303.784810759481, 4326.697131200817, 2780.9443811123665, 2860.4851126797166, 2870.1102658176032, 2870.3111253299267, 2906.7819913506573, 884.1379654836483, 896.9820603587891, 932.1051790281338, 939.1641439119189, 942.0202988891613, 9707.466089365082, 9782.902170978341, 9798.755031124208, 9829.115379615869, 9852.950735246279, 3992.960070399317, 4031.496062992126, 4119.237940980928, 4159.667226621863, 4164.271252530855, 8463.0, 8556.27271681914, 8571.357148213909, 8577.78555536104, 8590.484570925764, 4355.847545335898, 4411.602955733999, 4418.668599855024, 4530.0, 4585.28928016158, 3529.7705649133236, 3958.2083583283456, 4066.4916885389325, 4080.2043601498017, 4127.9587204128175, 3495.1611613213154, 3557.982210088933, 3637.799921004317, 3651.653092956165, 3735.551733791908, 1155.8439610652622, 1199.9280043197436, 1200.39980009995, 1212.2484059882752, 1214.732758793064, 768.8308572114126, 844.657913545003, 867.6702852915978, 875.2123089219754, 899.4243684042218, 5275.103232450492, 5404.081306177881, 5439.891202175934, 5463.453654634584, 5487.98472282629, 377.06675976956814, 380.3173303919416, 384.4521556781575, 384.45407521319794, 393.1645253835599, 3600.855965761393, 3654.3422184007136, 3704.608329387145, 3724.5158129443, 3748.11919198988, 8857.3799834011, 9417.058294170529, 9483.620655173854, 9487.810243795086, 9497.287703422133, 9220.124088211609, 9273.907260927304, 9317.11487408695, 9320.813583728423, 9395.765105872408, 7095.50331476802, 7171.282871712787, 7195.604241766753, 7223.89164162538, 7226.024486694334, 5063.291139240436, 5068.9239661405845, 5126.641135120506, 5296.0, 5317.707526086102, 8798.956005219932, 8821.382503224713, 8833.602487887933, 8844.425112367675, 8858.424202426822, 8732.912462096683, 8913.821723565623, 8965.462072275684, 9058.818823623622, 9066.863997040182, 5587.552995760248, 6203.658798766111, 6385.329540398191, 6459.257185423548, 6489.286178520453, 7207.891881621885, 7227.313405226495, 7265.09186351706, 7278.308560686726, 7283.380912622274, 6366.745330186741, 6448.613083215022, 6500.837479062872, 6647.5014373921185, 6726.73093076291, 6387.712552935036, 6394.520410969289, 6453.548251622341, 6512.92536731434, 6520.282768895323, 6072.301685306246, 6107.725152368065, 6142.723577438936, 6143.385661433821, 6154.661493617715, 4377.737335759864, 4487.865364039084, 4545.613622841963, 4632.837850675211, 4644.047970166041, 4480.462344518679, 4484.887877803081, 4513.390692256635, 4541.409616749801, 4561.064981678682], "value": 3962.7480202549737, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.8913612827125, 292.4735476142944, 294.27020987949885, 297.7632781938359, 301.6636450357852, 5007.699538027721, 5044.19292913134, 5052.545270925621, 5078.822241221558, 5105.5149760772665, 4968.180250258703, 5002.924956125652, 5029.497050294969, 5029.5221953914315, 5046.788770695034, 3707.610700876403, 3810.742454989847, 3933.704972127102, 3941.783201923893, 3949.1311911379594, 3912.726109172359, 3915.314819906519, 3930.76415415076, 3939.2121575684832, 3948.867611489792, 3925.8429662813455, 3944.349182384917, 3950.841966321358, 3961.7028722845757, 3977.880663580097, 3858.7491813032343, 3918.3534716771983, 3925.8625948091967, 3952.367621180612, 3957.6240257175523, 3438.0574975138966, 3454.844531996066, 3464.497647841049, 3467.2718729066673, 3496.73774466916, 4872.6832755870755, 4877.487863774323, 4882.145624515695, 4908.01839632075, 4928.310036594879, 4347.934780978288, 4529.320601909707, 4553.817847286105, 4564.360989461478, 4599.678022538424, 5272.499112584298, 5294.92057619136, 5301.946980530222, 5319.9202011969855, 5329.920051199235, 3805.1438426354125, 3809.8189561236104, 3819.854043786853, 3820.84716611338, 3825.1967086911504, 5311.176767601028, 5551.111822108443, 5556.388797232301, 5575.8884822303735, 5621.943780562183, 3880.0, 3882.5345905350305, 3882.902927426837, 3897.2010737798682, 3899.863504777319, 3941.3102707026155, 3942.211557688474, 3966.7619942803526, 3968.9603103969166, 3977.4033894915992, 4520.276755719069, 4520.304885667874, 4539.500654927955, 4549.158405694957, 4557.567031132037, 5234.18870075139, 5285.497877701612, 5322.3879253885525, 5343.70609616467, 5410.810621628303, 1365.3752035078226, 1382.260490637504, 1383.8823699985412, 1387.5708020738655, 1391.471240928461, 849.6006876767909, 869.604330029835, 882.9072947340437, 891.3582220801013, 892.8660601036647, 4567.1779079765965, 4626.86119416418, 4712.575868171881, 4714.222153344728, 4733.195356789354, 5467.660423196342, 5472.425395333433, 5476.452354764491, 5499.642523235977, 5536.695481748542, 4530.343100250511, 4692.061587682477, 4700.506446823103, 4719.339292499053, 4727.810887564528, 2885.249835042904, 2936.8091074080116, 2937.3537821679197, 2943.8969636062634, 2948.2334593005544, 5138.794448222104, 5157.174852023658, 5166.457521960216, 5169.948300517022, 5191.714455704897, 5386.245925570423, 5591.552675785927, 5594.608377413542, 5630.577706672016, 5689.715514224272, 5129.769160387791, 5129.820456284012, 5137.460566640449, 5143.1227601925775, 5164.767585458589, 5487.451254874481, 5494.1758736189895, 5495.2856128703015, 5516.751746171351, 5528.19841123043, 5147.562457191031, 5441.809536666197, 5476.561875049907, 5484.643498172606, 5505.146702261156, 5206.0, 5227.738613069255, 5237.685738855681, 5238.76425560843, 5255.290535777621, 3923.4311024900658, 3948.4669569607736, 3948.763074215556, 3954.723169378116, 3971.980140099281, 5427.375851777097, 5451.264079349237, 5499.340079190522, 5514.2004409359615, 5526.50261476469, 5314.316270283637, 5316.282301889196, 5316.405078476519, 5328.440513746001, 5329.760160792851, 5078.390593128848, 5254.448282930391, 5283.233931080049, 5305.787768489217, 5323.520883120537, 5123.666961647481, 5134.332536770196, 5138.766695993009, 5139.8715032123, 5165.870853228549, 5052.459000004887, 5219.243209734491, 5337.973310133424, 5367.731613419235, 5371.946280537145, 5221.399539053057, 5230.790768369223, 5233.869153271199, 5248.212768084818, 5259.684418934876], "value": 4000.5097368918005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.3697414357135, 581.9272590926134, 583.6352279825107, 587.3744462147812, 610.4536439886299, 12510.124291299613, 12922.676933076678, 12968.157069790468, 12973.286469244187, 13685.521006764766, 14257.287135643202, 14767.0, 14781.778273325908, 14785.852141478583, 14789.852101478982, 624.7532224771213, 794.5629903553023, 794.996025019877, 795.2087672765606, 796.4265728675344, 777.0946846923327, 809.9797505062392, 811.8254575266317, 814.775936617429, 815.7471183933, 835.8829763833069, 838.6310023589632, 839.4585492357456, 839.588601585225, 841.3479553346144, 829.6847198064727, 830.6220669595319, 832.305025303872, 833.2750507058868, 833.5873742497442, 606.8270542895298, 613.3284053960906, 613.7882430561449, 614.0666187395134, 615.0497481391217, 12891.613251602374, 13024.609261722164, 13026.088173827837, 13051.347432628425, 13091.279979601119, 12296.815547766791, 12693.701947974312, 12770.872291277154, 12804.935975320157, 13133.737325253442, 9466.242700583936, 9659.613615455373, 9677.37097088687, 9727.513624318826, 9827.803443931081, 3267.803931764102, 3341.816200108993, 3369.2756057447523, 3374.9325013499592, 3440.3807314683345, 57686.134707979414, 58098.70950645262, 58681.0, 59042.70478647622, 59052.704736476044, 9405.623775049058, 9851.113399794052, 10202.234832387601, 10232.079112879877, 10526.684199474028, 16945.576360590836, 18356.08219589015, 18686.197070439543, 18761.34335298258, 18863.24547018104, 6510.707018184193, 6531.934680653133, 6727.899081513781, 6730.697118629673, 6920.7231710731, 3233.805971641709, 3272.3291725196277, 3327.683870032343, 3394.6775056369606, 3435.0553597760318, 2978.4489869374233, 3089.7373723233327, 3090.9381812363627, 3098.3493466372315, 3114.174743692923, 505.06310793478303, 509.1065180608009, 512.6923845692554, 523.5105176659836, 527.2302438439845, 584.2171490203148, 608.7321578505444, 629.3549112159981, 644.2687549631203, 652.4323838260743, 7486.242549083971, 8287.171282871665, 8292.751217463485, 8345.290650294794, 8346.0, 527.5225920541916, 549.9092649712752, 579.9913001304984, 603.5563860562484, 619.4239357397663, 3727.6086010968456, 3752.81235938202, 3772.5098586058352, 3809.4857194278416, 3990.1221731219084, 53792.95882244247, 54145.72927135339, 57597.42402576005, 73612.0, 90779.54610226907, 35811.64188358135, 36396.0, 37797.62202377996, 47876.7606161967, 48647.0, 69508.6524567384, 73388.63305683545, 73569.26430735624, 74017.0, 74953.62523187349, 7154.785356439315, 7253.709851605877, 7356.816079597838, 7371.299726525972, 7382.815429614303, 33901.49147762835, 43773.0, 43815.34276985784, 43905.78047109744, 45642.543574565156, 59712.70143649254, 60917.39082609117, 61204.69397652983, 61410.0, 61691.69154154201, 9499.097585729345, 9720.222382209266, 9771.902280977383, 10077.294589378673, 10290.796442490437, 10760.0, 10812.729681758019, 10876.0, 11120.3327800329, 11221.046211072151, 10152.593896244067, 10214.285000049926, 10279.280450368702, 10361.948190259, 10629.149668026694, 9951.950240248752, 10016.0, 10363.844542332023, 10453.414348960107, 10581.788364232518, 9242.306826988137, 9998.950005249928, 10035.297529172887, 10062.849057264, 11198.552057917592, 9173.541322933694, 9333.25333973267, 9483.478408687588, 9490.667826626035, 9572.664956726481, 9610.903890961, 9938.950305248427, 9967.700968970943, 10017.0, 10040.849387259052], "value": 6165.875352121031, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 119.0, 115.0, 115.0, 116.0, 115.0, 117.0, 117.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 141.0, 155.0, 194.0, 135.0, 155.0, 165.0, 137.0, 205.0, 146.0], "value": 158.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 165.0, 176.0, 164.0, 164.0, 163.0, 163.0, 163.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 168.0, 76.0, 77.0, 78.0, 75.0, 163.0, 79.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 144.0, 86.0, 87.0, 87.0, 130.0, 87.0, 87.0, 138.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 62.0, 63.0, 66.0, 63.0, 63.0, 63.0, 65.0, 69.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 72.0, 66.0, 70.0, 65.0, 66.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 86.0, 87.0, 85.0, 86.0, 85.0, 108.0, 84.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 144.0, 147.0, 136.0, 138.0, 137.0, 149.0, 132.0, 146.0, 138.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 171.0, 175.0, 169.0, 171.0, 170.0, 177.0, 167.0, 175.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 67.0, 68.0, 66.0, 69.0, 67.0, 67.0, 67.0], "value": 68.0, "unit": "score"}]}]} 19:24:10 INFO - Return code: 0 19:24:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:24:10 ERROR - # TBPL SUCCESS # 19:24:10 INFO - Running post-action listener: _resource_record_post_action 19:24:10 INFO - ##### 19:24:10 INFO - ##### Finished run-tests step (success) 19:24:10 INFO - ##### 19:24:10 INFO - Running post-run listener: _resource_record_post_run 19:24:10 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534196224; Read time: 8; Write time: 560952 19:24:10 INFO - TinderboxPrint: CPU usage
13.4% 19:24:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:24:10 INFO - TinderboxPrint: I/O write bytes / time
534,196,224 / 560,952 19:24:10 INFO - TinderboxPrint: CPU idle
8,280.0 (86.5%) 19:24:10 INFO - TinderboxPrint: CPU user
1,229.7 (12.9%) 19:24:10 INFO - TinderboxPrint: Swap in / out
0 / 0 19:24:10 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243699712; Read time: 0; Write time: 283664 19:24:10 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290496512; Read time: 8; Write time: 277288 19:24:11 INFO - Running post-run listener: _upload_blobber_files 19:24:11 INFO - Blob upload gear active. 19:24:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:24:11 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 19:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:24:11 INFO - (blobuploader) - INFO - Open directory for files ... 19:24:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:24:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:24:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:16 INFO - (blobuploader) - INFO - Done attempting. 19:24:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:24:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:24:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:17 INFO - (blobuploader) - INFO - Done attempting. 19:24:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:24:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:24:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:24:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:24:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:24:18 INFO - (blobuploader) - INFO - Done attempting. 19:24:18 INFO - (blobuploader) - INFO - Iteration through files over. 19:24:18 INFO - Return code: 0 19:24:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:24:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:24:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac26ab7ea84fb376b6904b9246533312cece243a040aebd1fc6f8eef9aeede703bc40ded3f8228aae69163fe8c384f236b3fd674da9552016b8e42e06871a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8ee1b0e0a595ad0d8da59cea65dbcb5ac2abc5c20d13be79f3af8f144c8850400bdda4c70b5b8cf1495eec85296176a43c89d47da7375eb90eaa64e605342ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2d27d0f52803c03bd499055488e7e84a17af6d679a0e5eb7e593dab09aa1cc9eb56e74ea993d05f7cdc80bc010721b3bb14a0595690072f796e23fe9c3b186"} 19:24:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:24:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:24:18 INFO - Contents: 19:24:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac26ab7ea84fb376b6904b9246533312cece243a040aebd1fc6f8eef9aeede703bc40ded3f8228aae69163fe8c384f236b3fd674da9552016b8e42e06871a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8ee1b0e0a595ad0d8da59cea65dbcb5ac2abc5c20d13be79f3af8f144c8850400bdda4c70b5b8cf1495eec85296176a43c89d47da7375eb90eaa64e605342ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2d27d0f52803c03bd499055488e7e84a17af6d679a0e5eb7e593dab09aa1cc9eb56e74ea993d05f7cdc80bc010721b3bb14a0595690072f796e23fe9c3b186"} 19:24:18 INFO - Running post-run listener: copy_logs_to_upload_dir 19:24:18 INFO - Copying logs to upload dir... 19:24:18 INFO - mkdir: /builds/slave/test/build/upload/logs 19:24:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.046605 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 19:24:17.962207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 19:24:17.967673) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac26ab7ea84fb376b6904b9246533312cece243a040aebd1fc6f8eef9aeede703bc40ded3f8228aae69163fe8c384f236b3fd674da9552016b8e42e06871a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8ee1b0e0a595ad0d8da59cea65dbcb5ac2abc5c20d13be79f3af8f144c8850400bdda4c70b5b8cf1495eec85296176a43c89d47da7375eb90eaa64e605342ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2d27d0f52803c03bd499055488e7e84a17af6d679a0e5eb7e593dab09aa1cc9eb56e74ea993d05f7cdc80bc010721b3bb14a0595690072f796e23fe9c3b186"} build_url:https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/EFG4_-4dSVKqx7plXZYZIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/eac26ab7ea84fb376b6904b9246533312cece243a040aebd1fc6f8eef9aeede703bc40ded3f8228aae69163fe8c384f236b3fd674da9552016b8e42e06871a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b8ee1b0e0a595ad0d8da59cea65dbcb5ac2abc5c20d13be79f3af8f144c8850400bdda4c70b5b8cf1495eec85296176a43c89d47da7375eb90eaa64e605342ae", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d2d27d0f52803c03bd499055488e7e84a17af6d679a0e5eb7e593dab09aa1cc9eb56e74ea993d05f7cdc80bc010721b3bb14a0595690072f796e23fe9c3b186"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 19:24:17.992752) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 19:24:17.993078) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1465351409.902032-1997391702 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 19:24:18.046001) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 19:24:18.048347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 19:24:18.048660) ========= ========= Total master_lag: 0.34 =========