builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1467449040.61 results: success (0) buildid: 20160701230321 builduid: 9d1de611188d4cb596350822230b2d72 revision: b59259518acd507a14c72a0f106f70158ef8d7c6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.614271) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.614794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.615071) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.666328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.666663) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 01:44:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-07-02 01:44:01 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104135 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.791724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.792005) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020736 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:00.855800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 01:44:00.856136) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b59259518acd507a14c72a0f106f70158ef8d7c6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b59259518acd507a14c72a0f106f70158ef8d7c6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 01:44:01,316 truncating revision to first 12 chars 2016-07-02 01:44:01,316 Setting DEBUG logging. 2016-07-02 01:44:01,317 attempt 1/10 2016-07-02 01:44:01,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b59259518acd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 01:44:02,547 unpacking tar archive at: mozilla-aurora-b59259518acd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.571046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 01:44:02.444903) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:02.445263) ========= script_repo_revision: b59259518acd507a14c72a0f106f70158ef8d7c6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:02.445715) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:02.446033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 01:44:02.456747) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-02 01:44:02.457087) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:44:02 INFO - MultiFileLogger online at 20160702 01:44:02 in /builds/slave/test 01:44:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:44:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:44:03 INFO - {'append_to_log': False, 01:44:03 INFO - 'base_work_dir': '/builds/slave/test', 01:44:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:44:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:44:03 INFO - 'branch': 'Mozilla-Aurora', 01:44:03 INFO - 'buildbot_json_path': 'buildprops.json', 01:44:03 INFO - 'config_files': ('talos/linux_config.py',), 01:44:03 INFO - 'default_actions': ('clobber', 01:44:03 INFO - 'read-buildbot-config', 01:44:03 INFO - 'download-and-extract', 01:44:03 INFO - 'populate-webroot', 01:44:03 INFO - 'create-virtualenv', 01:44:03 INFO - 'install', 01:44:03 INFO - 'run-tests'), 01:44:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:44:03 INFO - 'download_minidump_stackwalk': True, 01:44:03 INFO - 'download_symbols': 'ondemand', 01:44:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:44:03 INFO - 'tooltool.py': '/tools/tooltool.py', 01:44:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:44:03 INFO - '/tools/misc-python/virtualenv.py')}, 01:44:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:44:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:44:03 INFO - 'installer_path': 'installer.exe', 01:44:03 INFO - 'log_level': 'info', 01:44:03 INFO - 'log_name': 'talos', 01:44:03 INFO - 'log_to_console': True, 01:44:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:44:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:44:03 INFO - 'opt_config_files': (), 01:44:03 INFO - 'pip_index': False, 01:44:03 INFO - 'sps_profile': False, 01:44:03 INFO - 'sps_profile_interval': 0, 01:44:03 INFO - 'suite': 'dromaeojs', 01:44:03 INFO - 'system_bits': '32', 01:44:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:44:03 INFO - 'title': 'talos-linux64-ix-055', 01:44:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:44:03 INFO - 'use_talos_json': True, 01:44:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:44:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:44:03 INFO - 'work_dir': 'build'} 01:44:03 INFO - ##### 01:44:03 INFO - ##### Running clobber step. 01:44:03 INFO - ##### 01:44:03 INFO - Running pre-action listener: _resource_record_pre_action 01:44:03 INFO - Running main action method: clobber 01:44:03 INFO - rmtree: /builds/slave/test/build 01:44:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:44:03 INFO - Running post-action listener: _resource_record_post_action 01:44:03 INFO - ##### 01:44:03 INFO - ##### Finished clobber step (success) 01:44:03 INFO - ##### 01:44:03 INFO - ##### 01:44:03 INFO - ##### Running read-buildbot-config step. 01:44:03 INFO - ##### 01:44:03 INFO - Running pre-action listener: _resource_record_pre_action 01:44:03 INFO - Running main action method: read_buildbot_config 01:44:03 INFO - Using buildbot properties: 01:44:03 INFO - { 01:44:03 INFO - "project": "", 01:44:03 INFO - "product": "firefox", 01:44:03 INFO - "script_repo_revision": "production", 01:44:03 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:44:03 INFO - "repository": "", 01:44:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:44:03 INFO - "buildid": "20160701230321", 01:44:03 INFO - "pgo_build": "True", 01:44:03 INFO - "basedir": "/builds/slave/test", 01:44:03 INFO - "buildnumber": 332, 01:44:03 INFO - "slavename": "talos-linux64-ix-055", 01:44:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:44:03 INFO - "platform": "ubuntu64_hw", 01:44:03 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 01:44:03 INFO - "branch": "mozilla-aurora", 01:44:03 INFO - "repo_path": "releases/mozilla-aurora", 01:44:03 INFO - "revision": "b59259518acd507a14c72a0f106f70158ef8d7c6", 01:44:03 INFO - "stage_platform": "linux64-pgo", 01:44:03 INFO - "builduid": "9d1de611188d4cb596350822230b2d72", 01:44:03 INFO - "slavebuilddir": "test" 01:44:03 INFO - } 01:44:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 01:44:03 INFO - Running post-action listener: _resource_record_post_action 01:44:03 INFO - ##### 01:44:03 INFO - ##### Finished read-buildbot-config step (success) 01:44:03 INFO - ##### 01:44:03 INFO - ##### 01:44:03 INFO - ##### Running download-and-extract step. 01:44:03 INFO - ##### 01:44:03 INFO - Running pre-action listener: _resource_record_pre_action 01:44:03 INFO - Running main action method: download_and_extract 01:44:03 INFO - mkdir: /builds/slave/test/build/tests 01:44: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')]} 01:44:03 INFO - https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:44:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:44:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:44:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:44:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:44:04 INFO - Downloaded 1361 bytes. 01:44:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 01:44:04 INFO - Using the following test package requirements: 01:44:04 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:44:04 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 01:44:04 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 01:44:04 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'jsshell-linux-x86_64.zip'], 01:44:04 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 01:44:04 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 01:44:04 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 01:44:04 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 01:44:04 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 01:44:04 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 01:44:04 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 01:44:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:44:04 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')]} 01:44:04 INFO - https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:44:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:44:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:44:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:44:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:44:05 INFO - Downloaded 24526211 bytes. 01:44:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:44:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:44:07 INFO - Return code: 0 01:44:07 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:07 INFO - https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 01:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:44:09 INFO - Downloaded 24526211 bytes. 01:44:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:44:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:44:10 INFO - Return code: 0 01:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:10 INFO - https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:44:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:44:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:44:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 01:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:44:11 INFO - Downloaded 10833369 bytes. 01:44:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:44:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:44:11 INFO - Return code: 0 01:44:11 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')]} 01:44:11 INFO - https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:44:13 INFO - Downloaded 63613522 bytes. 01:44:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:44:13 INFO - mkdir: /builds/slave/test/properties 01:44:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:44:13 INFO - Writing to file /builds/slave/test/properties/build_url 01:44:13 INFO - Contents: 01:44:13 INFO - build_url:https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 01:44:14 INFO - Running post-action listener: _resource_record_post_action 01:44:14 INFO - Running post-action listener: set_extra_try_arguments 01:44:14 INFO - ##### 01:44:14 INFO - ##### Finished download-and-extract step (success) 01:44:14 INFO - ##### 01:44:14 INFO - ##### 01:44:14 INFO - ##### Running populate-webroot step. 01:44:14 INFO - ##### 01:44:14 INFO - Running pre-action listener: _resource_record_pre_action 01:44:14 INFO - Running main action method: populate_webroot 01:44:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:44:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:44:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:44:14 INFO - '--tppagecycles', 01:44:14 INFO - '7'], 01:44:14 INFO - 'tests': ['tsvgm']}}, 01:44:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:44:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:44:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:44:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:44:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:44:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:44:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['damp', 'tps']}, 01:44:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'tests': ['damp', 'tps']}, 01:44:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['dromaeo_dom']}, 01:44:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:44:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['a11yr', 01:44:14 INFO - 'ts_paint', 01:44:14 INFO - 'tpaint', 01:44:14 INFO - 'sessionrestore', 01:44:14 INFO - 'sessionrestore_no_auto_restore', 01:44:14 INFO - 'tabpaint']}, 01:44:14 INFO - 'other-e10s': {'tests': ['a11yr', 01:44:14 INFO - 'ts_paint', 01:44:14 INFO - 'tpaint', 01:44:14 INFO - 'sessionrestore', 01:44:14 INFO - 'sessionrestore_no_auto_restore', 01:44:14 INFO - 'tabpaint']}, 01:44:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:44:14 INFO - 'ts_paint', 01:44:14 INFO - 'tpaint', 01:44:14 INFO - 'sessionrestore', 01:44:14 INFO - 'sessionrestore_no_auto_restore', 01:44:14 INFO - 'tabpaint']}, 01:44:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:44:14 INFO - 'ts_paint', 01:44:14 INFO - 'tpaint', 01:44:14 INFO - 'sessionrestore', 01:44:14 INFO - 'sessionrestore_no_auto_restore', 01:44:14 INFO - 'tabpaint']}, 01:44:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['a11yr', 01:44:14 INFO - 'ts_paint', 01:44:14 INFO - 'tpaint', 01:44:14 INFO - 'sessionrestore', 01:44:14 INFO - 'sessionrestore_no_auto_restore', 01:44:14 INFO - 'tabpaint']}, 01:44:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['a11yr', 01:44:14 INFO - 'ts_paint', 01:44:14 INFO - 'tpaint', 01:44:14 INFO - 'sessionrestore', 01:44:14 INFO - 'sessionrestore_no_auto_restore', 01:44:14 INFO - 'tabpaint']}, 01:44:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['tsvgx', 01:44:14 INFO - 'tsvgr_opacity', 01:44:14 INFO - 'tart', 01:44:14 INFO - 'tscrollx', 01:44:14 INFO - 'cart']}, 01:44:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:44:14 INFO - 'tsvgr_opacity', 01:44:14 INFO - 'tart', 01:44:14 INFO - 'tscrollx', 01:44:14 INFO - 'cart']}, 01:44:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'talos_options': ['--disable-e10s'], 01:44:14 INFO - 'tests': ['tp5o']}, 01:44:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'tests': ['tp5o']}, 01:44:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'talos_options': ['--disable-e10s', 01:44:14 INFO - '--xperf_path', 01:44:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:44:14 INFO - 'tests': ['tp5n']}, 01:44:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:44:14 INFO - 'talos_options': ['--xperf_path', 01:44:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:44:14 INFO - 'tests': ['tp5n']}}, 01:44:14 INFO - 'talos.zip': {'path': '', 01:44:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:44:14 INFO - Running post-action listener: _resource_record_post_action 01:44:14 INFO - ##### 01:44:14 INFO - ##### Finished populate-webroot step (success) 01:44:14 INFO - ##### 01:44:14 INFO - ##### 01:44:14 INFO - ##### Running create-virtualenv step. 01:44:14 INFO - ##### 01:44:14 INFO - Running pre-action listener: _resource_record_pre_action 01:44:14 INFO - Running main action method: create_virtualenv 01:44:14 INFO - Creating virtualenv /builds/slave/test/build/venv 01:44:14 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 01:44:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:44:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:44:14 INFO - Using real prefix '/usr' 01:44:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:44:14 INFO - Installing distribute.............................................................................................................................................................................................done. 01:44:16 INFO - Installing pip.................done. 01:44:16 INFO - Return code: 0 01:44:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:16 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:16 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 01:44:16 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 01:44:16 INFO - Using env: {'DISPLAY': ':0', 01:44:16 INFO - 'HOME': '/home/cltbld', 01:44:16 INFO - 'LANG': 'en_US.UTF-8', 01:44:16 INFO - 'LANGUAGE': 'en_US:en', 01:44:16 INFO - 'LOGNAME': 'cltbld', 01:44:16 INFO - 'MAIL': '/var/mail/cltbld', 01:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:16 INFO - 'MOZ_NO_REMOTE': '1', 01:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:16 INFO - 'NO_EM_RESTART': '1', 01:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:16 INFO - 'PWD': '/builds/slave/test', 01:44:16 INFO - 'SHELL': '/bin/bash', 01:44:16 INFO - 'SHLVL': '1', 01:44:16 INFO - 'TERM': 'linux', 01:44:16 INFO - 'TMOUT': '86400', 01:44:16 INFO - 'USER': 'cltbld', 01:44:16 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:16 INFO - '_': '/tools/buildbot/bin/python'} 01:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:17 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 01:44:17 INFO - Cleaning up... 01:44:17 INFO - Return code: 0 01:44:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:44:17 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')]} 01:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:17 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')]} 01:44:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:17 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:17 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 01:44:17 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 01:44:17 INFO - Using env: {'DISPLAY': ':0', 01:44:17 INFO - 'HOME': '/home/cltbld', 01:44:17 INFO - 'LANG': 'en_US.UTF-8', 01:44:17 INFO - 'LANGUAGE': 'en_US:en', 01:44:17 INFO - 'LOGNAME': 'cltbld', 01:44:17 INFO - 'MAIL': '/var/mail/cltbld', 01:44:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:17 INFO - 'MOZ_NO_REMOTE': '1', 01:44:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:17 INFO - 'NO_EM_RESTART': '1', 01:44:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:17 INFO - 'PWD': '/builds/slave/test', 01:44:17 INFO - 'SHELL': '/bin/bash', 01:44:17 INFO - 'SHLVL': '1', 01:44:17 INFO - 'TERM': 'linux', 01:44:17 INFO - 'TMOUT': '86400', 01:44:17 INFO - 'USER': 'cltbld', 01:44:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:17 INFO - '_': '/tools/buildbot/bin/python'} 01:44:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:17 INFO - Downloading/unpacking psutil>=3.1.1 01:44:17 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 01:44:17 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 01:44:17 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 01:44:17 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 01:44:17 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 01:44:17 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 01:44:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:44:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:44:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:44:19 INFO - Installing collected packages: psutil 01:44:19 INFO - Running setup.py install for psutil 01:44:19 INFO - building 'psutil._psutil_linux' extension 01:44:19 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 01:44:19 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 01:44:19 INFO - building 'psutil._psutil_posix' extension 01:44:19 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 01:44:19 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 01:44:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:44:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:44:19 INFO - Successfully installed psutil 01:44:19 INFO - Cleaning up... 01:44:19 INFO - Return code: 0 01:44:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:44:19 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')]} 01:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:19 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')]} 01:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:19 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:19 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 01:44:19 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 01:44:19 INFO - Using env: {'DISPLAY': ':0', 01:44:19 INFO - 'HOME': '/home/cltbld', 01:44:19 INFO - 'LANG': 'en_US.UTF-8', 01:44:19 INFO - 'LANGUAGE': 'en_US:en', 01:44:19 INFO - 'LOGNAME': 'cltbld', 01:44:19 INFO - 'MAIL': '/var/mail/cltbld', 01:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:19 INFO - 'MOZ_NO_REMOTE': '1', 01:44:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:19 INFO - 'NO_EM_RESTART': '1', 01:44:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:19 INFO - 'PWD': '/builds/slave/test', 01:44:19 INFO - 'SHELL': '/bin/bash', 01:44:19 INFO - 'SHLVL': '1', 01:44:19 INFO - 'TERM': 'linux', 01:44:19 INFO - 'TMOUT': '86400', 01:44:19 INFO - 'USER': 'cltbld', 01:44:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:19 INFO - '_': '/tools/buildbot/bin/python'} 01:44:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:44:20 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 01:44:20 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 01:44:20 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 01:44:20 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 01:44:20 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 01:44:20 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 01:44:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:44:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:44:22 INFO - Installing collected packages: mozsystemmonitor 01:44:22 INFO - Running setup.py install for mozsystemmonitor 01:44:22 INFO - Successfully installed mozsystemmonitor 01:44:22 INFO - Cleaning up... 01:44:22 INFO - Return code: 0 01:44:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:44: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')]} 01:44:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44: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')]} 01:44:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:22 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:22 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 01:44:22 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 01:44:22 INFO - Using env: {'DISPLAY': ':0', 01:44:22 INFO - 'HOME': '/home/cltbld', 01:44:22 INFO - 'LANG': 'en_US.UTF-8', 01:44:22 INFO - 'LANGUAGE': 'en_US:en', 01:44:22 INFO - 'LOGNAME': 'cltbld', 01:44:22 INFO - 'MAIL': '/var/mail/cltbld', 01:44:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:22 INFO - 'MOZ_NO_REMOTE': '1', 01:44:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:22 INFO - 'NO_EM_RESTART': '1', 01:44:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:22 INFO - 'PWD': '/builds/slave/test', 01:44:22 INFO - 'SHELL': '/bin/bash', 01:44:22 INFO - 'SHLVL': '1', 01:44:22 INFO - 'TERM': 'linux', 01:44:22 INFO - 'TMOUT': '86400', 01:44:22 INFO - 'USER': 'cltbld', 01:44:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:22 INFO - '_': '/tools/buildbot/bin/python'} 01:44:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:22 INFO - Downloading/unpacking jsonschema==2.5.1 01:44:22 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 01:44:22 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 01:44:22 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 01:44:22 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 01:44:22 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 01:44:22 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 01:44:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:44:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:44:24 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 01:44:24 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 01:44:24 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 01:44:24 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 01:44:24 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 01:44:24 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 01:44:24 INFO - Downloading functools32-3.2.3-2.tar.gz 01:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:44:24 INFO - warning: no files found matching '*.txt' 01:44:24 INFO - no previously-included directories found matching 'build' 01:44:24 INFO - no previously-included directories found matching 'dist' 01:44:24 INFO - no previously-included directories found matching '.git*' 01:44:24 INFO - Installing collected packages: jsonschema, functools32 01:44:24 INFO - Running setup.py install for functools32 01:44:24 INFO - warning: no files found matching '*.txt' 01:44:24 INFO - no previously-included directories found matching 'build' 01:44:24 INFO - no previously-included directories found matching 'dist' 01:44:24 INFO - no previously-included directories found matching '.git*' 01:44:24 INFO - Successfully installed jsonschema functools32 01:44:24 INFO - Cleaning up... 01:44:24 INFO - Return code: 0 01:44:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:44:24 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')]} 01:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:24 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')]} 01:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:24 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:24 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 01:44:24 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 01:44:24 INFO - Using env: {'DISPLAY': ':0', 01:44:24 INFO - 'HOME': '/home/cltbld', 01:44:24 INFO - 'LANG': 'en_US.UTF-8', 01:44:24 INFO - 'LANGUAGE': 'en_US:en', 01:44:24 INFO - 'LOGNAME': 'cltbld', 01:44:24 INFO - 'MAIL': '/var/mail/cltbld', 01:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:24 INFO - 'MOZ_NO_REMOTE': '1', 01:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:24 INFO - 'NO_EM_RESTART': '1', 01:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:24 INFO - 'PWD': '/builds/slave/test', 01:44:24 INFO - 'SHELL': '/bin/bash', 01:44:24 INFO - 'SHLVL': '1', 01:44:24 INFO - 'TERM': 'linux', 01:44:24 INFO - 'TMOUT': '86400', 01:44:24 INFO - 'USER': 'cltbld', 01:44:24 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:24 INFO - '_': '/tools/buildbot/bin/python'} 01:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:24 INFO - Downloading/unpacking blobuploader==1.2.4 01:44:24 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 01:44:24 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 01:44:24 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 01:44:24 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 01:44:24 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 01:44:24 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 01:44:26 INFO - Downloading blobuploader-1.2.4.tar.gz 01:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:44:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:44:26 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 01:44:26 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 01:44:26 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 01:44:26 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 01:44:26 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 01:44:26 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 01:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:44:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:44:27 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 01:44:27 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 01:44:27 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 01:44:27 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 01:44:27 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 01:44:27 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 01:44:27 INFO - Downloading docopt-0.6.1.tar.gz 01:44:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:44:27 INFO - Installing collected packages: blobuploader, requests, docopt 01:44:27 INFO - Running setup.py install for blobuploader 01:44:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:44:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:44:27 INFO - Running setup.py install for requests 01:44:27 INFO - Running setup.py install for docopt 01:44:28 INFO - Successfully installed blobuploader requests docopt 01:44:28 INFO - Cleaning up... 01:44:28 INFO - Return code: 0 01:44:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:28 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:28 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 01:44:28 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 01:44:28 INFO - Using env: {'DISPLAY': ':0', 01:44:28 INFO - 'HOME': '/home/cltbld', 01:44:28 INFO - 'LANG': 'en_US.UTF-8', 01:44:28 INFO - 'LANGUAGE': 'en_US:en', 01:44:28 INFO - 'LOGNAME': 'cltbld', 01:44:28 INFO - 'MAIL': '/var/mail/cltbld', 01:44:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:28 INFO - 'MOZ_NO_REMOTE': '1', 01:44:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:28 INFO - 'NO_EM_RESTART': '1', 01:44:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:28 INFO - 'PWD': '/builds/slave/test', 01:44:28 INFO - 'SHELL': '/bin/bash', 01:44:28 INFO - 'SHLVL': '1', 01:44:28 INFO - 'TERM': 'linux', 01:44:28 INFO - 'TMOUT': '86400', 01:44:28 INFO - 'USER': 'cltbld', 01:44:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:28 INFO - '_': '/tools/buildbot/bin/python'} 01:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:44:28 INFO - Running setup.py (path:/tmp/pip-nZV8GO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:44:28 INFO - Running setup.py (path:/tmp/pip-uf5Csl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:44:28 INFO - Running setup.py (path:/tmp/pip-BKsOhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:44:28 INFO - Running setup.py (path:/tmp/pip-sxfOTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:44:28 INFO - Running setup.py (path:/tmp/pip-_jWSuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:44:28 INFO - Running setup.py (path:/tmp/pip-YC8JnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:44:28 INFO - Running setup.py (path:/tmp/pip-dvRG1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:44:28 INFO - Running setup.py (path:/tmp/pip-_QLS1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:44:28 INFO - Running setup.py (path:/tmp/pip-z7YjXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:44:29 INFO - Running setup.py (path:/tmp/pip-LpLN6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:44:29 INFO - Running setup.py (path:/tmp/pip-S7w6I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:44:29 INFO - Running setup.py (path:/tmp/pip-PpIVwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:44:29 INFO - Running setup.py (path:/tmp/pip-eAAHg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:44:29 INFO - Running setup.py (path:/tmp/pip-CvFQaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:29 INFO - Running setup.py (path:/tmp/pip-ELF6BL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:44:29 INFO - Running setup.py (path:/tmp/pip-SneemZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:44:29 INFO - Running setup.py (path:/tmp/pip-7adkUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:44:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:44:29 INFO - Running setup.py install for manifestparser 01:44:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:44:29 INFO - Running setup.py install for mozcrash 01:44:29 INFO - Running setup.py install for mozdebug 01:44:29 INFO - Running setup.py install for mozdevice 01:44:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Running setup.py install for mozfile 01:44:30 INFO - Running setup.py install for mozhttpd 01:44:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Running setup.py install for mozinfo 01:44:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Running setup.py install for mozInstall 01:44:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Running setup.py install for mozleak 01:44:30 INFO - Running setup.py install for mozlog 01:44:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Running setup.py install for moznetwork 01:44:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Running setup.py install for mozprocess 01:44:30 INFO - Running setup.py install for mozprofile 01:44:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:44:30 INFO - Running setup.py install for mozrunner 01:44:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:44:31 INFO - Running setup.py install for mozscreenshot 01:44:31 INFO - Running setup.py install for moztest 01:44:31 INFO - Running setup.py install for mozversion 01:44:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:44:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:44:31 INFO - Cleaning up... 01:44:31 INFO - Return code: 0 01:44:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:44:31 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')]} 01:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:31 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')]} 01:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:31 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:31 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 01:44:31 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 01:44:31 INFO - Using env: {'DISPLAY': ':0', 01:44:31 INFO - 'HOME': '/home/cltbld', 01:44:31 INFO - 'LANG': 'en_US.UTF-8', 01:44:31 INFO - 'LANGUAGE': 'en_US:en', 01:44:31 INFO - 'LOGNAME': 'cltbld', 01:44:31 INFO - 'MAIL': '/var/mail/cltbld', 01:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:31 INFO - 'MOZ_NO_REMOTE': '1', 01:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:31 INFO - 'NO_EM_RESTART': '1', 01:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:31 INFO - 'PWD': '/builds/slave/test', 01:44:31 INFO - 'SHELL': '/bin/bash', 01:44:31 INFO - 'SHLVL': '1', 01:44:31 INFO - 'TERM': 'linux', 01:44:31 INFO - 'TMOUT': '86400', 01:44:31 INFO - 'USER': 'cltbld', 01:44:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:31 INFO - '_': '/tools/buildbot/bin/python'} 01:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:44:31 INFO - Running setup.py (path:/tmp/pip-Fov5Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:44:31 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)) 01:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:44:31 INFO - Running setup.py (path:/tmp/pip-c4KaYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:44:31 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)) 01:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:44:31 INFO - Running setup.py (path:/tmp/pip-ejT0ZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:44:31 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)) 01:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:44:31 INFO - Running setup.py (path:/tmp/pip-VA8OSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:44:31 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)) 01:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:44:31 INFO - Running setup.py (path:/tmp/pip-SFWMfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:44:31 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)) 01:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:44:31 INFO - Running setup.py (path:/tmp/pip-uFsGRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:44:32 INFO - Running setup.py (path:/tmp/pip-kF5g4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:44:32 INFO - Running setup.py (path:/tmp/pip-ZnPFEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:44:32 INFO - Running setup.py (path:/tmp/pip-VlA_wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:44:32 INFO - Running setup.py (path:/tmp/pip-CnTFF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:44:32 INFO - Running setup.py (path:/tmp/pip-T5ZRvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:44:32 INFO - Running setup.py (path:/tmp/pip-qY3XhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:44:32 INFO - Running setup.py (path:/tmp/pip-X7K9Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:44:32 INFO - Running setup.py (path:/tmp/pip-0VXdRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:32 INFO - Running setup.py (path:/tmp/pip-DGrEoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:44:32 INFO - Running setup.py (path:/tmp/pip-dO2q_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:44:32 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)) 01:44:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:44:32 INFO - Running setup.py (path:/tmp/pip-Xpeo_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:44:32 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)) 01:44:32 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)) 01:44:32 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)) 01:44:32 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)) 01:44:32 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)) 01:44:32 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)) 01:44:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:44:32 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 01:44:32 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 01:44:32 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 01:44:32 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 01:44:32 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 01:44:32 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 01:44:34 INFO - Downloading blessings-1.6.tar.gz 01:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:44:34 INFO - Installing collected packages: blessings 01:44:34 INFO - Running setup.py install for blessings 01:44:34 INFO - Successfully installed blessings 01:44:34 INFO - Cleaning up... 01:44:34 INFO - Return code: 0 01:44:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:44:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:44:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:44:35 INFO - Reading from file tmpfile_stdout 01:44:35 INFO - Current package versions: 01:44:35 INFO - argparse == 1.2.1 01:44:35 INFO - blessings == 1.6 01:44:35 INFO - blobuploader == 1.2.4 01:44:35 INFO - docopt == 0.6.1 01:44:35 INFO - functools32 == 3.2.3-2 01:44:35 INFO - jsonschema == 2.5.1 01:44:35 INFO - manifestparser == 1.1 01:44:35 INFO - mozInstall == 1.12 01:44:35 INFO - mozcrash == 0.17 01:44:35 INFO - mozdebug == 0.1 01:44:35 INFO - mozdevice == 0.48 01:44:35 INFO - mozfile == 1.2 01:44:35 INFO - mozhttpd == 0.7 01:44:35 INFO - mozinfo == 0.9 01:44:35 INFO - mozleak == 0.1 01:44:35 INFO - mozlog == 3.2 01:44:35 INFO - moznetwork == 0.27 01:44:35 INFO - mozprocess == 0.22 01:44:35 INFO - mozprofile == 0.28 01:44:35 INFO - mozrunner == 6.11 01:44:35 INFO - mozscreenshot == 0.1 01:44:35 INFO - mozsystemmonitor == 0.3 01:44:35 INFO - moztest == 0.7 01:44:35 INFO - mozversion == 1.4 01:44:35 INFO - psutil == 3.1.1 01:44:35 INFO - requests == 1.2.3 01:44:35 INFO - wsgiref == 0.1.2 01:44:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:44: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')]} 01:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44: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')]} 01:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:35 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:35 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 01:44:35 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 01:44:35 INFO - Using env: {'DISPLAY': ':0', 01:44:35 INFO - 'HOME': '/home/cltbld', 01:44:35 INFO - 'LANG': 'en_US.UTF-8', 01:44:35 INFO - 'LANGUAGE': 'en_US:en', 01:44:35 INFO - 'LOGNAME': 'cltbld', 01:44:35 INFO - 'MAIL': '/var/mail/cltbld', 01:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:35 INFO - 'MOZ_NO_REMOTE': '1', 01:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:35 INFO - 'NO_EM_RESTART': '1', 01:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:35 INFO - 'PWD': '/builds/slave/test', 01:44:35 INFO - 'SHELL': '/bin/bash', 01:44:35 INFO - 'SHLVL': '1', 01:44:35 INFO - 'TERM': 'linux', 01:44:35 INFO - 'TMOUT': '86400', 01:44:35 INFO - 'USER': 'cltbld', 01:44:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:35 INFO - '_': '/tools/buildbot/bin/python'} 01:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 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)) 01:44:35 INFO - Cleaning up... 01:44:35 INFO - Return code: 0 01:44:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:44: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')]} 01:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44: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')]} 01:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:35 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:35 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 01:44:35 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 01:44:35 INFO - Using env: {'DISPLAY': ':0', 01:44:35 INFO - 'HOME': '/home/cltbld', 01:44:35 INFO - 'LANG': 'en_US.UTF-8', 01:44:35 INFO - 'LANGUAGE': 'en_US:en', 01:44:35 INFO - 'LOGNAME': 'cltbld', 01:44:35 INFO - 'MAIL': '/var/mail/cltbld', 01:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:35 INFO - 'MOZ_NO_REMOTE': '1', 01:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:35 INFO - 'NO_EM_RESTART': '1', 01:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:35 INFO - 'PWD': '/builds/slave/test', 01:44:35 INFO - 'SHELL': '/bin/bash', 01:44:35 INFO - 'SHLVL': '1', 01:44:35 INFO - 'TERM': 'linux', 01:44:35 INFO - 'TMOUT': '86400', 01:44:35 INFO - 'USER': 'cltbld', 01:44:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:35 INFO - '_': '/tools/buildbot/bin/python'} 01:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:44:35 INFO - Cleaning up... 01:44:35 INFO - Return code: 0 01:44:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:44: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')]} 01:44:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:44:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44: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')]} 01:44:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:44:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:44:35 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 0x7f5721e8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, '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': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', '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 01:44:35 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 01:44:35 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 01:44:35 INFO - Using env: {'DISPLAY': ':0', 01:44:35 INFO - 'HOME': '/home/cltbld', 01:44:35 INFO - 'LANG': 'en_US.UTF-8', 01:44:35 INFO - 'LANGUAGE': 'en_US:en', 01:44:35 INFO - 'LOGNAME': 'cltbld', 01:44:35 INFO - 'MAIL': '/var/mail/cltbld', 01:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:35 INFO - 'MOZ_NO_REMOTE': '1', 01:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:35 INFO - 'NO_EM_RESTART': '1', 01:44:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:35 INFO - 'PWD': '/builds/slave/test', 01:44:35 INFO - 'SHELL': '/bin/bash', 01:44:35 INFO - 'SHLVL': '1', 01:44:35 INFO - 'TERM': 'linux', 01:44:35 INFO - 'TMOUT': '86400', 01:44:35 INFO - 'USER': 'cltbld', 01:44:35 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:35 INFO - '_': '/tools/buildbot/bin/python'} 01:44:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:44:35 INFO - Downloading/unpacking flake8 01:44:35 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 01:44:35 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 01:44:35 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 01:44:35 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 01:44:35 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 01:44:35 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 01:44:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:44:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:44:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:37 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 01:44:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:44:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:44:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:44:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:44:38 INFO - no previously-included directories found matching 'docs/_build' 01:44:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:44:38 INFO - Running setup.py install for pep8 01:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:44:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:44:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:44:38 INFO - no previously-included directories found matching 'docs/_build' 01:44:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:44:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:44:38 INFO - Cleaning up... 01:44:38 INFO - Return code: 0 01:44:38 INFO - Running post-action listener: _resource_record_post_action 01:44:38 INFO - Running post-action listener: _start_resource_monitoring 01:44:38 INFO - Starting resource monitoring. 01:44:38 INFO - ##### 01:44:38 INFO - ##### Finished create-virtualenv step (success) 01:44:38 INFO - ##### 01:44:38 INFO - ##### 01:44:38 INFO - ##### Running install step. 01:44:38 INFO - ##### 01:44:38 INFO - Running pre-action listener: _resource_record_pre_action 01:44:38 INFO - Running main action method: install 01:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:44:38 INFO - Reading from file tmpfile_stdout 01:44:38 INFO - Detecting whether we're running mozinstall >=1.0... 01:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:44:38 INFO - Reading from file tmpfile_stdout 01:44:38 INFO - Output received: 01:44:38 INFO - Usage: mozinstall [options] installer 01:44:38 INFO - Options: 01:44:38 INFO - -h, --help show this help message and exit 01:44:38 INFO - -d DEST, --destination=DEST 01:44:38 INFO - Directory to install application into. [default: 01:44:38 INFO - "/builds/slave/test"] 01:44:38 INFO - --app=APP Application being installed. [default: firefox] 01:44:38 INFO - mkdir: /builds/slave/test/build/application 01:44:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:44:54 INFO - Reading from file tmpfile_stdout 01:44:54 INFO - Output received: 01:44:54 INFO - /builds/slave/test/build/application/firefox/firefox 01:44:54 INFO - Running post-action listener: _resource_record_post_action 01:44:54 INFO - ##### 01:44:54 INFO - ##### Finished install step (success) 01:44:54 INFO - ##### 01:44:54 INFO - ##### 01:44:54 INFO - ##### Running run-tests step. 01:44:54 INFO - ##### 01:44:54 INFO - Running pre-action listener: _resource_record_pre_action 01:44:54 INFO - Running main action method: run_tests 01:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:44:54 INFO - Python 2.7.3 01:44:54 INFO - Return code: 0 01:44:54 INFO - grabbing minidump binary from tooltool 01:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:44:54 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 0x1e2e1c0>, '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 0x1e2f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e2f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:44:54 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 01:44:54 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 01:44:54 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 01:44:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:44:54 INFO - Return code: 0 01:44:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:44:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:44:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:44:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:44:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:44:55 INFO - Return code: 0 01:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 01:44:55 INFO - Using env: {'DISPLAY': ':0', 01:44:55 INFO - 'HOME': '/home/cltbld', 01:44:55 INFO - 'LANG': 'en_US.UTF-8', 01:44:55 INFO - 'LANGUAGE': 'en_US:en', 01:44:55 INFO - 'LOGNAME': 'cltbld', 01:44:55 INFO - 'MAIL': '/var/mail/cltbld', 01:44:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:44:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:44:55 INFO - 'MOZ_NO_REMOTE': '1', 01:44:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:44:55 INFO - 'NO_EM_RESTART': '1', 01:44:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:44:55 INFO - 'PWD': '/builds/slave/test', 01:44:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:44:55 INFO - 'SHELL': '/bin/bash', 01:44:55 INFO - 'SHLVL': '1', 01:44:55 INFO - 'TERM': 'linux', 01:44:55 INFO - 'TMOUT': '86400', 01:44:55 INFO - 'USER': 'cltbld', 01:44:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599', 01:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:44:55 INFO - '_': '/tools/buildbot/bin/python'} 01:44:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 01:44:56 INFO - mozversion application_buildid: 20160701230321 01:44:56 INFO - mozversion application_changeset: b59259518acd507a14c72a0f106f70158ef8d7c6 01:44:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:44:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:44:56 INFO - mozversion application_name: Firefox 01:44:56 INFO - mozversion application_remotingname: firefox-dev 01:44:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:44:56 INFO - mozversion application_vendor: Mozilla 01:44:56 INFO - mozversion application_version: 49.0a2 01:44:56 INFO - mozversion platform_buildid: 20160701230321 01:44:56 INFO - mozversion platform_changeset: b59259518acd507a14c72a0f106f70158ef8d7c6 01:44:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:44:56 INFO - mozversion platform_version: 49.0a2 01:44:56 INFO - using testdate: 1467449096 01:44:56 INFO - actual date: 1467449096 01:44:56 INFO - starting webserver on 'localhost:54872' 01:44:56 INFO - SUITE-START | Running 2 tests 01:44:56 INFO - TEST-START | dromaeo_css 01:44:56 INFO - operating with platform_type : linux_ 01:44:56 INFO - Initialising browser for dromaeo_css test... 01:44:56 INFO - TEST-INFO | started process 12160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9mtik/profile http://localhost:54872/getInfo.html) 01:44:59 INFO - PROCESS | 12160 | __metrics Screen width/height:1600/1200 01:44:59 INFO - PROCESS | 12160 | colorDepth:24 01:44:59 INFO - PROCESS | 12160 | Browser inner width/height: 1024/697 01:44:59 INFO - PROCESS | 12160 | __metrics 01:45:00 ERROR - PROCESS | 12160 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:45:01 INFO - TEST-INFO | 12160: exit 0 01:45:01 INFO - Browser initialized. 01:45:01 INFO - Running cycle 1/1 for dromaeo_css test... 01:45:01 INFO - TEST-INFO | started process 12252 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr9mtik/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:45:13 INFO - PROCESS | 12252 | RSS: Main: 145248256 01:45:13 INFO - PROCESS | 12252 | 01:46:04 INFO - PROCESS | 12252 | 1467449164519 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] 01:48:12 INFO - PROCESS | 12252 | Cycle 1(1): loaded http://localhost:54872/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54872/tests/dromaeo/cssquery-ext.html) 01:48:13 INFO - PROCESS | 12252 | RSS: Main: 257871872 01:48:13 INFO - PROCESS | 12252 | 01:51:15 INFO - PROCESS | 12252 | Cycle 1(1): loaded http://localhost:54872/tests/dromaeo/cssquery-ext.html (next: http://localhost:54872/tests/dromaeo/cssquery-jquery.html) 01:51:16 INFO - PROCESS | 12252 | RSS: Main: 231731200 01:51:16 INFO - PROCESS | 12252 | 01:54:18 INFO - PROCESS | 12252 | Cycle 1(1): loaded http://localhost:54872/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54872/tests/dromaeo/cssquery-mootools.html) 01:54:18 INFO - PROCESS | 12252 | RSS: Main: 229081088 01:54:18 INFO - PROCESS | 12252 | 01:57:20 INFO - PROCESS | 12252 | Cycle 1(1): loaded http://localhost:54872/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54872/tests/dromaeo/cssquery-prototype.html) 01:57:21 INFO - PROCESS | 12252 | RSS: Main: 219484160 01:57:21 INFO - PROCESS | 12252 | 02:00:24 INFO - PROCESS | 12252 | Cycle 1(1): loaded http://localhost:54872/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54872/tests/dromaeo/cssquery-yui.html) 02:00:24 INFO - PROCESS | 12252 | RSS: Main: 214597632 02:00:24 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | Cycle 1(1): loaded http://localhost:54872/tests/dromaeo/cssquery-yui.html (next: http://localhost:54872/tests/dromaeo/cssquery-dojo.html) 02:03:27 INFO - PROCESS | 12252 | RSS: Main: 255016960 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | __start_tp_report 02:03:27 INFO - PROCESS | 12252 | _x_x_mozilla_page_load 02:03:27 INFO - PROCESS | 12252 | _x_x_mozilla_page_load_details 02:03:27 INFO - PROCESS | 12252 | |i|pagename|runs| 02:03:27 INFO - PROCESS | 12252 | |0;dojo.html;3320.8173550454726;3347.297067615802;3359.815210163441;3374.595048594169;3400.3879301725697;5589.916151257735;5643.887122257553;5661.8584535386635;5663.971680141603;5674.71626418679;5579.9163012554745;5640.802571909984;5644.887102257952;5656.91514627281;5658.830235092953;4941.2094064949615;5109.4379618241965;5113.105206588851;5148.407933087706;5180.378354597454;4994.575461085812;5084.211947148198;5120.257562653413;5121.180611102224;5124.743762811844;5039.0425819094435;5059.342285502879;5086.643934924557;5094.592432605383;5113.488651134894;5175.301334319894;5189.714565698885;5194.3766747990485;5200.115980283361;5214.087534681435;4939.135651261015;4940.530649588283;4982.128127577659;5094.3886733591835;5100.158473851847;5468.0977638689565;5501.119820828688;5501.367342755554;5520.392756796749;5543.196236545678;6049.901738849234;6056.3338032816355;6081.726322315506;6084.421979911901;6107.114468402056;5871.765129394819;5914.260717410324;5922.378150294243;5922.644641321534;6109.961351452437;5554.472325129106;5569.081101618228;5592.245046918654;5606.383297837235;5611.270534830487;5886.705664716747;6052.741483205038;6060.817165348832;6102.9694851525455;6106.267247930276;5879.823605291848;5917.52659787216;5921.644701317935;6017.2779266488305;6024.819255422257;6068.544859135583;6076.27795527153;6079.209702738704;6116.602420842631;6118.174046503754;5756.510696590753;5864.091065884794;6007.519398448114;6038.33578306386;6040.7583696651645;5859;5962.07587823888;5964.940350596526;5970.880582388415;6006.489448396936;4569.474510431343;4569.657275704336;4584.862454126382;4585.839495617637;4610.884727881829;3990.341593637075;4019.3970904363996;4041;4101.282275601758;4141.316682747313;5593.580481463907;5595.440455954372;5609.691466969356;5614;5615.326160860723;5885.47030767233;5928.466438020599;5947.613405128653;5958.582899197015;5987.970060149759;5429.022775900296;5594.496495315441;5656;5662;5703.657780533098;5145.9742701287005;5164.8192313268855;5176.171812510056;5188.507091826271;5197.064528384927;5947.702614869326;6173.907391389043;6195.101710251988;6201.007838745779;6208.286047104551;5886.735096920564;5941.91087133702;5942.7920022799;5972.820815375546;5998.190244317136;6085.786997455068;6147.508199343953;6156.938430615636;6159.414855588712;6162.352952939877;5779.2775903012125;5786.797462088806;5853.824385268449;5873.50075243592;5874.706264686834;5911.674857882857;5975.641461512323;5981.910271345846;5998;6023.27720673522;5803.767849285981;5831.504322132666;5835.737391817293;5847.883042339215;5853.502452291603;5597.132444471114;5763.279590051244;5795.33353664334;5804.3905389935135;5832.329282132439;5759.280089988752;5765.91351129725;5773.711314434346;5777.711114444345;5800.622959507618;5864.9706751467675;5907.940920590911;5955.940440595538;5956.987312157031;5961.523078153824;5588.888222235614;5628.943710562842;5676.545876329801;5679.403662615366;5788.623739456922 02:03:27 INFO - PROCESS | 12252 | |1;ext.html;583.830689100161;628.2021832273014;654.074484604285;654.4568008552899;667.5227212543031;32861.178470538245;35571.64428355716;44113.558864411345;45113.09773804522;45152.774236128855;46729.53270467294;47359;47373.526264737346;47400;47517;8228;8875.378723489343;9019.188273055424;9023.548822558878;9026.954865225665;8270.462419942714;8522.57387130644;8534.274586660142;10765.62320318789;10996.12031037519;10683.519241634145;11031.83452248217;11074.280171788849;11077.833832492519;11078;8298.128696486903;10950.945245273762;10996.890031099707;11007.559697612085;11054.889451105466;10525.21060920434;10892.074173695246;10902.945485272523;11237.213395062348;11241.269317494336;44893.551064489264;45425;45436.3184552232;45450.09099818018;45461.54538454639;3644.781313121221;3645.343838109139;3670.394384926484;3676.0442285006093;3737.3085979093953;34653.30693386144;34757.65242347595;34995.475067874;35534.64465355339;36895.631043689486;4789.353437285957;4826.927596086061;4827.227643577046;4840.177169881129;4849.612031037508;365833;371149;372063;372313;373094;37950;38734.22531549353;66991.66504167546;68120.6593967027;68335;40931.590684093375;40962.59037409647;41038.79480602578;41059.7947010263;41094.79452602718;17259.3959211427;17532.824671753373;17535.561610959827;17536.298548057934;17551;12421.813672794915;12710.618681439571;14647.267636618126;14749.483768068281;14760.040597361352;8792.076831932683;8986.595603197871;9236.122568355995;9259.537023148816;9397;3465.1163953191776;3507.1407505160887;3521.9823900880842;3551.0944709099012;3571.7320351274925;1051.600391851107;1097.5993762276871;1103.178132291448;1115.275071203724;1162.4245998230929;33028;33588.48851801675;33868.153296167795;33926.32147357039;33987.49018764721;1179.7935361311909;1180.4805885410565;1207.6256360528264;1227.8158276258632;1235.882591153839;17198.484045478657;17311.913440432716;17471.825281747275;17488.912555437142;17493.825061749474;550398;553524;556603;556647;560911;41792.37311440331;42403;42633;42660.57339426628;42695.146097078505;1352.7159296547638;1470.1767010474168;1477.6527516033723;1493.387711038469;1513.803205583267;32874.50688239726;34282.48576271308;34427.82786086154;34611.82694086513;34776.65223347835;51200;51528;51846.74076629593;51855.740721296155;51897;405208.8437346884;405862;405975;406800;408873;26754.59868101941;38287;39292.80353598214;39467.21065578615;39546.406803897386;49074;49903.75048124736;50356.24465632945;52148;53211.73394133004;44074.77962610166;44294.557054430334;44942.77528612336;45766.77116614395;46553.76723116363;43617.56382436135;44093;44779;44828.775856121814;45578.54421455876;44044.33933491064;44171.77914110409;44620.77689611661;44863.32705009493;44863.32705009493;37833.243335132596;39620.405693914036;40100.799496002335;40245.59754402418;40750.1849963005;29850;29870.701292987662;30284;30477.39045219039;30548.694513054586 02:03:27 INFO - PROCESS | 12252 | |2;jquery.html;417.99373009404843;422.7717032802287;424.4312621087742;424.7366632687734;440.0209533787324;19260.422187334367;19458.90270548647;19976.700349494768;20346.491337716565;20420.183192672295;19092.809071909276;19653.115609797558;19864;20078.498037549067;20111.49721256969;5738.225339579166;5991.970040149793;5993.790217342394;5997.550183736215;6001.9699901500435;5664.320281566218;5858.297004359483;5876.882462350751;5890.911636325459;5940;5783.479486846183;5825.766969321222;5837.416258374171;5843.678597677126;5843.883122337551;5717.456841600062;5816.1566572846705;5820.039693450575;5821.50517206038;5834.620749651302;4993.425756038066;5051.419086805027;5057.367829021372;5058.696478211283;5064.696118232881;23500;23564.64653030206;24412.389690257707;24470;24773.132940347183;2387.8925448354867;2424.078850036992;2571.845689258632;2654.774344180747;3080.86136123875;10008.94995525025;14292.213928233943;14895.957282990195;14998;15907.920460397623;1997.4107638246753;2067.1008111471556;2121.95756084879;2168.609650262952;2201.416624594484;77970;81561.77657335204;81623.5918820408;81894.59052704758;85158;11038.558457661604;11224.270422422516;11516.712082198012;11517.539298428137;11551.075913926865;15964.121973291349;16025.358985640676;16071.437499687689;16091.436799711953;16163.838361616468;8764.912350876537;8780.385373023826;8933;8960;9025.729228123035;8814.162654547808;8827.735167944844;8864.157904999014;8911.064338244521;8955.194032537103;4653.813847446132;4721;4873.707577545359;4921.557059864629;4936.6297527685565;1815.0090701159534;1992.1334219614514;1999.9600607077452;2006.9799302007084;2026.574419371919;928.9489078100769;1002.7443002034435;1027.8406846938738;1034.8602938603342;1049.6483677967967;19299.131539080776;19775.802241977395;20070.19719211215;20236.89881550583;20500.549699282135;992.1318846009741;998.8801343838786;1029.5675816157232;1047.6699839550517;1064.1061508333037;9475.194608458358;11178.27341222818;11189.664310070712;11200.719982000515;11207.047400970845;472773;476684;478007;483508;489414;102006.48996754969;102187.48906255422;104618.47690761497;104671.47664261782;105048;1088.8257878739523;1127.475723788426;1134.240059160348;1160.0603511155991;1164.6564263542275;17235.138243088048;17518.211680474153;17785.911070444567;17899;17927.910360448637;41129.38305925354;44064.77967610142;44303.77848110739;44816.327755083046;45936.54063459323;62112.68943655253;63626.68186659037;63999.36000639934;64212.35787642064;66532.33467665454;8646.610902509276;8687.435316704394;8735.825283494167;8804.911950880665;9138.268938485038;9121.908780912372;9953.601855925972;10950.507227174638;13762.174269543859;14449.277536122941;11667.824982625098;12039.337836419081;12073.698157546132;12244.75510489803;12649.241045537297;11645;11678.182527223013;12030.699232519257;12126.151169418408;12323.44544495482;12030.819537706766;12109.273443593413;12142.635720928387;12163.878361216275;12617.621471355875;7912.169222231582;8241.876371854547;8263.256306932404;8349.66601335964;8906.910930890608;9656.9034309656;11695.76608467809;12227.938860305641;12692.048096392991;13154.934225328812 02:03:27 INFO - PROCESS | 12252 | |3;mootools.html;1344.9394777235023;1509.37360995187;1543.6140964758813;1683.4612923864368;1862.3761040051575;8961.865572016424;9369.43783372998;9372.765680857981;9631.614735410592;9636.903630963705;9444.386114902527;9656.903430965689;9660.5169741513;9662.468564228964;9667.516624168798;2115.8307335413206;2172.73927128744;2409.722881868581;2492.663490428796;2531.405119796846;2455.8035357171475;2488.203774792067;2488.713797913245;2489.7136829264596;2491.9377015574573;2356.352003199125;2429.101232543961;2429.4898071404937;2430.0158435833514;2432.2581612608146;2089.8223650989607;2360.3273067175946;2362.621980483123;2431.3921519620094;2435.902563897442;2414.3360575841607;2414.6740190074465;2434.245383930987;2434.9513009739885;2436.293474892279;9340.532973351374;9469.242460603135;9475.052494750538;9503.762405939839;9510;5481.506664400184;5624.943750562524;5629.240052592889;5629.831105066854;5639.605227634067;3524.1189702574356;3588.4617307404096;3631.6005239423644;3635.63643635637;3687.4284485904727;1155.5839897636845;1158.357111802949;1183.7159081820387;1185.8991985681228;1229.674136353867;13637.181769093788;13743.175409475463;13752.31238438074;13758.793618095737;13771.586852394445;4831;4897.41231052276;4958.454569997298;4965.354503914468;5023.472535383732;11399.145064120225;11407.771844563062;11511.48198331077;11586.13104017202;11596.362200078907;5606.915896261559;5609.214709940612;5609.887802243932;5614.326280846324;5614.6631202128;4400.537943515885;5119.462456442095;5253.894922101536;5256.842294731164;5259.947400526023;4315.115401342718;4326.329418940069;4340.500842403101;4368.978155109204;4395.802188901507;1322.4313545175476;1378.076688618608;1388.0908005256574;1395.2047333020284;1396.3158052554174;927.3091546797679;929.9395539289925;950.6862735297335;953.4041224234853;956.4691596164196;5938.049912014057;6048.243969503812;6097.634141951497;6099.085137229451;6212.494882829278;443.53428899655233;446.16789687233074;449.23629829289683;449.62905602877754;473.60217417369574;3963.781991990468;4254.553271906467;4266.040140968319;4285.37862010013;4286.442762440863;11398.544058237578;11601;11893.88106118945;11918.821217681741;12081.335526545949;11682;11911.642650720492;11981.221220620631;12173;12215.572454964211;8821.426607270507;8984.955075224581;8989.41568798039;9005.954970225239;9057.81884362309;6209.59637623553;6229.314775374796;6269.435750782452;6395.8720825582295;6470.870582588228;10759.515821788194;11065.557377704801;11073.723156921142;11364.431778411212;11368.488418021043;11304.434778261219;11404.82892756626;11522.654320370402;11531.942340288246;11616.361100139573;7689.538627682357;7946.165652606393;8106.554139522383;8438.113998030118;8547.786305342415;8685.652573896974;8884.555772211494;9121.315901307296;9149.31380146505;9491.430514169171;8183.140770219041;8361.832763344577;8397.538135402612;8438.704645337384;8574.485530868167;8154.469959452854;8221.958890205511;8338.583070846555;8388;8438.746837594881;7073.504854660125;7214.170370407261;7221.350078492961;7221.386182174574;7225.963870180615;5231.189165679326;5317.5012906555485;5319.095753721799;5331.440198779227;5372.838814835562;5249.89500209986;5282.2604835323855;5289.127293996447;5365.678059316453;5388.595855310789 02:03:27 INFO - PROCESS | 12252 | |4;prototype.html;350.35184907920353;357.06092975474496;359.1631498608243;362.5703541303554;362.74064044208404;5501.91747123793;5519.889602207953;5573.554115670747;5592.692401917893;5608.158776183574;5479.863003424916;5482.108672507979;5522.475364840344;5532.723363831812;5534.640248383852;3978.8660231833787;4035.4148648445957;4224.302990006645;4279.379489973952;4307;4252.893677658068;4295.312749960007;4298.871033868989;4312.310030395138;4313.590208930146;4097.487814023247;4276.315789473685;4278.486581610211;4280.250956082688;4284.250256205167;3988.521377434712;4219.599138081878;4227.408162857202;4234.153169366108;4240.893977650552;3722.7766334020043;3728.12389088564;3741.1021354874906;3744.569374521938;3751.81240937952;5216.017913192963;5297.496737809902;5304.832936753946;5331.813956277946;5343.572514198893;4814.518548145157;4827.420709514846;4830.299606557065;4838.95161048392;4847.321375007502;5643.379228284926;5652.576056795716;5705.77176912923;5716.771329146829;5748.712564371806;4011.29802284599;4075.0627355708057;4127.855525056609;4143.7928103595;4145.419641250227;5895.852603684899;5919.260092488439;5931.953476050799;5935.9406405935815;6005.099235114724;4128.3601041838565;4158.875233742992;4196.538380778173;4207.179599978036;4227.534971153171;4211.768352740567;4284.3359279311135;4286.742795432284;4287.871363859089;4308.547602501755;4717.858464246009;4793.376861008116;4828.788855411112;4831.371921650163;4842.443119041285;5721.656700597894;5735.913961290584;5736.254286942754;5782.277215348082;5825.446582574734;1457.358762144674;1503.518873960344;1523.5048609202054;1532.716447457224;1540.6302487402943;946.1720994130136;957.9856302155473;984.104464936904;1028.0850043461326;1054.9894501055044;5518.779248830082;5542.63972841764;5569.27599412082;5583.525400341016;5587.273654424899;5846.444587764156;5866.823995280149;5869.853253668693;5959.361175676723;5968.671723055274;5452.563794896399;5672.404397538282;5766;5776.537876969833;5777.62445441045;3195.6578237140457;3207.887723929651;3212.0685001349816;3222.5810644616517;3227.9193020174685;6085.726142323606;6151.64663773969;6218.19163508741;6283.6858157091965;6295.401936815995;6029.60807547508;6069.514438844882;6083.178770865965;6105.267367915879;6131.5780266795255;6064.331694054514;6176.382361763787;6210.254769427697;6212;6212.502999760009;5847.94152058474;5858;5948.226730525004;6013.9699301503215;6023.849403764941;5883.352831188651;5905.498032667099;5918.23063001807;5920.615160014758;5950.256217972754;5832.912506312494;6119.724612392364;6146.477549408351;6154.661493617715;6164.506839452923;4204.936925946052;4221.957780422156;4243.978780106079;4246.299360605465;4250.872473825791;5941.851453713519;5969.940300596939;5993.910091348721;5995.970020149872;6013.729382177725;5678.5457163426;5786.132080188006;5789.884202316014;5799.2750906136735;5829;5738.885222295447;5743.511801496919;5809.970950145392;5838.795642152504;5871.236739223874;5408.8377348679605;5478.671279723229;5645.322561292671;5783.884322313446;5803.823566162689;5849.707514624167;5864.67744274069;5874.94125058744;5876.178384700756;5905.52755779528;5708.201916396322;5722.971385143048;5767.452092051249;5781.739821707949;5786.971065144648 02:03:27 INFO - PROCESS | 12252 | |5;yui.html;721.7401735375267;764.3961270596229;790.0716657926935;806.3750593290196;817.6974519427811;16016.679666406664;16727.91636041821;17251.137443127856;17287.654246915055;17293.481195564123;14245.216513091777;14257.500987465415;14275.785863212033;14275.857241427582;14293;715.2346988722056;828.9171082891693;859.9398042137053;862.9611667474978;863.6588547523725;857.8798968144465;859.4327743689166;860.8751730999002;861.3109512390095;861.7802460372627;734.5776178697243;902.7291812456269;906.9183773460387;907.2877790934118;908.1463424381094;744.0216115807723;747.8691229034924;860.5224100624182;881.532787622561;884.6019291318933;653.8855700252484;654.5025780406925;655.472344762466;655.5476721062452;655.6295692933477;15684.215789210608;15774.921125394414;15824.367025318974;15831.445899393466;15850.841491585052;14165.71668566623;14346.569602911824;14440.9169312302;14799.70400591993;15089.622759430993;12928.935355323163;12929.806052909214;13086.47654093835;13123.081384303103;13255.734885302336;4676.485586585472;4677.134730074947;4734.289856521515;4753.382060332169;4805.903881922377;72653;73655.63172184158;74349;75183.62408187978;75570.62214688947;11453.312801231787;11621.47703353351;11658;11722.88277117235;11890.464929078213;23062.308130756104;23128.19051333229;23164.65253021206;23178.65232021521;23201.53596928052;7035.542689725152;7781.727639532589;8170.182981701902;8681.348898832613;8947.731568052839;4853.684510506806;4910.06708725341;4911.18965370717;4999.700017998932;5041.697498150123;4082.7142100053306;4345.022369966732;4357.4988876279;4367.847125350661;4368;715.4634024481638;715.7244460882598;718.6622287524959;720.5208536323391;728.8760910645203;710.2223065743003;710.4955481608116;715.301204222453;720.333691335523;729.390958549617;10037.849432258521;10393;10421.791564168825;10648.254622176528;10678.57285708563;631.4979591224987;664.6145235763246;715.391331957456;744.9217832127548;749.6027105633914;4633.675642705046;4737.24204127338;4824.276358546176;4889.364382630235;5013.423456302499;117575;122421;124370;125478;128876;103129;111252;112010;113134.86865131409;113205;90014;93054;93795.53102234582;98279.50860245652;98951.50524247477;9122.90877091247;9441.386309889835;9649.951750241204;9679.854802177832;9742.512874356396;57644.71177644085;58210;58346.12480812706;59132.1130183039;59373.10940335985;78164;79820.20179798128;80956.78564821415;81259.18740812753;81800.18199817925;12161.33112678811;12268.263904165779;12430.751384972431;12521.87478125207;12636.2418254905;11952.223105498115;13150.408231629408;13484.662883427993;13538;13892.027558070838;9359.298052645943;11904.285742855456;12683.936580317039;13063.673408164872;13254.403551839998;12921.35393230316;12963.15739476931;13416.1279516835;13421.463141474233;13536.59390218295;12921.547745828851;13227.603171904859;13230.933845330712;13321.66695832612;13385.799213012007;9903.653372131941;10113.898861011296;10295.639652612123;10343.793124137626;10635.255532112678;10644.254902156774;10766.838497422388;10897.78204435891;10901.236913415985;10957.945210273898 02:03:27 INFO - PROCESS | 12252 | __end_tp_report 02:03:27 INFO - PROCESS | 12252 | __start_cc_report 02:03:27 INFO - PROCESS | 12252 | _x_x_mozilla_cycle_collect,974 02:03:27 INFO - PROCESS | 12252 | __end_cc_report 02:03:27 INFO - PROCESS | 12252 | __startTimestamp1467450207400__endTimestamp 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | ------- Summary: start ------- 02:03:27 INFO - PROCESS | 12252 | Number of tests: 6 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | [#0] dojo.html Cycles:165 Average:5551.67 Median:5763.28 stddev:613.13 (10.6%) stddev-sans-first:589.51 02:03:27 INFO - PROCESS | 12252 | Values: 3320.8 3347.3 3359.8 3374.6 3400.4 5589.9 5643.9 5661.9 5664.0 5674.7 5579.9 5640.8 5644.9 5656.9 5658.8 4941.2 5109.4 5113.1 5148.4 5180.4 4994.6 5084.2 5120.3 5121.2 5124.7 5039.0 5059.3 5086.6 5094.6 5113.5 5175.3 5189.7 5194.4 5200.1 5214.1 4939.1 4940.5 4982.1 5094.4 5100.2 5468.1 5501.1 5501.4 5520.4 5543.2 6049.9 6056.3 6081.7 6084.4 6107.1 5871.8 5914.3 5922.4 5922.6 6110.0 5554.5 5569.1 5592.2 5606.4 5611.3 5886.7 6052.7 6060.8 6103.0 6106.3 5879.8 5917.5 5921.6 6017.3 6024.8 6068.5 6076.3 6079.2 6116.6 6118.2 5756.5 5864.1 6007.5 6038.3 6040.8 5859.0 5962.1 5964.9 5970.9 6006.5 4569.5 4569.7 4584.9 4585.8 4610.9 3990.3 4019.4 4041.0 4101.3 4141.3 5593.6 5595.4 5609.7 5614.0 5615.3 5885.5 5928.5 5947.6 5958.6 5988.0 5429.0 5594.5 5656.0 5662.0 5703.7 5146.0 5164.8 5176.2 5188.5 5197.1 5947.7 6173.9 6195.1 6201.0 6208.3 5886.7 5941.9 5942.8 5972.8 5998.2 6085.8 6147.5 6156.9 6159.4 6162.4 5779.3 5786.8 5853.8 5873.5 5874.7 5911.7 5975.6 5981.9 5998.0 6023.3 5803.8 5831.5 5835.7 5847.9 5853.5 5597.1 5763.3 5795.3 5804.4 5832.3 5759.3 5765.9 5773.7 5777.7 5800.6 5865.0 5907.9 5955.9 5957.0 5961.5 5588.9 5628.9 5676.5 5679.4 5788.6 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | [#1] ext.html Cycles:180 Average:60481.13 Median:39583.41 stddev:119685.73 (302.4%) stddev-sans-first:119936.99 02:03:27 INFO - PROCESS | 12252 | Values: 583.8 628.2 654.1 654.5 667.5 32861.2 35571.6 44113.6 45113.1 45152.8 46729.5 47359.0 47373.5 47400.0 47517.0 8228.0 8875.4 9019.2 9023.5 9027.0 8270.5 8522.6 8534.3 10765.6 10996.1 10683.5 11031.8 11074.3 11077.8 11078.0 8298.1 10950.9 10996.9 11007.6 11054.9 10525.2 10892.1 10902.9 11237.2 11241.3 44893.6 45425.0 45436.3 45450.1 45461.5 3644.8 3645.3 3670.4 3676.0 3737.3 34653.3 34757.7 34995.5 35534.6 36895.6 4789.4 4826.9 4827.2 4840.2 4849.6 365833.0 371149.0 372063.0 372313.0 373094.0 37950.0 38734.2 66991.7 68120.7 68335.0 40931.6 40962.6 41038.8 41059.8 41094.8 17259.4 17532.8 17535.6 17536.3 17551.0 12421.8 12710.6 14647.3 14749.5 14760.0 8792.1 8986.6 9236.1 9259.5 9397.0 3465.1 3507.1 3522.0 3551.1 3571.7 1051.6 1097.6 1103.2 1115.3 1162.4 33028.0 33588.5 33868.2 33926.3 33987.5 1179.8 1180.5 1207.6 1227.8 1235.9 17198.5 17311.9 17471.8 17488.9 17493.8 550398.0 553524.0 556603.0 556647.0 560911.0 41792.4 42403.0 42633.0 42660.6 42695.1 1352.7 1470.2 1477.7 1493.4 1513.8 32874.5 34282.5 34427.8 34611.8 34776.7 51200.0 51528.0 51846.7 51855.7 51897.0 405208.8 405862.0 405975.0 406800.0 408873.0 26754.6 38287.0 39292.8 39467.2 39546.4 49074.0 49903.8 50356.2 52148.0 53211.7 44074.8 44294.6 44942.8 45766.8 46553.8 43617.6 44093.0 44779.0 44828.8 45578.5 44044.3 44171.8 44620.8 44863.3 44863.3 37833.2 39620.4 40100.8 40245.6 40750.2 29850.0 29870.7 30284.0 30477.4 30548.7 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | [#2] jquery.html Cycles:180 Average:29601.50 Median:2405.99 stddev:79534.85 (3305.7%) stddev-sans-first:79727.78 02:03:27 INFO - PROCESS | 12252 | Values: 418.0 422.8 424.4 424.7 440.0 19260.4 19458.9 19976.7 20346.5 20420.2 19092.8 19653.1 19864.0 20078.5 20111.5 5738.2 5992.0 5993.8 5997.6 6002.0 5664.3 5858.3 5876.9 5890.9 5940.0 5783.5 5825.8 5837.4 5843.7 5843.9 5717.5 5816.2 5820.0 5821.5 5834.6 4993.4 5051.4 5057.4 5058.7 5064.7 23500.0 23564.6 24412.4 24470.0 24773.1 2387.9 2424.1 2571.8 2654.8 3080.9 10008.9 14292.2 14896.0 14998.0 15907.9 1997.4 2067.1 2122.0 2168.6 2201.4 77970.0 81561.8 81623.6 81894.6 85158.0 11038.6 11224.3 11516.7 11517.5 11551.1 15964.1 16025.4 16071.4 16091.4 16163.8 8764.9 8780.4 8933.0 8960.0 9025.7 8814.2 8827.7 8864.2 8911.1 8955.2 4653.8 4721.0 4873.7 4921.6 4936.6 1815.0 1992.1 2000.0 2007.0 2026.6 928.9 1002.7 1027.8 1034.9 1049.6 19299.1 19775.8 20070.2 20236.9 20500.5 992.1 998.9 1029.6 1047.7 1064.1 9475.2 11178.3 11189.7 11200.7 11207.0 472773.0 476684.0 478007.0 483508.0 489414.0 102006.5 102187.5 104618.5 104671.5 105048.0 1088.8 1127.5 1134.2 1160.1 1164.7 17235.1 17518.2 17785.9 17899.0 17927.9 41129.4 44064.8 44303.8 44816.3 45936.5 62112.7 63626.7 63999.4 64212.4 66532.3 8646.6 8687.4 8735.8 8804.9 9138.3 9121.9 9953.6 10950.5 13762.2 14449.3 11667.8 12039.3 12073.7 12244.8 12649.2 11645.0 11678.2 12030.7 12126.2 12323.4 12030.8 12109.3 12142.6 12163.9 12617.6 7912.2 8241.9 8263.3 8349.7 8906.9 9656.9 11695.8 12227.9 12692.0 13154.9 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | [#3] mootools.html Cycles:180 Average:6225.17 Median:2652.30 stddev:3686.50 (139.0%) stddev-sans-first:3678.60 02:03:27 INFO - PROCESS | 12252 | Values: 1344.9 1509.4 1543.6 1683.5 1862.4 8961.9 9369.4 9372.8 9631.6 9636.9 9444.4 9656.9 9660.5 9662.5 9667.5 2115.8 2172.7 2409.7 2492.7 2531.4 2455.8 2488.2 2488.7 2489.7 2491.9 2356.4 2429.1 2429.5 2430.0 2432.3 2089.8 2360.3 2362.6 2431.4 2435.9 2414.3 2414.7 2434.2 2435.0 2436.3 9340.5 9469.2 9475.1 9503.8 9510.0 5481.5 5624.9 5629.2 5629.8 5639.6 3524.1 3588.5 3631.6 3635.6 3687.4 1155.6 1158.4 1183.7 1185.9 1229.7 13637.2 13743.2 13752.3 13758.8 13771.6 4831.0 4897.4 4958.5 4965.4 5023.5 11399.1 11407.8 11511.5 11586.1 11596.4 5606.9 5609.2 5609.9 5614.3 5614.7 4400.5 5119.5 5253.9 5256.8 5259.9 4315.1 4326.3 4340.5 4369.0 4395.8 1322.4 1378.1 1388.1 1395.2 1396.3 927.3 929.9 950.7 953.4 956.5 5938.0 6048.2 6097.6 6099.1 6212.5 443.5 446.2 449.2 449.6 473.6 3963.8 4254.6 4266.0 4285.4 4286.4 11398.5 11601.0 11893.9 11918.8 12081.3 11682.0 11911.6 11981.2 12173.0 12215.6 8821.4 8985.0 8989.4 9006.0 9057.8 6209.6 6229.3 6269.4 6395.9 6470.9 10759.5 11065.6 11073.7 11364.4 11368.5 11304.4 11404.8 11522.7 11531.9 11616.4 7689.5 7946.2 8106.6 8438.1 8547.8 8685.7 8884.6 9121.3 9149.3 9491.4 8183.1 8361.8 8397.5 8438.7 8574.5 8154.5 8222.0 8338.6 8388.0 8438.7 7073.5 7214.2 7221.4 7221.4 7226.0 5231.2 5317.5 5319.1 5331.4 5372.8 5249.9 5282.3 5289.1 5365.7 5388.6 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | [#4] prototype.html Cycles:180 Average:4868.20 Median:5578.54 stddev:1439.54 (25.8%) stddev-sans-first:1403.07 02:03:27 INFO - PROCESS | 12252 | Values: 350.4 357.1 359.2 362.6 362.7 5501.9 5519.9 5573.6 5592.7 5608.2 5479.9 5482.1 5522.5 5532.7 5534.6 3978.9 4035.4 4224.3 4279.4 4307.0 4252.9 4295.3 4298.9 4312.3 4313.6 4097.5 4276.3 4278.5 4280.3 4284.3 3988.5 4219.6 4227.4 4234.2 4240.9 3722.8 3728.1 3741.1 3744.6 3751.8 5216.0 5297.5 5304.8 5331.8 5343.6 4814.5 4827.4 4830.3 4839.0 4847.3 5643.4 5652.6 5705.8 5716.8 5748.7 4011.3 4075.1 4127.9 4143.8 4145.4 5895.9 5919.3 5932.0 5935.9 6005.1 4128.4 4158.9 4196.5 4207.2 4227.5 4211.8 4284.3 4286.7 4287.9 4308.5 4717.9 4793.4 4828.8 4831.4 4842.4 5721.7 5735.9 5736.3 5782.3 5825.4 1457.4 1503.5 1523.5 1532.7 1540.6 946.2 958.0 984.1 1028.1 1055.0 5518.8 5542.6 5569.3 5583.5 5587.3 5846.4 5866.8 5869.9 5959.4 5968.7 5452.6 5672.4 5766.0 5776.5 5777.6 3195.7 3207.9 3212.1 3222.6 3227.9 6085.7 6151.6 6218.2 6283.7 6295.4 6029.6 6069.5 6083.2 6105.3 6131.6 6064.3 6176.4 6210.3 6212.0 6212.5 5847.9 5858.0 5948.2 6014.0 6023.8 5883.4 5905.5 5918.2 5920.6 5950.3 5832.9 6119.7 6146.5 6154.7 6164.5 4204.9 4222.0 4244.0 4246.3 4250.9 5941.9 5969.9 5993.9 5996.0 6013.7 5678.5 5786.1 5789.9 5799.3 5829.0 5738.9 5743.5 5810.0 5838.8 5871.2 5408.8 5478.7 5645.3 5783.9 5803.8 5849.7 5864.7 5874.9 5876.2 5905.5 5708.2 5723.0 5767.5 5781.7 5787.0 02:03:27 INFO - PROCESS | 12252 | 02:03:27 INFO - PROCESS | 12252 | [#5] yui.html Cycles:180 Average:21967.23 Median:4705.71 stddev:32497.11 (690.6%) stddev-sans-first:32549.12 02:03:27 INFO - PROCESS | 12252 | Values: 721.7 764.4 790.1 806.4 817.7 16016.7 16727.9 17251.1 17287.7 17293.5 14245.2 14257.5 14275.8 14275.9 14293.0 715.2 828.9 859.9 863.0 863.7 857.9 859.4 860.9 861.3 861.8 734.6 902.7 906.9 907.3 908.1 744.0 747.9 860.5 881.5 884.6 653.9 654.5 655.5 655.5 655.6 15684.2 15774.9 15824.4 15831.4 15850.8 14165.7 14346.6 14440.9 14799.7 15089.6 12928.9 12929.8 13086.5 13123.1 13255.7 4676.5 4677.1 4734.3 4753.4 4805.9 72653.0 73655.6 74349.0 75183.6 75570.6 11453.3 11621.5 11658.0 11722.9 11890.5 23062.3 23128.2 23164.7 23178.7 23201.5 7035.5 7781.7 8170.2 8681.3 8947.7 4853.7 4910.1 4911.2 4999.7 5041.7 4082.7 4345.0 4357.5 4367.8 4368.0 715.5 715.7 718.7 720.5 728.9 710.2 710.5 715.3 720.3 729.4 10037.8 10393.0 10421.8 10648.3 10678.6 631.5 664.6 715.4 744.9 749.6 4633.7 4737.2 4824.3 4889.4 5013.4 117575.0 122421.0 124370.0 125478.0 128876.0 103129.0 111252.0 112010.0 113134.9 113205.0 90014.0 93054.0 93795.5 98279.5 98951.5 9122.9 9441.4 9650.0 9679.9 9742.5 57644.7 58210.0 58346.1 59132.1 59373.1 78164.0 79820.2 80956.8 81259.2 81800.2 12161.3 12268.3 12430.8 12521.9 12636.2 11952.2 13150.4 13484.7 13538.0 13892.0 9359.3 11904.3 12683.9 13063.7 13254.4 12921.4 12963.2 13416.1 13421.5 13536.6 12921.5 13227.6 13230.9 13321.7 13385.8 9903.7 10113.9 10295.6 10343.8 10635.3 10644.3 10766.8 10897.8 10901.2 10957.9 02:03:27 INFO - PROCESS | 12252 | -------- Summary: end -------- 02:03:27 INFO - PROCESS | 12252 | 02:03:28 INFO - TEST-INFO | 12252: exit 0 02:03:28 INFO - TEST-OK | dromaeo_css | took 1112106ms 02:03:28 INFO - TEST-START | kraken 02:03:28 INFO - operating with platform_type : linux_ 02:03:28 INFO - Initialising browser for kraken test... 02:03:28 INFO - TEST-INFO | started process 12447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxdzao/profile http://localhost:54872/getInfo.html) 02:03:32 INFO - PROCESS | 12447 | __metrics Screen width/height:1600/1200 02:03:32 INFO - PROCESS | 12447 | colorDepth:24 02:03:32 INFO - PROCESS | 12447 | Browser inner width/height: 1024/697 02:03:32 INFO - PROCESS | 12447 | __metrics 02:03:32 ERROR - PROCESS | 12447 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:03:33 INFO - TEST-INFO | 12447: exit 0 02:03:33 INFO - Browser initialized. 02:03:33 INFO - Running cycle 1/1 for kraken test... 02:03:33 INFO - TEST-INFO | started process 12538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppxdzao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:45 INFO - PROCESS | 12538 | RSS: Main: 145211392 02:03:45 INFO - PROCESS | 12538 | 02:03:47 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54872/tests/kraken/driver.html?testName=audio-beat-detection) 02:03:48 INFO - PROCESS | 12538 | RSS: Main: 195002368 02:03:48 INFO - PROCESS | 12538 | 02:03:51 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54872/tests/kraken/driver.html?testName=audio-dft) 02:03:52 INFO - PROCESS | 12538 | RSS: Main: 192634880 02:03:52 INFO - PROCESS | 12538 | 02:03:54 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54872/tests/kraken/driver.html?testName=audio-fft) 02:03:55 INFO - PROCESS | 12538 | RSS: Main: 279056384 02:03:55 INFO - PROCESS | 12538 | 02:03:57 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54872/tests/kraken/driver.html?testName=audio-oscillator) 02:03:58 INFO - PROCESS | 12538 | RSS: Main: 187588608 02:03:58 INFO - PROCESS | 12538 | 02:04:00 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54872/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:04:00 INFO - PROCESS | 12538 | RSS: Main: 187793408 02:04:00 INFO - PROCESS | 12538 | 02:04:03 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54872/tests/kraken/driver.html?testName=imaging-darkroom) 02:04:04 INFO - PROCESS | 12538 | RSS: Main: 223055872 02:04:04 INFO - PROCESS | 12538 | 02:04:07 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54872/tests/kraken/driver.html?testName=imaging-desaturate) 02:04:08 INFO - PROCESS | 12538 | RSS: Main: 221843456 02:04:08 INFO - PROCESS | 12538 | 02:04:11 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54872/tests/kraken/driver.html?testName=json-parse-financial) 02:04:11 INFO - PROCESS | 12538 | RSS: Main: 221331456 02:04:11 INFO - PROCESS | 12538 | 02:04:13 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54872/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:04:13 INFO - PROCESS | 12538 | RSS: Main: 200343552 02:04:13 INFO - PROCESS | 12538 | 02:04:15 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:04:16 INFO - PROCESS | 12538 | RSS: Main: 200822784 02:04:16 INFO - PROCESS | 12538 | 02:04:18 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:04:18 INFO - PROCESS | 12538 | RSS: Main: 210280448 02:04:18 INFO - PROCESS | 12538 | 02:04:21 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:04:22 INFO - PROCESS | 12538 | RSS: Main: 215601152 02:04:22 INFO - PROCESS | 12538 | 02:04:24 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:04:25 INFO - PROCESS | 12538 | RSS: Main: 214913024 02:04:25 INFO - PROCESS | 12538 | 02:04:26 INFO - PROCESS | 12538 | Cycle 1(1): loaded http://localhost:54872/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54872/tests/kraken/driver.html?testName=ai-astar) 02:04:27 INFO - PROCESS | 12538 | RSS: Main: 257245184 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | __start_tp_report 02:04:27 INFO - PROCESS | 12538 | _x_x_mozilla_page_load 02:04:27 INFO - PROCESS | 12538 | _x_x_mozilla_page_load_details 02:04:27 INFO - PROCESS | 12538 | |i|pagename|runs| 02:04:27 INFO - PROCESS | 12538 | |0;ai-astar;111;104;111;109;110;109;109;109;109;109 02:04:27 INFO - PROCESS | 12538 | |1;audio-beat-detection;156;125;125;177;127;123;151;123;154;123 02:04:27 INFO - PROCESS | 12538 | |2;audio-dft;161;161;161;160;160;161;160;159;160;161 02:04:27 INFO - PROCESS | 12538 | |3;audio-fft;75;74;74;112;75;76;73;75;100;76 02:04:27 INFO - PROCESS | 12538 | |4;audio-oscillator;84;84;116;85;85;85;113;85;85;123 02:04:27 INFO - PROCESS | 12538 | |5;imaging-gaussian-blur;117;116;116;117;117;117;117;117;116;116 02:04:27 INFO - PROCESS | 12538 | |6;imaging-darkroom;146;146;145;146;146;145;145;145;146;145 02:04:27 INFO - PROCESS | 12538 | |7;imaging-desaturate;94;94;95;94;95;94;95;95;94;95 02:04:27 INFO - PROCESS | 12538 | |8;json-parse-financial;52;51;50;52;53;53;52;52;51;51 02:04:27 INFO - PROCESS | 12538 | |9;json-stringify-tinderbox;60;61;60;60;61;60;60;60;60;61 02:04:27 INFO - PROCESS | 12538 | |10;stanford-crypto-aes;78;76;76;76;79;77;77;79;100;76 02:04:27 INFO - PROCESS | 12538 | |11;stanford-crypto-ccm;126;117;135;117;124;118;122;120;124;129 02:04:27 INFO - PROCESS | 12538 | |12;stanford-crypto-pbkdf2;158;162;156;156;154;155;155;157;154;159 02:04:27 INFO - PROCESS | 12538 | |13;stanford-crypto-sha256-iterative;62;62;63;62;63;61;63;61;62;63 02:04:27 INFO - PROCESS | 12538 | __end_tp_report 02:04:27 INFO - PROCESS | 12538 | __start_cc_report 02:04:27 INFO - PROCESS | 12538 | _x_x_mozilla_cycle_collect,1608 02:04:27 INFO - PROCESS | 12538 | __end_cc_report 02:04:27 INFO - PROCESS | 12538 | __startTimestamp1467450267144__endTimestamp 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | ------- Summary: start ------- 02:04:27 INFO - PROCESS | 12538 | Number of tests: 14 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.00 stddev:1.94 (1.8%) stddev-sans-first:1.92 02:04:27 INFO - PROCESS | 12538 | Values: 111.0 104.0 111.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:139.00 stddev:19.44 (14.0%) stddev-sans-first:19.55 02:04:27 INFO - PROCESS | 12538 | Values: 156.0 125.0 125.0 177.0 127.0 123.0 151.0 123.0 154.0 123.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 02:04:27 INFO - PROCESS | 12538 | Values: 161.0 161.0 161.0 160.0 160.0 161.0 160.0 159.0 160.0 161.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:13.51 (18.0%) stddev-sans-first:14.15 02:04:27 INFO - PROCESS | 12538 | Values: 75.0 74.0 74.0 112.0 75.0 76.0 73.0 75.0 100.0 76.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:85.00 stddev:15.95 (18.8%) stddev-sans-first:16.45 02:04:27 INFO - PROCESS | 12538 | Values: 84.0 84.0 116.0 85.0 85.0 85.0 113.0 85.0 85.0 123.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:04:27 INFO - PROCESS | 12538 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:04:27 INFO - PROCESS | 12538 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:04:27 INFO - PROCESS | 12538 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#8] json-parse-financial Cycles:10 Average:51.70 Median:52.00 stddev:0.95 (1.8%) stddev-sans-first:1.00 02:04:27 INFO - PROCESS | 12538 | Values: 52.0 51.0 50.0 52.0 53.0 53.0 52.0 52.0 51.0 51.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 02:04:27 INFO - PROCESS | 12538 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 61.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:77.00 stddev:7.34 (9.5%) stddev-sans-first:7.76 02:04:27 INFO - PROCESS | 12538 | Values: 78.0 76.0 76.0 76.0 79.0 77.0 77.0 79.0 100.0 76.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:5.75 (4.6%) stddev-sans-first:6.01 02:04:27 INFO - PROCESS | 12538 | Values: 126.0 117.0 135.0 117.0 124.0 118.0 122.0 120.0 124.0 129.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:156.50 stddev:2.50 (1.6%) stddev-sans-first:2.60 02:04:27 INFO - PROCESS | 12538 | Values: 158.0 162.0 156.0 156.0 154.0 155.0 155.0 157.0 154.0 159.0 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - PROCESS | 12538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 02:04:27 INFO - PROCESS | 12538 | Values: 62.0 62.0 63.0 62.0 63.0 61.0 63.0 61.0 62.0 63.0 02:04:27 INFO - PROCESS | 12538 | -------- Summary: end -------- 02:04:27 INFO - PROCESS | 12538 | 02:04:27 INFO - TEST-INFO | 12538: exit 0 02:04:28 INFO - TEST-OK | kraken | took 59886ms 02:04:28 INFO - SUITE-END | took 1171s 02:04:28 INFO - Completed test suite (00:19:32) 02:04:28 INFO - javascript benchmark 02:04:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3320.8173550454726, 3347.297067615802, 3359.815210163441, 3374.595048594169, 3400.3879301725697, 5589.916151257735, 5643.887122257553, 5661.8584535386635, 5663.971680141603, 5674.71626418679, 5579.9163012554745, 5640.802571909984, 5644.887102257952, 5656.91514627281, 5658.830235092953, 4941.2094064949615, 5109.4379618241965, 5113.105206588851, 5148.407933087706, 5180.378354597454, 4994.575461085812, 5084.211947148198, 5120.257562653413, 5121.180611102224, 5124.743762811844, 5039.0425819094435, 5059.342285502879, 5086.643934924557, 5094.592432605383, 5113.488651134894, 5175.301334319894, 5189.714565698885, 5194.3766747990485, 5200.115980283361, 5214.087534681435, 4939.135651261015, 4940.530649588283, 4982.128127577659, 5094.3886733591835, 5100.158473851847, 5468.0977638689565, 5501.119820828688, 5501.367342755554, 5520.392756796749, 5543.196236545678, 6049.901738849234, 6056.3338032816355, 6081.726322315506, 6084.421979911901, 6107.114468402056, 5871.765129394819, 5914.260717410324, 5922.378150294243, 5922.644641321534, 6109.961351452437, 5554.472325129106, 5569.081101618228, 5592.245046918654, 5606.383297837235, 5611.270534830487, 5886.705664716747, 6052.741483205038, 6060.817165348832, 6102.9694851525455, 6106.267247930276, 5879.823605291848, 5917.52659787216, 5921.644701317935, 6017.2779266488305, 6024.819255422257, 6068.544859135583, 6076.27795527153, 6079.209702738704, 6116.602420842631, 6118.174046503754, 5756.510696590753, 5864.091065884794, 6007.519398448114, 6038.33578306386, 6040.7583696651645, 5859.0, 5962.07587823888, 5964.940350596526, 5970.880582388415, 6006.489448396936, 4569.474510431343, 4569.657275704336, 4584.862454126382, 4585.839495617637, 4610.884727881829, 3990.341593637075, 4019.3970904363996, 4041.0, 4101.282275601758, 4141.316682747313, 5593.580481463907, 5595.440455954372, 5609.691466969356, 5614.0, 5615.326160860723, 5885.47030767233, 5928.466438020599, 5947.613405128653, 5958.582899197015, 5987.970060149759, 5429.022775900296, 5594.496495315441, 5656.0, 5662.0, 5703.657780533098, 5145.9742701287005, 5164.8192313268855, 5176.171812510056, 5188.507091826271, 5197.064528384927, 5947.702614869326, 6173.907391389043, 6195.101710251988, 6201.007838745779, 6208.286047104551, 5886.735096920564, 5941.91087133702, 5942.7920022799, 5972.820815375546, 5998.190244317136, 6085.786997455068, 6147.508199343953, 6156.938430615636, 6159.414855588712, 6162.352952939877, 5779.2775903012125, 5786.797462088806, 5853.824385268449, 5873.50075243592, 5874.706264686834, 5911.674857882857, 5975.641461512323, 5981.910271345846, 5998.0, 6023.27720673522, 5803.767849285981, 5831.504322132666, 5835.737391817293, 5847.883042339215, 5853.502452291603, 5597.132444471114, 5763.279590051244, 5795.33353664334, 5804.3905389935135, 5832.329282132439, 5759.280089988752, 5765.91351129725, 5773.711314434346, 5777.711114444345, 5800.622959507618, 5864.9706751467675, 5907.940920590911, 5955.940440595538, 5956.987312157031, 5961.523078153824, 5588.888222235614, 5628.943710562842, 5676.545876329801, 5679.403662615366, 5788.623739456922], "value": 5512.004136532117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.830689100161, 628.2021832273014, 654.074484604285, 654.4568008552899, 667.5227212543031, 32861.178470538245, 35571.64428355716, 44113.558864411345, 45113.09773804522, 45152.774236128855, 46729.53270467294, 47359.0, 47373.526264737346, 47400.0, 47517.0, 8228.0, 8875.378723489343, 9019.188273055424, 9023.548822558878, 9026.954865225665, 8270.462419942714, 8522.57387130644, 8534.274586660142, 10765.62320318789, 10996.12031037519, 10683.519241634145, 11031.83452248217, 11074.280171788849, 11077.833832492519, 11078.0, 8298.128696486903, 10950.945245273762, 10996.890031099707, 11007.559697612085, 11054.889451105466, 10525.21060920434, 10892.074173695246, 10902.945485272523, 11237.213395062348, 11241.269317494336, 44893.551064489264, 45425.0, 45436.3184552232, 45450.09099818018, 45461.54538454639, 3644.781313121221, 3645.343838109139, 3670.394384926484, 3676.0442285006093, 3737.3085979093953, 34653.30693386144, 34757.65242347595, 34995.475067874, 35534.64465355339, 36895.631043689486, 4789.353437285957, 4826.927596086061, 4827.227643577046, 4840.177169881129, 4849.612031037508, 365833.0, 371149.0, 372063.0, 372313.0, 373094.0, 37950.0, 38734.22531549353, 66991.66504167546, 68120.6593967027, 68335.0, 40931.590684093375, 40962.59037409647, 41038.79480602578, 41059.7947010263, 41094.79452602718, 17259.3959211427, 17532.824671753373, 17535.561610959827, 17536.298548057934, 17551.0, 12421.813672794915, 12710.618681439571, 14647.267636618126, 14749.483768068281, 14760.040597361352, 8792.076831932683, 8986.595603197871, 9236.122568355995, 9259.537023148816, 9397.0, 3465.1163953191776, 3507.1407505160887, 3521.9823900880842, 3551.0944709099012, 3571.7320351274925, 1051.600391851107, 1097.5993762276871, 1103.178132291448, 1115.275071203724, 1162.4245998230929, 33028.0, 33588.48851801675, 33868.153296167795, 33926.32147357039, 33987.49018764721, 1179.7935361311909, 1180.4805885410565, 1207.6256360528264, 1227.8158276258632, 1235.882591153839, 17198.484045478657, 17311.913440432716, 17471.825281747275, 17488.912555437142, 17493.825061749474, 550398.0, 553524.0, 556603.0, 556647.0, 560911.0, 41792.37311440331, 42403.0, 42633.0, 42660.57339426628, 42695.146097078505, 1352.7159296547638, 1470.1767010474168, 1477.6527516033723, 1493.387711038469, 1513.803205583267, 32874.50688239726, 34282.48576271308, 34427.82786086154, 34611.82694086513, 34776.65223347835, 51200.0, 51528.0, 51846.74076629593, 51855.740721296155, 51897.0, 405208.8437346884, 405862.0, 405975.0, 406800.0, 408873.0, 26754.59868101941, 38287.0, 39292.80353598214, 39467.21065578615, 39546.406803897386, 49074.0, 49903.75048124736, 50356.24465632945, 52148.0, 53211.73394133004, 44074.77962610166, 44294.557054430334, 44942.77528612336, 45766.77116614395, 46553.76723116363, 43617.56382436135, 44093.0, 44779.0, 44828.775856121814, 45578.54421455876, 44044.33933491064, 44171.77914110409, 44620.77689611661, 44863.32705009493, 44863.32705009493, 37833.243335132596, 39620.405693914036, 40100.799496002335, 40245.59754402418, 40750.1849963005, 29850.0, 29870.701292987662, 30284.0, 30477.39045219039, 30548.694513054586], "value": 20177.280471281116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.99373009404843, 422.7717032802287, 424.4312621087742, 424.7366632687734, 440.0209533787324, 19260.422187334367, 19458.90270548647, 19976.700349494768, 20346.491337716565, 20420.183192672295, 19092.809071909276, 19653.115609797558, 19864.0, 20078.498037549067, 20111.49721256969, 5738.225339579166, 5991.970040149793, 5993.790217342394, 5997.550183736215, 6001.9699901500435, 5664.320281566218, 5858.297004359483, 5876.882462350751, 5890.911636325459, 5940.0, 5783.479486846183, 5825.766969321222, 5837.416258374171, 5843.678597677126, 5843.883122337551, 5717.456841600062, 5816.1566572846705, 5820.039693450575, 5821.50517206038, 5834.620749651302, 4993.425756038066, 5051.419086805027, 5057.367829021372, 5058.696478211283, 5064.696118232881, 23500.0, 23564.64653030206, 24412.389690257707, 24470.0, 24773.132940347183, 2387.8925448354867, 2424.078850036992, 2571.845689258632, 2654.774344180747, 3080.86136123875, 10008.94995525025, 14292.213928233943, 14895.957282990195, 14998.0, 15907.920460397623, 1997.4107638246753, 2067.1008111471556, 2121.95756084879, 2168.609650262952, 2201.416624594484, 77970.0, 81561.77657335204, 81623.5918820408, 81894.59052704758, 85158.0, 11038.558457661604, 11224.270422422516, 11516.712082198012, 11517.539298428137, 11551.075913926865, 15964.121973291349, 16025.358985640676, 16071.437499687689, 16091.436799711953, 16163.838361616468, 8764.912350876537, 8780.385373023826, 8933.0, 8960.0, 9025.729228123035, 8814.162654547808, 8827.735167944844, 8864.157904999014, 8911.064338244521, 8955.194032537103, 4653.813847446132, 4721.0, 4873.707577545359, 4921.557059864629, 4936.6297527685565, 1815.0090701159534, 1992.1334219614514, 1999.9600607077452, 2006.9799302007084, 2026.574419371919, 928.9489078100769, 1002.7443002034435, 1027.8406846938738, 1034.8602938603342, 1049.6483677967967, 19299.131539080776, 19775.802241977395, 20070.19719211215, 20236.89881550583, 20500.549699282135, 992.1318846009741, 998.8801343838786, 1029.5675816157232, 1047.6699839550517, 1064.1061508333037, 9475.194608458358, 11178.27341222818, 11189.664310070712, 11200.719982000515, 11207.047400970845, 472773.0, 476684.0, 478007.0, 483508.0, 489414.0, 102006.48996754969, 102187.48906255422, 104618.47690761497, 104671.47664261782, 105048.0, 1088.8257878739523, 1127.475723788426, 1134.240059160348, 1160.0603511155991, 1164.6564263542275, 17235.138243088048, 17518.211680474153, 17785.911070444567, 17899.0, 17927.910360448637, 41129.38305925354, 44064.77967610142, 44303.77848110739, 44816.327755083046, 45936.54063459323, 62112.68943655253, 63626.68186659037, 63999.36000639934, 64212.35787642064, 66532.33467665454, 8646.610902509276, 8687.435316704394, 8735.825283494167, 8804.911950880665, 9138.268938485038, 9121.908780912372, 9953.601855925972, 10950.507227174638, 13762.174269543859, 14449.277536122941, 11667.824982625098, 12039.337836419081, 12073.698157546132, 12244.75510489803, 12649.241045537297, 11645.0, 11678.182527223013, 12030.699232519257, 12126.151169418408, 12323.44544495482, 12030.819537706766, 12109.273443593413, 12142.635720928387, 12163.878361216275, 12617.621471355875, 7912.169222231582, 8241.876371854547, 8263.256306932404, 8349.66601335964, 8906.910930890608, 9656.9034309656, 11695.76608467809, 12227.938860305641, 12692.048096392991, 13154.934225328812], "value": 9609.219877454436, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.9394777235023, 1509.37360995187, 1543.6140964758813, 1683.4612923864368, 1862.3761040051575, 8961.865572016424, 9369.43783372998, 9372.765680857981, 9631.614735410592, 9636.903630963705, 9444.386114902527, 9656.903430965689, 9660.5169741513, 9662.468564228964, 9667.516624168798, 2115.8307335413206, 2172.73927128744, 2409.722881868581, 2492.663490428796, 2531.405119796846, 2455.8035357171475, 2488.203774792067, 2488.713797913245, 2489.7136829264596, 2491.9377015574573, 2356.352003199125, 2429.101232543961, 2429.4898071404937, 2430.0158435833514, 2432.2581612608146, 2089.8223650989607, 2360.3273067175946, 2362.621980483123, 2431.3921519620094, 2435.902563897442, 2414.3360575841607, 2414.6740190074465, 2434.245383930987, 2434.9513009739885, 2436.293474892279, 9340.532973351374, 9469.242460603135, 9475.052494750538, 9503.762405939839, 9510.0, 5481.506664400184, 5624.943750562524, 5629.240052592889, 5629.831105066854, 5639.605227634067, 3524.1189702574356, 3588.4617307404096, 3631.6005239423644, 3635.63643635637, 3687.4284485904727, 1155.5839897636845, 1158.357111802949, 1183.7159081820387, 1185.8991985681228, 1229.674136353867, 13637.181769093788, 13743.175409475463, 13752.31238438074, 13758.793618095737, 13771.586852394445, 4831.0, 4897.41231052276, 4958.454569997298, 4965.354503914468, 5023.472535383732, 11399.145064120225, 11407.771844563062, 11511.48198331077, 11586.13104017202, 11596.362200078907, 5606.915896261559, 5609.214709940612, 5609.887802243932, 5614.326280846324, 5614.6631202128, 4400.537943515885, 5119.462456442095, 5253.894922101536, 5256.842294731164, 5259.947400526023, 4315.115401342718, 4326.329418940069, 4340.500842403101, 4368.978155109204, 4395.802188901507, 1322.4313545175476, 1378.076688618608, 1388.0908005256574, 1395.2047333020284, 1396.3158052554174, 927.3091546797679, 929.9395539289925, 950.6862735297335, 953.4041224234853, 956.4691596164196, 5938.049912014057, 6048.243969503812, 6097.634141951497, 6099.085137229451, 6212.494882829278, 443.53428899655233, 446.16789687233074, 449.23629829289683, 449.62905602877754, 473.60217417369574, 3963.781991990468, 4254.553271906467, 4266.040140968319, 4285.37862010013, 4286.442762440863, 11398.544058237578, 11601.0, 11893.88106118945, 11918.821217681741, 12081.335526545949, 11682.0, 11911.642650720492, 11981.221220620631, 12173.0, 12215.572454964211, 8821.426607270507, 8984.955075224581, 8989.41568798039, 9005.954970225239, 9057.81884362309, 6209.59637623553, 6229.314775374796, 6269.435750782452, 6395.8720825582295, 6470.870582588228, 10759.515821788194, 11065.557377704801, 11073.723156921142, 11364.431778411212, 11368.488418021043, 11304.434778261219, 11404.82892756626, 11522.654320370402, 11531.942340288246, 11616.361100139573, 7689.538627682357, 7946.165652606393, 8106.554139522383, 8438.113998030118, 8547.786305342415, 8685.652573896974, 8884.555772211494, 9121.315901307296, 9149.31380146505, 9491.430514169171, 8183.140770219041, 8361.832763344577, 8397.538135402612, 8438.704645337384, 8574.485530868167, 8154.469959452854, 8221.958890205511, 8338.583070846555, 8388.0, 8438.746837594881, 7073.504854660125, 7214.170370407261, 7221.350078492961, 7221.386182174574, 7225.963870180615, 5231.189165679326, 5317.5012906555485, 5319.095753721799, 5331.440198779227, 5372.838814835562, 5249.89500209986, 5282.2604835323855, 5289.127293996447, 5365.678059316453, 5388.595855310789], "value": 4824.550417432186, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.35184907920353, 357.06092975474496, 359.1631498608243, 362.5703541303554, 362.74064044208404, 5501.91747123793, 5519.889602207953, 5573.554115670747, 5592.692401917893, 5608.158776183574, 5479.863003424916, 5482.108672507979, 5522.475364840344, 5532.723363831812, 5534.640248383852, 3978.8660231833787, 4035.4148648445957, 4224.302990006645, 4279.379489973952, 4307.0, 4252.893677658068, 4295.312749960007, 4298.871033868989, 4312.310030395138, 4313.590208930146, 4097.487814023247, 4276.315789473685, 4278.486581610211, 4280.250956082688, 4284.250256205167, 3988.521377434712, 4219.599138081878, 4227.408162857202, 4234.153169366108, 4240.893977650552, 3722.7766334020043, 3728.12389088564, 3741.1021354874906, 3744.569374521938, 3751.81240937952, 5216.017913192963, 5297.496737809902, 5304.832936753946, 5331.813956277946, 5343.572514198893, 4814.518548145157, 4827.420709514846, 4830.299606557065, 4838.95161048392, 4847.321375007502, 5643.379228284926, 5652.576056795716, 5705.77176912923, 5716.771329146829, 5748.712564371806, 4011.29802284599, 4075.0627355708057, 4127.855525056609, 4143.7928103595, 4145.419641250227, 5895.852603684899, 5919.260092488439, 5931.953476050799, 5935.9406405935815, 6005.099235114724, 4128.3601041838565, 4158.875233742992, 4196.538380778173, 4207.179599978036, 4227.534971153171, 4211.768352740567, 4284.3359279311135, 4286.742795432284, 4287.871363859089, 4308.547602501755, 4717.858464246009, 4793.376861008116, 4828.788855411112, 4831.371921650163, 4842.443119041285, 5721.656700597894, 5735.913961290584, 5736.254286942754, 5782.277215348082, 5825.446582574734, 1457.358762144674, 1503.518873960344, 1523.5048609202054, 1532.716447457224, 1540.6302487402943, 946.1720994130136, 957.9856302155473, 984.104464936904, 1028.0850043461326, 1054.9894501055044, 5518.779248830082, 5542.63972841764, 5569.27599412082, 5583.525400341016, 5587.273654424899, 5846.444587764156, 5866.823995280149, 5869.853253668693, 5959.361175676723, 5968.671723055274, 5452.563794896399, 5672.404397538282, 5766.0, 5776.537876969833, 5777.62445441045, 3195.6578237140457, 3207.887723929651, 3212.0685001349816, 3222.5810644616517, 3227.9193020174685, 6085.726142323606, 6151.64663773969, 6218.19163508741, 6283.6858157091965, 6295.401936815995, 6029.60807547508, 6069.514438844882, 6083.178770865965, 6105.267367915879, 6131.5780266795255, 6064.331694054514, 6176.382361763787, 6210.254769427697, 6212.0, 6212.502999760009, 5847.94152058474, 5858.0, 5948.226730525004, 6013.9699301503215, 6023.849403764941, 5883.352831188651, 5905.498032667099, 5918.23063001807, 5920.615160014758, 5950.256217972754, 5832.912506312494, 6119.724612392364, 6146.477549408351, 6154.661493617715, 6164.506839452923, 4204.936925946052, 4221.957780422156, 4243.978780106079, 4246.299360605465, 4250.872473825791, 5941.851453713519, 5969.940300596939, 5993.910091348721, 5995.970020149872, 6013.729382177725, 5678.5457163426, 5786.132080188006, 5789.884202316014, 5799.2750906136735, 5829.0, 5738.885222295447, 5743.511801496919, 5809.970950145392, 5838.795642152504, 5871.236739223874, 5408.8377348679605, 5478.671279723229, 5645.322561292671, 5783.884322313446, 5803.823566162689, 5849.707514624167, 5864.67744274069, 5874.94125058744, 5876.178384700756, 5905.52755779528, 5708.201916396322, 5722.971385143048, 5767.452092051249, 5781.739821707949, 5786.971065144648], "value": 4415.955397978216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.7401735375267, 764.3961270596229, 790.0716657926935, 806.3750593290196, 817.6974519427811, 16016.679666406664, 16727.91636041821, 17251.137443127856, 17287.654246915055, 17293.481195564123, 14245.216513091777, 14257.500987465415, 14275.785863212033, 14275.857241427582, 14293.0, 715.2346988722056, 828.9171082891693, 859.9398042137053, 862.9611667474978, 863.6588547523725, 857.8798968144465, 859.4327743689166, 860.8751730999002, 861.3109512390095, 861.7802460372627, 734.5776178697243, 902.7291812456269, 906.9183773460387, 907.2877790934118, 908.1463424381094, 744.0216115807723, 747.8691229034924, 860.5224100624182, 881.532787622561, 884.6019291318933, 653.8855700252484, 654.5025780406925, 655.472344762466, 655.5476721062452, 655.6295692933477, 15684.215789210608, 15774.921125394414, 15824.367025318974, 15831.445899393466, 15850.841491585052, 14165.71668566623, 14346.569602911824, 14440.9169312302, 14799.70400591993, 15089.622759430993, 12928.935355323163, 12929.806052909214, 13086.47654093835, 13123.081384303103, 13255.734885302336, 4676.485586585472, 4677.134730074947, 4734.289856521515, 4753.382060332169, 4805.903881922377, 72653.0, 73655.63172184158, 74349.0, 75183.62408187978, 75570.62214688947, 11453.312801231787, 11621.47703353351, 11658.0, 11722.88277117235, 11890.464929078213, 23062.308130756104, 23128.19051333229, 23164.65253021206, 23178.65232021521, 23201.53596928052, 7035.542689725152, 7781.727639532589, 8170.182981701902, 8681.348898832613, 8947.731568052839, 4853.684510506806, 4910.06708725341, 4911.18965370717, 4999.700017998932, 5041.697498150123, 4082.7142100053306, 4345.022369966732, 4357.4988876279, 4367.847125350661, 4368.0, 715.4634024481638, 715.7244460882598, 718.6622287524959, 720.5208536323391, 728.8760910645203, 710.2223065743003, 710.4955481608116, 715.301204222453, 720.333691335523, 729.390958549617, 10037.849432258521, 10393.0, 10421.791564168825, 10648.254622176528, 10678.57285708563, 631.4979591224987, 664.6145235763246, 715.391331957456, 744.9217832127548, 749.6027105633914, 4633.675642705046, 4737.24204127338, 4824.276358546176, 4889.364382630235, 5013.423456302499, 117575.0, 122421.0, 124370.0, 125478.0, 128876.0, 103129.0, 111252.0, 112010.0, 113134.86865131409, 113205.0, 90014.0, 93054.0, 93795.53102234582, 98279.50860245652, 98951.50524247477, 9122.90877091247, 9441.386309889835, 9649.951750241204, 9679.854802177832, 9742.512874356396, 57644.71177644085, 58210.0, 58346.12480812706, 59132.1130183039, 59373.10940335985, 78164.0, 79820.20179798128, 80956.78564821415, 81259.18740812753, 81800.18199817925, 12161.33112678811, 12268.263904165779, 12430.751384972431, 12521.87478125207, 12636.2418254905, 11952.223105498115, 13150.408231629408, 13484.662883427993, 13538.0, 13892.027558070838, 9359.298052645943, 11904.285742855456, 12683.936580317039, 13063.673408164872, 13254.403551839998, 12921.35393230316, 12963.15739476931, 13416.1279516835, 13421.463141474233, 13536.59390218295, 12921.547745828851, 13227.603171904859, 13230.933845330712, 13321.66695832612, 13385.799213012007, 9903.653372131941, 10113.898861011296, 10295.639652612123, 10343.793124137626, 10635.255532112678, 10644.254902156774, 10766.838497422388, 10897.78204435891, 10901.236913415985, 10957.945210273898], "value": 7795.03886356439, "unit": "score"}], "name": "dromaeo_css", "value": 7496.646215804448, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 111.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 125.0, 177.0, 127.0, 123.0, 151.0, 123.0, 154.0, 123.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 160.0, 159.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 112.0, 75.0, 76.0, 73.0, 75.0, 100.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 85.0, 85.0, 85.0, 113.0, 85.0, 85.0, 123.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 52.0, 53.0, 53.0, 52.0, 52.0, 51.0, 51.0], "value": 51.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 76.0, 79.0, 77.0, 77.0, 79.0, 100.0, 76.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 117.0, 135.0, 117.0, 124.0, 118.0, 122.0, 120.0, 124.0, 129.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 156.0, 156.0, 154.0, 155.0, 155.0, 157.0, 154.0, 159.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 61.0, 63.0, 61.0, 62.0, 63.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1473.3000000000002, "alertThreshold": 2.0}]} 02:04:28 INFO - Return code: 0 02:04:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:04:28 ERROR - # TBPL SUCCESS # 02:04:28 INFO - Running post-action listener: _resource_record_post_action 02:04:28 INFO - ##### 02:04:28 INFO - ##### Finished run-tests step (success) 02:04:28 INFO - ##### 02:04:28 INFO - Running post-run listener: _resource_record_post_run 02:04:28 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 262144; Write bytes: 506413056; Read time: 20; Write time: 339356 02:04:28 INFO - TinderboxPrint: CPU usage
13.0% 02:04:28 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 20 02:04:28 INFO - TinderboxPrint: I/O write bytes / time
506,413,056 / 339,356 02:04:28 INFO - TinderboxPrint: CPU idle
8,252.7 (87.0%) 02:04:28 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 02:04:28 INFO - TinderboxPrint: Swap in / out
0 / 0 02:04:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 252428288; Read time: 0; Write time: 194180 02:04:28 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 253984768; Read time: 20; Write time: 145176 02:04:29 INFO - Running post-run listener: _upload_blobber_files 02:04:29 INFO - Blob upload gear active. 02:04:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:04:29 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 02:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:04:29 INFO - (blobuploader) - INFO - Open directory for files ... 02:04:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:04:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:04:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:04:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:04:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:04:30 INFO - (blobuploader) - INFO - Done attempting. 02:04:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:04:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:04:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:04:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:04:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:04:31 INFO - (blobuploader) - INFO - Done attempting. 02:04:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:04:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:04:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:04:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:04:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:04:34 INFO - (blobuploader) - INFO - Done attempting. 02:04:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:04:34 INFO - Return code: 0 02:04:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:04:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:04:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3def3743a69bbd827bc95d8c2ac1fafe02606ce29eeaade2282a00ecc62b1670cbaf72cd2bb2db9a843e02184589c22256914e5e8d58453c1b73eefdbe40446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f330492eee254d1525c6e4bd7b5f6c9ff652eb70a7cef00f9ade18919ebc0eb9d54b5d36fd41dcf78b1bcb26ef8ec0ee54e1cdc0aac1908d6b56ffa0f76319a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11ec45852f04f655b23adad05460bcc32d6ac6a12ccbab67bfc1c870f3234c8519067d458e88b3d596bbaae79a3a1788046bec30f54aeb956b5189d9461c134d"} 02:04:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:04:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:04:34 INFO - Contents: 02:04:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3def3743a69bbd827bc95d8c2ac1fafe02606ce29eeaade2282a00ecc62b1670cbaf72cd2bb2db9a843e02184589c22256914e5e8d58453c1b73eefdbe40446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f330492eee254d1525c6e4bd7b5f6c9ff652eb70a7cef00f9ade18919ebc0eb9d54b5d36fd41dcf78b1bcb26ef8ec0ee54e1cdc0aac1908d6b56ffa0f76319a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11ec45852f04f655b23adad05460bcc32d6ac6a12ccbab67bfc1c870f3234c8519067d458e88b3d596bbaae79a3a1788046bec30f54aeb956b5189d9461c134d"} 02:04:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:04:34 INFO - Copying logs to upload dir... 02:04:34 INFO - mkdir: /builds/slave/test/build/upload/logs 02:04:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.660129 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-02 02:04:34.128308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 02:04:34.132016) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3def3743a69bbd827bc95d8c2ac1fafe02606ce29eeaade2282a00ecc62b1670cbaf72cd2bb2db9a843e02184589c22256914e5e8d58453c1b73eefdbe40446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f330492eee254d1525c6e4bd7b5f6c9ff652eb70a7cef00f9ade18919ebc0eb9d54b5d36fd41dcf78b1bcb26ef8ec0ee54e1cdc0aac1908d6b56ffa0f76319a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11ec45852f04f655b23adad05460bcc32d6ac6a12ccbab67bfc1c870f3234c8519067d458e88b3d596bbaae79a3a1788046bec30f54aeb956b5189d9461c134d"} build_url:https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/MlwgkqZWQdmHWucvDcRm1g/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3def3743a69bbd827bc95d8c2ac1fafe02606ce29eeaade2282a00ecc62b1670cbaf72cd2bb2db9a843e02184589c22256914e5e8d58453c1b73eefdbe40446", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8f330492eee254d1525c6e4bd7b5f6c9ff652eb70a7cef00f9ade18919ebc0eb9d54b5d36fd41dcf78b1bcb26ef8ec0ee54e1cdc0aac1908d6b56ffa0f76319a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11ec45852f04f655b23adad05460bcc32d6ac6a12ccbab67bfc1c870f3234c8519067d458e88b3d596bbaae79a3a1788046bec30f54aeb956b5189d9461c134d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 02:04:34.157762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 02:04:34.158248) ========= 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=bb9b54edd4a927dc735d112f000001d9-1467444422.718357-1944777599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004382 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 02:04:34.243707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 02:04:34.244016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 02:04:34.244316) ========= ========= Total master_lag: 0.19 =========