builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1465486830.93 results: success (0) buildid: 20160609073629 builduid: 2eddd392882f4e92b9c6f6c21bf94e57 revision: fae4bb6ae895ac8dd29da4242db79942c7f17ba1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:30.926238) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:30.926723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:30.927018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:30.941740) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:30.942100) ========= 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=232498196343f89f466a4a9a000001c8-1465486830.849345-806973890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 08:40:31-- 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% 21.3M=0.001s 2016-06-09 08:40:31 (21.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093493 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.049469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.049830) ========= 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=232498196343f89f466a4a9a000001c8-1465486830.849345-806973890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.099839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.100193) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fae4bb6ae895ac8dd29da4242db79942c7f17ba1 --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 fae4bb6ae895ac8dd29da4242db79942c7f17ba1 --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=232498196343f89f466a4a9a000001c8-1465486830.849345-806973890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 08:40:31,725 truncating revision to first 12 chars 2016-06-09 08:40:31,725 Setting DEBUG logging. 2016-06-09 08:40:31,725 attempt 1/10 2016-06-09 08:40:31,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fae4bb6ae895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 08:40:32,037 unpacking tar archive at: fx-team-fae4bb6ae895/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.764000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.764315) ========= script_repo_revision: fae4bb6ae895ac8dd29da4242db79942c7f17ba1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.764724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.764996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 08:40:31.773590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-09 08:40:31.773967) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=232498196343f89f466a4a9a000001c8-1465486830.849345-806973890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:32 INFO - MultiFileLogger online at 20160609 08:40:32 in /builds/slave/test 08:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 08:40:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:32 INFO - {'append_to_log': False, 08:40:32 INFO - 'base_work_dir': '/builds/slave/test', 08:40:32 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:32 INFO - 'branch': 'Fx-Team-Non-PGO', 08:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:32 INFO - 'config_files': ('talos/linux_config.py',), 08:40:32 INFO - 'default_actions': ('clobber', 08:40:32 INFO - 'read-buildbot-config', 08:40:32 INFO - 'download-and-extract', 08:40:32 INFO - 'populate-webroot', 08:40:32 INFO - 'create-virtualenv', 08:40:32 INFO - 'install', 08:40:32 INFO - 'run-tests'), 08:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:32 INFO - 'download_minidump_stackwalk': True, 08:40:32 INFO - 'download_symbols': 'ondemand', 08:40:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:32 INFO - 'installer_path': 'installer.exe', 08:40:32 INFO - 'log_level': 'info', 08:40:32 INFO - 'log_name': 'talos', 08:40:32 INFO - 'log_to_console': True, 08:40:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:32 INFO - 'opt_config_files': (), 08:40:32 INFO - 'pip_index': False, 08:40:32 INFO - 'sps_profile': False, 08:40:32 INFO - 'sps_profile_interval': 0, 08:40:32 INFO - 'suite': 'dromaeojs', 08:40:32 INFO - 'system_bits': '32', 08:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:32 INFO - 'title': 'talos-linux64-ix-025', 08:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:32 INFO - 'use_talos_json': True, 08:40:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:32 INFO - 'work_dir': 'build'} 08:40:32 INFO - ##### 08:40:32 INFO - ##### Running clobber step. 08:40:32 INFO - ##### 08:40:32 INFO - Running pre-action listener: _resource_record_pre_action 08:40:32 INFO - Running main action method: clobber 08:40:32 INFO - rmtree: /builds/slave/test/build 08:40:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:33 INFO - Running post-action listener: _resource_record_post_action 08:40:33 INFO - ##### 08:40:33 INFO - ##### Finished clobber step (success) 08:40:33 INFO - ##### 08:40:33 INFO - ##### 08:40:33 INFO - ##### Running read-buildbot-config step. 08:40:33 INFO - ##### 08:40:33 INFO - Running pre-action listener: _resource_record_pre_action 08:40:33 INFO - Running main action method: read_buildbot_config 08:40:33 INFO - Using buildbot properties: 08:40:33 INFO - { 08:40:33 INFO - "project": "", 08:40:33 INFO - "product": "firefox", 08:40:33 INFO - "script_repo_revision": "production", 08:40:33 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:40:33 INFO - "repository": "", 08:40:33 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:40:33 INFO - "buildid": "20160609073629", 08:40:33 INFO - "pgo_build": "False", 08:40:33 INFO - "basedir": "/builds/slave/test", 08:40:33 INFO - "buildnumber": 1836, 08:40:33 INFO - "slavename": "talos-linux64-ix-025", 08:40:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:40:33 INFO - "platform": "ubuntu64_hw", 08:40:33 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:40:33 INFO - "branch": "fx-team", 08:40:33 INFO - "repo_path": "integration/fx-team", 08:40:33 INFO - "revision": "fae4bb6ae895ac8dd29da4242db79942c7f17ba1", 08:40:33 INFO - "stage_platform": "linux64", 08:40:33 INFO - "builduid": "2eddd392882f4e92b9c6f6c21bf94e57", 08:40:33 INFO - "slavebuilddir": "test" 08:40:33 INFO - } 08:40:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:40:33 INFO - Running post-action listener: _resource_record_post_action 08:40:33 INFO - ##### 08:40:33 INFO - ##### Finished read-buildbot-config step (success) 08:40:33 INFO - ##### 08:40:33 INFO - ##### 08:40:33 INFO - ##### Running download-and-extract step. 08:40:33 INFO - ##### 08:40:33 INFO - Running pre-action listener: _resource_record_pre_action 08:40:33 INFO - Running main action method: download_and_extract 08:40:33 INFO - mkdir: /builds/slave/test/build/tests 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:40:33 INFO - https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:34 INFO - Downloaded 1361 bytes. 08:40:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:40:34 INFO - Using the following test package requirements: 08:40:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:40:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:40:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'jsshell-linux-x86_64.zip'], 08:40:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:40:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:40:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:40:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:40:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:40:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:40:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:40:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:40:34 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')]} 08:40:34 INFO - https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:38 INFO - Downloaded 22879604 bytes. 08:40:38 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'] 08:40:38 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 08:40:39 INFO - Return code: 0 08:40:39 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 08:40:39 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')]} 08:40:39 INFO - https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:41 INFO - Downloaded 22879604 bytes. 08:40: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'] 08:40: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 08:40:42 INFO - Return code: 0 08:40:42 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')]} 08:40:42 INFO - https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:44 INFO - Downloaded 10833377 bytes. 08:40: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'] 08:40: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 08:40:44 INFO - Return code: 0 08:40: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')]} 08:40:44 INFO - https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:40:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BB17g3F7TNSdm9dHM7T7BA/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 08:40:45 INFO - Downloaded 55364777 bytes. 08:40:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:45 INFO - mkdir: /builds/slave/test/properties 08:40:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:45 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:45 INFO - Contents: 08:40:45 INFO - build_url:https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:40:46 INFO - Running post-action listener: _resource_record_post_action 08:40:46 INFO - Running post-action listener: set_extra_try_arguments 08:40:46 INFO - ##### 08:40:46 INFO - ##### Finished download-and-extract step (success) 08:40:46 INFO - ##### 08:40:46 INFO - ##### 08:40:46 INFO - ##### Running populate-webroot step. 08:40:46 INFO - ##### 08:40:46 INFO - Running pre-action listener: _resource_record_pre_action 08:40:46 INFO - Running main action method: populate_webroot 08:40:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:46 INFO - '--tppagecycles', 08:40:46 INFO - '7'], 08:40:46 INFO - 'tests': ['tsvgm']}}, 08:40:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['damp', 'tps']}, 08:40:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'tests': ['damp', 'tps']}, 08:40:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['dromaeo_dom']}, 08:40:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['a11yr', 08:40:46 INFO - 'ts_paint', 08:40:46 INFO - 'tpaint', 08:40:46 INFO - 'sessionrestore', 08:40:46 INFO - 'sessionrestore_no_auto_restore', 08:40:46 INFO - 'tabpaint']}, 08:40:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:46 INFO - 'ts_paint', 08:40:46 INFO - 'tpaint', 08:40:46 INFO - 'sessionrestore', 08:40:46 INFO - 'sessionrestore_no_auto_restore', 08:40:46 INFO - 'tabpaint']}, 08:40:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:46 INFO - 'ts_paint', 08:40:46 INFO - 'tpaint', 08:40:46 INFO - 'sessionrestore', 08:40:46 INFO - 'sessionrestore_no_auto_restore', 08:40:46 INFO - 'tabpaint']}, 08:40:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:46 INFO - 'ts_paint', 08:40:46 INFO - 'tpaint', 08:40:46 INFO - 'sessionrestore', 08:40:46 INFO - 'sessionrestore_no_auto_restore', 08:40:46 INFO - 'tabpaint']}, 08:40:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['a11yr', 08:40:46 INFO - 'ts_paint', 08:40:46 INFO - 'tpaint', 08:40:46 INFO - 'sessionrestore', 08:40:46 INFO - 'sessionrestore_no_auto_restore', 08:40:46 INFO - 'tabpaint']}, 08:40:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['a11yr', 08:40:46 INFO - 'ts_paint', 08:40:46 INFO - 'tpaint', 08:40:46 INFO - 'sessionrestore', 08:40:46 INFO - 'sessionrestore_no_auto_restore', 08:40:46 INFO - 'tabpaint']}, 08:40:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['tsvgx', 08:40:46 INFO - 'tsvgr_opacity', 08:40:46 INFO - 'tart', 08:40:46 INFO - 'tscrollx', 08:40:46 INFO - 'cart']}, 08:40:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:46 INFO - 'tsvgr_opacity', 08:40:46 INFO - 'tart', 08:40:46 INFO - 'tscrollx', 08:40:46 INFO - 'cart']}, 08:40:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'talos_options': ['--disable-e10s'], 08:40:46 INFO - 'tests': ['tp5o']}, 08:40:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'tests': ['tp5o']}, 08:40:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'talos_options': ['--disable-e10s', 08:40:46 INFO - '--xperf_path', 08:40:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:46 INFO - 'tests': ['tp5n']}, 08:40:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:46 INFO - 'talos_options': ['--xperf_path', 08:40:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:46 INFO - 'tests': ['tp5n']}}, 08:40:46 INFO - 'talos.zip': {'path': '', 08:40:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:46 INFO - Running post-action listener: _resource_record_post_action 08:40:46 INFO - ##### 08:40:46 INFO - ##### Finished populate-webroot step (success) 08:40:46 INFO - ##### 08:40:46 INFO - ##### 08:40:46 INFO - ##### Running create-virtualenv step. 08:40:46 INFO - ##### 08:40:46 INFO - Running pre-action listener: _resource_record_pre_action 08:40:46 INFO - Running main action method: create_virtualenv 08:40:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40: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 08:40:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:46 INFO - Using real prefix '/usr' 08:40:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:49 INFO - Installing pip.................done. 08:40:49 INFO - Return code: 0 08:40:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:40: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 08:40: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 08:40:49 INFO - Using env: {'DISPLAY': ':0', 08:40:49 INFO - 'HOME': '/home/cltbld', 08:40:49 INFO - 'LANG': 'en_US.UTF-8', 08:40:49 INFO - 'LANGUAGE': 'en_US:en', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MAIL': '/var/mail/cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SHLVL': '1', 08:40:49 INFO - 'TERM': 'linux', 08:40:49 INFO - 'TMOUT': '86400', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - '_': '/tools/buildbot/bin/python'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40: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 08:40:49 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:40: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 08:40: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 08:40:49 INFO - Using env: {'DISPLAY': ':0', 08:40:49 INFO - 'HOME': '/home/cltbld', 08:40:49 INFO - 'LANG': 'en_US.UTF-8', 08:40:49 INFO - 'LANGUAGE': 'en_US:en', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MAIL': '/var/mail/cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SHLVL': '1', 08:40:49 INFO - 'TERM': 'linux', 08:40:49 INFO - 'TMOUT': '86400', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - '_': '/tools/buildbot/bin/python'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Downloading/unpacking psutil>=3.1.1 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:51 INFO - Installing collected packages: psutil 08:40:51 INFO - Running setup.py install for psutil 08:40:51 INFO - building 'psutil._psutil_linux' extension 08:40: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 08:40: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 08:40:51 INFO - building 'psutil._psutil_posix' extension 08:40: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 08:40: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:40:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:51 INFO - Successfully installed psutil 08:40:51 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:40: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 08:40: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 08:40:52 INFO - Using env: {'DISPLAY': ':0', 08:40:52 INFO - 'HOME': '/home/cltbld', 08:40:52 INFO - 'LANG': 'en_US.UTF-8', 08:40:52 INFO - 'LANGUAGE': 'en_US:en', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MAIL': '/var/mail/cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SHLVL': '1', 08:40:52 INFO - 'TERM': 'linux', 08:40:52 INFO - 'TMOUT': '86400', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - '_': '/tools/buildbot/bin/python'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:54 INFO - Installing collected packages: mozsystemmonitor 08:40:54 INFO - Running setup.py install for mozsystemmonitor 08:40:54 INFO - Successfully installed mozsystemmonitor 08:40:54 INFO - Cleaning up... 08:40:54 INFO - Return code: 0 08:40:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:40: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 08:40: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 08:40:54 INFO - Using env: {'DISPLAY': ':0', 08:40:54 INFO - 'HOME': '/home/cltbld', 08:40:54 INFO - 'LANG': 'en_US.UTF-8', 08:40:54 INFO - 'LANGUAGE': 'en_US:en', 08:40:54 INFO - 'LOGNAME': 'cltbld', 08:40:54 INFO - 'MAIL': '/var/mail/cltbld', 08:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:54 INFO - 'MOZ_NO_REMOTE': '1', 08:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:54 INFO - 'NO_EM_RESTART': '1', 08:40:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:54 INFO - 'PWD': '/builds/slave/test', 08:40:54 INFO - 'SHELL': '/bin/bash', 08:40:54 INFO - 'SHLVL': '1', 08:40:54 INFO - 'TERM': 'linux', 08:40:54 INFO - 'TMOUT': '86400', 08:40:54 INFO - 'USER': 'cltbld', 08:40:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:54 INFO - '_': '/tools/buildbot/bin/python'} 08:40:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:54 INFO - Downloading/unpacking jsonschema==2.5.1 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:56 INFO - warning: no files found matching '*.txt' 08:40:56 INFO - no previously-included directories found matching 'build' 08:40:56 INFO - no previously-included directories found matching 'dist' 08:40:56 INFO - no previously-included directories found matching '.git*' 08:40:56 INFO - Installing collected packages: jsonschema, functools32 08:40:57 INFO - Running setup.py install for functools32 08:40:57 INFO - warning: no files found matching '*.txt' 08:40:57 INFO - no previously-included directories found matching 'build' 08:40:57 INFO - no previously-included directories found matching 'dist' 08:40:57 INFO - no previously-included directories found matching '.git*' 08:40:57 INFO - Successfully installed jsonschema functools32 08:40:57 INFO - Cleaning up... 08:40:57 INFO - Return code: 0 08:40:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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')]} 08:40:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:40: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 08:40: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 08:40:57 INFO - Using env: {'DISPLAY': ':0', 08:40:57 INFO - 'HOME': '/home/cltbld', 08:40:57 INFO - 'LANG': 'en_US.UTF-8', 08:40:57 INFO - 'LANGUAGE': 'en_US:en', 08:40:57 INFO - 'LOGNAME': 'cltbld', 08:40:57 INFO - 'MAIL': '/var/mail/cltbld', 08:40:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:57 INFO - 'MOZ_NO_REMOTE': '1', 08:40:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:57 INFO - 'NO_EM_RESTART': '1', 08:40:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:57 INFO - 'PWD': '/builds/slave/test', 08:40:57 INFO - 'SHELL': '/bin/bash', 08:40:57 INFO - 'SHLVL': '1', 08:40:57 INFO - 'TERM': 'linux', 08:40:57 INFO - 'TMOUT': '86400', 08:40:57 INFO - 'USER': 'cltbld', 08:40:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:40:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:57 INFO - '_': '/tools/buildbot/bin/python'} 08:40:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:59 INFO - Downloading docopt-0.6.1.tar.gz 08:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:00 INFO - Running setup.py install for blobuploader 08:41:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:00 INFO - Running setup.py install for requests 08:41:00 INFO - Running setup.py install for docopt 08:41:00 INFO - Successfully installed blobuploader requests docopt 08:41:00 INFO - Cleaning up... 08:41:00 INFO - Return code: 0 08:41:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:41: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 08:41: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 08:41:00 INFO - Using env: {'DISPLAY': ':0', 08:41:00 INFO - 'HOME': '/home/cltbld', 08:41:00 INFO - 'LANG': 'en_US.UTF-8', 08:41:00 INFO - 'LANGUAGE': 'en_US:en', 08:41:00 INFO - 'LOGNAME': 'cltbld', 08:41:00 INFO - 'MAIL': '/var/mail/cltbld', 08:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:00 INFO - 'MOZ_NO_REMOTE': '1', 08:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:00 INFO - 'NO_EM_RESTART': '1', 08:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:00 INFO - 'PWD': '/builds/slave/test', 08:41:00 INFO - 'SHELL': '/bin/bash', 08:41:00 INFO - 'SHLVL': '1', 08:41:00 INFO - 'TERM': 'linux', 08:41:00 INFO - 'TMOUT': '86400', 08:41:00 INFO - 'USER': 'cltbld', 08:41:00 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:00 INFO - '_': '/tools/buildbot/bin/python'} 08:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:00 INFO - Running setup.py (path:/tmp/pip-6EpWgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:00 INFO - Running setup.py (path:/tmp/pip-NYS4ER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:00 INFO - Running setup.py (path:/tmp/pip-2FteBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:01 INFO - Running setup.py (path:/tmp/pip-rgthHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:01 INFO - Running setup.py (path:/tmp/pip-uTzoyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:01 INFO - Running setup.py (path:/tmp/pip-qKRgy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:01 INFO - Running setup.py (path:/tmp/pip-FjcO7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:01 INFO - Running setup.py (path:/tmp/pip-RUPTJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:01 INFO - Running setup.py (path:/tmp/pip-2MictT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:01 INFO - Running setup.py (path:/tmp/pip-Yfod3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:01 INFO - Running setup.py (path:/tmp/pip-4KEdRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:01 INFO - Running setup.py (path:/tmp/pip-Gcz4qK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:01 INFO - Running setup.py (path:/tmp/pip-e8Ivod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:01 INFO - Running setup.py (path:/tmp/pip-RF5hBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:01 INFO - Running setup.py (path:/tmp/pip-wZsOgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:01 INFO - Running setup.py (path:/tmp/pip-adAS8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:01 INFO - Running setup.py (path:/tmp/pip-qAraYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:02 INFO - Running setup.py install for manifestparser 08:41:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Running setup.py install for mozcrash 08:41:02 INFO - Running setup.py install for mozdebug 08:41:02 INFO - Running setup.py install for mozdevice 08:41:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Running setup.py install for mozfile 08:41:02 INFO - Running setup.py install for mozhttpd 08:41:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Running setup.py install for mozinfo 08:41:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Running setup.py install for mozInstall 08:41:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:02 INFO - Running setup.py install for mozleak 08:41:02 INFO - Running setup.py install for mozlog 08:41:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Running setup.py install for moznetwork 08:41:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Running setup.py install for mozprocess 08:41:03 INFO - Running setup.py install for mozprofile 08:41:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Running setup.py install for mozrunner 08:41:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Running setup.py install for mozscreenshot 08:41:03 INFO - Running setup.py install for moztest 08:41:03 INFO - Running setup.py install for mozversion 08:41:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:03 INFO - Cleaning up... 08:41:03 INFO - Return code: 0 08:41:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:41: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 08:41: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 08:41:03 INFO - Using env: {'DISPLAY': ':0', 08:41:03 INFO - 'HOME': '/home/cltbld', 08:41:03 INFO - 'LANG': 'en_US.UTF-8', 08:41:03 INFO - 'LANGUAGE': 'en_US:en', 08:41:03 INFO - 'LOGNAME': 'cltbld', 08:41:03 INFO - 'MAIL': '/var/mail/cltbld', 08:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:03 INFO - 'MOZ_NO_REMOTE': '1', 08:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:03 INFO - 'NO_EM_RESTART': '1', 08:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:03 INFO - 'PWD': '/builds/slave/test', 08:41:03 INFO - 'SHELL': '/bin/bash', 08:41:03 INFO - 'SHLVL': '1', 08:41:03 INFO - 'TERM': 'linux', 08:41:03 INFO - 'TMOUT': '86400', 08:41:03 INFO - 'USER': 'cltbld', 08:41:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:03 INFO - '_': '/tools/buildbot/bin/python'} 08:41:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:04 INFO - Running setup.py (path:/tmp/pip-fWimhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:04 INFO - Running setup.py (path:/tmp/pip-syt0AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:04 INFO - Running setup.py (path:/tmp/pip-hw_zeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:04 INFO - Running setup.py (path:/tmp/pip-Cp_gWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:04 INFO - Running setup.py (path:/tmp/pip-K6UPye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:04 INFO - Running setup.py (path:/tmp/pip-lBoRlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:04 INFO - Running setup.py (path:/tmp/pip-_avlTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:04 INFO - Running setup.py (path:/tmp/pip-6NK3Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:04 INFO - Running setup.py (path:/tmp/pip-yULATb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:04 INFO - Running setup.py (path:/tmp/pip-ghFL7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:04 INFO - Running setup.py (path:/tmp/pip-LjfzBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41: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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:04 INFO - Running setup.py (path:/tmp/pip-PHLfuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:04 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)) 08:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:04 INFO - Running setup.py (path:/tmp/pip-4mgK5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41: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)) 08:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:05 INFO - Running setup.py (path:/tmp/pip-Aqm2XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41: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)) 08:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:05 INFO - Running setup.py (path:/tmp/pip-b5UYNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41: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)) 08:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:05 INFO - Running setup.py (path:/tmp/pip-vC17vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41: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)) 08:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:05 INFO - Running setup.py (path:/tmp/pip-jn6IQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:07 INFO - Downloading blessings-1.6.tar.gz 08:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:07 INFO - Installing collected packages: blessings 08:41:07 INFO - Running setup.py install for blessings 08:41:07 INFO - Successfully installed blessings 08:41:07 INFO - Cleaning up... 08:41:07 INFO - Return code: 0 08:41:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:07 INFO - Reading from file tmpfile_stdout 08:41:07 INFO - Current package versions: 08:41:07 INFO - argparse == 1.2.1 08:41:07 INFO - blessings == 1.6 08:41:07 INFO - blobuploader == 1.2.4 08:41:07 INFO - docopt == 0.6.1 08:41:07 INFO - functools32 == 3.2.3-2 08:41:07 INFO - jsonschema == 2.5.1 08:41:07 INFO - manifestparser == 1.1 08:41:07 INFO - mozInstall == 1.12 08:41:07 INFO - mozcrash == 0.17 08:41:07 INFO - mozdebug == 0.1 08:41:07 INFO - mozdevice == 0.48 08:41:07 INFO - mozfile == 1.2 08:41:07 INFO - mozhttpd == 0.7 08:41:07 INFO - mozinfo == 0.9 08:41:07 INFO - mozleak == 0.1 08:41:07 INFO - mozlog == 3.2 08:41:07 INFO - moznetwork == 0.27 08:41:07 INFO - mozprocess == 0.22 08:41:07 INFO - mozprofile == 0.28 08:41:07 INFO - mozrunner == 6.11 08:41:07 INFO - mozscreenshot == 0.1 08:41:07 INFO - mozsystemmonitor == 0.3 08:41:07 INFO - moztest == 0.7 08:41:07 INFO - mozversion == 1.4 08:41:07 INFO - psutil == 3.1.1 08:41:07 INFO - requests == 1.2.3 08:41:07 INFO - wsgiref == 0.1.2 08:41:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:41: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 08:41: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 08:41:07 INFO - Using env: {'DISPLAY': ':0', 08:41:07 INFO - 'HOME': '/home/cltbld', 08:41:07 INFO - 'LANG': 'en_US.UTF-8', 08:41:07 INFO - 'LANGUAGE': 'en_US:en', 08:41:07 INFO - 'LOGNAME': 'cltbld', 08:41:07 INFO - 'MAIL': '/var/mail/cltbld', 08:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:07 INFO - 'MOZ_NO_REMOTE': '1', 08:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:07 INFO - 'NO_EM_RESTART': '1', 08:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:07 INFO - 'PWD': '/builds/slave/test', 08:41:07 INFO - 'SHELL': '/bin/bash', 08:41:07 INFO - 'SHLVL': '1', 08:41:07 INFO - 'TERM': 'linux', 08:41:07 INFO - 'TMOUT': '86400', 08:41:07 INFO - 'USER': 'cltbld', 08:41:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:07 INFO - '_': '/tools/buildbot/bin/python'} 08:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41: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)) 08:41:07 INFO - Cleaning up... 08:41:07 INFO - Return code: 0 08:41:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:41: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 08:41: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 08:41:07 INFO - Using env: {'DISPLAY': ':0', 08:41:07 INFO - 'HOME': '/home/cltbld', 08:41:07 INFO - 'LANG': 'en_US.UTF-8', 08:41:07 INFO - 'LANGUAGE': 'en_US:en', 08:41:07 INFO - 'LOGNAME': 'cltbld', 08:41:07 INFO - 'MAIL': '/var/mail/cltbld', 08:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:07 INFO - 'MOZ_NO_REMOTE': '1', 08:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:07 INFO - 'NO_EM_RESTART': '1', 08:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:07 INFO - 'PWD': '/builds/slave/test', 08:41:07 INFO - 'SHELL': '/bin/bash', 08:41:07 INFO - 'SHLVL': '1', 08:41:07 INFO - 'TERM': 'linux', 08:41:07 INFO - 'TMOUT': '86400', 08:41:07 INFO - 'USER': 'cltbld', 08:41:07 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:07 INFO - '_': '/tools/buildbot/bin/python'} 08:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:08 INFO - Cleaning up... 08:41:08 INFO - Return code: 0 08:41:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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 0x7f5f6b353f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xeb38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf7e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, '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': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', '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 08:41: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 08:41: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 08:41:08 INFO - Using env: {'DISPLAY': ':0', 08:41:08 INFO - 'HOME': '/home/cltbld', 08:41:08 INFO - 'LANG': 'en_US.UTF-8', 08:41:08 INFO - 'LANGUAGE': 'en_US:en', 08:41:08 INFO - 'LOGNAME': 'cltbld', 08:41:08 INFO - 'MAIL': '/var/mail/cltbld', 08:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:08 INFO - 'MOZ_NO_REMOTE': '1', 08:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:08 INFO - 'NO_EM_RESTART': '1', 08:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:08 INFO - 'PWD': '/builds/slave/test', 08:41:08 INFO - 'SHELL': '/bin/bash', 08:41:08 INFO - 'SHLVL': '1', 08:41:08 INFO - 'TERM': 'linux', 08:41:08 INFO - 'TMOUT': '86400', 08:41:08 INFO - 'USER': 'cltbld', 08:41:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:08 INFO - '_': '/tools/buildbot/bin/python'} 08:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:08 INFO - Downloading/unpacking flake8 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:41:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:41:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:41:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:10 INFO - no previously-included directories found matching 'docs/_build' 08:41:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:41:11 INFO - Running setup.py install for pep8 08:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:11 INFO - no previously-included directories found matching 'docs/_build' 08:41:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:41:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:41:11 INFO - Cleaning up... 08:41:11 INFO - Return code: 0 08:41:11 INFO - Running post-action listener: _resource_record_post_action 08:41:11 INFO - Running post-action listener: _start_resource_monitoring 08:41:11 INFO - Starting resource monitoring. 08:41:11 INFO - ##### 08:41:11 INFO - ##### Finished create-virtualenv step (success) 08:41:11 INFO - ##### 08:41:11 INFO - ##### 08:41:11 INFO - ##### Running install step. 08:41:11 INFO - ##### 08:41:11 INFO - Running pre-action listener: _resource_record_pre_action 08:41:11 INFO - Running main action method: install 08:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:11 INFO - Reading from file tmpfile_stdout 08:41:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:11 INFO - Reading from file tmpfile_stdout 08:41:11 INFO - Output received: 08:41:11 INFO - Usage: mozinstall [options] installer 08:41:11 INFO - Options: 08:41:11 INFO - -h, --help show this help message and exit 08:41:11 INFO - -d DEST, --destination=DEST 08:41:11 INFO - Directory to install application into. [default: 08:41:11 INFO - "/builds/slave/test"] 08:41:11 INFO - --app=APP Application being installed. [default: firefox] 08:41:11 INFO - mkdir: /builds/slave/test/build/application 08:41: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'] 08:41: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 08:41:27 INFO - Reading from file tmpfile_stdout 08:41:27 INFO - Output received: 08:41:27 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:27 INFO - Running post-action listener: _resource_record_post_action 08:41:27 INFO - ##### 08:41:27 INFO - ##### Finished install step (success) 08:41:27 INFO - ##### 08:41:27 INFO - ##### 08:41:27 INFO - ##### Running run-tests step. 08:41:27 INFO - ##### 08:41:27 INFO - Running pre-action listener: _resource_record_pre_action 08:41:27 INFO - Running main action method: run_tests 08:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:27 INFO - Python 2.7.3 08:41:27 INFO - Return code: 0 08:41:27 INFO - grabbing minidump binary from tooltool 08:41: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')]} 08:41: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 0x100d1c0>, '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 0x100e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41: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 08:41: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 08:41: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 08:41:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:27 INFO - Return code: 0 08:41:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:41:28 INFO - Return code: 0 08:41: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41: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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:28 INFO - Using env: {'DISPLAY': ':0', 08:41:28 INFO - 'HOME': '/home/cltbld', 08:41:28 INFO - 'LANG': 'en_US.UTF-8', 08:41:28 INFO - 'LANGUAGE': 'en_US:en', 08:41:28 INFO - 'LOGNAME': 'cltbld', 08:41:28 INFO - 'MAIL': '/var/mail/cltbld', 08:41:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:28 INFO - 'MOZ_NO_REMOTE': '1', 08:41:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:28 INFO - 'NO_EM_RESTART': '1', 08:41:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:28 INFO - 'PWD': '/builds/slave/test', 08:41:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:28 INFO - 'SHELL': '/bin/bash', 08:41:28 INFO - 'SHLVL': '1', 08:41:28 INFO - 'TERM': 'linux', 08:41:28 INFO - 'TMOUT': '86400', 08:41:28 INFO - 'USER': 'cltbld', 08:41:28 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465486830.849345-806973890', 08:41:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:28 INFO - '_': '/tools/buildbot/bin/python'} 08:41: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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:28 INFO - mozversion application_buildid: 20160609073629 08:41:28 INFO - mozversion application_changeset: fae4bb6ae895ac8dd29da4242db79942c7f17ba1 08:41:28 INFO - mozversion application_display_name: Nightly 08:41:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:28 INFO - mozversion application_name: Firefox 08:41:28 INFO - mozversion application_remotingname: firefox 08:41:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:41:28 INFO - mozversion application_vendor: Mozilla 08:41:28 INFO - mozversion application_version: 50.0a1 08:41:28 INFO - mozversion platform_buildid: 20160609073629 08:41:28 INFO - mozversion platform_changeset: fae4bb6ae895ac8dd29da4242db79942c7f17ba1 08:41:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:41:28 INFO - mozversion platform_version: 50.0a1 08:41:28 INFO - using testdate: 1465486888 08:41:28 INFO - actual date: 1465486888 08:41:28 INFO - starting webserver on 'localhost:56703' 08:41:28 INFO - SUITE-START | Running 2 tests 08:41:28 INFO - TEST-START | dromaeo_css 08:41:28 INFO - operating with platform_type : linux_ 08:41:28 INFO - Initialising browser for dromaeo_css test... 08:41:28 INFO - TEST-INFO | started process 6495 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp77dTqW/profile http://localhost:56703/getInfo.html) 08:41:33 INFO - PROCESS | 6495 | __metrics Screen width/height:1600/1200 08:41:33 INFO - PROCESS | 6495 | colorDepth:24 08:41:33 INFO - PROCESS | 6495 | Browser inner width/height: 1024/697 08:41:33 INFO - PROCESS | 6495 | __metrics 08:41:34 ERROR - PROCESS | 6495 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:41:34 INFO - PROCESS | 6495 | console.error: PushService: 08:41:34 INFO - PROCESS | 6495 | stateChangeProcessEnqueue: Error transitioning state 08:41:34 INFO - PROCESS | 6495 | UnknownError 08:41:35 INFO - TEST-INFO | 6495: exit 0 08:41:35 INFO - Browser initialized. 08:41:35 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:35 INFO - TEST-INFO | started process 6578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp77dTqW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:47 INFO - PROCESS | 6578 | RSS: Main: 178794496 08:41:47 INFO - PROCESS | 6578 | 08:42:38 INFO - PROCESS | 6578 | 1465486958617 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] 08:44:50 INFO - PROCESS | 6578 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56703/tests/dromaeo/cssquery-ext.html) 08:44:51 INFO - PROCESS | 6578 | RSS: Main: 278659072 08:44:51 INFO - PROCESS | 6578 | 08:47:54 INFO - PROCESS | 6578 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-ext.html (next: http://localhost:56703/tests/dromaeo/cssquery-jquery.html) 08:47:54 INFO - PROCESS | 6578 | RSS: Main: 258379776 08:47:54 INFO - PROCESS | 6578 | 08:50:57 INFO - PROCESS | 6578 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56703/tests/dromaeo/cssquery-mootools.html) 08:50:57 INFO - PROCESS | 6578 | RSS: Main: 260624384 08:50:57 INFO - PROCESS | 6578 | 08:53:59 INFO - PROCESS | 6578 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56703/tests/dromaeo/cssquery-prototype.html) 08:54:00 INFO - PROCESS | 6578 | RSS: Main: 255328256 08:54:00 INFO - PROCESS | 6578 | 08:57:03 INFO - PROCESS | 6578 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56703/tests/dromaeo/cssquery-yui.html) 08:57:03 INFO - PROCESS | 6578 | RSS: Main: 232448000 08:57:03 INFO - PROCESS | 6578 | 09:00:06 INFO - PROCESS | 6578 | Cycle 1(1): loaded http://localhost:56703/tests/dromaeo/cssquery-yui.html (next: http://localhost:56703/tests/dromaeo/cssquery-dojo.html) 09:00:07 INFO - PROCESS | 6578 | RSS: Main: 281358336 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | __start_tp_report 09:00:07 INFO - PROCESS | 6578 | _x_x_mozilla_page_load 09:00:07 INFO - PROCESS | 6578 | _x_x_mozilla_page_load_details 09:00:07 INFO - PROCESS | 6578 | |i|pagename|runs| 09:00:07 INFO - PROCESS | 6578 | |0;dojo.html;2580.651612032376;2600.3369140869077;2629.513539995101;2641.9339516512086;2642.180923913587;4536.319552067192;4589.196890544158;4608.285715714062;4677.859664210071;4710.364100846385;4638.536146385368;4676.7193968361835;4700.694454860441;4712.128256272592;4774.570288674018;4215.915681686357;4226.535081141072;4227.936580951288;4239.576042395751;4322.1571793500125;4300.118475712487;4325.913481730364;4366.737995720251;4375.037491751809;4378.737275763465;4156.231097247019;4190.182914331706;4261.509926358477;4266.424032755569;4318.050028993632;4231.597998190167;4232.555581663912;4250.213710463574;4260.850870219528;4301.075268817188;4257.701960862741;4266.91466170678;4271.231178387889;4279.87160385189;4316.942349124453;4722.504137065593;4750.50119737426;4752.477227504972;4783.736894470802;4801.783919723586;4870.464248932614;4963.329950456714;5016.147254966664;5120.718360490171;5121.795128194905;5109.105906466353;5110.5400513953555;5112.258722485219;5115.283860259567;5120.334356533664;4722.362481065081;4772.665913386064;4779.091972525209;4779.689320194177;4784.497627749036;4965.205567109245;5095.617828662865;5168.0697474454955;5168.9224661630105;5210.322658054504;5010.348654674869;5013.072581572421;5033.6224783141415;5037.395512538519;5039.294498770175;5057.747112644353;5058.215976523571;5059.822906198266;5063.797448102108;5090.41460232078;4754.120487709784;4961.677490963076;5001.074801161797;5017.974910125426;5020.995800839846;4943.555080042814;4978.178600530944;4984.601231901439;5001.174806156943;5036.345275114285;4039.7374170678813;4198.979005104955;4217.97891010543;4218.87343379693;4266.31738921771;3600.0459878132315;3687.4100143976834;3700.5929347771726;3712.2204337089515;3755.9248815023548;4423.889402764957;4437.844675436344;4442.666799990014;4479.350494178326;4479.417675702138;4912.066707325596;5105.719185444762;5108.948910510921;5112.769925353368;5162.586993040548;4356.716813407118;4400.955990440055;4408.647308215335;4413.801378937956;4447.755373454426;4511.571400716993;4512.842050528216;4515;4519.525449827786;4551.362809206714;4642.814287428465;4801.303810947324;4804.2073057945045;4804.855854324306;4837.637177211724;4982.925256121233;5009.5491405773655;5030.270610761346;5055.140626093499;5061.848144555669;4766.523347665206;4774.641901857444;4777.689450185727;4781.497942715965;4825.469198388104;4826.444958829779;4925.507449255046;4952.752362381939;4962.5533701967;5009.749512524287;5001.374828146481;5059.165237735732;5089.541941225308;5090;5131.179011358165;4946.8763280918265;4949.406071271326;4955.1823949048;4958.677685950546;5008.023435430202;4741.668083234278;4781.808727650855;4820.421549414093;4929.285253638131;4994.650374473752;4747.62019038483;4768.356271903387;4796.544328288807;4859.538343857328;4865.854024379274;4908.852734417973;4914.680545764657;4959.479254678206;4966.975165124151;4967.279744436964;4652.883677907944;4655.23188673865;4754.952450475451;4800.207965685623;4802.27965805132 09:00:07 INFO - PROCESS | 6578 | |1;ext.html;553.6429003292876;559.2533967153848;571.9084946408573;577.1804038265662;579.4582065768507;27907.302317442074;30599.38801223977;40007.599924000715;40908;40968.79515602425;41565.792171039175;41980.79009604947;42006.57993420065;42023.369649455206;42040.57959420405;7672.386209103258;7816.960915195416;7955;7955.880661790078;7958.681652733912;7605.961970190141;7842.333401660866;7852.960735196345;9937.205023598095;10264.384136951769;10298.691039268833;10337.173026157889;10342.844857327145;10349.223808214376;10378.377297362145;10251.077403033763;10298.279120461571;10361.326513776581;10367;10378;7645.9235407645765;9794.069563391538;10140.89859101407;10147.746306342327;10486.056254937015;39424.802875985726;39715.20569588592;39723;39789.20421591581;39815;2658.5746280595013;2691.341417578296;3033.8786448542032;3182.9045128646176;3188.3782662380845;29669.554956675667;30064.54903176454;30233.546496802566;30285;30708.2322941926;3084;3123.8438078096233;3144.276816332256;3146.103360542257;3156.226724452501;261487;261731.69134154398;261782;262846;262915;31691.20771980719;32606.83696581502;53028.73485632624;53605.73197133989;53624.73187634037;33862.83068584641;33924.49113263303;33988.32023359519;34062;34068;13804;14045;14051.367688454044;14060.507882224074;14061.78907316391;9308.255339572817;11400.486978086006;11497.425128743529;11503.539858405737;11509.53961841517;7735.883961740578;7919.881201781978;7947.841043179104;8068.3948703847445;8125.3499720022255;3119.7192252696914;3127.03062050765;3145.418097651896;3157.194915296585;3160.936781264362;828.8300898315831;871.7951281448854;878.1481962496368;976.4531862157073;982.3614650477105;28378.716212837608;28404.147875563765;28424.857875710488;28745.56881646777;29054.564181537295;945.8344789661782;980.460746589373;993.513178542509;1010.7927874785652;1069.2942657845786;14599.270036498345;14860.925695371454;15155.924220378827;15321.23393830304;15348.846511534965;378388;381992;383620;385308;387165;50445;51076.74461627668;51094.23358649623;51207.23189152091;51244.231336529985;1093.748437859297;1160.6053941659877;1169.3217933598323;1178.8762179971322;1230.772307123185;28066.85966570154;28985.855070724512;29254.26864328409;29283.56074658839;29767.702322976493;41459;42184.36723449212;42197.578024219365;42202.36696449617;42238.788806055774;287015;295929;296305;296375;297380;21697.34907952764;24240.63639045451;24940.75059249384;25086.247412577653;25233.621495677948;42731.786341068095;42741.14517709691;42829.78585107055;42920.35619465648;43281.56718432775;35837;36116;36242.8187859059;36531.81734091313;37111.44332835064;35561.64438355583;35778.463323049655;36279.27441451209;36459.27081458409;36702.8164859174;35244.823775880956;35501.82249088738;35809.82095089508;35991;36423.45364819583;32018;32565.7203995718;32909;33200.1699957503;33365.16587085342;24902.50194996126;25196.622050668888;25291.49417011686;25577.488450231263;25740.871295643403 09:00:07 INFO - PROCESS | 6578 | |2;jquery.html;352.47129306040955;352.5962772625345;356.76988342519076;362.8312834531942;369.12149085177276;16065.196740162988;16157.434489792844;17240.913795431006;17242.56893577658;17242.913785431087;16241.83758162418;16672.66654666909;16823.66352672946;17286.222120004597;17287.82712172878;4864.6837955532865;5085.745712714368;5092.414372347172;5094.6688465249645;5097.0315640028275;4971.4034315882145;5065.518775716301;5106.489351064901;5112.463191364909;5116.155834287338;5295.0733621616255;5607.495325420711;5613.270274864262;5680.517156041741;5692.686902220376;5273.156294992821;5529.170624406331;5574.60977731559;5629.240052592889;5631.239782629334;5208.515573061659;5242.842714718565;5258.132408152688;5258.316418865523;5258.447862974371;12267.815982760265;12324.81512777309;12372.44324005422;12487.625371238877;12583.874161258453;1746.6642875552668;1836.109486898853;1870.2799422222406;1877.2584828992608;1898.411492437349;8740.125987401272;9095.408798428147;9484.33609647325;9555.952220238923;9619.615215391375;1494.7907292978991;1586.8889177757562;1621.6756648670314;1651.21971891375;1663;44389.55610443919;60787.999999999556;60885.69557152186;64526.67736661334;68828.6558567209;9440.57517411718;9463.432194068379;10001.24990625706;10096.192304615613;10228.795424091477;11258.324500529994;12731.23612583248;13679;13939.790903136462;13948.442062317394;7344.30229128232;7347.950600500839;7383.926160738324;7548.849023019508;7582.658780354897;7101.815674557602;7218.133823941055;7294.854102917912;7320.414366850639;7429.405647548291;4270.50889147752;4315.287977483743;4381.3427985801745;4397.31841564558;4498.370228168059;1699.405208177128;1807.6384723055442;1817.3457555280088;1836.1278392763331;1846.5937493751353;762.9885551716728;872.0799556467861;878.3061381508537;900.3157600223747;910.8360495110811;16105.355785768672;16510.917445412695;16877.915610422115;17003.149842507824;17517.386891458736;856.7301300090452;879.9736007919772;884.2395539835736;885.9291256699448;887.2946007923716;9343.672971445967;9415.623375065057;9571.664991725396;9660.082292182231;9876.753081173028;395602;397859;404741;404864;407487;47194;72697.90953135707;75961.24038759652;76290.61854690692;76803.61598192086;896.3859756067114;898.7303808857185;907.4555266839975;914.4924566865453;918.9081091890891;14965.176915269765;15232.086074835544;15373.846261537241;15463;15501.147436890627;26615.46769064569;33246.83376583102;34867.47698784571;35275;36866;45215.32177017281;46639.30041049319;47735;48092.5190748102;48168;7225.5664660120565;7469.253074692488;7481.251874812693;7568.4323675723435;7587.279208475186;9656.179224765692;10967.725806854573;11122.110231181648;11183.888161118284;11243.156763242627;5709.51469125129;6268.623882567061;9447.905520944978;9732.951335243279;9788.363756355815;9484.620615175592;9954.45250511229;10121.898781012096;10232.232582556488;10282.126019288444;10064.69805905824;10103.141232995278;10166.390016599027;10170.542325595217;10504.157667117366;7629.7329593463965;7947.086085100287;8111.514718434371;8114.797130071795;8134.186581341818;7947.721829736162;9299.395539289924;10390.74023149397;10393.9480302598;10424.739381515219 09:00:07 INFO - PROCESS | 6578 | |3;mootools.html;1205.5177928828462;1333.3599872061407;1397.1547213935569;1449.3912556726175;1697.278656570957;6490.578112422695;7482.102147742272;7699.846003079942;7710.306072453478;7862.213778622135;7464.701411943529;7675.04061992251;7676.309132178103;7679.846403071949;7696.88454673179;1840.8067152948947;1873.1196337721317;1876.8967706776123;2112.9894350528266;2150.7419109706857;1871.915763790626;2121.1727426303755;2202.2072054060527;2209.3924170852983;2218.511927375983;2151.236311109557;2170.8806015669134;2178.292055082097;2179.2372669565684;2182.8253739700785;1806.3136008316887;2133.6799480077957;2140.8501404901663;2144.345974477784;2147.5382792699643;2077.7091207231;2136.572685462898;2136.59404713104;2145.0990583954776;2153.192552792703;7763.534187948741;7772.650230739574;7844.980152580128;7855.332296754783;7858.057033156001;4474.530174331713;4643.141018911479;4645.024544845586;4645.303204519315;4659.347691323217;2716.4567086582565;2800.9019684311156;2837.460882432352;2839.0489186122672;2874.439484300562;828.6395417993132;862.6549380247889;880.5025160784137;880.6917578847416;902.4359775140537;10482.79034419315;10500.894991050069;10517.526711297933;10556.155507559377;10581.576736930514;4180.916381672349;4212.073343864345;4259.87220383389;4288.785560721952;4306.5262821089655;8961.148690874486;8970.686025989058;8994.86507702385;8997.415168014059;8999.280057595377;4571.885702857388;4574.428196475441;4576.450825900846;4579.885502862388;4583.633309335245;3497.8076205808925;3700.2414505026945;4144.854930077433;4209.494860616745;4212.789360531961;3524.8590056397456;3623.2934577757082;3672.5042119314085;3672.889813305605;3673.651003154696;1080.9675709728563;1087.5812812067252;1098.6429410441638;1114.8940850619178;1148.9080873530097;659.4065341192965;775.8797386405116;779.945403821727;789.1674283630709;814.311906439058;4807.591354734886;4913.778879950411;4950.702957822542;5006.69959802413;5015.523525265094;376.55378376623787;380.3382115119672;381.28889620856904;392.28408155116455;410.1653135868493;3404.1829960809227;3447.1382154461385;3468.965310346864;3471.392506311385;3499.9650003500146;9244.722658320261;9554.904450955402;9591.232701384011;9601.279904007228;9602.135807777333;9398.483083430478;9501.239900808057;9520.809583808285;9551.570179341947;9554.761130971781;7020.894686579705;7070.823229419203;7169.175544812309;7172.82067948295;7178.676959536833;4874.366332376769;4999.450060493416;5078.162103252922;5083.644144909821;5122.513361230677;8489.108643592333;8733.694320698745;8799.824003520022;8812.559372031501;8985.550722463982;8719.825603487769;8988.921329440509;9005.234555062892;9039.548022598976;9048.90951090507;5721.313442386941;6008.459238668541;6096.116063170904;6435.646039467874;6569.113169722026;7391.371733402721;7406.555606663617;7431.442641801995;7434.962825185839;7485.850282994418;6283.120363149072;6332.683365831598;6384.138141350858;6408.102865598913;6491.837704057436;6377.744890204525;6408.647524386203;6445.677716114082;6487.351264873475;6498.447631951148;6035.849103772441;6067.726952287246;6078.6048906820915;6084.787032453843;6094.39056094387;4131.215069136854;4252.702310838212;4321.870343889688;4395.7582332970715;4408.625266852225;4186.602272784081;4328.43730315057;4335.891602709831;4356.976110613939;4371.803268852846 09:00:07 INFO - PROCESS | 6578 | |4;prototype.html;290.455396132252;291.6747826173816;295.8446815421905;295.88164734106346;301.19280328719054;4894.730789806559;4916.508349165082;4957.752112394384;4959.7520123993745;4969.403671559414;4829.22732362822;4833.767389315728;4853.451937732692;4870.02763880628;4877.365942427479;3571.910702232439;3678.2275722098393;3681.7606855554304;3701.9629803702023;3703.0557207911943;3686.6221287269695;3704.7962362070075;3776.7356285060055;3780.3006443807844;3823.3500304948225;3713.4801127842125;3734.7198960077967;3754.361758501048;3755.568109667382;3778.960785783918;3642.21692336149;3755.7746535207975;3777.8111094445167;3784.924301513968;3801.163743976321;3310.0235430548046;3330.5670262865915;3340.6325304216516;3342.866285348583;3346.8493917773517;4669.603083737887;4763.809447622091;4775.641826863;4787.521247875219;4808.951910480921;4316.740995540277;4321.65426765858;4333.414988976479;4336.176126535979;4352.434183556117;4847.2729090636685;5065.4174769901565;5080.949190508085;5097.541221290065;5134.460881607452;3577.3560759063357;3580.943621631625;3601.7213889069267;3612.277544491112;3612.638736126393;5352.892942141136;5371.4154324474375;5396.892062158735;5414.864628384283;5424.945750542483;3516.2791627716256;3673.1000904778502;3678.209185025179;3684.5578530576504;3689.9815500922323;3716;3717.683996860297;3721.702263818888;3731.384321586908;3735.7758534488016;4213.789310534522;4275.572442755762;4300.118475712471;4305.56944305567;4320.287152619845;5016.197408414636;5146.408163061221;5152.093725321655;5164.974175129176;5205.9739701302005;1278.5525066226746;1281.5642681488152;1286.0611753420055;1293.812397202419;1301.7982212757038;798.8841617965362;807.947483413588;808.9393295502861;836.3476488339105;837.4807619276088;4407.294832826732;4507.323901414748;4508.909821803545;4510.774461276923;4557.202489564313;5180.663256888365;5224.164133738584;5233.345831771028;5239.345081864767;5243;4454.443194600675;4487.685861989629;4503.3245013247615;4512.187806194916;4525.796339164745;2730.3447172678416;2799.6080548723194;2809.7241234600037;2817.1266907258814;2826.1945345576823;4942.406911170682;4953.43035550909;4964.673668642018;4999.550130462198;5009.7495125243595;5209.270702101709;5363.383210930715;5410.594205434608;5421.241026256327;5427.565794736491;4945.381827271591;4963.907940253211;4966.453690094087;4971.0115953618115;4992.850214493571;5253.816116435906;5269.209618557247;5291.788328466972;5308.336457942757;5308.575313974796;4999.0501804657;5111.795528178831;5138.743062846768;5187.221916712523;5203.973980130075;4901.656884018084;4907.165781817171;4925.113479573568;4937.604991600735;4979.609787302043;3670.467782171517;3671;3677.135873069773;3677.3013127505687;3679.632036796299;4990.775415106256;5239.816606418757;5312.0969435196885;5322.467753224647;5352.250684904038;5098.413682426569;5113.693178409308;5123.180291153398;5127.333446651912;5129.923051154161;5076.5177308157145;5088.59291256706;5098.872528186676;5111.769970351417;5145.687849598328;4787;5018.824341148043;5023.824166154167;5053.67151135175;5061.962297728883;4866.367372241586;5020.42265139499;5133.358330208724;5170.793168273227;5193.870153246199;5078.577998160521;5086.745662716776;5089.618278629044;5090.2003897856775;5090.796368145233 09:00:07 INFO - PROCESS | 6578 | |5;yui.html;528.8598521391832;540.7080176704579;555.0453220460806;579.4408395897959;584.1150656755015;10795.08241799447;11250.212485126045;11258.268212566189;11571;11620.302781833096;10891.782164356728;11799.410029498513;12078.456469458873;12080.395980201;12097.092718046139;620.1813606040029;763.5876626621617;769.7382889817447;786.3591173193857;788.8264581791997;788.8185717285028;793.6507936507946;794.3168874767724;794.5749024272016;794.7695168401157;836.2515548584014;840.6175190288435;841.4068082002174;841.5119230846094;842.0316635868769;656.8916128838736;795.0657976877146;800.2637573432427;801.286854699318;811.9837603247961;595.1043679262725;595.4402861310398;595.8540157661357;595.8629515211526;596.0790578556141;11373.943130284295;11388;11394.373309467976;11404.54381824726;11409.20135590509;11351.943240283828;11689.590864319707;11843.289402635783;12014.159008869383;12245.571405000872;10399.48002599867;10480.737981550446;10492.790144197073;10667.19996000303;11038.834417483744;4060.634542891154;4095.9795201024103;4099.528554216274;4233;4282.743035417854;60549.69725151346;61006.69496652488;61439.38560614381;62607.06089408662;62675;8895.644174232959;8942.68700595476;9079.228265597367;9305.162535371848;9410.858837117448;18346.266149353876;18418.723719144222;18494.0752962354;18683.15925783343;18713.345032923782;6305.085762564402;6366.076918846741;6451.225852897683;6520.5435619507125;6577.276499585042;3577.284543091392;3648.7810731356203;3667.8716244931297;3706.79612621303;3746.2132952079824;2611.9216423507323;2673.224764818181;2685.9059932902255;2691.300261931912;2691.757741803247;458.94722106958125;461.6606794006403;467.68431308866377;468.2110643565603;470.7904982282851;432.3234138573123;481.37661728062244;498.81294514557044;521.8877941242652;556.8385168301228;7404.851902961911;7431.368333691588;7461.776146715607;7497.10034795828;7793.337566306814;433.01625049544316;482.25973131244075;482.8816939849759;495.40798745498785;527.686026814045;3400.608929973035;3517.9472307915403;3547.2018795770746;3568.2506673598837;3581.8567257309937;59152;88779.11220887837;93270.53364733269;97851;101273.49363253136;55324;85772.57113714391;86134;87041.56479217563;89359.55320223357;49815.25277120846;61335.69332153311;76924;79346;80938.19061809307;7383.07711536058;7451.552906825608;7530.887036694564;7684.5773482459;7849.686012559434;30939.535906960962;31703;38323.616763832004;39132;41272.79363603163;55208.44791552194;58338.416615835;58818.411815883;59635.403645962986;59686.70156649189;9924.503774811375;10842.1210455297;10898.400587967737;10930.781384372109;11152.888471115184;11471.655850324503;11816.881831181578;12045.217060891015;12205.084618653815;12466.252024878537;10439.164866810484;10541.894581054397;10550.736231593964;11087;11213.15901307389;10683.30558513694;10806.621768238074;10811.29726567802;10838.67483975482;10899.569254140095;10248.38509689421;10285.897141028494;10504.579816807242;10514.947425262824;10641.255112142077;8356.122607126408;8367.790805229675;8439.873401898854;8667.219950204511;8837.690680826141;8017.436132204117;8036.1160272368825;8036.4776289541;8117.715879944174;8257.545834979133 09:00:07 INFO - PROCESS | 6578 | __end_tp_report 09:00:07 INFO - PROCESS | 6578 | __start_cc_report 09:00:07 INFO - PROCESS | 6578 | _x_x_mozilla_cycle_collect,992 09:00:07 INFO - PROCESS | 6578 | __end_cc_report 09:00:07 INFO - PROCESS | 6578 | __startTimestamp1465488007202__endTimestamp 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | ------- Summary: start ------- 09:00:07 INFO - PROCESS | 6578 | Number of tests: 6 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | [#0] dojo.html Cycles:165 Average:4647.59 Median:4779.69 stddev:499.48 (10.4%) stddev-sans-first:473.96 09:00:07 INFO - PROCESS | 6578 | Values: 2580.7 2600.3 2629.5 2641.9 2642.2 4536.3 4589.2 4608.3 4677.9 4710.4 4638.5 4676.7 4700.7 4712.1 4774.6 4215.9 4226.5 4227.9 4239.6 4322.2 4300.1 4325.9 4366.7 4375.0 4378.7 4156.2 4190.2 4261.5 4266.4 4318.1 4231.6 4232.6 4250.2 4260.9 4301.1 4257.7 4266.9 4271.2 4279.9 4316.9 4722.5 4750.5 4752.5 4783.7 4801.8 4870.5 4963.3 5016.1 5120.7 5121.8 5109.1 5110.5 5112.3 5115.3 5120.3 4722.4 4772.7 4779.1 4779.7 4784.5 4965.2 5095.6 5168.1 5168.9 5210.3 5010.3 5013.1 5033.6 5037.4 5039.3 5057.7 5058.2 5059.8 5063.8 5090.4 4754.1 4961.7 5001.1 5018.0 5021.0 4943.6 4978.2 4984.6 5001.2 5036.3 4039.7 4199.0 4218.0 4218.9 4266.3 3600.0 3687.4 3700.6 3712.2 3755.9 4423.9 4437.8 4442.7 4479.4 4479.4 4912.1 5105.7 5108.9 5112.8 5162.6 4356.7 4401.0 4408.6 4413.8 4447.8 4511.6 4512.8 4515.0 4519.5 4551.4 4642.8 4801.3 4804.2 4804.9 4837.6 4982.9 5009.5 5030.3 5055.1 5061.8 4766.5 4774.6 4777.7 4781.5 4825.5 4826.4 4925.5 4952.8 4962.6 5009.7 5001.4 5059.2 5089.5 5090.0 5131.2 4946.9 4949.4 4955.2 4958.7 5008.0 4741.7 4781.8 4820.4 4929.3 4994.7 4747.6 4768.4 4796.5 4859.5 4865.9 4908.9 4914.7 4959.5 4967.0 4967.3 4652.9 4655.2 4755.0 4800.2 4802.3 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | [#1] ext.html Cycles:180 Average:46083.40 Median:32757.92 stddev:83572.77 (255.1%) stddev-sans-first:83737.30 09:00:07 INFO - PROCESS | 6578 | Values: 553.6 559.3 571.9 577.2 579.5 27907.3 30599.4 40007.6 40908.0 40968.8 41565.8 41980.8 42006.6 42023.4 42040.6 7672.4 7817.0 7955.0 7955.9 7958.7 7606.0 7842.3 7853.0 9937.2 10264.4 10298.7 10337.2 10342.8 10349.2 10378.4 10251.1 10298.3 10361.3 10367.0 10378.0 7645.9 9794.1 10140.9 10147.7 10486.1 39424.8 39715.2 39723.0 39789.2 39815.0 2658.6 2691.3 3033.9 3182.9 3188.4 29669.6 30064.5 30233.5 30285.0 30708.2 3084.0 3123.8 3144.3 3146.1 3156.2 261487.0 261731.7 261782.0 262846.0 262915.0 31691.2 32606.8 53028.7 53605.7 53624.7 33862.8 33924.5 33988.3 34062.0 34068.0 13804.0 14045.0 14051.4 14060.5 14061.8 9308.3 11400.5 11497.4 11503.5 11509.5 7735.9 7919.9 7947.8 8068.4 8125.3 3119.7 3127.0 3145.4 3157.2 3160.9 828.8 871.8 878.1 976.5 982.4 28378.7 28404.1 28424.9 28745.6 29054.6 945.8 980.5 993.5 1010.8 1069.3 14599.3 14860.9 15155.9 15321.2 15348.8 378388.0 381992.0 383620.0 385308.0 387165.0 50445.0 51076.7 51094.2 51207.2 51244.2 1093.7 1160.6 1169.3 1178.9 1230.8 28066.9 28985.9 29254.3 29283.6 29767.7 41459.0 42184.4 42197.6 42202.4 42238.8 287015.0 295929.0 296305.0 296375.0 297380.0 21697.3 24240.6 24940.8 25086.2 25233.6 42731.8 42741.1 42829.8 42920.4 43281.6 35837.0 36116.0 36242.8 36531.8 37111.4 35561.6 35778.5 36279.3 36459.3 36702.8 35244.8 35501.8 35809.8 35991.0 36423.5 32018.0 32565.7 32909.0 33200.2 33365.2 24902.5 25196.6 25291.5 25577.5 25740.9 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | [#2] jquery.html Cycles:180 Average:23625.91 Median:4918.04 stddev:66053.86 (1343.1%) stddev-sans-first:66216.04 09:00:07 INFO - PROCESS | 6578 | Values: 352.5 352.6 356.8 362.8 369.1 16065.2 16157.4 17240.9 17242.6 17242.9 16241.8 16672.7 16823.7 17286.2 17287.8 4864.7 5085.7 5092.4 5094.7 5097.0 4971.4 5065.5 5106.5 5112.5 5116.2 5295.1 5607.5 5613.3 5680.5 5692.7 5273.2 5529.2 5574.6 5629.2 5631.2 5208.5 5242.8 5258.1 5258.3 5258.4 12267.8 12324.8 12372.4 12487.6 12583.9 1746.7 1836.1 1870.3 1877.3 1898.4 8740.1 9095.4 9484.3 9556.0 9619.6 1494.8 1586.9 1621.7 1651.2 1663.0 44389.6 60788.0 60885.7 64526.7 68828.7 9440.6 9463.4 10001.2 10096.2 10228.8 11258.3 12731.2 13679.0 13939.8 13948.4 7344.3 7348.0 7383.9 7548.8 7582.7 7101.8 7218.1 7294.9 7320.4 7429.4 4270.5 4315.3 4381.3 4397.3 4498.4 1699.4 1807.6 1817.3 1836.1 1846.6 763.0 872.1 878.3 900.3 910.8 16105.4 16510.9 16877.9 17003.1 17517.4 856.7 880.0 884.2 885.9 887.3 9343.7 9415.6 9571.7 9660.1 9876.8 395602.0 397859.0 404741.0 404864.0 407487.0 47194.0 72697.9 75961.2 76290.6 76803.6 896.4 898.7 907.5 914.5 918.9 14965.2 15232.1 15373.8 15463.0 15501.1 26615.5 33246.8 34867.5 35275.0 36866.0 45215.3 46639.3 47735.0 48092.5 48168.0 7225.6 7469.3 7481.3 7568.4 7587.3 9656.2 10967.7 11122.1 11183.9 11243.2 5709.5 6268.6 9447.9 9733.0 9788.4 9484.6 9954.5 10121.9 10232.2 10282.1 10064.7 10103.1 10166.4 10170.5 10504.2 7629.7 7947.1 8111.5 8114.8 8134.2 7947.7 9299.4 10390.7 10393.9 10424.7 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | [#3] mootools.html Cycles:180 Average:4991.32 Median:4840.98 stddev:2865.36 (59.2%) stddev-sans-first:2859.28 09:00:07 INFO - PROCESS | 6578 | Values: 1205.5 1333.4 1397.2 1449.4 1697.3 6490.6 7482.1 7699.8 7710.3 7862.2 7464.7 7675.0 7676.3 7679.8 7696.9 1840.8 1873.1 1876.9 2113.0 2150.7 1871.9 2121.2 2202.2 2209.4 2218.5 2151.2 2170.9 2178.3 2179.2 2182.8 1806.3 2133.7 2140.9 2144.3 2147.5 2077.7 2136.6 2136.6 2145.1 2153.2 7763.5 7772.7 7845.0 7855.3 7858.1 4474.5 4643.1 4645.0 4645.3 4659.3 2716.5 2800.9 2837.5 2839.0 2874.4 828.6 862.7 880.5 880.7 902.4 10482.8 10500.9 10517.5 10556.2 10581.6 4180.9 4212.1 4259.9 4288.8 4306.5 8961.1 8970.7 8994.9 8997.4 8999.3 4571.9 4574.4 4576.5 4579.9 4583.6 3497.8 3700.2 4144.9 4209.5 4212.8 3524.9 3623.3 3672.5 3672.9 3673.7 1081.0 1087.6 1098.6 1114.9 1148.9 659.4 775.9 779.9 789.2 814.3 4807.6 4913.8 4950.7 5006.7 5015.5 376.6 380.3 381.3 392.3 410.2 3404.2 3447.1 3469.0 3471.4 3500.0 9244.7 9554.9 9591.2 9601.3 9602.1 9398.5 9501.2 9520.8 9551.6 9554.8 7020.9 7070.8 7169.2 7172.8 7178.7 4874.4 4999.5 5078.2 5083.6 5122.5 8489.1 8733.7 8799.8 8812.6 8985.6 8719.8 8988.9 9005.2 9039.5 9048.9 5721.3 6008.5 6096.1 6435.6 6569.1 7391.4 7406.6 7431.4 7435.0 7485.9 6283.1 6332.7 6384.1 6408.1 6491.8 6377.7 6408.6 6445.7 6487.4 6498.4 6035.8 6067.7 6078.6 6084.8 6094.4 4131.2 4252.7 4321.9 4395.8 4408.6 4186.6 4328.4 4335.9 4357.0 4371.8 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | [#4] prototype.html Cycles:180 Average:4231.48 Median:4868.20 stddev:1246.30 (25.6%) stddev-sans-first:1214.18 09:00:07 INFO - PROCESS | 6578 | Values: 290.5 291.7 295.8 295.9 301.2 4894.7 4916.5 4957.8 4959.8 4969.4 4829.2 4833.8 4853.5 4870.0 4877.4 3571.9 3678.2 3681.8 3702.0 3703.1 3686.6 3704.8 3776.7 3780.3 3823.4 3713.5 3734.7 3754.4 3755.6 3779.0 3642.2 3755.8 3777.8 3784.9 3801.2 3310.0 3330.6 3340.6 3342.9 3346.8 4669.6 4763.8 4775.6 4787.5 4809.0 4316.7 4321.7 4333.4 4336.2 4352.4 4847.3 5065.4 5080.9 5097.5 5134.5 3577.4 3580.9 3601.7 3612.3 3612.6 5352.9 5371.4 5396.9 5414.9 5424.9 3516.3 3673.1 3678.2 3684.6 3690.0 3716.0 3717.7 3721.7 3731.4 3735.8 4213.8 4275.6 4300.1 4305.6 4320.3 5016.2 5146.4 5152.1 5165.0 5206.0 1278.6 1281.6 1286.1 1293.8 1301.8 798.9 807.9 808.9 836.3 837.5 4407.3 4507.3 4508.9 4510.8 4557.2 5180.7 5224.2 5233.3 5239.3 5243.0 4454.4 4487.7 4503.3 4512.2 4525.8 2730.3 2799.6 2809.7 2817.1 2826.2 4942.4 4953.4 4964.7 4999.6 5009.7 5209.3 5363.4 5410.6 5421.2 5427.6 4945.4 4963.9 4966.5 4971.0 4992.9 5253.8 5269.2 5291.8 5308.3 5308.6 4999.1 5111.8 5138.7 5187.2 5204.0 4901.7 4907.2 4925.1 4937.6 4979.6 3670.5 3671.0 3677.1 3677.3 3679.6 4990.8 5239.8 5312.1 5322.5 5352.3 5098.4 5113.7 5123.2 5127.3 5129.9 5076.5 5088.6 5098.9 5111.8 5145.7 4787.0 5018.8 5023.8 5053.7 5062.0 4866.4 5020.4 5133.4 5170.8 5193.9 5078.6 5086.7 5089.6 5090.2 5090.8 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - PROCESS | 6578 | [#5] yui.html Cycles:180 Average:16444.99 Median:497.11 stddev:23926.68 (4813.2%) stddev-sans-first:23963.95 09:00:07 INFO - PROCESS | 6578 | Values: 528.9 540.7 555.0 579.4 584.1 10795.1 11250.2 11258.3 11571.0 11620.3 10891.8 11799.4 12078.5 12080.4 12097.1 620.2 763.6 769.7 786.4 788.8 788.8 793.7 794.3 794.6 794.8 836.3 840.6 841.4 841.5 842.0 656.9 795.1 800.3 801.3 812.0 595.1 595.4 595.9 595.9 596.1 11373.9 11388.0 11394.4 11404.5 11409.2 11351.9 11689.6 11843.3 12014.2 12245.6 10399.5 10480.7 10492.8 10667.2 11038.8 4060.6 4096.0 4099.5 4233.0 4282.7 60549.7 61006.7 61439.4 62607.1 62675.0 8895.6 8942.7 9079.2 9305.2 9410.9 18346.3 18418.7 18494.1 18683.2 18713.3 6305.1 6366.1 6451.2 6520.5 6577.3 3577.3 3648.8 3667.9 3706.8 3746.2 2611.9 2673.2 2685.9 2691.3 2691.8 458.9 461.7 467.7 468.2 470.8 432.3 481.4 498.8 521.9 556.8 7404.9 7431.4 7461.8 7497.1 7793.3 433.0 482.3 482.9 495.4 527.7 3400.6 3517.9 3547.2 3568.3 3581.9 59152.0 88779.1 93270.5 97851.0 101273.5 55324.0 85772.6 86134.0 87041.6 89359.6 49815.3 61335.7 76924.0 79346.0 80938.2 7383.1 7451.6 7530.9 7684.6 7849.7 30939.5 31703.0 38323.6 39132.0 41272.8 55208.4 58338.4 58818.4 59635.4 59686.7 9924.5 10842.1 10898.4 10930.8 11152.9 11471.7 11816.9 12045.2 12205.1 12466.3 10439.2 10541.9 10550.7 11087.0 11213.2 10683.3 10806.6 10811.3 10838.7 10899.6 10248.4 10285.9 10504.6 10514.9 10641.3 8356.1 8367.8 8439.9 8667.2 8837.7 8017.4 8036.1 8036.5 8117.7 8257.5 09:00:07 INFO - PROCESS | 6578 | -------- Summary: end -------- 09:00:07 INFO - PROCESS | 6578 | 09:00:07 INFO - TEST-INFO | 6578: exit 0 09:00:08 INFO - TEST-OK | dromaeo_css | took 1119353ms 09:00:08 INFO - TEST-START | kraken 09:00:08 INFO - operating with platform_type : linux_ 09:00:08 INFO - Initialising browser for kraken test... 09:00:08 INFO - TEST-INFO | started process 6755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9Osyk/profile http://localhost:56703/getInfo.html) 09:00:12 INFO - PROCESS | 6755 | __metrics Screen width/height:1600/1200 09:00:12 INFO - PROCESS | 6755 | colorDepth:24 09:00:12 INFO - PROCESS | 6755 | Browser inner width/height: 1024/697 09:00:12 INFO - PROCESS | 6755 | __metrics 09:00:13 ERROR - PROCESS | 6755 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:00:13 INFO - PROCESS | 6755 | console.error: PushService: 09:00:13 INFO - PROCESS | 6755 | stateChangeProcessEnqueue: Error transitioning state 09:00:13 INFO - PROCESS | 6755 | UnknownError 09:00:14 INFO - TEST-INFO | 6755: exit 0 09:00:14 INFO - Browser initialized. 09:00:14 INFO - Running cycle 1/1 for kraken test... 09:00:14 INFO - TEST-INFO | started process 6835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB9Osyk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:26 INFO - PROCESS | 6835 | RSS: Main: 175521792 09:00:26 INFO - PROCESS | 6835 | 09:00:29 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:30 INFO - PROCESS | 6835 | RSS: Main: 232697856 09:00:30 INFO - PROCESS | 6835 | 09:00:32 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-dft) 09:00:33 INFO - PROCESS | 6835 | RSS: Main: 220897280 09:00:33 INFO - PROCESS | 6835 | 09:00:36 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-fft) 09:00:37 INFO - PROCESS | 6835 | RSS: Main: 287072256 09:00:37 INFO - PROCESS | 6835 | 09:00:39 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56703/tests/kraken/driver.html?testName=audio-oscillator) 09:00:40 INFO - PROCESS | 6835 | RSS: Main: 198057984 09:00:40 INFO - PROCESS | 6835 | 09:00:42 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56703/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:42 INFO - PROCESS | 6835 | RSS: Main: 202076160 09:00:42 INFO - PROCESS | 6835 | 09:00:46 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56703/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:46 INFO - PROCESS | 6835 | RSS: Main: 238227456 09:00:46 INFO - PROCESS | 6835 | 09:00:50 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56703/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:50 INFO - PROCESS | 6835 | RSS: Main: 234143744 09:00:50 INFO - PROCESS | 6835 | 09:00:53 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56703/tests/kraken/driver.html?testName=json-parse-financial) 09:00:54 INFO - PROCESS | 6835 | RSS: Main: 236765184 09:00:54 INFO - PROCESS | 6835 | 09:00:56 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56703/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:00:56 INFO - PROCESS | 6835 | RSS: Main: 222560256 09:00:56 INFO - PROCESS | 6835 | 09:00:58 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:00:59 INFO - PROCESS | 6835 | RSS: Main: 224120832 09:00:59 INFO - PROCESS | 6835 | 09:01:01 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:02 INFO - PROCESS | 6835 | RSS: Main: 235270144 09:01:02 INFO - PROCESS | 6835 | 09:01:04 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:05 INFO - PROCESS | 6835 | RSS: Main: 240984064 09:01:05 INFO - PROCESS | 6835 | 09:01:08 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:08 INFO - PROCESS | 6835 | RSS: Main: 237596672 09:01:08 INFO - PROCESS | 6835 | 09:01:10 INFO - PROCESS | 6835 | Cycle 1(1): loaded http://localhost:56703/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56703/tests/kraken/driver.html?testName=ai-astar) 09:01:11 INFO - PROCESS | 6835 | RSS: Main: 280211456 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | __start_tp_report 09:01:11 INFO - PROCESS | 6835 | _x_x_mozilla_page_load 09:01:11 INFO - PROCESS | 6835 | _x_x_mozilla_page_load_details 09:01:11 INFO - PROCESS | 6835 | |i|pagename|runs| 09:01:11 INFO - PROCESS | 6835 | |0;ai-astar;113;108;113;115;113;113;113;113;112;112 09:01:11 INFO - PROCESS | 6835 | |1;audio-beat-detection;163;133;139;192;130;154;157;131;199;132 09:01:11 INFO - PROCESS | 6835 | |2;audio-dft;162;161;162;161;164;161;169;160;161;161 09:01:11 INFO - PROCESS | 6835 | |3;audio-fft;77;77;77;121;75;76;75;75;108;76 09:01:11 INFO - PROCESS | 6835 | |4;audio-oscillator;87;87;114;87;87;86;119;86;87;135 09:01:11 INFO - PROCESS | 6835 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;116;117;117 09:01:11 INFO - PROCESS | 6835 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 09:01:11 INFO - PROCESS | 6835 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;95 09:01:11 INFO - PROCESS | 6835 | |8;json-parse-financial;63;63;63;63;64;64;63;63;62;62 09:01:11 INFO - PROCESS | 6835 | |9;json-stringify-tinderbox;65;65;65;64;65;65;65;66;65;65 09:01:11 INFO - PROCESS | 6835 | |10;stanford-crypto-aes;84;84;84;91;88;85;85;85;121;86 09:01:11 INFO - PROCESS | 6835 | |11;stanford-crypto-ccm;136;133;128;140;132;143;130;131;140;135 09:01:11 INFO - PROCESS | 6835 | |12;stanford-crypto-pbkdf2;176;170;171;167;167;165;166;166;167;163 09:01:11 INFO - PROCESS | 6835 | |13;stanford-crypto-sha256-iterative;68;67;68;79;66;71;67;65;66;67 09:01:11 INFO - PROCESS | 6835 | __end_tp_report 09:01:11 INFO - PROCESS | 6835 | __start_cc_report 09:01:11 INFO - PROCESS | 6835 | _x_x_mozilla_cycle_collect,1876 09:01:11 INFO - PROCESS | 6835 | __end_cc_report 09:01:11 INFO - PROCESS | 6835 | __startTimestamp1465488071035__endTimestamp 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | ------- Summary: start ------- 09:01:11 INFO - PROCESS | 6835 | Number of tests: 14 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.78 (1.6%) stddev-sans-first:1.88 09:01:11 INFO - PROCESS | 6835 | Values: 113.0 108.0 113.0 115.0 113.0 113.0 113.0 113.0 112.0 112.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:155.50 stddev:25.39 (16.3%) stddev-sans-first:26.68 09:01:11 INFO - PROCESS | 6835 | Values: 163.0 133.0 139.0 192.0 130.0 154.0 157.0 131.0 199.0 132.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.50 stddev:2.62 (1.6%) stddev-sans-first:2.77 09:01:11 INFO - PROCESS | 6835 | Values: 162.0 161.0 162.0 161.0 164.0 161.0 169.0 160.0 161.0 161.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:16.54 (21.8%) stddev-sans-first:17.36 09:01:11 INFO - PROCESS | 6835 | Values: 77.0 77.0 77.0 121.0 75.0 76.0 75.0 75.0 108.0 76.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:87.00 stddev:18.12 (20.8%) stddev-sans-first:18.82 09:01:11 INFO - PROCESS | 6835 | Values: 87.0 87.0 114.0 87.0 87.0 86.0 119.0 86.0 87.0 135.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:01:11 INFO - PROCESS | 6835 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 116.0 117.0 117.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:01:11 INFO - PROCESS | 6835 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:01:11 INFO - PROCESS | 6835 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:01:11 INFO - PROCESS | 6835 | Values: 63.0 63.0 63.0 63.0 64.0 64.0 63.0 63.0 62.0 62.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 09:01:11 INFO - PROCESS | 6835 | Values: 65.0 65.0 65.0 64.0 65.0 65.0 65.0 66.0 65.0 65.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:85.00 stddev:11.35 (13.4%) stddev-sans-first:11.88 09:01:11 INFO - PROCESS | 6835 | Values: 84.0 84.0 84.0 91.0 88.0 85.0 85.0 85.0 121.0 86.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:135.50 stddev:4.92 (3.6%) stddev-sans-first:5.20 09:01:11 INFO - PROCESS | 6835 | Values: 136.0 133.0 128.0 140.0 132.0 143.0 130.0 131.0 140.0 135.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:167.00 stddev:3.68 (2.2%) stddev-sans-first:2.42 09:01:11 INFO - PROCESS | 6835 | Values: 176.0 170.0 171.0 167.0 167.0 165.0 166.0 166.0 167.0 163.0 09:01:11 INFO - PROCESS | 6835 | 09:01:11 INFO - PROCESS | 6835 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.50 stddev:4.06 (6.0%) stddev-sans-first:4.30 09:01:11 INFO - PROCESS | 6835 | Values: 68.0 67.0 68.0 79.0 66.0 71.0 67.0 65.0 66.0 67.0 09:01:11 INFO - PROCESS | 6835 | -------- Summary: end -------- 09:01:11 INFO - PROCESS | 6835 | 09:01:12 INFO - TEST-INFO | 6835: exit 0 09:01:12 INFO - TEST-OK | kraken | took 64138ms 09:01:12 INFO - SUITE-END | took 1183s 09:01:12 INFO - Completed test suite (00:19:43) 09:01:12 INFO - javascript benchmark 09:01:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.651612032376, 2600.3369140869077, 2629.513539995101, 2641.9339516512086, 2642.180923913587, 4536.319552067192, 4589.196890544158, 4608.285715714062, 4677.859664210071, 4710.364100846385, 4638.536146385368, 4676.7193968361835, 4700.694454860441, 4712.128256272592, 4774.570288674018, 4215.915681686357, 4226.535081141072, 4227.936580951288, 4239.576042395751, 4322.1571793500125, 4300.118475712487, 4325.913481730364, 4366.737995720251, 4375.037491751809, 4378.737275763465, 4156.231097247019, 4190.182914331706, 4261.509926358477, 4266.424032755569, 4318.050028993632, 4231.597998190167, 4232.555581663912, 4250.213710463574, 4260.850870219528, 4301.075268817188, 4257.701960862741, 4266.91466170678, 4271.231178387889, 4279.87160385189, 4316.942349124453, 4722.504137065593, 4750.50119737426, 4752.477227504972, 4783.736894470802, 4801.783919723586, 4870.464248932614, 4963.329950456714, 5016.147254966664, 5120.718360490171, 5121.795128194905, 5109.105906466353, 5110.5400513953555, 5112.258722485219, 5115.283860259567, 5120.334356533664, 4722.362481065081, 4772.665913386064, 4779.091972525209, 4779.689320194177, 4784.497627749036, 4965.205567109245, 5095.617828662865, 5168.0697474454955, 5168.9224661630105, 5210.322658054504, 5010.348654674869, 5013.072581572421, 5033.6224783141415, 5037.395512538519, 5039.294498770175, 5057.747112644353, 5058.215976523571, 5059.822906198266, 5063.797448102108, 5090.41460232078, 4754.120487709784, 4961.677490963076, 5001.074801161797, 5017.974910125426, 5020.995800839846, 4943.555080042814, 4978.178600530944, 4984.601231901439, 5001.174806156943, 5036.345275114285, 4039.7374170678813, 4198.979005104955, 4217.97891010543, 4218.87343379693, 4266.31738921771, 3600.0459878132315, 3687.4100143976834, 3700.5929347771726, 3712.2204337089515, 3755.9248815023548, 4423.889402764957, 4437.844675436344, 4442.666799990014, 4479.350494178326, 4479.417675702138, 4912.066707325596, 5105.719185444762, 5108.948910510921, 5112.769925353368, 5162.586993040548, 4356.716813407118, 4400.955990440055, 4408.647308215335, 4413.801378937956, 4447.755373454426, 4511.571400716993, 4512.842050528216, 4515.0, 4519.525449827786, 4551.362809206714, 4642.814287428465, 4801.303810947324, 4804.2073057945045, 4804.855854324306, 4837.637177211724, 4982.925256121233, 5009.5491405773655, 5030.270610761346, 5055.140626093499, 5061.848144555669, 4766.523347665206, 4774.641901857444, 4777.689450185727, 4781.497942715965, 4825.469198388104, 4826.444958829779, 4925.507449255046, 4952.752362381939, 4962.5533701967, 5009.749512524287, 5001.374828146481, 5059.165237735732, 5089.541941225308, 5090.0, 5131.179011358165, 4946.8763280918265, 4949.406071271326, 4955.1823949048, 4958.677685950546, 5008.023435430202, 4741.668083234278, 4781.808727650855, 4820.421549414093, 4929.285253638131, 4994.650374473752, 4747.62019038483, 4768.356271903387, 4796.544328288807, 4859.538343857328, 4865.854024379274, 4908.852734417973, 4914.680545764657, 4959.479254678206, 4966.975165124151, 4967.279744436964, 4652.883677907944, 4655.23188673865, 4754.952450475451, 4800.207965685623, 4802.27965805132], "value": 4615.099496731926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6429003292876, 559.2533967153848, 571.9084946408573, 577.1804038265662, 579.4582065768507, 27907.302317442074, 30599.38801223977, 40007.599924000715, 40908.0, 40968.79515602425, 41565.792171039175, 41980.79009604947, 42006.57993420065, 42023.369649455206, 42040.57959420405, 7672.386209103258, 7816.960915195416, 7955.0, 7955.880661790078, 7958.681652733912, 7605.961970190141, 7842.333401660866, 7852.960735196345, 9937.205023598095, 10264.384136951769, 10298.691039268833, 10337.173026157889, 10342.844857327145, 10349.223808214376, 10378.377297362145, 10251.077403033763, 10298.279120461571, 10361.326513776581, 10367.0, 10378.0, 7645.9235407645765, 9794.069563391538, 10140.89859101407, 10147.746306342327, 10486.056254937015, 39424.802875985726, 39715.20569588592, 39723.0, 39789.20421591581, 39815.0, 2658.5746280595013, 2691.341417578296, 3033.8786448542032, 3182.9045128646176, 3188.3782662380845, 29669.554956675667, 30064.54903176454, 30233.546496802566, 30285.0, 30708.2322941926, 3084.0, 3123.8438078096233, 3144.276816332256, 3146.103360542257, 3156.226724452501, 261487.0, 261731.69134154398, 261782.0, 262846.0, 262915.0, 31691.20771980719, 32606.83696581502, 53028.73485632624, 53605.73197133989, 53624.73187634037, 33862.83068584641, 33924.49113263303, 33988.32023359519, 34062.0, 34068.0, 13804.0, 14045.0, 14051.367688454044, 14060.507882224074, 14061.78907316391, 9308.255339572817, 11400.486978086006, 11497.425128743529, 11503.539858405737, 11509.53961841517, 7735.883961740578, 7919.881201781978, 7947.841043179104, 8068.3948703847445, 8125.3499720022255, 3119.7192252696914, 3127.03062050765, 3145.418097651896, 3157.194915296585, 3160.936781264362, 828.8300898315831, 871.7951281448854, 878.1481962496368, 976.4531862157073, 982.3614650477105, 28378.716212837608, 28404.147875563765, 28424.857875710488, 28745.56881646777, 29054.564181537295, 945.8344789661782, 980.460746589373, 993.513178542509, 1010.7927874785652, 1069.2942657845786, 14599.270036498345, 14860.925695371454, 15155.924220378827, 15321.23393830304, 15348.846511534965, 378388.0, 381992.0, 383620.0, 385308.0, 387165.0, 50445.0, 51076.74461627668, 51094.23358649623, 51207.23189152091, 51244.231336529985, 1093.748437859297, 1160.6053941659877, 1169.3217933598323, 1178.8762179971322, 1230.772307123185, 28066.85966570154, 28985.855070724512, 29254.26864328409, 29283.56074658839, 29767.702322976493, 41459.0, 42184.36723449212, 42197.578024219365, 42202.36696449617, 42238.788806055774, 287015.0, 295929.0, 296305.0, 296375.0, 297380.0, 21697.34907952764, 24240.63639045451, 24940.75059249384, 25086.247412577653, 25233.621495677948, 42731.786341068095, 42741.14517709691, 42829.78585107055, 42920.35619465648, 43281.56718432775, 35837.0, 36116.0, 36242.8187859059, 36531.81734091313, 37111.44332835064, 35561.64438355583, 35778.463323049655, 36279.27441451209, 36459.27081458409, 36702.8164859174, 35244.823775880956, 35501.82249088738, 35809.82095089508, 35991.0, 36423.45364819583, 32018.0, 32565.7203995718, 32909.0, 33200.1699957503, 33365.16587085342, 24902.50194996126, 25196.622050668888, 25291.49417011686, 25577.488450231263, 25740.871295643403], "value": 16825.786924771313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.47129306040955, 352.5962772625345, 356.76988342519076, 362.8312834531942, 369.12149085177276, 16065.196740162988, 16157.434489792844, 17240.913795431006, 17242.56893577658, 17242.913785431087, 16241.83758162418, 16672.66654666909, 16823.66352672946, 17286.222120004597, 17287.82712172878, 4864.6837955532865, 5085.745712714368, 5092.414372347172, 5094.6688465249645, 5097.0315640028275, 4971.4034315882145, 5065.518775716301, 5106.489351064901, 5112.463191364909, 5116.155834287338, 5295.0733621616255, 5607.495325420711, 5613.270274864262, 5680.517156041741, 5692.686902220376, 5273.156294992821, 5529.170624406331, 5574.60977731559, 5629.240052592889, 5631.239782629334, 5208.515573061659, 5242.842714718565, 5258.132408152688, 5258.316418865523, 5258.447862974371, 12267.815982760265, 12324.81512777309, 12372.44324005422, 12487.625371238877, 12583.874161258453, 1746.6642875552668, 1836.109486898853, 1870.2799422222406, 1877.2584828992608, 1898.411492437349, 8740.125987401272, 9095.408798428147, 9484.33609647325, 9555.952220238923, 9619.615215391375, 1494.7907292978991, 1586.8889177757562, 1621.6756648670314, 1651.21971891375, 1663.0, 44389.55610443919, 60787.999999999556, 60885.69557152186, 64526.67736661334, 68828.6558567209, 9440.57517411718, 9463.432194068379, 10001.24990625706, 10096.192304615613, 10228.795424091477, 11258.324500529994, 12731.23612583248, 13679.0, 13939.790903136462, 13948.442062317394, 7344.30229128232, 7347.950600500839, 7383.926160738324, 7548.849023019508, 7582.658780354897, 7101.815674557602, 7218.133823941055, 7294.854102917912, 7320.414366850639, 7429.405647548291, 4270.50889147752, 4315.287977483743, 4381.3427985801745, 4397.31841564558, 4498.370228168059, 1699.405208177128, 1807.6384723055442, 1817.3457555280088, 1836.1278392763331, 1846.5937493751353, 762.9885551716728, 872.0799556467861, 878.3061381508537, 900.3157600223747, 910.8360495110811, 16105.355785768672, 16510.917445412695, 16877.915610422115, 17003.149842507824, 17517.386891458736, 856.7301300090452, 879.9736007919772, 884.2395539835736, 885.9291256699448, 887.2946007923716, 9343.672971445967, 9415.623375065057, 9571.664991725396, 9660.082292182231, 9876.753081173028, 395602.0, 397859.0, 404741.0, 404864.0, 407487.0, 47194.0, 72697.90953135707, 75961.24038759652, 76290.61854690692, 76803.61598192086, 896.3859756067114, 898.7303808857185, 907.4555266839975, 914.4924566865453, 918.9081091890891, 14965.176915269765, 15232.086074835544, 15373.846261537241, 15463.0, 15501.147436890627, 26615.46769064569, 33246.83376583102, 34867.47698784571, 35275.0, 36866.0, 45215.32177017281, 46639.30041049319, 47735.0, 48092.5190748102, 48168.0, 7225.5664660120565, 7469.253074692488, 7481.251874812693, 7568.4323675723435, 7587.279208475186, 9656.179224765692, 10967.725806854573, 11122.110231181648, 11183.888161118284, 11243.156763242627, 5709.51469125129, 6268.623882567061, 9447.905520944978, 9732.951335243279, 9788.363756355815, 9484.620615175592, 9954.45250511229, 10121.898781012096, 10232.232582556488, 10282.126019288444, 10064.69805905824, 10103.141232995278, 10166.390016599027, 10170.542325595217, 10504.157667117366, 7629.7329593463965, 7947.086085100287, 8111.514718434371, 8114.797130071795, 8134.186581341818, 7947.721829736162, 9299.395539289924, 10390.74023149397, 10393.9480302598, 10424.739381515219], "value": 7878.735665510624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.5177928828462, 1333.3599872061407, 1397.1547213935569, 1449.3912556726175, 1697.278656570957, 6490.578112422695, 7482.102147742272, 7699.846003079942, 7710.306072453478, 7862.213778622135, 7464.701411943529, 7675.04061992251, 7676.309132178103, 7679.846403071949, 7696.88454673179, 1840.8067152948947, 1873.1196337721317, 1876.8967706776123, 2112.9894350528266, 2150.7419109706857, 1871.915763790626, 2121.1727426303755, 2202.2072054060527, 2209.3924170852983, 2218.511927375983, 2151.236311109557, 2170.8806015669134, 2178.292055082097, 2179.2372669565684, 2182.8253739700785, 1806.3136008316887, 2133.6799480077957, 2140.8501404901663, 2144.345974477784, 2147.5382792699643, 2077.7091207231, 2136.572685462898, 2136.59404713104, 2145.0990583954776, 2153.192552792703, 7763.534187948741, 7772.650230739574, 7844.980152580128, 7855.332296754783, 7858.057033156001, 4474.530174331713, 4643.141018911479, 4645.024544845586, 4645.303204519315, 4659.347691323217, 2716.4567086582565, 2800.9019684311156, 2837.460882432352, 2839.0489186122672, 2874.439484300562, 828.6395417993132, 862.6549380247889, 880.5025160784137, 880.6917578847416, 902.4359775140537, 10482.79034419315, 10500.894991050069, 10517.526711297933, 10556.155507559377, 10581.576736930514, 4180.916381672349, 4212.073343864345, 4259.87220383389, 4288.785560721952, 4306.5262821089655, 8961.148690874486, 8970.686025989058, 8994.86507702385, 8997.415168014059, 8999.280057595377, 4571.885702857388, 4574.428196475441, 4576.450825900846, 4579.885502862388, 4583.633309335245, 3497.8076205808925, 3700.2414505026945, 4144.854930077433, 4209.494860616745, 4212.789360531961, 3524.8590056397456, 3623.2934577757082, 3672.5042119314085, 3672.889813305605, 3673.651003154696, 1080.9675709728563, 1087.5812812067252, 1098.6429410441638, 1114.8940850619178, 1148.9080873530097, 659.4065341192965, 775.8797386405116, 779.945403821727, 789.1674283630709, 814.311906439058, 4807.591354734886, 4913.778879950411, 4950.702957822542, 5006.69959802413, 5015.523525265094, 376.55378376623787, 380.3382115119672, 381.28889620856904, 392.28408155116455, 410.1653135868493, 3404.1829960809227, 3447.1382154461385, 3468.965310346864, 3471.392506311385, 3499.9650003500146, 9244.722658320261, 9554.904450955402, 9591.232701384011, 9601.279904007228, 9602.135807777333, 9398.483083430478, 9501.239900808057, 9520.809583808285, 9551.570179341947, 9554.761130971781, 7020.894686579705, 7070.823229419203, 7169.175544812309, 7172.82067948295, 7178.676959536833, 4874.366332376769, 4999.450060493416, 5078.162103252922, 5083.644144909821, 5122.513361230677, 8489.108643592333, 8733.694320698745, 8799.824003520022, 8812.559372031501, 8985.550722463982, 8719.825603487769, 8988.921329440509, 9005.234555062892, 9039.548022598976, 9048.90951090507, 5721.313442386941, 6008.459238668541, 6096.116063170904, 6435.646039467874, 6569.113169722026, 7391.371733402721, 7406.555606663617, 7431.442641801995, 7434.962825185839, 7485.850282994418, 6283.120363149072, 6332.683365831598, 6384.138141350858, 6408.102865598913, 6491.837704057436, 6377.744890204525, 6408.647524386203, 6445.677716114082, 6487.351264873475, 6498.447631951148, 6035.849103772441, 6067.726952287246, 6078.6048906820915, 6084.787032453843, 6094.39056094387, 4131.215069136854, 4252.702310838212, 4321.870343889688, 4395.7582332970715, 4408.625266852225, 4186.602272784081, 4328.43730315057, 4335.891602709831, 4356.976110613939, 4371.803268852846], "value": 3920.9802011382935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.455396132252, 291.6747826173816, 295.8446815421905, 295.88164734106346, 301.19280328719054, 4894.730789806559, 4916.508349165082, 4957.752112394384, 4959.7520123993745, 4969.403671559414, 4829.22732362822, 4833.767389315728, 4853.451937732692, 4870.02763880628, 4877.365942427479, 3571.910702232439, 3678.2275722098393, 3681.7606855554304, 3701.9629803702023, 3703.0557207911943, 3686.6221287269695, 3704.7962362070075, 3776.7356285060055, 3780.3006443807844, 3823.3500304948225, 3713.4801127842125, 3734.7198960077967, 3754.361758501048, 3755.568109667382, 3778.960785783918, 3642.21692336149, 3755.7746535207975, 3777.8111094445167, 3784.924301513968, 3801.163743976321, 3310.0235430548046, 3330.5670262865915, 3340.6325304216516, 3342.866285348583, 3346.8493917773517, 4669.603083737887, 4763.809447622091, 4775.641826863, 4787.521247875219, 4808.951910480921, 4316.740995540277, 4321.65426765858, 4333.414988976479, 4336.176126535979, 4352.434183556117, 4847.2729090636685, 5065.4174769901565, 5080.949190508085, 5097.541221290065, 5134.460881607452, 3577.3560759063357, 3580.943621631625, 3601.7213889069267, 3612.277544491112, 3612.638736126393, 5352.892942141136, 5371.4154324474375, 5396.892062158735, 5414.864628384283, 5424.945750542483, 3516.2791627716256, 3673.1000904778502, 3678.209185025179, 3684.5578530576504, 3689.9815500922323, 3716.0, 3717.683996860297, 3721.702263818888, 3731.384321586908, 3735.7758534488016, 4213.789310534522, 4275.572442755762, 4300.118475712471, 4305.56944305567, 4320.287152619845, 5016.197408414636, 5146.408163061221, 5152.093725321655, 5164.974175129176, 5205.9739701302005, 1278.5525066226746, 1281.5642681488152, 1286.0611753420055, 1293.812397202419, 1301.7982212757038, 798.8841617965362, 807.947483413588, 808.9393295502861, 836.3476488339105, 837.4807619276088, 4407.294832826732, 4507.323901414748, 4508.909821803545, 4510.774461276923, 4557.202489564313, 5180.663256888365, 5224.164133738584, 5233.345831771028, 5239.345081864767, 5243.0, 4454.443194600675, 4487.685861989629, 4503.3245013247615, 4512.187806194916, 4525.796339164745, 2730.3447172678416, 2799.6080548723194, 2809.7241234600037, 2817.1266907258814, 2826.1945345576823, 4942.406911170682, 4953.43035550909, 4964.673668642018, 4999.550130462198, 5009.7495125243595, 5209.270702101709, 5363.383210930715, 5410.594205434608, 5421.241026256327, 5427.565794736491, 4945.381827271591, 4963.907940253211, 4966.453690094087, 4971.0115953618115, 4992.850214493571, 5253.816116435906, 5269.209618557247, 5291.788328466972, 5308.336457942757, 5308.575313974796, 4999.0501804657, 5111.795528178831, 5138.743062846768, 5187.221916712523, 5203.973980130075, 4901.656884018084, 4907.165781817171, 4925.113479573568, 4937.604991600735, 4979.609787302043, 3670.467782171517, 3671.0, 3677.135873069773, 3677.3013127505687, 3679.632036796299, 4990.775415106256, 5239.816606418757, 5312.0969435196885, 5322.467753224647, 5352.250684904038, 5098.413682426569, 5113.693178409308, 5123.180291153398, 5127.333446651912, 5129.923051154161, 5076.5177308157145, 5088.59291256706, 5098.872528186676, 5111.769970351417, 5145.687849598328, 4787.0, 5018.824341148043, 5023.824166154167, 5053.67151135175, 5061.962297728883, 4866.367372241586, 5020.42265139499, 5133.358330208724, 5170.793168273227, 5193.870153246199, 5078.577998160521, 5086.745662716776, 5089.618278629044, 5090.2003897856775, 5090.796368145233], "value": 3830.0887004369492, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.8598521391832, 540.7080176704579, 555.0453220460806, 579.4408395897959, 584.1150656755015, 10795.08241799447, 11250.212485126045, 11258.268212566189, 11571.0, 11620.302781833096, 10891.782164356728, 11799.410029498513, 12078.456469458873, 12080.395980201, 12097.092718046139, 620.1813606040029, 763.5876626621617, 769.7382889817447, 786.3591173193857, 788.8264581791997, 788.8185717285028, 793.6507936507946, 794.3168874767724, 794.5749024272016, 794.7695168401157, 836.2515548584014, 840.6175190288435, 841.4068082002174, 841.5119230846094, 842.0316635868769, 656.8916128838736, 795.0657976877146, 800.2637573432427, 801.286854699318, 811.9837603247961, 595.1043679262725, 595.4402861310398, 595.8540157661357, 595.8629515211526, 596.0790578556141, 11373.943130284295, 11388.0, 11394.373309467976, 11404.54381824726, 11409.20135590509, 11351.943240283828, 11689.590864319707, 11843.289402635783, 12014.159008869383, 12245.571405000872, 10399.48002599867, 10480.737981550446, 10492.790144197073, 10667.19996000303, 11038.834417483744, 4060.634542891154, 4095.9795201024103, 4099.528554216274, 4233.0, 4282.743035417854, 60549.69725151346, 61006.69496652488, 61439.38560614381, 62607.06089408662, 62675.0, 8895.644174232959, 8942.68700595476, 9079.228265597367, 9305.162535371848, 9410.858837117448, 18346.266149353876, 18418.723719144222, 18494.0752962354, 18683.15925783343, 18713.345032923782, 6305.085762564402, 6366.076918846741, 6451.225852897683, 6520.5435619507125, 6577.276499585042, 3577.284543091392, 3648.7810731356203, 3667.8716244931297, 3706.79612621303, 3746.2132952079824, 2611.9216423507323, 2673.224764818181, 2685.9059932902255, 2691.300261931912, 2691.757741803247, 458.94722106958125, 461.6606794006403, 467.68431308866377, 468.2110643565603, 470.7904982282851, 432.3234138573123, 481.37661728062244, 498.81294514557044, 521.8877941242652, 556.8385168301228, 7404.851902961911, 7431.368333691588, 7461.776146715607, 7497.10034795828, 7793.337566306814, 433.01625049544316, 482.25973131244075, 482.8816939849759, 495.40798745498785, 527.686026814045, 3400.608929973035, 3517.9472307915403, 3547.2018795770746, 3568.2506673598837, 3581.8567257309937, 59152.0, 88779.11220887837, 93270.53364733269, 97851.0, 101273.49363253136, 55324.0, 85772.57113714391, 86134.0, 87041.56479217563, 89359.55320223357, 49815.25277120846, 61335.69332153311, 76924.0, 79346.0, 80938.19061809307, 7383.07711536058, 7451.552906825608, 7530.887036694564, 7684.5773482459, 7849.686012559434, 30939.535906960962, 31703.0, 38323.616763832004, 39132.0, 41272.79363603163, 55208.44791552194, 58338.416615835, 58818.411815883, 59635.403645962986, 59686.70156649189, 9924.503774811375, 10842.1210455297, 10898.400587967737, 10930.781384372109, 11152.888471115184, 11471.655850324503, 11816.881831181578, 12045.217060891015, 12205.084618653815, 12466.252024878537, 10439.164866810484, 10541.894581054397, 10550.736231593964, 11087.0, 11213.15901307389, 10683.30558513694, 10806.621768238074, 10811.29726567802, 10838.67483975482, 10899.569254140095, 10248.38509689421, 10285.897141028494, 10504.579816807242, 10514.947425262824, 10641.255112142077, 8356.122607126408, 8367.790805229675, 8439.873401898854, 8667.219950204511, 8837.690680826141, 8017.436132204117, 8036.1160272368825, 8036.4776289541, 8117.715879944174, 8257.545834979133], "value": 6086.105972639072, "unit": "score"}], "name": "dromaeo_css", "value": 6183.972106554718, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 115.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 139.0, 192.0, 130.0, 154.0, 157.0, 131.0, 199.0, 132.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 164.0, 161.0, 169.0, 160.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 121.0, 75.0, 76.0, 75.0, 75.0, 108.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 114.0, 87.0, 87.0, 86.0, 119.0, 86.0, 87.0, 135.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 63.0, 62.0, 62.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 91.0, 88.0, 85.0, 85.0, 85.0, 121.0, 86.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 128.0, 140.0, 132.0, 143.0, 130.0, 131.0, 140.0, 135.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 171.0, 167.0, 167.0, 165.0, 166.0, 166.0, 167.0, 163.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 79.0, 66.0, 71.0, 67.0, 65.0, 66.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1554.9999999999998, "alertThreshold": 2.0}]} 09:01:12 INFO - Return code: 0 09:01:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:12 ERROR - # TBPL SUCCESS # 09:01:12 INFO - Running post-action listener: _resource_record_post_action 09:01:12 INFO - ##### 09:01:12 INFO - ##### Finished run-tests step (success) 09:01:12 INFO - ##### 09:01:12 INFO - Running post-run listener: _resource_record_post_run 09:01:12 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535052288; Read time: 20; Write time: 444084 09:01:12 INFO - TinderboxPrint: CPU usage
13.1% 09:01:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 09:01:12 INFO - TinderboxPrint: I/O write bytes / time
535,052,288 / 444,084 09:01:12 INFO - TinderboxPrint: CPU idle
8,323.2 (86.8%) 09:01:12 INFO - TinderboxPrint: CPU user
1,214.6 (12.7%) 09:01:12 INFO - TinderboxPrint: Swap in / out
0 / 0 09:01:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237629440; Read time: 0; Write time: 218848 09:01:12 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297242624; Read time: 20; Write time: 225236 09:01:12 INFO - Running post-run listener: _upload_blobber_files 09:01:12 INFO - Blob upload gear active. 09:01:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:12 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 09:01:12 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'] 09:01:12 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 09:01:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:14 INFO - (blobuploader) - INFO - Done attempting. 09:01:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:18 INFO - (blobuploader) - INFO - Done attempting. 09:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:19 INFO - (blobuploader) - INFO - Done attempting. 09:01:19 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:19 INFO - Return code: 0 09:01:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d45727f0e8566f172b52614695df8cf55e232f6ab00e1ce16f06636b59e4b76dd561e65f8d1fa5ad6eea2f796e666d954639f18d8f4c050129c87d866855d8f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/208616d10869402ac53006aa7146a2695e9cf56f93c0712c44dc71566f02febcf0fac2672d6f57b670bb16de59c7f008843b154cf916b72aaef3618394bcda71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7468787e7bcf9439a1689d2d6610b5056f7eca98711740ed1b95bf5b2521d31287d463ee2f9e4fb0ae8280276eaffd1eb75a583b87c4f6373f1e1ee75111576e"} 09:01:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:19 INFO - Contents: 09:01:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d45727f0e8566f172b52614695df8cf55e232f6ab00e1ce16f06636b59e4b76dd561e65f8d1fa5ad6eea2f796e666d954639f18d8f4c050129c87d866855d8f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/208616d10869402ac53006aa7146a2695e9cf56f93c0712c44dc71566f02febcf0fac2672d6f57b670bb16de59c7f008843b154cf916b72aaef3618394bcda71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7468787e7bcf9439a1689d2d6610b5056f7eca98711740ed1b95bf5b2521d31287d463ee2f9e4fb0ae8280276eaffd1eb75a583b87c4f6373f1e1ee75111576e"} 09:01:19 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:19 INFO - Copying logs to upload dir... 09:01:19 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.773949 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-09 09:01:18.561878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:01:18.568990) ========= 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=232498196343f89f466a4a9a000001c8-1465486830.849345-806973890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d45727f0e8566f172b52614695df8cf55e232f6ab00e1ce16f06636b59e4b76dd561e65f8d1fa5ad6eea2f796e666d954639f18d8f4c050129c87d866855d8f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/208616d10869402ac53006aa7146a2695e9cf56f93c0712c44dc71566f02febcf0fac2672d6f57b670bb16de59c7f008843b154cf916b72aaef3618394bcda71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7468787e7bcf9439a1689d2d6610b5056f7eca98711740ed1b95bf5b2521d31287d463ee2f9e4fb0ae8280276eaffd1eb75a583b87c4f6373f1e1ee75111576e"} build_url:https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/BB17g3F7TNSdm9dHM7T7BA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d45727f0e8566f172b52614695df8cf55e232f6ab00e1ce16f06636b59e4b76dd561e65f8d1fa5ad6eea2f796e666d954639f18d8f4c050129c87d866855d8f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/208616d10869402ac53006aa7146a2695e9cf56f93c0712c44dc71566f02febcf0fac2672d6f57b670bb16de59c7f008843b154cf916b72aaef3618394bcda71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7468787e7bcf9439a1689d2d6610b5056f7eca98711740ed1b95bf5b2521d31287d463ee2f9e4fb0ae8280276eaffd1eb75a583b87c4f6373f1e1ee75111576e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 09:01:18.601356) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:01:18.601721) ========= 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=232498196343f89f466a4a9a000001c8-1465486830.849345-806973890 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 09:01:18.683288) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:01:18.686708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 09:01:18.687064) ========= ========= Total master_lag: 0.17 =========