builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1466764230.12 results: success (0) buildid: 20160624021358 builduid: bd0a5a4b9424469e990508583acf8ef3 revision: 34e0a985d93d88be6058db05071121decf373c97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.117484) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.118056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.118571) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.134061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.134362) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 03:30:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.7M=0s 2016-06-24 03:30:30 (88.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.236084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.236431) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015222 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.286200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.286584) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 34e0a985d93d88be6058db05071121decf373c97 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 34e0a985d93d88be6058db05071121decf373c97 --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=03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 03:30:30,732 truncating revision to first 12 chars 2016-06-24 03:30:30,732 Setting DEBUG logging. 2016-06-24 03:30:30,732 attempt 1/10 2016-06-24 03:30:30,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/34e0a985d93d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 03:30:31,057 unpacking tar archive at: mozilla-central-34e0a985d93d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.957069) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.957391) ========= script_repo_revision: 34e0a985d93d88be6058db05071121decf373c97 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.957781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.958064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 03:30:30.967294) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-24 03:30:30.967702) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:31 INFO - MultiFileLogger online at 20160624 03:30:31 in /builds/slave/test 03:30:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:30:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:31 INFO - {'append_to_log': False, 03:30:31 INFO - 'base_work_dir': '/builds/slave/test', 03:30:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:30:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:31 INFO - 'branch': 'Firefox-Non-PGO', 03:30:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:31 INFO - 'config_files': ('talos/linux_config.py',), 03:30:31 INFO - 'default_actions': ('clobber', 03:30:31 INFO - 'read-buildbot-config', 03:30:31 INFO - 'download-and-extract', 03:30:31 INFO - 'populate-webroot', 03:30:31 INFO - 'create-virtualenv', 03:30:31 INFO - 'install', 03:30:31 INFO - 'run-tests'), 03:30:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:31 INFO - 'download_minidump_stackwalk': True, 03:30:31 INFO - 'download_symbols': 'ondemand', 03:30:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:31 INFO - 'installer_path': 'installer.exe', 03:30:31 INFO - 'log_level': 'info', 03:30:31 INFO - 'log_name': 'talos', 03:30:31 INFO - 'log_to_console': True, 03:30:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:31 INFO - 'opt_config_files': (), 03:30:31 INFO - 'pip_index': False, 03:30:31 INFO - 'sps_profile': False, 03:30:31 INFO - 'sps_profile_interval': 0, 03:30:31 INFO - 'suite': 'dromaeojs', 03:30:31 INFO - 'system_bits': '32', 03:30:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:31 INFO - 'title': 'talos-linux64-ix-047', 03:30:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:31 INFO - 'use_talos_json': True, 03:30:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:31 INFO - 'work_dir': 'build'} 03:30:31 INFO - ##### 03:30:31 INFO - ##### Running clobber step. 03:30:31 INFO - ##### 03:30:31 INFO - Running pre-action listener: _resource_record_pre_action 03:30:31 INFO - Running main action method: clobber 03:30:31 INFO - rmtree: /builds/slave/test/build 03:30:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:32 INFO - Running post-action listener: _resource_record_post_action 03:30:32 INFO - ##### 03:30:32 INFO - ##### Finished clobber step (success) 03:30:32 INFO - ##### 03:30:32 INFO - ##### 03:30:32 INFO - ##### Running read-buildbot-config step. 03:30:32 INFO - ##### 03:30:32 INFO - Running pre-action listener: _resource_record_pre_action 03:30:32 INFO - Running main action method: read_buildbot_config 03:30:32 INFO - Using buildbot properties: 03:30:32 INFO - { 03:30:32 INFO - "project": "", 03:30:32 INFO - "product": "firefox", 03:30:32 INFO - "script_repo_revision": "production", 03:30:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:30:32 INFO - "repository": "", 03:30:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:30:32 INFO - "buildid": "20160624021358", 03:30:32 INFO - "pgo_build": "False", 03:30:32 INFO - "basedir": "/builds/slave/test", 03:30:32 INFO - "buildnumber": 618, 03:30:32 INFO - "slavename": "talos-linux64-ix-047", 03:30:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:30:32 INFO - "platform": "ubuntu64_hw", 03:30:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:30:32 INFO - "branch": "mozilla-central", 03:30:32 INFO - "repo_path": "mozilla-central", 03:30:32 INFO - "revision": "34e0a985d93d88be6058db05071121decf373c97", 03:30:32 INFO - "stage_platform": "linux64", 03:30:32 INFO - "builduid": "bd0a5a4b9424469e990508583acf8ef3", 03:30:32 INFO - "slavebuilddir": "test" 03:30:32 INFO - } 03:30:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:30:32 INFO - Running post-action listener: _resource_record_post_action 03:30:32 INFO - ##### 03:30:32 INFO - ##### Finished read-buildbot-config step (success) 03:30:32 INFO - ##### 03:30:32 INFO - ##### 03:30:32 INFO - ##### Running download-and-extract step. 03:30:32 INFO - ##### 03:30:32 INFO - Running pre-action listener: _resource_record_pre_action 03:30:32 INFO - Running main action method: download_and_extract 03:30:32 INFO - mkdir: /builds/slave/test/build/tests 03:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:32 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:32 INFO - Downloaded 1361 bytes. 03:30:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:32 INFO - Using the following test package requirements: 03:30:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:30:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'jsshell-linux-x86_64.zip'], 03:30:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:30:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:30:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:32 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:33 INFO - Downloaded 22709610 bytes. 03:30:33 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'] 03:30:33 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 03:30:35 INFO - Return code: 0 03:30:35 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 03:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:35 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:36 INFO - Downloaded 22709610 bytes. 03:30:36 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'] 03:30:36 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 03:30:37 INFO - Return code: 0 03:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:37 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:38 INFO - Downloaded 14405384 bytes. 03:30:38 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'] 03:30:38 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 03:30:38 INFO - Return code: 0 03:30:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:38 INFO - https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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 03:30:40 INFO - Downloaded 56252982 bytes. 03:30:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:40 INFO - mkdir: /builds/slave/test/properties 03:30:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:40 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:40 INFO - Contents: 03:30:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:41 INFO - Running post-action listener: _resource_record_post_action 03:30:41 INFO - Running post-action listener: set_extra_try_arguments 03:30:41 INFO - ##### 03:30:41 INFO - ##### Finished download-and-extract step (success) 03:30:41 INFO - ##### 03:30:41 INFO - ##### 03:30:41 INFO - ##### Running populate-webroot step. 03:30:41 INFO - ##### 03:30:41 INFO - Running pre-action listener: _resource_record_pre_action 03:30:41 INFO - Running main action method: populate_webroot 03:30:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:41 INFO - '--tppagecycles', 03:30:41 INFO - '7'], 03:30:41 INFO - 'tests': ['tsvgm']}}, 03:30:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['damp', 'tps']}, 03:30:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'tests': ['damp', 'tps']}, 03:30:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['dromaeo_dom']}, 03:30:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['basic_compositor_video']}, 03:30:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:30:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['a11yr', 03:30:41 INFO - 'ts_paint', 03:30:41 INFO - 'tpaint', 03:30:41 INFO - 'sessionrestore', 03:30:41 INFO - 'sessionrestore_no_auto_restore', 03:30:41 INFO - 'tabpaint']}, 03:30:41 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:41 INFO - 'ts_paint', 03:30:41 INFO - 'tpaint', 03:30:41 INFO - 'sessionrestore', 03:30:41 INFO - 'sessionrestore_no_auto_restore', 03:30:41 INFO - 'tabpaint']}, 03:30:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:41 INFO - 'ts_paint', 03:30:41 INFO - 'tpaint', 03:30:41 INFO - 'sessionrestore', 03:30:41 INFO - 'sessionrestore_no_auto_restore', 03:30:41 INFO - 'tabpaint']}, 03:30:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:41 INFO - 'ts_paint', 03:30:41 INFO - 'tpaint', 03:30:41 INFO - 'sessionrestore', 03:30:41 INFO - 'sessionrestore_no_auto_restore', 03:30:41 INFO - 'tabpaint']}, 03:30:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['a11yr', 03:30:41 INFO - 'ts_paint', 03:30:41 INFO - 'tpaint', 03:30:41 INFO - 'sessionrestore', 03:30:41 INFO - 'sessionrestore_no_auto_restore', 03:30:41 INFO - 'tabpaint']}, 03:30:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['a11yr', 03:30:41 INFO - 'ts_paint', 03:30:41 INFO - 'tpaint', 03:30:41 INFO - 'sessionrestore', 03:30:41 INFO - 'sessionrestore_no_auto_restore', 03:30:41 INFO - 'tabpaint']}, 03:30:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['tsvgx', 03:30:41 INFO - 'tsvgr_opacity', 03:30:41 INFO - 'tart', 03:30:41 INFO - 'tscrollx', 03:30:41 INFO - 'cart']}, 03:30:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:41 INFO - 'tsvgr_opacity', 03:30:41 INFO - 'tart', 03:30:41 INFO - 'tscrollx', 03:30:41 INFO - 'cart']}, 03:30:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'talos_options': ['--disable-e10s'], 03:30:41 INFO - 'tests': ['tp5o']}, 03:30:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'tests': ['tp5o']}, 03:30:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'talos_options': ['--disable-e10s', 03:30:41 INFO - '--xperf_path', 03:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:41 INFO - 'tests': ['tp5n']}, 03:30:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:41 INFO - 'talos_options': ['--xperf_path', 03:30:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:41 INFO - 'tests': ['tp5n']}}, 03:30:41 INFO - 'talos.zip': {'path': '', 03:30:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:41 INFO - Running post-action listener: _resource_record_post_action 03:30:41 INFO - ##### 03:30:41 INFO - ##### Finished populate-webroot step (success) 03:30:41 INFO - ##### 03:30:41 INFO - ##### 03:30:41 INFO - ##### Running create-virtualenv step. 03:30:41 INFO - ##### 03:30:41 INFO - Running pre-action listener: _resource_record_pre_action 03:30:41 INFO - Running main action method: create_virtualenv 03:30:41 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:41 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 03:30:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:41 INFO - Using real prefix '/usr' 03:30:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:42 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:44 INFO - Installing pip.................done. 03:30:44 INFO - Return code: 0 03:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:44 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:30:44 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 03:30:44 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 03:30:44 INFO - Using env: {'DISPLAY': ':0', 03:30:44 INFO - 'HOME': '/home/cltbld', 03:30:44 INFO - 'LANG': 'en_US.UTF-8', 03:30:44 INFO - 'LANGUAGE': 'en_US:en', 03:30:44 INFO - 'LOGNAME': 'cltbld', 03:30:44 INFO - 'MAIL': '/var/mail/cltbld', 03:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:44 INFO - 'MOZ_NO_REMOTE': '1', 03:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:44 INFO - 'NO_EM_RESTART': '1', 03:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:44 INFO - 'PWD': '/builds/slave/test', 03:30:44 INFO - 'SHELL': '/bin/bash', 03:30:44 INFO - 'SHLVL': '1', 03:30:44 INFO - 'TERM': 'linux', 03:30:44 INFO - 'TMOUT': '86400', 03:30:44 INFO - 'USER': 'cltbld', 03:30:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:44 INFO - '_': '/tools/buildbot/bin/python'} 03:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:44 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 03:30:44 INFO - Cleaning up... 03:30:44 INFO - Return code: 0 03:30:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:44 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:30:44 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 03:30:44 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 03:30:44 INFO - Using env: {'DISPLAY': ':0', 03:30:44 INFO - 'HOME': '/home/cltbld', 03:30:44 INFO - 'LANG': 'en_US.UTF-8', 03:30:44 INFO - 'LANGUAGE': 'en_US:en', 03:30:44 INFO - 'LOGNAME': 'cltbld', 03:30:44 INFO - 'MAIL': '/var/mail/cltbld', 03:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:44 INFO - 'MOZ_NO_REMOTE': '1', 03:30:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:44 INFO - 'NO_EM_RESTART': '1', 03:30:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:44 INFO - 'PWD': '/builds/slave/test', 03:30:44 INFO - 'SHELL': '/bin/bash', 03:30:44 INFO - 'SHLVL': '1', 03:30:44 INFO - 'TERM': 'linux', 03:30:44 INFO - 'TMOUT': '86400', 03:30:44 INFO - 'USER': 'cltbld', 03:30:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:44 INFO - '_': '/tools/buildbot/bin/python'} 03:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:44 INFO - Downloading/unpacking psutil>=3.1.1 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:44 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 03:30:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:46 INFO - Installing collected packages: psutil 03:30:46 INFO - Running setup.py install for psutil 03:30:46 INFO - building 'psutil._psutil_linux' extension 03:30:46 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 03:30:46 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 03:30:46 INFO - building 'psutil._psutil_posix' extension 03:30:46 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 03:30:46 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 03:30:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:47 INFO - Successfully installed psutil 03:30:47 INFO - Cleaning up... 03:30:47 INFO - Return code: 0 03:30:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30:47 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')]} 03:30:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:47 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')]} 03:30:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:47 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:30:47 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 03:30:47 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 03:30:47 INFO - Using env: {'DISPLAY': ':0', 03:30:47 INFO - 'HOME': '/home/cltbld', 03:30:47 INFO - 'LANG': 'en_US.UTF-8', 03:30:47 INFO - 'LANGUAGE': 'en_US:en', 03:30:47 INFO - 'LOGNAME': 'cltbld', 03:30:47 INFO - 'MAIL': '/var/mail/cltbld', 03:30:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:47 INFO - 'MOZ_NO_REMOTE': '1', 03:30:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:47 INFO - 'NO_EM_RESTART': '1', 03:30:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:47 INFO - 'PWD': '/builds/slave/test', 03:30:47 INFO - 'SHELL': '/bin/bash', 03:30:47 INFO - 'SHLVL': '1', 03:30:47 INFO - 'TERM': 'linux', 03:30:47 INFO - 'TMOUT': '86400', 03:30:47 INFO - 'USER': 'cltbld', 03:30:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:30:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:47 INFO - '_': '/tools/buildbot/bin/python'} 03:30:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:47 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 03:30:47 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 03:30:47 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 03:30:47 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 03:30:47 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 03:30:47 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 03:30:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:49 INFO - Installing collected packages: mozsystemmonitor 03:30:49 INFO - Running setup.py install for mozsystemmonitor 03:30:49 INFO - Successfully installed mozsystemmonitor 03:30:49 INFO - Cleaning up... 03:30:49 INFO - Return code: 0 03:30:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:30: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:30: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 jsonschema==2.5.1 03:30:49 INFO - Using env: {'DISPLAY': ':0', 03:30:49 INFO - 'HOME': '/home/cltbld', 03:30:49 INFO - 'LANG': 'en_US.UTF-8', 03:30:49 INFO - 'LANGUAGE': 'en_US:en', 03:30:49 INFO - 'LOGNAME': 'cltbld', 03:30:49 INFO - 'MAIL': '/var/mail/cltbld', 03:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:49 INFO - 'MOZ_NO_REMOTE': '1', 03:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:49 INFO - 'NO_EM_RESTART': '1', 03:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:49 INFO - 'PWD': '/builds/slave/test', 03:30:49 INFO - 'SHELL': '/bin/bash', 03:30:49 INFO - 'SHLVL': '1', 03:30:49 INFO - 'TERM': 'linux', 03:30:49 INFO - 'TMOUT': '86400', 03:30:49 INFO - 'USER': 'cltbld', 03:30:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:49 INFO - '_': '/tools/buildbot/bin/python'} 03:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:51 INFO - warning: no files found matching '*.txt' 03:30:51 INFO - no previously-included directories found matching 'build' 03:30:51 INFO - no previously-included directories found matching 'dist' 03:30:51 INFO - no previously-included directories found matching '.git*' 03:30:51 INFO - Installing collected packages: jsonschema, functools32 03:30:51 INFO - Running setup.py install for functools32 03:30:51 INFO - warning: no files found matching '*.txt' 03:30:51 INFO - no previously-included directories found matching 'build' 03:30:51 INFO - no previously-included directories found matching 'dist' 03:30:51 INFO - no previously-included directories found matching '.git*' 03:30:52 INFO - Successfully installed jsonschema functools32 03:30:52 INFO - Cleaning up... 03:30:52 INFO - Return code: 0 03:30:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:30: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 blobuploader==1.2.4 03:30:52 INFO - Using env: {'DISPLAY': ':0', 03:30:52 INFO - 'HOME': '/home/cltbld', 03:30:52 INFO - 'LANG': 'en_US.UTF-8', 03:30:52 INFO - 'LANGUAGE': 'en_US:en', 03:30:52 INFO - 'LOGNAME': 'cltbld', 03:30:52 INFO - 'MAIL': '/var/mail/cltbld', 03:30:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:52 INFO - 'MOZ_NO_REMOTE': '1', 03:30:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:52 INFO - 'NO_EM_RESTART': '1', 03:30:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:52 INFO - 'PWD': '/builds/slave/test', 03:30:52 INFO - 'SHELL': '/bin/bash', 03:30:52 INFO - 'SHLVL': '1', 03:30:52 INFO - 'TERM': 'linux', 03:30:52 INFO - 'TMOUT': '86400', 03:30:52 INFO - 'USER': 'cltbld', 03:30:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:30:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:52 INFO - '_': '/tools/buildbot/bin/python'} 03:30:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:54 INFO - Downloading docopt-0.6.1.tar.gz 03:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:54 INFO - Running setup.py install for blobuploader 03:30:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:55 INFO - Running setup.py install for requests 03:30:55 INFO - Running setup.py install for docopt 03:30:55 INFO - Successfully installed blobuploader requests docopt 03:30:55 INFO - Cleaning up... 03:30:55 INFO - Return code: 0 03:30:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:55 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:30:55 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 03:30:55 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 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:55 INFO - Running setup.py (path:/tmp/pip-zrNokx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:55 INFO - Running setup.py (path:/tmp/pip-Gw0Z_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:55 INFO - Running setup.py (path:/tmp/pip-O9blD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:55 INFO - Running setup.py (path:/tmp/pip-42HmRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:56 INFO - Running setup.py (path:/tmp/pip-2hDGBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:56 INFO - Running setup.py (path:/tmp/pip-wu5Sd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:56 INFO - Running setup.py (path:/tmp/pip-2O4u1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:56 INFO - Running setup.py (path:/tmp/pip-zi68BG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:56 INFO - Running setup.py (path:/tmp/pip-Y9a2Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:56 INFO - Running setup.py (path:/tmp/pip-18WlnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:56 INFO - Running setup.py (path:/tmp/pip-hERnA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:56 INFO - Running setup.py (path:/tmp/pip-NNCJzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:56 INFO - Running setup.py (path:/tmp/pip-upZ2jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:56 INFO - Running setup.py (path:/tmp/pip-WDubaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:56 INFO - Running setup.py (path:/tmp/pip-H4OQ1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:56 INFO - Running setup.py (path:/tmp/pip-JQB5Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:56 INFO - Running setup.py (path:/tmp/pip-wOkboF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:56 INFO - Running setup.py install for manifestparser 03:30:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozcrash 03:30:57 INFO - Running setup.py install for mozdebug 03:30:57 INFO - Running setup.py install for mozdevice 03:30:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozfile 03:30:57 INFO - Running setup.py install for mozhttpd 03:30:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozinfo 03:30:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozInstall 03:30:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for mozleak 03:30:57 INFO - Running setup.py install for mozlog 03:30:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:57 INFO - Running setup.py install for moznetwork 03:30:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:58 INFO - Running setup.py install for mozprocess 03:30:58 INFO - Running setup.py install for mozprofile 03:30:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:58 INFO - Running setup.py install for mozrunner 03:30:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:58 INFO - Running setup.py install for mozscreenshot 03:30:58 INFO - Running setup.py install for moztest 03:30:58 INFO - Running setup.py install for mozversion 03:30:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:58 INFO - Cleaning up... 03:30:58 INFO - Return code: 0 03:30:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:58 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:30:58 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 03:30:58 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 03:30:58 INFO - Using env: {'DISPLAY': ':0', 03:30:58 INFO - 'HOME': '/home/cltbld', 03:30:58 INFO - 'LANG': 'en_US.UTF-8', 03:30:58 INFO - 'LANGUAGE': 'en_US:en', 03:30:58 INFO - 'LOGNAME': 'cltbld', 03:30:58 INFO - 'MAIL': '/var/mail/cltbld', 03:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:58 INFO - 'MOZ_NO_REMOTE': '1', 03:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:58 INFO - 'NO_EM_RESTART': '1', 03:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:58 INFO - 'PWD': '/builds/slave/test', 03:30:58 INFO - 'SHELL': '/bin/bash', 03:30:58 INFO - 'SHLVL': '1', 03:30:58 INFO - 'TERM': 'linux', 03:30:58 INFO - 'TMOUT': '86400', 03:30:58 INFO - 'USER': 'cltbld', 03:30:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:58 INFO - '_': '/tools/buildbot/bin/python'} 03:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:58 INFO - Running setup.py (path:/tmp/pip-EjAV2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:59 INFO - Running setup.py (path:/tmp/pip-JJHble-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:59 INFO - Running setup.py (path:/tmp/pip-Kiw735-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:59 INFO - Running setup.py (path:/tmp/pip-_u_yGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:59 INFO - Running setup.py (path:/tmp/pip-8oOWGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:59 INFO - Running setup.py (path:/tmp/pip-MyqaIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:59 INFO - Running setup.py (path:/tmp/pip-VlIWmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:59 INFO - Running setup.py (path:/tmp/pip-XVVn_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:59 INFO - Running setup.py (path:/tmp/pip-ItqsKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:59 INFO - Running setup.py (path:/tmp/pip-ueSrej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:59 INFO - Running setup.py (path:/tmp/pip-KA8jvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:59 INFO - Running setup.py (path:/tmp/pip-wy6XwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:59 INFO - Running setup.py (path:/tmp/pip-Gcc30w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:59 INFO - Running setup.py (path:/tmp/pip-nZ9ToO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:59 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)) 03:30:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:59 INFO - Running setup.py (path:/tmp/pip-2Xjc5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:31:00 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)) 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:31:00 INFO - Running setup.py (path:/tmp/pip-fA1mt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:31:00 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)) 03:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:31:00 INFO - Running setup.py (path:/tmp/pip-CUjujV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:31:00 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)) 03:31:00 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)) 03:31:00 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)) 03:31:00 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)) 03:31:00 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)) 03:31:00 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)) 03:31:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:31:02 INFO - Downloading blessings-1.6.tar.gz 03:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:31:02 INFO - Installing collected packages: blessings 03:31:02 INFO - Running setup.py install for blessings 03:31:02 INFO - Successfully installed blessings 03:31:02 INFO - Cleaning up... 03:31:02 INFO - Return code: 0 03:31:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:31:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:02 INFO - Reading from file tmpfile_stdout 03:31:02 INFO - Current package versions: 03:31:02 INFO - argparse == 1.2.1 03:31:02 INFO - blessings == 1.6 03:31:02 INFO - blobuploader == 1.2.4 03:31:02 INFO - docopt == 0.6.1 03:31:02 INFO - functools32 == 3.2.3-2 03:31:02 INFO - jsonschema == 2.5.1 03:31:02 INFO - manifestparser == 1.1 03:31:02 INFO - mozInstall == 1.12 03:31:02 INFO - mozcrash == 0.17 03:31:02 INFO - mozdebug == 0.1 03:31:02 INFO - mozdevice == 0.48 03:31:02 INFO - mozfile == 1.2 03:31:02 INFO - mozhttpd == 0.7 03:31:02 INFO - mozinfo == 0.9 03:31:02 INFO - mozleak == 0.1 03:31:02 INFO - mozlog == 3.2 03:31:02 INFO - moznetwork == 0.27 03:31:02 INFO - mozprocess == 0.22 03:31:02 INFO - mozprofile == 0.28 03:31:02 INFO - mozrunner == 6.11 03:31:02 INFO - mozscreenshot == 0.1 03:31:02 INFO - mozsystemmonitor == 0.3 03:31:02 INFO - moztest == 0.7 03:31:02 INFO - mozversion == 1.4 03:31:02 INFO - psutil == 3.1.1 03:31:02 INFO - requests == 1.2.3 03:31:02 INFO - wsgiref == 0.1.2 03:31:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:02 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:31:02 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 03:31:02 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 03:31:02 INFO - Using env: {'DISPLAY': ':0', 03:31:02 INFO - 'HOME': '/home/cltbld', 03:31:02 INFO - 'LANG': 'en_US.UTF-8', 03:31:02 INFO - 'LANGUAGE': 'en_US:en', 03:31:02 INFO - 'LOGNAME': 'cltbld', 03:31:02 INFO - 'MAIL': '/var/mail/cltbld', 03:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:02 INFO - 'MOZ_NO_REMOTE': '1', 03:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:02 INFO - 'NO_EM_RESTART': '1', 03:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:02 INFO - 'PWD': '/builds/slave/test', 03:31:02 INFO - 'SHELL': '/bin/bash', 03:31:02 INFO - 'SHLVL': '1', 03:31:02 INFO - 'TERM': 'linux', 03:31:02 INFO - 'TMOUT': '86400', 03:31:02 INFO - 'USER': 'cltbld', 03:31:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:02 INFO - '_': '/tools/buildbot/bin/python'} 03:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 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)) 03:31:02 INFO - Cleaning up... 03:31:02 INFO - Return code: 0 03:31:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:02 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:31:02 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 03:31:02 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 03:31:02 INFO - Using env: {'DISPLAY': ':0', 03:31:02 INFO - 'HOME': '/home/cltbld', 03:31:02 INFO - 'LANG': 'en_US.UTF-8', 03:31:02 INFO - 'LANGUAGE': 'en_US:en', 03:31:02 INFO - 'LOGNAME': 'cltbld', 03:31:02 INFO - 'MAIL': '/var/mail/cltbld', 03:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:02 INFO - 'MOZ_NO_REMOTE': '1', 03:31:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:02 INFO - 'NO_EM_RESTART': '1', 03:31:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:02 INFO - 'PWD': '/builds/slave/test', 03:31:02 INFO - 'SHELL': '/bin/bash', 03:31:02 INFO - 'SHLVL': '1', 03:31:02 INFO - 'TERM': 'linux', 03:31:02 INFO - 'TMOUT': '86400', 03:31:02 INFO - 'USER': 'cltbld', 03:31:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:02 INFO - '_': '/tools/buildbot/bin/python'} 03:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:31:03 INFO - Cleaning up... 03:31:03 INFO - Return code: 0 03:31:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:31: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')]} 03:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31: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')]} 03:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:31:03 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 0x7f8d13a95f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df9350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, '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': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', '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 03:31:03 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 03:31:03 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 03:31:03 INFO - Using env: {'DISPLAY': ':0', 03:31:03 INFO - 'HOME': '/home/cltbld', 03:31:03 INFO - 'LANG': 'en_US.UTF-8', 03:31:03 INFO - 'LANGUAGE': 'en_US:en', 03:31:03 INFO - 'LOGNAME': 'cltbld', 03:31:03 INFO - 'MAIL': '/var/mail/cltbld', 03:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:03 INFO - 'MOZ_NO_REMOTE': '1', 03:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:03 INFO - 'NO_EM_RESTART': '1', 03:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:03 INFO - 'PWD': '/builds/slave/test', 03:31:03 INFO - 'SHELL': '/bin/bash', 03:31:03 INFO - 'SHLVL': '1', 03:31:03 INFO - 'TERM': 'linux', 03:31:03 INFO - 'TMOUT': '86400', 03:31:03 INFO - 'USER': 'cltbld', 03:31:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:03 INFO - '_': '/tools/buildbot/bin/python'} 03:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:31:03 INFO - Downloading/unpacking flake8 03:31:03 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 03:31:03 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 03:31:03 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 03:31:03 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 03:31:03 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 03:31:03 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 03:31:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:31:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:31:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31: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 03:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:05 INFO - no previously-included directories found matching 'docs/_build' 03:31:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:31:05 INFO - Running setup.py install for pep8 03:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:31:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:31:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:31:06 INFO - no previously-included directories found matching 'docs/_build' 03:31:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:31:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:31:06 INFO - Cleaning up... 03:31:06 INFO - Return code: 0 03:31:06 INFO - Running post-action listener: _resource_record_post_action 03:31:06 INFO - Running post-action listener: _start_resource_monitoring 03:31:06 INFO - Starting resource monitoring. 03:31:06 INFO - ##### 03:31:06 INFO - ##### Finished create-virtualenv step (success) 03:31:06 INFO - ##### 03:31:06 INFO - ##### 03:31:06 INFO - ##### Running install step. 03:31:06 INFO - ##### 03:31:06 INFO - Running pre-action listener: _resource_record_pre_action 03:31:06 INFO - Running main action method: install 03:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:31:06 INFO - Reading from file tmpfile_stdout 03:31:06 INFO - Detecting whether we're running mozinstall >=1.0... 03:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:31:06 INFO - Reading from file tmpfile_stdout 03:31:06 INFO - Output received: 03:31:06 INFO - Usage: mozinstall [options] installer 03:31:06 INFO - Options: 03:31:06 INFO - -h, --help show this help message and exit 03:31:06 INFO - -d DEST, --destination=DEST 03:31:06 INFO - Directory to install application into. [default: 03:31:06 INFO - "/builds/slave/test"] 03:31:06 INFO - --app=APP Application being installed. [default: firefox] 03:31:06 INFO - mkdir: /builds/slave/test/build/application 03:31:06 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'] 03:31:06 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 03:31:22 INFO - Reading from file tmpfile_stdout 03:31:22 INFO - Output received: 03:31:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:22 INFO - Running post-action listener: _resource_record_post_action 03:31:22 INFO - ##### 03:31:22 INFO - ##### Finished install step (success) 03:31:22 INFO - ##### 03:31:22 INFO - ##### 03:31:22 INFO - ##### Running run-tests step. 03:31:22 INFO - ##### 03:31:22 INFO - Running pre-action listener: _resource_record_pre_action 03:31:22 INFO - Running main action method: run_tests 03:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:22 INFO - Python 2.7.3 03:31:22 INFO - Return code: 0 03:31:22 INFO - grabbing minidump binary from tooltool 03:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:31:22 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 0x1e881c0>, '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 0x1e890c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:22 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 03:31:22 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 03:31:22 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 03:31:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:22 INFO - Return code: 0 03:31:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:31:23 INFO - Return code: 0 03:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 03:31:23 INFO - Using env: {'DISPLAY': ':0', 03:31:23 INFO - 'HOME': '/home/cltbld', 03:31:23 INFO - 'LANG': 'en_US.UTF-8', 03:31:23 INFO - 'LANGUAGE': 'en_US:en', 03:31:23 INFO - 'LOGNAME': 'cltbld', 03:31:23 INFO - 'MAIL': '/var/mail/cltbld', 03:31:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:23 INFO - 'MOZ_NO_REMOTE': '1', 03:31:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:23 INFO - 'NO_EM_RESTART': '1', 03:31:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:23 INFO - 'PWD': '/builds/slave/test', 03:31:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:23 INFO - 'SHELL': '/bin/bash', 03:31:23 INFO - 'SHLVL': '1', 03:31:23 INFO - 'TERM': 'linux', 03:31:23 INFO - 'TMOUT': '86400', 03:31:23 INFO - 'USER': 'cltbld', 03:31:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413', 03:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:23 INFO - '_': '/tools/buildbot/bin/python'} 03:31:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 03:31:23 INFO - mozversion application_buildid: 20160624021358 03:31:23 INFO - mozversion application_changeset: 34e0a985d93d88be6058db05071121decf373c97 03:31:23 INFO - mozversion application_display_name: Nightly 03:31:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:23 INFO - mozversion application_name: Firefox 03:31:23 INFO - mozversion application_remotingname: firefox 03:31:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:31:23 INFO - mozversion application_vendor: Mozilla 03:31:23 INFO - mozversion application_version: 50.0a1 03:31:23 INFO - mozversion platform_buildid: 20160624021358 03:31:23 INFO - mozversion platform_changeset: 34e0a985d93d88be6058db05071121decf373c97 03:31:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:31:23 INFO - mozversion platform_version: 50.0a1 03:31:23 INFO - using testdate: 1466764283 03:31:23 INFO - actual date: 1466764283 03:31:23 INFO - starting webserver on 'localhost:51301' 03:31:23 INFO - SUITE-START | Running 2 tests 03:31:23 INFO - TEST-START | dromaeo_css 03:31:23 INFO - operating with platform_type : linux_ 03:31:23 INFO - Initialising browser for dromaeo_css test... 03:31:23 INFO - TEST-INFO | started process 14556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVELqh/profile http://localhost:51301/getInfo.html) 03:31:28 INFO - PROCESS | 14556 | __metrics Screen width/height:1600/1200 03:31:28 INFO - PROCESS | 14556 | colorDepth:24 03:31:28 INFO - PROCESS | 14556 | Browser inner width/height: 1024/697 03:31:28 INFO - PROCESS | 14556 | __metrics 03:31:29 INFO - PROCESS | 14556 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:30 INFO - TEST-INFO | 14556: exit 0 03:31:30 INFO - Browser initialized. 03:31:30 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:30 INFO - TEST-INFO | started process 14640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVELqh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:42 INFO - PROCESS | 14640 | RSS: Main: 175828992 03:31:42 INFO - PROCESS | 14640 | 03:32:33 INFO - PROCESS | 14640 | 1466764353452 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] 03:34:46 INFO - PROCESS | 14640 | Cycle 1(1): loaded http://localhost:51301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51301/tests/dromaeo/cssquery-ext.html) 03:34:47 INFO - PROCESS | 14640 | RSS: Main: 289878016 03:34:47 INFO - PROCESS | 14640 | 03:37:50 INFO - PROCESS | 14640 | Cycle 1(1): loaded http://localhost:51301/tests/dromaeo/cssquery-ext.html (next: http://localhost:51301/tests/dromaeo/cssquery-jquery.html) 03:37:51 INFO - PROCESS | 14640 | RSS: Main: 264982528 03:37:51 INFO - PROCESS | 14640 | 03:40:53 INFO - PROCESS | 14640 | Cycle 1(1): loaded http://localhost:51301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51301/tests/dromaeo/cssquery-mootools.html) 03:40:54 INFO - PROCESS | 14640 | RSS: Main: 264904704 03:40:54 INFO - PROCESS | 14640 | 03:43:56 INFO - PROCESS | 14640 | Cycle 1(1): loaded http://localhost:51301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51301/tests/dromaeo/cssquery-prototype.html) 03:43:56 INFO - PROCESS | 14640 | RSS: Main: 257212416 03:43:56 INFO - PROCESS | 14640 | 03:46:59 INFO - PROCESS | 14640 | Cycle 1(1): loaded http://localhost:51301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51301/tests/dromaeo/cssquery-yui.html) 03:47:00 INFO - PROCESS | 14640 | RSS: Main: 236474368 03:47:00 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | Cycle 1(1): loaded http://localhost:51301/tests/dromaeo/cssquery-yui.html (next: http://localhost:51301/tests/dromaeo/cssquery-dojo.html) 03:50:03 INFO - PROCESS | 14640 | RSS: Main: 305049600 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | __start_tp_report 03:50:03 INFO - PROCESS | 14640 | _x_x_mozilla_page_load 03:50:03 INFO - PROCESS | 14640 | _x_x_mozilla_page_load_details 03:50:03 INFO - PROCESS | 14640 | |i|pagename|runs| 03:50:03 INFO - PROCESS | 14640 | |0;dojo.html;2611.9477610447802;2630.7895368370528;2639.85480798556;2642.4054587717765;2662.760351568359;4562.931556026662;4651.604613607839;4738.691985020975;4817.494163112875;4871.707697538146;4670.159371313162;4743.051389722061;4779.474257831635;4784.90430191396;4860.246661767423;4325.762083085429;4359.520452750195;4369.956300437003;4391.846285380012;4497.505274419811;4394.1870753910625;4449.332600109977;4513.413256276679;4556.2937744649635;4564.269716845305;4250.829966801324;4448.488423831269;4479.529649386816;4499.302608095751;4507.301368287921;4280.935785963213;4311.8490852820005;4335.9566404335865;4344.087741574273;4410.823567057314;4310.633596144332;4325.935110973338;4366.3013917773005;4381.5618438155925;4387.451568553931;4789.305550695164;4790.928136077961;4809.663323567352;4814.614830813562;4828.46886842447;4939.802407903716;5045.722485263309;5083.74581270935;5114.539691427789;5133.871653208662;5157.381114266274;5164.1220992431;5188.040212560688;5199.714015729133;5212.139996900507;4625.051864367797;4840.515948405131;4852.927206091911;4857.95142048575;4859.975700121477;5197.986392653472;5204.7918083277;5245.475452454724;5256;5328.17413300939;5096.159133742891;5101.132807422747;5117.360329958755;5118.488151184852;5119.3088932994315;4915.68048076881;5021.372328458942;5092.159793634083;5105.2342148678;5120.462351453044;5070.4929507049;5092.949070509248;5121.948780512222;5122.513361230677;5165.096108181053;5080.949190508121;5081.0854046272025;5089.312942752755;5099.878408893492;5145.716985565829;4254.510731265944;4300.247456695066;4305.677074219383;4396.1867054595;4444.400005999149;3759.7368184226843;3766.0584853786554;3788.5264341957254;3795.7532760370486;3809.504764380613;4350.32569951658;4352.9129417412105;4354.1944740222525;4354.477462704495;4400.933985990213;4983.725895075733;5035.018171456531;5104.1578139606545;5105.591552675777;5150.27896094547;4343.457067866517;4369.235383807821;4369.366441865912;4397.07661391105;4410.669199810027;4594.425696787902;4604.677672562955;4609.262517997105;4610.608098311681;4657.138429390574;4635.072985402865;4757.119932812441;4772.093302272557;4780.282957556395;4827.42070951488;5170.43125256229;5181.481851814789;5199.324087868704;5206.0368831766245;5225.529702326809;4822.083804077354;4825.517448255287;4849.127157111754;4851.1753001990455;4894.339264199288;4871.585915197248;5004.424491183415;5044.722540260321;5068.670536415121;5106.4893510648635;5135.666181698178;5137.486251374982;5158.561522270649;5159.277701121921;5167.58659307262;5018.372703412074;5018.598512119095;5019.372578427697;5023.547880690755;5054.69671819692;4850.175470170009;4917.434495033117;4961.627877909099;4992.926520798046;5011.498850115106;4911.091448082117;4946.678465899705;4979.950200498093;4983.302337672656;4986.700797952134;4836.782344794563;5042.420121685906;5044.722540260321;5045.596352291735;5079.746012699424;4838.806447742051;4891.877703057452;4904.950950490449;4905.23968784839;4976.2038073908 03:50:03 INFO - PROCESS | 14640 | |1;ext.html;535.7508758427331;590.371254613836;597.5309382135024;600.7026521871675;612.0941007309181;26670.333241668945;28906;28936.421271574556;29005.274868128254;37790.8110459448;37356.81321593395;41174.79412602933;41194.38208426876;41194.58805411945;41245;7778.805529861756;7938.2855543001115;7939.967804185477;7946.16565260648;7949.562774047425;7811.414143939199;7897.24976127267;7900.288973992339;7900.525968441883;7903.130655627876;7872.055353357577;7900.407469439786;7919.722809701633;7920.5247685139075;7927.246911543423;7834.138244793068;7841.059072911287;7842.215778422169;7883.014623172104;7890.644920978541;7684.423668224906;7744.148143704188;7747.0703515577925;7749.225077492262;7753.108392534874;37749.81125094384;38215.426768598496;38239.617603823885;38308;38310.80844595759;2934.0611004478574;2962.244627619965;3009.6839831817783;3079;3211.6467188609236;29238.707612923812;29388;29717.405651886842;29898.85050574755;30392;3322.7840190387788;3348.29685765987;3350.782199157047;3373.4602463605706;3434.9828250858836;255940;256212;256493.717531413;257089;259342;27586.172414827586;28315.292117697223;49891.750541247064;50546.49453505492;50636.74681626642;33330.66669333276;33406.3318733624;33467.330653386794;33516.83241583825;33521.83239083789;12795.808062879065;12854.55009074678;12858.292793896426;12866.614001579968;12879.871201288055;10708.732281692864;10759.46202689878;10766.192535559865;10770.946145269223;10773.622923197807;7663.808404789925;7706.306432421109;7737.342325902361;7749.263819937097;7755.961220193863;2868.8709008094684;2871.9856400717863;2924.5320748680533;2959.5731500170086;2964.155215763497;817.6263876687104;865.2947847504264;882.2280504558511;952.319091849331;963.2197919684937;27187.1843844685;27899.16302510928;28263.15210543687;28436.857815710788;28661.28346791347;986.1223511075149;993.3592832623062;999.9200063994863;1022.7801022780138;1099.4777480696764;14526.709465810625;14641.34113964874;14758.188299643623;14954.327055282321;14963.476278330207;420041;422785;422920;423170;424744;48379;48609.756951215015;48849.75575122102;48965.2655210165;48994.755026224644;1136.1478890831877;1170.6019953215948;1176.7293522489874;1183.5679976808576;1185.152615879633;26236.475270494866;27262.454750904475;27837.304067398476;27876;27999.860000699868;37531;37689.246215075;37730.43404348882;37733.05667358228;37764.62235377611;340517;341498;343858;344085;344336;24522.75477245205;24977.375565611004;24989.250322490356;25017.499650007263;25062.874685627183;39331.2133757329;39799.80100099481;39914.2017159661;40020.79989600033;41683.166336673705;31419.214519637193;34256;34515.82742086273;34545.30909381748;34699.30601388009;34447.4832877512;34489;34607.65392346044;34668.82665586656;34862.65137348696;30797.384052319278;34656;36405.81797090998;37267.6273237275;37479;29486.705132948395;32719.34561308808;33071.662206362606;33529.49705754464;33575.32849342951;24708;25234.87382563149;25280;25571.872140639924;25669.10158144456 03:50:03 INFO - PROCESS | 14640 | |2;jquery.html;353.1224906108322;375.2476285048477;377.9357509223432;379.57298039705313;392.9980350098249;12426.751464970706;13843.792343114848;17134.571635709115;17230.13849307536;17249.91375043126;16039.35842566296;16561.337546498155;17334;17336.47990560282;17406.912965435185;4863.562279394854;5007.624428167884;5044.344235249412;5049.747512624373;5051.242313652945;3763.153290509641;3952.9011774705573;3953.268645300614;3987.541432735229;5099.59203263738;3848.3650197717484;6084.482818960371;6097.603655762384;6220.937790622081;6222.439980401763;6099.634021958696;6180.783672571439;6181.505479561669;6185.721642526075;6199.256089269294;3410.897673069812;5290.841274761763;5378.489043540896;5414.675119492843;5416.187571864212;18136.727949080774;19087.427377178567;19211.903940480348;19824.207031718714;20994.37016889496;1795.165248159599;1851.759271294723;1858.8977606231651;1918.4052943587394;1930.758655168104;9278.164965153168;11842.934135927722;11904.702382440508;13194.274314912676;13284;1733.479956013191;1782.58109344304;1821.6629923464202;1847.5288801355703;1859.5630026943657;42946.355804662955;58775.70612146912;59355.70322148405;63073.68463157701;67018.66490667564;8567.228949394585;9170.495622740813;9943.502824858728;10292.845607315896;10369.170466362673;13636.113652612548;13757.31213439324;13792.655183620289;13798.93100534491;13804;7115.501914865909;7176.210616832144;7260.528065675714;7332.120145582564;7544.132424771222;6654.168228971379;6686.866262674816;6795.728170873209;7016.5088443808445;7046.6476676165985;4423.8451654192595;4450.910981780411;4461.955380446154;4532.501424843264;4579.839705610354;1774.8491378232995;1837.3569250762393;1855.7123645834647;1866.150901339887;1894.1003023563696;768.2854944901295;883.6995421556574;894.5482531321641;926.3237836379346;935.6117211357347;15113.54659360221;15407.383704651913;16440.75338869918;17031.318747250218;17206;853.4111463090571;860.5525126933959;880.801819590587;888.8844450221429;889.8309321228945;9307.627694892128;9310.348275620641;9472.479013654178;9660.661876834278;9830.852537211947;402602;405408;415021;415392;416813;52319.738401307746;70381;71188.28811711817;71948;75084.24915750882;867.1501928110487;892.6794315512949;893.8078313162571;906.9909300907038;907.0657223060258;11274.60538881168;14436;14547.85452145465;15632.531024069296;15718.607034824221;34534.82732586321;35983.46024809578;36063.27873442464;36098.63901360953;36200;46894.53105468902;47728.761356193;49168.2624760636;49272;50073.49926500688;7809.804754881174;7823.2959033684965;7829.921700782919;7888.408369372435;8040.276375126266;10348.586056557653;11419.657410277705;11668;11672.591459298883;11772.352520611448;9581.281403894875;10144.239182061523;10257.128144107535;10309.175265978854;10334.276600637882;9909;9957.601695932082;10342.638007669695;10378.532966016397;10418.843717344094;9690.46702431373;10099.394036357842;10282.537285822007;10413.895861041292;10463.11063559606;7540.472166948261;7720.729774457867;7804.726834560764;8042.396820238622;8047.1550487198;9025.187733104052;9986.550605222928;9997.500124993867;10216.066814276706;10291.639792607222 03:50:03 INFO - PROCESS | 14640 | |3;mootools.html;1192.3740036480851;1327.9070465067446;1392.3734319556202;1432.792245124457;1642.1214650162158;6595.802125936218;7674.347680447162;7911.090224624156;7936.920630793683;8163.4693744906535;7868.252516010984;7966.32286255669;7970.800729981754;8059.91940080599;8062.113167551579;2189.189999700109;2219.3785739992745;2221.577900198965;2222.122261706625;2225.0765932138142;2212.557488502306;2238.809701175402;2252.4481502032027;2253.3915842722536;2254.1772253127656;2137.1024169848624;2187.7046598709208;2197.52753158071;2200.6588978708246;2201.9559608807813;2159.114762947192;2162;2162.178372218563;2167.5773224221202;2168.1977668262684;2145.1419432227076;2205.073868975034;2209.690643309938;2214.800667939893;2214.833887458431;7843.686252549891;7963.601819908981;8017.518948863087;8097.433179677425;8119.3910456715985;4549.931751023737;4584.037352156051;4601.723896566184;4615.9076818463445;4656.254999200111;2880.2079428157217;2975.181824998143;3032.9090127296217;3034.1049390429876;3034.6510151332436;948.8529277961927;959.5586030426012;965.971020869368;967.3132076225888;978.9706308810747;10877.456127193687;11019.724506887313;11042.668719938414;11046.226764126515;11048.447577621087;4065.837366505366;4109.876703698894;4157.189348077157;4292.7424354538825;4299.269124248885;8602.698905538276;8706.172913573328;8729.825403491895;8765.43024703405;8767.210951014311;4624.630029597624;4636.142313671914;4642.814287428465;4647.3029045643425;4671.906561868744;3644.927101457956;3780.527434070741;4306.5908738670405;4353.151135528605;4366.781660916941;3487.633798451177;3536.381133301662;3560.913921254042;3602.243528858969;3633.4368172933237;1059.7933402986343;1086.750047489082;1088.374184843718;1094.9397783122006;1100.3068067117824;776.6970881356276;793.7579038393345;818.3167055508717;828.6395417993192;832.854250506159;4875.902481950341;5007.148784706608;5034.244863270465;5040.949590504121;5069.670471419346;866.2026295436993;867.4405008769309;871.5032431514103;901.4275934781462;901.7655409593552;3240.8379581021327;3442.8622855085514;3447.5862896452586;3483.7909725416557;3488.2500262443696;9462.769839920766;9748.073932976356;9767.218622510181;9768.169705574963;9779.266555008402;9741.366811157252;9759.072888075621;9760.707178784647;9764.853527197098;9765.951170244103;7131.0729605151;7491.464249828772;7520.623968801648;7569.697212111454;7577.393808495417;4805.519448055166;4938.185199442052;4980.05378977993;5039.2944987702485;5040.319556859924;8944.150305720947;9007.594658240263;9037.819243615222;9082.228010618906;9140.223081038186;8794.164554367326;9126.269898408244;9139;9170.908290917005;9422.575984080595;6061.909071363845;6187.443130118311;6195.752169913333;6322.683865806784;6576.506761992965;7430.145533263744;7724.304812566896;7730.304272615492;7757.650905709143;7757.806054848674;6687.465002799861;6751.392374686302;6863.039174515671;6897.379235868595;7048.118985126859;6783.762568310283;6799.558028728117;6885.862282754417;6890.517663763489;6895;5828.358880523224;5901.114832775118;5946.494547963472;5983.640981541122;5988;4562.38407814954;4569.451665800125;4588.2429399150105;4657.231556793091;4764.642651801059;4570.565796249351;4594.9310760339295;4678.976605116953;4793.161196790478;4972 03:50:03 INFO - PROCESS | 14640 | |4;prototype.html;276.75507176149114;284.5887692284649;289.22343507681876;291.8686591034035;294.6331816887975;4703.553162449562;4833.9274910876275;4885.511448855113;4950.727709975949;4954.603631709464;4702.388689470373;4817.397825271841;4870.196417591093;4876.634252431064;4906.730129842857;3616.9095772605765;3775.490308808317;3824.29250588642;3839.289731399686;3864.4396562498423;3669.1377526281435;3779;3797.7341586088983;3810.580836108026;3815.179736356683;3748.512693349861;3768.5289338832645;3774.3017541754725;3775.3393156197694;3782.659560639556;3769.849206031783;3776.622337766229;3788.242351529705;3804.9809750951345;3845.0771814764535;3142.308692087737;3297.868085276586;3309.619393769699;3397.963621095565;3403.1322012886553;4778.737169455679;4796.44840843304;4807;4812.639052071108;4814.831480898187;4305.956940430587;4312.439382880237;4326.632236259922;4332.371806088131;4339.8047087880805;4941;5079.568236699885;5096.974515127437;5104.566111880495;5109.693418394908;3573.928521429557;3577.177249232665;3577.624349443323;3582.9283414331826;3583.8924832255075;5320.122179840322;5368.32895888014;5368.926214757064;5374.677519348852;5383.165609330521;3525.541679581689;3712.7586706863967;3718.7396882218527;3729.4219395993664;3752.1370084880086;3724.5902950675404;3737.7009839212797;3744.3711985286486;3755.1550901047044;3776.8103047539935;4260.680448966278;4305.892352691208;4322.438083049184;4337.891552711144;4348.717333373321;4839.661223714306;4949.7772600233075;5081.949180508148;5120.359955005624;5140.791913900231;1276.655303068185;1288.3815768431205;1300.2458574027041;1300.2783455182275;1303.5111833062601;806.5886397937095;823.9083214740493;832.5171400587644;832.7501749475133;833.295864994079;4010.27814993304;4020.43713880057;4029.274730548471;4040.4343391925154;4066.3900414938;4616.6537509686905;4671.462781780138;4696.201645720235;4703.765711287179;4736.873663382151;4048.8582899598373;4062.857799977046;4075.8777236682945;4083.448289649914;4100.856470023595;2493.3641921310314;2593.937819433555;2766.1839757271655;2791.8185317954267;2815.8451285179103;4908.533689299511;4923.90152196954;4928.728919909439;4943.65394422387;4957.157283261782;5249.160134378558;5401.540869026177;5408.729563521808;5419.539339156137;5431.4840090191365;4866.805327786919;4881.121398148367;4885.682430642068;4928.088303663833;4940.901181976412;5216.634835561475;5238.982991548205;5262.368515778131;5268.315119034501;5270.8945821084135;4907.852764417074;5123.718195499134;5155.458676839028;5174.482551744946;5187.844364669066;4916.959461823446;4926.236433352836;4934.235193545006;4939.629527785359;4947.035328110984;3792.5259342582176;3799.6770274526975;3801.8669346572738;3832.137769001952;3837.0982819036944;4925.1873440881855;5020.623453240948;5257.63196576236;5267.499587539178;5293.867653308698;5079.746012699424;5101.9489805101475;5117.257997590403;5143.768530416215;5159.071367153948;5066.544011039025;5083.92374114396;5117.8464646060675;5120.257562653469;5136.356365962856;4769.904601907873;5044.1424957758;5061.392632884077;5064.29099926018;5073.797048118034;5167.22491626244;5175.4565770593545;5185.844424667266;5190.97404512975;5201.699575106223;5040.470750571284;5045.974770126126;5058.747062646779;5064.12627327891;5085.338905942203 03:50:03 INFO - PROCESS | 14640 | |5;yui.html;639.8080575827252;686.239408043919;709.6168069242609;731.8182717221465;740.7518481308762;11960.521579136835;13941.302934853267;13953.581392558226;13963.790543141848;13987.720245595083;13431.932840335785;13518.729625407486;13583.52457663982;13657.521986730466;13668.11157274779;630.3349965786094;777.789996700889;796.2276591706036;799.9000124984377;799.952002879829;645.4030022229442;651.0884761334146;651.2152855808763;765.9502132361406;797.0435477427081;822.9053658829222;825.9008918929737;829.7676650537859;833.7332053742805;835.4235577451569;820.0405525535139;827.1810907201886;827.3133299361546;827.5531213144894;827.7806381308958;488.46513068190274;593.5696619950545;605.8848818724429;608.5831205624162;610.4414460768392;13310.933445332808;13431.059825812197;13451.327433628378;13490.39293231807;13504.729905401837;12657.30384828834;12783;13333.999950003692;13343.733125337536;13459.057865949388;11240.381779002151;11650.126240531994;11650.359230242333;11777.528898844035;12367.752644947052;3763.661270485642;3789.696824254053;3827.349350610403;3913;3931.528216613996;57602;57815.13277300844;57917.420825791625;58295.417045829425;58448;10042.447665378475;10204.285700000928;10232.846507302396;10340.586376545005;10343.586256549654;19185.136668849937;19195.136218870186;19209.231630734892;19213.32753353654;19244;6878.65606719662;6889.862202755917;6906.171259448898;6942.271061538567;7116.964415177995;3802.2205447883116;3824.6366595173413;3829.368154254517;3920.4511368408444;3959.8416063357145;2837.6169217155834;2953.468375692353;2957.038962337249;2961.5113506271223;2963.525835866251;483.44645381038515;488.53833127693986;494.83917726738235;496.4786973677624;502.1488576862184;524.7769697878387;533.5224973648562;551.1319671517376;566.6968172028028;568.7241687781423;7497.737579184703;7627.733029344057;7789.454738168274;7802.804929876798;7835.686572537149;431.38527598172476;512.060369222481;514.8687084793354;554.3597145297189;589.711041589618;3465.6707612776745;3849.0569810396632;4343.087951530214;4442.42248507692;4507.661925355612;70983.29016709767;74139;74366.62816685882;84609;94448.52775736077;69115;73683;73708.26291737122;74695;75958;43088;60369.396306036375;63962.040569391495;64296;65667.34332656708;8376.24613784738;8469.280111190372;8469.364797640079;8521.91478085236;8614.741557753277;37670.434943475324;38166.6183338163;42874.35688464738;44242.557574423845;45223.095538089714;38784;42564;53616;60366;62965.37034629595;10982;11066.723331916766;11201.831972520256;11395.316281023164;11618.825717614412;11182.776344473228;11205.943970280096;11632.476538555617;11637.185397022466;11652.242604230698;11078.224524283223;11754.588589399329;12042.24931871954;12156.635300940987;12403.25580465175;11820.881791181979;12121.45453454579;12196.695082622651;12241.632751017483;12352.75294494087;11193.552257909592;11232.157588180755;11311.434428278388;11654.475548600163;11765.882341176479;9303.209227215762;9419.387739796892;9659.855102173333;9679.419234845931;9696.5636546357;9454.733842766382;9622.807543849223;9642.373245739005;9983.750406239902;10089.798204035731 03:50:03 INFO - PROCESS | 14640 | __end_tp_report 03:50:03 INFO - PROCESS | 14640 | __start_cc_report 03:50:03 INFO - PROCESS | 14640 | _x_x_mozilla_cycle_collect,1118 03:50:03 INFO - PROCESS | 14640 | __end_cc_report 03:50:03 INFO - PROCESS | 14640 | __startTimestamp1466765403784__endTimestamp 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | ------- Summary: start ------- 03:50:03 INFO - PROCESS | 14640 | Number of tests: 6 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | [#0] dojo.html Cycles:165 Average:4727.40 Median:4852.93 stddev:505.63 (10.4%) stddev-sans-first:479.17 03:50:03 INFO - PROCESS | 14640 | Values: 2611.9 2630.8 2639.9 2642.4 2662.8 4562.9 4651.6 4738.7 4817.5 4871.7 4670.2 4743.1 4779.5 4784.9 4860.2 4325.8 4359.5 4370.0 4391.8 4497.5 4394.2 4449.3 4513.4 4556.3 4564.3 4250.8 4448.5 4479.5 4499.3 4507.3 4280.9 4311.8 4336.0 4344.1 4410.8 4310.6 4325.9 4366.3 4381.6 4387.5 4789.3 4790.9 4809.7 4814.6 4828.5 4939.8 5045.7 5083.7 5114.5 5133.9 5157.4 5164.1 5188.0 5199.7 5212.1 4625.1 4840.5 4852.9 4858.0 4860.0 5198.0 5204.8 5245.5 5256.0 5328.2 5096.2 5101.1 5117.4 5118.5 5119.3 4915.7 5021.4 5092.2 5105.2 5120.5 5070.5 5092.9 5121.9 5122.5 5165.1 5080.9 5081.1 5089.3 5099.9 5145.7 4254.5 4300.2 4305.7 4396.2 4444.4 3759.7 3766.1 3788.5 3795.8 3809.5 4350.3 4352.9 4354.2 4354.5 4400.9 4983.7 5035.0 5104.2 5105.6 5150.3 4343.5 4369.2 4369.4 4397.1 4410.7 4594.4 4604.7 4609.3 4610.6 4657.1 4635.1 4757.1 4772.1 4780.3 4827.4 5170.4 5181.5 5199.3 5206.0 5225.5 4822.1 4825.5 4849.1 4851.2 4894.3 4871.6 5004.4 5044.7 5068.7 5106.5 5135.7 5137.5 5158.6 5159.3 5167.6 5018.4 5018.6 5019.4 5023.5 5054.7 4850.2 4917.4 4961.6 4992.9 5011.5 4911.1 4946.7 4980.0 4983.3 4986.7 4836.8 5042.4 5044.7 5045.6 5079.7 4838.8 4891.9 4905.0 4905.2 4976.2 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | [#1] ext.html Cycles:180 Average:47307.36 Median:189391.74 stddev:92056.67 (48.6%) stddev-sans-first:92247.93 03:50:03 INFO - PROCESS | 14640 | Values: 535.8 590.4 597.5 600.7 612.1 26670.3 28906.0 28936.4 29005.3 37790.8 37356.8 41174.8 41194.4 41194.6 41245.0 7778.8 7938.3 7940.0 7946.2 7949.6 7811.4 7897.2 7900.3 7900.5 7903.1 7872.1 7900.4 7919.7 7920.5 7927.2 7834.1 7841.1 7842.2 7883.0 7890.6 7684.4 7744.1 7747.1 7749.2 7753.1 37749.8 38215.4 38239.6 38308.0 38310.8 2934.1 2962.2 3009.7 3079.0 3211.6 29238.7 29388.0 29717.4 29898.9 30392.0 3322.8 3348.3 3350.8 3373.5 3435.0 255940.0 256212.0 256493.7 257089.0 259342.0 27586.2 28315.3 49891.8 50546.5 50636.7 33330.7 33406.3 33467.3 33516.8 33521.8 12795.8 12854.6 12858.3 12866.6 12879.9 10708.7 10759.5 10766.2 10770.9 10773.6 7663.8 7706.3 7737.3 7749.3 7756.0 2868.9 2872.0 2924.5 2959.6 2964.2 817.6 865.3 882.2 952.3 963.2 27187.2 27899.2 28263.2 28436.9 28661.3 986.1 993.4 999.9 1022.8 1099.5 14526.7 14641.3 14758.2 14954.3 14963.5 420041.0 422785.0 422920.0 423170.0 424744.0 48379.0 48609.8 48849.8 48965.3 48994.8 1136.1 1170.6 1176.7 1183.6 1185.2 26236.5 27262.5 27837.3 27876.0 27999.9 37531.0 37689.2 37730.4 37733.1 37764.6 340517.0 341498.0 343858.0 344085.0 344336.0 24522.8 24977.4 24989.3 25017.5 25062.9 39331.2 39799.8 39914.2 40020.8 41683.2 31419.2 34256.0 34515.8 34545.3 34699.3 34447.5 34489.0 34607.7 34668.8 34862.7 30797.4 34656.0 36405.8 37267.6 37479.0 29486.7 32719.3 33071.7 33529.5 33575.3 24708.0 25234.9 25280.0 25571.9 25669.1 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | [#2] jquery.html Cycles:180 Average:24164.20 Median:23685.10 stddev:67399.72 (284.6%) stddev-sans-first:67565.09 03:50:03 INFO - PROCESS | 14640 | Values: 353.1 375.2 377.9 379.6 393.0 12426.8 13843.8 17134.6 17230.1 17249.9 16039.4 16561.3 17334.0 17336.5 17406.9 4863.6 5007.6 5044.3 5049.7 5051.2 3763.2 3952.9 3953.3 3987.5 5099.6 3848.4 6084.5 6097.6 6220.9 6222.4 6099.6 6180.8 6181.5 6185.7 6199.3 3410.9 5290.8 5378.5 5414.7 5416.2 18136.7 19087.4 19211.9 19824.2 20994.4 1795.2 1851.8 1858.9 1918.4 1930.8 9278.2 11842.9 11904.7 13194.3 13284.0 1733.5 1782.6 1821.7 1847.5 1859.6 42946.4 58775.7 59355.7 63073.7 67018.7 8567.2 9170.5 9943.5 10292.8 10369.2 13636.1 13757.3 13792.7 13798.9 13804.0 7115.5 7176.2 7260.5 7332.1 7544.1 6654.2 6686.9 6795.7 7016.5 7046.6 4423.8 4450.9 4462.0 4532.5 4579.8 1774.8 1837.4 1855.7 1866.2 1894.1 768.3 883.7 894.5 926.3 935.6 15113.5 15407.4 16440.8 17031.3 17206.0 853.4 860.6 880.8 888.9 889.8 9307.6 9310.3 9472.5 9660.7 9830.9 402602.0 405408.0 415021.0 415392.0 416813.0 52319.7 70381.0 71188.3 71948.0 75084.2 867.2 892.7 893.8 907.0 907.1 11274.6 14436.0 14547.9 15632.5 15718.6 34534.8 35983.5 36063.3 36098.6 36200.0 46894.5 47728.8 49168.3 49272.0 50073.5 7809.8 7823.3 7829.9 7888.4 8040.3 10348.6 11419.7 11668.0 11672.6 11772.4 9581.3 10144.2 10257.1 10309.2 10334.3 9909.0 9957.6 10342.6 10378.5 10418.8 9690.5 10099.4 10282.5 10413.9 10463.1 7540.5 7720.7 7804.7 8042.4 8047.2 9025.2 9986.6 9997.5 10216.1 10291.6 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | [#3] mootools.html Cycles:180 Average:5138.97 Median:5036.77 stddev:2916.26 (57.9%) stddev-sans-first:2909.36 03:50:03 INFO - PROCESS | 14640 | Values: 1192.4 1327.9 1392.4 1432.8 1642.1 6595.8 7674.3 7911.1 7936.9 8163.5 7868.3 7966.3 7970.8 8059.9 8062.1 2189.2 2219.4 2221.6 2222.1 2225.1 2212.6 2238.8 2252.4 2253.4 2254.2 2137.1 2187.7 2197.5 2200.7 2202.0 2159.1 2162.0 2162.2 2167.6 2168.2 2145.1 2205.1 2209.7 2214.8 2214.8 7843.7 7963.6 8017.5 8097.4 8119.4 4549.9 4584.0 4601.7 4615.9 4656.3 2880.2 2975.2 3032.9 3034.1 3034.7 948.9 959.6 966.0 967.3 979.0 10877.5 11019.7 11042.7 11046.2 11048.4 4065.8 4109.9 4157.2 4292.7 4299.3 8602.7 8706.2 8729.8 8765.4 8767.2 4624.6 4636.1 4642.8 4647.3 4671.9 3644.9 3780.5 4306.6 4353.2 4366.8 3487.6 3536.4 3560.9 3602.2 3633.4 1059.8 1086.8 1088.4 1094.9 1100.3 776.7 793.8 818.3 828.6 832.9 4875.9 5007.1 5034.2 5040.9 5069.7 866.2 867.4 871.5 901.4 901.8 3240.8 3442.9 3447.6 3483.8 3488.3 9462.8 9748.1 9767.2 9768.2 9779.3 9741.4 9759.1 9760.7 9764.9 9766.0 7131.1 7491.5 7520.6 7569.7 7577.4 4805.5 4938.2 4980.1 5039.3 5040.3 8944.2 9007.6 9037.8 9082.2 9140.2 8794.2 9126.3 9139.0 9170.9 9422.6 6061.9 6187.4 6195.8 6322.7 6576.5 7430.1 7724.3 7730.3 7757.7 7757.8 6687.5 6751.4 6863.0 6897.4 7048.1 6783.8 6799.6 6885.9 6890.5 6895.0 5828.4 5901.1 5946.5 5983.6 5988.0 4562.4 4569.5 4588.2 4657.2 4764.6 4570.6 4594.9 4679.0 4793.2 4972.0 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | [#4] prototype.html Cycles:180 Average:4191.24 Median:4809.82 stddev:1230.00 (25.6%) stddev-sans-first:1197.85 03:50:03 INFO - PROCESS | 14640 | Values: 276.8 284.6 289.2 291.9 294.6 4703.6 4833.9 4885.5 4950.7 4954.6 4702.4 4817.4 4870.2 4876.6 4906.7 3616.9 3775.5 3824.3 3839.3 3864.4 3669.1 3779.0 3797.7 3810.6 3815.2 3748.5 3768.5 3774.3 3775.3 3782.7 3769.8 3776.6 3788.2 3805.0 3845.1 3142.3 3297.9 3309.6 3398.0 3403.1 4778.7 4796.4 4807.0 4812.6 4814.8 4306.0 4312.4 4326.6 4332.4 4339.8 4941.0 5079.6 5097.0 5104.6 5109.7 3573.9 3577.2 3577.6 3582.9 3583.9 5320.1 5368.3 5368.9 5374.7 5383.2 3525.5 3712.8 3718.7 3729.4 3752.1 3724.6 3737.7 3744.4 3755.2 3776.8 4260.7 4305.9 4322.4 4337.9 4348.7 4839.7 4949.8 5081.9 5120.4 5140.8 1276.7 1288.4 1300.2 1300.3 1303.5 806.6 823.9 832.5 832.8 833.3 4010.3 4020.4 4029.3 4040.4 4066.4 4616.7 4671.5 4696.2 4703.8 4736.9 4048.9 4062.9 4075.9 4083.4 4100.9 2493.4 2593.9 2766.2 2791.8 2815.8 4908.5 4923.9 4928.7 4943.7 4957.2 5249.2 5401.5 5408.7 5419.5 5431.5 4866.8 4881.1 4885.7 4928.1 4940.9 5216.6 5239.0 5262.4 5268.3 5270.9 4907.9 5123.7 5155.5 5174.5 5187.8 4917.0 4926.2 4934.2 4939.6 4947.0 3792.5 3799.7 3801.9 3832.1 3837.1 4925.2 5020.6 5257.6 5267.5 5293.9 5079.7 5101.9 5117.3 5143.8 5159.1 5066.5 5083.9 5117.8 5120.3 5136.4 4769.9 5044.1 5061.4 5064.3 5073.8 5167.2 5175.5 5185.8 5191.0 5201.7 5040.5 5046.0 5058.7 5064.1 5085.3 03:50:03 INFO - PROCESS | 14640 | 03:50:03 INFO - PROCESS | 14640 | [#5] yui.html Cycles:180 Average:16115.68 Median:485.96 stddev:21397.10 (4403.1%) stddev-sans-first:21425.57 03:50:03 INFO - PROCESS | 14640 | Values: 639.8 686.2 709.6 731.8 740.8 11960.5 13941.3 13953.6 13963.8 13987.7 13431.9 13518.7 13583.5 13657.5 13668.1 630.3 777.8 796.2 799.9 800.0 645.4 651.1 651.2 766.0 797.0 822.9 825.9 829.8 833.7 835.4 820.0 827.2 827.3 827.6 827.8 488.5 593.6 605.9 608.6 610.4 13310.9 13431.1 13451.3 13490.4 13504.7 12657.3 12783.0 13334.0 13343.7 13459.1 11240.4 11650.1 11650.4 11777.5 12367.8 3763.7 3789.7 3827.3 3913.0 3931.5 57602.0 57815.1 57917.4 58295.4 58448.0 10042.4 10204.3 10232.8 10340.6 10343.6 19185.1 19195.1 19209.2 19213.3 19244.0 6878.7 6889.9 6906.2 6942.3 7117.0 3802.2 3824.6 3829.4 3920.5 3959.8 2837.6 2953.5 2957.0 2961.5 2963.5 483.4 488.5 494.8 496.5 502.1 524.8 533.5 551.1 566.7 568.7 7497.7 7627.7 7789.5 7802.8 7835.7 431.4 512.1 514.9 554.4 589.7 3465.7 3849.1 4343.1 4442.4 4507.7 70983.3 74139.0 74366.6 84609.0 94448.5 69115.0 73683.0 73708.3 74695.0 75958.0 43088.0 60369.4 63962.0 64296.0 65667.3 8376.2 8469.3 8469.4 8521.9 8614.7 37670.4 38166.6 42874.4 44242.6 45223.1 38784.0 42564.0 53616.0 60366.0 62965.4 10982.0 11066.7 11201.8 11395.3 11618.8 11182.8 11205.9 11632.5 11637.2 11652.2 11078.2 11754.6 12042.2 12156.6 12403.3 11820.9 12121.5 12196.7 12241.6 12352.8 11193.6 11232.2 11311.4 11654.5 11765.9 9303.2 9419.4 9659.9 9679.4 9696.6 9454.7 9622.8 9642.4 9983.8 10089.8 03:50:03 INFO - PROCESS | 14640 | -------- Summary: end -------- 03:50:03 INFO - PROCESS | 14640 | 03:50:04 INFO - TEST-INFO | 14640: exit 0 03:50:04 INFO - TEST-OK | dromaeo_css | took 1120661ms 03:50:04 INFO - TEST-START | kraken 03:50:04 INFO - operating with platform_type : linux_ 03:50:04 INFO - Initialising browser for kraken test... 03:50:04 INFO - TEST-INFO | started process 14823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps2em3C/profile http://localhost:51301/getInfo.html) 03:50:09 INFO - PROCESS | 14823 | __metrics Screen width/height:1600/1200 03:50:09 INFO - PROCESS | 14823 | colorDepth:24 03:50:09 INFO - PROCESS | 14823 | Browser inner width/height: 1024/697 03:50:09 INFO - PROCESS | 14823 | __metrics 03:50:10 INFO - PROCESS | 14823 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:50:10 INFO - TEST-INFO | 14823: exit 0 03:50:10 INFO - Browser initialized. 03:50:10 INFO - Running cycle 1/1 for kraken test... 03:50:10 INFO - TEST-INFO | started process 14905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps2em3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:23 INFO - PROCESS | 14905 | RSS: Main: 175730688 03:50:23 INFO - PROCESS | 14905 | 03:50:25 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51301/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:26 INFO - PROCESS | 14905 | RSS: Main: 233832448 03:50:26 INFO - PROCESS | 14905 | 03:50:29 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51301/tests/kraken/driver.html?testName=audio-dft) 03:50:30 INFO - PROCESS | 14905 | RSS: Main: 222482432 03:50:30 INFO - PROCESS | 14905 | 03:50:33 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51301/tests/kraken/driver.html?testName=audio-fft) 03:50:34 INFO - PROCESS | 14905 | RSS: Main: 288632832 03:50:34 INFO - PROCESS | 14905 | 03:50:36 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51301/tests/kraken/driver.html?testName=audio-oscillator) 03:50:36 INFO - PROCESS | 14905 | RSS: Main: 198877184 03:50:36 INFO - PROCESS | 14905 | 03:50:39 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:39 INFO - PROCESS | 14905 | RSS: Main: 203202560 03:50:39 INFO - PROCESS | 14905 | 03:50:42 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51301/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:43 INFO - PROCESS | 14905 | RSS: Main: 239153152 03:50:43 INFO - PROCESS | 14905 | 03:50:47 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51301/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:47 INFO - PROCESS | 14905 | RSS: Main: 234848256 03:50:47 INFO - PROCESS | 14905 | 03:50:50 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51301/tests/kraken/driver.html?testName=json-parse-financial) 03:50:51 INFO - PROCESS | 14905 | RSS: Main: 237236224 03:50:51 INFO - PROCESS | 14905 | 03:50:52 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:53 INFO - PROCESS | 14905 | RSS: Main: 224620544 03:50:53 INFO - PROCESS | 14905 | 03:50:55 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:55 INFO - PROCESS | 14905 | RSS: Main: 228630528 03:50:55 INFO - PROCESS | 14905 | 03:50:58 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:58 INFO - PROCESS | 14905 | RSS: Main: 236679168 03:50:58 INFO - PROCESS | 14905 | 03:51:01 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:51:02 INFO - PROCESS | 14905 | RSS: Main: 239046656 03:51:02 INFO - PROCESS | 14905 | 03:51:05 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:51:05 INFO - PROCESS | 14905 | RSS: Main: 238669824 03:51:05 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | Cycle 1(1): loaded http://localhost:51301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51301/tests/kraken/driver.html?testName=ai-astar) 03:51:07 INFO - PROCESS | 14905 | RSS: Main: 280952832 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | __start_tp_report 03:51:07 INFO - PROCESS | 14905 | _x_x_mozilla_page_load 03:51:07 INFO - PROCESS | 14905 | _x_x_mozilla_page_load_details 03:51:07 INFO - PROCESS | 14905 | |i|pagename|runs| 03:51:07 INFO - PROCESS | 14905 | |0;ai-astar;103;113;112;112;112;113;114;112;113;113 03:51:07 INFO - PROCESS | 14905 | |1;audio-beat-detection;163;135;132;183;131;162;157;140;200;133 03:51:07 INFO - PROCESS | 14905 | |2;audio-dft;163;160;162;160;163;163;163;163;165;162 03:51:07 INFO - PROCESS | 14905 | |3;audio-fft;76;75;75;112;78;76;75;75;98;77 03:51:07 INFO - PROCESS | 14905 | |4;audio-oscillator;86;85;113;86;87;86;121;85;86;125 03:51:07 INFO - PROCESS | 14905 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;116;117 03:51:07 INFO - PROCESS | 14905 | |6;imaging-darkroom;147;147;146;145;146;146;147;146;146;146 03:51:07 INFO - PROCESS | 14905 | |7;imaging-desaturate;95;94;95;95;95;94;95;95;95;95 03:51:07 INFO - PROCESS | 14905 | |8;json-parse-financial;65;66;65;66;67;66;66;65;66;64 03:51:07 INFO - PROCESS | 14905 | |9;json-stringify-tinderbox;65;64;64;64;64;64;64;64;64;64 03:51:07 INFO - PROCESS | 14905 | |10;stanford-crypto-aes;83;81;88;86;83;88;82;86;105;82 03:51:07 INFO - PROCESS | 14905 | |11;stanford-crypto-ccm;131;129;131;131;130;137;130;130;137;143 03:51:07 INFO - PROCESS | 14905 | |12;stanford-crypto-pbkdf2;174;173;168;174;168;171;170;175;169;166 03:51:07 INFO - PROCESS | 14905 | |13;stanford-crypto-sha256-iterative;73;68;68;67;68;66;67;67;67;65 03:51:07 INFO - PROCESS | 14905 | __end_tp_report 03:51:07 INFO - PROCESS | 14905 | __start_cc_report 03:51:07 INFO - PROCESS | 14905 | _x_x_mozilla_cycle_collect,1872 03:51:07 INFO - PROCESS | 14905 | __end_cc_report 03:51:07 INFO - PROCESS | 14905 | __startTimestamp1466765467825__endTimestamp 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | ------- Summary: start ------- 03:51:07 INFO - PROCESS | 14905 | Number of tests: 14 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.13 (2.8%) stddev-sans-first:0.71 03:51:07 INFO - PROCESS | 14905 | Values: 103.0 113.0 112.0 112.0 112.0 113.0 114.0 112.0 113.0 113.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:159.50 stddev:23.85 (15.0%) stddev-sans-first:25.06 03:51:07 INFO - PROCESS | 14905 | Values: 163.0 135.0 132.0 183.0 131.0 162.0 157.0 140.0 200.0 133.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 03:51:07 INFO - PROCESS | 14905 | Values: 163.0 160.0 162.0 160.0 163.0 163.0 163.0 163.0 165.0 162.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.75 (16.8%) stddev-sans-first:13.36 03:51:07 INFO - PROCESS | 14905 | Values: 76.0 75.0 75.0 112.0 78.0 76.0 75.0 75.0 98.0 77.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:86.00 stddev:16.59 (19.3%) stddev-sans-first:17.20 03:51:07 INFO - PROCESS | 14905 | Values: 86.0 85.0 113.0 86.0 87.0 86.0 121.0 85.0 86.0 125.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:51:07 INFO - PROCESS | 14905 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 03:51:07 INFO - PROCESS | 14905 | Values: 147.0 147.0 146.0 145.0 146.0 146.0 147.0 146.0 146.0 146.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:51:07 INFO - PROCESS | 14905 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 03:51:07 INFO - PROCESS | 14905 | Values: 65.0 66.0 65.0 66.0 67.0 66.0 66.0 65.0 66.0 64.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.32 (0.5%) stddev-sans-first:0.00 03:51:07 INFO - PROCESS | 14905 | Values: 65.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:84.50 stddev:7.01 (8.3%) stddev-sans-first:7.33 03:51:07 INFO - PROCESS | 14905 | Values: 83.0 81.0 88.0 86.0 83.0 88.0 82.0 86.0 105.0 82.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:131.00 stddev:4.56 (3.5%) stddev-sans-first:4.78 03:51:07 INFO - PROCESS | 14905 | Values: 131.0 129.0 131.0 131.0 130.0 137.0 130.0 130.0 137.0 143.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:172.00 stddev:3.08 (1.8%) stddev-sans-first:3.05 03:51:07 INFO - PROCESS | 14905 | Values: 174.0 173.0 168.0 174.0 168.0 171.0 170.0 175.0 169.0 166.0 03:51:07 INFO - PROCESS | 14905 | 03:51:07 INFO - PROCESS | 14905 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.12 (3.1%) stddev-sans-first:1.00 03:51:07 INFO - PROCESS | 14905 | Values: 73.0 68.0 68.0 67.0 68.0 66.0 67.0 67.0 67.0 65.0 03:51:07 INFO - PROCESS | 14905 | -------- Summary: end -------- 03:51:07 INFO - PROCESS | 14905 | 03:51:08 INFO - TEST-INFO | 14905: exit 0 03:51:08 INFO - TEST-OK | kraken | took 64317ms 03:51:08 INFO - SUITE-END | took 1184s 03:51:08 INFO - Completed test suite (00:19:45) 03:51:08 INFO - javascript benchmark 03:51:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2611.9477610447802, 2630.7895368370528, 2639.85480798556, 2642.4054587717765, 2662.760351568359, 4562.931556026662, 4651.604613607839, 4738.691985020975, 4817.494163112875, 4871.707697538146, 4670.159371313162, 4743.051389722061, 4779.474257831635, 4784.90430191396, 4860.246661767423, 4325.762083085429, 4359.520452750195, 4369.956300437003, 4391.846285380012, 4497.505274419811, 4394.1870753910625, 4449.332600109977, 4513.413256276679, 4556.2937744649635, 4564.269716845305, 4250.829966801324, 4448.488423831269, 4479.529649386816, 4499.302608095751, 4507.301368287921, 4280.935785963213, 4311.8490852820005, 4335.9566404335865, 4344.087741574273, 4410.823567057314, 4310.633596144332, 4325.935110973338, 4366.3013917773005, 4381.5618438155925, 4387.451568553931, 4789.305550695164, 4790.928136077961, 4809.663323567352, 4814.614830813562, 4828.46886842447, 4939.802407903716, 5045.722485263309, 5083.74581270935, 5114.539691427789, 5133.871653208662, 5157.381114266274, 5164.1220992431, 5188.040212560688, 5199.714015729133, 5212.139996900507, 4625.051864367797, 4840.515948405131, 4852.927206091911, 4857.95142048575, 4859.975700121477, 5197.986392653472, 5204.7918083277, 5245.475452454724, 5256.0, 5328.17413300939, 5096.159133742891, 5101.132807422747, 5117.360329958755, 5118.488151184852, 5119.3088932994315, 4915.68048076881, 5021.372328458942, 5092.159793634083, 5105.2342148678, 5120.462351453044, 5070.4929507049, 5092.949070509248, 5121.948780512222, 5122.513361230677, 5165.096108181053, 5080.949190508121, 5081.0854046272025, 5089.312942752755, 5099.878408893492, 5145.716985565829, 4254.510731265944, 4300.247456695066, 4305.677074219383, 4396.1867054595, 4444.400005999149, 3759.7368184226843, 3766.0584853786554, 3788.5264341957254, 3795.7532760370486, 3809.504764380613, 4350.32569951658, 4352.9129417412105, 4354.1944740222525, 4354.477462704495, 4400.933985990213, 4983.725895075733, 5035.018171456531, 5104.1578139606545, 5105.591552675777, 5150.27896094547, 4343.457067866517, 4369.235383807821, 4369.366441865912, 4397.07661391105, 4410.669199810027, 4594.425696787902, 4604.677672562955, 4609.262517997105, 4610.608098311681, 4657.138429390574, 4635.072985402865, 4757.119932812441, 4772.093302272557, 4780.282957556395, 4827.42070951488, 5170.43125256229, 5181.481851814789, 5199.324087868704, 5206.0368831766245, 5225.529702326809, 4822.083804077354, 4825.517448255287, 4849.127157111754, 4851.1753001990455, 4894.339264199288, 4871.585915197248, 5004.424491183415, 5044.722540260321, 5068.670536415121, 5106.4893510648635, 5135.666181698178, 5137.486251374982, 5158.561522270649, 5159.277701121921, 5167.58659307262, 5018.372703412074, 5018.598512119095, 5019.372578427697, 5023.547880690755, 5054.69671819692, 4850.175470170009, 4917.434495033117, 4961.627877909099, 4992.926520798046, 5011.498850115106, 4911.091448082117, 4946.678465899705, 4979.950200498093, 4983.302337672656, 4986.700797952134, 4836.782344794563, 5042.420121685906, 5044.722540260321, 5045.596352291735, 5079.746012699424, 4838.806447742051, 4891.877703057452, 4904.950950490449, 4905.23968784839, 4976.2038073908], "value": 4694.420234660456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.7508758427331, 590.371254613836, 597.5309382135024, 600.7026521871675, 612.0941007309181, 26670.333241668945, 28906.0, 28936.421271574556, 29005.274868128254, 37790.8110459448, 37356.81321593395, 41174.79412602933, 41194.38208426876, 41194.58805411945, 41245.0, 7778.805529861756, 7938.2855543001115, 7939.967804185477, 7946.16565260648, 7949.562774047425, 7811.414143939199, 7897.24976127267, 7900.288973992339, 7900.525968441883, 7903.130655627876, 7872.055353357577, 7900.407469439786, 7919.722809701633, 7920.5247685139075, 7927.246911543423, 7834.138244793068, 7841.059072911287, 7842.215778422169, 7883.014623172104, 7890.644920978541, 7684.423668224906, 7744.148143704188, 7747.0703515577925, 7749.225077492262, 7753.108392534874, 37749.81125094384, 38215.426768598496, 38239.617603823885, 38308.0, 38310.80844595759, 2934.0611004478574, 2962.244627619965, 3009.6839831817783, 3079.0, 3211.6467188609236, 29238.707612923812, 29388.0, 29717.405651886842, 29898.85050574755, 30392.0, 3322.7840190387788, 3348.29685765987, 3350.782199157047, 3373.4602463605706, 3434.9828250858836, 255940.0, 256212.0, 256493.717531413, 257089.0, 259342.0, 27586.172414827586, 28315.292117697223, 49891.750541247064, 50546.49453505492, 50636.74681626642, 33330.66669333276, 33406.3318733624, 33467.330653386794, 33516.83241583825, 33521.83239083789, 12795.808062879065, 12854.55009074678, 12858.292793896426, 12866.614001579968, 12879.871201288055, 10708.732281692864, 10759.46202689878, 10766.192535559865, 10770.946145269223, 10773.622923197807, 7663.808404789925, 7706.306432421109, 7737.342325902361, 7749.263819937097, 7755.961220193863, 2868.8709008094684, 2871.9856400717863, 2924.5320748680533, 2959.5731500170086, 2964.155215763497, 817.6263876687104, 865.2947847504264, 882.2280504558511, 952.319091849331, 963.2197919684937, 27187.1843844685, 27899.16302510928, 28263.15210543687, 28436.857815710788, 28661.28346791347, 986.1223511075149, 993.3592832623062, 999.9200063994863, 1022.7801022780138, 1099.4777480696764, 14526.709465810625, 14641.34113964874, 14758.188299643623, 14954.327055282321, 14963.476278330207, 420041.0, 422785.0, 422920.0, 423170.0, 424744.0, 48379.0, 48609.756951215015, 48849.75575122102, 48965.2655210165, 48994.755026224644, 1136.1478890831877, 1170.6019953215948, 1176.7293522489874, 1183.5679976808576, 1185.152615879633, 26236.475270494866, 27262.454750904475, 27837.304067398476, 27876.0, 27999.860000699868, 37531.0, 37689.246215075, 37730.43404348882, 37733.05667358228, 37764.62235377611, 340517.0, 341498.0, 343858.0, 344085.0, 344336.0, 24522.75477245205, 24977.375565611004, 24989.250322490356, 25017.499650007263, 25062.874685627183, 39331.2133757329, 39799.80100099481, 39914.2017159661, 40020.79989600033, 41683.166336673705, 31419.214519637193, 34256.0, 34515.82742086273, 34545.30909381748, 34699.30601388009, 34447.4832877512, 34489.0, 34607.65392346044, 34668.82665586656, 34862.65137348696, 30797.384052319278, 34656.0, 36405.81797090998, 37267.6273237275, 37479.0, 29486.705132948395, 32719.34561308808, 33071.662206362606, 33529.49705754464, 33575.32849342951, 24708.0, 25234.87382563149, 25280.0, 25571.872140639924, 25669.10158144456], "value": 16143.630837906558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.1224906108322, 375.2476285048477, 377.9357509223432, 379.57298039705313, 392.9980350098249, 12426.751464970706, 13843.792343114848, 17134.571635709115, 17230.13849307536, 17249.91375043126, 16039.35842566296, 16561.337546498155, 17334.0, 17336.47990560282, 17406.912965435185, 4863.562279394854, 5007.624428167884, 5044.344235249412, 5049.747512624373, 5051.242313652945, 3763.153290509641, 3952.9011774705573, 3953.268645300614, 3987.541432735229, 5099.59203263738, 3848.3650197717484, 6084.482818960371, 6097.603655762384, 6220.937790622081, 6222.439980401763, 6099.634021958696, 6180.783672571439, 6181.505479561669, 6185.721642526075, 6199.256089269294, 3410.897673069812, 5290.841274761763, 5378.489043540896, 5414.675119492843, 5416.187571864212, 18136.727949080774, 19087.427377178567, 19211.903940480348, 19824.207031718714, 20994.37016889496, 1795.165248159599, 1851.759271294723, 1858.8977606231651, 1918.4052943587394, 1930.758655168104, 9278.164965153168, 11842.934135927722, 11904.702382440508, 13194.274314912676, 13284.0, 1733.479956013191, 1782.58109344304, 1821.6629923464202, 1847.5288801355703, 1859.5630026943657, 42946.355804662955, 58775.70612146912, 59355.70322148405, 63073.68463157701, 67018.66490667564, 8567.228949394585, 9170.495622740813, 9943.502824858728, 10292.845607315896, 10369.170466362673, 13636.113652612548, 13757.31213439324, 13792.655183620289, 13798.93100534491, 13804.0, 7115.501914865909, 7176.210616832144, 7260.528065675714, 7332.120145582564, 7544.132424771222, 6654.168228971379, 6686.866262674816, 6795.728170873209, 7016.5088443808445, 7046.6476676165985, 4423.8451654192595, 4450.910981780411, 4461.955380446154, 4532.501424843264, 4579.839705610354, 1774.8491378232995, 1837.3569250762393, 1855.7123645834647, 1866.150901339887, 1894.1003023563696, 768.2854944901295, 883.6995421556574, 894.5482531321641, 926.3237836379346, 935.6117211357347, 15113.54659360221, 15407.383704651913, 16440.75338869918, 17031.318747250218, 17206.0, 853.4111463090571, 860.5525126933959, 880.801819590587, 888.8844450221429, 889.8309321228945, 9307.627694892128, 9310.348275620641, 9472.479013654178, 9660.661876834278, 9830.852537211947, 402602.0, 405408.0, 415021.0, 415392.0, 416813.0, 52319.738401307746, 70381.0, 71188.28811711817, 71948.0, 75084.24915750882, 867.1501928110487, 892.6794315512949, 893.8078313162571, 906.9909300907038, 907.0657223060258, 11274.60538881168, 14436.0, 14547.85452145465, 15632.531024069296, 15718.607034824221, 34534.82732586321, 35983.46024809578, 36063.27873442464, 36098.63901360953, 36200.0, 46894.53105468902, 47728.761356193, 49168.2624760636, 49272.0, 50073.49926500688, 7809.804754881174, 7823.2959033684965, 7829.921700782919, 7888.408369372435, 8040.276375126266, 10348.586056557653, 11419.657410277705, 11668.0, 11672.591459298883, 11772.352520611448, 9581.281403894875, 10144.239182061523, 10257.128144107535, 10309.175265978854, 10334.276600637882, 9909.0, 9957.601695932082, 10342.638007669695, 10378.532966016397, 10418.843717344094, 9690.46702431373, 10099.394036357842, 10282.537285822007, 10413.895861041292, 10463.11063559606, 7540.472166948261, 7720.729774457867, 7804.726834560764, 8042.396820238622, 8047.1550487198, 9025.187733104052, 9986.550605222928, 9997.500124993867, 10216.066814276706, 10291.639792607222], "value": 8094.150114178592, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1192.3740036480851, 1327.9070465067446, 1392.3734319556202, 1432.792245124457, 1642.1214650162158, 6595.802125936218, 7674.347680447162, 7911.090224624156, 7936.920630793683, 8163.4693744906535, 7868.252516010984, 7966.32286255669, 7970.800729981754, 8059.91940080599, 8062.113167551579, 2189.189999700109, 2219.3785739992745, 2221.577900198965, 2222.122261706625, 2225.0765932138142, 2212.557488502306, 2238.809701175402, 2252.4481502032027, 2253.3915842722536, 2254.1772253127656, 2137.1024169848624, 2187.7046598709208, 2197.52753158071, 2200.6588978708246, 2201.9559608807813, 2159.114762947192, 2162.0, 2162.178372218563, 2167.5773224221202, 2168.1977668262684, 2145.1419432227076, 2205.073868975034, 2209.690643309938, 2214.800667939893, 2214.833887458431, 7843.686252549891, 7963.601819908981, 8017.518948863087, 8097.433179677425, 8119.3910456715985, 4549.931751023737, 4584.037352156051, 4601.723896566184, 4615.9076818463445, 4656.254999200111, 2880.2079428157217, 2975.181824998143, 3032.9090127296217, 3034.1049390429876, 3034.6510151332436, 948.8529277961927, 959.5586030426012, 965.971020869368, 967.3132076225888, 978.9706308810747, 10877.456127193687, 11019.724506887313, 11042.668719938414, 11046.226764126515, 11048.447577621087, 4065.837366505366, 4109.876703698894, 4157.189348077157, 4292.7424354538825, 4299.269124248885, 8602.698905538276, 8706.172913573328, 8729.825403491895, 8765.43024703405, 8767.210951014311, 4624.630029597624, 4636.142313671914, 4642.814287428465, 4647.3029045643425, 4671.906561868744, 3644.927101457956, 3780.527434070741, 4306.5908738670405, 4353.151135528605, 4366.781660916941, 3487.633798451177, 3536.381133301662, 3560.913921254042, 3602.243528858969, 3633.4368172933237, 1059.7933402986343, 1086.750047489082, 1088.374184843718, 1094.9397783122006, 1100.3068067117824, 776.6970881356276, 793.7579038393345, 818.3167055508717, 828.6395417993192, 832.854250506159, 4875.902481950341, 5007.148784706608, 5034.244863270465, 5040.949590504121, 5069.670471419346, 866.2026295436993, 867.4405008769309, 871.5032431514103, 901.4275934781462, 901.7655409593552, 3240.8379581021327, 3442.8622855085514, 3447.5862896452586, 3483.7909725416557, 3488.2500262443696, 9462.769839920766, 9748.073932976356, 9767.218622510181, 9768.169705574963, 9779.266555008402, 9741.366811157252, 9759.072888075621, 9760.707178784647, 9764.853527197098, 9765.951170244103, 7131.0729605151, 7491.464249828772, 7520.623968801648, 7569.697212111454, 7577.393808495417, 4805.519448055166, 4938.185199442052, 4980.05378977993, 5039.2944987702485, 5040.319556859924, 8944.150305720947, 9007.594658240263, 9037.819243615222, 9082.228010618906, 9140.223081038186, 8794.164554367326, 9126.269898408244, 9139.0, 9170.908290917005, 9422.575984080595, 6061.909071363845, 6187.443130118311, 6195.752169913333, 6322.683865806784, 6576.506761992965, 7430.145533263744, 7724.304812566896, 7730.304272615492, 7757.650905709143, 7757.806054848674, 6687.465002799861, 6751.392374686302, 6863.039174515671, 6897.379235868595, 7048.118985126859, 6783.762568310283, 6799.558028728117, 6885.862282754417, 6890.517663763489, 6895.0, 5828.358880523224, 5901.114832775118, 5946.494547963472, 5983.640981541122, 5988.0, 4562.38407814954, 4569.451665800125, 4588.2429399150105, 4657.231556793091, 4764.642651801059, 4570.565796249351, 4594.9310760339295, 4678.976605116953, 4793.161196790478, 4972.0], "value": 4125.634796311535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [276.75507176149114, 284.5887692284649, 289.22343507681876, 291.8686591034035, 294.6331816887975, 4703.553162449562, 4833.9274910876275, 4885.511448855113, 4950.727709975949, 4954.603631709464, 4702.388689470373, 4817.397825271841, 4870.196417591093, 4876.634252431064, 4906.730129842857, 3616.9095772605765, 3775.490308808317, 3824.29250588642, 3839.289731399686, 3864.4396562498423, 3669.1377526281435, 3779.0, 3797.7341586088983, 3810.580836108026, 3815.179736356683, 3748.512693349861, 3768.5289338832645, 3774.3017541754725, 3775.3393156197694, 3782.659560639556, 3769.849206031783, 3776.622337766229, 3788.242351529705, 3804.9809750951345, 3845.0771814764535, 3142.308692087737, 3297.868085276586, 3309.619393769699, 3397.963621095565, 3403.1322012886553, 4778.737169455679, 4796.44840843304, 4807.0, 4812.639052071108, 4814.831480898187, 4305.956940430587, 4312.439382880237, 4326.632236259922, 4332.371806088131, 4339.8047087880805, 4941.0, 5079.568236699885, 5096.974515127437, 5104.566111880495, 5109.693418394908, 3573.928521429557, 3577.177249232665, 3577.624349443323, 3582.9283414331826, 3583.8924832255075, 5320.122179840322, 5368.32895888014, 5368.926214757064, 5374.677519348852, 5383.165609330521, 3525.541679581689, 3712.7586706863967, 3718.7396882218527, 3729.4219395993664, 3752.1370084880086, 3724.5902950675404, 3737.7009839212797, 3744.3711985286486, 3755.1550901047044, 3776.8103047539935, 4260.680448966278, 4305.892352691208, 4322.438083049184, 4337.891552711144, 4348.717333373321, 4839.661223714306, 4949.7772600233075, 5081.949180508148, 5120.359955005624, 5140.791913900231, 1276.655303068185, 1288.3815768431205, 1300.2458574027041, 1300.2783455182275, 1303.5111833062601, 806.5886397937095, 823.9083214740493, 832.5171400587644, 832.7501749475133, 833.295864994079, 4010.27814993304, 4020.43713880057, 4029.274730548471, 4040.4343391925154, 4066.3900414938, 4616.6537509686905, 4671.462781780138, 4696.201645720235, 4703.765711287179, 4736.873663382151, 4048.8582899598373, 4062.857799977046, 4075.8777236682945, 4083.448289649914, 4100.856470023595, 2493.3641921310314, 2593.937819433555, 2766.1839757271655, 2791.8185317954267, 2815.8451285179103, 4908.533689299511, 4923.90152196954, 4928.728919909439, 4943.65394422387, 4957.157283261782, 5249.160134378558, 5401.540869026177, 5408.729563521808, 5419.539339156137, 5431.4840090191365, 4866.805327786919, 4881.121398148367, 4885.682430642068, 4928.088303663833, 4940.901181976412, 5216.634835561475, 5238.982991548205, 5262.368515778131, 5268.315119034501, 5270.8945821084135, 4907.852764417074, 5123.718195499134, 5155.458676839028, 5174.482551744946, 5187.844364669066, 4916.959461823446, 4926.236433352836, 4934.235193545006, 4939.629527785359, 4947.035328110984, 3792.5259342582176, 3799.6770274526975, 3801.8669346572738, 3832.137769001952, 3837.0982819036944, 4925.1873440881855, 5020.623453240948, 5257.63196576236, 5267.499587539178, 5293.867653308698, 5079.746012699424, 5101.9489805101475, 5117.257997590403, 5143.768530416215, 5159.071367153948, 5066.544011039025, 5083.92374114396, 5117.8464646060675, 5120.257562653469, 5136.356365962856, 4769.904601907873, 5044.1424957758, 5061.392632884077, 5064.29099926018, 5073.797048118034, 5167.22491626244, 5175.4565770593545, 5185.844424667266, 5190.97404512975, 5201.699575106223, 5040.470750571284, 5045.974770126126, 5058.747062646779, 5064.12627327891, 5085.338905942203], "value": 3795.512480260333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.8080575827252, 686.239408043919, 709.6168069242609, 731.8182717221465, 740.7518481308762, 11960.521579136835, 13941.302934853267, 13953.581392558226, 13963.790543141848, 13987.720245595083, 13431.932840335785, 13518.729625407486, 13583.52457663982, 13657.521986730466, 13668.11157274779, 630.3349965786094, 777.789996700889, 796.2276591706036, 799.9000124984377, 799.952002879829, 645.4030022229442, 651.0884761334146, 651.2152855808763, 765.9502132361406, 797.0435477427081, 822.9053658829222, 825.9008918929737, 829.7676650537859, 833.7332053742805, 835.4235577451569, 820.0405525535139, 827.1810907201886, 827.3133299361546, 827.5531213144894, 827.7806381308958, 488.46513068190274, 593.5696619950545, 605.8848818724429, 608.5831205624162, 610.4414460768392, 13310.933445332808, 13431.059825812197, 13451.327433628378, 13490.39293231807, 13504.729905401837, 12657.30384828834, 12783.0, 13333.999950003692, 13343.733125337536, 13459.057865949388, 11240.381779002151, 11650.126240531994, 11650.359230242333, 11777.528898844035, 12367.752644947052, 3763.661270485642, 3789.696824254053, 3827.349350610403, 3913.0, 3931.528216613996, 57602.0, 57815.13277300844, 57917.420825791625, 58295.417045829425, 58448.0, 10042.447665378475, 10204.285700000928, 10232.846507302396, 10340.586376545005, 10343.586256549654, 19185.136668849937, 19195.136218870186, 19209.231630734892, 19213.32753353654, 19244.0, 6878.65606719662, 6889.862202755917, 6906.171259448898, 6942.271061538567, 7116.964415177995, 3802.2205447883116, 3824.6366595173413, 3829.368154254517, 3920.4511368408444, 3959.8416063357145, 2837.6169217155834, 2953.468375692353, 2957.038962337249, 2961.5113506271223, 2963.525835866251, 483.44645381038515, 488.53833127693986, 494.83917726738235, 496.4786973677624, 502.1488576862184, 524.7769697878387, 533.5224973648562, 551.1319671517376, 566.6968172028028, 568.7241687781423, 7497.737579184703, 7627.733029344057, 7789.454738168274, 7802.804929876798, 7835.686572537149, 431.38527598172476, 512.060369222481, 514.8687084793354, 554.3597145297189, 589.711041589618, 3465.6707612776745, 3849.0569810396632, 4343.087951530214, 4442.42248507692, 4507.661925355612, 70983.29016709767, 74139.0, 74366.62816685882, 84609.0, 94448.52775736077, 69115.0, 73683.0, 73708.26291737122, 74695.0, 75958.0, 43088.0, 60369.396306036375, 63962.040569391495, 64296.0, 65667.34332656708, 8376.24613784738, 8469.280111190372, 8469.364797640079, 8521.91478085236, 8614.741557753277, 37670.434943475324, 38166.6183338163, 42874.35688464738, 44242.557574423845, 45223.095538089714, 38784.0, 42564.0, 53616.0, 60366.0, 62965.37034629595, 10982.0, 11066.723331916766, 11201.831972520256, 11395.316281023164, 11618.825717614412, 11182.776344473228, 11205.943970280096, 11632.476538555617, 11637.185397022466, 11652.242604230698, 11078.224524283223, 11754.588589399329, 12042.24931871954, 12156.635300940987, 12403.25580465175, 11820.881791181979, 12121.45453454579, 12196.695082622651, 12241.632751017483, 12352.75294494087, 11193.552257909592, 11232.157588180755, 11311.434428278388, 11654.475548600163, 11765.882341176479, 9303.209227215762, 9419.387739796892, 9659.855102173333, 9679.419234845931, 9696.5636546357, 9454.733842766382, 9622.807543849223, 9642.373245739005, 9983.750406239902, 10089.798204035731], "value": 6411.372900820326, "unit": "score"}], "name": "dromaeo_css", "value": 6284.230197658568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 112.0, 112.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 135.0, 132.0, 183.0, 131.0, 162.0, 157.0, 140.0, 200.0, 133.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 160.0, 163.0, 163.0, 163.0, 163.0, 165.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 112.0, 78.0, 76.0, 75.0, 75.0, 98.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 113.0, 86.0, 87.0, 86.0, 121.0, 85.0, 86.0, 125.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 145.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 67.0, 66.0, 66.0, 65.0, 66.0, 64.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 88.0, 86.0, 83.0, 88.0, 82.0, 86.0, 105.0, 82.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 131.0, 131.0, 130.0, 137.0, 130.0, 130.0, 137.0, 143.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 168.0, 174.0, 168.0, 171.0, 170.0, 175.0, 169.0, 166.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 68.0, 67.0, 68.0, 66.0, 67.0, 67.0, 67.0, 65.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1550.6, "alertThreshold": 2.0}]} 03:51:09 INFO - Return code: 0 03:51:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:51:09 INFO - # TBPL SUCCESS # 03:51:09 INFO - Running post-action listener: _resource_record_post_action 03:51:09 INFO - ##### 03:51:09 INFO - ##### Finished run-tests step (success) 03:51:09 INFO - ##### 03:51:09 INFO - Running post-run listener: _resource_record_post_run 03:51:09 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534814720; Read time: 8; Write time: 421144 03:51:09 INFO - TinderboxPrint: CPU usage
13.2% 03:51:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:51:09 INFO - TinderboxPrint: I/O write bytes / time
534,814,720 / 421,144 03:51:09 INFO - TinderboxPrint: CPU idle
8,327.6 (86.8%) 03:51:09 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 03:51:09 INFO - TinderboxPrint: Swap in / out
0 / 0 03:51:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246272000; Read time: 0; Write time: 224868 03:51:09 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288542720; Read time: 8; Write time: 196276 03:51:09 INFO - Running post-run listener: _upload_blobber_files 03:51:09 INFO - Blob upload gear active. 03:51:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:51:09 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 03:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:51:10 INFO - (blobuploader) - INFO - Open directory for files ... 03:51:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:51:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:51:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:13 INFO - (blobuploader) - INFO - Done attempting. 03:51:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:51:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:51:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:14 INFO - (blobuploader) - INFO - Done attempting. 03:51:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:51:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:51:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:51:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:51:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:51:15 INFO - (blobuploader) - INFO - Done attempting. 03:51:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:51:15 INFO - Return code: 0 03:51:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:51:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:51:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ab12925276edc1bff681cdd29af7d80631168d3e55500714c12ce9058a97a8f05b6b96092d4c4c34b108a812dd761615e305dc379b4f47a1967b621603064be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/866e4f149d4a0a11ae5cb37d006e96706f4f8c67bbab1a9b2ca99891872c81e7992ed286a6d44e2dfd90107c46e331a2a137e44e6fa917bf0fcb8b07d178348f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604190a3575f7f72dbc060cbaca8a7c14ab6b24461c90a0a64bc218575525766e868b5319edacc8806e670e2ea6f49d4938a0c1b3dde9fcc46f5ce07c4dfb2d2"} 03:51:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:51:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:51:15 INFO - Contents: 03:51:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ab12925276edc1bff681cdd29af7d80631168d3e55500714c12ce9058a97a8f05b6b96092d4c4c34b108a812dd761615e305dc379b4f47a1967b621603064be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/866e4f149d4a0a11ae5cb37d006e96706f4f8c67bbab1a9b2ca99891872c81e7992ed286a6d44e2dfd90107c46e331a2a137e44e6fa917bf0fcb8b07d178348f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604190a3575f7f72dbc060cbaca8a7c14ab6b24461c90a0a64bc218575525766e868b5319edacc8806e670e2ea6f49d4938a0c1b3dde9fcc46f5ce07c4dfb2d2"} 03:51:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:51:15 INFO - Copying logs to upload dir... 03:51:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:51:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.881368 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-24 03:51:14.879586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:14.883490) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ab12925276edc1bff681cdd29af7d80631168d3e55500714c12ce9058a97a8f05b6b96092d4c4c34b108a812dd761615e305dc379b4f47a1967b621603064be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/866e4f149d4a0a11ae5cb37d006e96706f4f8c67bbab1a9b2ca99891872c81e7992ed286a6d44e2dfd90107c46e331a2a137e44e6fa917bf0fcb8b07d178348f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604190a3575f7f72dbc060cbaca8a7c14ab6b24461c90a0a64bc218575525766e868b5319edacc8806e670e2ea6f49d4938a0c1b3dde9fcc46f5ce07c4dfb2d2"} build_url:https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/Cyn6TeMlTdSYWbjAeEcaCQ/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/Firefox-Non-PGO/sha512/5ab12925276edc1bff681cdd29af7d80631168d3e55500714c12ce9058a97a8f05b6b96092d4c4c34b108a812dd761615e305dc379b4f47a1967b621603064be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/866e4f149d4a0a11ae5cb37d006e96706f4f8c67bbab1a9b2ca99891872c81e7992ed286a6d44e2dfd90107c46e331a2a137e44e6fa917bf0fcb8b07d178348f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/604190a3575f7f72dbc060cbaca8a7c14ab6b24461c90a0a64bc218575525766e868b5319edacc8806e670e2ea6f49d4938a0c1b3dde9fcc46f5ce07c4dfb2d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:14.911656) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:14.912293) ========= 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=03627c79f6bb3d1578c4a402000001ba-1466764229.859947-1455468413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 03:51:14.999356) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:51:14.999719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 03:51:15.000149) ========= ========= Total master_lag: 0.19 =========