builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1467040716.71 results: success (0) buildid: 20160627053006 builduid: a67037abe1d24321b35362d85663932b revision: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.714942) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.715390) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.715824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.745364) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.745673) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:18: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% 46.6M=0s 2016-06-27 08:18:37 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181486 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.940872) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.941209) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015145 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:36.991271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:18:36.991640) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 507d73e670e6b25171aa135d8cf809ff3f3bf8dd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 507d73e670e6b25171aa135d8cf809ff3f3bf8dd --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=a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:18:38,096 truncating revision to first 12 chars 2016-06-27 08:18:38,096 Setting DEBUG logging. 2016-06-27 08:18:38,096 attempt 1/10 2016-06-27 08:18:38,096 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/507d73e670e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:18:38,797 unpacking tar archive at: fx-team-507d73e670e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.042229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 08:18:38.047564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:38.047876) ========= script_repo_revision: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:38.048297) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:38.048573) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:18:38.057285) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-27 08:18:38.057558) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:39 INFO - MultiFileLogger online at 20160627 08:18:39 in /builds/slave/test 08:18:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:18:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:39 INFO - {'append_to_log': False, 08:18:39 INFO - 'base_work_dir': '/builds/slave/test', 08:18:39 INFO - 'blob_upload_branch': 'Fx-Team', 08:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:39 INFO - 'branch': 'Fx-Team', 08:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:39 INFO - 'config_files': ('talos/linux_config.py',), 08:18:39 INFO - 'default_actions': ('clobber', 08:18:39 INFO - 'read-buildbot-config', 08:18:39 INFO - 'download-and-extract', 08:18:39 INFO - 'populate-webroot', 08:18:39 INFO - 'create-virtualenv', 08:18:39 INFO - 'install', 08:18:39 INFO - 'run-tests'), 08:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:39 INFO - 'download_minidump_stackwalk': True, 08:18:39 INFO - 'download_symbols': 'ondemand', 08:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:39 INFO - 'installer_path': 'installer.exe', 08:18:39 INFO - 'log_level': 'info', 08:18:39 INFO - 'log_name': 'talos', 08:18:39 INFO - 'log_to_console': True, 08:18:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:39 INFO - 'opt_config_files': (), 08:18:39 INFO - 'pip_index': False, 08:18:39 INFO - 'sps_profile': False, 08:18:39 INFO - 'sps_profile_interval': 0, 08:18:39 INFO - 'suite': 'dromaeojs', 08:18:39 INFO - 'system_bits': '32', 08:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:39 INFO - 'title': 'talos-linux64-ix-002', 08:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:39 INFO - 'use_talos_json': True, 08:18:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:39 INFO - 'work_dir': 'build'} 08:18:39 INFO - ##### 08:18:39 INFO - ##### Running clobber step. 08:18:39 INFO - ##### 08:18:39 INFO - Running pre-action listener: _resource_record_pre_action 08:18:39 INFO - Running main action method: clobber 08:18:39 INFO - rmtree: /builds/slave/test/build 08:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:39 INFO - Running post-action listener: _resource_record_post_action 08:18:39 INFO - ##### 08:18:39 INFO - ##### Finished clobber step (success) 08:18:39 INFO - ##### 08:18:39 INFO - ##### 08:18:39 INFO - ##### Running read-buildbot-config step. 08:18:39 INFO - ##### 08:18:39 INFO - Running pre-action listener: _resource_record_pre_action 08:18:39 INFO - Running main action method: read_buildbot_config 08:18:39 INFO - Using buildbot properties: 08:18:39 INFO - { 08:18:39 INFO - "project": "", 08:18:39 INFO - "product": "firefox", 08:18:39 INFO - "script_repo_revision": "production", 08:18:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:18:39 INFO - "repository": "", 08:18:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:18:39 INFO - "buildid": "20160627053006", 08:18:39 INFO - "pgo_build": "True", 08:18:39 INFO - "basedir": "/builds/slave/test", 08:18:39 INFO - "buildnumber": 836, 08:18:39 INFO - "slavename": "talos-linux64-ix-002", 08:18:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:18:39 INFO - "platform": "ubuntu64_hw", 08:18:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:18:39 INFO - "branch": "fx-team", 08:18:39 INFO - "repo_path": "integration/fx-team", 08:18:39 INFO - "revision": "507d73e670e6b25171aa135d8cf809ff3f3bf8dd", 08:18:39 INFO - "stage_platform": "linux64-pgo", 08:18:39 INFO - "builduid": "a67037abe1d24321b35362d85663932b", 08:18:39 INFO - "slavebuilddir": "test" 08:18:39 INFO - } 08:18:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:18:39 INFO - Running post-action listener: _resource_record_post_action 08:18:39 INFO - ##### 08:18:39 INFO - ##### Finished read-buildbot-config step (success) 08:18:39 INFO - ##### 08:18:39 INFO - ##### 08:18:39 INFO - ##### Running download-and-extract step. 08:18:39 INFO - ##### 08:18:39 INFO - Running pre-action listener: _resource_record_pre_action 08:18:39 INFO - Running main action method: download_and_extract 08:18:39 INFO - mkdir: /builds/slave/test/build/tests 08:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:39 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:18:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:18:40 INFO - Downloaded 1361 bytes. 08:18:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:18:40 INFO - Using the following test package requirements: 08:18:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:18:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:18:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'jsshell-linux-x86_64.zip'], 08:18:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:18:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:18:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:18:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:18:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:18:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:18:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:18:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:18: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')]} 08:18:40 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:18:41 INFO - Downloaded 24279315 bytes. 08:18:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:18:43 INFO - Return code: 0 08:18: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 08:18: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')]} 08:18:43 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:18:53 INFO - Downloaded 24279315 bytes. 08:18:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:18:54 INFO - Return code: 0 08:18:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:54 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:18:56 INFO - Downloaded 14405240 bytes. 08:18:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:18:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:18:56 INFO - Return code: 0 08:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:18:56 INFO - https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:18:58 INFO - Downloaded 60190590 bytes. 08:18:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:18:58 INFO - mkdir: /builds/slave/test/properties 08:18:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:58 INFO - Contents: 08:18:58 INFO - build_url:https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:18:58 INFO - Running post-action listener: _resource_record_post_action 08:18:58 INFO - Running post-action listener: set_extra_try_arguments 08:18:58 INFO - ##### 08:18:58 INFO - ##### Finished download-and-extract step (success) 08:18:58 INFO - ##### 08:18:58 INFO - ##### 08:18:58 INFO - ##### Running populate-webroot step. 08:18:58 INFO - ##### 08:18:58 INFO - Running pre-action listener: _resource_record_pre_action 08:18:58 INFO - Running main action method: populate_webroot 08:18:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:58 INFO - '--tppagecycles', 08:18:58 INFO - '7'], 08:18:58 INFO - 'tests': ['tsvgm']}}, 08:18:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['damp', 'tps']}, 08:18:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'tests': ['damp', 'tps']}, 08:18:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['dromaeo_dom']}, 08:18:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['basic_compositor_video']}, 08:18:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:18:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['a11yr', 08:18:58 INFO - 'ts_paint', 08:18:58 INFO - 'tpaint', 08:18:58 INFO - 'sessionrestore', 08:18:58 INFO - 'sessionrestore_no_auto_restore', 08:18:58 INFO - 'tabpaint']}, 08:18:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tsvgx', 08:18:58 INFO - 'tsvgr_opacity', 08:18:58 INFO - 'tart', 08:18:58 INFO - 'tscrollx', 08:18:58 INFO - 'cart']}, 08:18:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:58 INFO - 'tsvgr_opacity', 08:18:58 INFO - 'tart', 08:18:58 INFO - 'tscrollx', 08:18:58 INFO - 'cart']}, 08:18:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s'], 08:18:58 INFO - 'tests': ['tp5o']}, 08:18:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'tests': ['tp5o']}, 08:18:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'talos_options': ['--disable-e10s', 08:18:58 INFO - '--xperf_path', 08:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:58 INFO - 'tests': ['tp5n']}, 08:18:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:18:58 INFO - 'talos_options': ['--xperf_path', 08:18:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:58 INFO - 'tests': ['tp5n']}}, 08:18:58 INFO - 'talos.zip': {'path': '', 08:18:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:58 INFO - Running post-action listener: _resource_record_post_action 08:18:58 INFO - ##### 08:18:58 INFO - ##### Finished populate-webroot step (success) 08:18:58 INFO - ##### 08:18:58 INFO - ##### 08:18:58 INFO - ##### Running create-virtualenv step. 08:18:58 INFO - ##### 08:18:58 INFO - Running pre-action listener: _resource_record_pre_action 08:18:58 INFO - Running main action method: create_virtualenv 08:18:58 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:18:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:58 INFO - Using real prefix '/usr' 08:18:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:01 INFO - Installing pip.................done. 08:19:01 INFO - Return code: 0 08:19:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:19:01 INFO - Using env: {'DISPLAY': ':0', 08:19:01 INFO - 'HOME': '/home/cltbld', 08:19:01 INFO - 'LANG': 'en_US.UTF-8', 08:19:01 INFO - 'LANGUAGE': 'en_US:en', 08:19:01 INFO - 'LOGNAME': 'cltbld', 08:19:01 INFO - 'MAIL': '/var/mail/cltbld', 08:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:01 INFO - 'MOZ_NO_REMOTE': '1', 08:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:01 INFO - 'NO_EM_RESTART': '1', 08:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:01 INFO - 'PWD': '/builds/slave/test', 08:19:01 INFO - 'SHELL': '/bin/bash', 08:19:01 INFO - 'SHLVL': '1', 08:19:01 INFO - 'TERM': 'linux', 08:19:01 INFO - 'TMOUT': '86400', 08:19:01 INFO - 'USER': 'cltbld', 08:19:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:01 INFO - '_': '/tools/buildbot/bin/python'} 08:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:19:01 INFO - Cleaning up... 08:19:01 INFO - Return code: 0 08:19:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:01 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:19:01 INFO - Using env: {'DISPLAY': ':0', 08:19:01 INFO - 'HOME': '/home/cltbld', 08:19:01 INFO - 'LANG': 'en_US.UTF-8', 08:19:01 INFO - 'LANGUAGE': 'en_US:en', 08:19:01 INFO - 'LOGNAME': 'cltbld', 08:19:01 INFO - 'MAIL': '/var/mail/cltbld', 08:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:01 INFO - 'MOZ_NO_REMOTE': '1', 08:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:01 INFO - 'NO_EM_RESTART': '1', 08:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:01 INFO - 'PWD': '/builds/slave/test', 08:19:01 INFO - 'SHELL': '/bin/bash', 08:19:01 INFO - 'SHLVL': '1', 08:19:01 INFO - 'TERM': 'linux', 08:19:01 INFO - 'TMOUT': '86400', 08:19:01 INFO - 'USER': 'cltbld', 08:19:01 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:01 INFO - '_': '/tools/buildbot/bin/python'} 08:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:01 INFO - Downloading/unpacking psutil>=3.1.1 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:03 INFO - Installing collected packages: psutil 08:19:03 INFO - Running setup.py install for psutil 08:19:03 INFO - building 'psutil._psutil_linux' extension 08:19:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:19:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:19:04 INFO - building 'psutil._psutil_posix' extension 08:19:04 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:19:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:19:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:04 INFO - Successfully installed psutil 08:19:04 INFO - Cleaning up... 08:19:04 INFO - Return code: 0 08:19:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:04 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:19:04 INFO - Using env: {'DISPLAY': ':0', 08:19:04 INFO - 'HOME': '/home/cltbld', 08:19:04 INFO - 'LANG': 'en_US.UTF-8', 08:19:04 INFO - 'LANGUAGE': 'en_US:en', 08:19:04 INFO - 'LOGNAME': 'cltbld', 08:19:04 INFO - 'MAIL': '/var/mail/cltbld', 08:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:04 INFO - 'MOZ_NO_REMOTE': '1', 08:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:04 INFO - 'NO_EM_RESTART': '1', 08:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:04 INFO - 'PWD': '/builds/slave/test', 08:19:04 INFO - 'SHELL': '/bin/bash', 08:19:04 INFO - 'SHLVL': '1', 08:19:04 INFO - 'TERM': 'linux', 08:19:04 INFO - 'TMOUT': '86400', 08:19:04 INFO - 'USER': 'cltbld', 08:19:04 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:04 INFO - '_': '/tools/buildbot/bin/python'} 08:19:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19: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 08:19:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:19:06 INFO - Installing collected packages: mozsystemmonitor 08:19:06 INFO - Running setup.py install for mozsystemmonitor 08:19:06 INFO - Successfully installed mozsystemmonitor 08:19:06 INFO - Cleaning up... 08:19:06 INFO - Return code: 0 08:19:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:06 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:19:06 INFO - Using env: {'DISPLAY': ':0', 08:19:06 INFO - 'HOME': '/home/cltbld', 08:19:06 INFO - 'LANG': 'en_US.UTF-8', 08:19:06 INFO - 'LANGUAGE': 'en_US:en', 08:19:06 INFO - 'LOGNAME': 'cltbld', 08:19:06 INFO - 'MAIL': '/var/mail/cltbld', 08:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:06 INFO - 'MOZ_NO_REMOTE': '1', 08:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:06 INFO - 'NO_EM_RESTART': '1', 08:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:06 INFO - 'PWD': '/builds/slave/test', 08:19:06 INFO - 'SHELL': '/bin/bash', 08:19:06 INFO - 'SHLVL': '1', 08:19:06 INFO - 'TERM': 'linux', 08:19:06 INFO - 'TMOUT': '86400', 08:19:06 INFO - 'USER': 'cltbld', 08:19:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:06 INFO - '_': '/tools/buildbot/bin/python'} 08:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:06 INFO - Downloading/unpacking jsonschema==2.5.1 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:19:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:19:09 INFO - warning: no files found matching '*.txt' 08:19:09 INFO - no previously-included directories found matching 'build' 08:19:09 INFO - no previously-included directories found matching 'dist' 08:19:09 INFO - no previously-included directories found matching '.git*' 08:19:09 INFO - Installing collected packages: jsonschema, functools32 08:19:09 INFO - Running setup.py install for functools32 08:19:09 INFO - warning: no files found matching '*.txt' 08:19:09 INFO - no previously-included directories found matching 'build' 08:19:09 INFO - no previously-included directories found matching 'dist' 08:19:09 INFO - no previously-included directories found matching '.git*' 08:19:09 INFO - Successfully installed jsonschema functools32 08:19:09 INFO - Cleaning up... 08:19:09 INFO - Return code: 0 08:19:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:09 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:19:09 INFO - Using env: {'DISPLAY': ':0', 08:19:09 INFO - 'HOME': '/home/cltbld', 08:19:09 INFO - 'LANG': 'en_US.UTF-8', 08:19:09 INFO - 'LANGUAGE': 'en_US:en', 08:19:09 INFO - 'LOGNAME': 'cltbld', 08:19:09 INFO - 'MAIL': '/var/mail/cltbld', 08:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:09 INFO - 'MOZ_NO_REMOTE': '1', 08:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:09 INFO - 'NO_EM_RESTART': '1', 08:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:09 INFO - 'PWD': '/builds/slave/test', 08:19:09 INFO - 'SHELL': '/bin/bash', 08:19:09 INFO - 'SHLVL': '1', 08:19:09 INFO - 'TERM': 'linux', 08:19:09 INFO - 'TMOUT': '86400', 08:19:09 INFO - 'USER': 'cltbld', 08:19:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:09 INFO - '_': '/tools/buildbot/bin/python'} 08:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:09 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:12 INFO - Downloading docopt-0.6.1.tar.gz 08:19:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:12 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:12 INFO - Running setup.py install for blobuploader 08:19:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:12 INFO - Running setup.py install for requests 08:19:12 INFO - Running setup.py install for docopt 08:19:12 INFO - Successfully installed blobuploader requests docopt 08:19:12 INFO - Cleaning up... 08:19:12 INFO - Return code: 0 08:19:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:12 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:12 INFO - Using env: {'DISPLAY': ':0', 08:19:12 INFO - 'HOME': '/home/cltbld', 08:19:12 INFO - 'LANG': 'en_US.UTF-8', 08:19:12 INFO - 'LANGUAGE': 'en_US:en', 08:19:12 INFO - 'LOGNAME': 'cltbld', 08:19:12 INFO - 'MAIL': '/var/mail/cltbld', 08:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:12 INFO - 'MOZ_NO_REMOTE': '1', 08:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:12 INFO - 'NO_EM_RESTART': '1', 08:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:12 INFO - 'PWD': '/builds/slave/test', 08:19:12 INFO - 'SHELL': '/bin/bash', 08:19:12 INFO - 'SHLVL': '1', 08:19:12 INFO - 'TERM': 'linux', 08:19:12 INFO - 'TMOUT': '86400', 08:19:12 INFO - 'USER': 'cltbld', 08:19:12 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:12 INFO - '_': '/tools/buildbot/bin/python'} 08:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:12 INFO - Running setup.py (path:/tmp/pip-t6eWtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:13 INFO - Running setup.py (path:/tmp/pip-E5B6f4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:13 INFO - Running setup.py (path:/tmp/pip-teRkxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:13 INFO - Running setup.py (path:/tmp/pip-BCPk_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:13 INFO - Running setup.py (path:/tmp/pip-75_mwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:13 INFO - Running setup.py (path:/tmp/pip-U25p6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:13 INFO - Running setup.py (path:/tmp/pip-XoD9Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:13 INFO - Running setup.py (path:/tmp/pip-GwFqPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:13 INFO - Running setup.py (path:/tmp/pip-WUbV0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:13 INFO - Running setup.py (path:/tmp/pip-S_KGSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:13 INFO - Running setup.py (path:/tmp/pip-8zQF6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:13 INFO - Running setup.py (path:/tmp/pip-I82jp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:13 INFO - Running setup.py (path:/tmp/pip-va7zxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:13 INFO - Running setup.py (path:/tmp/pip-If2c3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:13 INFO - Running setup.py (path:/tmp/pip-gEaDfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:14 INFO - Running setup.py (path:/tmp/pip-e9CvbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:14 INFO - Running setup.py (path:/tmp/pip-LsOJ6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:14 INFO - Running setup.py install for manifestparser 08:19:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozcrash 08:19:14 INFO - Running setup.py install for mozdebug 08:19:14 INFO - Running setup.py install for mozdevice 08:19:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozfile 08:19:14 INFO - Running setup.py install for mozhttpd 08:19:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozinfo 08:19:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozInstall 08:19:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:14 INFO - Running setup.py install for mozleak 08:19:15 INFO - Running setup.py install for mozlog 08:19:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for moznetwork 08:19:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozprocess 08:19:15 INFO - Running setup.py install for mozprofile 08:19:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozrunner 08:19:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Running setup.py install for mozscreenshot 08:19:15 INFO - Running setup.py install for moztest 08:19:15 INFO - Running setup.py install for mozversion 08:19:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:15 INFO - Cleaning up... 08:19:15 INFO - Return code: 0 08:19:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:15 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:19:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:15 INFO - Using env: {'DISPLAY': ':0', 08:19:15 INFO - 'HOME': '/home/cltbld', 08:19:15 INFO - 'LANG': 'en_US.UTF-8', 08:19:15 INFO - 'LANGUAGE': 'en_US:en', 08:19:15 INFO - 'LOGNAME': 'cltbld', 08:19:15 INFO - 'MAIL': '/var/mail/cltbld', 08:19:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:15 INFO - 'MOZ_NO_REMOTE': '1', 08:19:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:15 INFO - 'NO_EM_RESTART': '1', 08:19:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:15 INFO - 'PWD': '/builds/slave/test', 08:19:15 INFO - 'SHELL': '/bin/bash', 08:19:15 INFO - 'SHLVL': '1', 08:19:15 INFO - 'TERM': 'linux', 08:19:15 INFO - 'TMOUT': '86400', 08:19:15 INFO - 'USER': 'cltbld', 08:19:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:15 INFO - '_': '/tools/buildbot/bin/python'} 08:19:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:16 INFO - Running setup.py (path:/tmp/pip-XZFx1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:16 INFO - Running setup.py (path:/tmp/pip-fFh5r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:16 INFO - Running setup.py (path:/tmp/pip-fM8UJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:16 INFO - Running setup.py (path:/tmp/pip-GvC0JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:16 INFO - Running setup.py (path:/tmp/pip-qO61UG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:16 INFO - Running setup.py (path:/tmp/pip-WxD6pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:16 INFO - Running setup.py (path:/tmp/pip-V3mE0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:16 INFO - Running setup.py (path:/tmp/pip-hTJB1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:16 INFO - Running setup.py (path:/tmp/pip-iHeCKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:16 INFO - Running setup.py (path:/tmp/pip-dRLSXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:16 INFO - Running setup.py (path:/tmp/pip-jSQHEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:16 INFO - Running setup.py (path:/tmp/pip-rR9lAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:17 INFO - Running setup.py (path:/tmp/pip-mKZD6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:17 INFO - Running setup.py (path:/tmp/pip-yBdqEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:17 INFO - Running setup.py (path:/tmp/pip-w76_ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:17 INFO - Running setup.py (path:/tmp/pip-KRT3CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:19:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:17 INFO - Running setup.py (path:/tmp/pip-Dma4g5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:19:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:20 INFO - Downloading blessings-1.6.tar.gz 08:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:20 INFO - Installing collected packages: blessings 08:19:20 INFO - Running setup.py install for blessings 08:19:20 INFO - Successfully installed blessings 08:19:20 INFO - Cleaning up... 08:19:20 INFO - Return code: 0 08:19:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:20 INFO - Reading from file tmpfile_stdout 08:19:20 INFO - Current package versions: 08:19:20 INFO - argparse == 1.2.1 08:19:20 INFO - blessings == 1.6 08:19:20 INFO - blobuploader == 1.2.4 08:19:20 INFO - docopt == 0.6.1 08:19:20 INFO - functools32 == 3.2.3-2 08:19:20 INFO - jsonschema == 2.5.1 08:19:20 INFO - manifestparser == 1.1 08:19:20 INFO - mozInstall == 1.12 08:19:20 INFO - mozcrash == 0.17 08:19:20 INFO - mozdebug == 0.1 08:19:20 INFO - mozdevice == 0.48 08:19:20 INFO - mozfile == 1.2 08:19:20 INFO - mozhttpd == 0.7 08:19:20 INFO - mozinfo == 0.9 08:19:20 INFO - mozleak == 0.1 08:19:20 INFO - mozlog == 3.2 08:19:20 INFO - moznetwork == 0.27 08:19:20 INFO - mozprocess == 0.22 08:19:20 INFO - mozprofile == 0.28 08:19:20 INFO - mozrunner == 6.11 08:19:20 INFO - mozscreenshot == 0.1 08:19:20 INFO - mozsystemmonitor == 0.3 08:19:20 INFO - moztest == 0.7 08:19:20 INFO - mozversion == 1.4 08:19:20 INFO - psutil == 3.1.1 08:19:20 INFO - requests == 1.2.3 08:19:20 INFO - wsgiref == 0.1.2 08:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:19:20 INFO - Using env: {'DISPLAY': ':0', 08:19:20 INFO - 'HOME': '/home/cltbld', 08:19:20 INFO - 'LANG': 'en_US.UTF-8', 08:19:20 INFO - 'LANGUAGE': 'en_US:en', 08:19:20 INFO - 'LOGNAME': 'cltbld', 08:19:20 INFO - 'MAIL': '/var/mail/cltbld', 08:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:20 INFO - 'MOZ_NO_REMOTE': '1', 08:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:20 INFO - 'NO_EM_RESTART': '1', 08:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:20 INFO - 'PWD': '/builds/slave/test', 08:19:20 INFO - 'SHELL': '/bin/bash', 08:19:20 INFO - 'SHLVL': '1', 08:19:20 INFO - 'TERM': 'linux', 08:19:20 INFO - 'TMOUT': '86400', 08:19:20 INFO - 'USER': 'cltbld', 08:19:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:20 INFO - '_': '/tools/buildbot/bin/python'} 08:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:19:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:19:20 INFO - Cleaning up... 08:19:20 INFO - Return code: 0 08:19:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:20 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:19:20 INFO - Using env: {'DISPLAY': ':0', 08:19:20 INFO - 'HOME': '/home/cltbld', 08:19:20 INFO - 'LANG': 'en_US.UTF-8', 08:19:20 INFO - 'LANGUAGE': 'en_US:en', 08:19:20 INFO - 'LOGNAME': 'cltbld', 08:19:20 INFO - 'MAIL': '/var/mail/cltbld', 08:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:20 INFO - 'MOZ_NO_REMOTE': '1', 08:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:20 INFO - 'NO_EM_RESTART': '1', 08:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:20 INFO - 'PWD': '/builds/slave/test', 08:19:20 INFO - 'SHELL': '/bin/bash', 08:19:20 INFO - 'SHLVL': '1', 08:19:20 INFO - 'TERM': 'linux', 08:19:20 INFO - 'TMOUT': '86400', 08:19:20 INFO - 'USER': 'cltbld', 08:19:20 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:20 INFO - '_': '/tools/buildbot/bin/python'} 08:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:19:21 INFO - Cleaning up... 08:19:21 INFO - Return code: 0 08:19:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:21 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 0x7fd2f9cd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e2480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:19:21 INFO - Using env: {'DISPLAY': ':0', 08:19:21 INFO - 'HOME': '/home/cltbld', 08:19:21 INFO - 'LANG': 'en_US.UTF-8', 08:19:21 INFO - 'LANGUAGE': 'en_US:en', 08:19:21 INFO - 'LOGNAME': 'cltbld', 08:19:21 INFO - 'MAIL': '/var/mail/cltbld', 08:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:21 INFO - 'MOZ_NO_REMOTE': '1', 08:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:21 INFO - 'NO_EM_RESTART': '1', 08:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:21 INFO - 'PWD': '/builds/slave/test', 08:19:21 INFO - 'SHELL': '/bin/bash', 08:19:21 INFO - 'SHLVL': '1', 08:19:21 INFO - 'TERM': 'linux', 08:19:21 INFO - 'TMOUT': '86400', 08:19:21 INFO - 'USER': 'cltbld', 08:19:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:21 INFO - '_': '/tools/buildbot/bin/python'} 08:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:21 INFO - Downloading/unpacking flake8 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:19:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:19:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:24 INFO - no previously-included directories found matching 'docs/_build' 08:19:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:19:24 INFO - Running setup.py install for pep8 08:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:19:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:19:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:19:24 INFO - no previously-included directories found matching 'docs/_build' 08:19:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:19:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:19:24 INFO - Cleaning up... 08:19:24 INFO - Return code: 0 08:19:24 INFO - Running post-action listener: _resource_record_post_action 08:19:24 INFO - Running post-action listener: _start_resource_monitoring 08:19:24 INFO - Starting resource monitoring. 08:19:24 INFO - ##### 08:19:24 INFO - ##### Finished create-virtualenv step (success) 08:19:24 INFO - ##### 08:19:24 INFO - ##### 08:19:24 INFO - ##### Running install step. 08:19:24 INFO - ##### 08:19:24 INFO - Running pre-action listener: _resource_record_pre_action 08:19:24 INFO - Running main action method: install 08:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:24 INFO - Reading from file tmpfile_stdout 08:19:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:24 INFO - Reading from file tmpfile_stdout 08:19:24 INFO - Output received: 08:19:24 INFO - Usage: mozinstall [options] installer 08:19:24 INFO - Options: 08:19:24 INFO - -h, --help show this help message and exit 08:19:24 INFO - -d DEST, --destination=DEST 08:19:24 INFO - Directory to install application into. [default: 08:19:24 INFO - "/builds/slave/test"] 08:19:24 INFO - --app=APP Application being installed. [default: firefox] 08:19:24 INFO - mkdir: /builds/slave/test/build/application 08:19:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:19:41 INFO - Reading from file tmpfile_stdout 08:19:41 INFO - Output received: 08:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:41 INFO - Running post-action listener: _resource_record_post_action 08:19:41 INFO - ##### 08:19:41 INFO - ##### Finished install step (success) 08:19:41 INFO - ##### 08:19:41 INFO - ##### 08:19:41 INFO - ##### Running run-tests step. 08:19:41 INFO - ##### 08:19:41 INFO - Running pre-action listener: _resource_record_pre_action 08:19:41 INFO - Running main action method: run_tests 08:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:41 INFO - Python 2.7.3 08:19:41 INFO - Return code: 0 08:19:41 INFO - grabbing minidump binary from tooltool 08:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:41 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 0x28716f0>, '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 0x28725f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2872aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:19:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:19:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:19:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:41 INFO - Return code: 0 08:19:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:19:42 INFO - Return code: 0 08:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:19:42 INFO - Using env: {'DISPLAY': ':0', 08:19:42 INFO - 'HOME': '/home/cltbld', 08:19:42 INFO - 'LANG': 'en_US.UTF-8', 08:19:42 INFO - 'LANGUAGE': 'en_US:en', 08:19:42 INFO - 'LOGNAME': 'cltbld', 08:19:42 INFO - 'MAIL': '/var/mail/cltbld', 08:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:42 INFO - 'MOZ_NO_REMOTE': '1', 08:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:42 INFO - 'NO_EM_RESTART': '1', 08:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:42 INFO - 'PWD': '/builds/slave/test', 08:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:42 INFO - 'SHELL': '/bin/bash', 08:19:42 INFO - 'SHLVL': '1', 08:19:42 INFO - 'TERM': 'linux', 08:19:42 INFO - 'TMOUT': '86400', 08:19:42 INFO - 'USER': 'cltbld', 08:19:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208', 08:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:42 INFO - '_': '/tools/buildbot/bin/python'} 08:19:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:19:42 INFO - mozversion application_buildid: 20160627053006 08:19:42 INFO - mozversion application_changeset: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd 08:19:42 INFO - mozversion application_display_name: Nightly 08:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:42 INFO - mozversion application_name: Firefox 08:19:42 INFO - mozversion application_remotingname: firefox 08:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:19:42 INFO - mozversion application_vendor: Mozilla 08:19:42 INFO - mozversion application_version: 50.0a1 08:19:42 INFO - mozversion platform_buildid: 20160627053006 08:19:42 INFO - mozversion platform_changeset: 507d73e670e6b25171aa135d8cf809ff3f3bf8dd 08:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:19:42 INFO - mozversion platform_version: 50.0a1 08:19:42 INFO - using testdate: 1467040782 08:19:42 INFO - actual date: 1467040782 08:19:42 INFO - starting webserver on 'localhost:37919' 08:19:42 INFO - SUITE-START | Running 2 tests 08:19:42 INFO - TEST-START | dromaeo_css 08:19:42 INFO - operating with platform_type : linux_ 08:19:42 INFO - Initialising browser for dromaeo_css test... 08:19:42 INFO - TEST-INFO | started process 21512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoNwwLi/profile http://localhost:37919/getInfo.html) 08:19:47 INFO - PROCESS | 21512 | __metrics Screen width/height:1600/1200 08:19:47 INFO - PROCESS | 21512 | colorDepth:24 08:19:47 INFO - PROCESS | 21512 | Browser inner width/height: 1024/697 08:19:47 INFO - PROCESS | 21512 | __metrics 08:19:48 INFO - PROCESS | 21512 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:49 INFO - TEST-INFO | 21512: exit 0 08:19:49 INFO - Browser initialized. 08:19:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:49 INFO - TEST-INFO | started process 21598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoNwwLi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:20:01 INFO - PROCESS | 21598 | RSS: Main: 173834240 08:20:01 INFO - PROCESS | 21598 | 08:20:52 INFO - PROCESS | 21598 | 1467040852029 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:23:01 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:37919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37919/tests/dromaeo/cssquery-ext.html) 08:23:02 INFO - PROCESS | 21598 | RSS: Main: 309481472 08:23:02 INFO - PROCESS | 21598 | 08:26:05 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:37919/tests/dromaeo/cssquery-ext.html (next: http://localhost:37919/tests/dromaeo/cssquery-jquery.html) 08:26:05 INFO - PROCESS | 21598 | RSS: Main: 258367488 08:26:05 INFO - PROCESS | 21598 | 08:29:07 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:37919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37919/tests/dromaeo/cssquery-mootools.html) 08:29:08 INFO - PROCESS | 21598 | RSS: Main: 266207232 08:29:08 INFO - PROCESS | 21598 | 08:32:10 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:37919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37919/tests/dromaeo/cssquery-prototype.html) 08:32:10 INFO - PROCESS | 21598 | RSS: Main: 256536576 08:32:10 INFO - PROCESS | 21598 | 08:35:13 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:37919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37919/tests/dromaeo/cssquery-yui.html) 08:35:14 INFO - PROCESS | 21598 | RSS: Main: 243646464 08:35:14 INFO - PROCESS | 21598 | 08:38:16 INFO - PROCESS | 21598 | Cycle 1(1): loaded http://localhost:37919/tests/dromaeo/cssquery-yui.html (next: http://localhost:37919/tests/dromaeo/cssquery-dojo.html) 08:38:17 INFO - PROCESS | 21598 | RSS: Main: 275156992 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | __start_tp_report 08:38:17 INFO - PROCESS | 21598 | _x_x_mozilla_page_load 08:38:17 INFO - PROCESS | 21598 | _x_x_mozilla_page_load_details 08:38:17 INFO - PROCESS | 21598 | |i|pagename|runs| 08:38:17 INFO - PROCESS | 21598 | |0;dojo.html;3120.938880780535;3146.229173852405;3157.3369592385625;3165.35110302388;3208.1017315151753;5256.684598924067;5285;5470.507654311116;5552.083906155484;5568.025595520783;5395.0558652235895;5421.539169170625;5464.644798088121;5494.532964697995;5494.697791621459;4901.362822833027;4966.5778408835295;4987.700737955716;4999.625028122887;5152.819651312205;5038.7984480620735;5042.319286896259;5085.949140508603;5100.081985242655;5107.591392688576;4787;4822.324874517552;4858;4864.562189402971;4921.18800397934;4930.679505832145;4932.728699921503;4942.827001054946;5011.724355160465;5020.698758074491;4961.727105009223;4985.925211121836;5006.299118123466;5019.5231453012275;5044.419891712427;5265.789368425297;5401.297831281948;5454.53636440903;5502.724863756836;5502.9174562381595;5849.736761845727;5883.294004719461;5899.115132730082;5902.966980778389;5919.91120133194;5895.793647222326;5928.940710592925;5936.376680448534;5941.168236446901;5957.463828255478;5284.365876094855;5404.675719456806;5458.754356053947;5461.863453413617;5533.750981205855;6024.578279520391;6031.24609423822;6031.819045428644;6031.9698401508585;6034.456898879122;5812.854678633068;5821.708914554255;5822.417758224228;5823.272090988627;5823.941760582425;5610.074337734228;5692.686902220335;5768.480836724715;5773.162891380726;5807.448292412214;5756.30924289088;5800.303963524404;5801.984652685763;5802.941970580325;5811.9709401453565;5557.277553917965;5786.71066446676;5799.3620701722775;5805.622634528742;5806.970965145148;4344.847930322424;4356.825726970949;4387.100644367961;4390.758508282075;4443.178012067778;3921.0785465415606;3933.0757272041046;3936.0553467167674;3966.2464131814863;3967.861124860674;5413.377461591888;5416.91874621881;5420.512153906167;5420.756065977041;5424.294841670637;5677.602567820213;5764.510016648632;5800.6809625471005;5808.099744539603;5824.184614154022;5375.3280839895015;5447.509724124848;5455.1271796512365;5456.645318054393;5459.563234941195;4775.689580177277;4895.877603059952;4899.828506002273;4913;4955.4301255356095;6021.6989150542295;6054.485368743618;6073.787417440457;6094.8171554853425;6110.969445152835;5917.1715959766525;5919.733611987557;5924.8815023700145;5926.881462370815;5927.9703601481715;5740.971295143665;5859.707014649165;6078.878422431439;6095.05526643371;6101.60339577926;5709.628874123168;5787.94212057874;5805.477507024388;5806;5849.239598852292;5811.27359080115;5826.155207494805;5865.14955331466;5884.205632239764;5886.94113058864;5543.36251331086;5680.715964201856;5752.13717942312;5752.597318187687;5761.164631128547;5735.684537350486;5736.512396446182;5737.139429085671;5743.396943320891;5775.566832487496;5607.158926161109;5609.523190528687;5616.8876622466505;5618.325800903917;5622.5501959842295;5483.2049352844415;5491.807786727445;5697.344805347272;5741.052726300114;5797.043487824461;5409.810656626999;5547;5569.832905012856;5614.85962850932;5618.85952851182 08:38:17 INFO - PROCESS | 21598 | |1;ext.html;575.2177039226651;613.3712944232161;613.9140520327152;631.7094136697119;631.8894193516134;42258.577414225845;43666.56333436665;44486.33270500945;44546.55453445465;44563.55436445639;44633.55366446335;45237.32144017842;45274.320885186746;45297.54702452975;45298.320525192146;8329.541875196892;8905.421147625417;9121.680741174061;10863.891361086407;11105.167112466557;10569.841452378221;10948.45257737114;10954.726131846728;10956;10965.50655220517;11013.229073964785;11059.72350691235;11085.168612354066;11085.334879907232;11091.057260132899;10870.61952831651;10951.507182176822;11000.669979900616;11006.614768483145;11010;10910.945445272722;10984.395858227794;10985.505652245669;10997.450127493674;10998.285111467729;43650.563494364964;44001.339979900324;44031.339529906756;44045.55954440479;44059.33910991338;3785.9053523661855;4214.220369231702;4306.4832220133785;4320.697551171419;4362;33668.83165584181;33926.49110263348;34254.82872585646;34653;34805.82597087024;4329.350597410382;4357.193919124972;4364.192624364503;4375.291305943139;4392.626626736731;386110;388425;388876.05561972293;389471;389798;65934;66024;66517;66614.66692666506;66698.33301667018;69063;69416.30583694199;69431.65284173547;69515.65242173757;69517.65241173762;16955.15224238783;17354.913225433793;17381.304747810198;17394.826051739572;17395.130243487776;13976.231307278198;14000;14002.789958150635;14016.929915350358;14054.297285135703;20102.296419625243;20145;20312.79687203109;20442.773433594033;20493.692594611093;7272.527340704186;7292.708291668274;7299.613073516015;7412.592307423036;7507.436942229355;922.4280945813505;1002.6390499420203;1007.9970429422772;1019.4444028004755;1061.2093989977361;32390;32728.836355818545;32808;33095.66904330974;33669.98990030303;980.1766516126346;1077.9299345542515;1109.8168802147716;1161.7386088130272;1179.9823002654966;16591.502254932373;16890.91554542244;16954.15229238533;16966.915165424092;17237.655246895243;555268;555683;557392;558643;558969;60486.39513604896;60879.695601522595;60897;60942.69528652328;60979;1214.5445457953267;1330.301591664384;1346.6633341664583;1370.6847425092485;1382.1776043254247;32668.183295417806;33706.49440258349;33787.66212337845;34159.31681366309;34398.14004649904;50658;51533;51596.22605660843;51602.48397515977;51668.48331516637;449276;459744;460648;460990;461241;28630.284242894093;37634.43548346832;42694.57305426906;43521;44367.334489983325;45493.31760023536;45982.77008614936;49264.50735492599;49667.25499117588;49833.50166498288;41720.28818126812;42775;43427;43755.56244437515;43987.34018989654;41520;41662.16675666409;42331.576684232765;42861.785691071345;42979.57020429755;41703.58296417118;42027.7898610505;42231.78884105683;42307.3653895198;42565;36400.63599363973;37213.81393093017;37339.39681667146;37390.25219495541;37584.624153758115;27987.300317492227;28216.85891570611;28387.290317741397;28526.42947141087;28975.42049159047 08:38:17 INFO - PROCESS | 21598 | |2;jquery.html;371.69335298378826;380.08589342630967;384.84990853567103;395.63403851437397;412.31349802578706;17809.910950445246;19253.903730481365;19599.216031358745;19604.117814698337;19617.313394031193;18423.07884605771;18672.719909201373;18678.346257880978;19256.711149332772;19951.900240498813;5648.350439699446;5690.743916523756;5909.497692696126;5950.7917222896995;5951.9107213391835;5778.075507918734;5869.941300587004;5885.352611212763;5902.97048514759;5906.763729450817;5595.4124816894255;5842.970785146068;5852.297724273093;5854.121881717755;5864.149698293745;5793;5817.127430885359;5820.039693450597;5824.388439213864;5865.824025279248;4951.653384263103;5203;5251.028559716465;5277.182036784305;5328.706921119337;14189.645258868612;14266.785998210034;14335.426582936774;22501.887490562607;23704.64443033356;2421.5641184586766;2475.356407334088;2494.064725727852;2600.557905156128;3007.443622929765;9488.762780930532;9779.657711980046;10748.623798167027;10849.620263290826;10990.945045274722;1950.697641865513;1954.7263383126374;2048.09883651193;2049.579836133589;2100.2544096845554;62138.68930655318;65295.020574691895;65392.67303663499;81752.59123704344;84832;8531;9971.152452041657;10259.7435064124;10264.281500295057;10348.586056557653;13835.446582136601;13912.860871391358;14208.857911420753;14985.775213371808;15023.924880375529;8425.957870210732;8429;8436;8465.915340846514;8570.057293697688;7681.961590192013;7964.522128672298;8012.79968000793;8158.510489370657;8323.334133269324;4211.620954114144;4282.314829627245;4285;4521.0279789845345;4797.328374027639;1938.7867334593184;1959.8637485141264;1964.4990527415703;1965.3809050149157;1993.1130646862007;879.3009557401881;967.7000129959735;980.3676628574672;1002.2983911262146;1011.4942528735633;19699.704504432444;19800.70298945517;19998.50003749889;20246.291379801638;20551.177952882015;1001.3891526169031;1007.3099926550336;1014.802113587858;1018.5467466977273;1093.1582681335485;10592;11170.944145279222;11239.438028098562;11341.092712582973;11343.20597558163;480836;485753;487980;492296.69258268113;493027;89436;92412;92965.53517232371;93172;94684;1004.1414590525142;1012.71643939697;1015.7816069545083;1034.363866222268;1039.2517387481003;17501.912490437466;17661.82338176602;17676.381326653507;17815.287388504832;18031;31978.84010579932;38959.61040389673;40665.59334406618;40919.59080409277;42344.57655423407;58616.70691646515;58876.11685824802;59040.40959590521;59341.40658593359;59414;8568.228859402683;8778;8825.293976481995;8892.822143557221;8973.461592304482;9855.753606159904;13623.523176688768;13692.589222323346;14136.43454261818;14318.713625727636;12021.75956480848;12228.44971976281;12435.44040518197;12442.440090196144;12799.360031998176;12043.638690839289;12145.089118315986;12178.45196966121;12340.938295308824;12582.87417125817;9547.47240441526;11945.343006134746;12670.239785612892;12804.61586152417;13043.869561304646;8693;8718.520481373585;8883.955580222317;8897.021327653823;8928.776780580538;9282.489463079595;11522.596709115141;12254.4485498151;12287.385630718607;12551.937240314106 08:38:17 INFO - PROCESS | 21598 | |3;mootools.html;1313.7700902342099;1465.978010329845;1488.8808895288378;1626.9511914642558;1772.592303770132;8327.87508187377;8727.650893964243;8746.212840844331;8975.281977441806;8975.41659792113;8706.303495720344;8895.599698013588;8899;8906.91093089069;8914.465132092062;1931.9903400482979;2096.9895150524226;2157.0401171478698;2245.124401483423;2274.0676322707695;2290.2900100968754;2300.25241796416;2301.6777651128855;2302.067662596651;2303.608386574278;2209.845310828243;2233.6314508106225;2254.830887683422;2258.6386178211487;2259.67234750961;1915.3104882242383;2159.622066138435;2183.11583808557;2223.3107736601705;2223.788740069691;2267.4444761033487;2283.1095872609694;2288.19913030438;2288.5766133265397;2289.3933107726466;9033.864492032624;9070.591823367899;9086.227670647937;9100.36297459178;9110.5444727764;5111.693298402108;5238.349919775259;5246.344206974129;5246.501582349709;5247.790088396459;3304.4217261979056;3377.090468980458;3383.086566626997;3521.0845180253064;3525.0834782956617;1103.3049179017248;1107.3577325151473;1121.4616983847718;1137.5108703257597;1162.96511104667;12523.436445359981;12640.810387844189;12696.936515317457;12771.106022578424;12772.48910043597;4545.113702827917;4627.190241707688;4692.319613656001;4722.173619616553;4727.57451829337;10401.479926003669;10411.323263987817;10413;10427.374357538572;10469.895301047045;5273.707941554344;5286.969041036961;5304.124819404755;5305.257263983045;5311.070562651597;4105.97947010263;4698.530146985342;4845.370101886732;4849.102915960488;4904.386951631046;3892.5523564789846;3983.083890705154;3992.2215168041953;4034.7377420467574;4088.9182216356103;1279.2388528825334;1299.2918859221747;1312.6324629103867;1324.0466863858007;1325.5691900132304;926.2080920812742;936.5410948635256;941.1388579449726;942.3733217410482;969.6751588218026;5703.54371650267;5750.769969201268;5824.155497452845;6013.54898382623;6033.5474839387225;445.34089547469927;469.2164085976428;996.14829320931;1057.5241141486363;1104.116706634705;4115.8765237042935;4169.583041695806;4203.390508376268;4229.830806767756;4251.489821221473;11129.666110016713;11206.103511719042;11300.660980170607;11368.090552755759;11479.942600286946;11166.441677916071;11263.831042534368;11264.493097810619;11275.323480591027;11299.039581635652;8228.711995080144;8246.670133194724;8426.873596896052;8429.957850210832;8441.36689748259;5819.185314055951;5911.349751527243;6026.15633811258;6045.78839740607;6082.2093127893095;10092.343997640424;10423.583056677951;10429;10434.269601127848;10445.321054131457;10426.68719938403;10552.525136368728;10731.302465339728;10741.838872416763;10741.892581074402;6870.484713646397;7063.081799366049;7067.222605513492;7648.73229436967;7797.493162944391;7712.190220026816;8416;8476.533790641573;8735.519546425008;8741.300695944183;7499.88750168737;7764.145943946049;7801.336886364723;7810.609469526615;7858.960705196438;7752.14726380109;7801.609919504115;7835.5690437026515;7839.490433121829;7893.921060789548;6706.396424321834;6769.526133170631;6811.318868113149;6870.62211578348;6876.381125698511;5065;5230.215467679878;5340.252364669027;5377.139657654913;5392.110301800159;4961.925571116509;5120.667156634807;5132.230165475208;5157.329547158845;5323.787048518016 08:38:17 INFO - PROCESS | 21598 | |4;prototype.html;302.61870043744887;310.6443122624595;317.84425631440587;318.47928636679023;320.09253765574596;5078.542931136197;5264.341957255343;5426.945730542693;5440.58544778358;5464.644798088127;5397.028534863723;5418.7019713915815;5419.512243898049;5425.13197888338;5430.809921652743;4192.308269135589;4205.285101532739;4230.323148296257;4241.257779888522;4275.337322714969;3997.640802127276;4103.4870641169855;4209.5477060414105;4246.683528106297;4254.723442976197;4092.754434733911;4114.773687447189;4131.628153466202;4183.895402614944;4189.72766770159;4110.095778928631;4137.2552940470705;4138.275801734684;4144.357624568197;4196.076863090116;3581.426971684518;3656.4880916671686;3701.241245544684;3707.9814600927093;3713.4801127842125;5204.4014938281825;5204.713740744258;5209;5216.478352164753;5224.190250511177;4708.882277943045;4725.291206319045;4742.786574604151;4765.69023013503;4773.260144677581;5310.336207974004;5546.77812887484;5591.043134902751;5644.266245388073;5652.745626446778;3931.9383766383203;3934.1344904121047;3994.08136128692;3994.500687414073;4010.318245898204;5569.805056822992;5589.385167631557;5847;5880.97059514704;5892.882142357172;3986.8072560092414;3996.7402118862183;3999.7600143991453;4002.579729128458;4008.178323443687;4010.839566417311;4047.615476529725;4049.5950404959267;4059.1475790084414;4059.959400405958;4579.17574836526;4677.321788340671;4685.906281874343;4687.078297897846;4713.31656909753;5609.915851262234;5636.943630563642;5647.011772939802;5661.858453538612;5665.433456654301;1385.5358454917514;1405.4729476446332;1413.1168019987508;1415.1509094543192;1417.2701058954647;843.9662413503391;886.1183122792862;893.2452077994085;911.4850109688005;911.7128104647015;4801.591864691471;4812.075169931985;4844.660873738804;4876.561109500162;4882.9755851221225;5092.694438333712;5111;5144.794208231704;5147.510986456281;5220.92168617471;4628.4445866496235;4801.855944321676;4810.783514741775;4815.975920120447;4841.975790121027;2707.485577740223;2712.633794437765;2733.289344770334;2760.371380885247;2763.322985868475;5296.549793267615;5303.859670170932;5353.973230133903;5366.248725178478;5395.919061214085;4818.7831547580445;5229.581633469314;5237.397699264558;5273.288106105703;5301.893962120736;5218.530332270114;5227.7714737036;5280.577553795687;5285.312909321764;5294.152935530374;5085.46602606721;5103.693778373309;5107.829172601704;5110.591152707849;5186.8962620748125;5074.797008119782;5296.285001524745;5854.414558544282;5856.970715146397;5864.853378665567;5806.274215723035;5946.881062378815;5969.910451343147;5970.910436343545;6093.817185484442;3946.861859834892;3992.7205095643026;4039.091204478969;4067.389891516178;4073.4093556434746;5681.857953551194;5796.971015145066;5832.270966129234;5837.3870743571315;5841.853953651193;5651.378348381592;5668.376478587435;5670.18554062696;5679.403662615366;5689.26039614864;5588.6646801192055;5624.915626265528;5642.943570564242;5677.608985798506;5688.971555142198;5440.510354068153;5512.641678290898;5512.862178445571;5555.444455554574;5580.35825880029;5654.3497497788285;5673.659580425187;5682.6306290091015;5683.204351390891;5686.4646545433325;5553.916691249715;5561.610687251854;5565.638233514808;5571.804986825604;5589.636673616202 08:38:17 INFO - PROCESS | 21598 | |5;yui.html;689.5345641691858;706.9116360454943;796.9641366138524;797.740734261365;833.5582141465026;14773.630659233524;15711.685766284667;15712.921435392822;15729.213539323046;15729.60675983101;15304.770428443582;15913.44302949397;15916;16406.425775097872;16456.259468323926;657.7796438193187;763.3969164360149;798.6805277888848;798.7244400681756;805.879118132279;778.8403377307667;786.905571331441;787.1616728184493;787.6061969015492;787.7085478372982;828.0684230240979;834.9499030058216;836.1972506393869;836.5900708652747;836.6193382011201;694.4964900447161;804.1998211779259;829.2909562324246;831.7380025292044;832.4214670803793;606.19981624256;610.036142894226;610.081826850587;610.112286622967;610.914471973924;12632.49470021198;12652.92450141739;12688.36558172097;12696.111272210948;12696.365181740968;13524.25616591087;14057.226852523107;14067;14260.500882469063;14336.42654293827;13217.339133043406;13498.325083745773;13562.660933476644;13589.52436664712;13624.727505449835;4365.934510982338;4403.889902752425;4425.977870110661;4496.662750293741;4632.7220366777765;75778.62110689412;75781;75885;75997;78638.60680696674;10373.18342204419;10623.150147988143;10641.840372394421;10779.461026948622;10883.67348979532;17865.910670446563;17926.641467170582;17929.551761206076;17934.19296131677;17937.730934036;7573.886391704129;7613.08642962848;7621.69513219465;7672.80817979555;7777.57223352721;4571.1543364477675;4736.5500277474275;4743.359646447685;4788.832390866303;4816.084943860656;3293.275479394529;3393.983030084834;3408.079818449005;3413.385590593717;3414.965850341465;579.244086467156;580.7096451774113;616.1927874484439;653.6862306093102;655.5574986883929;558.3969313141797;634.5906890055888;677.1975209376905;722.4437183368776;754.6340025087828;8971.685990990283;9129.863052054225;9399.57701903416;9515.57179926905;9610.471424071744;569.7920854489541;575.6287194759441;591.6538824787461;653.8234676637281;685.1093578348127;4065.79671016448;4231.534531201627;4260.44614200152;4287.185434767384;4356.324769660708;111163;115472;118064;123130.38434807947;123769;85202.57398712967;100646.4967675157;101978.49010754899;102056;104010;77114.61442692863;78124.60937695275;78889;87958;89926;8795.956020219857;9408.388454750419;9411.670591529264;9417.764555886157;9475.952620236854;44628.55371446374;45535.31697024614;53703;53774.731126344115;54917;24211.75788242095;43186.27254909768;74058.62970685112;75497.6225118871;75714.62142689251;14082;14196.787048194079;14217.289135542975;14311.069780464237;14590.051646642934;15330.156841373386;15665.295061722021;15845.286962086964;16207.837921621105;16870.409535666193;12830.615081547568;12947.611571652866;13307.268100254192;13451.19938952792;13484.325783710972;14664.560063198121;14778.852211477748;15380.38478460849;15428.460003899809;15468;12988.805167922677;13323.53367632167;13455.663608409477;13475.326233688473;13573.59279221625;10655.946720266658;11262.718432039264;11663.125265605284;11833.34916579562;11856.881431185922;10521.81903981341;10552.103071238724;10677.14582833387;10677.519511622151;10743.301685390425 08:38:17 INFO - PROCESS | 21598 | __end_tp_report 08:38:17 INFO - PROCESS | 21598 | __start_cc_report 08:38:17 INFO - PROCESS | 21598 | _x_x_mozilla_cycle_collect,1112 08:38:17 INFO - PROCESS | 21598 | __end_cc_report 08:38:17 INFO - PROCESS | 21598 | __startTimestamp1467041897150__endTimestamp 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | ------- Summary: start ------- 08:38:17 INFO - PROCESS | 21598 | Number of tests: 6 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | [#0] dojo.html Cycles:165 Average:5407.97 Median:5607.16 stddev:625.96 (11.2%) stddev-sans-first:601.62 08:38:17 INFO - PROCESS | 21598 | Values: 3120.9 3146.2 3157.3 3165.4 3208.1 5256.7 5285.0 5470.5 5552.1 5568.0 5395.1 5421.5 5464.6 5494.5 5494.7 4901.4 4966.6 4987.7 4999.6 5152.8 5038.8 5042.3 5085.9 5100.1 5107.6 4787.0 4822.3 4858.0 4864.6 4921.2 4930.7 4932.7 4942.8 5011.7 5020.7 4961.7 4985.9 5006.3 5019.5 5044.4 5265.8 5401.3 5454.5 5502.7 5502.9 5849.7 5883.3 5899.1 5903.0 5919.9 5895.8 5928.9 5936.4 5941.2 5957.5 5284.4 5404.7 5458.8 5461.9 5533.8 6024.6 6031.2 6031.8 6032.0 6034.5 5812.9 5821.7 5822.4 5823.3 5823.9 5610.1 5692.7 5768.5 5773.2 5807.4 5756.3 5800.3 5802.0 5802.9 5812.0 5557.3 5786.7 5799.4 5805.6 5807.0 4344.8 4356.8 4387.1 4390.8 4443.2 3921.1 3933.1 3936.1 3966.2 3967.9 5413.4 5416.9 5420.5 5420.8 5424.3 5677.6 5764.5 5800.7 5808.1 5824.2 5375.3 5447.5 5455.1 5456.6 5459.6 4775.7 4895.9 4899.8 4913.0 4955.4 6021.7 6054.5 6073.8 6094.8 6111.0 5917.2 5919.7 5924.9 5926.9 5928.0 5741.0 5859.7 6078.9 6095.1 6101.6 5709.6 5787.9 5805.5 5806.0 5849.2 5811.3 5826.2 5865.1 5884.2 5886.9 5543.4 5680.7 5752.1 5752.6 5761.2 5735.7 5736.5 5737.1 5743.4 5775.6 5607.2 5609.5 5616.9 5618.3 5622.6 5483.2 5491.8 5697.3 5741.1 5797.0 5409.8 5547.0 5569.8 5614.9 5618.9 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | [#1] ext.html Cycles:180 Average:64130.64 Median:41711.94 stddev:125263.94 (300.3%) stddev-sans-first:125524.45 08:38:17 INFO - PROCESS | 21598 | Values: 575.2 613.4 613.9 631.7 631.9 42258.6 43666.6 44486.3 44546.6 44563.6 44633.6 45237.3 45274.3 45297.5 45298.3 8329.5 8905.4 9121.7 10863.9 11105.2 10569.8 10948.5 10954.7 10956.0 10965.5 11013.2 11059.7 11085.2 11085.3 11091.1 10870.6 10951.5 11000.7 11006.6 11010.0 10910.9 10984.4 10985.5 10997.5 10998.3 43650.6 44001.3 44031.3 44045.6 44059.3 3785.9 4214.2 4306.5 4320.7 4362.0 33668.8 33926.5 34254.8 34653.0 34805.8 4329.4 4357.2 4364.2 4375.3 4392.6 386110.0 388425.0 388876.1 389471.0 389798.0 65934.0 66024.0 66517.0 66614.7 66698.3 69063.0 69416.3 69431.7 69515.7 69517.7 16955.2 17354.9 17381.3 17394.8 17395.1 13976.2 14000.0 14002.8 14016.9 14054.3 20102.3 20145.0 20312.8 20442.8 20493.7 7272.5 7292.7 7299.6 7412.6 7507.4 922.4 1002.6 1008.0 1019.4 1061.2 32390.0 32728.8 32808.0 33095.7 33670.0 980.2 1077.9 1109.8 1161.7 1180.0 16591.5 16890.9 16954.2 16966.9 17237.7 555268.0 555683.0 557392.0 558643.0 558969.0 60486.4 60879.7 60897.0 60942.7 60979.0 1214.5 1330.3 1346.7 1370.7 1382.2 32668.2 33706.5 33787.7 34159.3 34398.1 50658.0 51533.0 51596.2 51602.5 51668.5 449276.0 459744.0 460648.0 460990.0 461241.0 28630.3 37634.4 42694.6 43521.0 44367.3 45493.3 45982.8 49264.5 49667.3 49833.5 41720.3 42775.0 43427.0 43755.6 43987.3 41520.0 41662.2 42331.6 42861.8 42979.6 41703.6 42027.8 42231.8 42307.4 42565.0 36400.6 37213.8 37339.4 37390.3 37584.6 27987.3 28216.9 28387.3 28526.4 28975.4 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | [#2] jquery.html Cycles:180 Average:28566.28 Median:16175.27 stddev:80358.80 (496.8%) stddev-sans-first:80556.34 08:38:17 INFO - PROCESS | 21598 | Values: 371.7 380.1 384.8 395.6 412.3 17809.9 19253.9 19599.2 19604.1 19617.3 18423.1 18672.7 18678.3 19256.7 19951.9 5648.4 5690.7 5909.5 5950.8 5951.9 5778.1 5869.9 5885.4 5903.0 5906.8 5595.4 5843.0 5852.3 5854.1 5864.1 5793.0 5817.1 5820.0 5824.4 5865.8 4951.7 5203.0 5251.0 5277.2 5328.7 14189.6 14266.8 14335.4 22501.9 23704.6 2421.6 2475.4 2494.1 2600.6 3007.4 9488.8 9779.7 10748.6 10849.6 10990.9 1950.7 1954.7 2048.1 2049.6 2100.3 62138.7 65295.0 65392.7 81752.6 84832.0 8531.0 9971.2 10259.7 10264.3 10348.6 13835.4 13912.9 14208.9 14985.8 15023.9 8426.0 8429.0 8436.0 8465.9 8570.1 7682.0 7964.5 8012.8 8158.5 8323.3 4211.6 4282.3 4285.0 4521.0 4797.3 1938.8 1959.9 1964.5 1965.4 1993.1 879.3 967.7 980.4 1002.3 1011.5 19699.7 19800.7 19998.5 20246.3 20551.2 1001.4 1007.3 1014.8 1018.5 1093.2 10592.0 11170.9 11239.4 11341.1 11343.2 480836.0 485753.0 487980.0 492296.7 493027.0 89436.0 92412.0 92965.5 93172.0 94684.0 1004.1 1012.7 1015.8 1034.4 1039.3 17501.9 17661.8 17676.4 17815.3 18031.0 31978.8 38959.6 40665.6 40919.6 42344.6 58616.7 58876.1 59040.4 59341.4 59414.0 8568.2 8778.0 8825.3 8892.8 8973.5 9855.8 13623.5 13692.6 14136.4 14318.7 12021.8 12228.4 12435.4 12442.4 12799.4 12043.6 12145.1 12178.5 12340.9 12582.9 9547.5 11945.3 12670.2 12804.6 13043.9 8693.0 8718.5 8884.0 8897.0 8928.8 9282.5 11522.6 12254.4 12287.4 12551.9 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | [#3] mootools.html Cycles:180 Average:5843.42 Median:2548.20 stddev:3404.87 (133.6%) stddev-sans-first:3397.40 08:38:17 INFO - PROCESS | 21598 | Values: 1313.8 1466.0 1488.9 1627.0 1772.6 8327.9 8727.7 8746.2 8975.3 8975.4 8706.3 8895.6 8899.0 8906.9 8914.5 1932.0 2097.0 2157.0 2245.1 2274.1 2290.3 2300.3 2301.7 2302.1 2303.6 2209.8 2233.6 2254.8 2258.6 2259.7 1915.3 2159.6 2183.1 2223.3 2223.8 2267.4 2283.1 2288.2 2288.6 2289.4 9033.9 9070.6 9086.2 9100.4 9110.5 5111.7 5238.3 5246.3 5246.5 5247.8 3304.4 3377.1 3383.1 3521.1 3525.1 1103.3 1107.4 1121.5 1137.5 1163.0 12523.4 12640.8 12696.9 12771.1 12772.5 4545.1 4627.2 4692.3 4722.2 4727.6 10401.5 10411.3 10413.0 10427.4 10469.9 5273.7 5287.0 5304.1 5305.3 5311.1 4106.0 4698.5 4845.4 4849.1 4904.4 3892.6 3983.1 3992.2 4034.7 4088.9 1279.2 1299.3 1312.6 1324.0 1325.6 926.2 936.5 941.1 942.4 969.7 5703.5 5750.8 5824.2 6013.5 6033.5 445.3 469.2 996.1 1057.5 1104.1 4115.9 4169.6 4203.4 4229.8 4251.5 11129.7 11206.1 11300.7 11368.1 11479.9 11166.4 11263.8 11264.5 11275.3 11299.0 8228.7 8246.7 8426.9 8430.0 8441.4 5819.2 5911.3 6026.2 6045.8 6082.2 10092.3 10423.6 10429.0 10434.3 10445.3 10426.7 10552.5 10731.3 10741.8 10741.9 6870.5 7063.1 7067.2 7648.7 7797.5 7712.2 8416.0 8476.5 8735.5 8741.3 7499.9 7764.1 7801.3 7810.6 7859.0 7752.1 7801.6 7835.6 7839.5 7893.9 6706.4 6769.5 6811.3 6870.6 6876.4 5065.0 5230.2 5340.3 5377.1 5392.1 4961.9 5120.7 5132.2 5157.3 5323.8 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | [#4] prototype.html Cycles:180 Average:4587.59 Median:5167.20 stddev:1351.71 (26.2%) stddev-sans-first:1316.68 08:38:17 INFO - PROCESS | 21598 | Values: 302.6 310.6 317.8 318.5 320.1 5078.5 5264.3 5426.9 5440.6 5464.6 5397.0 5418.7 5419.5 5425.1 5430.8 4192.3 4205.3 4230.3 4241.3 4275.3 3997.6 4103.5 4209.5 4246.7 4254.7 4092.8 4114.8 4131.6 4183.9 4189.7 4110.1 4137.3 4138.3 4144.4 4196.1 3581.4 3656.5 3701.2 3708.0 3713.5 5204.4 5204.7 5209.0 5216.5 5224.2 4708.9 4725.3 4742.8 4765.7 4773.3 5310.3 5546.8 5591.0 5644.3 5652.7 3931.9 3934.1 3994.1 3994.5 4010.3 5569.8 5589.4 5847.0 5881.0 5892.9 3986.8 3996.7 3999.8 4002.6 4008.2 4010.8 4047.6 4049.6 4059.1 4060.0 4579.2 4677.3 4685.9 4687.1 4713.3 5609.9 5636.9 5647.0 5661.9 5665.4 1385.5 1405.5 1413.1 1415.2 1417.3 844.0 886.1 893.2 911.5 911.7 4801.6 4812.1 4844.7 4876.6 4883.0 5092.7 5111.0 5144.8 5147.5 5220.9 4628.4 4801.9 4810.8 4816.0 4842.0 2707.5 2712.6 2733.3 2760.4 2763.3 5296.5 5303.9 5354.0 5366.2 5395.9 4818.8 5229.6 5237.4 5273.3 5301.9 5218.5 5227.8 5280.6 5285.3 5294.2 5085.5 5103.7 5107.8 5110.6 5186.9 5074.8 5296.3 5854.4 5857.0 5864.9 5806.3 5946.9 5969.9 5970.9 6093.8 3946.9 3992.7 4039.1 4067.4 4073.4 5681.9 5797.0 5832.3 5837.4 5841.9 5651.4 5668.4 5670.2 5679.4 5689.3 5588.7 5624.9 5642.9 5677.6 5689.0 5440.5 5512.6 5512.9 5555.4 5580.4 5654.3 5673.7 5682.6 5683.2 5686.5 5553.9 5561.6 5565.6 5571.8 5589.6 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - PROCESS | 21598 | [#5] yui.html Cycles:180 Average:20247.69 Median:4361.13 stddev:29540.53 (677.4%) stddev-sans-first:29586.90 08:38:17 INFO - PROCESS | 21598 | Values: 689.5 706.9 797.0 797.7 833.6 14773.6 15711.7 15712.9 15729.2 15729.6 15304.8 15913.4 15916.0 16406.4 16456.3 657.8 763.4 798.7 798.7 805.9 778.8 786.9 787.2 787.6 787.7 828.1 834.9 836.2 836.6 836.6 694.5 804.2 829.3 831.7 832.4 606.2 610.0 610.1 610.1 610.9 12632.5 12652.9 12688.4 12696.1 12696.4 13524.3 14057.2 14067.0 14260.5 14336.4 13217.3 13498.3 13562.7 13589.5 13624.7 4365.9 4403.9 4426.0 4496.7 4632.7 75778.6 75781.0 75885.0 75997.0 78638.6 10373.2 10623.2 10641.8 10779.5 10883.7 17865.9 17926.6 17929.6 17934.2 17937.7 7573.9 7613.1 7621.7 7672.8 7777.6 4571.2 4736.6 4743.4 4788.8 4816.1 3293.3 3394.0 3408.1 3413.4 3415.0 579.2 580.7 616.2 653.7 655.6 558.4 634.6 677.2 722.4 754.6 8971.7 9129.9 9399.6 9515.6 9610.5 569.8 575.6 591.7 653.8 685.1 4065.8 4231.5 4260.4 4287.2 4356.3 111163.0 115472.0 118064.0 123130.4 123769.0 85202.6 100646.5 101978.5 102056.0 104010.0 77114.6 78124.6 78889.0 87958.0 89926.0 8796.0 9408.4 9411.7 9417.8 9476.0 44628.6 45535.3 53703.0 53774.7 54917.0 24211.8 43186.3 74058.6 75497.6 75714.6 14082.0 14196.8 14217.3 14311.1 14590.1 15330.2 15665.3 15845.3 16207.8 16870.4 12830.6 12947.6 13307.3 13451.2 13484.3 14664.6 14778.9 15380.4 15428.5 15468.0 12988.8 13323.5 13455.7 13475.3 13573.6 10655.9 11262.7 11663.1 11833.3 11856.9 10521.8 10552.1 10677.1 10677.5 10743.3 08:38:17 INFO - PROCESS | 21598 | -------- Summary: end -------- 08:38:17 INFO - PROCESS | 21598 | 08:38:17 INFO - TEST-INFO | 21598: exit 0 08:38:17 INFO - TEST-OK | dromaeo_css | took 1115000ms 08:38:17 INFO - TEST-START | kraken 08:38:17 INFO - operating with platform_type : linux_ 08:38:17 INFO - Initialising browser for kraken test... 08:38:17 INFO - TEST-INFO | started process 21784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewtNe1/profile http://localhost:37919/getInfo.html) 08:38:22 INFO - PROCESS | 21784 | __metrics Screen width/height:1600/1200 08:38:22 INFO - PROCESS | 21784 | colorDepth:24 08:38:22 INFO - PROCESS | 21784 | Browser inner width/height: 1024/697 08:38:22 INFO - PROCESS | 21784 | __metrics 08:38:23 INFO - PROCESS | 21784 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:24 INFO - TEST-INFO | 21784: exit 0 08:38:24 INFO - Browser initialized. 08:38:24 INFO - Running cycle 1/1 for kraken test... 08:38:24 INFO - TEST-INFO | started process 21864 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewtNe1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:36 INFO - PROCESS | 21864 | RSS: Main: 173916160 08:38:36 INFO - PROCESS | 21864 | 08:38:38 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37919/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:39 INFO - PROCESS | 21864 | RSS: Main: 231915520 08:38:39 INFO - PROCESS | 21864 | 08:38:42 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37919/tests/kraken/driver.html?testName=audio-dft) 08:38:42 INFO - PROCESS | 21864 | RSS: Main: 219942912 08:38:42 INFO - PROCESS | 21864 | 08:38:45 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37919/tests/kraken/driver.html?testName=audio-fft) 08:38:46 INFO - PROCESS | 21864 | RSS: Main: 285982720 08:38:46 INFO - PROCESS | 21864 | 08:38:48 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37919/tests/kraken/driver.html?testName=audio-oscillator) 08:38:49 INFO - PROCESS | 21864 | RSS: Main: 196866048 08:38:49 INFO - PROCESS | 21864 | 08:38:51 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:51 INFO - PROCESS | 21864 | RSS: Main: 201089024 08:38:51 INFO - PROCESS | 21864 | 08:38:54 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37919/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:55 INFO - PROCESS | 21864 | RSS: Main: 236654592 08:38:55 INFO - PROCESS | 21864 | 08:38:58 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37919/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:59 INFO - PROCESS | 21864 | RSS: Main: 236888064 08:38:59 INFO - PROCESS | 21864 | 08:39:02 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37919/tests/kraken/driver.html?testName=json-parse-financial) 08:39:02 INFO - PROCESS | 21864 | RSS: Main: 237137920 08:39:02 INFO - PROCESS | 21864 | 08:39:04 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:05 INFO - PROCESS | 21864 | RSS: Main: 224030720 08:39:05 INFO - PROCESS | 21864 | 08:39:06 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:07 INFO - PROCESS | 21864 | RSS: Main: 227688448 08:39:07 INFO - PROCESS | 21864 | 08:39:09 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:39:10 INFO - PROCESS | 21864 | RSS: Main: 235540480 08:39:10 INFO - PROCESS | 21864 | 08:39:12 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:39:13 INFO - PROCESS | 21864 | RSS: Main: 237256704 08:39:13 INFO - PROCESS | 21864 | 08:39:15 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:39:16 INFO - PROCESS | 21864 | RSS: Main: 238092288 08:39:16 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | Cycle 1(1): loaded http://localhost:37919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37919/tests/kraken/driver.html?testName=ai-astar) 08:39:18 INFO - PROCESS | 21864 | RSS: Main: 281120768 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | __start_tp_report 08:39:18 INFO - PROCESS | 21864 | _x_x_mozilla_page_load 08:39:18 INFO - PROCESS | 21864 | _x_x_mozilla_page_load_details 08:39:18 INFO - PROCESS | 21864 | |i|pagename|runs| 08:39:18 INFO - PROCESS | 21864 | |0;ai-astar;102;112;110;110;110;110;109;109;110;109 08:39:18 INFO - PROCESS | 21864 | |1;audio-beat-detection;152;132;127;189;134;127;154;131;164;126 08:39:18 INFO - PROCESS | 21864 | |2;audio-dft;161;162;163;162;163;164;162;162;162;162 08:39:18 INFO - PROCESS | 21864 | |3;audio-fft;74;76;75;133;75;75;77;76;98;75 08:39:18 INFO - PROCESS | 21864 | |4;audio-oscillator;85;85;119;84;84;84;131;84;85;128 08:39:18 INFO - PROCESS | 21864 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;116;116;116 08:39:18 INFO - PROCESS | 21864 | |6;imaging-darkroom;146;146;145;146;146;145;145;146;146;145 08:39:18 INFO - PROCESS | 21864 | |7;imaging-desaturate;94;94;94;94;95;94;94;94;95;96 08:39:18 INFO - PROCESS | 21864 | |8;json-parse-financial;53;54;53;54;53;52;53;51;55;52 08:39:18 INFO - PROCESS | 21864 | |9;json-stringify-tinderbox;61;62;61;61;61;62;65;63;62;62 08:39:18 INFO - PROCESS | 21864 | |10;stanford-crypto-aes;78;83;77;78;79;79;86;81;94;80 08:39:18 INFO - PROCESS | 21864 | |11;stanford-crypto-ccm;126;122;120;133;128;120;130;121;125;138 08:39:18 INFO - PROCESS | 21864 | |12;stanford-crypto-pbkdf2;157;159;155;156;157;156;157;156;162;158 08:39:18 INFO - PROCESS | 21864 | |13;stanford-crypto-sha256-iterative;63;61;63;61;62;62;61;61;61;65 08:39:18 INFO - PROCESS | 21864 | __end_tp_report 08:39:18 INFO - PROCESS | 21864 | __start_cc_report 08:39:18 INFO - PROCESS | 21864 | _x_x_mozilla_cycle_collect,1656 08:39:18 INFO - PROCESS | 21864 | __end_cc_report 08:39:18 INFO - PROCESS | 21864 | __startTimestamp1467041958434__endTimestamp 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | ------- Summary: start ------- 08:39:18 INFO - PROCESS | 21864 | Number of tests: 14 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 08:39:18 INFO - PROCESS | 21864 | Values: 102.0 112.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:143.00 stddev:20.82 (14.6%) stddev-sans-first:21.86 08:39:18 INFO - PROCESS | 21864 | Values: 152.0 132.0 127.0 189.0 134.0 127.0 154.0 131.0 164.0 126.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 08:39:18 INFO - PROCESS | 21864 | Values: 161.0 162.0 163.0 162.0 163.0 164.0 162.0 162.0 162.0 162.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.50 stddev:18.84 (25.0%) stddev-sans-first:19.67 08:39:18 INFO - PROCESS | 21864 | Values: 74.0 76.0 75.0 133.0 75.0 75.0 77.0 76.0 98.0 75.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:84.00 stddev:20.30 (24.2%) stddev-sans-first:21.07 08:39:18 INFO - PROCESS | 21864 | Values: 85.0 85.0 119.0 84.0 84.0 84.0 131.0 84.0 85.0 128.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:39:18 INFO - PROCESS | 21864 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 08:39:18 INFO - PROCESS | 21864 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 08:39:18 INFO - PROCESS | 21864 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 96.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:1.15 (2.2%) stddev-sans-first:1.22 08:39:18 INFO - PROCESS | 21864 | Values: 53.0 54.0 53.0 54.0 53.0 52.0 53.0 51.0 55.0 52.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.27 08:39:18 INFO - PROCESS | 21864 | Values: 61.0 62.0 61.0 61.0 61.0 62.0 65.0 63.0 62.0 62.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:80.50 stddev:5.15 (6.4%) stddev-sans-first:5.30 08:39:18 INFO - PROCESS | 21864 | Values: 78.0 83.0 77.0 78.0 79.0 79.0 86.0 81.0 94.0 80.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:127.00 stddev:6.02 (4.7%) stddev-sans-first:6.38 08:39:18 INFO - PROCESS | 21864 | Values: 126.0 122.0 120.0 133.0 128.0 120.0 130.0 121.0 125.0 138.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:157.00 stddev:2.00 (1.3%) stddev-sans-first:2.12 08:39:18 INFO - PROCESS | 21864 | Values: 157.0 159.0 155.0 156.0 157.0 156.0 157.0 156.0 162.0 158.0 08:39:18 INFO - PROCESS | 21864 | 08:39:18 INFO - PROCESS | 21864 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:1.33 (2.2%) stddev-sans-first:1.36 08:39:18 INFO - PROCESS | 21864 | Values: 63.0 61.0 63.0 61.0 62.0 62.0 61.0 61.0 61.0 65.0 08:39:18 INFO - PROCESS | 21864 | -------- Summary: end -------- 08:39:18 INFO - PROCESS | 21864 | 08:39:19 INFO - TEST-INFO | 21864: exit 0 08:39:19 INFO - TEST-OK | kraken | took 61532ms 08:39:19 INFO - SUITE-END | took 1176s 08:39:19 INFO - Completed test suite (00:19:36) 08:39:19 INFO - javascript benchmark 08:39:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3120.938880780535, 3146.229173852405, 3157.3369592385625, 3165.35110302388, 3208.1017315151753, 5256.684598924067, 5285.0, 5470.507654311116, 5552.083906155484, 5568.025595520783, 5395.0558652235895, 5421.539169170625, 5464.644798088121, 5494.532964697995, 5494.697791621459, 4901.362822833027, 4966.5778408835295, 4987.700737955716, 4999.625028122887, 5152.819651312205, 5038.7984480620735, 5042.319286896259, 5085.949140508603, 5100.081985242655, 5107.591392688576, 4787.0, 4822.324874517552, 4858.0, 4864.562189402971, 4921.18800397934, 4930.679505832145, 4932.728699921503, 4942.827001054946, 5011.724355160465, 5020.698758074491, 4961.727105009223, 4985.925211121836, 5006.299118123466, 5019.5231453012275, 5044.419891712427, 5265.789368425297, 5401.297831281948, 5454.53636440903, 5502.724863756836, 5502.9174562381595, 5849.736761845727, 5883.294004719461, 5899.115132730082, 5902.966980778389, 5919.91120133194, 5895.793647222326, 5928.940710592925, 5936.376680448534, 5941.168236446901, 5957.463828255478, 5284.365876094855, 5404.675719456806, 5458.754356053947, 5461.863453413617, 5533.750981205855, 6024.578279520391, 6031.24609423822, 6031.819045428644, 6031.9698401508585, 6034.456898879122, 5812.854678633068, 5821.708914554255, 5822.417758224228, 5823.272090988627, 5823.941760582425, 5610.074337734228, 5692.686902220335, 5768.480836724715, 5773.162891380726, 5807.448292412214, 5756.30924289088, 5800.303963524404, 5801.984652685763, 5802.941970580325, 5811.9709401453565, 5557.277553917965, 5786.71066446676, 5799.3620701722775, 5805.622634528742, 5806.970965145148, 4344.847930322424, 4356.825726970949, 4387.100644367961, 4390.758508282075, 4443.178012067778, 3921.0785465415606, 3933.0757272041046, 3936.0553467167674, 3966.2464131814863, 3967.861124860674, 5413.377461591888, 5416.91874621881, 5420.512153906167, 5420.756065977041, 5424.294841670637, 5677.602567820213, 5764.510016648632, 5800.6809625471005, 5808.099744539603, 5824.184614154022, 5375.3280839895015, 5447.509724124848, 5455.1271796512365, 5456.645318054393, 5459.563234941195, 4775.689580177277, 4895.877603059952, 4899.828506002273, 4913.0, 4955.4301255356095, 6021.6989150542295, 6054.485368743618, 6073.787417440457, 6094.8171554853425, 6110.969445152835, 5917.1715959766525, 5919.733611987557, 5924.8815023700145, 5926.881462370815, 5927.9703601481715, 5740.971295143665, 5859.707014649165, 6078.878422431439, 6095.05526643371, 6101.60339577926, 5709.628874123168, 5787.94212057874, 5805.477507024388, 5806.0, 5849.239598852292, 5811.27359080115, 5826.155207494805, 5865.14955331466, 5884.205632239764, 5886.94113058864, 5543.36251331086, 5680.715964201856, 5752.13717942312, 5752.597318187687, 5761.164631128547, 5735.684537350486, 5736.512396446182, 5737.139429085671, 5743.396943320891, 5775.566832487496, 5607.158926161109, 5609.523190528687, 5616.8876622466505, 5618.325800903917, 5622.5501959842295, 5483.2049352844415, 5491.807786727445, 5697.344805347272, 5741.052726300114, 5797.043487824461, 5409.810656626999, 5547.0, 5569.832905012856, 5614.85962850932, 5618.85952851182], "value": 5365.225078179476, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2177039226651, 613.3712944232161, 613.9140520327152, 631.7094136697119, 631.8894193516134, 42258.577414225845, 43666.56333436665, 44486.33270500945, 44546.55453445465, 44563.55436445639, 44633.55366446335, 45237.32144017842, 45274.320885186746, 45297.54702452975, 45298.320525192146, 8329.541875196892, 8905.421147625417, 9121.680741174061, 10863.891361086407, 11105.167112466557, 10569.841452378221, 10948.45257737114, 10954.726131846728, 10956.0, 10965.50655220517, 11013.229073964785, 11059.72350691235, 11085.168612354066, 11085.334879907232, 11091.057260132899, 10870.61952831651, 10951.507182176822, 11000.669979900616, 11006.614768483145, 11010.0, 10910.945445272722, 10984.395858227794, 10985.505652245669, 10997.450127493674, 10998.285111467729, 43650.563494364964, 44001.339979900324, 44031.339529906756, 44045.55954440479, 44059.33910991338, 3785.9053523661855, 4214.220369231702, 4306.4832220133785, 4320.697551171419, 4362.0, 33668.83165584181, 33926.49110263348, 34254.82872585646, 34653.0, 34805.82597087024, 4329.350597410382, 4357.193919124972, 4364.192624364503, 4375.291305943139, 4392.626626736731, 386110.0, 388425.0, 388876.05561972293, 389471.0, 389798.0, 65934.0, 66024.0, 66517.0, 66614.66692666506, 66698.33301667018, 69063.0, 69416.30583694199, 69431.65284173547, 69515.65242173757, 69517.65241173762, 16955.15224238783, 17354.913225433793, 17381.304747810198, 17394.826051739572, 17395.130243487776, 13976.231307278198, 14000.0, 14002.789958150635, 14016.929915350358, 14054.297285135703, 20102.296419625243, 20145.0, 20312.79687203109, 20442.773433594033, 20493.692594611093, 7272.527340704186, 7292.708291668274, 7299.613073516015, 7412.592307423036, 7507.436942229355, 922.4280945813505, 1002.6390499420203, 1007.9970429422772, 1019.4444028004755, 1061.2093989977361, 32390.0, 32728.836355818545, 32808.0, 33095.66904330974, 33669.98990030303, 980.1766516126346, 1077.9299345542515, 1109.8168802147716, 1161.7386088130272, 1179.9823002654966, 16591.502254932373, 16890.91554542244, 16954.15229238533, 16966.915165424092, 17237.655246895243, 555268.0, 555683.0, 557392.0, 558643.0, 558969.0, 60486.39513604896, 60879.695601522595, 60897.0, 60942.69528652328, 60979.0, 1214.5445457953267, 1330.301591664384, 1346.6633341664583, 1370.6847425092485, 1382.1776043254247, 32668.183295417806, 33706.49440258349, 33787.66212337845, 34159.31681366309, 34398.14004649904, 50658.0, 51533.0, 51596.22605660843, 51602.48397515977, 51668.48331516637, 449276.0, 459744.0, 460648.0, 460990.0, 461241.0, 28630.284242894093, 37634.43548346832, 42694.57305426906, 43521.0, 44367.334489983325, 45493.31760023536, 45982.77008614936, 49264.50735492599, 49667.25499117588, 49833.50166498288, 41720.28818126812, 42775.0, 43427.0, 43755.56244437515, 43987.34018989654, 41520.0, 41662.16675666409, 42331.576684232765, 42861.785691071345, 42979.57020429755, 41703.58296417118, 42027.7898610505, 42231.78884105683, 42307.3653895198, 42565.0, 36400.63599363973, 37213.81393093017, 37339.39681667146, 37390.25219495541, 37584.624153758115, 27987.300317492227, 28216.85891570611, 28387.290317741397, 28526.42947141087, 28975.42049159047], "value": 21565.52574163559, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.69335298378826, 380.08589342630967, 384.84990853567103, 395.63403851437397, 412.31349802578706, 17809.910950445246, 19253.903730481365, 19599.216031358745, 19604.117814698337, 19617.313394031193, 18423.07884605771, 18672.719909201373, 18678.346257880978, 19256.711149332772, 19951.900240498813, 5648.350439699446, 5690.743916523756, 5909.497692696126, 5950.7917222896995, 5951.9107213391835, 5778.075507918734, 5869.941300587004, 5885.352611212763, 5902.97048514759, 5906.763729450817, 5595.4124816894255, 5842.970785146068, 5852.297724273093, 5854.121881717755, 5864.149698293745, 5793.0, 5817.127430885359, 5820.039693450597, 5824.388439213864, 5865.824025279248, 4951.653384263103, 5203.0, 5251.028559716465, 5277.182036784305, 5328.706921119337, 14189.645258868612, 14266.785998210034, 14335.426582936774, 22501.887490562607, 23704.64443033356, 2421.5641184586766, 2475.356407334088, 2494.064725727852, 2600.557905156128, 3007.443622929765, 9488.762780930532, 9779.657711980046, 10748.623798167027, 10849.620263290826, 10990.945045274722, 1950.697641865513, 1954.7263383126374, 2048.09883651193, 2049.579836133589, 2100.2544096845554, 62138.68930655318, 65295.020574691895, 65392.67303663499, 81752.59123704344, 84832.0, 8531.0, 9971.152452041657, 10259.7435064124, 10264.281500295057, 10348.586056557653, 13835.446582136601, 13912.860871391358, 14208.857911420753, 14985.775213371808, 15023.924880375529, 8425.957870210732, 8429.0, 8436.0, 8465.915340846514, 8570.057293697688, 7681.961590192013, 7964.522128672298, 8012.79968000793, 8158.510489370657, 8323.334133269324, 4211.620954114144, 4282.314829627245, 4285.0, 4521.0279789845345, 4797.328374027639, 1938.7867334593184, 1959.8637485141264, 1964.4990527415703, 1965.3809050149157, 1993.1130646862007, 879.3009557401881, 967.7000129959735, 980.3676628574672, 1002.2983911262146, 1011.4942528735633, 19699.704504432444, 19800.70298945517, 19998.50003749889, 20246.291379801638, 20551.177952882015, 1001.3891526169031, 1007.3099926550336, 1014.802113587858, 1018.5467466977273, 1093.1582681335485, 10592.0, 11170.944145279222, 11239.438028098562, 11341.092712582973, 11343.20597558163, 480836.0, 485753.0, 487980.0, 492296.69258268113, 493027.0, 89436.0, 92412.0, 92965.53517232371, 93172.0, 94684.0, 1004.1414590525142, 1012.71643939697, 1015.7816069545083, 1034.363866222268, 1039.2517387481003, 17501.912490437466, 17661.82338176602, 17676.381326653507, 17815.287388504832, 18031.0, 31978.84010579932, 38959.61040389673, 40665.59334406618, 40919.59080409277, 42344.57655423407, 58616.70691646515, 58876.11685824802, 59040.40959590521, 59341.40658593359, 59414.0, 8568.228859402683, 8778.0, 8825.293976481995, 8892.822143557221, 8973.461592304482, 9855.753606159904, 13623.523176688768, 13692.589222323346, 14136.43454261818, 14318.713625727636, 12021.75956480848, 12228.44971976281, 12435.44040518197, 12442.440090196144, 12799.360031998176, 12043.638690839289, 12145.089118315986, 12178.45196966121, 12340.938295308824, 12582.87417125817, 9547.47240441526, 11945.343006134746, 12670.239785612892, 12804.61586152417, 13043.869561304646, 8693.0, 8718.520481373585, 8883.955580222317, 8897.021327653823, 8928.776780580538, 9282.489463079595, 11522.596709115141, 12254.4485498151, 12287.385630718607, 12551.937240314106], "value": 9175.242609052244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.7700902342099, 1465.978010329845, 1488.8808895288378, 1626.9511914642558, 1772.592303770132, 8327.87508187377, 8727.650893964243, 8746.212840844331, 8975.281977441806, 8975.41659792113, 8706.303495720344, 8895.599698013588, 8899.0, 8906.91093089069, 8914.465132092062, 1931.9903400482979, 2096.9895150524226, 2157.0401171478698, 2245.124401483423, 2274.0676322707695, 2290.2900100968754, 2300.25241796416, 2301.6777651128855, 2302.067662596651, 2303.608386574278, 2209.845310828243, 2233.6314508106225, 2254.830887683422, 2258.6386178211487, 2259.67234750961, 1915.3104882242383, 2159.622066138435, 2183.11583808557, 2223.3107736601705, 2223.788740069691, 2267.4444761033487, 2283.1095872609694, 2288.19913030438, 2288.5766133265397, 2289.3933107726466, 9033.864492032624, 9070.591823367899, 9086.227670647937, 9100.36297459178, 9110.5444727764, 5111.693298402108, 5238.349919775259, 5246.344206974129, 5246.501582349709, 5247.790088396459, 3304.4217261979056, 3377.090468980458, 3383.086566626997, 3521.0845180253064, 3525.0834782956617, 1103.3049179017248, 1107.3577325151473, 1121.4616983847718, 1137.5108703257597, 1162.96511104667, 12523.436445359981, 12640.810387844189, 12696.936515317457, 12771.106022578424, 12772.48910043597, 4545.113702827917, 4627.190241707688, 4692.319613656001, 4722.173619616553, 4727.57451829337, 10401.479926003669, 10411.323263987817, 10413.0, 10427.374357538572, 10469.895301047045, 5273.707941554344, 5286.969041036961, 5304.124819404755, 5305.257263983045, 5311.070562651597, 4105.97947010263, 4698.530146985342, 4845.370101886732, 4849.102915960488, 4904.386951631046, 3892.5523564789846, 3983.083890705154, 3992.2215168041953, 4034.7377420467574, 4088.9182216356103, 1279.2388528825334, 1299.2918859221747, 1312.6324629103867, 1324.0466863858007, 1325.5691900132304, 926.2080920812742, 936.5410948635256, 941.1388579449726, 942.3733217410482, 969.6751588218026, 5703.54371650267, 5750.769969201268, 5824.155497452845, 6013.54898382623, 6033.5474839387225, 445.34089547469927, 469.2164085976428, 996.14829320931, 1057.5241141486363, 1104.116706634705, 4115.8765237042935, 4169.583041695806, 4203.390508376268, 4229.830806767756, 4251.489821221473, 11129.666110016713, 11206.103511719042, 11300.660980170607, 11368.090552755759, 11479.942600286946, 11166.441677916071, 11263.831042534368, 11264.493097810619, 11275.323480591027, 11299.039581635652, 8228.711995080144, 8246.670133194724, 8426.873596896052, 8429.957850210832, 8441.36689748259, 5819.185314055951, 5911.349751527243, 6026.15633811258, 6045.78839740607, 6082.2093127893095, 10092.343997640424, 10423.583056677951, 10429.0, 10434.269601127848, 10445.321054131457, 10426.68719938403, 10552.525136368728, 10731.302465339728, 10741.838872416763, 10741.892581074402, 6870.484713646397, 7063.081799366049, 7067.222605513492, 7648.73229436967, 7797.493162944391, 7712.190220026816, 8416.0, 8476.533790641573, 8735.519546425008, 8741.300695944183, 7499.88750168737, 7764.145943946049, 7801.336886364723, 7810.609469526615, 7858.960705196438, 7752.14726380109, 7801.609919504115, 7835.5690437026515, 7839.490433121829, 7893.921060789548, 6706.396424321834, 6769.526133170631, 6811.318868113149, 6870.62211578348, 6876.381125698511, 5065.0, 5230.215467679878, 5340.252364669027, 5377.139657654913, 5392.110301800159, 4961.925571116509, 5120.667156634807, 5132.230165475208, 5157.329547158845, 5323.787048518016], "value": 4621.4088045973385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.61870043744887, 310.6443122624595, 317.84425631440587, 318.47928636679023, 320.09253765574596, 5078.542931136197, 5264.341957255343, 5426.945730542693, 5440.58544778358, 5464.644798088127, 5397.028534863723, 5418.7019713915815, 5419.512243898049, 5425.13197888338, 5430.809921652743, 4192.308269135589, 4205.285101532739, 4230.323148296257, 4241.257779888522, 4275.337322714969, 3997.640802127276, 4103.4870641169855, 4209.5477060414105, 4246.683528106297, 4254.723442976197, 4092.754434733911, 4114.773687447189, 4131.628153466202, 4183.895402614944, 4189.72766770159, 4110.095778928631, 4137.2552940470705, 4138.275801734684, 4144.357624568197, 4196.076863090116, 3581.426971684518, 3656.4880916671686, 3701.241245544684, 3707.9814600927093, 3713.4801127842125, 5204.4014938281825, 5204.713740744258, 5209.0, 5216.478352164753, 5224.190250511177, 4708.882277943045, 4725.291206319045, 4742.786574604151, 4765.69023013503, 4773.260144677581, 5310.336207974004, 5546.77812887484, 5591.043134902751, 5644.266245388073, 5652.745626446778, 3931.9383766383203, 3934.1344904121047, 3994.08136128692, 3994.500687414073, 4010.318245898204, 5569.805056822992, 5589.385167631557, 5847.0, 5880.97059514704, 5892.882142357172, 3986.8072560092414, 3996.7402118862183, 3999.7600143991453, 4002.579729128458, 4008.178323443687, 4010.839566417311, 4047.615476529725, 4049.5950404959267, 4059.1475790084414, 4059.959400405958, 4579.17574836526, 4677.321788340671, 4685.906281874343, 4687.078297897846, 4713.31656909753, 5609.915851262234, 5636.943630563642, 5647.011772939802, 5661.858453538612, 5665.433456654301, 1385.5358454917514, 1405.4729476446332, 1413.1168019987508, 1415.1509094543192, 1417.2701058954647, 843.9662413503391, 886.1183122792862, 893.2452077994085, 911.4850109688005, 911.7128104647015, 4801.591864691471, 4812.075169931985, 4844.660873738804, 4876.561109500162, 4882.9755851221225, 5092.694438333712, 5111.0, 5144.794208231704, 5147.510986456281, 5220.92168617471, 4628.4445866496235, 4801.855944321676, 4810.783514741775, 4815.975920120447, 4841.975790121027, 2707.485577740223, 2712.633794437765, 2733.289344770334, 2760.371380885247, 2763.322985868475, 5296.549793267615, 5303.859670170932, 5353.973230133903, 5366.248725178478, 5395.919061214085, 4818.7831547580445, 5229.581633469314, 5237.397699264558, 5273.288106105703, 5301.893962120736, 5218.530332270114, 5227.7714737036, 5280.577553795687, 5285.312909321764, 5294.152935530374, 5085.46602606721, 5103.693778373309, 5107.829172601704, 5110.591152707849, 5186.8962620748125, 5074.797008119782, 5296.285001524745, 5854.414558544282, 5856.970715146397, 5864.853378665567, 5806.274215723035, 5946.881062378815, 5969.910451343147, 5970.910436343545, 6093.817185484442, 3946.861859834892, 3992.7205095643026, 4039.091204478969, 4067.389891516178, 4073.4093556434746, 5681.857953551194, 5796.971015145066, 5832.270966129234, 5837.3870743571315, 5841.853953651193, 5651.378348381592, 5668.376478587435, 5670.18554062696, 5679.403662615366, 5689.26039614864, 5588.6646801192055, 5624.915626265528, 5642.943570564242, 5677.608985798506, 5688.971555142198, 5440.510354068153, 5512.641678290898, 5512.862178445571, 5555.444455554574, 5580.35825880029, 5654.3497497788285, 5673.659580425187, 5682.6306290091015, 5683.204351390891, 5686.4646545433325, 5553.916691249715, 5561.610687251854, 5565.638233514808, 5571.804986825604, 5589.636673616202], "value": 4150.1392082536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5345641691858, 706.9116360454943, 796.9641366138524, 797.740734261365, 833.5582141465026, 14773.630659233524, 15711.685766284667, 15712.921435392822, 15729.213539323046, 15729.60675983101, 15304.770428443582, 15913.44302949397, 15916.0, 16406.425775097872, 16456.259468323926, 657.7796438193187, 763.3969164360149, 798.6805277888848, 798.7244400681756, 805.879118132279, 778.8403377307667, 786.905571331441, 787.1616728184493, 787.6061969015492, 787.7085478372982, 828.0684230240979, 834.9499030058216, 836.1972506393869, 836.5900708652747, 836.6193382011201, 694.4964900447161, 804.1998211779259, 829.2909562324246, 831.7380025292044, 832.4214670803793, 606.19981624256, 610.036142894226, 610.081826850587, 610.112286622967, 610.914471973924, 12632.49470021198, 12652.92450141739, 12688.36558172097, 12696.111272210948, 12696.365181740968, 13524.25616591087, 14057.226852523107, 14067.0, 14260.500882469063, 14336.42654293827, 13217.339133043406, 13498.325083745773, 13562.660933476644, 13589.52436664712, 13624.727505449835, 4365.934510982338, 4403.889902752425, 4425.977870110661, 4496.662750293741, 4632.7220366777765, 75778.62110689412, 75781.0, 75885.0, 75997.0, 78638.60680696674, 10373.18342204419, 10623.150147988143, 10641.840372394421, 10779.461026948622, 10883.67348979532, 17865.910670446563, 17926.641467170582, 17929.551761206076, 17934.19296131677, 17937.730934036, 7573.886391704129, 7613.08642962848, 7621.69513219465, 7672.80817979555, 7777.57223352721, 4571.1543364477675, 4736.5500277474275, 4743.359646447685, 4788.832390866303, 4816.084943860656, 3293.275479394529, 3393.983030084834, 3408.079818449005, 3413.385590593717, 3414.965850341465, 579.244086467156, 580.7096451774113, 616.1927874484439, 653.6862306093102, 655.5574986883929, 558.3969313141797, 634.5906890055888, 677.1975209376905, 722.4437183368776, 754.6340025087828, 8971.685990990283, 9129.863052054225, 9399.57701903416, 9515.57179926905, 9610.471424071744, 569.7920854489541, 575.6287194759441, 591.6538824787461, 653.8234676637281, 685.1093578348127, 4065.79671016448, 4231.534531201627, 4260.44614200152, 4287.185434767384, 4356.324769660708, 111163.0, 115472.0, 118064.0, 123130.38434807947, 123769.0, 85202.57398712967, 100646.4967675157, 101978.49010754899, 102056.0, 104010.0, 77114.61442692863, 78124.60937695275, 78889.0, 87958.0, 89926.0, 8795.956020219857, 9408.388454750419, 9411.670591529264, 9417.764555886157, 9475.952620236854, 44628.55371446374, 45535.31697024614, 53703.0, 53774.731126344115, 54917.0, 24211.75788242095, 43186.27254909768, 74058.62970685112, 75497.6225118871, 75714.62142689251, 14082.0, 14196.787048194079, 14217.289135542975, 14311.069780464237, 14590.051646642934, 15330.156841373386, 15665.295061722021, 15845.286962086964, 16207.837921621105, 16870.409535666193, 12830.615081547568, 12947.611571652866, 13307.268100254192, 13451.19938952792, 13484.325783710972, 14664.560063198121, 14778.852211477748, 15380.38478460849, 15428.460003899809, 15468.0, 12988.805167922677, 13323.53367632167, 13455.663608409477, 13475.326233688473, 13573.59279221625, 10655.946720266658, 11262.718432039264, 11663.125265605284, 11833.34916579562, 11856.881431185922, 10521.81903981341, 10552.103071238724, 10677.14582833387, 10677.519511622151, 10743.301685390425], "value": 7380.041155738939, "unit": "score"}], "name": "dromaeo_css", "value": 7291.524094448898, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 132.0, 127.0, 189.0, 134.0, 127.0, 154.0, 131.0, 164.0, 126.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 162.0, 163.0, 164.0, 162.0, 162.0, 162.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 133.0, 75.0, 75.0, 77.0, 76.0, 98.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 84.0, 84.0, 84.0, 131.0, 84.0, 85.0, 128.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 96.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 54.0, 53.0, 52.0, 53.0, 51.0, 55.0, 52.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 62.0, 65.0, 63.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 77.0, 78.0, 79.0, 79.0, 86.0, 81.0, 94.0, 80.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 122.0, 120.0, 133.0, 128.0, 120.0, 130.0, 121.0, 125.0, 138.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 155.0, 156.0, 157.0, 156.0, 157.0, 156.0, 162.0, 158.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 65.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1493.7999999999997, "alertThreshold": 2.0}]} 08:39:19 INFO - Return code: 0 08:39:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:39:19 INFO - # TBPL SUCCESS # 08:39:19 INFO - Running post-action listener: _resource_record_post_action 08:39:19 INFO - ##### 08:39:19 INFO - ##### Finished run-tests step (success) 08:39:19 INFO - ##### 08:39:19 INFO - Running post-run listener: _resource_record_post_run 08:39:19 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 551071744; Read time: 0; Write time: 445340 08:39:19 INFO - TinderboxPrint: CPU usage
13.2% 08:39:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:39:19 INFO - TinderboxPrint: I/O write bytes / time
551,071,744 / 445,340 08:39:19 INFO - TinderboxPrint: CPU idle
8,275.8 (86.8%) 08:39:19 INFO - TinderboxPrint: CPU user
1,210.7 (12.7%) 08:39:19 INFO - TinderboxPrint: Swap in / out
0 / 0 08:39:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257073152; Read time: 0; Write time: 280164 08:39:19 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 293998592; Read time: 0; Write time: 165176 08:39:20 INFO - Running post-run listener: _upload_blobber_files 08:39:20 INFO - Blob upload gear active. 08:39:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:20 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:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:39:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:21 INFO - (blobuploader) - INFO - Done attempting. 08:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:25 INFO - (blobuploader) - INFO - Done attempting. 08:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:26 INFO - (blobuploader) - INFO - Done attempting. 08:39:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:26 INFO - Return code: 0 08:39:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7bbb666fb8a794485c7463b64a1251a3ad5d6a6a3758f5c46424ccf301ac8e7893908c1cc8c2b40da06c669104d967c88ab3909aae9b10c44a635a72cfade40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47225cf7af59afae52c26028314089fcf0015aa12e892323a66c33e8cf4dd6b42c9b7104650b3ca934ee7b2030a81a8560cc31176cd0cdbdeaf26f7734f2b338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5aa545df02d1a7e4ab2359573a9935d21da26017a1882f8f2913e2362f3c5afb8ce407664eed0665e7f1e598dae79efa2a6cad666751e6fd4a7ff59bce68b57a"} 08:39:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:26 INFO - Contents: 08:39:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7bbb666fb8a794485c7463b64a1251a3ad5d6a6a3758f5c46424ccf301ac8e7893908c1cc8c2b40da06c669104d967c88ab3909aae9b10c44a635a72cfade40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47225cf7af59afae52c26028314089fcf0015aa12e892323a66c33e8cf4dd6b42c9b7104650b3ca934ee7b2030a81a8560cc31176cd0cdbdeaf26f7734f2b338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5aa545df02d1a7e4ab2359573a9935d21da26017a1882f8f2913e2362f3c5afb8ce407664eed0665e7f1e598dae79efa2a6cad666751e6fd4a7ff59bce68b57a"} 08:39:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:26 INFO - Copying logs to upload dir... 08:39:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.664642 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-27 08:39:25.744507) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:25.747878) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7bbb666fb8a794485c7463b64a1251a3ad5d6a6a3758f5c46424ccf301ac8e7893908c1cc8c2b40da06c669104d967c88ab3909aae9b10c44a635a72cfade40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47225cf7af59afae52c26028314089fcf0015aa12e892323a66c33e8cf4dd6b42c9b7104650b3ca934ee7b2030a81a8560cc31176cd0cdbdeaf26f7734f2b338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5aa545df02d1a7e4ab2359573a9935d21da26017a1882f8f2913e2362f3c5afb8ce407664eed0665e7f1e598dae79efa2a6cad666751e6fd4a7ff59bce68b57a"} build_url:https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011261 build_url: 'https://queue.taskcluster.net/v1/task/EV3vy5CIShenTGFOr_6OMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7bbb666fb8a794485c7463b64a1251a3ad5d6a6a3758f5c46424ccf301ac8e7893908c1cc8c2b40da06c669104d967c88ab3909aae9b10c44a635a72cfade40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47225cf7af59afae52c26028314089fcf0015aa12e892323a66c33e8cf4dd6b42c9b7104650b3ca934ee7b2030a81a8560cc31176cd0cdbdeaf26f7734f2b338", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5aa545df02d1a7e4ab2359573a9935d21da26017a1882f8f2913e2362f3c5afb8ce407664eed0665e7f1e598dae79efa2a6cad666751e6fd4a7ff59bce68b57a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:25.773945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:25.774314) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467040510.349000-1216447208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:39:25.860877) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:39:25.861464) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 08:39:25.861948) ========= ========= Total master_lag: 0.18 =========