builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1465483717.68 results: success (0) buildid: 20160609063733 builduid: 675db5e24b73496ab91a7bb112579705 revision: c9564b7204d452746ee472b8dec3c4d33e876716 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:37.677382) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:37.677867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:37.678147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:37.807069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:37.807710) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 07:48:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.9M=0s 2016-06-09 07:48:38 (70.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150295 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.093498) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.093811) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019654 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.140569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.140917) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c9564b7204d452746ee472b8dec3c4d33e876716 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c9564b7204d452746ee472b8dec3c4d33e876716 --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=78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 07:48:38,293 truncating revision to first 12 chars 2016-06-09 07:48:38,293 Setting DEBUG logging. 2016-06-09 07:48:38,294 attempt 1/10 2016-06-09 07:48:38,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c9564b7204d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 07:48:38,674 unpacking tar archive at: mozilla-central-c9564b7204d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.763997 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.932559) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.932862) ========= script_repo_revision: c9564b7204d452746ee472b8dec3c4d33e876716 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.933261) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.933529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 07:48:38.986435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-06-09 07:48:38.986835) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:48:39 INFO - MultiFileLogger online at 20160609 07:48:39 in /builds/slave/test 07:48:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:48:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:48:39 INFO - {'append_to_log': False, 07:48:39 INFO - 'base_work_dir': '/builds/slave/test', 07:48:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:48:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:48:39 INFO - 'branch': 'Firefox-Non-PGO', 07:48:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:48:39 INFO - 'config_files': ('talos/linux_config.py',), 07:48:39 INFO - 'default_actions': ('clobber', 07:48:39 INFO - 'read-buildbot-config', 07:48:39 INFO - 'download-and-extract', 07:48:39 INFO - 'populate-webroot', 07:48:39 INFO - 'create-virtualenv', 07:48:39 INFO - 'install', 07:48:39 INFO - 'run-tests'), 07:48:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:48:39 INFO - 'download_minidump_stackwalk': True, 07:48:39 INFO - 'download_symbols': 'ondemand', 07:48:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:48:39 INFO - 'tooltool.py': '/tools/tooltool.py', 07:48:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:48:39 INFO - '/tools/misc-python/virtualenv.py')}, 07:48:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:48:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:48:39 INFO - 'installer_path': 'installer.exe', 07:48:39 INFO - 'log_level': 'info', 07:48:39 INFO - 'log_name': 'talos', 07:48:39 INFO - 'log_to_console': True, 07:48:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:48:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:48:39 INFO - 'opt_config_files': (), 07:48:39 INFO - 'pip_index': False, 07:48:39 INFO - 'sps_profile': False, 07:48:39 INFO - 'sps_profile_interval': 0, 07:48:39 INFO - 'suite': 'dromaeojs', 07:48:39 INFO - 'system_bits': '32', 07:48:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:48:39 INFO - 'title': 'talos-linux64-ix-019', 07:48:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:48:39 INFO - 'use_talos_json': True, 07:48:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:48:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:48:39 INFO - 'work_dir': 'build'} 07:48:39 INFO - ##### 07:48:39 INFO - ##### Running clobber step. 07:48:39 INFO - ##### 07:48:39 INFO - Running pre-action listener: _resource_record_pre_action 07:48:39 INFO - Running main action method: clobber 07:48:39 INFO - rmtree: /builds/slave/test/build 07:48:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:48:39 INFO - Running post-action listener: _resource_record_post_action 07:48:39 INFO - ##### 07:48:39 INFO - ##### Finished clobber step (success) 07:48:39 INFO - ##### 07:48:39 INFO - ##### 07:48:39 INFO - ##### Running read-buildbot-config step. 07:48:39 INFO - ##### 07:48:39 INFO - Running pre-action listener: _resource_record_pre_action 07:48:39 INFO - Running main action method: read_buildbot_config 07:48:39 INFO - Using buildbot properties: 07:48:39 INFO - { 07:48:39 INFO - "project": "", 07:48:39 INFO - "product": "firefox", 07:48:39 INFO - "script_repo_revision": "production", 07:48:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:48:39 INFO - "repository": "", 07:48:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:48:39 INFO - "buildid": "20160609063733", 07:48:39 INFO - "pgo_build": "False", 07:48:39 INFO - "basedir": "/builds/slave/test", 07:48:39 INFO - "buildnumber": 525, 07:48:39 INFO - "slavename": "talos-linux64-ix-019", 07:48:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:48:39 INFO - "platform": "ubuntu64_hw", 07:48:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:48:39 INFO - "branch": "mozilla-central", 07:48:39 INFO - "repo_path": "mozilla-central", 07:48:39 INFO - "revision": "c9564b7204d452746ee472b8dec3c4d33e876716", 07:48:39 INFO - "stage_platform": "linux64", 07:48:39 INFO - "builduid": "675db5e24b73496ab91a7bb112579705", 07:48:39 INFO - "slavebuilddir": "test" 07:48:39 INFO - } 07:48:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:48:39 INFO - Running post-action listener: _resource_record_post_action 07:48:39 INFO - ##### 07:48:39 INFO - ##### Finished read-buildbot-config step (success) 07:48:39 INFO - ##### 07:48:39 INFO - ##### 07:48:39 INFO - ##### Running download-and-extract step. 07:48:39 INFO - ##### 07:48:39 INFO - Running pre-action listener: _resource_record_pre_action 07:48:39 INFO - Running main action method: download_and_extract 07:48:39 INFO - mkdir: /builds/slave/test/build/tests 07:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:39 INFO - https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:48:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:48:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:48:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:48:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:48:40 INFO - Downloaded 1361 bytes. 07:48:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:48:40 INFO - Using the following test package requirements: 07:48:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:48:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:48:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:48:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'jsshell-linux-x86_64.zip'], 07:48:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:48:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:48:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:48:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:48:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:48:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:48:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:48:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:40 INFO - https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:48:42 INFO - Downloaded 22879571 bytes. 07:48:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:48:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:48:43 INFO - Return code: 0 07:48:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:43 INFO - https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:48:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:48:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:48:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:48:44 INFO - Downloaded 22879571 bytes. 07:48:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:48:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:48:46 INFO - Return code: 0 07:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:46 INFO - https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:48:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:48:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:48:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:48:47 INFO - Downloaded 10833377 bytes. 07:48:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:48:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:48:47 INFO - Return code: 0 07:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:48:47 INFO - https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:48:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:48:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:48:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:49:19 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 07:49:19 INFO - retry: attempt #1 caught exception: The read operation timed out 07:49:19 INFO - retry: Failed, sleeping 30 seconds before retrying 07:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 07:49:51 INFO - Downloaded 55432186 bytes. 07:49:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:49:51 INFO - mkdir: /builds/slave/test/properties 07:49:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:49:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:49:51 INFO - Contents: 07:49:51 INFO - build_url:https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:49:51 INFO - Running post-action listener: _resource_record_post_action 07:49:51 INFO - Running post-action listener: set_extra_try_arguments 07:49:51 INFO - ##### 07:49:51 INFO - ##### Finished download-and-extract step (success) 07:49:51 INFO - ##### 07:49:51 INFO - ##### 07:49:51 INFO - ##### Running populate-webroot step. 07:49:51 INFO - ##### 07:49:51 INFO - Running pre-action listener: _resource_record_pre_action 07:49:51 INFO - Running main action method: populate_webroot 07:49:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:49:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:49:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:49:51 INFO - '--tppagecycles', 07:49:51 INFO - '7'], 07:49:51 INFO - 'tests': ['tsvgm']}}, 07:49:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:49:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:49:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:49:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:49:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:49:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['damp', 'tps']}, 07:49:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'tests': ['damp', 'tps']}, 07:49:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['dromaeo_dom']}, 07:49:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:49:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['a11yr', 07:49:51 INFO - 'ts_paint', 07:49:51 INFO - 'tpaint', 07:49:51 INFO - 'sessionrestore', 07:49:51 INFO - 'sessionrestore_no_auto_restore', 07:49:51 INFO - 'tabpaint']}, 07:49:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:49:51 INFO - 'ts_paint', 07:49:51 INFO - 'tpaint', 07:49:51 INFO - 'sessionrestore', 07:49:51 INFO - 'sessionrestore_no_auto_restore', 07:49:51 INFO - 'tabpaint']}, 07:49:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:49:51 INFO - 'ts_paint', 07:49:51 INFO - 'tpaint', 07:49:51 INFO - 'sessionrestore', 07:49:51 INFO - 'sessionrestore_no_auto_restore', 07:49:51 INFO - 'tabpaint']}, 07:49:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:49:51 INFO - 'ts_paint', 07:49:51 INFO - 'tpaint', 07:49:51 INFO - 'sessionrestore', 07:49:51 INFO - 'sessionrestore_no_auto_restore', 07:49:51 INFO - 'tabpaint']}, 07:49:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['a11yr', 07:49:51 INFO - 'ts_paint', 07:49:51 INFO - 'tpaint', 07:49:51 INFO - 'sessionrestore', 07:49:51 INFO - 'sessionrestore_no_auto_restore', 07:49:51 INFO - 'tabpaint']}, 07:49:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['a11yr', 07:49:51 INFO - 'ts_paint', 07:49:51 INFO - 'tpaint', 07:49:51 INFO - 'sessionrestore', 07:49:51 INFO - 'sessionrestore_no_auto_restore', 07:49:51 INFO - 'tabpaint']}, 07:49:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['tsvgx', 07:49:51 INFO - 'tsvgr_opacity', 07:49:51 INFO - 'tart', 07:49:51 INFO - 'tscrollx', 07:49:51 INFO - 'cart']}, 07:49:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:49:51 INFO - 'tsvgr_opacity', 07:49:51 INFO - 'tart', 07:49:51 INFO - 'tscrollx', 07:49:51 INFO - 'cart']}, 07:49:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'talos_options': ['--disable-e10s'], 07:49:51 INFO - 'tests': ['tp5o']}, 07:49:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'tests': ['tp5o']}, 07:49:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'talos_options': ['--disable-e10s', 07:49:51 INFO - '--xperf_path', 07:49:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:51 INFO - 'tests': ['tp5n']}, 07:49:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:49:51 INFO - 'talos_options': ['--xperf_path', 07:49:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:49:51 INFO - 'tests': ['tp5n']}}, 07:49:51 INFO - 'talos.zip': {'path': '', 07:49:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:49:51 INFO - Running post-action listener: _resource_record_post_action 07:49:51 INFO - ##### 07:49:51 INFO - ##### Finished populate-webroot step (success) 07:49:51 INFO - ##### 07:49:51 INFO - ##### 07:49:51 INFO - ##### Running create-virtualenv step. 07:49:51 INFO - ##### 07:49:51 INFO - Running pre-action listener: _resource_record_pre_action 07:49:51 INFO - Running main action method: create_virtualenv 07:49:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:49:51 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 07:49:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:49:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:49:51 INFO - Using real prefix '/usr' 07:49:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:49:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:49:54 INFO - Installing pip.................done. 07:49:54 INFO - Return code: 0 07:49:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:49: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')]} 07:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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')]} 07:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:49:54 INFO - Using env: {'DISPLAY': ':0', 07:49:54 INFO - 'HOME': '/home/cltbld', 07:49:54 INFO - 'LANG': 'en_US.UTF-8', 07:49:54 INFO - 'LANGUAGE': 'en_US:en', 07:49:54 INFO - 'LOGNAME': 'cltbld', 07:49:54 INFO - 'MAIL': '/var/mail/cltbld', 07:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:54 INFO - 'MOZ_NO_REMOTE': '1', 07:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:54 INFO - 'NO_EM_RESTART': '1', 07:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:54 INFO - 'PWD': '/builds/slave/test', 07:49:54 INFO - 'SHELL': '/bin/bash', 07:49:54 INFO - 'SHLVL': '1', 07:49:54 INFO - 'TERM': 'linux', 07:49:54 INFO - 'TMOUT': '86400', 07:49:54 INFO - 'USER': 'cltbld', 07:49:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:54 INFO - '_': '/tools/buildbot/bin/python'} 07:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:54 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 07:49:54 INFO - Cleaning up... 07:49:54 INFO - Return code: 0 07:49:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:49: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')]} 07:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49: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')]} 07:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:49:54 INFO - Using env: {'DISPLAY': ':0', 07:49:54 INFO - 'HOME': '/home/cltbld', 07:49:54 INFO - 'LANG': 'en_US.UTF-8', 07:49:54 INFO - 'LANGUAGE': 'en_US:en', 07:49:54 INFO - 'LOGNAME': 'cltbld', 07:49:54 INFO - 'MAIL': '/var/mail/cltbld', 07:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:54 INFO - 'MOZ_NO_REMOTE': '1', 07:49:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:54 INFO - 'NO_EM_RESTART': '1', 07:49:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:54 INFO - 'PWD': '/builds/slave/test', 07:49:54 INFO - 'SHELL': '/bin/bash', 07:49:54 INFO - 'SHLVL': '1', 07:49:54 INFO - 'TERM': 'linux', 07:49:54 INFO - 'TMOUT': '86400', 07:49:54 INFO - 'USER': 'cltbld', 07:49:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:54 INFO - '_': '/tools/buildbot/bin/python'} 07:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:54 INFO - Downloading/unpacking psutil>=3.1.1 07:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:49:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:49:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:49:56 INFO - Installing collected packages: psutil 07:49:56 INFO - Running setup.py install for psutil 07:49:56 INFO - building 'psutil._psutil_linux' extension 07:49:56 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 07:49:56 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 07:49:57 INFO - building 'psutil._psutil_posix' extension 07:49:57 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 07:49:57 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 07:49:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:49:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:49:57 INFO - Successfully installed psutil 07:49:57 INFO - Cleaning up... 07:49:57 INFO - Return code: 0 07:49:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:49:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:49:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:49:57 INFO - Using env: {'DISPLAY': ':0', 07:49:57 INFO - 'HOME': '/home/cltbld', 07:49:57 INFO - 'LANG': 'en_US.UTF-8', 07:49:57 INFO - 'LANGUAGE': 'en_US:en', 07:49:57 INFO - 'LOGNAME': 'cltbld', 07:49:57 INFO - 'MAIL': '/var/mail/cltbld', 07:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:57 INFO - 'MOZ_NO_REMOTE': '1', 07:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:57 INFO - 'NO_EM_RESTART': '1', 07:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:57 INFO - 'PWD': '/builds/slave/test', 07:49:57 INFO - 'SHELL': '/bin/bash', 07:49:57 INFO - 'SHLVL': '1', 07:49:57 INFO - 'TERM': 'linux', 07:49:57 INFO - 'TMOUT': '86400', 07:49:57 INFO - 'USER': 'cltbld', 07:49:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:57 INFO - '_': '/tools/buildbot/bin/python'} 07:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:49:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:49:59 INFO - Installing collected packages: mozsystemmonitor 07:49:59 INFO - Running setup.py install for mozsystemmonitor 07:49:59 INFO - Successfully installed mozsystemmonitor 07:49:59 INFO - Cleaning up... 07:49:59 INFO - Return code: 0 07:49:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:49:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:49:59 INFO - Using env: {'DISPLAY': ':0', 07:49:59 INFO - 'HOME': '/home/cltbld', 07:49:59 INFO - 'LANG': 'en_US.UTF-8', 07:49:59 INFO - 'LANGUAGE': 'en_US:en', 07:49:59 INFO - 'LOGNAME': 'cltbld', 07:49:59 INFO - 'MAIL': '/var/mail/cltbld', 07:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:49:59 INFO - 'MOZ_NO_REMOTE': '1', 07:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:49:59 INFO - 'NO_EM_RESTART': '1', 07:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:49:59 INFO - 'PWD': '/builds/slave/test', 07:49:59 INFO - 'SHELL': '/bin/bash', 07:49:59 INFO - 'SHLVL': '1', 07:49:59 INFO - 'TERM': 'linux', 07:49:59 INFO - 'TMOUT': '86400', 07:49:59 INFO - 'USER': 'cltbld', 07:49:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:49:59 INFO - '_': '/tools/buildbot/bin/python'} 07:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:49:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:50:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:50:01 INFO - warning: no files found matching '*.txt' 07:50:01 INFO - no previously-included directories found matching 'build' 07:50:01 INFO - no previously-included directories found matching 'dist' 07:50:01 INFO - no previously-included directories found matching '.git*' 07:50:02 INFO - Installing collected packages: jsonschema, functools32 07:50:02 INFO - Running setup.py install for functools32 07:50:02 INFO - warning: no files found matching '*.txt' 07:50:02 INFO - no previously-included directories found matching 'build' 07:50:02 INFO - no previously-included directories found matching 'dist' 07:50:02 INFO - no previously-included directories found matching '.git*' 07:50:02 INFO - Successfully installed jsonschema functools32 07:50:02 INFO - Cleaning up... 07:50:02 INFO - Return code: 0 07:50:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:50:02 INFO - Using env: {'DISPLAY': ':0', 07:50:02 INFO - 'HOME': '/home/cltbld', 07:50:02 INFO - 'LANG': 'en_US.UTF-8', 07:50:02 INFO - 'LANGUAGE': 'en_US:en', 07:50:02 INFO - 'LOGNAME': 'cltbld', 07:50:02 INFO - 'MAIL': '/var/mail/cltbld', 07:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:02 INFO - 'MOZ_NO_REMOTE': '1', 07:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:02 INFO - 'NO_EM_RESTART': '1', 07:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:02 INFO - 'PWD': '/builds/slave/test', 07:50:02 INFO - 'SHELL': '/bin/bash', 07:50:02 INFO - 'SHLVL': '1', 07:50:02 INFO - 'TERM': 'linux', 07:50:02 INFO - 'TMOUT': '86400', 07:50:02 INFO - 'USER': 'cltbld', 07:50:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:02 INFO - '_': '/tools/buildbot/bin/python'} 07:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:50:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:50:04 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 07:50:04 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 07:50:04 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 07:50:04 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 07:50:04 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 07:50:04 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 07:50:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:50:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:50:04 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 07:50:04 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 07:50:04 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 07:50:04 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 07:50:04 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 07:50:04 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 07:50:05 INFO - Downloading docopt-0.6.1.tar.gz 07:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:50:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:50:05 INFO - Running setup.py install for blobuploader 07:50:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:50:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:50:05 INFO - Running setup.py install for requests 07:50:05 INFO - Running setup.py install for docopt 07:50:05 INFO - Successfully installed blobuploader requests docopt 07:50:05 INFO - Cleaning up... 07:50:05 INFO - Return code: 0 07:50:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:05 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')]} 07:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:05 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')]} 07:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:05 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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:50:05 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 07:50:05 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 07:50:05 INFO - Using env: {'DISPLAY': ':0', 07:50:05 INFO - 'HOME': '/home/cltbld', 07:50:05 INFO - 'LANG': 'en_US.UTF-8', 07:50:05 INFO - 'LANGUAGE': 'en_US:en', 07:50:05 INFO - 'LOGNAME': 'cltbld', 07:50:05 INFO - 'MAIL': '/var/mail/cltbld', 07:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:05 INFO - 'MOZ_NO_REMOTE': '1', 07:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:05 INFO - 'NO_EM_RESTART': '1', 07:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:05 INFO - 'PWD': '/builds/slave/test', 07:50:05 INFO - 'SHELL': '/bin/bash', 07:50:05 INFO - 'SHLVL': '1', 07:50:05 INFO - 'TERM': 'linux', 07:50:05 INFO - 'TMOUT': '86400', 07:50:05 INFO - 'USER': 'cltbld', 07:50:05 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:05 INFO - '_': '/tools/buildbot/bin/python'} 07:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:05 INFO - Running setup.py (path:/tmp/pip-G3uKfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:05 INFO - Running setup.py (path:/tmp/pip-zQ4MK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:06 INFO - Running setup.py (path:/tmp/pip-1hB6nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:06 INFO - Running setup.py (path:/tmp/pip-Pmao6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:06 INFO - Running setup.py (path:/tmp/pip-WRQ3Js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:06 INFO - Running setup.py (path:/tmp/pip-_IVsNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:06 INFO - Running setup.py (path:/tmp/pip-dWyv_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:06 INFO - Running setup.py (path:/tmp/pip-6yDTUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:06 INFO - Running setup.py (path:/tmp/pip-1fP9Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:06 INFO - Running setup.py (path:/tmp/pip-cMyaB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:06 INFO - Running setup.py (path:/tmp/pip-k0GrO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:06 INFO - Running setup.py (path:/tmp/pip-PYINzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:06 INFO - Running setup.py (path:/tmp/pip-vigxbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:06 INFO - Running setup.py (path:/tmp/pip-fuZxLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:06 INFO - Running setup.py (path:/tmp/pip-PZhJgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:06 INFO - Running setup.py (path:/tmp/pip-ACfzT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:07 INFO - Running setup.py (path:/tmp/pip-zg0aSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:50:07 INFO - Running setup.py install for manifestparser 07:50:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Running setup.py install for mozcrash 07:50:07 INFO - Running setup.py install for mozdebug 07:50:07 INFO - Running setup.py install for mozdevice 07:50:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Running setup.py install for mozfile 07:50:07 INFO - Running setup.py install for mozhttpd 07:50:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Running setup.py install for mozinfo 07:50:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Running setup.py install for mozInstall 07:50:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:50:07 INFO - Running setup.py install for mozleak 07:50:08 INFO - Running setup.py install for mozlog 07:50:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:50:08 INFO - Running setup.py install for moznetwork 07:50:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:50:08 INFO - Running setup.py install for mozprocess 07:50:08 INFO - Running setup.py install for mozprofile 07:50:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:50:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:50:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:50:08 INFO - Running setup.py install for mozrunner 07:50:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:50:08 INFO - Running setup.py install for mozscreenshot 07:50:08 INFO - Running setup.py install for moztest 07:50:08 INFO - Running setup.py install for mozversion 07:50:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:50:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:50:08 INFO - Cleaning up... 07:50:08 INFO - Return code: 0 07:50:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:08 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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:50:08 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 07:50:08 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 07:50:08 INFO - Using env: {'DISPLAY': ':0', 07:50:08 INFO - 'HOME': '/home/cltbld', 07:50:08 INFO - 'LANG': 'en_US.UTF-8', 07:50:08 INFO - 'LANGUAGE': 'en_US:en', 07:50:08 INFO - 'LOGNAME': 'cltbld', 07:50:08 INFO - 'MAIL': '/var/mail/cltbld', 07:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:08 INFO - 'MOZ_NO_REMOTE': '1', 07:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:08 INFO - 'NO_EM_RESTART': '1', 07:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:08 INFO - 'PWD': '/builds/slave/test', 07:50:08 INFO - 'SHELL': '/bin/bash', 07:50:08 INFO - 'SHLVL': '1', 07:50:08 INFO - 'TERM': 'linux', 07:50:08 INFO - 'TMOUT': '86400', 07:50:08 INFO - 'USER': 'cltbld', 07:50:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:08 INFO - '_': '/tools/buildbot/bin/python'} 07:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:09 INFO - Running setup.py (path:/tmp/pip-UChOK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:09 INFO - Running setup.py (path:/tmp/pip-FnwuBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:09 INFO - Running setup.py (path:/tmp/pip-6lRbND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:09 INFO - Running setup.py (path:/tmp/pip-4Zz8nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:09 INFO - Running setup.py (path:/tmp/pip-9orvkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:09 INFO - Running setup.py (path:/tmp/pip-LXZVvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:09 INFO - Running setup.py (path:/tmp/pip-wOr097-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:09 INFO - Running setup.py (path:/tmp/pip-kFxlwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:09 INFO - Running setup.py (path:/tmp/pip-6XMMHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:09 INFO - Running setup.py (path:/tmp/pip-CxaY3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:09 INFO - Running setup.py (path:/tmp/pip-sKoLCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:09 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)) 07:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:09 INFO - Running setup.py (path:/tmp/pip-9jztXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:10 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)) 07:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:10 INFO - Running setup.py (path:/tmp/pip-6QQLoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:10 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)) 07:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:10 INFO - Running setup.py (path:/tmp/pip-tfQ4o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:10 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)) 07:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:10 INFO - Running setup.py (path:/tmp/pip-DM1dmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:10 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)) 07:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:10 INFO - Running setup.py (path:/tmp/pip-0lVR61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:10 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)) 07:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:10 INFO - Running setup.py (path:/tmp/pip-hT9E8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:10 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)) 07:50:10 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)) 07:50:10 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)) 07:50:10 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)) 07:50:10 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)) 07:50:10 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)) 07:50:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:12 INFO - Downloading blessings-1.6.tar.gz 07:50:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:50:12 INFO - Installing collected packages: blessings 07:50:12 INFO - Running setup.py install for blessings 07:50:12 INFO - Successfully installed blessings 07:50:12 INFO - Cleaning up... 07:50:12 INFO - Return code: 0 07:50:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:50:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:12 INFO - Reading from file tmpfile_stdout 07:50:12 INFO - Current package versions: 07:50:12 INFO - argparse == 1.2.1 07:50:12 INFO - blessings == 1.6 07:50:12 INFO - blobuploader == 1.2.4 07:50:12 INFO - docopt == 0.6.1 07:50:12 INFO - functools32 == 3.2.3-2 07:50:12 INFO - jsonschema == 2.5.1 07:50:12 INFO - manifestparser == 1.1 07:50:12 INFO - mozInstall == 1.12 07:50:12 INFO - mozcrash == 0.17 07:50:12 INFO - mozdebug == 0.1 07:50:12 INFO - mozdevice == 0.48 07:50:12 INFO - mozfile == 1.2 07:50:12 INFO - mozhttpd == 0.7 07:50:12 INFO - mozinfo == 0.9 07:50:12 INFO - mozleak == 0.1 07:50:12 INFO - mozlog == 3.2 07:50:12 INFO - moznetwork == 0.27 07:50:12 INFO - mozprocess == 0.22 07:50:12 INFO - mozprofile == 0.28 07:50:12 INFO - mozrunner == 6.11 07:50:12 INFO - mozscreenshot == 0.1 07:50:12 INFO - mozsystemmonitor == 0.3 07:50:12 INFO - moztest == 0.7 07:50:12 INFO - mozversion == 1.4 07:50:12 INFO - psutil == 3.1.1 07:50:12 INFO - requests == 1.2.3 07:50:12 INFO - wsgiref == 0.1.2 07:50:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:12 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')]} 07:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:12 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')]} 07:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:12 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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:50:12 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 07:50:12 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 07:50:12 INFO - Using env: {'DISPLAY': ':0', 07:50:12 INFO - 'HOME': '/home/cltbld', 07:50:12 INFO - 'LANG': 'en_US.UTF-8', 07:50:12 INFO - 'LANGUAGE': 'en_US:en', 07:50:12 INFO - 'LOGNAME': 'cltbld', 07:50:12 INFO - 'MAIL': '/var/mail/cltbld', 07:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:12 INFO - 'MOZ_NO_REMOTE': '1', 07:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:12 INFO - 'NO_EM_RESTART': '1', 07:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:12 INFO - 'PWD': '/builds/slave/test', 07:50:12 INFO - 'SHELL': '/bin/bash', 07:50:12 INFO - 'SHLVL': '1', 07:50:12 INFO - 'TERM': 'linux', 07:50:12 INFO - 'TMOUT': '86400', 07:50:12 INFO - 'USER': 'cltbld', 07:50:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:12 INFO - '_': '/tools/buildbot/bin/python'} 07:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 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)) 07:50:12 INFO - Cleaning up... 07:50:12 INFO - Return code: 0 07:50:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:50:12 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')]} 07:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:12 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')]} 07:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:12 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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:50:12 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 07:50:12 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 07:50:12 INFO - Using env: {'DISPLAY': ':0', 07:50:12 INFO - 'HOME': '/home/cltbld', 07:50:12 INFO - 'LANG': 'en_US.UTF-8', 07:50:12 INFO - 'LANGUAGE': 'en_US:en', 07:50:12 INFO - 'LOGNAME': 'cltbld', 07:50:12 INFO - 'MAIL': '/var/mail/cltbld', 07:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:12 INFO - 'MOZ_NO_REMOTE': '1', 07:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:12 INFO - 'NO_EM_RESTART': '1', 07:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:12 INFO - 'PWD': '/builds/slave/test', 07:50:12 INFO - 'SHELL': '/bin/bash', 07:50:12 INFO - 'SHLVL': '1', 07:50:12 INFO - 'TERM': 'linux', 07:50:12 INFO - 'TMOUT': '86400', 07:50:12 INFO - 'USER': 'cltbld', 07:50:12 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:12 INFO - '_': '/tools/buildbot/bin/python'} 07:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:50:13 INFO - Cleaning up... 07:50:13 INFO - Return code: 0 07:50:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:50:13 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')]} 07:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:13 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')]} 07:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:13 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 0x7fc33cbbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', '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 07:50:13 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 07:50:13 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 07:50:13 INFO - Using env: {'DISPLAY': ':0', 07:50:13 INFO - 'HOME': '/home/cltbld', 07:50:13 INFO - 'LANG': 'en_US.UTF-8', 07:50:13 INFO - 'LANGUAGE': 'en_US:en', 07:50:13 INFO - 'LOGNAME': 'cltbld', 07:50:13 INFO - 'MAIL': '/var/mail/cltbld', 07:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:13 INFO - 'MOZ_NO_REMOTE': '1', 07:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:13 INFO - 'NO_EM_RESTART': '1', 07:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:13 INFO - 'PWD': '/builds/slave/test', 07:50:13 INFO - 'SHELL': '/bin/bash', 07:50:13 INFO - 'SHLVL': '1', 07:50:13 INFO - 'TERM': 'linux', 07:50:13 INFO - 'TMOUT': '86400', 07:50:13 INFO - 'USER': 'cltbld', 07:50:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:13 INFO - '_': '/tools/buildbot/bin/python'} 07:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:13 INFO - Downloading/unpacking flake8 07:50:13 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 07:50:13 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 07:50:13 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 07:50:13 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 07:50:13 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 07:50:13 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 07:50:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:50:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:50:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 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 07:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:50:16 INFO - no previously-included directories found matching 'docs/_build' 07:50:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:50:16 INFO - Running setup.py install for pep8 07:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:50:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:50:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:50:16 INFO - no previously-included directories found matching 'docs/_build' 07:50:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:50:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:50:16 INFO - Cleaning up... 07:50:16 INFO - Return code: 0 07:50:16 INFO - Running post-action listener: _resource_record_post_action 07:50:16 INFO - Running post-action listener: _start_resource_monitoring 07:50:16 INFO - Starting resource monitoring. 07:50:16 INFO - ##### 07:50:16 INFO - ##### Finished create-virtualenv step (success) 07:50:16 INFO - ##### 07:50:16 INFO - ##### 07:50:16 INFO - ##### Running install step. 07:50:16 INFO - ##### 07:50:16 INFO - Running pre-action listener: _resource_record_pre_action 07:50:16 INFO - Running main action method: install 07:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:16 INFO - Reading from file tmpfile_stdout 07:50:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:50:16 INFO - Reading from file tmpfile_stdout 07:50:16 INFO - Output received: 07:50:16 INFO - Usage: mozinstall [options] installer 07:50:16 INFO - Options: 07:50:16 INFO - -h, --help show this help message and exit 07:50:16 INFO - -d DEST, --destination=DEST 07:50:16 INFO - Directory to install application into. [default: 07:50:16 INFO - "/builds/slave/test"] 07:50:16 INFO - --app=APP Application being installed. [default: firefox] 07:50:16 INFO - mkdir: /builds/slave/test/build/application 07:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:50:32 INFO - Reading from file tmpfile_stdout 07:50:32 INFO - Output received: 07:50:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:50:32 INFO - Running post-action listener: _resource_record_post_action 07:50:32 INFO - ##### 07:50:32 INFO - ##### Finished install step (success) 07:50:32 INFO - ##### 07:50:32 INFO - ##### 07:50:32 INFO - ##### Running run-tests step. 07:50:32 INFO - ##### 07:50:32 INFO - Running pre-action listener: _resource_record_pre_action 07:50:32 INFO - Running main action method: run_tests 07:50:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:50:32 INFO - Python 2.7.3 07:50:32 INFO - Return code: 0 07:50:32 INFO - grabbing minidump binary from tooltool 07:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:50:32 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 0x16461c0>, '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 0x16470c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1647550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:50:32 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 07:50:32 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 07:50:32 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 07:50:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:50:32 INFO - Return code: 0 07:50:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:50:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:50:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:50:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:50:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:50:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:50:33 INFO - Return code: 0 07:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 07:50:33 INFO - Using env: {'DISPLAY': ':0', 07:50:33 INFO - 'HOME': '/home/cltbld', 07:50:33 INFO - 'LANG': 'en_US.UTF-8', 07:50:33 INFO - 'LANGUAGE': 'en_US:en', 07:50:33 INFO - 'LOGNAME': 'cltbld', 07:50:33 INFO - 'MAIL': '/var/mail/cltbld', 07:50:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:50:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:33 INFO - 'MOZ_NO_REMOTE': '1', 07:50:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:50:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:33 INFO - 'NO_EM_RESTART': '1', 07:50:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:33 INFO - 'PWD': '/builds/slave/test', 07:50:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:50:33 INFO - 'SHELL': '/bin/bash', 07:50:33 INFO - 'SHLVL': '1', 07:50:33 INFO - 'TERM': 'linux', 07:50:33 INFO - 'TMOUT': '86400', 07:50:33 INFO - 'USER': 'cltbld', 07:50:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610', 07:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:33 INFO - '_': '/tools/buildbot/bin/python'} 07:50:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 07:50:33 INFO - mozversion application_buildid: 20160609063733 07:50:33 INFO - mozversion application_changeset: c9564b7204d452746ee472b8dec3c4d33e876716 07:50:33 INFO - mozversion application_display_name: Nightly 07:50:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:50:33 INFO - mozversion application_name: Firefox 07:50:33 INFO - mozversion application_remotingname: firefox 07:50:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:50:33 INFO - mozversion application_vendor: Mozilla 07:50:33 INFO - mozversion application_version: 50.0a1 07:50:33 INFO - mozversion platform_buildid: 20160609063733 07:50:33 INFO - mozversion platform_changeset: c9564b7204d452746ee472b8dec3c4d33e876716 07:50:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:50:33 INFO - mozversion platform_version: 50.0a1 07:50:33 INFO - using testdate: 1465483833 07:50:33 INFO - actual date: 1465483833 07:50:33 INFO - starting webserver on 'localhost:54377' 07:50:33 INFO - SUITE-START | Running 2 tests 07:50:33 INFO - TEST-START | dromaeo_css 07:50:33 INFO - operating with platform_type : linux_ 07:50:33 INFO - Initialising browser for dromaeo_css test... 07:50:33 INFO - TEST-INFO | started process 12807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKuI1Eu/profile http://localhost:54377/getInfo.html) 07:50:38 INFO - PROCESS | 12807 | __metrics Screen width/height:1600/1200 07:50:38 INFO - PROCESS | 12807 | colorDepth:24 07:50:38 INFO - PROCESS | 12807 | Browser inner width/height: 1024/697 07:50:38 INFO - PROCESS | 12807 | __metrics 07:50:39 ERROR - PROCESS | 12807 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:50:39 INFO - PROCESS | 12807 | console.error: PushService: 07:50:39 INFO - PROCESS | 12807 | stateChangeProcessEnqueue: Error transitioning state 07:50:39 INFO - PROCESS | 12807 | UnknownError 07:50:40 INFO - TEST-INFO | 12807: exit 0 07:50:40 INFO - Browser initialized. 07:50:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:50:40 INFO - TEST-INFO | started process 12889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKuI1Eu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:50:52 INFO - PROCESS | 12889 | RSS: Main: 178348032 07:50:52 INFO - PROCESS | 12889 | 07:51:44 INFO - PROCESS | 12889 | 1465483904184 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] 07:53:55 INFO - PROCESS | 12889 | Cycle 1(1): loaded http://localhost:54377/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54377/tests/dromaeo/cssquery-ext.html) 07:53:56 INFO - PROCESS | 12889 | RSS: Main: 286605312 07:53:56 INFO - PROCESS | 12889 | 07:56:59 INFO - PROCESS | 12889 | Cycle 1(1): loaded http://localhost:54377/tests/dromaeo/cssquery-ext.html (next: http://localhost:54377/tests/dromaeo/cssquery-jquery.html) 07:57:00 INFO - PROCESS | 12889 | RSS: Main: 263995392 07:57:00 INFO - PROCESS | 12889 | 08:00:02 INFO - PROCESS | 12889 | Cycle 1(1): loaded http://localhost:54377/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54377/tests/dromaeo/cssquery-mootools.html) 08:00:02 INFO - PROCESS | 12889 | RSS: Main: 261959680 08:00:02 INFO - PROCESS | 12889 | 08:03:05 INFO - PROCESS | 12889 | Cycle 1(1): loaded http://localhost:54377/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54377/tests/dromaeo/cssquery-prototype.html) 08:03:05 INFO - PROCESS | 12889 | RSS: Main: 258678784 08:03:05 INFO - PROCESS | 12889 | 08:06:08 INFO - PROCESS | 12889 | Cycle 1(1): loaded http://localhost:54377/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54377/tests/dromaeo/cssquery-yui.html) 08:06:09 INFO - PROCESS | 12889 | RSS: Main: 229490688 08:06:09 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | Cycle 1(1): loaded http://localhost:54377/tests/dromaeo/cssquery-yui.html (next: http://localhost:54377/tests/dromaeo/cssquery-dojo.html) 08:09:12 INFO - PROCESS | 12889 | RSS: Main: 286969856 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | __start_tp_report 08:09:12 INFO - PROCESS | 12889 | _x_x_mozilla_page_load 08:09:12 INFO - PROCESS | 12889 | _x_x_mozilla_page_load_details 08:09:12 INFO - PROCESS | 12889 | |i|pagename|runs| 08:09:12 INFO - PROCESS | 12889 | |0;dojo.html;2574.099065327135;2608.92173234803;2634.2229042432486;2649.933751656208;2652.5358062339087;4459.754713490756;4514.074614703986;4558.390334015674;4633.6988095773795;4672.719636821793;4590.563896429842;4594.310853371996;4597.218472859614;4627.190241707696;4640.582347588716;4047.6154765297397;4189.350650649147;4281.7002809803325;4317.43873296471;4420.027593929331;4293.677974151936;4367.781610919441;4375.846845360413;4383;4394.560543945612;4170.895727606819;4188.141431006667;4221.577842215754;4235.343521754133;4243.893902652428;4205.558416366268;4211.578842115795;4214.38891360754;4255.276602977501;4261.31818908973;4212.094399704079;4227.239096962546;4228.978855105735;4263.808128634188;4276.764777937212;4454.354118652777;4536.659750518725;4588.587027167571;4605.539446055401;4621.537846215351;4992.40091189056;4992.425871024842;5011.348524691767;5015.774290156952;5019.322391477177;4966.553010229097;5027.4721154279005;5028.22062580297;5042.042012017741;5043.773030213649;4495.730256184639;4578.816847326137;4598.701084429501;4600.723956562617;4621.838235661803;5020.071286811952;5077;5095.210242412432;5099.133147364957;5104.770285337168;4706.694064885772;4843.75781210938;4876.707397556158;4882.658213925062;4888.095702295016;4824.0834241494;4859.611231101503;4914.287428322945;4920.876978075506;4936.925946110811;4867.805287788519;4895.363602731622;4900.142475066849;4901.117798796179;4937;4622.976885115553;4844.95155048452;4863.7324947128245;4864.343313652612;4902.411710594752;4066.7356621820077;4088.3049881520215;4132.33882578786;4139.503259608866;4171.770552619635;3603.387424137903;3622.601513833476;3629.927401451956;3656.9634303657153;3672.4307732301536;4279.572042795696;4290.077633308853;4292.7424354538825;4339.045410009793;4339.978300108479;4757.215059515142;4849.587785038311;4916.115099282163;4926.039422312686;4942.505749425029;4259.87220383389;4266.274733295348;4267.125239325993;4273.380359847804;4296.871093867127;4344.283193273074;4433.046894917608;4436.0462500562535;4464.15181115587;4474.127545128734;4607.285870690049;4658.7204767713365;4661.906761864676;4676.6492513060975;4725.8818529535665;4926.039422312615;4929.5809856161195;4930.334404855299;4944.826931057396;4991.376077990251;4497.97751011256;4667.183242932405;4673.878269215432;4679.321498382784;4725.574698277172;4808.447028591757;4842.443119041355;4846.806127754991;4864.854054378375;4872.756362181806;4904.828331008398;4925.827596034122;4944.332515110414;4954.5540901319055;4982.8754281143265;4625.583697467244;4684.297355396718;4794.376731024944;4806.663533552758;4853.563179313879;4719.74041427711;4755.548222918956;4774.737389443475;4779.832705855279;4800.951990480051;4724.102420540086;4733.502982186958;4780.235162374003;4799.1601469743355;4801.279808028824;4656.790444430077;4687.507811679725;4848.515148485123;4886.53577910098;4895;4672.883177920579;4675.32207829856;4697.13103075932;4697.882552936067;4743.596794272526 08:09:12 INFO - PROCESS | 12889 | |1;ext.html;560.4647561578693;579.1949190625029;580.5616759346692;581.1805354450227;589.3929252869543;27150;27715.445691086166;39450.2109957801;39604.60395396045;39815.203695926066;36818.26363472729;37361.439578406345;37495.81252093743;40820;41037.38443923336;7752.496087754292;7957.681692732283;7965.283124518792;7966.482178658398;7969.043714754238;7582.4313176511705;9958.153556947667;10234.84647730281;10238.027387398222;10562.947185264064;10261.692149235534;10342.32774869631;10342.327748696349;10345.327553709023;10351.068403843652;10186.439745813977;10252.333598316085;10252.384856908535;10257.076863082359;10260.589576416935;10041.54813033408;10108.44403557804;10110.24173187014;10119.139873110795;10124.392536447836;38344.616553834385;38452;38556.036099097466;38727.612723872684;39019;3078.6812749993746;3097.6902309769066;3186.9362612747614;3387.9661203387896;3641.7814931104217;28510.857445712845;28846.711532884612;29001.984930527542;29559.261018474495;29868;3380.1042723678247;3402.761806673534;3418.077119177833;3445.879394221215;3515.3848076586496;250903;251522;252426;253035.73482132656;253629;50725;50983.490165098614;51191;51230;51307;54465.45534544683;54594.72702636461;54632;54655.72672136614;54689.1796623051;14425.062370945854;14840;14849.109053456827;14849.554513364616;14860.70278594422;11064.889351106547;11080.224384293022;11107.777844443066;11113.333200008025;11140.220184587;15142;15393.23033848303;15642.843571564139;15713;15752.92123539375;5832.358440571534;5920;5946.791862284799;6024.27708674953;6095.542834287447;759.9772006839804;817.8078151634361;850.4302117581235;911.6399022386121;974.3228456222857;27406.862965685443;27572.310692232855;27770.583441248396;27941;27979.160625181277;798.5927177139585;921.2814005075918;946.9384490008127;1000.3447741729179;1033.2405681823852;14584.927075364556;14670.559883203521;14728.705425891421;14840.925795370955;14943.476978305707;384536;385786;387293;387376;388018;48448.27327590089;48790.512094879305;48824.755876221105;48854;48861;1056.815057364958;1097.6377795327362;1160.1646814293695;1169.4211365374194;1189.3458597771364;26601.467970640864;28479.572806408334;28627.713722862503;28949;29081;41336.1732765349;41414;41894.58105418907;41917.16165676608;41935.790321048196;297670;298291;298389;298550;300220;30737;35592.82203588966;39171.608283916794;40265.79867100646;40292.79853600713;40326.59673403228;40890.591094088675;41007.38488922728;41792.16415671731;41868.79065604653;35498.11254718549;35594.28811423705;35823.28353432865;35847.82076089603;36311.27377452489;35356.64643353534;35435.64564354427;35728;35838;36093.81953090323;34878;35210.47184292289;35447.29105417929;35664.465033024004;35681.28637427185;30913;31789.68210317867;31924.5211321835;32139;32163.356732864744;24554.754452455247;24633.384165396008;24708.629370559098;25159.867805948412;25227.73861306964 08:09:12 INFO - PROCESS | 12889 | |2;jquery.html;347.7235597699829;351.1974443937378;352.54521667049505;363.69267968566584;369.56945158889897;15782;16390.754138687913;16962.915185424055;16967.74548381775;16973.066481343507;15418.845811541882;15847.52457426279;16336.428225012127;16349.42777002805;16379.181040947935;4741.905161896769;4830.492798256185;4977.47736487669;5009.298698182258;5010.749462526877;3663.7984910829896;3820.2550502651993;4898.951010489903;5386.649867758583;5671.234383358235;5802.39074897136;5806.419358064181;5822.184894114827;5824.708764561776;5825.621334613236;5606.131049687305;5662.660240385549;5756.021476349009;5756.683382413966;5795.478406943395;3344.1138098403944;4665.300204969248;4933.1120398328285;4942.87642808929;5027.773750181214;20292.492687682778;20305.390838274874;20407.693884591743;20665.070071846803;20673.896630516752;1941.7184508246366;1985.0174163788872;2001.169514651418;2232.6651002349613;2239.596872562938;6193.256809182882;6196.101565273055;6334.208223972004;11331.716707082307;12617.684557886034;1519.574519134644;1658.9502314930571;1705.7867766529184;1707.4706840879367;1737.7393390991326;64855;65016.67491662559;65176.67411662911;65261.347386526;66815.66592167057;8106.554139522383;8716.91283087161;8777.648894044167;8824.51465169409;8870.42342247752;11832.290062596272;11854.762904741858;11918.761624767456;11925.105617078754;11942;6905;6911.343422374866;7013.457039451313;7062.611556364346;7089.22018577956;6941.652917354112;6942.861142777117;6973.825654358681;7103.715851365888;7136.464765142531;3692.9630703693156;3694.612065733113;3715.684166845794;3760.191558814868;3787.16682329887;1678.320280286486;1698.507432844486;1760.9911950440166;1803.350793714288;1811.112554848115;813.9470934389365;829.1418381974627;841.469873979389;861.8922634670666;898.5641963647626;15769.68460630781;16316.510504684878;16495.34018639241;16592.751108733377;17002.659946800995;813.6745301879178;844.936629752771;864.3171894203634;866.328595338605;919.6827094652468;9280.95359523198;9499.24006079512;9531.38046027006;9547.33168678186;9702.27232957517;358544;361588;365295;378271;379041;76879;76949.2305076942;77577;78033;78740.6062969693;888.0497867282076;892.4912799704236;892.8571428571528;893.6872094766779;899.8830152080187;14418.783718244025;14550.708985820436;14588.197649129399;14697;15139.091654500766;35289.64710352864;35508.82245588755;36465.27069458649;36720.63279367172;37772.24455510819;45247;50032.499675002786;50036;50303.74848125736;50743.746281269836;7372.483926125335;7584.772456826304;7602;7639.083310002613;7704.768856934301;10318.948405258227;11097;11753.177277590828;11847.940760296144;12264.509419623471;10129.392236465836;10164.237682173718;10363.378197307884;10423.114035307084;10651.893481065401;9932.205423566242;10243.180545556188;10298;10431.478426078515;10432.739181520523;6012.428819262163;6402.679866006774;10490.737731556772;10641.574337026432;10666.573337066431;7690.577018264049;7719.691212351443;7759.107702614272;7856.764297071097;7871.803204919923;9896.356736812084;10437.791244174921;10472.162227021972;10613.257072005194;10718.8928110721 08:09:12 INFO - PROCESS | 12889 | |3;mootools.html;1197.4551579031543;1350.1291666874863;1405.7118290750395;1436.956891293261;1661.476634860019;6461.935380646192;7281.417486601073;7485.476016678835;7497.512661676994;7634.656440460179;7423.814404639887;7561.357284630813;7574.20470850561;7574.242575742423;7593;2131.488442773731;2161.081540345347;2164.4156077859047;2166.815820655246;2168.8373371997086;2130.169233998734;2152.5156839711094;2197.7582465928735;2200.0759680934048;2203.790639889208;2128.531723020933;2149.344449942767;2153.9892300538477;2158.4495953531828;2184.1045171479695;2124.5538436928264;2125.5642593268344;2126.3408343413435;2138.721966144399;2146.2702681088426;2071.109422948132;2110.0504772852123;2111.5143516991025;2112.3768488295837;2113;7393.7781866543555;7547.660355284025;7597.81005474862;7601.087869455645;7632.503887247367;4370.847020354304;4465.464144302672;4466.196084704752;4470.284754439306;4470.926977525371;2695.110613497541;2782.791290653209;2837.5812093953023;2846.644169478815;2847.03200911691;853.5774791478258;871.1897934920521;873.9038705742363;877.2324216310728;881.9382643214977;9952.651657191964;10038.447885366302;10047.598096076148;10061.547230374577;10074.294799364048;3799.9050023749073;3863.96136038636;3922.3332033554366;3923.6664883484655;3944.3886197639413;8108.351331893435;8183.590820458953;8185.836283274421;8190.2628763410385;8190.754277371689;4303.526612072669;4358.106588149421;4360.324149756792;4363.956360436418;4366.6506679465565;3564.2515071834687;3940.940885886714;4041.7170798043853;4077.918441631151;4080.8367665293054;3306.2891478331794;3321.2693207494312;3365.063543483678;3387.0854869185673;3416.0605833396016;998.4708104704373;999.4508511806671;1001.8046480936148;1004.1013293102632;1022.7852151048214;686.8900975843941;772.687061739985;813.4427916876958;827.1439060572279;833.5873742497503;5039.874003149951;5134.178531434953;5161.793528258828;5177.404598471224;5251.76367063483;370.8257119154047;373.86353980796815;384.29481900712506;386.32393311704516;389.18271629578226;3319.7842140260805;3439.7420193485586;3443.4318337474037;3468.8785892493643;3493.6681015303507;8863.556822158995;9126.178643921947;9224.723258302261;9236.445813251226;9250.074992500697;9111.544422778967;9169.22061624756;9206.217471514863;9208.171264586219;9226;6736.090627765189;6991.860162796817;7075.858482830315;7088.432925365958;7091.680874360666;4999.975000124976;5004.47453017428;5128.230690626265;5182.844514664566;5220.060389129993;8277.710280140167;8397.37019723511;8449.831003379775;8503.277221436247;8518.531480768617;8563.486190828571;8580.785480363042;8637.438566493409;8704.738857834274;8721.127887211482;5894.528437725057;6270.968645156745;6624.735010599522;6739.696713647995;6759.256481787098;7123.643817808985;7409.184989651242;7416.035915330973;7417.777466676009;7422.66598003102;6389.2971773105855;6568.1789776277965;6610.074589557562;6654.4676425884845;6656.068150459037;6356.713947872265;6359.20509936258;6426.068220107964;6483.384078512534;6572.112764776694;6022.09668549721;6068.423499767515;6128.448439640454;6145.385461453819;6149.631022138686;4109.589041095866;4162.937555936724;4202.558731333166;4280.079782846703;4282.143571285693;4267.176101438274;4359.149965756647;4421.2483877740215;4429.800658970418;4455.086707225076 08:09:12 INFO - PROCESS | 12889 | |4;prototype.html;287.6002356724153;287.99280017999547;289.2537253884977;292.7804146889833;295.1484965873455;4681.578657920786;4727.692699974508;4738.952610473894;4772.57046865782;4780.498047704993;4633.9073218535605;4673.275642275453;4677.170311961266;4688.742119183444;4711.764411779414;3483.860645574174;3573.3746594346017;3583.516225309589;3605.801680907549;3607.7113830893463;3571.6964058055096;3588.120910376961;3690.538682664667;3722.181120153562;3755.586885442599;3661.4690869823858;3672.210474747942;3684.944725829101;3698.611645777195;3717.8326975286177;3589.766665166756;3688.465172549992;3692.4461330800327;3696.667299943018;3711.9420965024974;3237.4010808000594;3251.6098068231727;3257;3258.0877354340823;3267.6568960259306;4583.670735486705;4585.409243777255;4590.095110529126;4592.380028696117;4617.861464156081;4206.747595144301;4209.452771139732;4211.957880421218;4213.873583792491;4244.129953359554;4721.362616046824;4874.684524850703;4891.437484689271;4894.632902532324;4909.790594232574;3508.614052454228;3520.9647903520895;3528;3555.6622120898733;3583.157957879896;5123.231515272739;5161.406438259611;5166.250893620404;5179.948200517984;5187;3521.5245941798044;3614.1326081740194;3627.4196128619296;3629.8366573504254;3635.909102272464;3652.5616925969052;3661.5423072115987;3667.394879844796;3676.8713095041544;3679.5768486623847;4148.875533733993;4155.8961025974595;4166.708330416903;4191.308434108399;4195.58044195578;4831.801530303704;4838.177509823268;4873.439554451213;4880.731559764176;4902.7988142904505;1219.7499512600073;1261.7161138743709;1270.1934271737327;1273.2615083251876;1277.2783377391745;797.4378063465243;800.6357107516067;815.7267315449272;825.7646570727314;832.4755404095381;4218.894527636772;4314.201872653569;4386.385905973167;4401.185780630593;4403.2734598791485;5061.139606266944;5069.771860266297;5078.263651770472;5090.371081253963;5099.6175286852895;4335.2196604610845;4387.276099443556;4394.406755088022;4423.20382331177;4426.535213802505;2566.242958327298;2639.5512762830367;2674.879630416636;2677.7857771378244;2678.1831541380066;4700.670953033255;4749.3588365570895;4783.641226907996;4787.845469538652;4795.424549054066;5149.742512874342;5182.378114626269;5188;5201.947980520222;5237.8428647140645;4593.517680643551;4779.805048737816;4791.736454494967;4796.2805579162705;4805.687630304019;5027.321311622884;5034.572061374824;5043.4956504349275;5063.8480845574695;5108.310378099058;4949.802007919643;4984.501549844987;4991.276264941491;5009.797648564391;5016.799328026838;4584.601696482605;4811.687240329367;4852.708837469763;4853.417589889236;4856.271559266138;3567.5005499230647;3588.7439396211116;3618.3848745712767;3621.9818900905325;3623.5868011476073;5169.379674438941;5170.353705786777;5173.275741396283;5184.585233181412;5186.792528298825;4869.220924652039;4888.582311129732;4889.706617602955;4921;4965.205567109245;4885.682430641997;4891.437484689306;4916.06594746997;4922.556969872729;4950.529699678525;4878.438979517259;4902.436219834764;4947.628927830499;4959.603231741524;4969.45336013031;4795.904081918412;4820.39745031871;4900.975495122501;4911.459739428731;4991.226359914219;4877.609791216623;4926.359573255454;4928.137575924127;4945.2938736135975;4949 08:09:12 INFO - PROCESS | 12889 | |5;yui.html;626.6177631644696;685.1538350137582;686.4028295383015;721.5310048468494;725.6988349834819;11941.820872686905;13038.478460861554;13069.150505217167;13466.865331346684;13617.114887532316;12296.200746951441;12325.815112773316;12412.81380779289;12413.813792793115;12415.255084694925;634.9619022858643;779.777763337449;783.7687882074802;790.9604519774017;807.2653884964683;790.8695065314216;800.2397722163968;800.7277525641281;801.9438639295252;804.2801692485223;830.2901019628222;830.3108420011376;830.7383174300106;831.0359982420393;831.2145022953312;656.1994366872408;675.1627981303197;677.3395938959525;678.4301187002941;826.4462809917339;590.3004939147124;605.1558076483282;607.2834055814137;607.8328459673625;608.1485919712394;12021.699457513545;12127.514899404014;12154.696132596668;12159.51361945521;12161.391930403444;11701.18091733579;12394.62816115518;12455.564055258114;12739.299338536377;12774.872251277462;11459.828102578385;11638.476268567934;11676.1826672133;11684.766304673858;12130.757384852253;4172.332426811726;4182.91634167318;4216.852410165629;4392.275274579691;4395.868123956255;57131.42868571303;57159.714201429146;57162.14189290519;57319;57711.422885771026;10353.119984801226;10415.114715249138;10502.527386267637;10594.470276486145;10881.347119172875;18359.816401836077;18379.172937217856;18663.253469861054;18673.719894201597;18687.15907784153;6539.182602174728;6616.801495955129;6688.86622267552;6852.588844669336;6923.238443771181;3601.6938560222675;3611.368010598135;3647.252313275772;3705.7035437164964;3706.5552133743586;2697.109953715269;2794.9580756288674;2795.273228960485;2796.720327967187;2799.5240809062507;515.8220413957179;545.4518209199808;547.1710358806412;553.9502642492535;555.4001678187548;554.0636324611394;595.1400226672416;598.9760409583567;603.9818805435756;616.6423474384846;7793.18171591986;8032.4778889372;8042.879356809653;8068.193180681885;8104.878426823602;584.7427132061879;600.5765935015803;609.2414943395501;615.2555407956423;615.7629312714637;4045.7370270932297;4050.675945924319;4088.7342322748927;4098.713090083726;4198.8110535026;100499;100783.49608251912;102898.48550757348;105275.47362263293;105860;55730.442695573336;63496.365036349045;68164;71658;76261;44818.77590612026;56124.71937640367;72054;72669.90995135077;72934.6353268241;8472.237498625153;8563.61463734121;8760.91239087601;8848.380613357003;8983.505907175168;31556.684433155373;36994.63005369912;37661.623383765815;40465.59534404736;45899.77050114862;59219;59371.70314148402;59869;60264;61166.69416652888;8989.370744047854;10738.624148154777;10802.459877006275;11033.337999720043;11239.213255072067;9995.150412215044;11047.171462140532;11266;12852.678683032998;12992;11268.943655281999;12241.816372754594;12297.323647199131;12468;13162.868371316164;11518.560179977503;11884.465199066235;11958.820617690915;12171.634850954486;12525.49898004106;11529.596464123715;11628.941855291008;11989.64031079069;12288.877111228774;12556.121071524905;9316.232512785913;9638.469884156439;9671.226301895973;9962.501874906371;10146.898531014594;10257.538410771383;10319.226058045526;10360.844587331045;10366.844497332395;10559.15526757873 08:09:12 INFO - PROCESS | 12889 | __end_tp_report 08:09:12 INFO - PROCESS | 12889 | __start_cc_report 08:09:12 INFO - PROCESS | 12889 | _x_x_mozilla_cycle_collect,1088 08:09:12 INFO - PROCESS | 12889 | __end_cc_report 08:09:12 INFO - PROCESS | 12889 | __startTimestamp1465484952448__endTimestamp 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | ------- Summary: start ------- 08:09:12 INFO - PROCESS | 12889 | Number of tests: 6 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | [#0] dojo.html Cycles:165 Average:4553.69 Median:4672.72 stddev:470.48 (10.1%) stddev-sans-first:445.56 08:09:12 INFO - PROCESS | 12889 | Values: 2574.1 2608.9 2634.2 2649.9 2652.5 4459.8 4514.1 4558.4 4633.7 4672.7 4590.6 4594.3 4597.2 4627.2 4640.6 4047.6 4189.4 4281.7 4317.4 4420.0 4293.7 4367.8 4375.8 4383.0 4394.6 4170.9 4188.1 4221.6 4235.3 4243.9 4205.6 4211.6 4214.4 4255.3 4261.3 4212.1 4227.2 4229.0 4263.8 4276.8 4454.4 4536.7 4588.6 4605.5 4621.5 4992.4 4992.4 5011.3 5015.8 5019.3 4966.6 5027.5 5028.2 5042.0 5043.8 4495.7 4578.8 4598.7 4600.7 4621.8 5020.1 5077.0 5095.2 5099.1 5104.8 4706.7 4843.8 4876.7 4882.7 4888.1 4824.1 4859.6 4914.3 4920.9 4936.9 4867.8 4895.4 4900.1 4901.1 4937.0 4623.0 4845.0 4863.7 4864.3 4902.4 4066.7 4088.3 4132.3 4139.5 4171.8 3603.4 3622.6 3629.9 3657.0 3672.4 4279.6 4290.1 4292.7 4339.0 4340.0 4757.2 4849.6 4916.1 4926.0 4942.5 4259.9 4266.3 4267.1 4273.4 4296.9 4344.3 4433.0 4436.0 4464.2 4474.1 4607.3 4658.7 4661.9 4676.6 4725.9 4926.0 4929.6 4930.3 4944.8 4991.4 4498.0 4667.2 4673.9 4679.3 4725.6 4808.4 4842.4 4846.8 4864.9 4872.8 4904.8 4925.8 4944.3 4954.6 4982.9 4625.6 4684.3 4794.4 4806.7 4853.6 4719.7 4755.5 4774.7 4779.8 4801.0 4724.1 4733.5 4780.2 4799.2 4801.3 4656.8 4687.5 4848.5 4886.5 4895.0 4672.9 4675.3 4697.1 4697.9 4743.6 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | [#1] ext.html Cycles:180 Average:47043.14 Median:19161.94 stddev:83375.02 (435.1%) stddev-sans-first:83535.86 08:09:12 INFO - PROCESS | 12889 | Values: 560.5 579.2 580.6 581.2 589.4 27150.0 27715.4 39450.2 39604.6 39815.2 36818.3 37361.4 37495.8 40820.0 41037.4 7752.5 7957.7 7965.3 7966.5 7969.0 7582.4 9958.2 10234.8 10238.0 10562.9 10261.7 10342.3 10342.3 10345.3 10351.1 10186.4 10252.3 10252.4 10257.1 10260.6 10041.5 10108.4 10110.2 10119.1 10124.4 38344.6 38452.0 38556.0 38727.6 39019.0 3078.7 3097.7 3186.9 3388.0 3641.8 28510.9 28846.7 29002.0 29559.3 29868.0 3380.1 3402.8 3418.1 3445.9 3515.4 250903.0 251522.0 252426.0 253035.7 253629.0 50725.0 50983.5 51191.0 51230.0 51307.0 54465.5 54594.7 54632.0 54655.7 54689.2 14425.1 14840.0 14849.1 14849.6 14860.7 11064.9 11080.2 11107.8 11113.3 11140.2 15142.0 15393.2 15642.8 15713.0 15752.9 5832.4 5920.0 5946.8 6024.3 6095.5 760.0 817.8 850.4 911.6 974.3 27406.9 27572.3 27770.6 27941.0 27979.2 798.6 921.3 946.9 1000.3 1033.2 14584.9 14670.6 14728.7 14840.9 14943.5 384536.0 385786.0 387293.0 387376.0 388018.0 48448.3 48790.5 48824.8 48854.0 48861.0 1056.8 1097.6 1160.2 1169.4 1189.3 26601.5 28479.6 28627.7 28949.0 29081.0 41336.2 41414.0 41894.6 41917.2 41935.8 297670.0 298291.0 298389.0 298550.0 300220.0 30737.0 35592.8 39171.6 40265.8 40292.8 40326.6 40890.6 41007.4 41792.2 41868.8 35498.1 35594.3 35823.3 35847.8 36311.3 35356.6 35435.6 35728.0 35838.0 36093.8 34878.0 35210.5 35447.3 35664.5 35681.3 30913.0 31789.7 31924.5 32139.0 32163.4 24554.8 24633.4 24708.6 25159.9 25227.7 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | [#2] jquery.html Cycles:180 Average:23297.75 Median:24533.63 stddev:60988.94 (248.6%) stddev-sans-first:61135.69 08:09:12 INFO - PROCESS | 12889 | Values: 347.7 351.2 352.5 363.7 369.6 15782.0 16390.8 16962.9 16967.7 16973.1 15418.8 15847.5 16336.4 16349.4 16379.2 4741.9 4830.5 4977.5 5009.3 5010.7 3663.8 3820.3 4899.0 5386.6 5671.2 5802.4 5806.4 5822.2 5824.7 5825.6 5606.1 5662.7 5756.0 5756.7 5795.5 3344.1 4665.3 4933.1 4942.9 5027.8 20292.5 20305.4 20407.7 20665.1 20673.9 1941.7 1985.0 2001.2 2232.7 2239.6 6193.3 6196.1 6334.2 11331.7 12617.7 1519.6 1659.0 1705.8 1707.5 1737.7 64855.0 65016.7 65176.7 65261.3 66815.7 8106.6 8716.9 8777.6 8824.5 8870.4 11832.3 11854.8 11918.8 11925.1 11942.0 6905.0 6911.3 7013.5 7062.6 7089.2 6941.7 6942.9 6973.8 7103.7 7136.5 3693.0 3694.6 3715.7 3760.2 3787.2 1678.3 1698.5 1761.0 1803.4 1811.1 813.9 829.1 841.5 861.9 898.6 15769.7 16316.5 16495.3 16592.8 17002.7 813.7 844.9 864.3 866.3 919.7 9281.0 9499.2 9531.4 9547.3 9702.3 358544.0 361588.0 365295.0 378271.0 379041.0 76879.0 76949.2 77577.0 78033.0 78740.6 888.0 892.5 892.9 893.7 899.9 14418.8 14550.7 14588.2 14697.0 15139.1 35289.6 35508.8 36465.3 36720.6 37772.2 45247.0 50032.5 50036.0 50303.7 50743.7 7372.5 7584.8 7602.0 7639.1 7704.8 10318.9 11097.0 11753.2 11847.9 12264.5 10129.4 10164.2 10363.4 10423.1 10651.9 9932.2 10243.2 10298.0 10431.5 10432.7 6012.4 6402.7 10490.7 10641.6 10666.6 7690.6 7719.7 7759.1 7856.8 7871.8 9896.4 10437.8 10472.2 10613.3 10718.9 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | [#3] mootools.html Cycles:180 Average:4893.47 Median:5131.20 stddev:2749.26 (53.6%) stddev-sans-first:2742.94 08:09:12 INFO - PROCESS | 12889 | Values: 1197.5 1350.1 1405.7 1437.0 1661.5 6461.9 7281.4 7485.5 7497.5 7634.7 7423.8 7561.4 7574.2 7574.2 7593.0 2131.5 2161.1 2164.4 2166.8 2168.8 2130.2 2152.5 2197.8 2200.1 2203.8 2128.5 2149.3 2154.0 2158.4 2184.1 2124.6 2125.6 2126.3 2138.7 2146.3 2071.1 2110.1 2111.5 2112.4 2113.0 7393.8 7547.7 7597.8 7601.1 7632.5 4370.8 4465.5 4466.2 4470.3 4470.9 2695.1 2782.8 2837.6 2846.6 2847.0 853.6 871.2 873.9 877.2 881.9 9952.7 10038.4 10047.6 10061.5 10074.3 3799.9 3864.0 3922.3 3923.7 3944.4 8108.4 8183.6 8185.8 8190.3 8190.8 4303.5 4358.1 4360.3 4364.0 4366.7 3564.3 3940.9 4041.7 4077.9 4080.8 3306.3 3321.3 3365.1 3387.1 3416.1 998.5 999.5 1001.8 1004.1 1022.8 686.9 772.7 813.4 827.1 833.6 5039.9 5134.2 5161.8 5177.4 5251.8 370.8 373.9 384.3 386.3 389.2 3319.8 3439.7 3443.4 3468.9 3493.7 8863.6 9126.2 9224.7 9236.4 9250.1 9111.5 9169.2 9206.2 9208.2 9226.0 6736.1 6991.9 7075.9 7088.4 7091.7 5000.0 5004.5 5128.2 5182.8 5220.1 8277.7 8397.4 8449.8 8503.3 8518.5 8563.5 8580.8 8637.4 8704.7 8721.1 5894.5 6271.0 6624.7 6739.7 6759.3 7123.6 7409.2 7416.0 7417.8 7422.7 6389.3 6568.2 6610.1 6654.5 6656.1 6356.7 6359.2 6426.1 6483.4 6572.1 6022.1 6068.4 6128.4 6145.4 6149.6 4109.6 4162.9 4202.6 4280.1 4282.1 4267.2 4359.1 4421.2 4429.8 4455.1 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | [#4] prototype.html Cycles:180 Average:4102.01 Median:4685.16 stddev:1195.57 (25.5%) stddev-sans-first:1164.14 08:09:12 INFO - PROCESS | 12889 | Values: 287.6 288.0 289.3 292.8 295.1 4681.6 4727.7 4739.0 4772.6 4780.5 4633.9 4673.3 4677.2 4688.7 4711.8 3483.9 3573.4 3583.5 3605.8 3607.7 3571.7 3588.1 3690.5 3722.2 3755.6 3661.5 3672.2 3684.9 3698.6 3717.8 3589.8 3688.5 3692.4 3696.7 3711.9 3237.4 3251.6 3257.0 3258.1 3267.7 4583.7 4585.4 4590.1 4592.4 4617.9 4206.7 4209.5 4212.0 4213.9 4244.1 4721.4 4874.7 4891.4 4894.6 4909.8 3508.6 3521.0 3528.0 3555.7 3583.2 5123.2 5161.4 5166.3 5179.9 5187.0 3521.5 3614.1 3627.4 3629.8 3635.9 3652.6 3661.5 3667.4 3676.9 3679.6 4148.9 4155.9 4166.7 4191.3 4195.6 4831.8 4838.2 4873.4 4880.7 4902.8 1219.7 1261.7 1270.2 1273.3 1277.3 797.4 800.6 815.7 825.8 832.5 4218.9 4314.2 4386.4 4401.2 4403.3 5061.1 5069.8 5078.3 5090.4 5099.6 4335.2 4387.3 4394.4 4423.2 4426.5 2566.2 2639.6 2674.9 2677.8 2678.2 4700.7 4749.4 4783.6 4787.8 4795.4 5149.7 5182.4 5188.0 5201.9 5237.8 4593.5 4779.8 4791.7 4796.3 4805.7 5027.3 5034.6 5043.5 5063.8 5108.3 4949.8 4984.5 4991.3 5009.8 5016.8 4584.6 4811.7 4852.7 4853.4 4856.3 3567.5 3588.7 3618.4 3622.0 3623.6 5169.4 5170.4 5173.3 5184.6 5186.8 4869.2 4888.6 4889.7 4921.0 4965.2 4885.7 4891.4 4916.1 4922.6 4950.5 4878.4 4902.4 4947.6 4959.6 4969.5 4795.9 4820.4 4901.0 4911.5 4991.2 4877.6 4926.4 4928.1 4945.3 4949.0 08:09:12 INFO - PROCESS | 12889 | 08:09:12 INFO - PROCESS | 12889 | [#5] yui.html Cycles:180 Average:16760.79 Median:4304.56 stddev:23630.97 (549.0%) stddev-sans-first:23666.20 08:09:12 INFO - PROCESS | 12889 | Values: 626.6 685.2 686.4 721.5 725.7 11941.8 13038.5 13069.2 13466.9 13617.1 12296.2 12325.8 12412.8 12413.8 12415.3 635.0 779.8 783.8 791.0 807.3 790.9 800.2 800.7 801.9 804.3 830.3 830.3 830.7 831.0 831.2 656.2 675.2 677.3 678.4 826.4 590.3 605.2 607.3 607.8 608.1 12021.7 12127.5 12154.7 12159.5 12161.4 11701.2 12394.6 12455.6 12739.3 12774.9 11459.8 11638.5 11676.2 11684.8 12130.8 4172.3 4182.9 4216.9 4392.3 4395.9 57131.4 57159.7 57162.1 57319.0 57711.4 10353.1 10415.1 10502.5 10594.5 10881.3 18359.8 18379.2 18663.3 18673.7 18687.2 6539.2 6616.8 6688.9 6852.6 6923.2 3601.7 3611.4 3647.3 3705.7 3706.6 2697.1 2795.0 2795.3 2796.7 2799.5 515.8 545.5 547.2 554.0 555.4 554.1 595.1 599.0 604.0 616.6 7793.2 8032.5 8042.9 8068.2 8104.9 584.7 600.6 609.2 615.3 615.8 4045.7 4050.7 4088.7 4098.7 4198.8 100499.0 100783.5 102898.5 105275.5 105860.0 55730.4 63496.4 68164.0 71658.0 76261.0 44818.8 56124.7 72054.0 72669.9 72934.6 8472.2 8563.6 8760.9 8848.4 8983.5 31556.7 36994.6 37661.6 40465.6 45899.8 59219.0 59371.7 59869.0 60264.0 61166.7 8989.4 10738.6 10802.5 11033.3 11239.2 9995.2 11047.2 11266.0 12852.7 12992.0 11268.9 12241.8 12297.3 12468.0 13162.9 11518.6 11884.5 11958.8 12171.6 12525.5 11529.6 11628.9 11989.6 12288.9 12556.1 9316.2 9638.5 9671.2 9962.5 10146.9 10257.5 10319.2 10360.8 10366.8 10559.2 08:09:12 INFO - PROCESS | 12889 | -------- Summary: end -------- 08:09:12 INFO - PROCESS | 12889 | 08:09:13 INFO - TEST-INFO | 12889: exit 0 08:09:13 INFO - TEST-OK | dromaeo_css | took 1119403ms 08:09:13 INFO - TEST-START | kraken 08:09:13 INFO - operating with platform_type : linux_ 08:09:13 INFO - Initialising browser for kraken test... 08:09:13 INFO - TEST-INFO | started process 13066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9qVIW0/profile http://localhost:54377/getInfo.html) 08:09:17 INFO - PROCESS | 13066 | __metrics Screen width/height:1600/1200 08:09:17 INFO - PROCESS | 13066 | colorDepth:24 08:09:17 INFO - PROCESS | 13066 | Browser inner width/height: 1024/697 08:09:17 INFO - PROCESS | 13066 | __metrics 08:09:19 INFO - PROCESS | 13066 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:09:19 ERROR - PROCESS | 13066 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:09:19 INFO - PROCESS | 13066 | console.error: PushService: 08:09:19 INFO - PROCESS | 13066 | stateChangeProcessEnqueue: Error transitioning state 08:09:19 INFO - PROCESS | 13066 | UnknownError 08:09:20 INFO - TEST-INFO | 13066: exit 0 08:09:20 INFO - Browser initialized. 08:09:20 INFO - Running cycle 1/1 for kraken test... 08:09:20 INFO - TEST-INFO | started process 13148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9qVIW0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:32 INFO - PROCESS | 13148 | RSS: Main: 174637056 08:09:32 INFO - PROCESS | 13148 | 08:09:34 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54377/tests/kraken/driver.html?testName=audio-beat-detection) 08:09:35 INFO - PROCESS | 13148 | RSS: Main: 232550400 08:09:35 INFO - PROCESS | 13148 | 08:09:38 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54377/tests/kraken/driver.html?testName=audio-dft) 08:09:39 INFO - PROCESS | 13148 | RSS: Main: 219566080 08:09:39 INFO - PROCESS | 13148 | 08:09:42 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54377/tests/kraken/driver.html?testName=audio-fft) 08:09:43 INFO - PROCESS | 13148 | RSS: Main: 287309824 08:09:43 INFO - PROCESS | 13148 | 08:09:45 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54377/tests/kraken/driver.html?testName=audio-oscillator) 08:09:45 INFO - PROCESS | 13148 | RSS: Main: 197296128 08:09:45 INFO - PROCESS | 13148 | 08:09:48 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54377/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:09:48 INFO - PROCESS | 13148 | RSS: Main: 200978432 08:09:48 INFO - PROCESS | 13148 | 08:09:51 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54377/tests/kraken/driver.html?testName=imaging-darkroom) 08:09:52 INFO - PROCESS | 13148 | RSS: Main: 237424640 08:09:52 INFO - PROCESS | 13148 | 08:09:55 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54377/tests/kraken/driver.html?testName=imaging-desaturate) 08:09:56 INFO - PROCESS | 13148 | RSS: Main: 233312256 08:09:56 INFO - PROCESS | 13148 | 08:09:59 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54377/tests/kraken/driver.html?testName=json-parse-financial) 08:10:00 INFO - PROCESS | 13148 | RSS: Main: 236400640 08:10:00 INFO - PROCESS | 13148 | 08:10:01 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54377/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:10:02 INFO - PROCESS | 13148 | RSS: Main: 223047680 08:10:02 INFO - PROCESS | 13148 | 08:10:04 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:10:04 INFO - PROCESS | 13148 | RSS: Main: 225660928 08:10:04 INFO - PROCESS | 13148 | 08:10:07 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:10:07 INFO - PROCESS | 13148 | RSS: Main: 234221568 08:10:07 INFO - PROCESS | 13148 | 08:10:10 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:10:11 INFO - PROCESS | 13148 | RSS: Main: 240959488 08:10:11 INFO - PROCESS | 13148 | 08:10:14 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:10:14 INFO - PROCESS | 13148 | RSS: Main: 241020928 08:10:14 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | Cycle 1(1): loaded http://localhost:54377/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54377/tests/kraken/driver.html?testName=ai-astar) 08:10:16 INFO - PROCESS | 13148 | RSS: Main: 283897856 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | __start_tp_report 08:10:16 INFO - PROCESS | 13148 | _x_x_mozilla_page_load 08:10:16 INFO - PROCESS | 13148 | _x_x_mozilla_page_load_details 08:10:16 INFO - PROCESS | 13148 | |i|pagename|runs| 08:10:16 INFO - PROCESS | 13148 | |0;ai-astar;114;110;114;115;113;114;115;113;112;112 08:10:16 INFO - PROCESS | 13148 | |1;audio-beat-detection;153;129;140;179;139;156;156;143;196;129 08:10:16 INFO - PROCESS | 13148 | |2;audio-dft;162;161;163;161;164;163;163;161;163;162 08:10:16 INFO - PROCESS | 13148 | |3;audio-fft;76;75;76;119;76;77;76;75;98;75 08:10:16 INFO - PROCESS | 13148 | |4;audio-oscillator;87;88;115;87;85;86;117;85;84;130 08:10:16 INFO - PROCESS | 13148 | |5;imaging-gaussian-blur;117;117;118;118;117;118;118;116;117;117 08:10:16 INFO - PROCESS | 13148 | |6;imaging-darkroom;147;146;148;147;147;147;147;147;147;146 08:10:16 INFO - PROCESS | 13148 | |7;imaging-desaturate;95;94;95;94;95;95;95;94;94;95 08:10:16 INFO - PROCESS | 13148 | |8;json-parse-financial;63;63;63;64;65;64;63;63;64;64 08:10:16 INFO - PROCESS | 13148 | |9;json-stringify-tinderbox;64;65;65;65;64;65;65;65;65;64 08:10:16 INFO - PROCESS | 13148 | |10;stanford-crypto-aes;84;86;83;88;85;86;85;86;120;84 08:10:16 INFO - PROCESS | 13148 | |11;stanford-crypto-ccm;134;132;134;131;148;132;135;144;152;152 08:10:16 INFO - PROCESS | 13148 | |12;stanford-crypto-pbkdf2;176;173;169;173;172;176;179;169;172;171 08:10:16 INFO - PROCESS | 13148 | |13;stanford-crypto-sha256-iterative;66;68;68;67;70;72;67;68;66;66 08:10:16 INFO - PROCESS | 13148 | __end_tp_report 08:10:16 INFO - PROCESS | 13148 | __start_cc_report 08:10:16 INFO - PROCESS | 13148 | _x_x_mozilla_cycle_collect,1883 08:10:16 INFO - PROCESS | 13148 | __end_cc_report 08:10:16 INFO - PROCESS | 13148 | __startTimestamp1465485016782__endTimestamp 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | ------- Summary: start ------- 08:10:16 INFO - PROCESS | 13148 | Number of tests: 14 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.55 (1.4%) stddev-sans-first:1.62 08:10:16 INFO - PROCESS | 13148 | Values: 114.0 110.0 114.0 115.0 113.0 114.0 115.0 113.0 112.0 112.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#1] audio-beat-detection Cycles:10 Average:152.00 Median:154.50 stddev:21.47 (13.9%) stddev-sans-first:22.77 08:10:16 INFO - PROCESS | 13148 | Values: 153.0 129.0 140.0 179.0 139.0 156.0 156.0 143.0 196.0 129.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.12 08:10:16 INFO - PROCESS | 13148 | Values: 162.0 161.0 163.0 161.0 164.0 163.0 163.0 161.0 163.0 162.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:14.68 (19.3%) stddev-sans-first:15.39 08:10:16 INFO - PROCESS | 13148 | Values: 76.0 75.0 76.0 119.0 76.0 77.0 76.0 75.0 98.0 75.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:85.50 stddev:17.22 (20.1%) stddev-sans-first:17.92 08:10:16 INFO - PROCESS | 13148 | Values: 87.0 88.0 115.0 87.0 85.0 86.0 117.0 85.0 84.0 130.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 08:10:16 INFO - PROCESS | 13148 | Values: 117.0 117.0 118.0 118.0 117.0 118.0 118.0 116.0 117.0 117.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:10:16 INFO - PROCESS | 13148 | Values: 147.0 146.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 146.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 08:10:16 INFO - PROCESS | 13148 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 08:10:16 INFO - PROCESS | 13148 | Values: 63.0 63.0 63.0 64.0 65.0 64.0 63.0 63.0 64.0 64.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 08:10:16 INFO - PROCESS | 13148 | Values: 64.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 65.0 64.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:85.50 stddev:11.09 (13.0%) stddev-sans-first:11.63 08:10:16 INFO - PROCESS | 13148 | Values: 84.0 86.0 83.0 88.0 85.0 86.0 85.0 86.0 120.0 84.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:139.50 stddev:8.63 (6.2%) stddev-sans-first:8.93 08:10:16 INFO - PROCESS | 13148 | Values: 134.0 132.0 134.0 131.0 148.0 132.0 135.0 144.0 152.0 152.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.00 Median:173.00 stddev:3.20 (1.8%) stddev-sans-first:3.20 08:10:16 INFO - PROCESS | 13148 | Values: 176.0 173.0 169.0 173.0 172.0 176.0 179.0 169.0 172.0 171.0 08:10:16 INFO - PROCESS | 13148 | 08:10:16 INFO - PROCESS | 13148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.93 (2.8%) stddev-sans-first:1.94 08:10:16 INFO - PROCESS | 13148 | Values: 66.0 68.0 68.0 67.0 70.0 72.0 67.0 68.0 66.0 66.0 08:10:16 INFO - PROCESS | 13148 | -------- Summary: end -------- 08:10:16 INFO - PROCESS | 13148 | 08:10:17 INFO - TEST-INFO | 13148: exit 0 08:10:18 INFO - TEST-OK | kraken | took 64809ms 08:10:18 INFO - SUITE-END | took 1184s 08:10:18 INFO - Completed test suite (00:19:44) 08:10:18 INFO - javascript benchmark 08:10:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.099065327135, 2608.92173234803, 2634.2229042432486, 2649.933751656208, 2652.5358062339087, 4459.754713490756, 4514.074614703986, 4558.390334015674, 4633.6988095773795, 4672.719636821793, 4590.563896429842, 4594.310853371996, 4597.218472859614, 4627.190241707696, 4640.582347588716, 4047.6154765297397, 4189.350650649147, 4281.7002809803325, 4317.43873296471, 4420.027593929331, 4293.677974151936, 4367.781610919441, 4375.846845360413, 4383.0, 4394.560543945612, 4170.895727606819, 4188.141431006667, 4221.577842215754, 4235.343521754133, 4243.893902652428, 4205.558416366268, 4211.578842115795, 4214.38891360754, 4255.276602977501, 4261.31818908973, 4212.094399704079, 4227.239096962546, 4228.978855105735, 4263.808128634188, 4276.764777937212, 4454.354118652777, 4536.659750518725, 4588.587027167571, 4605.539446055401, 4621.537846215351, 4992.40091189056, 4992.425871024842, 5011.348524691767, 5015.774290156952, 5019.322391477177, 4966.553010229097, 5027.4721154279005, 5028.22062580297, 5042.042012017741, 5043.773030213649, 4495.730256184639, 4578.816847326137, 4598.701084429501, 4600.723956562617, 4621.838235661803, 5020.071286811952, 5077.0, 5095.210242412432, 5099.133147364957, 5104.770285337168, 4706.694064885772, 4843.75781210938, 4876.707397556158, 4882.658213925062, 4888.095702295016, 4824.0834241494, 4859.611231101503, 4914.287428322945, 4920.876978075506, 4936.925946110811, 4867.805287788519, 4895.363602731622, 4900.142475066849, 4901.117798796179, 4937.0, 4622.976885115553, 4844.95155048452, 4863.7324947128245, 4864.343313652612, 4902.411710594752, 4066.7356621820077, 4088.3049881520215, 4132.33882578786, 4139.503259608866, 4171.770552619635, 3603.387424137903, 3622.601513833476, 3629.927401451956, 3656.9634303657153, 3672.4307732301536, 4279.572042795696, 4290.077633308853, 4292.7424354538825, 4339.045410009793, 4339.978300108479, 4757.215059515142, 4849.587785038311, 4916.115099282163, 4926.039422312686, 4942.505749425029, 4259.87220383389, 4266.274733295348, 4267.125239325993, 4273.380359847804, 4296.871093867127, 4344.283193273074, 4433.046894917608, 4436.0462500562535, 4464.15181115587, 4474.127545128734, 4607.285870690049, 4658.7204767713365, 4661.906761864676, 4676.6492513060975, 4725.8818529535665, 4926.039422312615, 4929.5809856161195, 4930.334404855299, 4944.826931057396, 4991.376077990251, 4497.97751011256, 4667.183242932405, 4673.878269215432, 4679.321498382784, 4725.574698277172, 4808.447028591757, 4842.443119041355, 4846.806127754991, 4864.854054378375, 4872.756362181806, 4904.828331008398, 4925.827596034122, 4944.332515110414, 4954.5540901319055, 4982.8754281143265, 4625.583697467244, 4684.297355396718, 4794.376731024944, 4806.663533552758, 4853.563179313879, 4719.74041427711, 4755.548222918956, 4774.737389443475, 4779.832705855279, 4800.951990480051, 4724.102420540086, 4733.502982186958, 4780.235162374003, 4799.1601469743355, 4801.279808028824, 4656.790444430077, 4687.507811679725, 4848.515148485123, 4886.53577910098, 4895.0, 4672.883177920579, 4675.32207829856, 4697.13103075932, 4697.882552936067, 4743.596794272526], "value": 4524.468295791763, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.4647561578693, 579.1949190625029, 580.5616759346692, 581.1805354450227, 589.3929252869543, 27150.0, 27715.445691086166, 39450.2109957801, 39604.60395396045, 39815.203695926066, 36818.26363472729, 37361.439578406345, 37495.81252093743, 40820.0, 41037.38443923336, 7752.496087754292, 7957.681692732283, 7965.283124518792, 7966.482178658398, 7969.043714754238, 7582.4313176511705, 9958.153556947667, 10234.84647730281, 10238.027387398222, 10562.947185264064, 10261.692149235534, 10342.32774869631, 10342.327748696349, 10345.327553709023, 10351.068403843652, 10186.439745813977, 10252.333598316085, 10252.384856908535, 10257.076863082359, 10260.589576416935, 10041.54813033408, 10108.44403557804, 10110.24173187014, 10119.139873110795, 10124.392536447836, 38344.616553834385, 38452.0, 38556.036099097466, 38727.612723872684, 39019.0, 3078.6812749993746, 3097.6902309769066, 3186.9362612747614, 3387.9661203387896, 3641.7814931104217, 28510.857445712845, 28846.711532884612, 29001.984930527542, 29559.261018474495, 29868.0, 3380.1042723678247, 3402.761806673534, 3418.077119177833, 3445.879394221215, 3515.3848076586496, 250903.0, 251522.0, 252426.0, 253035.73482132656, 253629.0, 50725.0, 50983.490165098614, 51191.0, 51230.0, 51307.0, 54465.45534544683, 54594.72702636461, 54632.0, 54655.72672136614, 54689.1796623051, 14425.062370945854, 14840.0, 14849.109053456827, 14849.554513364616, 14860.70278594422, 11064.889351106547, 11080.224384293022, 11107.777844443066, 11113.333200008025, 11140.220184587, 15142.0, 15393.23033848303, 15642.843571564139, 15713.0, 15752.92123539375, 5832.358440571534, 5920.0, 5946.791862284799, 6024.27708674953, 6095.542834287447, 759.9772006839804, 817.8078151634361, 850.4302117581235, 911.6399022386121, 974.3228456222857, 27406.862965685443, 27572.310692232855, 27770.583441248396, 27941.0, 27979.160625181277, 798.5927177139585, 921.2814005075918, 946.9384490008127, 1000.3447741729179, 1033.2405681823852, 14584.927075364556, 14670.559883203521, 14728.705425891421, 14840.925795370955, 14943.476978305707, 384536.0, 385786.0, 387293.0, 387376.0, 388018.0, 48448.27327590089, 48790.512094879305, 48824.755876221105, 48854.0, 48861.0, 1056.815057364958, 1097.6377795327362, 1160.1646814293695, 1169.4211365374194, 1189.3458597771364, 26601.467970640864, 28479.572806408334, 28627.713722862503, 28949.0, 29081.0, 41336.1732765349, 41414.0, 41894.58105418907, 41917.16165676608, 41935.790321048196, 297670.0, 298291.0, 298389.0, 298550.0, 300220.0, 30737.0, 35592.82203588966, 39171.608283916794, 40265.79867100646, 40292.79853600713, 40326.59673403228, 40890.591094088675, 41007.38488922728, 41792.16415671731, 41868.79065604653, 35498.11254718549, 35594.28811423705, 35823.28353432865, 35847.82076089603, 36311.27377452489, 35356.64643353534, 35435.64564354427, 35728.0, 35838.0, 36093.81953090323, 34878.0, 35210.47184292289, 35447.29105417929, 35664.465033024004, 35681.28637427185, 30913.0, 31789.68210317867, 31924.5211321835, 32139.0, 32163.356732864744, 24554.754452455247, 24633.384165396008, 24708.629370559098, 25159.867805948412, 25227.73861306964], "value": 17870.398250585127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.7235597699829, 351.1974443937378, 352.54521667049505, 363.69267968566584, 369.56945158889897, 15782.0, 16390.754138687913, 16962.915185424055, 16967.74548381775, 16973.066481343507, 15418.845811541882, 15847.52457426279, 16336.428225012127, 16349.42777002805, 16379.181040947935, 4741.905161896769, 4830.492798256185, 4977.47736487669, 5009.298698182258, 5010.749462526877, 3663.7984910829896, 3820.2550502651993, 4898.951010489903, 5386.649867758583, 5671.234383358235, 5802.39074897136, 5806.419358064181, 5822.184894114827, 5824.708764561776, 5825.621334613236, 5606.131049687305, 5662.660240385549, 5756.021476349009, 5756.683382413966, 5795.478406943395, 3344.1138098403944, 4665.300204969248, 4933.1120398328285, 4942.87642808929, 5027.773750181214, 20292.492687682778, 20305.390838274874, 20407.693884591743, 20665.070071846803, 20673.896630516752, 1941.7184508246366, 1985.0174163788872, 2001.169514651418, 2232.6651002349613, 2239.596872562938, 6193.256809182882, 6196.101565273055, 6334.208223972004, 11331.716707082307, 12617.684557886034, 1519.574519134644, 1658.9502314930571, 1705.7867766529184, 1707.4706840879367, 1737.7393390991326, 64855.0, 65016.67491662559, 65176.67411662911, 65261.347386526, 66815.66592167057, 8106.554139522383, 8716.91283087161, 8777.648894044167, 8824.51465169409, 8870.42342247752, 11832.290062596272, 11854.762904741858, 11918.761624767456, 11925.105617078754, 11942.0, 6905.0, 6911.343422374866, 7013.457039451313, 7062.611556364346, 7089.22018577956, 6941.652917354112, 6942.861142777117, 6973.825654358681, 7103.715851365888, 7136.464765142531, 3692.9630703693156, 3694.612065733113, 3715.684166845794, 3760.191558814868, 3787.16682329887, 1678.320280286486, 1698.507432844486, 1760.9911950440166, 1803.350793714288, 1811.112554848115, 813.9470934389365, 829.1418381974627, 841.469873979389, 861.8922634670666, 898.5641963647626, 15769.68460630781, 16316.510504684878, 16495.34018639241, 16592.751108733377, 17002.659946800995, 813.6745301879178, 844.936629752771, 864.3171894203634, 866.328595338605, 919.6827094652468, 9280.95359523198, 9499.24006079512, 9531.38046027006, 9547.33168678186, 9702.27232957517, 358544.0, 361588.0, 365295.0, 378271.0, 379041.0, 76879.0, 76949.2305076942, 77577.0, 78033.0, 78740.6062969693, 888.0497867282076, 892.4912799704236, 892.8571428571528, 893.6872094766779, 899.8830152080187, 14418.783718244025, 14550.708985820436, 14588.197649129399, 14697.0, 15139.091654500766, 35289.64710352864, 35508.82245588755, 36465.27069458649, 36720.63279367172, 37772.24455510819, 45247.0, 50032.499675002786, 50036.0, 50303.74848125736, 50743.746281269836, 7372.483926125335, 7584.772456826304, 7602.0, 7639.083310002613, 7704.768856934301, 10318.948405258227, 11097.0, 11753.177277590828, 11847.940760296144, 12264.509419623471, 10129.392236465836, 10164.237682173718, 10363.378197307884, 10423.114035307084, 10651.893481065401, 9932.205423566242, 10243.180545556188, 10298.0, 10431.478426078515, 10432.739181520523, 6012.428819262163, 6402.679866006774, 10490.737731556772, 10641.574337026432, 10666.573337066431, 7690.577018264049, 7719.691212351443, 7759.107702614272, 7856.764297071097, 7871.803204919923, 9896.356736812084, 10437.791244174921, 10472.162227021972, 10613.257072005194, 10718.8928110721], "value": 7918.03479148455, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.4551579031543, 1350.1291666874863, 1405.7118290750395, 1436.956891293261, 1661.476634860019, 6461.935380646192, 7281.417486601073, 7485.476016678835, 7497.512661676994, 7634.656440460179, 7423.814404639887, 7561.357284630813, 7574.20470850561, 7574.242575742423, 7593.0, 2131.488442773731, 2161.081540345347, 2164.4156077859047, 2166.815820655246, 2168.8373371997086, 2130.169233998734, 2152.5156839711094, 2197.7582465928735, 2200.0759680934048, 2203.790639889208, 2128.531723020933, 2149.344449942767, 2153.9892300538477, 2158.4495953531828, 2184.1045171479695, 2124.5538436928264, 2125.5642593268344, 2126.3408343413435, 2138.721966144399, 2146.2702681088426, 2071.109422948132, 2110.0504772852123, 2111.5143516991025, 2112.3768488295837, 2113.0, 7393.7781866543555, 7547.660355284025, 7597.81005474862, 7601.087869455645, 7632.503887247367, 4370.847020354304, 4465.464144302672, 4466.196084704752, 4470.284754439306, 4470.926977525371, 2695.110613497541, 2782.791290653209, 2837.5812093953023, 2846.644169478815, 2847.03200911691, 853.5774791478258, 871.1897934920521, 873.9038705742363, 877.2324216310728, 881.9382643214977, 9952.651657191964, 10038.447885366302, 10047.598096076148, 10061.547230374577, 10074.294799364048, 3799.9050023749073, 3863.96136038636, 3922.3332033554366, 3923.6664883484655, 3944.3886197639413, 8108.351331893435, 8183.590820458953, 8185.836283274421, 8190.2628763410385, 8190.754277371689, 4303.526612072669, 4358.106588149421, 4360.324149756792, 4363.956360436418, 4366.6506679465565, 3564.2515071834687, 3940.940885886714, 4041.7170798043853, 4077.918441631151, 4080.8367665293054, 3306.2891478331794, 3321.2693207494312, 3365.063543483678, 3387.0854869185673, 3416.0605833396016, 998.4708104704373, 999.4508511806671, 1001.8046480936148, 1004.1013293102632, 1022.7852151048214, 686.8900975843941, 772.687061739985, 813.4427916876958, 827.1439060572279, 833.5873742497503, 5039.874003149951, 5134.178531434953, 5161.793528258828, 5177.404598471224, 5251.76367063483, 370.8257119154047, 373.86353980796815, 384.29481900712506, 386.32393311704516, 389.18271629578226, 3319.7842140260805, 3439.7420193485586, 3443.4318337474037, 3468.8785892493643, 3493.6681015303507, 8863.556822158995, 9126.178643921947, 9224.723258302261, 9236.445813251226, 9250.074992500697, 9111.544422778967, 9169.22061624756, 9206.217471514863, 9208.171264586219, 9226.0, 6736.090627765189, 6991.860162796817, 7075.858482830315, 7088.432925365958, 7091.680874360666, 4999.975000124976, 5004.47453017428, 5128.230690626265, 5182.844514664566, 5220.060389129993, 8277.710280140167, 8397.37019723511, 8449.831003379775, 8503.277221436247, 8518.531480768617, 8563.486190828571, 8580.785480363042, 8637.438566493409, 8704.738857834274, 8721.127887211482, 5894.528437725057, 6270.968645156745, 6624.735010599522, 6739.696713647995, 6759.256481787098, 7123.643817808985, 7409.184989651242, 7416.035915330973, 7417.777466676009, 7422.66598003102, 6389.2971773105855, 6568.1789776277965, 6610.074589557562, 6654.4676425884845, 6656.068150459037, 6356.713947872265, 6359.20509936258, 6426.068220107964, 6483.384078512534, 6572.112764776694, 6022.09668549721, 6068.423499767515, 6128.448439640454, 6145.385461453819, 6149.631022138686, 4109.589041095866, 4162.937555936724, 4202.558731333166, 4280.079782846703, 4282.143571285693, 4267.176101438274, 4359.149965756647, 4421.2483877740215, 4429.800658970418, 4455.086707225076], "value": 3867.5656946232734, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.6002356724153, 287.99280017999547, 289.2537253884977, 292.7804146889833, 295.1484965873455, 4681.578657920786, 4727.692699974508, 4738.952610473894, 4772.57046865782, 4780.498047704993, 4633.9073218535605, 4673.275642275453, 4677.170311961266, 4688.742119183444, 4711.764411779414, 3483.860645574174, 3573.3746594346017, 3583.516225309589, 3605.801680907549, 3607.7113830893463, 3571.6964058055096, 3588.120910376961, 3690.538682664667, 3722.181120153562, 3755.586885442599, 3661.4690869823858, 3672.210474747942, 3684.944725829101, 3698.611645777195, 3717.8326975286177, 3589.766665166756, 3688.465172549992, 3692.4461330800327, 3696.667299943018, 3711.9420965024974, 3237.4010808000594, 3251.6098068231727, 3257.0, 3258.0877354340823, 3267.6568960259306, 4583.670735486705, 4585.409243777255, 4590.095110529126, 4592.380028696117, 4617.861464156081, 4206.747595144301, 4209.452771139732, 4211.957880421218, 4213.873583792491, 4244.129953359554, 4721.362616046824, 4874.684524850703, 4891.437484689271, 4894.632902532324, 4909.790594232574, 3508.614052454228, 3520.9647903520895, 3528.0, 3555.6622120898733, 3583.157957879896, 5123.231515272739, 5161.406438259611, 5166.250893620404, 5179.948200517984, 5187.0, 3521.5245941798044, 3614.1326081740194, 3627.4196128619296, 3629.8366573504254, 3635.909102272464, 3652.5616925969052, 3661.5423072115987, 3667.394879844796, 3676.8713095041544, 3679.5768486623847, 4148.875533733993, 4155.8961025974595, 4166.708330416903, 4191.308434108399, 4195.58044195578, 4831.801530303704, 4838.177509823268, 4873.439554451213, 4880.731559764176, 4902.7988142904505, 1219.7499512600073, 1261.7161138743709, 1270.1934271737327, 1273.2615083251876, 1277.2783377391745, 797.4378063465243, 800.6357107516067, 815.7267315449272, 825.7646570727314, 832.4755404095381, 4218.894527636772, 4314.201872653569, 4386.385905973167, 4401.185780630593, 4403.2734598791485, 5061.139606266944, 5069.771860266297, 5078.263651770472, 5090.371081253963, 5099.6175286852895, 4335.2196604610845, 4387.276099443556, 4394.406755088022, 4423.20382331177, 4426.535213802505, 2566.242958327298, 2639.5512762830367, 2674.879630416636, 2677.7857771378244, 2678.1831541380066, 4700.670953033255, 4749.3588365570895, 4783.641226907996, 4787.845469538652, 4795.424549054066, 5149.742512874342, 5182.378114626269, 5188.0, 5201.947980520222, 5237.8428647140645, 4593.517680643551, 4779.805048737816, 4791.736454494967, 4796.2805579162705, 4805.687630304019, 5027.321311622884, 5034.572061374824, 5043.4956504349275, 5063.8480845574695, 5108.310378099058, 4949.802007919643, 4984.501549844987, 4991.276264941491, 5009.797648564391, 5016.799328026838, 4584.601696482605, 4811.687240329367, 4852.708837469763, 4853.417589889236, 4856.271559266138, 3567.5005499230647, 3588.7439396211116, 3618.3848745712767, 3621.9818900905325, 3623.5868011476073, 5169.379674438941, 5170.353705786777, 5173.275741396283, 5184.585233181412, 5186.792528298825, 4869.220924652039, 4888.582311129732, 4889.706617602955, 4921.0, 4965.205567109245, 4885.682430641997, 4891.437484689306, 4916.06594746997, 4922.556969872729, 4950.529699678525, 4878.438979517259, 4902.436219834764, 4947.628927830499, 4959.603231741524, 4969.45336013031, 4795.904081918412, 4820.39745031871, 4900.975495122501, 4911.459739428731, 4991.226359914219, 4877.609791216623, 4926.359573255454, 4928.137575924127, 4945.2938736135975, 4949.0], "value": 3719.3785759325856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.6177631644696, 685.1538350137582, 686.4028295383015, 721.5310048468494, 725.6988349834819, 11941.820872686905, 13038.478460861554, 13069.150505217167, 13466.865331346684, 13617.114887532316, 12296.200746951441, 12325.815112773316, 12412.81380779289, 12413.813792793115, 12415.255084694925, 634.9619022858643, 779.777763337449, 783.7687882074802, 790.9604519774017, 807.2653884964683, 790.8695065314216, 800.2397722163968, 800.7277525641281, 801.9438639295252, 804.2801692485223, 830.2901019628222, 830.3108420011376, 830.7383174300106, 831.0359982420393, 831.2145022953312, 656.1994366872408, 675.1627981303197, 677.3395938959525, 678.4301187002941, 826.4462809917339, 590.3004939147124, 605.1558076483282, 607.2834055814137, 607.8328459673625, 608.1485919712394, 12021.699457513545, 12127.514899404014, 12154.696132596668, 12159.51361945521, 12161.391930403444, 11701.18091733579, 12394.62816115518, 12455.564055258114, 12739.299338536377, 12774.872251277462, 11459.828102578385, 11638.476268567934, 11676.1826672133, 11684.766304673858, 12130.757384852253, 4172.332426811726, 4182.91634167318, 4216.852410165629, 4392.275274579691, 4395.868123956255, 57131.42868571303, 57159.714201429146, 57162.14189290519, 57319.0, 57711.422885771026, 10353.119984801226, 10415.114715249138, 10502.527386267637, 10594.470276486145, 10881.347119172875, 18359.816401836077, 18379.172937217856, 18663.253469861054, 18673.719894201597, 18687.15907784153, 6539.182602174728, 6616.801495955129, 6688.86622267552, 6852.588844669336, 6923.238443771181, 3601.6938560222675, 3611.368010598135, 3647.252313275772, 3705.7035437164964, 3706.5552133743586, 2697.109953715269, 2794.9580756288674, 2795.273228960485, 2796.720327967187, 2799.5240809062507, 515.8220413957179, 545.4518209199808, 547.1710358806412, 553.9502642492535, 555.4001678187548, 554.0636324611394, 595.1400226672416, 598.9760409583567, 603.9818805435756, 616.6423474384846, 7793.18171591986, 8032.4778889372, 8042.879356809653, 8068.193180681885, 8104.878426823602, 584.7427132061879, 600.5765935015803, 609.2414943395501, 615.2555407956423, 615.7629312714637, 4045.7370270932297, 4050.675945924319, 4088.7342322748927, 4098.713090083726, 4198.8110535026, 100499.0, 100783.49608251912, 102898.48550757348, 105275.47362263293, 105860.0, 55730.442695573336, 63496.365036349045, 68164.0, 71658.0, 76261.0, 44818.77590612026, 56124.71937640367, 72054.0, 72669.90995135077, 72934.6353268241, 8472.237498625153, 8563.61463734121, 8760.91239087601, 8848.380613357003, 8983.505907175168, 31556.684433155373, 36994.63005369912, 37661.623383765815, 40465.59534404736, 45899.77050114862, 59219.0, 59371.70314148402, 59869.0, 60264.0, 61166.69416652888, 8989.370744047854, 10738.624148154777, 10802.459877006275, 11033.337999720043, 11239.213255072067, 9995.150412215044, 11047.171462140532, 11266.0, 12852.678683032998, 12992.0, 11268.943655281999, 12241.816372754594, 12297.323647199131, 12468.0, 13162.868371316164, 11518.560179977503, 11884.465199066235, 11958.820617690915, 12171.634850954486, 12525.49898004106, 11529.596464123715, 11628.941855291008, 11989.64031079069, 12288.877111228774, 12556.121071524905, 9316.232512785913, 9638.469884156439, 9671.226301895973, 9962.501874906371, 10146.898531014594, 10257.538410771383, 10319.226058045526, 10360.844587331045, 10366.844497332395, 10559.15526757873], "value": 6489.103905306942, "unit": "score"}], "name": "dromaeo_css", "value": 6252.845941998962, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 114.0, 115.0, 113.0, 114.0, 115.0, 113.0, 112.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 129.0, 140.0, 179.0, 139.0, 156.0, 156.0, 143.0, 196.0, 129.0], "value": 152.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 161.0, 164.0, 163.0, 163.0, 161.0, 163.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 119.0, 76.0, 77.0, 76.0, 75.0, 98.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 115.0, 87.0, 85.0, 86.0, 117.0, 85.0, 84.0, 130.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 116.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 65.0, 64.0, 63.0, 63.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 88.0, 85.0, 86.0, 85.0, 86.0, 120.0, 84.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 134.0, 131.0, 148.0, 132.0, 135.0, 144.0, 152.0, 152.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 173.0, 169.0, 173.0, 172.0, 176.0, 179.0, 169.0, 172.0, 171.0], "value": 173.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 67.0, 70.0, 72.0, 67.0, 68.0, 66.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1562.2, "alertThreshold": 2.0}]} 08:10:18 INFO - Return code: 0 08:10:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:10:18 ERROR - # TBPL SUCCESS # 08:10:18 INFO - Running post-action listener: _resource_record_post_action 08:10:18 INFO - ##### 08:10:18 INFO - ##### Finished run-tests step (success) 08:10:18 INFO - ##### 08:10:18 INFO - Running post-run listener: _resource_record_post_run 08:10:18 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 305987584; Read time: 4; Write time: 254908 08:10:18 INFO - TinderboxPrint: CPU usage
13.1% 08:10:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 08:10:18 INFO - TinderboxPrint: I/O write bytes / time
305,987,584 / 254,908 08:10:18 INFO - TinderboxPrint: CPU idle
8,333.4 (86.9%) 08:10:18 INFO - TinderboxPrint: CPU user
1,212.2 (12.6%) 08:10:18 INFO - TinderboxPrint: Swap in / out
0 / 0 08:10:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15175680; Read time: 0; Write time: 8660 08:10:18 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289927168; Read time: 4; Write time: 246016 08:10:19 INFO - Running post-run listener: _upload_blobber_files 08:10:19 INFO - Blob upload gear active. 08:10:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:10:19 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 08:10:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:10:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:10:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:10:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:10:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:20 INFO - (blobuploader) - INFO - Done attempting. 08:10:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:10:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:21 INFO - (blobuploader) - INFO - Done attempting. 08:10:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:10:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:10:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:25 INFO - (blobuploader) - INFO - Done attempting. 08:10:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:10:25 INFO - Return code: 0 08:10:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:10:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:10:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16ee84f0fe7c8bf418ee99d8e12531c78dabf088f10cee3c3bff61a05d0c832dd2ffa7800078ef263bd56fbf685db15881f1e9c6357691ac3e4ea96674f97bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b72ac82f951c58366b03d52cf2fe531cb10c7dd76b388ee73bf364767fedd4415222d84c96d2921301a192619a7748999d2ff97fb395b377c0d538b3c9e7eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8836da08c5f76a59d69373ec796ade64b9d947bd0fb5ce7fd1c3dff40864d6d67691a46fb256853caa3ba21c2b2a127427f9f25fc029fa09319de07ef202c1be"} 08:10:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:10:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:10:25 INFO - Contents: 08:10:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16ee84f0fe7c8bf418ee99d8e12531c78dabf088f10cee3c3bff61a05d0c832dd2ffa7800078ef263bd56fbf685db15881f1e9c6357691ac3e4ea96674f97bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b72ac82f951c58366b03d52cf2fe531cb10c7dd76b388ee73bf364767fedd4415222d84c96d2921301a192619a7748999d2ff97fb395b377c0d538b3c9e7eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8836da08c5f76a59d69373ec796ade64b9d947bd0fb5ce7fd1c3dff40864d6d67691a46fb256853caa3ba21c2b2a127427f9f25fc029fa09319de07ef202c1be"} 08:10:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:10:25 INFO - Copying logs to upload dir... 08:10:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:10:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1306.591406 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2016-06-09 08:10:25.599886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:10:25.603724) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16ee84f0fe7c8bf418ee99d8e12531c78dabf088f10cee3c3bff61a05d0c832dd2ffa7800078ef263bd56fbf685db15881f1e9c6357691ac3e4ea96674f97bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b72ac82f951c58366b03d52cf2fe531cb10c7dd76b388ee73bf364767fedd4415222d84c96d2921301a192619a7748999d2ff97fb395b377c0d538b3c9e7eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8836da08c5f76a59d69373ec796ade64b9d947bd0fb5ce7fd1c3dff40864d6d67691a46fb256853caa3ba21c2b2a127427f9f25fc029fa09319de07ef202c1be"} build_url:https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/cO0sp-xZRgWhFyoOqEduqw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/16ee84f0fe7c8bf418ee99d8e12531c78dabf088f10cee3c3bff61a05d0c832dd2ffa7800078ef263bd56fbf685db15881f1e9c6357691ac3e4ea96674f97bd2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b72ac82f951c58366b03d52cf2fe531cb10c7dd76b388ee73bf364767fedd4415222d84c96d2921301a192619a7748999d2ff97fb395b377c0d538b3c9e7eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8836da08c5f76a59d69373ec796ade64b9d947bd0fb5ce7fd1c3dff40864d6d67691a46fb256853caa3ba21c2b2a127427f9f25fc029fa09319de07ef202c1be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 08:10:25.628928) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:10:25.629269) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465483716.85004-1041100610 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 08:10:25.714195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:10:25.714586) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 08:10:25.714960) ========= ========= Total master_lag: 0.31 =========