builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1468320268.77 results: success (0) buildid: 20160712004050 builduid: 9466084a6d5c4350bef37e735a4b09ec revision: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:28.769936) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:28.770579) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:28.771295) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:28.787223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:28.787528) ========= 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=0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 03:44:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.5M=0s 2016-07-12 03:44:29 (70.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147205 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:28.949304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:28.949690) ========= 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=0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017465 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:29.003093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:29.004200) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf --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=0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 03:44:29,976 truncating revision to first 12 chars 2016-07-12 03:44:29,977 Setting DEBUG logging. 2016-07-12 03:44:29,977 attempt 1/10 2016-07-12 03:44:29,977 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/632484723c99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 03:44:30,302 unpacking tar archive at: mozilla-aurora-632484723c99/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671684 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:29.691765) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:29.692136) ========= script_repo_revision: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:29.692690) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:29.693002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 03:44:29.703600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-12 03:44:29.704109) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:30 INFO - MultiFileLogger online at 20160712 03:44:30 in /builds/slave/test 03:44:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:44:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:30 INFO - {'append_to_log': False, 03:44:30 INFO - 'base_work_dir': '/builds/slave/test', 03:44:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:44:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:30 INFO - 'branch': 'Mozilla-Aurora', 03:44:30 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:30 INFO - 'config_files': ('talos/linux_config.py',), 03:44:30 INFO - 'default_actions': ('clobber', 03:44:30 INFO - 'read-buildbot-config', 03:44:30 INFO - 'download-and-extract', 03:44:30 INFO - 'populate-webroot', 03:44:30 INFO - 'create-virtualenv', 03:44:30 INFO - 'install', 03:44:30 INFO - 'run-tests'), 03:44:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:30 INFO - 'download_minidump_stackwalk': True, 03:44:30 INFO - 'download_symbols': 'ondemand', 03:44:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:30 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:30 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:30 INFO - 'installer_path': 'installer.exe', 03:44:30 INFO - 'log_level': 'info', 03:44:30 INFO - 'log_name': 'talos', 03:44:30 INFO - 'log_to_console': True, 03:44:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:30 INFO - 'opt_config_files': (), 03:44:30 INFO - 'pip_index': False, 03:44:30 INFO - 'sps_profile': False, 03:44:30 INFO - 'sps_profile_interval': 0, 03:44:30 INFO - 'suite': 'dromaeojs', 03:44:30 INFO - 'system_bits': '32', 03:44:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:30 INFO - 'title': 'talos-linux64-ix-017', 03:44:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:30 INFO - 'use_talos_json': True, 03:44:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:30 INFO - 'work_dir': 'build'} 03:44:30 INFO - ##### 03:44:30 INFO - ##### Running clobber step. 03:44:30 INFO - ##### 03:44:30 INFO - Running pre-action listener: _resource_record_pre_action 03:44:30 INFO - Running main action method: clobber 03:44:30 INFO - rmtree: /builds/slave/test/build 03:44:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:31 INFO - Running post-action listener: _resource_record_post_action 03:44:31 INFO - ##### 03:44:31 INFO - ##### Finished clobber step (success) 03:44:31 INFO - ##### 03:44:31 INFO - ##### 03:44:31 INFO - ##### Running read-buildbot-config step. 03:44:31 INFO - ##### 03:44:31 INFO - Running pre-action listener: _resource_record_pre_action 03:44:31 INFO - Running main action method: read_buildbot_config 03:44:31 INFO - Using buildbot properties: 03:44:31 INFO - { 03:44:31 INFO - "project": "", 03:44:31 INFO - "product": "firefox", 03:44:31 INFO - "script_repo_revision": "production", 03:44:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:44:31 INFO - "repository": "", 03:44:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:44:31 INFO - "buildid": "20160712004050", 03:44:31 INFO - "stage_platform": "linux64-pgo", 03:44:31 INFO - "basedir": "/builds/slave/test", 03:44:31 INFO - "nightly_build": "True", 03:44:31 INFO - "buildnumber": 601, 03:44:31 INFO - "slavename": "talos-linux64-ix-017", 03:44:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:44:31 INFO - "platform": "ubuntu64_hw", 03:44:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:44:31 INFO - "branch": "mozilla-aurora", 03:44:31 INFO - "repo_path": "releases/mozilla-aurora", 03:44:31 INFO - "revision": "632484723c99dc0ac9dcf11e25ec10e8fdb8dabf", 03:44:31 INFO - "pgo_build": "True", 03:44:31 INFO - "builduid": "9466084a6d5c4350bef37e735a4b09ec", 03:44:31 INFO - "slavebuilddir": "test" 03:44:31 INFO - } 03:44:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:44:31 INFO - Running post-action listener: _resource_record_post_action 03:44:31 INFO - ##### 03:44:31 INFO - ##### Finished read-buildbot-config step (success) 03:44:31 INFO - ##### 03:44:31 INFO - ##### 03:44:31 INFO - ##### Running download-and-extract step. 03:44:31 INFO - ##### 03:44:31 INFO - Running pre-action listener: _resource_record_pre_action 03:44:31 INFO - Running main action method: download_and_extract 03:44:31 INFO - mkdir: /builds/slave/test/build/tests 03:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:31 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:44:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:44:32 INFO - Downloaded 1361 bytes. 03:44:32 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:44:32 INFO - Using the following test package requirements: 03:44:32 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:32 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:44:32 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:44:32 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'jsshell-linux-x86_64.zip'], 03:44:32 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:44:32 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:44:32 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:44:32 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:44:32 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:44:32 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:44:32 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:44:32 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:44:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:32 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:33 INFO - Downloaded 24526838 bytes. 03:44:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:34 INFO - Return code: 0 03:44:34 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:34 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:44:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:44:36 INFO - Downloaded 24526838 bytes. 03:44:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:44:37 INFO - Return code: 0 03:44:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:37 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:44:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:44:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:44:38 INFO - Downloaded 10833369 bytes. 03:44:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:44:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:44:38 INFO - Return code: 0 03:44:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:44:38 INFO - https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:44:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:44:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:44:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:44:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:45:01 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:45:01 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 03:45:01 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 03:45:01 INFO - Server: 10.26.75.40 03:45:01 INFO - Address: 10.26.75.40#53 03:45:01 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 03:45:01 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 03:45:01 INFO - Address: 10.26.48.46 03:45:01 INFO - Return code: 0 03:45:01 INFO - retry: attempt #1 caught exception: 03:45:01 INFO - retry: Failed, sleeping 30 seconds before retrying 03:45:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 03:45:37 INFO - Downloaded 63640850 bytes. 03:45:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:45:37 INFO - mkdir: /builds/slave/test/properties 03:45:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:37 INFO - Contents: 03:45:37 INFO - build_url:https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:45:38 INFO - Running post-action listener: _resource_record_post_action 03:45:38 INFO - Running post-action listener: set_extra_try_arguments 03:45:38 INFO - ##### 03:45:38 INFO - ##### Finished download-and-extract step (success) 03:45:38 INFO - ##### 03:45:38 INFO - ##### 03:45:38 INFO - ##### Running populate-webroot step. 03:45:38 INFO - ##### 03:45:38 INFO - Running pre-action listener: _resource_record_pre_action 03:45:38 INFO - Running main action method: populate_webroot 03:45:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:45:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:45:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:45:38 INFO - '--tppagecycles', 03:45:38 INFO - '7'], 03:45:38 INFO - 'tests': ['tsvgm']}}, 03:45:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:45:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:45:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:45:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:45:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['damp', 'tps']}, 03:45:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'tests': ['damp', 'tps']}, 03:45:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['dromaeo_dom']}, 03:45:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['a11yr', 03:45:38 INFO - 'ts_paint', 03:45:38 INFO - 'tpaint', 03:45:38 INFO - 'sessionrestore', 03:45:38 INFO - 'sessionrestore_no_auto_restore', 03:45:38 INFO - 'tabpaint']}, 03:45:38 INFO - 'other-e10s': {'tests': ['a11yr', 03:45:38 INFO - 'ts_paint', 03:45:38 INFO - 'tpaint', 03:45:38 INFO - 'sessionrestore', 03:45:38 INFO - 'sessionrestore_no_auto_restore', 03:45:38 INFO - 'tabpaint']}, 03:45:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:45:38 INFO - 'ts_paint', 03:45:38 INFO - 'tpaint', 03:45:38 INFO - 'sessionrestore', 03:45:38 INFO - 'sessionrestore_no_auto_restore', 03:45:38 INFO - 'tabpaint']}, 03:45:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:45:38 INFO - 'ts_paint', 03:45:38 INFO - 'tpaint', 03:45:38 INFO - 'sessionrestore', 03:45:38 INFO - 'sessionrestore_no_auto_restore', 03:45:38 INFO - 'tabpaint']}, 03:45:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['a11yr', 03:45:38 INFO - 'ts_paint', 03:45:38 INFO - 'tpaint', 03:45:38 INFO - 'sessionrestore', 03:45:38 INFO - 'sessionrestore_no_auto_restore', 03:45:38 INFO - 'tabpaint']}, 03:45:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['a11yr', 03:45:38 INFO - 'ts_paint', 03:45:38 INFO - 'tpaint', 03:45:38 INFO - 'sessionrestore', 03:45:38 INFO - 'sessionrestore_no_auto_restore', 03:45:38 INFO - 'tabpaint']}, 03:45:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['tsvgx', 03:45:38 INFO - 'tsvgr_opacity', 03:45:38 INFO - 'tart', 03:45:38 INFO - 'tscrollx', 03:45:38 INFO - 'cart']}, 03:45:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:45:38 INFO - 'tsvgr_opacity', 03:45:38 INFO - 'tart', 03:45:38 INFO - 'tscrollx', 03:45:38 INFO - 'cart']}, 03:45:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'talos_options': ['--disable-e10s'], 03:45:38 INFO - 'tests': ['tp5o']}, 03:45:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'tests': ['tp5o']}, 03:45:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'talos_options': ['--disable-e10s', 03:45:38 INFO - '--xperf_path', 03:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:38 INFO - 'tests': ['tp5n']}, 03:45:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:38 INFO - 'talos_options': ['--xperf_path', 03:45:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:38 INFO - 'tests': ['tp5n']}}, 03:45:38 INFO - 'talos.zip': {'path': '', 03:45:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:45:38 INFO - Running post-action listener: _resource_record_post_action 03:45:38 INFO - ##### 03:45:38 INFO - ##### Finished populate-webroot step (success) 03:45:38 INFO - ##### 03:45:38 INFO - ##### 03:45:38 INFO - ##### Running create-virtualenv step. 03:45:38 INFO - ##### 03:45:38 INFO - Running pre-action listener: _resource_record_pre_action 03:45:38 INFO - Running main action method: create_virtualenv 03:45:38 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:45:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:38 INFO - Using real prefix '/usr' 03:45:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:39 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:41 INFO - Installing pip.................done. 03:45:41 INFO - Return code: 0 03:45:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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')]} 03:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:41 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:45:41 INFO - Using env: {'DISPLAY': ':0', 03:45:41 INFO - 'HOME': '/home/cltbld', 03:45:41 INFO - 'LANG': 'en_US.UTF-8', 03:45:41 INFO - 'LANGUAGE': 'en_US:en', 03:45:41 INFO - 'LOGNAME': 'cltbld', 03:45:41 INFO - 'MAIL': '/var/mail/cltbld', 03:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:41 INFO - 'MOZ_NO_REMOTE': '1', 03:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:41 INFO - 'NO_EM_RESTART': '1', 03:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:41 INFO - 'PWD': '/builds/slave/test', 03:45:41 INFO - 'SHELL': '/bin/bash', 03:45:41 INFO - 'SHLVL': '1', 03:45:41 INFO - 'TERM': 'linux', 03:45:41 INFO - 'TMOUT': '86400', 03:45:41 INFO - 'USER': 'cltbld', 03:45:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:41 INFO - '_': '/tools/buildbot/bin/python'} 03:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:45:41 INFO - Cleaning up... 03:45:41 INFO - Return code: 0 03:45:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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')]} 03:45:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:41 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:45:41 INFO - Using env: {'DISPLAY': ':0', 03:45:41 INFO - 'HOME': '/home/cltbld', 03:45:41 INFO - 'LANG': 'en_US.UTF-8', 03:45:41 INFO - 'LANGUAGE': 'en_US:en', 03:45:41 INFO - 'LOGNAME': 'cltbld', 03:45:41 INFO - 'MAIL': '/var/mail/cltbld', 03:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:41 INFO - 'MOZ_NO_REMOTE': '1', 03:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:41 INFO - 'NO_EM_RESTART': '1', 03:45:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:41 INFO - 'PWD': '/builds/slave/test', 03:45:41 INFO - 'SHELL': '/bin/bash', 03:45:41 INFO - 'SHLVL': '1', 03:45:41 INFO - 'TERM': 'linux', 03:45:41 INFO - 'TMOUT': '86400', 03:45:41 INFO - 'USER': 'cltbld', 03:45:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:41 INFO - '_': '/tools/buildbot/bin/python'} 03:45:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:41 INFO - Downloading/unpacking psutil>=3.1.1 03:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:43 INFO - Installing collected packages: psutil 03:45:43 INFO - Running setup.py install for psutil 03:45:43 INFO - building 'psutil._psutil_linux' extension 03:45:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:45:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:45:44 INFO - building 'psutil._psutil_posix' extension 03:45:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:45:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:45:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:44 INFO - Successfully installed psutil 03:45:44 INFO - Cleaning up... 03:45:44 INFO - Return code: 0 03:45:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:45:44 INFO - Using env: {'DISPLAY': ':0', 03:45:44 INFO - 'HOME': '/home/cltbld', 03:45:44 INFO - 'LANG': 'en_US.UTF-8', 03:45:44 INFO - 'LANGUAGE': 'en_US:en', 03:45:44 INFO - 'LOGNAME': 'cltbld', 03:45:44 INFO - 'MAIL': '/var/mail/cltbld', 03:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:44 INFO - 'MOZ_NO_REMOTE': '1', 03:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:44 INFO - 'NO_EM_RESTART': '1', 03:45:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:44 INFO - 'PWD': '/builds/slave/test', 03:45:44 INFO - 'SHELL': '/bin/bash', 03:45:44 INFO - 'SHLVL': '1', 03:45:44 INFO - 'TERM': 'linux', 03:45:44 INFO - 'TMOUT': '86400', 03:45:44 INFO - 'USER': 'cltbld', 03:45:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:44 INFO - '_': '/tools/buildbot/bin/python'} 03:45:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:46 INFO - Installing collected packages: mozsystemmonitor 03:45:46 INFO - Running setup.py install for mozsystemmonitor 03:45:46 INFO - Successfully installed mozsystemmonitor 03:45:46 INFO - Cleaning up... 03:45:46 INFO - Return code: 0 03:45:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:46 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:45:46 INFO - Using env: {'DISPLAY': ':0', 03:45:46 INFO - 'HOME': '/home/cltbld', 03:45:46 INFO - 'LANG': 'en_US.UTF-8', 03:45:46 INFO - 'LANGUAGE': 'en_US:en', 03:45:46 INFO - 'LOGNAME': 'cltbld', 03:45:46 INFO - 'MAIL': '/var/mail/cltbld', 03:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:46 INFO - 'MOZ_NO_REMOTE': '1', 03:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:46 INFO - 'NO_EM_RESTART': '1', 03:45:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:46 INFO - 'PWD': '/builds/slave/test', 03:45:46 INFO - 'SHELL': '/bin/bash', 03:45:46 INFO - 'SHLVL': '1', 03:45:46 INFO - 'TERM': 'linux', 03:45:46 INFO - 'TMOUT': '86400', 03:45:46 INFO - 'USER': 'cltbld', 03:45:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:46 INFO - '_': '/tools/buildbot/bin/python'} 03:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:46 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:48 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:48 INFO - warning: no files found matching '*.txt' 03:45:48 INFO - no previously-included directories found matching 'build' 03:45:48 INFO - no previously-included directories found matching 'dist' 03:45:48 INFO - no previously-included directories found matching '.git*' 03:45:49 INFO - Installing collected packages: jsonschema, functools32 03:45:49 INFO - Running setup.py install for functools32 03:45:49 INFO - warning: no files found matching '*.txt' 03:45:49 INFO - no previously-included directories found matching 'build' 03:45:49 INFO - no previously-included directories found matching 'dist' 03:45:49 INFO - no previously-included directories found matching '.git*' 03:45:49 INFO - Successfully installed jsonschema functools32 03:45:49 INFO - Cleaning up... 03:45:49 INFO - Return code: 0 03:45:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:45:49 INFO - Using env: {'DISPLAY': ':0', 03:45:49 INFO - 'HOME': '/home/cltbld', 03:45:49 INFO - 'LANG': 'en_US.UTF-8', 03:45:49 INFO - 'LANGUAGE': 'en_US:en', 03:45:49 INFO - 'LOGNAME': 'cltbld', 03:45:49 INFO - 'MAIL': '/var/mail/cltbld', 03:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:49 INFO - 'MOZ_NO_REMOTE': '1', 03:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:49 INFO - 'NO_EM_RESTART': '1', 03:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:49 INFO - 'PWD': '/builds/slave/test', 03:45:49 INFO - 'SHELL': '/bin/bash', 03:45:49 INFO - 'SHLVL': '1', 03:45:49 INFO - 'TERM': 'linux', 03:45:49 INFO - 'TMOUT': '86400', 03:45:49 INFO - 'USER': 'cltbld', 03:45:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:49 INFO - '_': '/tools/buildbot/bin/python'} 03:45:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:51 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:52 INFO - Downloading docopt-0.6.1.tar.gz 03:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:52 INFO - Running setup.py install for blobuploader 03:45:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:52 INFO - Running setup.py install for requests 03:45:52 INFO - Running setup.py install for docopt 03:45:52 INFO - Successfully installed blobuploader requests docopt 03:45:52 INFO - Cleaning up... 03:45:52 INFO - Return code: 0 03:45:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:52 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:52 INFO - Using env: {'DISPLAY': ':0', 03:45:52 INFO - 'HOME': '/home/cltbld', 03:45:52 INFO - 'LANG': 'en_US.UTF-8', 03:45:52 INFO - 'LANGUAGE': 'en_US:en', 03:45:52 INFO - 'LOGNAME': 'cltbld', 03:45:52 INFO - 'MAIL': '/var/mail/cltbld', 03:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:52 INFO - 'MOZ_NO_REMOTE': '1', 03:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:52 INFO - 'NO_EM_RESTART': '1', 03:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:52 INFO - 'PWD': '/builds/slave/test', 03:45:52 INFO - 'SHELL': '/bin/bash', 03:45:52 INFO - 'SHLVL': '1', 03:45:52 INFO - 'TERM': 'linux', 03:45:52 INFO - 'TMOUT': '86400', 03:45:52 INFO - 'USER': 'cltbld', 03:45:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:52 INFO - '_': '/tools/buildbot/bin/python'} 03:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:52 INFO - Running setup.py (path:/tmp/pip-3Fcy5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:52 INFO - Running setup.py (path:/tmp/pip-SmAhnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:53 INFO - Running setup.py (path:/tmp/pip-lmlPvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:53 INFO - Running setup.py (path:/tmp/pip-1haMi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:53 INFO - Running setup.py (path:/tmp/pip-20UId0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:53 INFO - Running setup.py (path:/tmp/pip-Zq1u_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:53 INFO - Running setup.py (path:/tmp/pip-9aR_BM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:53 INFO - Running setup.py (path:/tmp/pip-FKm7vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:53 INFO - Running setup.py (path:/tmp/pip-gcDr78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:53 INFO - Running setup.py (path:/tmp/pip-3oJpB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:53 INFO - Running setup.py (path:/tmp/pip-cHuQ63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:53 INFO - Running setup.py (path:/tmp/pip-PwYm1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:53 INFO - Running setup.py (path:/tmp/pip-zxyimt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:53 INFO - Running setup.py (path:/tmp/pip-DuHauA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:53 INFO - Running setup.py (path:/tmp/pip-vwUhOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:54 INFO - Running setup.py (path:/tmp/pip-XUCRkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:54 INFO - Running setup.py (path:/tmp/pip-HRQr6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:54 INFO - Running setup.py install for manifestparser 03:45:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Running setup.py install for mozcrash 03:45:54 INFO - Running setup.py install for mozdebug 03:45:54 INFO - Running setup.py install for mozdevice 03:45:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Running setup.py install for mozfile 03:45:54 INFO - Running setup.py install for mozhttpd 03:45:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Running setup.py install for mozinfo 03:45:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Running setup.py install for mozInstall 03:45:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:54 INFO - Running setup.py install for mozleak 03:45:55 INFO - Running setup.py install for mozlog 03:45:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:55 INFO - Running setup.py install for moznetwork 03:45:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:55 INFO - Running setup.py install for mozprocess 03:45:55 INFO - Running setup.py install for mozprofile 03:45:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:55 INFO - Running setup.py install for mozrunner 03:45:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:55 INFO - Running setup.py install for mozscreenshot 03:45:55 INFO - Running setup.py install for moztest 03:45:55 INFO - Running setup.py install for mozversion 03:45:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:55 INFO - Cleaning up... 03:45:55 INFO - Return code: 0 03:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:55 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:45:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:55 INFO - Using env: {'DISPLAY': ':0', 03:45:55 INFO - 'HOME': '/home/cltbld', 03:45:55 INFO - 'LANG': 'en_US.UTF-8', 03:45:55 INFO - 'LANGUAGE': 'en_US:en', 03:45:55 INFO - 'LOGNAME': 'cltbld', 03:45:55 INFO - 'MAIL': '/var/mail/cltbld', 03:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:55 INFO - 'MOZ_NO_REMOTE': '1', 03:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:55 INFO - 'NO_EM_RESTART': '1', 03:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:55 INFO - 'PWD': '/builds/slave/test', 03:45:55 INFO - 'SHELL': '/bin/bash', 03:45:55 INFO - 'SHLVL': '1', 03:45:55 INFO - 'TERM': 'linux', 03:45:55 INFO - 'TMOUT': '86400', 03:45:55 INFO - 'USER': 'cltbld', 03:45:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:55 INFO - '_': '/tools/buildbot/bin/python'} 03:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:56 INFO - Running setup.py (path:/tmp/pip-O1RClM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:56 INFO - Running setup.py (path:/tmp/pip-YjgKm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:56 INFO - Running setup.py (path:/tmp/pip-9wRHDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:56 INFO - Running setup.py (path:/tmp/pip-etg_HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:56 INFO - Running setup.py (path:/tmp/pip-OsI3d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:56 INFO - Running setup.py (path:/tmp/pip-tcDI4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:56 INFO - Running setup.py (path:/tmp/pip-vWXFF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:56 INFO - Running setup.py (path:/tmp/pip-Jarv4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:56 INFO - Running setup.py (path:/tmp/pip-oyK_vL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:56 INFO - Running setup.py (path:/tmp/pip-0GtjkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:56 INFO - Running setup.py (path:/tmp/pip-DuqmJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:56 INFO - Running setup.py (path:/tmp/pip-MFeJfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:57 INFO - Running setup.py (path:/tmp/pip-i4uiQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:57 INFO - Running setup.py (path:/tmp/pip-qVUzU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:57 INFO - Running setup.py (path:/tmp/pip-To8WRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:57 INFO - Running setup.py (path:/tmp/pip-5VoZIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:57 INFO - Running setup.py (path:/tmp/pip-Ozy62d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:59 INFO - Downloading blessings-1.6.tar.gz 03:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:59 INFO - Installing collected packages: blessings 03:45:59 INFO - Running setup.py install for blessings 03:45:59 INFO - Successfully installed blessings 03:45:59 INFO - Cleaning up... 03:45:59 INFO - Return code: 0 03:45:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:59 INFO - Reading from file tmpfile_stdout 03:45:59 INFO - Current package versions: 03:45:59 INFO - argparse == 1.2.1 03:45:59 INFO - blessings == 1.6 03:45:59 INFO - blobuploader == 1.2.4 03:45:59 INFO - docopt == 0.6.1 03:45:59 INFO - functools32 == 3.2.3-2 03:45:59 INFO - jsonschema == 2.5.1 03:45:59 INFO - manifestparser == 1.1 03:45:59 INFO - mozInstall == 1.12 03:45:59 INFO - mozcrash == 0.17 03:45:59 INFO - mozdebug == 0.1 03:45:59 INFO - mozdevice == 0.48 03:45:59 INFO - mozfile == 1.2 03:45:59 INFO - mozhttpd == 0.7 03:45:59 INFO - mozinfo == 0.9 03:45:59 INFO - mozleak == 0.1 03:45:59 INFO - mozlog == 3.2 03:45:59 INFO - moznetwork == 0.27 03:45:59 INFO - mozprocess == 0.22 03:45:59 INFO - mozprofile == 0.28 03:45:59 INFO - mozrunner == 6.11 03:45:59 INFO - mozscreenshot == 0.1 03:45:59 INFO - mozsystemmonitor == 0.3 03:45:59 INFO - moztest == 0.7 03:45:59 INFO - mozversion == 1.4 03:45:59 INFO - psutil == 3.1.1 03:45:59 INFO - requests == 1.2.3 03:45:59 INFO - wsgiref == 0.1.2 03:45:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:59 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:45:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:45:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:45:59 INFO - Using env: {'DISPLAY': ':0', 03:45:59 INFO - 'HOME': '/home/cltbld', 03:45:59 INFO - 'LANG': 'en_US.UTF-8', 03:45:59 INFO - 'LANGUAGE': 'en_US:en', 03:45:59 INFO - 'LOGNAME': 'cltbld', 03:45:59 INFO - 'MAIL': '/var/mail/cltbld', 03:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:59 INFO - 'MOZ_NO_REMOTE': '1', 03:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:59 INFO - 'NO_EM_RESTART': '1', 03:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:59 INFO - 'PWD': '/builds/slave/test', 03:45:59 INFO - 'SHELL': '/bin/bash', 03:45:59 INFO - 'SHLVL': '1', 03:45:59 INFO - 'TERM': 'linux', 03:45:59 INFO - 'TMOUT': '86400', 03:45:59 INFO - 'USER': 'cltbld', 03:45:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:59 INFO - '_': '/tools/buildbot/bin/python'} 03:45:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:45:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:45:59 INFO - Cleaning up... 03:46:00 INFO - Return code: 0 03:46:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:00 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:46:00 INFO - Using env: {'DISPLAY': ':0', 03:46:00 INFO - 'HOME': '/home/cltbld', 03:46:00 INFO - 'LANG': 'en_US.UTF-8', 03:46:00 INFO - 'LANGUAGE': 'en_US:en', 03:46:00 INFO - 'LOGNAME': 'cltbld', 03:46:00 INFO - 'MAIL': '/var/mail/cltbld', 03:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:00 INFO - 'MOZ_NO_REMOTE': '1', 03:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:00 INFO - 'NO_EM_RESTART': '1', 03:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:00 INFO - 'PWD': '/builds/slave/test', 03:46:00 INFO - 'SHELL': '/bin/bash', 03:46:00 INFO - 'SHLVL': '1', 03:46:00 INFO - 'TERM': 'linux', 03:46:00 INFO - 'TMOUT': '86400', 03:46:00 INFO - 'USER': 'cltbld', 03:46:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:00 INFO - '_': '/tools/buildbot/bin/python'} 03:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:46:00 INFO - Cleaning up... 03:46:00 INFO - Return code: 0 03:46:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:00 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 0x7fd5d964ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1563350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, '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': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:46:00 INFO - Using env: {'DISPLAY': ':0', 03:46:00 INFO - 'HOME': '/home/cltbld', 03:46:00 INFO - 'LANG': 'en_US.UTF-8', 03:46:00 INFO - 'LANGUAGE': 'en_US:en', 03:46:00 INFO - 'LOGNAME': 'cltbld', 03:46:00 INFO - 'MAIL': '/var/mail/cltbld', 03:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:00 INFO - 'MOZ_NO_REMOTE': '1', 03:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:00 INFO - 'NO_EM_RESTART': '1', 03:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:00 INFO - 'PWD': '/builds/slave/test', 03:46:00 INFO - 'SHELL': '/bin/bash', 03:46:00 INFO - 'SHLVL': '1', 03:46:00 INFO - 'TERM': 'linux', 03:46:00 INFO - 'TMOUT': '86400', 03:46:00 INFO - 'USER': 'cltbld', 03:46:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:00 INFO - '_': '/tools/buildbot/bin/python'} 03:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:00 INFO - Downloading/unpacking flake8 03:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:46:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:46:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:46:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:03 INFO - no previously-included directories found matching 'docs/_build' 03:46:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:46:03 INFO - Running setup.py install for pep8 03:46:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:03 INFO - no previously-included directories found matching 'docs/_build' 03:46:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:46:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:46:03 INFO - Cleaning up... 03:46:03 INFO - Return code: 0 03:46:03 INFO - Running post-action listener: _resource_record_post_action 03:46:03 INFO - Running post-action listener: _start_resource_monitoring 03:46:03 INFO - Starting resource monitoring. 03:46:03 INFO - ##### 03:46:03 INFO - ##### Finished create-virtualenv step (success) 03:46:03 INFO - ##### 03:46:03 INFO - ##### 03:46:03 INFO - ##### Running install step. 03:46:03 INFO - ##### 03:46:03 INFO - Running pre-action listener: _resource_record_pre_action 03:46:03 INFO - Running main action method: install 03:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:03 INFO - Reading from file tmpfile_stdout 03:46:03 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:46:03 INFO - Reading from file tmpfile_stdout 03:46:03 INFO - Output received: 03:46:03 INFO - Usage: mozinstall [options] installer 03:46:03 INFO - Options: 03:46:03 INFO - -h, --help show this help message and exit 03:46:03 INFO - -d DEST, --destination=DEST 03:46:03 INFO - Directory to install application into. [default: 03:46:03 INFO - "/builds/slave/test"] 03:46:03 INFO - --app=APP Application being installed. [default: firefox] 03:46:03 INFO - mkdir: /builds/slave/test/build/application 03:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:46:19 INFO - Reading from file tmpfile_stdout 03:46:19 INFO - Output received: 03:46:19 INFO - /builds/slave/test/build/application/firefox/firefox 03:46:19 INFO - Running post-action listener: _resource_record_post_action 03:46:19 INFO - ##### 03:46:19 INFO - ##### Finished install step (success) 03:46:19 INFO - ##### 03:46:19 INFO - ##### 03:46:19 INFO - ##### Running run-tests step. 03:46:19 INFO - ##### 03:46:19 INFO - Running pre-action listener: _resource_record_pre_action 03:46:19 INFO - Running main action method: run_tests 03:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:19 INFO - Python 2.7.3 03:46:19 INFO - Return code: 0 03:46:19 INFO - grabbing minidump binary from tooltool 03:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:19 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 0x15f21c0>, '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 0x15f30c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:46:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:46:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:46:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:19 INFO - Return code: 0 03:46:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:46:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:46:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:46:20 INFO - Return code: 0 03:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:46:20 INFO - Using env: {'DISPLAY': ':0', 03:46:20 INFO - 'HOME': '/home/cltbld', 03:46:20 INFO - 'LANG': 'en_US.UTF-8', 03:46:20 INFO - 'LANGUAGE': 'en_US:en', 03:46:20 INFO - 'LOGNAME': 'cltbld', 03:46:20 INFO - 'MAIL': '/var/mail/cltbld', 03:46:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:20 INFO - 'MOZ_NO_REMOTE': '1', 03:46:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:20 INFO - 'NO_EM_RESTART': '1', 03:46:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:20 INFO - 'PWD': '/builds/slave/test', 03:46:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:20 INFO - 'SHELL': '/bin/bash', 03:46:20 INFO - 'SHLVL': '1', 03:46:20 INFO - 'TERM': 'linux', 03:46:20 INFO - 'TMOUT': '86400', 03:46:20 INFO - 'USER': 'cltbld', 03:46:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333', 03:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:20 INFO - '_': '/tools/buildbot/bin/python'} 03:46:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:46:20 INFO - mozversion application_buildid: 20160712004050 03:46:20 INFO - mozversion application_changeset: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf 03:46:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:46:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:20 INFO - mozversion application_name: Firefox 03:46:20 INFO - mozversion application_remotingname: firefox-dev 03:46:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:20 INFO - mozversion application_vendor: Mozilla 03:46:20 INFO - mozversion application_version: 49.0a2 03:46:20 INFO - mozversion platform_buildid: 20160712004050 03:46:20 INFO - mozversion platform_changeset: 632484723c99dc0ac9dcf11e25ec10e8fdb8dabf 03:46:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:20 INFO - mozversion platform_version: 49.0a2 03:46:20 INFO - using testdate: 1468320380 03:46:20 INFO - actual date: 1468320380 03:46:20 INFO - starting webserver on 'localhost:49552' 03:46:20 INFO - SUITE-START | Running 2 tests 03:46:20 INFO - TEST-START | dromaeo_css 03:46:20 INFO - operating with platform_type : linux_ 03:46:20 INFO - Initialising browser for dromaeo_css test... 03:46:20 INFO - TEST-INFO | started process 9912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJ5IPR/profile http://localhost:49552/getInfo.html) 03:46:24 INFO - PROCESS | 9912 | __metrics Screen width/height:1600/1200 03:46:24 INFO - PROCESS | 9912 | colorDepth:24 03:46:24 INFO - PROCESS | 9912 | Browser inner width/height: 1024/697 03:46:24 INFO - PROCESS | 9912 | __metrics 03:46:24 ERROR - PROCESS | 9912 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:46:25 INFO - TEST-INFO | 9912: exit 0 03:46:25 INFO - Browser initialized. 03:46:25 INFO - Running cycle 1/1 for dromaeo_css test... 03:46:25 INFO - TEST-INFO | started process 10006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIJ5IPR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:37 INFO - PROCESS | 10006 | RSS: Main: 145547264 03:46:37 INFO - PROCESS | 10006 | 03:47:28 INFO - PROCESS | 10006 | 1468320448814 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:49:36 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:49552/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49552/tests/dromaeo/cssquery-ext.html) 03:49:37 INFO - PROCESS | 10006 | RSS: Main: 254676992 03:49:37 INFO - PROCESS | 10006 | 03:52:40 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:49552/tests/dromaeo/cssquery-ext.html (next: http://localhost:49552/tests/dromaeo/cssquery-jquery.html) 03:52:40 INFO - PROCESS | 10006 | RSS: Main: 226373632 03:52:40 INFO - PROCESS | 10006 | 03:55:42 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:49552/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49552/tests/dromaeo/cssquery-mootools.html) 03:55:43 INFO - PROCESS | 10006 | RSS: Main: 229740544 03:55:43 INFO - PROCESS | 10006 | 03:58:45 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:49552/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49552/tests/dromaeo/cssquery-prototype.html) 03:58:45 INFO - PROCESS | 10006 | RSS: Main: 219234304 03:58:45 INFO - PROCESS | 10006 | 04:01:48 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:49552/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49552/tests/dromaeo/cssquery-yui.html) 04:01:49 INFO - PROCESS | 10006 | RSS: Main: 215400448 04:01:49 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | Cycle 1(1): loaded http://localhost:49552/tests/dromaeo/cssquery-yui.html (next: http://localhost:49552/tests/dromaeo/cssquery-dojo.html) 04:04:51 INFO - PROCESS | 10006 | RSS: Main: 259928064 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | __start_tp_report 04:04:51 INFO - PROCESS | 10006 | _x_x_mozilla_page_load 04:04:51 INFO - PROCESS | 10006 | _x_x_mozilla_page_load_details 04:04:51 INFO - PROCESS | 10006 | |i|pagename|runs| 04:04:51 INFO - PROCESS | 10006 | |0;dojo.html;3265.673432656735;3288.210829400943;3296.3077753671737;3316.7512436567263;3329.167708072982;5311.78752849886;5402.297701298826;5415.48552887475;5427.674339539631;5428.430014848438;5410.756515956781;5499.532539734118;5501.449855014496;5508.9724551377185;5510.1459273812625;4909.214525675892;4985.925211121827;5006.54941055305;5045.318881950926;5066.6706664066905;4882.316475693388;5004.399472063357;5039.571636410909;5046.066477701637;5046.6719663221775;4933.901321973558;4940.209566469365;4988.575971042465;4998.600111991032;5016.749162541876;5058.392992840846;5070;5077.492250774893;5079.390473143209;5106.259592359106;4851.951480485185;4869.829555965524;4924.409070911478;4983.377077865267;4997.800087996476;5231.712255825928;5241.344831896013;5248.527632513054;5284.418713941502;5289.86775330616;5801.82594522165;5843.561732870052;5845.444682755132;5848.444397782204;5848.619839710448;5847.707614619252;5879.265091863517;5895.35151133375;5906.409359064102;5972.104184372335;5530.751116199781;5575.024370735106;5576.163575463713;5576.470235327719;5581.358143813472;5688.516476099495;6045.546584006217;6046.486048685823;6063.696815159225;6065.181200537959;5704.942950570441;5759.971200143972;5762.193292938992;5862.736176872051;5868.882622347529;5924.407559244041;5929.14027466015;5930.8813823723285;5949.464548190684;5962.165296858443;5612.943870561242;5776.393478684761;5879.52963762898;5885.323187833454;5898.852528686732;5800.53595712342;5878.059510478303;5878.911816322759;5879.147523609053;5915.704214789243;4546.909061818811;4553.089382123589;4554;4554.4990051094355;4574.702644328108;3944.9211015780097;3978.1645854370904;4050.2911990401562;4081.6530594899173;4117.300058989979;5612.298462692163;5617.775288988395;5627.606067575231;5636.2391077204875;5638.830835074954;5902.3507414184405;5919.763209471573;5920.911186332122;5921.61509501881;5953.553483488669;5348.03735327637;5423.105187643994;5464.781408743605;5472.425395333512;5550.777968881281;4944.060628480577;4956.776945037482;4958.826441074545;4959.2809042688605;4963.801447942042;6024.759009639565;6033.064874944303;6034.2155519782145;6034.577579569388;6034.668093254913;5678.801241956512;5827.3881242470625;5879.823605291848;5898.1152827076285;5955.821325360246;6199.752009919553;6218.81343559694;6227.06594010902;6229.065640154013;6230.937690623217;5539.861503462445;5821.738021788945;5836.737346819318;5842.152887831156;5844.561657875762;5786.3056433228285;5799.710014499343;5847.94152058491;5883.411658834082;5883.529317654663;5724.227229323988;5755.165501002415;5761.2222349983895;5763.4812866842185;5765.1928729977;5467.808626698046;5661.745221464962;5736.799212027559;5750.884982300414;5760.567957403127;5621.297337832771;5695.743691533974;5695.914561281501;5696.772129114789;5745.425457454221;5802.854928626818;5832.300123985149;5857.765689372548;5858.414158584107;5861.677607731615;5438.755256013568;5585.860353491195;5659;5712.571557133148;5721.942780572141 04:04:51 INFO - PROCESS | 10006 | |1;ext.html;595.919550860634;640.356441776015;647.2782847125455;652.598651829125;669.2203582826008;32729.18177045572;44663.33005004928;45475.317870231935;45531.31703024457;45542;48527;48746;48922;48935.755321223434;49026.754866225616;8240.917590824105;9036.141566551167;9168.26653867689;9172.770680733001;9178.586963586622;10529.578816847355;10793.244472886901;10798.946005270001;11128.332300061982;11150.665480035612;10865.293755905881;11000.944995275013;11003.669889903316;11013.118950483982;11014.284071535365;8386.329093672492;10624.893751062467;10851.240413171081;10884.61903833366;10952.780944381107;10368.533415996299;10884.346939183675;10900.454977251105;10902.291351062155;10909.781804363947;46070;46721;46756.29865551985;46761.064778704575;46848.29727554089;3799;3805.429185622151;3821.3503704370323;3900.4539364488996;4343.913121737548;34855.4771678425;35530.46704299412;35548.46677299843;35624.10939726502;35739.82130089359;4656.278276867091;4712.104700107003;4754.144254034307;4811.182099043136;4878.0975519529;286006;289774;382036;383467;383989;69559;70284;70312.64843675749;70364;70390.29609703837;40385;41154.38268425976;41247.525148491186;43483.78258108689;43539.56460435355;16204.270807813677;16261.18694065292;16379.59051023734;16384.098874561776;16389.262483188286;11063.446827658585;11541;11745.412729363497;12132.393380331125;12167.513299468099;22348.441288967904;22355.888220558794;22360.664590031163;22361.44096397603;22476.55046899053;7697.538147711155;7708.537487750753;7911.564863932539;7969.481983671043;8231.34149268057;1085.9565617375374;1102.862142232221;1132.8867113288604;1177.2289150606366;1194.6475789642077;33823.32353352919;34429;34518.309633807185;34637.480437793456;34902.476462853076;1154.5035634677001;1239.3493415956696;1260.7667581497453;1275.3878138493576;1310.6199202231246;17856.910715446338;18152.364667236583;18221.908890455463;18242.45272641823;18321.63356732858;680837;682726;684112;687044;688999;63973.36026639674;64228;64552.35447645558;64573.354266457674;64652.35347646557;1318.2288361308742;1418.2412409361148;1422.665673566711;1422.9612382960497;1461.868431841118;33864.49203262002;36070.8196459016;36148.09629759277;36200;36493.27013459663;55041.1743823835;55395.723021384634;55456;55472;55577.49901254534;440011;442324;442579;442907;444327;27470.862645686644;30358.84820575883;30908.536371954888;31249.375012499167;32520.83739581287;51521.7423912878;52525.47474525359;52934;53003.152811589636;53036;42688;43201.13597728091;43571.34642980421;43748;44253.11493770171;42192.578074220095;42479.3628095585;42565;42989.14021719611;43228;43219.56780432155;43956;44267.11465770602;44726.10547788961;44881.55118448774;36900.446493303156;38140.70777496023;38822.4176637345;39079.21841563096;39351.80324098361;28384.290392740346;29993.4001319968;30884.30136342433;30952.53571196479;31416.214594634403 04:04:51 INFO - PROCESS | 10006 | |2;jquery.html;403.63672694574876;409.95080590329167;413.6360003197186;414.8983499042734;429.2809544013778;18521.536961575966;19050.809491905078;20035.098420571074;20063.699044514327;20089.29687460939;15882.920585397085;16295.429659961903;16303.184840757944;16698.916505417455;16849.74725379117;5635.971820140904;5747.856303592402;5835.795747148851;5837.9124313135335;5843.678597677126;5587.078132108198;5810.82567522975;5822.9417705822825;5825.79609713658;5849.093390524476;5536.916946245809;5728.398518155596;5773.1051686988585;5775.306963164426;5778.82663520093;5525.033119204123;5542.418046105182;5739.885202295952;5745.741441635116;5768.42315768424;4892.119418504668;5144.4083930348115;5153.948460515422;5154.226865970097;5158.226266060084;22414.775852241433;22501.549969000527;22706.772932270796;23068.53862922749;23118.42203944915;2254.763249858774;2478.083109249571;2558.3604098975256;2995.955060674092;3135.7961732487543;10042.096211341015;10053.648122315684;10053.899461005369;10067.697969060866;10071.446070466121;1961.0782932021928;2061.752589689247;2087.2277257414703;2092.3199960013058;2105.1053302346595;56144.43855561433;82204.58897705533;83517.58241208816;83736.58131709302;84382;11437.714057148638;11501.942490287494;11621.825672614917;11689.532418703327;11804.291742495478;13230.404631791593;16242.269097890623;16318.102504362136;16339.673206536041;16357.836421635631;7580.54516728987;7876.527408355517;7900.881486777703;7934.761957141295;8086.353091752646;7461.1419686735635;7504.437167212481;7612.581308028;7757.961210193913;7828.060632724109;5013.248012798036;5042.268871013683;5047.268146118792;5088.414832294334;5122.87192820175;2047.6621357476147;2076.512019675375;2095.9161633534486;2110.683397490389;2118.8728676279475;947.9431234125974;1034.9534270957824;1051.6582110813863;1055.904968552834;1129.8870112988636;18780.530486737942;18833.340833070775;19114.330998415266;19194.808051919303;19680.90159549193;1020.5713600287897;1027.0448482910965;1045.7856139491387;1049.3284298049255;1089.536946797608;10405.947970260251;10687.198460115367;10770.623028193975;10780.40707761065;10793.190510711727;561969;580547;587454;590335;614509;81439.99999999882;83829;100717.49641251747;100879.49560252299;101239;1051.153821173947;1090.1278976818514;1092.3118435385657;1093.3330668292335;1103.9889601103887;17208.741868871726;17245.22396492136;17246.741298880275;17474.38839640657;17705;36997.26005479929;38375.616243837205;39265.607343926196;39446.2110757789;43612.56387436212;53502.73248633732;53760.46239537711;55150;62227.377726222156;62561.37438625556;8413.915860841558;8858.15847494487;8904.510251936206;8939.195472407515;9089.045650206634;9663.951680241555;12786.872131278567;13342.26617536006;13464.596062118153;13530.458781649018;11342.943285283522;11649.534018639159;11679.76640467203;11838.585649502571;12104.45529951172;11526.366049867338;11678.941605291919;11858.288502689866;11900.821487677518;11939.880601193878;11472.196946213686;11939;11944.64166075019;12121.878781212075;12423.565175218824;8753.737387878375;8760.4305720128;8761.211490965843;8793.14613975145;9013.053629369084;8939.418937769024;11041.779164416506;11420.714482138013;11705.414729263674;11836.053115750547 04:04:51 INFO - PROCESS | 10006 | |3;mootools.html;1361.2036958379347;1539.6458814472667;1585.5243426971908;1767.672980498607;1899.8860068395898;8943.060978597252;9346.439213647185;9368.906310936889;9577.138057574817;9587.376820506663;9353.67262145825;9560.76098097548;9565.282603804708;9567.330286879922;9567.904320956806;2141.625215587274;2425.818063645225;2459.102427613926;2491.6137998610243;2526.2926380613367;2470.703515578133;2503.912363067293;2507.6865391826022;2514.446821699223;2514.5222407742563;2434.1480481831395;2456.3736247256925;2461.5569197544437;2462.655228268044;2464.728879823227;2121.5226574020876;2398.6761787158684;2466.198485492222;2476.257122863152;2494.014864128659;2415.239199652104;2420.261820144855;2421.3099266708905;2431.9878400607886;2472.678551788274;9342.906570934272;9366.20387267083;9391.953040234823;9417.529123543864;9422.057794220591;5287.154055351164;5424.186372044185;5429.619926605139;5433.483819037185;5436.456354364572;3453.5855697316483;3550.91122721934;3586.7668601540818;3591.8742844000335;3620.601733809279;1157.953681852725;1165.452237448398;1184.2184158455377;1198.964031079069;1204.7048473124141;13146.934265328613;13158.934205328913;13160.802587961189;13238.073334866467;13293.601191964257;5002.349694539686;5074.594032477393;5085.186370180753;5091.159958606789;5095.24214146119;11263.26788758728;11327.376994265394;11347.943260283646;11351.772964540663;11356.716082098013;4759.4764575896625;5340.973295133577;5349.973250133725;5352.57179425645;5355.7054362009685;4766.428028636586;4906.1659517881335;4913.287573301851;4953.306537084811;4961.603071754251;4255.212785634668;4257.318828987347;4301.677374196947;4469.776511174493;4495.640348772155;1336.8061631063442;1341.47011930287;1347.6496111011209;1353.7427888701313;1392.491740514725;990.3810118675827;1002.5588740953957;1017.572619499797;1023.1150055202345;1030.7062487191115;6332.303446620868;6334.429901308904;6371.585846919936;6379.393957574023;6405.615663060231;488.9144399730033;491.92867034280545;493.0976313346639;496.74417674897455;506.4707380787086;4197.097624010852;4260.531341552427;4349.151915376471;4372.366006928977;4410.845620403335;11278.774424511465;11593.88406115928;11620.418979051014;11643.06855451562;11648.53405863773;11213.271137376045;11600.825987610193;11632.418379081013;11999.04007679401;12015.579454719043;8721.825563488695;8816.471011739317;8885.733427997042;8898.288136948899;8943.508107054175;6337.397947195009;6493.350664933469;6547.672616369257;6605.57063790852;6677;10542.789144217226;10898.455077246264;11107.222494425312;11117;11157.218994670295;10910.127189824954;10976.615818446317;11224.494897729459;11226.101911847196;11259.155563332946;7796.259355361231;8733.170348816851;8958.372913895964;9055.411398259092;9234.815303694022;9279.72160835176;9291.163795258459;9305.255579553484;9347.112024357675;9358.4384936904;7990.081140668665;8181.590920454072;8204.876926845982;8292.419530633038;8440.535770532433;7724.150343462103;7800.375969922506;7992.16082311349;8030.598470076589;8055.798605034921;7435.8884616731875;7585.658645361083;7591.278828511283;7628.427867909818;7743.109542402696;5639.351474580476;5675.545956323567;5703.258576385043;5741.483266506035;5960.165576819162;5455.454454554513;5484.424135465719;5563.443655634404;5666.9716651416475;5698.743556540048 04:04:51 INFO - PROCESS | 10006 | |4;prototype.html;343.42819206021977;343.88651744924164;351.78716876289843;354.62586970745866;356.17190033172847;5443.210734443508;5490.780368785254;5522.66863988161;5539.584531160164;5558.555315574755;5370.650907691007;5420.891582168354;5445.156000819869;5445.237666726662;5445.673259604417;3916;4074.022234663674;4232.809523571446;4259.3814350546745;4306.997246280479;4185.727927684691;4227.661787057028;4243.745375277478;4281.314989601664;4301.462317210348;4062.8577999770014;4238;4261.637760790321;4268.807903644328;4309.784510774449;4137.696625562953;4248.681348898845;4265.38151967966;4272.487301523806;4289.356596510517;3763.1344790698017;3770.5286839145106;3794.3739283018267;3794.715396345285;3808.124131449782;5220.791168353261;5250.8687282817855;5255.816046438395;5274.235235890775;5296.708681022542;4873.951260487421;4889.8777530561665;4901.093297739894;4907.460179380265;4931.309616653672;5381.946180538183;5416.620836541444;5628.915566266509;5641.548676105943;5720.513756330717;4055.1484188320487;4122.443470131524;4131.8967025824295;4154.667626589866;4172;5840.153177789197;5847.678377689225;5864.384239654817;5874.179004508574;5888.704485013291;3932.980335098306;4110.615842811162;4118.567550407224;4123.505179378494;4131.29767939451;4167.729097608646;4180.958190418118;4184.351425528987;4187.471572875939;4197.307444271661;4804.447488538863;4812.109759694467;4824.34871292371;4826.155422800995;4840.903181936342;5512.200730893998;5662.103195429495;5698.800541981011;5710.343310519261;5718.599698021182;1446.7341076558012;1454.0911930043724;1460.7443697352921;1462.8390877003521;1463.4852927220277;925.7916968682127;941.1435593609782;950.5912457643279;957.7031120352713;960.3085778239656;4999.400191938545;5022.347094877716;5044.646874718735;5051;5056.595472362203;5126.461721519261;5144.511271429208;5158.097332966716;5161.74191290434;5182.24857395683;4674.322223277673;5024.166179344513;5040.218766091261;5041.445441001487;5078.13671675816;2695.9730402696114;2754.325190328382;2778;2786.5680819473014;2788.721127887195;5402.8919421611345;5450.727463626803;5519.227308176858;5544.364412498323;5549.751305956208;5025.3718285214345;5291.3385826771655;5356.544693701079;5362.399236370357;5378.1663842104535;5473.425290344457;5878.147668588031;5943.673097979653;6086.604370715978;6092;5747.3103227612955;5780.855478613068;5828.184054232495;5837.007708689448;5860.736266868086;5509.283793106871;5709.287213835915;5724.484796368347;5737.713114344349;5747.166660834072;6000.729967151576;6010.579259451796;6032.607880487754;6033.42682445167;6055.1220073090035;4152.979235103805;4168.374743788456;4187.288161012696;4192.0777428965575;4194.769287689206;5552.7223638818705;5875.441833025856;5891.528677705859;5926.525877929842;5932.851678708067;5726.79956201531;5759.424057594207;5767.913481297868;5785.218995435731;5795.710214489174;5573.21974923503;5738.454846789548;5748.6838223898085;5769.134629805562;5804.593678442638;5643.5044713151865;5644.209810626434;5650.35020972577;5667.263255776723;5675.31896172462;5735.856603584777;5767.385132163001;5791.9131213031;5804.767809287581;5835.503982161394;5395.676259424447;5628.212050313042;5655.802046928502;5674.517665998436;5692.743826527899 04:04:51 INFO - PROCESS | 10006 | |5;yui.html;779.7270955165693;783.7609529093628;822.7737372222638;827.3794654009492;896.3725392225435;15362.769558456617;15611.765823512656;15620;15657.765133522978;16116.355345786169;14657.193854338033;14765.557033289018;14775.704485910275;14785.926070369633;14787.630309242275;707.9008938748553;814.6293436486415;833.4999000599637;844.6072576252042;849.5285116760195;827.606886728805;836.8828364029041;837.8826964224983;839.9664013439456;840.8528507511161;896.0591379052001;896.4800415758876;896.789254525186;897.3135551303258;897.4570384917129;723.9384652304534;865.6148014133713;888.1340692824444;890.496869268861;891.9554022298859;660.4023358860192;661.1240106858384;661.5898143151229;662.1392190152782;663.4592806862391;14564.85435145656;14576.344064517121;14595.708085838223;14648.853511464855;14662.633434164125;14578.343974521173;14856.851431485655;15029.699406011929;15185.272103578536;15422;13329.733405331936;13525.526606568723;13577.389017494237;13805.51680691181;13847.446102155902;3998;4113.115680128757;4129.463169787939;4758.286257061434;4789.521047895182;67445;68317;68452.6577367115;77622.61188694077;78074.21925780726;11718.824217636742;11859.762804743857;11914.642560723192;12046.156769026084;12056.216345937486;19431;19497.220111195395;19508.80491195098;19568.608627827365;20157.395278141677;9188.127127922837;9407.29445291606;9450;9509.429434233969;9698.224142068617;5027.597792176617;5049.848504544796;5110.642255042186;5168.431472538018;5170.560502357342;3878.8060596970604;3974.125692347679;3974.324364857981;3977.622125898035;3997.9805149687227;623.8253289079065;627.1502114634695;699.0667458942268;707.3492387003865;708.5146674527965;658.6180015590945;718.5461648470415;781.6560713286136;792.3502727763179;807.2049031703767;10469.482635301603;10599.947000265103;10892;11008.834867476995;11140.164487663458;732.6849454734408;763.713607397226;792.2829838995718;802.1296892871184;820.6922404098464;4589.33454649074;4699.365585645963;4716.481187069419;4720.740359280273;4785.1625965455905;112000.43999780112;112218.43890780657;114244.42877785557;120827;121170;74205;98105.50947245218;98204.50897745609;99708;101678;90723;91033.54483227673;91039.54480227556;91358.99999999868;91492.54253728822;9584.66453674118;9619.470929098967;9634.855477167988;9734.464604446823;9742.464164471023;38863.61136388713;43852.780736096116;44148;47024;55406;74423.62788186024;75728;75978.62010690132;76252;77259.61370193113;13723.1079979801;13730.65673358174;13866.791998119834;14328.14031158134;14437.927810361301;15729.606759830638;15862.841371586137;16071.67856642884;16588.58528536748;16923.66152676915;13523.864761352654;13704.314784260549;13905.887528997453;13945.651358716113;14332.57002289933;13922.582322530341;13936.442542298195;14304.713905722036;15034.924825375803;15098.169600672069;14429.42282308696;14732.705345892808;14734.26328683583;14879.628009299855;14979.850201497846;11066.336019838835;11399.601013964471;11483.483243253906;11515.30908145514;11674.299542027506;11646.883531164918;12232.004040364058;12295.938520307342;12424.627261182179;12478.313692746986 04:04:51 INFO - PROCESS | 10006 | __end_tp_report 04:04:51 INFO - PROCESS | 10006 | __start_cc_report 04:04:51 INFO - PROCESS | 10006 | _x_x_mozilla_cycle_collect,909 04:04:51 INFO - PROCESS | 10006 | __end_cc_report 04:04:51 INFO - PROCESS | 10006 | __startTimestamp1468321491874__endTimestamp 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | ------- Summary: start ------- 04:04:51 INFO - PROCESS | 10006 | Number of tests: 6 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | [#0] dojo.html Cycles:165 Average:5454.01 Median:5661.75 stddev:609.13 (10.8%) stddev-sans-first:586.31 04:04:51 INFO - PROCESS | 10006 | Values: 3265.7 3288.2 3296.3 3316.8 3329.2 5311.8 5402.3 5415.5 5427.7 5428.4 5410.8 5499.5 5501.4 5509.0 5510.1 4909.2 4985.9 5006.5 5045.3 5066.7 4882.3 5004.4 5039.6 5046.1 5046.7 4933.9 4940.2 4988.6 4998.6 5016.7 5058.4 5070.0 5077.5 5079.4 5106.3 4852.0 4869.8 4924.4 4983.4 4997.8 5231.7 5241.3 5248.5 5284.4 5289.9 5801.8 5843.6 5845.4 5848.4 5848.6 5847.7 5879.3 5895.4 5906.4 5972.1 5530.8 5575.0 5576.2 5576.5 5581.4 5688.5 6045.5 6046.5 6063.7 6065.2 5704.9 5760.0 5762.2 5862.7 5868.9 5924.4 5929.1 5930.9 5949.5 5962.2 5612.9 5776.4 5879.5 5885.3 5898.9 5800.5 5878.1 5878.9 5879.1 5915.7 4546.9 4553.1 4554.0 4554.5 4574.7 3944.9 3978.2 4050.3 4081.7 4117.3 5612.3 5617.8 5627.6 5636.2 5638.8 5902.4 5919.8 5920.9 5921.6 5953.6 5348.0 5423.1 5464.8 5472.4 5550.8 4944.1 4956.8 4958.8 4959.3 4963.8 6024.8 6033.1 6034.2 6034.6 6034.7 5678.8 5827.4 5879.8 5898.1 5955.8 6199.8 6218.8 6227.1 6229.1 6230.9 5539.9 5821.7 5836.7 5842.2 5844.6 5786.3 5799.7 5847.9 5883.4 5883.5 5724.2 5755.2 5761.2 5763.5 5765.2 5467.8 5661.7 5736.8 5750.9 5760.6 5621.3 5695.7 5695.9 5696.8 5745.4 5802.9 5832.3 5857.8 5858.4 5861.7 5438.8 5585.9 5659.0 5712.6 5721.9 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | [#1] ext.html Cycles:180 Average:65887.51 Median:21361.44 stddev:136525.89 (639.1%) stddev-sans-first:136820.87 04:04:51 INFO - PROCESS | 10006 | Values: 595.9 640.4 647.3 652.6 669.2 32729.2 44663.3 45475.3 45531.3 45542.0 48527.0 48746.0 48922.0 48935.8 49026.8 8240.9 9036.1 9168.3 9172.8 9178.6 10529.6 10793.2 10798.9 11128.3 11150.7 10865.3 11000.9 11003.7 11013.1 11014.3 8386.3 10624.9 10851.2 10884.6 10952.8 10368.5 10884.3 10900.5 10902.3 10909.8 46070.0 46721.0 46756.3 46761.1 46848.3 3799.0 3805.4 3821.4 3900.5 4343.9 34855.5 35530.5 35548.5 35624.1 35739.8 4656.3 4712.1 4754.1 4811.2 4878.1 286006.0 289774.0 382036.0 383467.0 383989.0 69559.0 70284.0 70312.6 70364.0 70390.3 40385.0 41154.4 41247.5 43483.8 43539.6 16204.3 16261.2 16379.6 16384.1 16389.3 11063.4 11541.0 11745.4 12132.4 12167.5 22348.4 22355.9 22360.7 22361.4 22476.6 7697.5 7708.5 7911.6 7969.5 8231.3 1086.0 1102.9 1132.9 1177.2 1194.6 33823.3 34429.0 34518.3 34637.5 34902.5 1154.5 1239.3 1260.8 1275.4 1310.6 17856.9 18152.4 18221.9 18242.5 18321.6 680837.0 682726.0 684112.0 687044.0 688999.0 63973.4 64228.0 64552.4 64573.4 64652.4 1318.2 1418.2 1422.7 1423.0 1461.9 33864.5 36070.8 36148.1 36200.0 36493.3 55041.2 55395.7 55456.0 55472.0 55577.5 440011.0 442324.0 442579.0 442907.0 444327.0 27470.9 30358.8 30908.5 31249.4 32520.8 51521.7 52525.5 52934.0 53003.2 53036.0 42688.0 43201.1 43571.3 43748.0 44253.1 42192.6 42479.4 42565.0 42989.1 43228.0 43219.6 43956.0 44267.1 44726.1 44881.6 36900.4 38140.7 38822.4 39079.2 39351.8 28384.3 29993.4 30884.3 30952.5 31416.2 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | [#2] jquery.html Cycles:180 Average:31515.57 Median:22458.16 stddev:96388.23 (429.2%) stddev-sans-first:96630.31 04:04:51 INFO - PROCESS | 10006 | Values: 403.6 410.0 413.6 414.9 429.3 18521.5 19050.8 20035.1 20063.7 20089.3 15882.9 16295.4 16303.2 16698.9 16849.7 5636.0 5747.9 5835.8 5837.9 5843.7 5587.1 5810.8 5822.9 5825.8 5849.1 5536.9 5728.4 5773.1 5775.3 5778.8 5525.0 5542.4 5739.9 5745.7 5768.4 4892.1 5144.4 5153.9 5154.2 5158.2 22414.8 22501.5 22706.8 23068.5 23118.4 2254.8 2478.1 2558.4 2996.0 3135.8 10042.1 10053.6 10053.9 10067.7 10071.4 1961.1 2061.8 2087.2 2092.3 2105.1 56144.4 82204.6 83517.6 83736.6 84382.0 11437.7 11501.9 11621.8 11689.5 11804.3 13230.4 16242.3 16318.1 16339.7 16357.8 7580.5 7876.5 7900.9 7934.8 8086.4 7461.1 7504.4 7612.6 7758.0 7828.1 5013.2 5042.3 5047.3 5088.4 5122.9 2047.7 2076.5 2095.9 2110.7 2118.9 947.9 1035.0 1051.7 1055.9 1129.9 18780.5 18833.3 19114.3 19194.8 19680.9 1020.6 1027.0 1045.8 1049.3 1089.5 10405.9 10687.2 10770.6 10780.4 10793.2 561969.0 580547.0 587454.0 590335.0 614509.0 81440.0 83829.0 100717.5 100879.5 101239.0 1051.2 1090.1 1092.3 1093.3 1104.0 17208.7 17245.2 17246.7 17474.4 17705.0 36997.3 38375.6 39265.6 39446.2 43612.6 53502.7 53760.5 55150.0 62227.4 62561.4 8413.9 8858.2 8904.5 8939.2 9089.0 9664.0 12786.9 13342.3 13464.6 13530.5 11342.9 11649.5 11679.8 11838.6 12104.5 11526.4 11678.9 11858.3 11900.8 11939.9 11472.2 11939.0 11944.6 12121.9 12423.6 8753.7 8760.4 8761.2 8793.1 9013.1 8939.4 11041.8 11420.7 11705.4 11836.1 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | [#3] mootools.html Cycles:180 Average:6214.49 Median:2627.67 stddev:3601.12 (137.0%) stddev-sans-first:3592.75 04:04:51 INFO - PROCESS | 10006 | Values: 1361.2 1539.6 1585.5 1767.7 1899.9 8943.1 9346.4 9368.9 9577.1 9587.4 9353.7 9560.8 9565.3 9567.3 9567.9 2141.6 2425.8 2459.1 2491.6 2526.3 2470.7 2503.9 2507.7 2514.4 2514.5 2434.1 2456.4 2461.6 2462.7 2464.7 2121.5 2398.7 2466.2 2476.3 2494.0 2415.2 2420.3 2421.3 2432.0 2472.7 9342.9 9366.2 9392.0 9417.5 9422.1 5287.2 5424.2 5429.6 5433.5 5436.5 3453.6 3550.9 3586.8 3591.9 3620.6 1158.0 1165.5 1184.2 1199.0 1204.7 13146.9 13158.9 13160.8 13238.1 13293.6 5002.3 5074.6 5085.2 5091.2 5095.2 11263.3 11327.4 11347.9 11351.8 11356.7 4759.5 5341.0 5350.0 5352.6 5355.7 4766.4 4906.2 4913.3 4953.3 4961.6 4255.2 4257.3 4301.7 4469.8 4495.6 1336.8 1341.5 1347.6 1353.7 1392.5 990.4 1002.6 1017.6 1023.1 1030.7 6332.3 6334.4 6371.6 6379.4 6405.6 488.9 491.9 493.1 496.7 506.5 4197.1 4260.5 4349.2 4372.4 4410.8 11278.8 11593.9 11620.4 11643.1 11648.5 11213.3 11600.8 11632.4 11999.0 12015.6 8721.8 8816.5 8885.7 8898.3 8943.5 6337.4 6493.4 6547.7 6605.6 6677.0 10542.8 10898.5 11107.2 11117.0 11157.2 10910.1 10976.6 11224.5 11226.1 11259.2 7796.3 8733.2 8958.4 9055.4 9234.8 9279.7 9291.2 9305.3 9347.1 9358.4 7990.1 8181.6 8204.9 8292.4 8440.5 7724.2 7800.4 7992.2 8030.6 8055.8 7435.9 7585.7 7591.3 7628.4 7743.1 5639.4 5675.5 5703.3 5741.5 5960.2 5455.5 5484.4 5563.4 5667.0 5698.7 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | [#4] prototype.html Cycles:180 Average:4708.02 Median:5294.02 stddev:1380.52 (26.1%) stddev-sans-first:1344.96 04:04:51 INFO - PROCESS | 10006 | Values: 343.4 343.9 351.8 354.6 356.2 5443.2 5490.8 5522.7 5539.6 5558.6 5370.7 5420.9 5445.2 5445.2 5445.7 3916.0 4074.0 4232.8 4259.4 4307.0 4185.7 4227.7 4243.7 4281.3 4301.5 4062.9 4238.0 4261.6 4268.8 4309.8 4137.7 4248.7 4265.4 4272.5 4289.4 3763.1 3770.5 3794.4 3794.7 3808.1 5220.8 5250.9 5255.8 5274.2 5296.7 4874.0 4889.9 4901.1 4907.5 4931.3 5381.9 5416.6 5628.9 5641.5 5720.5 4055.1 4122.4 4131.9 4154.7 4172.0 5840.2 5847.7 5864.4 5874.2 5888.7 3933.0 4110.6 4118.6 4123.5 4131.3 4167.7 4181.0 4184.4 4187.5 4197.3 4804.4 4812.1 4824.3 4826.2 4840.9 5512.2 5662.1 5698.8 5710.3 5718.6 1446.7 1454.1 1460.7 1462.8 1463.5 925.8 941.1 950.6 957.7 960.3 4999.4 5022.3 5044.6 5051.0 5056.6 5126.5 5144.5 5158.1 5161.7 5182.2 4674.3 5024.2 5040.2 5041.4 5078.1 2696.0 2754.3 2778.0 2786.6 2788.7 5402.9 5450.7 5519.2 5544.4 5549.8 5025.4 5291.3 5356.5 5362.4 5378.2 5473.4 5878.1 5943.7 6086.6 6092.0 5747.3 5780.9 5828.2 5837.0 5860.7 5509.3 5709.3 5724.5 5737.7 5747.2 6000.7 6010.6 6032.6 6033.4 6055.1 4153.0 4168.4 4187.3 4192.1 4194.8 5552.7 5875.4 5891.5 5926.5 5932.9 5726.8 5759.4 5767.9 5785.2 5795.7 5573.2 5738.5 5748.7 5769.1 5804.6 5643.5 5644.2 5650.4 5667.3 5675.3 5735.9 5767.4 5791.9 5804.8 5835.5 5395.7 5628.2 5655.8 5674.5 5692.7 04:04:51 INFO - PROCESS | 10006 | 04:04:51 INFO - PROCESS | 10006 | [#5] yui.html Cycles:180 Average:20909.16 Median:44000.39 stddev:29680.83 (67.5%) stddev-sans-first:29725.60 04:04:51 INFO - PROCESS | 10006 | Values: 779.7 783.8 822.8 827.4 896.4 15362.8 15611.8 15620.0 15657.8 16116.4 14657.2 14765.6 14775.7 14785.9 14787.6 707.9 814.6 833.5 844.6 849.5 827.6 836.9 837.9 840.0 840.9 896.1 896.5 896.8 897.3 897.5 723.9 865.6 888.1 890.5 892.0 660.4 661.1 661.6 662.1 663.5 14564.9 14576.3 14595.7 14648.9 14662.6 14578.3 14856.9 15029.7 15185.3 15422.0 13329.7 13525.5 13577.4 13805.5 13847.4 3998.0 4113.1 4129.5 4758.3 4789.5 67445.0 68317.0 68452.7 77622.6 78074.2 11718.8 11859.8 11914.6 12046.2 12056.2 19431.0 19497.2 19508.8 19568.6 20157.4 9188.1 9407.3 9450.0 9509.4 9698.2 5027.6 5049.8 5110.6 5168.4 5170.6 3878.8 3974.1 3974.3 3977.6 3998.0 623.8 627.2 699.1 707.3 708.5 658.6 718.5 781.7 792.4 807.2 10469.5 10599.9 10892.0 11008.8 11140.2 732.7 763.7 792.3 802.1 820.7 4589.3 4699.4 4716.5 4720.7 4785.2 112000.4 112218.4 114244.4 120827.0 121170.0 74205.0 98105.5 98204.5 99708.0 101678.0 90723.0 91033.5 91039.5 91359.0 91492.5 9584.7 9619.5 9634.9 9734.5 9742.5 38863.6 43852.8 44148.0 47024.0 55406.0 74423.6 75728.0 75978.6 76252.0 77259.6 13723.1 13730.7 13866.8 14328.1 14437.9 15729.6 15862.8 16071.7 16588.6 16923.7 13523.9 13704.3 13905.9 13945.7 14332.6 13922.6 13936.4 14304.7 15034.9 15098.2 14429.4 14732.7 14734.3 14879.6 14979.9 11066.3 11399.6 11483.5 11515.3 11674.3 11646.9 12232.0 12295.9 12424.6 12478.3 04:04:51 INFO - PROCESS | 10006 | -------- Summary: end -------- 04:04:51 INFO - PROCESS | 10006 | 04:04:52 INFO - TEST-INFO | 10006: exit 0 04:04:52 INFO - TEST-OK | dromaeo_css | took 1111843ms 04:04:52 INFO - TEST-START | kraken 04:04:52 INFO - operating with platform_type : linux_ 04:04:52 INFO - Initialising browser for kraken test... 04:04:52 INFO - TEST-INFO | started process 10204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Kdau9/profile http://localhost:49552/getInfo.html) 04:04:56 INFO - PROCESS | 10204 | __metrics Screen width/height:1600/1200 04:04:56 INFO - PROCESS | 10204 | colorDepth:24 04:04:56 INFO - PROCESS | 10204 | Browser inner width/height: 1024/697 04:04:56 INFO - PROCESS | 10204 | __metrics 04:04:56 ERROR - PROCESS | 10204 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:04:57 INFO - TEST-INFO | 10204: exit 0 04:04:57 INFO - Browser initialized. 04:04:57 INFO - Running cycle 1/1 for kraken test... 04:04:57 INFO - TEST-INFO | started process 10295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Kdau9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:09 INFO - PROCESS | 10295 | RSS: Main: 145367040 04:05:09 INFO - PROCESS | 10295 | 04:05:12 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49552/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:12 INFO - PROCESS | 10295 | RSS: Main: 194641920 04:05:12 INFO - PROCESS | 10295 | 04:05:15 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49552/tests/kraken/driver.html?testName=audio-dft) 04:05:16 INFO - PROCESS | 10295 | RSS: Main: 194256896 04:05:16 INFO - PROCESS | 10295 | 04:05:19 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49552/tests/kraken/driver.html?testName=audio-fft) 04:05:19 INFO - PROCESS | 10295 | RSS: Main: 279928832 04:05:19 INFO - PROCESS | 10295 | 04:05:21 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49552/tests/kraken/driver.html?testName=audio-oscillator) 04:05:22 INFO - PROCESS | 10295 | RSS: Main: 188575744 04:05:22 INFO - PROCESS | 10295 | 04:05:24 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49552/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:25 INFO - PROCESS | 10295 | RSS: Main: 189513728 04:05:25 INFO - PROCESS | 10295 | 04:05:28 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49552/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:28 INFO - PROCESS | 10295 | RSS: Main: 223883264 04:05:28 INFO - PROCESS | 10295 | 04:05:32 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49552/tests/kraken/driver.html?testName=imaging-desaturate) 04:05:32 INFO - PROCESS | 10295 | RSS: Main: 224411648 04:05:32 INFO - PROCESS | 10295 | 04:05:35 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49552/tests/kraken/driver.html?testName=json-parse-financial) 04:05:35 INFO - PROCESS | 10295 | RSS: Main: 224083968 04:05:35 INFO - PROCESS | 10295 | 04:05:37 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49552/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:05:38 INFO - PROCESS | 10295 | RSS: Main: 200900608 04:05:38 INFO - PROCESS | 10295 | 04:05:39 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:40 INFO - PROCESS | 10295 | RSS: Main: 202678272 04:05:40 INFO - PROCESS | 10295 | 04:05:42 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:43 INFO - PROCESS | 10295 | RSS: Main: 210685952 04:05:43 INFO - PROCESS | 10295 | 04:05:45 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:46 INFO - PROCESS | 10295 | RSS: Main: 216477696 04:05:46 INFO - PROCESS | 10295 | 04:05:48 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:49 INFO - PROCESS | 10295 | RSS: Main: 217788416 04:05:49 INFO - PROCESS | 10295 | 04:05:50 INFO - PROCESS | 10295 | Cycle 1(1): loaded http://localhost:49552/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49552/tests/kraken/driver.html?testName=ai-astar) 04:05:51 INFO - PROCESS | 10295 | RSS: Main: 260288512 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | __start_tp_report 04:05:51 INFO - PROCESS | 10295 | _x_x_mozilla_page_load 04:05:51 INFO - PROCESS | 10295 | _x_x_mozilla_page_load_details 04:05:51 INFO - PROCESS | 10295 | |i|pagename|runs| 04:05:51 INFO - PROCESS | 10295 | |0;ai-astar;111;104;110;110;111;109;110;110;109;109 04:05:51 INFO - PROCESS | 10295 | |1;audio-beat-detection;164;123;125;179;123;128;125;151;156;125 04:05:51 INFO - PROCESS | 10295 | |2;audio-dft;160;160;162;162;161;160;162;161;161;161 04:05:51 INFO - PROCESS | 10295 | |3;audio-fft;75;76;74;130;74;76;74;79;97;74 04:05:51 INFO - PROCESS | 10295 | |4;audio-oscillator;84;85;114;86;86;84;118;85;85;124 04:05:51 INFO - PROCESS | 10295 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;116 04:05:51 INFO - PROCESS | 10295 | |6;imaging-darkroom;145;146;147;148;147;146;146;146;145;145 04:05:51 INFO - PROCESS | 10295 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;95;95 04:05:51 INFO - PROCESS | 10295 | |8;json-parse-financial;51;50;50;51;51;51;51;51;52;51 04:05:51 INFO - PROCESS | 10295 | |9;json-stringify-tinderbox;60;59;59;59;59;59;60;59;60;60 04:05:51 INFO - PROCESS | 10295 | |10;stanford-crypto-aes;76;76;76;76;77;77;77;77;103;78 04:05:51 INFO - PROCESS | 10295 | |11;stanford-crypto-ccm;126;117;125;117;116;121;125;124;133;122 04:05:51 INFO - PROCESS | 10295 | |12;stanford-crypto-pbkdf2;156;153;154;155;152;150;151;157;154;151 04:05:51 INFO - PROCESS | 10295 | |13;stanford-crypto-sha256-iterative;63;63;64;64;61;63;60;59;59;64 04:05:51 INFO - PROCESS | 10295 | __end_tp_report 04:05:51 INFO - PROCESS | 10295 | __start_cc_report 04:05:51 INFO - PROCESS | 10295 | _x_x_mozilla_cycle_collect,1566 04:05:51 INFO - PROCESS | 10295 | __end_cc_report 04:05:51 INFO - PROCESS | 10295 | __startTimestamp1468321551207__endTimestamp 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | ------- Summary: start ------- 04:05:51 INFO - PROCESS | 10295 | Number of tests: 14 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:2.03 04:05:51 INFO - PROCESS | 10295 | Values: 111.0 104.0 110.0 110.0 111.0 109.0 110.0 110.0 109.0 109.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:139.50 stddev:20.74 (14.9%) stddev-sans-first:20.08 04:05:51 INFO - PROCESS | 10295 | Values: 164.0 123.0 125.0 179.0 123.0 128.0 125.0 151.0 156.0 125.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 04:05:51 INFO - PROCESS | 10295 | Values: 160.0 160.0 162.0 162.0 161.0 160.0 162.0 161.0 161.0 161.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:17.97 (23.8%) stddev-sans-first:18.83 04:05:51 INFO - PROCESS | 10295 | Values: 75.0 76.0 74.0 130.0 74.0 76.0 74.0 79.0 97.0 74.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.45 (19.4%) stddev-sans-first:16.95 04:05:51 INFO - PROCESS | 10295 | Values: 84.0 85.0 114.0 86.0 86.0 84.0 118.0 85.0 85.0 124.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:05:51 INFO - PROCESS | 10295 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 04:05:51 INFO - PROCESS | 10295 | Values: 145.0 146.0 147.0 148.0 147.0 146.0 146.0 146.0 145.0 145.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 04:05:51 INFO - PROCESS | 10295 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 04:05:51 INFO - PROCESS | 10295 | Values: 51.0 50.0 50.0 51.0 51.0 51.0 51.0 51.0 52.0 51.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 04:05:51 INFO - PROCESS | 10295 | Values: 60.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 60.0 60.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:77.00 stddev:8.35 (10.8%) stddev-sans-first:8.77 04:05:51 INFO - PROCESS | 10295 | Values: 76.0 76.0 76.0 76.0 77.0 77.0 77.0 77.0 103.0 78.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:124.50 stddev:5.19 (4.2%) stddev-sans-first:5.36 04:05:51 INFO - PROCESS | 10295 | Values: 126.0 117.0 125.0 117.0 116.0 121.0 125.0 124.0 133.0 122.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:154.00 stddev:2.31 (1.5%) stddev-sans-first:2.24 04:05:51 INFO - PROCESS | 10295 | Values: 156.0 153.0 154.0 155.0 152.0 150.0 151.0 157.0 154.0 151.0 04:05:51 INFO - PROCESS | 10295 | 04:05:51 INFO - PROCESS | 10295 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:63.00 stddev:2.05 (3.3%) stddev-sans-first:2.15 04:05:51 INFO - PROCESS | 10295 | Values: 63.0 63.0 64.0 64.0 61.0 63.0 60.0 59.0 59.0 64.0 04:05:51 INFO - PROCESS | 10295 | -------- Summary: end -------- 04:05:51 INFO - PROCESS | 10295 | 04:05:52 INFO - TEST-INFO | 10295: exit 0 04:05:52 INFO - TEST-OK | kraken | took 59566ms 04:05:52 INFO - SUITE-END | took 1171s 04:05:52 INFO - Completed test suite (00:19:31) 04:05:52 INFO - javascript benchmark 04:05:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.673432656735, 3288.210829400943, 3296.3077753671737, 3316.7512436567263, 3329.167708072982, 5311.78752849886, 5402.297701298826, 5415.48552887475, 5427.674339539631, 5428.430014848438, 5410.756515956781, 5499.532539734118, 5501.449855014496, 5508.9724551377185, 5510.1459273812625, 4909.214525675892, 4985.925211121827, 5006.54941055305, 5045.318881950926, 5066.6706664066905, 4882.316475693388, 5004.399472063357, 5039.571636410909, 5046.066477701637, 5046.6719663221775, 4933.901321973558, 4940.209566469365, 4988.575971042465, 4998.600111991032, 5016.749162541876, 5058.392992840846, 5070.0, 5077.492250774893, 5079.390473143209, 5106.259592359106, 4851.951480485185, 4869.829555965524, 4924.409070911478, 4983.377077865267, 4997.800087996476, 5231.712255825928, 5241.344831896013, 5248.527632513054, 5284.418713941502, 5289.86775330616, 5801.82594522165, 5843.561732870052, 5845.444682755132, 5848.444397782204, 5848.619839710448, 5847.707614619252, 5879.265091863517, 5895.35151133375, 5906.409359064102, 5972.104184372335, 5530.751116199781, 5575.024370735106, 5576.163575463713, 5576.470235327719, 5581.358143813472, 5688.516476099495, 6045.546584006217, 6046.486048685823, 6063.696815159225, 6065.181200537959, 5704.942950570441, 5759.971200143972, 5762.193292938992, 5862.736176872051, 5868.882622347529, 5924.407559244041, 5929.14027466015, 5930.8813823723285, 5949.464548190684, 5962.165296858443, 5612.943870561242, 5776.393478684761, 5879.52963762898, 5885.323187833454, 5898.852528686732, 5800.53595712342, 5878.059510478303, 5878.911816322759, 5879.147523609053, 5915.704214789243, 4546.909061818811, 4553.089382123589, 4554.0, 4554.4990051094355, 4574.702644328108, 3944.9211015780097, 3978.1645854370904, 4050.2911990401562, 4081.6530594899173, 4117.300058989979, 5612.298462692163, 5617.775288988395, 5627.606067575231, 5636.2391077204875, 5638.830835074954, 5902.3507414184405, 5919.763209471573, 5920.911186332122, 5921.61509501881, 5953.553483488669, 5348.03735327637, 5423.105187643994, 5464.781408743605, 5472.425395333512, 5550.777968881281, 4944.060628480577, 4956.776945037482, 4958.826441074545, 4959.2809042688605, 4963.801447942042, 6024.759009639565, 6033.064874944303, 6034.2155519782145, 6034.577579569388, 6034.668093254913, 5678.801241956512, 5827.3881242470625, 5879.823605291848, 5898.1152827076285, 5955.821325360246, 6199.752009919553, 6218.81343559694, 6227.06594010902, 6229.065640154013, 6230.937690623217, 5539.861503462445, 5821.738021788945, 5836.737346819318, 5842.152887831156, 5844.561657875762, 5786.3056433228285, 5799.710014499343, 5847.94152058491, 5883.411658834082, 5883.529317654663, 5724.227229323988, 5755.165501002415, 5761.2222349983895, 5763.4812866842185, 5765.1928729977, 5467.808626698046, 5661.745221464962, 5736.799212027559, 5750.884982300414, 5760.567957403127, 5621.297337832771, 5695.743691533974, 5695.914561281501, 5696.772129114789, 5745.425457454221, 5802.854928626818, 5832.300123985149, 5857.765689372548, 5858.414158584107, 5861.677607731615, 5438.755256013568, 5585.860353491195, 5659.0, 5712.571557133148, 5721.942780572141], "value": 5414.57301003789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.919550860634, 640.356441776015, 647.2782847125455, 652.598651829125, 669.2203582826008, 32729.18177045572, 44663.33005004928, 45475.317870231935, 45531.31703024457, 45542.0, 48527.0, 48746.0, 48922.0, 48935.755321223434, 49026.754866225616, 8240.917590824105, 9036.141566551167, 9168.26653867689, 9172.770680733001, 9178.586963586622, 10529.578816847355, 10793.244472886901, 10798.946005270001, 11128.332300061982, 11150.665480035612, 10865.293755905881, 11000.944995275013, 11003.669889903316, 11013.118950483982, 11014.284071535365, 8386.329093672492, 10624.893751062467, 10851.240413171081, 10884.61903833366, 10952.780944381107, 10368.533415996299, 10884.346939183675, 10900.454977251105, 10902.291351062155, 10909.781804363947, 46070.0, 46721.0, 46756.29865551985, 46761.064778704575, 46848.29727554089, 3799.0, 3805.429185622151, 3821.3503704370323, 3900.4539364488996, 4343.913121737548, 34855.4771678425, 35530.46704299412, 35548.46677299843, 35624.10939726502, 35739.82130089359, 4656.278276867091, 4712.104700107003, 4754.144254034307, 4811.182099043136, 4878.0975519529, 286006.0, 289774.0, 382036.0, 383467.0, 383989.0, 69559.0, 70284.0, 70312.64843675749, 70364.0, 70390.29609703837, 40385.0, 41154.38268425976, 41247.525148491186, 43483.78258108689, 43539.56460435355, 16204.270807813677, 16261.18694065292, 16379.59051023734, 16384.098874561776, 16389.262483188286, 11063.446827658585, 11541.0, 11745.412729363497, 12132.393380331125, 12167.513299468099, 22348.441288967904, 22355.888220558794, 22360.664590031163, 22361.44096397603, 22476.55046899053, 7697.538147711155, 7708.537487750753, 7911.564863932539, 7969.481983671043, 8231.34149268057, 1085.9565617375374, 1102.862142232221, 1132.8867113288604, 1177.2289150606366, 1194.6475789642077, 33823.32353352919, 34429.0, 34518.309633807185, 34637.480437793456, 34902.476462853076, 1154.5035634677001, 1239.3493415956696, 1260.7667581497453, 1275.3878138493576, 1310.6199202231246, 17856.910715446338, 18152.364667236583, 18221.908890455463, 18242.45272641823, 18321.63356732858, 680837.0, 682726.0, 684112.0, 687044.0, 688999.0, 63973.36026639674, 64228.0, 64552.35447645558, 64573.354266457674, 64652.35347646557, 1318.2288361308742, 1418.2412409361148, 1422.665673566711, 1422.9612382960497, 1461.868431841118, 33864.49203262002, 36070.8196459016, 36148.09629759277, 36200.0, 36493.27013459663, 55041.1743823835, 55395.723021384634, 55456.0, 55472.0, 55577.49901254534, 440011.0, 442324.0, 442579.0, 442907.0, 444327.0, 27470.862645686644, 30358.84820575883, 30908.536371954888, 31249.375012499167, 32520.83739581287, 51521.7423912878, 52525.47474525359, 52934.0, 53003.152811589636, 53036.0, 42688.0, 43201.13597728091, 43571.34642980421, 43748.0, 44253.11493770171, 42192.578074220095, 42479.3628095585, 42565.0, 42989.14021719611, 43228.0, 43219.56780432155, 43956.0, 44267.11465770602, 44726.10547788961, 44881.55118448774, 36900.446493303156, 38140.70777496023, 38822.4176637345, 39079.21841563096, 39351.80324098361, 28384.290392740346, 29993.4001319968, 30884.30136342433, 30952.53571196479, 31416.214594634403], "value": 21689.613571367583, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.63672694574876, 409.95080590329167, 413.6360003197186, 414.8983499042734, 429.2809544013778, 18521.536961575966, 19050.809491905078, 20035.098420571074, 20063.699044514327, 20089.29687460939, 15882.920585397085, 16295.429659961903, 16303.184840757944, 16698.916505417455, 16849.74725379117, 5635.971820140904, 5747.856303592402, 5835.795747148851, 5837.9124313135335, 5843.678597677126, 5587.078132108198, 5810.82567522975, 5822.9417705822825, 5825.79609713658, 5849.093390524476, 5536.916946245809, 5728.398518155596, 5773.1051686988585, 5775.306963164426, 5778.82663520093, 5525.033119204123, 5542.418046105182, 5739.885202295952, 5745.741441635116, 5768.42315768424, 4892.119418504668, 5144.4083930348115, 5153.948460515422, 5154.226865970097, 5158.226266060084, 22414.775852241433, 22501.549969000527, 22706.772932270796, 23068.53862922749, 23118.42203944915, 2254.763249858774, 2478.083109249571, 2558.3604098975256, 2995.955060674092, 3135.7961732487543, 10042.096211341015, 10053.648122315684, 10053.899461005369, 10067.697969060866, 10071.446070466121, 1961.0782932021928, 2061.752589689247, 2087.2277257414703, 2092.3199960013058, 2105.1053302346595, 56144.43855561433, 82204.58897705533, 83517.58241208816, 83736.58131709302, 84382.0, 11437.714057148638, 11501.942490287494, 11621.825672614917, 11689.532418703327, 11804.291742495478, 13230.404631791593, 16242.269097890623, 16318.102504362136, 16339.673206536041, 16357.836421635631, 7580.54516728987, 7876.527408355517, 7900.881486777703, 7934.761957141295, 8086.353091752646, 7461.1419686735635, 7504.437167212481, 7612.581308028, 7757.961210193913, 7828.060632724109, 5013.248012798036, 5042.268871013683, 5047.268146118792, 5088.414832294334, 5122.87192820175, 2047.6621357476147, 2076.512019675375, 2095.9161633534486, 2110.683397490389, 2118.8728676279475, 947.9431234125974, 1034.9534270957824, 1051.6582110813863, 1055.904968552834, 1129.8870112988636, 18780.530486737942, 18833.340833070775, 19114.330998415266, 19194.808051919303, 19680.90159549193, 1020.5713600287897, 1027.0448482910965, 1045.7856139491387, 1049.3284298049255, 1089.536946797608, 10405.947970260251, 10687.198460115367, 10770.623028193975, 10780.40707761065, 10793.190510711727, 561969.0, 580547.0, 587454.0, 590335.0, 614509.0, 81439.99999999882, 83829.0, 100717.49641251747, 100879.49560252299, 101239.0, 1051.153821173947, 1090.1278976818514, 1092.3118435385657, 1093.3330668292335, 1103.9889601103887, 17208.741868871726, 17245.22396492136, 17246.741298880275, 17474.38839640657, 17705.0, 36997.26005479929, 38375.616243837205, 39265.607343926196, 39446.2110757789, 43612.56387436212, 53502.73248633732, 53760.46239537711, 55150.0, 62227.377726222156, 62561.37438625556, 8413.915860841558, 8858.15847494487, 8904.510251936206, 8939.195472407515, 9089.045650206634, 9663.951680241555, 12786.872131278567, 13342.26617536006, 13464.596062118153, 13530.458781649018, 11342.943285283522, 11649.534018639159, 11679.76640467203, 11838.585649502571, 12104.45529951172, 11526.366049867338, 11678.941605291919, 11858.288502689866, 11900.821487677518, 11939.880601193878, 11472.196946213686, 11939.0, 11944.64166075019, 12121.878781212075, 12423.565175218824, 8753.737387878375, 8760.4305720128, 8761.211490965843, 8793.14613975145, 9013.053629369084, 8939.418937769024, 11041.779164416506, 11420.714482138013, 11705.414729263674, 11836.053115750547], "value": 9319.416670797262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.2036958379347, 1539.6458814472667, 1585.5243426971908, 1767.672980498607, 1899.8860068395898, 8943.060978597252, 9346.439213647185, 9368.906310936889, 9577.138057574817, 9587.376820506663, 9353.67262145825, 9560.76098097548, 9565.282603804708, 9567.330286879922, 9567.904320956806, 2141.625215587274, 2425.818063645225, 2459.102427613926, 2491.6137998610243, 2526.2926380613367, 2470.703515578133, 2503.912363067293, 2507.6865391826022, 2514.446821699223, 2514.5222407742563, 2434.1480481831395, 2456.3736247256925, 2461.5569197544437, 2462.655228268044, 2464.728879823227, 2121.5226574020876, 2398.6761787158684, 2466.198485492222, 2476.257122863152, 2494.014864128659, 2415.239199652104, 2420.261820144855, 2421.3099266708905, 2431.9878400607886, 2472.678551788274, 9342.906570934272, 9366.20387267083, 9391.953040234823, 9417.529123543864, 9422.057794220591, 5287.154055351164, 5424.186372044185, 5429.619926605139, 5433.483819037185, 5436.456354364572, 3453.5855697316483, 3550.91122721934, 3586.7668601540818, 3591.8742844000335, 3620.601733809279, 1157.953681852725, 1165.452237448398, 1184.2184158455377, 1198.964031079069, 1204.7048473124141, 13146.934265328613, 13158.934205328913, 13160.802587961189, 13238.073334866467, 13293.601191964257, 5002.349694539686, 5074.594032477393, 5085.186370180753, 5091.159958606789, 5095.24214146119, 11263.26788758728, 11327.376994265394, 11347.943260283646, 11351.772964540663, 11356.716082098013, 4759.4764575896625, 5340.973295133577, 5349.973250133725, 5352.57179425645, 5355.7054362009685, 4766.428028636586, 4906.1659517881335, 4913.287573301851, 4953.306537084811, 4961.603071754251, 4255.212785634668, 4257.318828987347, 4301.677374196947, 4469.776511174493, 4495.640348772155, 1336.8061631063442, 1341.47011930287, 1347.6496111011209, 1353.7427888701313, 1392.491740514725, 990.3810118675827, 1002.5588740953957, 1017.572619499797, 1023.1150055202345, 1030.7062487191115, 6332.303446620868, 6334.429901308904, 6371.585846919936, 6379.393957574023, 6405.615663060231, 488.9144399730033, 491.92867034280545, 493.0976313346639, 496.74417674897455, 506.4707380787086, 4197.097624010852, 4260.531341552427, 4349.151915376471, 4372.366006928977, 4410.845620403335, 11278.774424511465, 11593.88406115928, 11620.418979051014, 11643.06855451562, 11648.53405863773, 11213.271137376045, 11600.825987610193, 11632.418379081013, 11999.04007679401, 12015.579454719043, 8721.825563488695, 8816.471011739317, 8885.733427997042, 8898.288136948899, 8943.508107054175, 6337.397947195009, 6493.350664933469, 6547.672616369257, 6605.57063790852, 6677.0, 10542.789144217226, 10898.455077246264, 11107.222494425312, 11117.0, 11157.218994670295, 10910.127189824954, 10976.615818446317, 11224.494897729459, 11226.101911847196, 11259.155563332946, 7796.259355361231, 8733.170348816851, 8958.372913895964, 9055.411398259092, 9234.815303694022, 9279.72160835176, 9291.163795258459, 9305.255579553484, 9347.112024357675, 9358.4384936904, 7990.081140668665, 8181.590920454072, 8204.876926845982, 8292.419530633038, 8440.535770532433, 7724.150343462103, 7800.375969922506, 7992.16082311349, 8030.598470076589, 8055.798605034921, 7435.8884616731875, 7585.658645361083, 7591.278828511283, 7628.427867909818, 7743.109542402696, 5639.351474580476, 5675.545956323567, 5703.258576385043, 5741.483266506035, 5960.165576819162, 5455.454454554513, 5484.424135465719, 5563.443655634404, 5666.9716651416475, 5698.743556540048], "value": 4859.686096152675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.42819206021977, 343.88651744924164, 351.78716876289843, 354.62586970745866, 356.17190033172847, 5443.210734443508, 5490.780368785254, 5522.66863988161, 5539.584531160164, 5558.555315574755, 5370.650907691007, 5420.891582168354, 5445.156000819869, 5445.237666726662, 5445.673259604417, 3916.0, 4074.022234663674, 4232.809523571446, 4259.3814350546745, 4306.997246280479, 4185.727927684691, 4227.661787057028, 4243.745375277478, 4281.314989601664, 4301.462317210348, 4062.8577999770014, 4238.0, 4261.637760790321, 4268.807903644328, 4309.784510774449, 4137.696625562953, 4248.681348898845, 4265.38151967966, 4272.487301523806, 4289.356596510517, 3763.1344790698017, 3770.5286839145106, 3794.3739283018267, 3794.715396345285, 3808.124131449782, 5220.791168353261, 5250.8687282817855, 5255.816046438395, 5274.235235890775, 5296.708681022542, 4873.951260487421, 4889.8777530561665, 4901.093297739894, 4907.460179380265, 4931.309616653672, 5381.946180538183, 5416.620836541444, 5628.915566266509, 5641.548676105943, 5720.513756330717, 4055.1484188320487, 4122.443470131524, 4131.8967025824295, 4154.667626589866, 4172.0, 5840.153177789197, 5847.678377689225, 5864.384239654817, 5874.179004508574, 5888.704485013291, 3932.980335098306, 4110.615842811162, 4118.567550407224, 4123.505179378494, 4131.29767939451, 4167.729097608646, 4180.958190418118, 4184.351425528987, 4187.471572875939, 4197.307444271661, 4804.447488538863, 4812.109759694467, 4824.34871292371, 4826.155422800995, 4840.903181936342, 5512.200730893998, 5662.103195429495, 5698.800541981011, 5710.343310519261, 5718.599698021182, 1446.7341076558012, 1454.0911930043724, 1460.7443697352921, 1462.8390877003521, 1463.4852927220277, 925.7916968682127, 941.1435593609782, 950.5912457643279, 957.7031120352713, 960.3085778239656, 4999.400191938545, 5022.347094877716, 5044.646874718735, 5051.0, 5056.595472362203, 5126.461721519261, 5144.511271429208, 5158.097332966716, 5161.74191290434, 5182.24857395683, 4674.322223277673, 5024.166179344513, 5040.218766091261, 5041.445441001487, 5078.13671675816, 2695.9730402696114, 2754.325190328382, 2778.0, 2786.5680819473014, 2788.721127887195, 5402.8919421611345, 5450.727463626803, 5519.227308176858, 5544.364412498323, 5549.751305956208, 5025.3718285214345, 5291.3385826771655, 5356.544693701079, 5362.399236370357, 5378.1663842104535, 5473.425290344457, 5878.147668588031, 5943.673097979653, 6086.604370715978, 6092.0, 5747.3103227612955, 5780.855478613068, 5828.184054232495, 5837.007708689448, 5860.736266868086, 5509.283793106871, 5709.287213835915, 5724.484796368347, 5737.713114344349, 5747.166660834072, 6000.729967151576, 6010.579259451796, 6032.607880487754, 6033.42682445167, 6055.1220073090035, 4152.979235103805, 4168.374743788456, 4187.288161012696, 4192.0777428965575, 4194.769287689206, 5552.7223638818705, 5875.441833025856, 5891.528677705859, 5926.525877929842, 5932.851678708067, 5726.79956201531, 5759.424057594207, 5767.913481297868, 5785.218995435731, 5795.710214489174, 5573.21974923503, 5738.454846789548, 5748.6838223898085, 5769.134629805562, 5804.593678442638, 5643.5044713151865, 5644.209810626434, 5650.35020972577, 5667.263255776723, 5675.31896172462, 5735.856603584777, 5767.385132163001, 5791.9131213031, 5804.767809287581, 5835.503982161394, 5395.676259424447, 5628.212050313042, 5655.802046928502, 5674.517665998436, 5692.743826527899], "value": 4271.928799168373, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [779.7270955165693, 783.7609529093628, 822.7737372222638, 827.3794654009492, 896.3725392225435, 15362.769558456617, 15611.765823512656, 15620.0, 15657.765133522978, 16116.355345786169, 14657.193854338033, 14765.557033289018, 14775.704485910275, 14785.926070369633, 14787.630309242275, 707.9008938748553, 814.6293436486415, 833.4999000599637, 844.6072576252042, 849.5285116760195, 827.606886728805, 836.8828364029041, 837.8826964224983, 839.9664013439456, 840.8528507511161, 896.0591379052001, 896.4800415758876, 896.789254525186, 897.3135551303258, 897.4570384917129, 723.9384652304534, 865.6148014133713, 888.1340692824444, 890.496869268861, 891.9554022298859, 660.4023358860192, 661.1240106858384, 661.5898143151229, 662.1392190152782, 663.4592806862391, 14564.85435145656, 14576.344064517121, 14595.708085838223, 14648.853511464855, 14662.633434164125, 14578.343974521173, 14856.851431485655, 15029.699406011929, 15185.272103578536, 15422.0, 13329.733405331936, 13525.526606568723, 13577.389017494237, 13805.51680691181, 13847.446102155902, 3998.0, 4113.115680128757, 4129.463169787939, 4758.286257061434, 4789.521047895182, 67445.0, 68317.0, 68452.6577367115, 77622.61188694077, 78074.21925780726, 11718.824217636742, 11859.762804743857, 11914.642560723192, 12046.156769026084, 12056.216345937486, 19431.0, 19497.220111195395, 19508.80491195098, 19568.608627827365, 20157.395278141677, 9188.127127922837, 9407.29445291606, 9450.0, 9509.429434233969, 9698.224142068617, 5027.597792176617, 5049.848504544796, 5110.642255042186, 5168.431472538018, 5170.560502357342, 3878.8060596970604, 3974.125692347679, 3974.324364857981, 3977.622125898035, 3997.9805149687227, 623.8253289079065, 627.1502114634695, 699.0667458942268, 707.3492387003865, 708.5146674527965, 658.6180015590945, 718.5461648470415, 781.6560713286136, 792.3502727763179, 807.2049031703767, 10469.482635301603, 10599.947000265103, 10892.0, 11008.834867476995, 11140.164487663458, 732.6849454734408, 763.713607397226, 792.2829838995718, 802.1296892871184, 820.6922404098464, 4589.33454649074, 4699.365585645963, 4716.481187069419, 4720.740359280273, 4785.1625965455905, 112000.43999780112, 112218.43890780657, 114244.42877785557, 120827.0, 121170.0, 74205.0, 98105.50947245218, 98204.50897745609, 99708.0, 101678.0, 90723.0, 91033.54483227673, 91039.54480227556, 91358.99999999868, 91492.54253728822, 9584.66453674118, 9619.470929098967, 9634.855477167988, 9734.464604446823, 9742.464164471023, 38863.61136388713, 43852.780736096116, 44148.0, 47024.0, 55406.0, 74423.62788186024, 75728.0, 75978.62010690132, 76252.0, 77259.61370193113, 13723.1079979801, 13730.65673358174, 13866.791998119834, 14328.14031158134, 14437.927810361301, 15729.606759830638, 15862.841371586137, 16071.67856642884, 16588.58528536748, 16923.66152676915, 13523.864761352654, 13704.314784260549, 13905.887528997453, 13945.651358716113, 14332.57002289933, 13922.582322530341, 13936.442542298195, 14304.713905722036, 15034.924825375803, 15098.169600672069, 14429.42282308696, 14732.705345892808, 14734.26328683583, 14879.628009299855, 14979.850201497846, 11066.336019838835, 11399.601013964471, 11483.483243253906, 11515.30908145514, 11674.299542027506, 11646.883531164918, 12232.004040364058, 12295.938520307342, 12424.627261182179, 12478.313692746986], "value": 7864.382725540296, "unit": "score"}], "name": "dromaeo_css", "value": 7505.124760602695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 104.0, 110.0, 110.0, 111.0, 109.0, 110.0, 110.0, 109.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 123.0, 125.0, 179.0, 123.0, 128.0, 125.0, 151.0, 156.0, 125.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 130.0, 74.0, 76.0, 74.0, 79.0, 97.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 114.0, 86.0, 86.0, 84.0, 118.0, 85.0, 85.0, 124.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 51.0, 52.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 60.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 77.0, 77.0, 77.0, 77.0, 103.0, 78.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 117.0, 125.0, 117.0, 116.0, 121.0, 125.0, 124.0, 133.0, 122.0], "value": 122.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 153.0, 154.0, 155.0, 152.0, 150.0, 151.0, 157.0, 154.0, 151.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 61.0, 63.0, 60.0, 59.0, 59.0, 64.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1473.3, "alertThreshold": 2.0}]} 04:05:52 INFO - Return code: 0 04:05:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:52 ERROR - # TBPL SUCCESS # 04:05:52 INFO - Running post-action listener: _resource_record_post_action 04:05:52 INFO - ##### 04:05:52 INFO - ##### Finished run-tests step (success) 04:05:52 INFO - ##### 04:05:52 INFO - Running post-run listener: _resource_record_post_run 04:05:52 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 290816; Write bytes: 266190848; Read time: 44; Write time: 164824 04:05:52 INFO - TinderboxPrint: CPU usage
13.1% 04:05:52 INFO - TinderboxPrint: I/O read bytes / time
290,816 / 44 04:05:52 INFO - TinderboxPrint: I/O write bytes / time
266,190,848 / 164,824 04:05:52 INFO - TinderboxPrint: CPU idle
8,248.4 (86.9%) 04:05:52 INFO - TinderboxPrint: CPU user
1,200.1 (12.6%) 04:05:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:05:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15564800; Read time: 0; Write time: 15084 04:05:52 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 250290176; Read time: 28; Write time: 149740 04:05:53 INFO - Running post-run listener: _upload_blobber_files 04:05:53 INFO - Blob upload gear active. 04:05:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:53 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 04:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:05:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:05:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:05:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:54 INFO - (blobuploader) - INFO - Done attempting. 04:05:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:05:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:05:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:55 INFO - (blobuploader) - INFO - Done attempting. 04:05:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:58 INFO - (blobuploader) - INFO - Done attempting. 04:05:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:58 INFO - Return code: 0 04:05:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ff24b31d4a3d3f465682cd0c60eac6d46900081fa26e6960f3863b2f7ab6fbf3099ff0ac6cf4b4da4a1a015ceadebe679e4c38905635804109730008828b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267c1b02fa7ce4df48e37a4e09489cf553ba2443e6cd991f7ef16a849e847652fa0f1e1db78974589574b2b96494912b38b6aa400b9ad2e0bf85f9a3ee5b67eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5651a373611bc8ff6eb24f4c1fb0cdf79b9c0a7a81ecfbf83b8ec440b00e9f676417bde1045213742f738e67982c2ddfb6803adf7cd5fda5de87773a2adae25"} 04:05:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:58 INFO - Contents: 04:05:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ff24b31d4a3d3f465682cd0c60eac6d46900081fa26e6960f3863b2f7ab6fbf3099ff0ac6cf4b4da4a1a015ceadebe679e4c38905635804109730008828b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267c1b02fa7ce4df48e37a4e09489cf553ba2443e6cd991f7ef16a849e847652fa0f1e1db78974589574b2b96494912b38b6aa400b9ad2e0bf85f9a3ee5b67eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5651a373611bc8ff6eb24f4c1fb0cdf79b9c0a7a81ecfbf83b8ec440b00e9f676417bde1045213742f738e67982c2ddfb6803adf7cd5fda5de87773a2adae25"} 04:05:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:58 INFO - Copying logs to upload dir... 04:05:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.323847 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-12 04:05:58.044158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:58.047487) ========= 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=0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ff24b31d4a3d3f465682cd0c60eac6d46900081fa26e6960f3863b2f7ab6fbf3099ff0ac6cf4b4da4a1a015ceadebe679e4c38905635804109730008828b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267c1b02fa7ce4df48e37a4e09489cf553ba2443e6cd991f7ef16a849e847652fa0f1e1db78974589574b2b96494912b38b6aa400b9ad2e0bf85f9a3ee5b67eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5651a373611bc8ff6eb24f4c1fb0cdf79b9c0a7a81ecfbf83b8ec440b00e9f676417bde1045213742f738e67982c2ddfb6803adf7cd5fda5de87773a2adae25"} build_url:https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/H_4DAX4USTyqtnpoi_kRoA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/14ff24b31d4a3d3f465682cd0c60eac6d46900081fa26e6960f3863b2f7ab6fbf3099ff0ac6cf4b4da4a1a015ceadebe679e4c38905635804109730008828b84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/267c1b02fa7ce4df48e37a4e09489cf553ba2443e6cd991f7ef16a849e847652fa0f1e1db78974589574b2b96494912b38b6aa400b9ad2e0bf85f9a3ee5b67eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5651a373611bc8ff6eb24f4c1fb0cdf79b9c0a7a81ecfbf83b8ec440b00e9f676417bde1045213742f738e67982c2ddfb6803adf7cd5fda5de87773a2adae25"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:58.073056) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:58.073388) ========= 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=0333a256a5e4f052382dd180000001b1-1468320268.511297-1694293333 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 04:05:58.159132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 04:05:58.159522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 04:05:58.159912) ========= ========= Total master_lag: 0.18 =========