builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1466074946.11 results: success (0) buildid: 20160616013125 builduid: 4ff50bfc5fa6492196f22a26fd4df1a4 revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.110112) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.112941) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.113230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.128466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.128841) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 04:02:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-16 04:02:26 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.246476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.246795) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023093 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.297748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.298105) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6b40db1565705c392042da04396d1ca83c0d017d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6b40db1565705c392042da04396d1ca83c0d017d --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=516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 04:02:26,488 truncating revision to first 12 chars 2016-06-16 04:02:26,488 Setting DEBUG logging. 2016-06-16 04:02:26,488 attempt 1/10 2016-06-16 04:02:26,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6b40db156570?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 04:02:26,798 unpacking tar archive at: mozilla-central-6b40db156570/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655650 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.967556) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.967896) ========= script_repo_revision: 6b40db1565705c392042da04396d1ca83c0d017d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.968322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.968629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 04:02:26.981842) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-16 04:02:26.982207) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:02:27 INFO - MultiFileLogger online at 20160616 04:02:27 in /builds/slave/test 04:02:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:02:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:02:27 INFO - {'append_to_log': False, 04:02:27 INFO - 'base_work_dir': '/builds/slave/test', 04:02:27 INFO - 'blob_upload_branch': 'Firefox', 04:02:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:02:27 INFO - 'branch': 'Firefox', 04:02:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:02:27 INFO - 'config_files': ('talos/linux_config.py',), 04:02:27 INFO - 'default_actions': ('clobber', 04:02:27 INFO - 'read-buildbot-config', 04:02:27 INFO - 'download-and-extract', 04:02:27 INFO - 'populate-webroot', 04:02:27 INFO - 'create-virtualenv', 04:02:27 INFO - 'install', 04:02:27 INFO - 'run-tests'), 04:02:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:02:27 INFO - 'download_minidump_stackwalk': True, 04:02:27 INFO - 'download_symbols': 'ondemand', 04:02:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:02:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:02:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:02:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:02:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:02:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:02:27 INFO - 'installer_path': 'installer.exe', 04:02:27 INFO - 'log_level': 'info', 04:02:27 INFO - 'log_name': 'talos', 04:02:27 INFO - 'log_to_console': True, 04:02:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:02:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:02:27 INFO - 'opt_config_files': (), 04:02:27 INFO - 'pip_index': False, 04:02:27 INFO - 'sps_profile': False, 04:02:27 INFO - 'sps_profile_interval': 0, 04:02:27 INFO - 'suite': 'dromaeojs', 04:02:27 INFO - 'system_bits': '32', 04:02:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:02:27 INFO - 'title': 'talos-linux64-ix-061', 04:02:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:02:27 INFO - 'use_talos_json': True, 04:02:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:02:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:02:27 INFO - 'work_dir': 'build'} 04:02:27 INFO - ##### 04:02:27 INFO - ##### Running clobber step. 04:02:27 INFO - ##### 04:02:27 INFO - Running pre-action listener: _resource_record_pre_action 04:02:27 INFO - Running main action method: clobber 04:02:27 INFO - rmtree: /builds/slave/test/build 04:02:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - ##### 04:02:28 INFO - ##### Finished clobber step (success) 04:02:28 INFO - ##### 04:02:28 INFO - ##### 04:02:28 INFO - ##### Running read-buildbot-config step. 04:02:28 INFO - ##### 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running main action method: read_buildbot_config 04:02:28 INFO - Using buildbot properties: 04:02:28 INFO - { 04:02:28 INFO - "project": "", 04:02:28 INFO - "product": "firefox", 04:02:28 INFO - "script_repo_revision": "production", 04:02:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:02:28 INFO - "repository": "", 04:02:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:02:28 INFO - "buildid": "20160616013125", 04:02:28 INFO - "pgo_build": "True", 04:02:28 INFO - "basedir": "/builds/slave/test", 04:02:28 INFO - "buildnumber": 342, 04:02:28 INFO - "slavename": "talos-linux64-ix-061", 04:02:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:02:28 INFO - "platform": "ubuntu64_hw", 04:02:28 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:02:28 INFO - "branch": "mozilla-central", 04:02:28 INFO - "repo_path": "mozilla-central", 04:02:28 INFO - "revision": "6b40db1565705c392042da04396d1ca83c0d017d", 04:02:28 INFO - "stage_platform": "linux64-pgo", 04:02:28 INFO - "builduid": "4ff50bfc5fa6492196f22a26fd4df1a4", 04:02:28 INFO - "slavebuilddir": "test" 04:02:28 INFO - } 04:02:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:02:28 INFO - Running post-action listener: _resource_record_post_action 04:02:28 INFO - ##### 04:02:28 INFO - ##### Finished read-buildbot-config step (success) 04:02:28 INFO - ##### 04:02:28 INFO - ##### 04:02:28 INFO - ##### Running download-and-extract step. 04:02:28 INFO - ##### 04:02:28 INFO - Running pre-action listener: _resource_record_pre_action 04:02:28 INFO - Running main action method: download_and_extract 04:02:28 INFO - mkdir: /builds/slave/test/build/tests 04:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:28 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:02:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:02:34 INFO - Downloaded 1361 bytes. 04:02:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:02:34 INFO - Using the following test package requirements: 04:02:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:02:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:02:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'jsshell-linux-x86_64.zip'], 04:02:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:02:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:02:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:02:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:02:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:02:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:02:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:02:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:02: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')]} 04:02:34 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:36 INFO - Downloaded 24220364 bytes. 04:02:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:02:37 INFO - Return code: 0 04:02:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:02: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')]} 04:02:37 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:02:42 INFO - Downloaded 24220364 bytes. 04:02:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:02:43 INFO - Return code: 0 04:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:43 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:02:44 INFO - Downloaded 14405384 bytes. 04:02:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:02:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:02:44 INFO - Return code: 0 04:02: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')]} 04:02:44 INFO - https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:02:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:02:47 INFO - Downloaded 59401722 bytes. 04:02:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:47 INFO - mkdir: /builds/slave/test/properties 04:02:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:02:47 INFO - Writing to file /builds/slave/test/properties/build_url 04:02:47 INFO - Contents: 04:02:47 INFO - build_url:https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:02:48 INFO - Running post-action listener: _resource_record_post_action 04:02:48 INFO - Running post-action listener: set_extra_try_arguments 04:02:48 INFO - ##### 04:02:48 INFO - ##### Finished download-and-extract step (success) 04:02:48 INFO - ##### 04:02:48 INFO - ##### 04:02:48 INFO - ##### Running populate-webroot step. 04:02:48 INFO - ##### 04:02:48 INFO - Running pre-action listener: _resource_record_pre_action 04:02:48 INFO - Running main action method: populate_webroot 04:02:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:02:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:02:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:02:48 INFO - '--tppagecycles', 04:02:48 INFO - '7'], 04:02:48 INFO - 'tests': ['tsvgm']}}, 04:02:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:02:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:02:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:02:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:02:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:02:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['damp', 'tps']}, 04:02:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'tests': ['damp', 'tps']}, 04:02:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['dromaeo_dom']}, 04:02:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:02:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['basic_compositor_video']}, 04:02:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:02:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['a11yr', 04:02:48 INFO - 'ts_paint', 04:02:48 INFO - 'tpaint', 04:02:48 INFO - 'sessionrestore', 04:02:48 INFO - 'sessionrestore_no_auto_restore', 04:02:48 INFO - 'tabpaint']}, 04:02:48 INFO - 'other-e10s': {'tests': ['a11yr', 04:02:48 INFO - 'ts_paint', 04:02:48 INFO - 'tpaint', 04:02:48 INFO - 'sessionrestore', 04:02:48 INFO - 'sessionrestore_no_auto_restore', 04:02:48 INFO - 'tabpaint']}, 04:02:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:02:48 INFO - 'ts_paint', 04:02:48 INFO - 'tpaint', 04:02:48 INFO - 'sessionrestore', 04:02:48 INFO - 'sessionrestore_no_auto_restore', 04:02:48 INFO - 'tabpaint']}, 04:02:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:02:48 INFO - 'ts_paint', 04:02:48 INFO - 'tpaint', 04:02:48 INFO - 'sessionrestore', 04:02:48 INFO - 'sessionrestore_no_auto_restore', 04:02:48 INFO - 'tabpaint']}, 04:02:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['a11yr', 04:02:48 INFO - 'ts_paint', 04:02:48 INFO - 'tpaint', 04:02:48 INFO - 'sessionrestore', 04:02:48 INFO - 'sessionrestore_no_auto_restore', 04:02:48 INFO - 'tabpaint']}, 04:02:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['a11yr', 04:02:48 INFO - 'ts_paint', 04:02:48 INFO - 'tpaint', 04:02:48 INFO - 'sessionrestore', 04:02:48 INFO - 'sessionrestore_no_auto_restore', 04:02:48 INFO - 'tabpaint']}, 04:02:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['tsvgx', 04:02:48 INFO - 'tsvgr_opacity', 04:02:48 INFO - 'tart', 04:02:48 INFO - 'tscrollx', 04:02:48 INFO - 'cart']}, 04:02:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:02:48 INFO - 'tsvgr_opacity', 04:02:48 INFO - 'tart', 04:02:48 INFO - 'tscrollx', 04:02:48 INFO - 'cart']}, 04:02:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'talos_options': ['--disable-e10s'], 04:02:48 INFO - 'tests': ['tp5o']}, 04:02:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'tests': ['tp5o']}, 04:02:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'talos_options': ['--disable-e10s', 04:02:48 INFO - '--xperf_path', 04:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:48 INFO - 'tests': ['tp5n']}, 04:02:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:02:48 INFO - 'talos_options': ['--xperf_path', 04:02:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:02:48 INFO - 'tests': ['tp5n']}}, 04:02:48 INFO - 'talos.zip': {'path': '', 04:02:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:02:48 INFO - Running post-action listener: _resource_record_post_action 04:02:48 INFO - ##### 04:02:48 INFO - ##### Finished populate-webroot step (success) 04:02:48 INFO - ##### 04:02:48 INFO - ##### 04:02:48 INFO - ##### Running create-virtualenv step. 04:02:48 INFO - ##### 04:02:48 INFO - Running pre-action listener: _resource_record_pre_action 04:02:48 INFO - Running main action method: create_virtualenv 04:02:48 INFO - Creating virtualenv /builds/slave/test/build/venv 04:02:48 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 04:02:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:02:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:02:48 INFO - Using real prefix '/usr' 04:02:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:02:49 INFO - Installing distribute.............................................................................................................................................................................................done. 04:02:51 INFO - Installing pip.................done. 04:02:51 INFO - Return code: 0 04:02:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:02:51 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')]} 04:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:51 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')]} 04:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:51 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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:02:51 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 04:02:51 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 04:02:51 INFO - Using env: {'DISPLAY': ':0', 04:02:51 INFO - 'HOME': '/home/cltbld', 04:02:51 INFO - 'LANG': 'en_US.UTF-8', 04:02:51 INFO - 'LANGUAGE': 'en_US:en', 04:02:51 INFO - 'LOGNAME': 'cltbld', 04:02:51 INFO - 'MAIL': '/var/mail/cltbld', 04:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:51 INFO - 'MOZ_NO_REMOTE': '1', 04:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:51 INFO - 'NO_EM_RESTART': '1', 04:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:51 INFO - 'PWD': '/builds/slave/test', 04:02:51 INFO - 'SHELL': '/bin/bash', 04:02:51 INFO - 'SHLVL': '1', 04:02:51 INFO - 'TERM': 'linux', 04:02:51 INFO - 'TMOUT': '86400', 04:02:51 INFO - 'USER': 'cltbld', 04:02:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:51 INFO - '_': '/tools/buildbot/bin/python'} 04:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:51 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 04:02:51 INFO - Cleaning up... 04:02:51 INFO - Return code: 0 04:02:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:02:51 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')]} 04:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:51 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')]} 04:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:51 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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:02:51 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 04:02:51 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 04:02:51 INFO - Using env: {'DISPLAY': ':0', 04:02:51 INFO - 'HOME': '/home/cltbld', 04:02:51 INFO - 'LANG': 'en_US.UTF-8', 04:02:51 INFO - 'LANGUAGE': 'en_US:en', 04:02:51 INFO - 'LOGNAME': 'cltbld', 04:02:51 INFO - 'MAIL': '/var/mail/cltbld', 04:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:51 INFO - 'MOZ_NO_REMOTE': '1', 04:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:51 INFO - 'NO_EM_RESTART': '1', 04:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:51 INFO - 'PWD': '/builds/slave/test', 04:02:51 INFO - 'SHELL': '/bin/bash', 04:02:51 INFO - 'SHLVL': '1', 04:02:51 INFO - 'TERM': 'linux', 04:02:51 INFO - 'TMOUT': '86400', 04:02:51 INFO - 'USER': 'cltbld', 04:02:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:51 INFO - '_': '/tools/buildbot/bin/python'} 04:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:51 INFO - Downloading/unpacking psutil>=3.1.1 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:02:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:53 INFO - Installing collected packages: psutil 04:02:53 INFO - Running setup.py install for psutil 04:02:53 INFO - building 'psutil._psutil_linux' extension 04:02:53 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 04:02:54 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 04:02:54 INFO - building 'psutil._psutil_posix' extension 04:02:54 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 04:02:54 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 04:02:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:02:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:02:54 INFO - Successfully installed psutil 04:02:54 INFO - Cleaning up... 04:02:54 INFO - Return code: 0 04:02:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:02:54 INFO - Using env: {'DISPLAY': ':0', 04:02:54 INFO - 'HOME': '/home/cltbld', 04:02:54 INFO - 'LANG': 'en_US.UTF-8', 04:02:54 INFO - 'LANGUAGE': 'en_US:en', 04:02:54 INFO - 'LOGNAME': 'cltbld', 04:02:54 INFO - 'MAIL': '/var/mail/cltbld', 04:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:54 INFO - 'MOZ_NO_REMOTE': '1', 04:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:54 INFO - 'NO_EM_RESTART': '1', 04:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:54 INFO - 'PWD': '/builds/slave/test', 04:02:54 INFO - 'SHELL': '/bin/bash', 04:02:54 INFO - 'SHLVL': '1', 04:02:54 INFO - 'TERM': 'linux', 04:02:54 INFO - 'TMOUT': '86400', 04:02:54 INFO - 'USER': 'cltbld', 04:02:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:54 INFO - '_': '/tools/buildbot/bin/python'} 04:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:02:56 INFO - Installing collected packages: mozsystemmonitor 04:02:56 INFO - Running setup.py install for mozsystemmonitor 04:02:56 INFO - Successfully installed mozsystemmonitor 04:02:56 INFO - Cleaning up... 04:02:57 INFO - Return code: 0 04:02:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:02:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:02:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:02:57 INFO - Using env: {'DISPLAY': ':0', 04:02:57 INFO - 'HOME': '/home/cltbld', 04:02:57 INFO - 'LANG': 'en_US.UTF-8', 04:02:57 INFO - 'LANGUAGE': 'en_US:en', 04:02:57 INFO - 'LOGNAME': 'cltbld', 04:02:57 INFO - 'MAIL': '/var/mail/cltbld', 04:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:57 INFO - 'MOZ_NO_REMOTE': '1', 04:02:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:57 INFO - 'NO_EM_RESTART': '1', 04:02:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:57 INFO - 'PWD': '/builds/slave/test', 04:02:57 INFO - 'SHELL': '/bin/bash', 04:02:57 INFO - 'SHLVL': '1', 04:02:57 INFO - 'TERM': 'linux', 04:02:57 INFO - 'TMOUT': '86400', 04:02:57 INFO - 'USER': 'cltbld', 04:02:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:57 INFO - '_': '/tools/buildbot/bin/python'} 04:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02: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 04:02:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:02:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:59 INFO - Downloading functools32-3.2.3-2.tar.gz 04:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:02:59 INFO - warning: no files found matching '*.txt' 04:02:59 INFO - no previously-included directories found matching 'build' 04:02:59 INFO - no previously-included directories found matching 'dist' 04:02:59 INFO - no previously-included directories found matching '.git*' 04:02:59 INFO - Installing collected packages: jsonschema, functools32 04:02:59 INFO - Running setup.py install for functools32 04:02:59 INFO - warning: no files found matching '*.txt' 04:02:59 INFO - no previously-included directories found matching 'build' 04:02:59 INFO - no previously-included directories found matching 'dist' 04:02:59 INFO - no previously-included directories found matching '.git*' 04:02:59 INFO - Successfully installed jsonschema functools32 04:02:59 INFO - Cleaning up... 04:02:59 INFO - Return code: 0 04:02:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:02: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')]} 04:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02: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')]} 04:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:02:59 INFO - Using env: {'DISPLAY': ':0', 04:02:59 INFO - 'HOME': '/home/cltbld', 04:02:59 INFO - 'LANG': 'en_US.UTF-8', 04:02:59 INFO - 'LANGUAGE': 'en_US:en', 04:02:59 INFO - 'LOGNAME': 'cltbld', 04:02:59 INFO - 'MAIL': '/var/mail/cltbld', 04:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:02:59 INFO - 'MOZ_NO_REMOTE': '1', 04:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:02:59 INFO - 'NO_EM_RESTART': '1', 04:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:02:59 INFO - 'PWD': '/builds/slave/test', 04:02:59 INFO - 'SHELL': '/bin/bash', 04:02:59 INFO - 'SHLVL': '1', 04:02:59 INFO - 'TERM': 'linux', 04:02:59 INFO - 'TMOUT': '86400', 04:02:59 INFO - 'USER': 'cltbld', 04:02:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:02:59 INFO - '_': '/tools/buildbot/bin/python'} 04:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:02:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:02:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:03:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:03:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:03: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 04:03: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 04:03: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 04:03: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 04:03: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 04:03: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 04:03:02 INFO - Downloading docopt-0.6.1.tar.gz 04:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:03:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:03:02 INFO - Running setup.py install for blobuploader 04:03:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:03:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:03:02 INFO - Running setup.py install for requests 04:03:02 INFO - Running setup.py install for docopt 04:03:03 INFO - Successfully installed blobuploader requests docopt 04:03:03 INFO - Cleaning up... 04:03:03 INFO - Return code: 0 04:03:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:03 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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:03:03 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 04:03:03 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 04:03:03 INFO - Using env: {'DISPLAY': ':0', 04:03:03 INFO - 'HOME': '/home/cltbld', 04:03:03 INFO - 'LANG': 'en_US.UTF-8', 04:03:03 INFO - 'LANGUAGE': 'en_US:en', 04:03:03 INFO - 'LOGNAME': 'cltbld', 04:03:03 INFO - 'MAIL': '/var/mail/cltbld', 04:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:03 INFO - 'MOZ_NO_REMOTE': '1', 04:03:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:03 INFO - 'NO_EM_RESTART': '1', 04:03:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:03 INFO - 'PWD': '/builds/slave/test', 04:03:03 INFO - 'SHELL': '/bin/bash', 04:03:03 INFO - 'SHLVL': '1', 04:03:03 INFO - 'TERM': 'linux', 04:03:03 INFO - 'TMOUT': '86400', 04:03:03 INFO - 'USER': 'cltbld', 04:03:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:03 INFO - '_': '/tools/buildbot/bin/python'} 04:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:03 INFO - Running setup.py (path:/tmp/pip-D2k5qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:03 INFO - Running setup.py (path:/tmp/pip-hwp7Tj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:03 INFO - Running setup.py (path:/tmp/pip-ODWGSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:03 INFO - Running setup.py (path:/tmp/pip-N4jvkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:03 INFO - Running setup.py (path:/tmp/pip-uvg2aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:03 INFO - Running setup.py (path:/tmp/pip-NvHA0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:03 INFO - Running setup.py (path:/tmp/pip-4mzIUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:03 INFO - Running setup.py (path:/tmp/pip-dWijDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:03 INFO - Running setup.py (path:/tmp/pip-uv5GWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:03 INFO - Running setup.py (path:/tmp/pip-y53Qau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:04 INFO - Running setup.py (path:/tmp/pip-MCSBF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:04 INFO - Running setup.py (path:/tmp/pip-WrnvWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:04 INFO - Running setup.py (path:/tmp/pip-waw9Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:04 INFO - Running setup.py (path:/tmp/pip-odXT_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:04 INFO - Running setup.py (path:/tmp/pip-qjp8NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:04 INFO - Running setup.py (path:/tmp/pip-mLJVfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:04 INFO - Running setup.py (path:/tmp/pip-fawNLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:03:04 INFO - Running setup.py install for manifestparser 04:03:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:03:04 INFO - Running setup.py install for mozcrash 04:03:04 INFO - Running setup.py install for mozdebug 04:03:04 INFO - Running setup.py install for mozdevice 04:03:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:03:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:03:04 INFO - Running setup.py install for mozfile 04:03:05 INFO - Running setup.py install for mozhttpd 04:03:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Running setup.py install for mozinfo 04:03:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Running setup.py install for mozInstall 04:03:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Running setup.py install for mozleak 04:03:05 INFO - Running setup.py install for mozlog 04:03:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Running setup.py install for moznetwork 04:03:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Running setup.py install for mozprocess 04:03:05 INFO - Running setup.py install for mozprofile 04:03:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:03:05 INFO - Running setup.py install for mozrunner 04:03:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:03:06 INFO - Running setup.py install for mozscreenshot 04:03:06 INFO - Running setup.py install for moztest 04:03:06 INFO - Running setup.py install for mozversion 04:03:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:03:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:03:06 INFO - Cleaning up... 04:03:06 INFO - Return code: 0 04:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:06 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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:03:06 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 04:03:06 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 04:03:06 INFO - Using env: {'DISPLAY': ':0', 04:03:06 INFO - 'HOME': '/home/cltbld', 04:03:06 INFO - 'LANG': 'en_US.UTF-8', 04:03:06 INFO - 'LANGUAGE': 'en_US:en', 04:03:06 INFO - 'LOGNAME': 'cltbld', 04:03:06 INFO - 'MAIL': '/var/mail/cltbld', 04:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:06 INFO - 'MOZ_NO_REMOTE': '1', 04:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:06 INFO - 'NO_EM_RESTART': '1', 04:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:06 INFO - 'PWD': '/builds/slave/test', 04:03:06 INFO - 'SHELL': '/bin/bash', 04:03:06 INFO - 'SHLVL': '1', 04:03:06 INFO - 'TERM': 'linux', 04:03:06 INFO - 'TMOUT': '86400', 04:03:06 INFO - 'USER': 'cltbld', 04:03:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:06 INFO - '_': '/tools/buildbot/bin/python'} 04:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:06 INFO - Running setup.py (path:/tmp/pip-GSQQ9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:06 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)) 04:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:06 INFO - Running setup.py (path:/tmp/pip-Rr3G5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:06 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)) 04:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:06 INFO - Running setup.py (path:/tmp/pip-XZDCwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:06 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)) 04:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:06 INFO - Running setup.py (path:/tmp/pip-S6K8hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:06 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)) 04:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:06 INFO - Running setup.py (path:/tmp/pip-3Pt12_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:06 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)) 04:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:06 INFO - Running setup.py (path:/tmp/pip-mPJAWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:06 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)) 04:03:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:06 INFO - Running setup.py (path:/tmp/pip-iPsG9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:07 INFO - Running setup.py (path:/tmp/pip-H9oJZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:07 INFO - Running setup.py (path:/tmp/pip-4CibTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:07 INFO - Running setup.py (path:/tmp/pip-2vyMRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:07 INFO - Running setup.py (path:/tmp/pip-zZ8itI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:07 INFO - Running setup.py (path:/tmp/pip-6CseO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:07 INFO - Running setup.py (path:/tmp/pip-R2Xvd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:07 INFO - Running setup.py (path:/tmp/pip-9SjEM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:07 INFO - Running setup.py (path:/tmp/pip-xnxyaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:07 INFO - Running setup.py (path:/tmp/pip-XoboHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:07 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)) 04:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:07 INFO - Running setup.py (path:/tmp/pip-8igm3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:07 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)) 04:03:07 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)) 04:03:07 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)) 04:03:07 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)) 04:03:07 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)) 04:03:07 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)) 04:03:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:07 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 04:03:07 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 04:03:07 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 04:03:07 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 04:03:07 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 04:03:07 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 04:03:09 INFO - Downloading blessings-1.6.tar.gz 04:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:03:09 INFO - Installing collected packages: blessings 04:03:09 INFO - Running setup.py install for blessings 04:03:09 INFO - Successfully installed blessings 04:03:09 INFO - Cleaning up... 04:03:09 INFO - Return code: 0 04:03:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:03:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:10 INFO - Reading from file tmpfile_stdout 04:03:10 INFO - Current package versions: 04:03:10 INFO - argparse == 1.2.1 04:03:10 INFO - blessings == 1.6 04:03:10 INFO - blobuploader == 1.2.4 04:03:10 INFO - docopt == 0.6.1 04:03:10 INFO - functools32 == 3.2.3-2 04:03:10 INFO - jsonschema == 2.5.1 04:03:10 INFO - manifestparser == 1.1 04:03:10 INFO - mozInstall == 1.12 04:03:10 INFO - mozcrash == 0.17 04:03:10 INFO - mozdebug == 0.1 04:03:10 INFO - mozdevice == 0.48 04:03:10 INFO - mozfile == 1.2 04:03:10 INFO - mozhttpd == 0.7 04:03:10 INFO - mozinfo == 0.9 04:03:10 INFO - mozleak == 0.1 04:03:10 INFO - mozlog == 3.2 04:03:10 INFO - moznetwork == 0.27 04:03:10 INFO - mozprocess == 0.22 04:03:10 INFO - mozprofile == 0.28 04:03:10 INFO - mozrunner == 6.11 04:03:10 INFO - mozscreenshot == 0.1 04:03:10 INFO - mozsystemmonitor == 0.3 04:03:10 INFO - moztest == 0.7 04:03:10 INFO - mozversion == 1.4 04:03:10 INFO - psutil == 3.1.1 04:03:10 INFO - requests == 1.2.3 04:03:10 INFO - wsgiref == 0.1.2 04:03:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:03:10 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 04:03:10 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 04:03:10 INFO - Using env: {'DISPLAY': ':0', 04:03:10 INFO - 'HOME': '/home/cltbld', 04:03:10 INFO - 'LANG': 'en_US.UTF-8', 04:03:10 INFO - 'LANGUAGE': 'en_US:en', 04:03:10 INFO - 'LOGNAME': 'cltbld', 04:03:10 INFO - 'MAIL': '/var/mail/cltbld', 04:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:10 INFO - 'MOZ_NO_REMOTE': '1', 04:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:10 INFO - 'NO_EM_RESTART': '1', 04:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:10 INFO - 'PWD': '/builds/slave/test', 04:03:10 INFO - 'SHELL': '/bin/bash', 04:03:10 INFO - 'SHLVL': '1', 04:03:10 INFO - 'TERM': 'linux', 04:03:10 INFO - 'TMOUT': '86400', 04:03:10 INFO - 'USER': 'cltbld', 04:03:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:10 INFO - '_': '/tools/buildbot/bin/python'} 04:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 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)) 04:03:10 INFO - Cleaning up... 04:03:10 INFO - Return code: 0 04:03:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:03:10 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 04:03:10 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 04:03:10 INFO - Using env: {'DISPLAY': ':0', 04:03:10 INFO - 'HOME': '/home/cltbld', 04:03:10 INFO - 'LANG': 'en_US.UTF-8', 04:03:10 INFO - 'LANGUAGE': 'en_US:en', 04:03:10 INFO - 'LOGNAME': 'cltbld', 04:03:10 INFO - 'MAIL': '/var/mail/cltbld', 04:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:10 INFO - 'MOZ_NO_REMOTE': '1', 04:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:10 INFO - 'NO_EM_RESTART': '1', 04:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:10 INFO - 'PWD': '/builds/slave/test', 04:03:10 INFO - 'SHELL': '/bin/bash', 04:03:10 INFO - 'SHLVL': '1', 04:03:10 INFO - 'TERM': 'linux', 04:03:10 INFO - 'TMOUT': '86400', 04:03:10 INFO - 'USER': 'cltbld', 04:03:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:10 INFO - '_': '/tools/buildbot/bin/python'} 04:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:03:10 INFO - Cleaning up... 04:03:10 INFO - Return code: 0 04:03:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:03:10 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 0x7f4b051bdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ed8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ab9990>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, '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': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', '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 04:03:10 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 04:03:10 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 04:03:10 INFO - Using env: {'DISPLAY': ':0', 04:03:10 INFO - 'HOME': '/home/cltbld', 04:03:10 INFO - 'LANG': 'en_US.UTF-8', 04:03:10 INFO - 'LANGUAGE': 'en_US:en', 04:03:10 INFO - 'LOGNAME': 'cltbld', 04:03:10 INFO - 'MAIL': '/var/mail/cltbld', 04:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:10 INFO - 'MOZ_NO_REMOTE': '1', 04:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:10 INFO - 'NO_EM_RESTART': '1', 04:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:10 INFO - 'PWD': '/builds/slave/test', 04:03:10 INFO - 'SHELL': '/bin/bash', 04:03:10 INFO - 'SHLVL': '1', 04:03:10 INFO - 'TERM': 'linux', 04:03:10 INFO - 'TMOUT': '86400', 04:03:10 INFO - 'USER': 'cltbld', 04:03:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:10 INFO - '_': '/tools/buildbot/bin/python'} 04:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:10 INFO - Downloading/unpacking flake8 04:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:03:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:03:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:12 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 04:03:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:03:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:13 INFO - no previously-included directories found matching 'docs/_build' 04:03:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:03:13 INFO - Running setup.py install for pep8 04:03:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:03:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:03:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:03:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:03:13 INFO - no previously-included directories found matching 'docs/_build' 04:03:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:03:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:03:13 INFO - Cleaning up... 04:03:13 INFO - Return code: 0 04:03:13 INFO - Running post-action listener: _resource_record_post_action 04:03:13 INFO - Running post-action listener: _start_resource_monitoring 04:03:13 INFO - Starting resource monitoring. 04:03:13 INFO - ##### 04:03:13 INFO - ##### Finished create-virtualenv step (success) 04:03:13 INFO - ##### 04:03:13 INFO - ##### 04:03:13 INFO - ##### Running install step. 04:03:13 INFO - ##### 04:03:13 INFO - Running pre-action listener: _resource_record_pre_action 04:03:13 INFO - Running main action method: install 04:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:13 INFO - Reading from file tmpfile_stdout 04:03:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:03:13 INFO - Reading from file tmpfile_stdout 04:03:13 INFO - Output received: 04:03:13 INFO - Usage: mozinstall [options] installer 04:03:13 INFO - Options: 04:03:13 INFO - -h, --help show this help message and exit 04:03:13 INFO - -d DEST, --destination=DEST 04:03:13 INFO - Directory to install application into. [default: 04:03:13 INFO - "/builds/slave/test"] 04:03:13 INFO - --app=APP Application being installed. [default: firefox] 04:03:13 INFO - mkdir: /builds/slave/test/build/application 04:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:03:30 INFO - Reading from file tmpfile_stdout 04:03:30 INFO - Output received: 04:03:30 INFO - /builds/slave/test/build/application/firefox/firefox 04:03:30 INFO - Running post-action listener: _resource_record_post_action 04:03:30 INFO - ##### 04:03:30 INFO - ##### Finished install step (success) 04:03:30 INFO - ##### 04:03:30 INFO - ##### 04:03:30 INFO - ##### Running run-tests step. 04:03:30 INFO - ##### 04:03:30 INFO - Running pre-action listener: _resource_record_pre_action 04:03:30 INFO - Running main action method: run_tests 04:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:03:30 INFO - Python 2.7.3 04:03:30 INFO - Return code: 0 04:03:30 INFO - grabbing minidump binary from tooltool 04:03:30 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')]} 04:03:30 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 0x1b48800>, '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 0x1b49700>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b49b90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:03:30 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 04:03:30 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 04:03:30 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 04:03:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:03:30 INFO - Return code: 0 04:03:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:03:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:03:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:03:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:03:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:03:31 INFO - Return code: 0 04:03:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 04:03:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 04:03:31 INFO - Using env: {'DISPLAY': ':0', 04:03:31 INFO - 'HOME': '/home/cltbld', 04:03:31 INFO - 'LANG': 'en_US.UTF-8', 04:03:31 INFO - 'LANGUAGE': 'en_US:en', 04:03:31 INFO - 'LOGNAME': 'cltbld', 04:03:31 INFO - 'MAIL': '/var/mail/cltbld', 04:03:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:03:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:31 INFO - 'MOZ_NO_REMOTE': '1', 04:03:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:31 INFO - 'NO_EM_RESTART': '1', 04:03:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:31 INFO - 'PWD': '/builds/slave/test', 04:03:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:03:31 INFO - 'SHELL': '/bin/bash', 04:03:31 INFO - 'SHLVL': '1', 04:03:31 INFO - 'TERM': 'linux', 04:03:31 INFO - 'TMOUT': '86400', 04:03:31 INFO - 'USER': 'cltbld', 04:03:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429', 04:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:31 INFO - '_': '/tools/buildbot/bin/python'} 04:03:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 04:03:32 INFO - mozversion application_buildid: 20160616013125 04:03:32 INFO - mozversion application_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 04:03:32 INFO - mozversion application_display_name: Nightly 04:03:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:03:32 INFO - mozversion application_name: Firefox 04:03:32 INFO - mozversion application_remotingname: firefox 04:03:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:03:32 INFO - mozversion application_vendor: Mozilla 04:03:32 INFO - mozversion application_version: 50.0a1 04:03:32 INFO - mozversion platform_buildid: 20160616013125 04:03:32 INFO - mozversion platform_changeset: 6b40db1565705c392042da04396d1ca83c0d017d 04:03:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:03:32 INFO - mozversion platform_version: 50.0a1 04:03:32 INFO - using testdate: 1466075012 04:03:32 INFO - actual date: 1466075012 04:03:32 INFO - starting webserver on 'localhost:34018' 04:03:32 INFO - SUITE-START | Running 2 tests 04:03:32 INFO - TEST-START | dromaeo_css 04:03:32 INFO - operating with platform_type : linux_ 04:03:32 INFO - Initialising browser for dromaeo_css test... 04:03:32 INFO - TEST-INFO | started process 27614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm04i5G/profile http://localhost:34018/getInfo.html) 04:03:36 INFO - PROCESS | 27614 | __metrics Screen width/height:1600/1200 04:03:36 INFO - PROCESS | 27614 | colorDepth:24 04:03:36 INFO - PROCESS | 27614 | Browser inner width/height: 1024/697 04:03:36 INFO - PROCESS | 27614 | __metrics 04:03:37 INFO - PROCESS | 27614 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:03:38 INFO - PROCESS | 27614 | console.error: PushService: 04:03:38 INFO - PROCESS | 27614 | stateChangeProcessEnqueue: Error transitioning state 04:03:38 INFO - PROCESS | 27614 | UnknownError 04:03:38 INFO - TEST-INFO | 27614: exit 0 04:03:38 INFO - Browser initialized. 04:03:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:03:38 INFO - TEST-INFO | started process 27695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm04i5G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:03:50 INFO - PROCESS | 27695 | RSS: Main: 174514176 04:03:50 INFO - PROCESS | 27695 | 04:04:41 INFO - PROCESS | 27695 | 1466075081486 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] 04:06:50 INFO - PROCESS | 27695 | Cycle 1(1): loaded http://localhost:34018/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34018/tests/dromaeo/cssquery-ext.html) 04:06:51 INFO - PROCESS | 27695 | RSS: Main: 266670080 04:06:51 INFO - PROCESS | 27695 | 04:09:53 INFO - PROCESS | 27695 | Cycle 1(1): loaded http://localhost:34018/tests/dromaeo/cssquery-ext.html (next: http://localhost:34018/tests/dromaeo/cssquery-jquery.html) 04:09:54 INFO - PROCESS | 27695 | RSS: Main: 268537856 04:09:54 INFO - PROCESS | 27695 | 04:12:56 INFO - PROCESS | 27695 | Cycle 1(1): loaded http://localhost:34018/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34018/tests/dromaeo/cssquery-mootools.html) 04:12:57 INFO - PROCESS | 27695 | RSS: Main: 265244672 04:12:57 INFO - PROCESS | 27695 | 04:15:59 INFO - PROCESS | 27695 | Cycle 1(1): loaded http://localhost:34018/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34018/tests/dromaeo/cssquery-prototype.html) 04:15:59 INFO - PROCESS | 27695 | RSS: Main: 267735040 04:15:59 INFO - PROCESS | 27695 | 04:19:02 INFO - PROCESS | 27695 | Cycle 1(1): loaded http://localhost:34018/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34018/tests/dromaeo/cssquery-yui.html) 04:19:03 INFO - PROCESS | 27695 | RSS: Main: 248745984 04:19:03 INFO - PROCESS | 27695 | 04:22:05 INFO - PROCESS | 27695 | Cycle 1(1): loaded http://localhost:34018/tests/dromaeo/cssquery-yui.html (next: http://localhost:34018/tests/dromaeo/cssquery-dojo.html) 04:22:06 INFO - PROCESS | 27695 | RSS: Main: 304664576 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | __start_tp_report 04:22:06 INFO - PROCESS | 27695 | _x_x_mozilla_page_load 04:22:06 INFO - PROCESS | 27695 | _x_x_mozilla_page_load_details 04:22:06 INFO - PROCESS | 27695 | |i|pagename|runs| 04:22:06 INFO - PROCESS | 27695 | |0;dojo.html;3119.469690152674;3120.2667373167315;3143.481325581279;3162.683731626836;3189.5694081299016;5341.626086173969;5415.702136382497;5416.810411635589;5466.617336786427;5497.038018346793;5439.728013599324;5460.235567020621;5494.917576236349;5509.090999984997;5510.448955104497;4970.3787026621585;5044.924326135093;5049.899002019957;5067;5160.432352441228;5043.470435604246;5050;5091.974540127294;5104.106781313274;5117.897642047157;4871.050145221683;4926.581240594536;4928.975355123237;4938.851834444972;4972.204447288453;4912.649021519075;4948.406191257036;4951.762059485129;5001.874953126201;5052.191649336089;4953.083679519301;4956.132676781584;4957.90084198314;4984.152694041985;4999.250112483121;5335.119705248668;5438.972805135989;5493.450654934514;5501.202325662796;5522.392536820947;5829.679367634779;5917.792877249276;5918.348981612019;5925.466707996258;5931.436513531207;5705.372409035002;5894.675792831393;5910.763569457216;5975.611585246945;5976.671283079429;5406.513413792738;5460.017196904556;5475.288212532425;5485.424030476823;5527.44725527444;6006.189164462741;6008.639481631116;6016.488598469179;6018.759249630053;6022.397760223943;5609.719514024282;5788.218590490314;5806.79676211339;5809.8547536311935;5810.244668193108;5718.370979192286;5772.365039845614;5789.739461724148;5815.185873977646;5818.709064546756;5743.4543718346695;5782.710864456761;5784.132380142928;5786.71066446676;5787.797427090116;5638.718064096861;5762.481376676119;5793.913091303634;5800.883982320414;5802.709864506842;4456.710313829655;4481;4481.439820022497;4515.187266292099;4523.434570678665;3948.4274780156716;3967.6230758077936;3973.543042550086;3980.6218409251073;4000.7799571023875;5326.813561525328;5390.407055223922;5472.480114389126;5477.917831232535;5525.917111243334;5871.911921321183;5875.970620146957;5876.1479585459865;5931.614445061057;5945.1973983512535;5461.371942226615;5475.479829416199;5480.616356855062;5482.150266708666;5486.506214440719;4896.608271338356;4928.359313289249;4961.603071754251;5032.396112466454;5087.745612719349;5945.672987985702;5947.49446297061;5954.85112872173;5955.136505206808;5989.431004054608;5781.94218057814;5816.621919575214;5816.73824677882;5817.76728930838;5820.097884827858;5919;5939.673317967553;5948.137520059654;5949.196858424058;5989.580729349078;5725.799597014085;5726.570507211893;5730.856728581652;5734.569907256889;5770.307563092456;5824.359320474659;5836.182934389104;5886.087656413263;5895.970520147372;5899.056151015817;5668.291463567054;5699.772009119754;5702.45826646468;5776;5780.624259423124;5735.741891614971;5777.335606405317;5778.971105144447;5781.768729250783;5791.218185545066;5464.9453505464435;5617.943820561905;5633.492985631313;5634.352049514195;5634.971825140848;5673.914891276717;5705.857353566194;5716.742746576331;5798.304203495608;5800.622959507618;5624.465675760796;5634.830955071355;5645.661260324394;5650.406707295675;5690.630109042899 04:22:06 INFO - PROCESS | 27695 | |1;ext.html;619.3032838057186;634.2040738872714;641.0992555459578;645.1451826330114;649.7401039584166;32058.67941320586;34706.82646586766;44653.33020004703;45888;46050.76974615131;47158.528414715845;47737;47762.28356574654;47840.282395764094;47840.52159478404;8796.340274479408;8996.280297576179;9005.54972251388;9010.414323069012;9014.098590140999;8874.112588741107;8963.731088067369;8966.327525435585;8970.192682658559;8971.551422428885;8991.685291014783;9047.728568142966;9048.41185322952;9049.276057915384;9050.637974481013;8962.327825413087;9002.459852408843;9005.414648047856;9023.684171053981;9027.232685221765;8922.15239552248;8975.865362019575;8982.326325525612;8989.056149104315;8992.77518062047;42643.78678106589;42738;43141.47014563457;43176.352354714705;43183;3399.2761168129405;3771.4908487354405;3833.8274777635074;4004.819783109767;4357.085012147453;32728;32870.671293287;33251.5012274816;34014.82992585046;34281.48577771335;4203.516595591515;4208.416833667313;4244.3209086546;4247.5540068293;4324.2648749712625;323150;325675;325686;328315;332003;52838;60493.395066048775;60773.39226607766;61409.385906140364;62464.68767656224;64878.35121648723;64901.67549162319;65230.347696522425;65272.673636631516;65285.67357163279;17431.12844357777;17651.911740441217;17657.470275891745;17659.29362825498;17667.11664416774;12500.24998500093;12633.684157896127;12814.167079139826;13461.663458413617;13575.728485430236;18258;18307.72538411925;18429.078546072644;18432.63134737298;18471.53821154482;6736.393724564813;6792.864142717118;6905;6993.943512762586;7041.4718896082995;962.605331813953;1007.7984403119406;1014.3457469932;1060.7136073260176;1071.49104175516;32346.8678596248;32605.67394326074;32952.176195595304;33445.49831752526;33487;1091.5251865438559;1118.2395970739974;1120.2438354110943;1131.9490622921987;1210.5823490895627;16268.26792794327;16685.833141668427;16806.831931680772;16876.83123168777;17065.14674266282;534214;538387;538434;539676;539703;59550;59751.40248597545;59824;59846;59964.70017649884;1253.674044748372;1352.1278775190144;1374.3746595299115;1395.3651088754796;1400.271858633505;31924.840375797972;33903;34063;34082.65917340795;34091;51012.489875102256;51572;51651.2252316208;51686;51689.741551292005;404323;405124;405185;405318;405923;22865.19971800979;28859.42281154407;28929.85535072311;29944.25139371533;30187.547186791777;49550.50449495603;49762.25356619726;50003.74998125132;50748;51063.74468127636;40695.59304407037;41289.79355103205;41605;42464;43009;41356;41543.792281038404;41705;41894.790526047174;42202.788986054875;40398.79800600978;41032.179356413304;41848.581514184465;41893;41969.58030419657;34517;35691.82154089213;36391.818040909624;36444.635553644126;36713.44929826001;27159.592606110527;27764.722352776214;27901.441971160057;27953.72046279511;28033.859830700716 04:22:06 INFO - PROCESS | 27695 | |2;jquery.html;381.47547122706294;385.331449934364;391.2448973481181;401.5161730115211;420.7832966022497;14270.64323391913;16447.917760411183;18722;19421.320253791102;19487.317943871967;17688.734668979974;18114.818851811477;18841.24635014598;18872.905635471838;19009.904950475262;5097.388313402397;5230.2416149658275;5247.2653828464045;5279.762410691528;5340.06548853951;3828.138668799512;5201.453847346031;5227.08526007949;5269.077911365515;6932.306769323078;7372.299631534996;7392.926070739278;7507.474476786627;7526.247375262485;7540.698372065138;7209.387202087829;7399.149097853762;7399.4450416219;7400.185979542246;7403.9629801850915;7057.188423331331;7121.9643901780155;7138.321859423347;7226.096737907762;7226.891596626055;25693.743062569323;25823;26351.73648263531;26814.46371072587;26965.460690786076;2490.501899620065;2532.6327682485935;2535.4287564444185;2987.9402411951855;3202.615686117681;15294.311755970897;15873.365065397371;15953.680926381523;16067.357305707757;16101;2054.1269960266977;2097.6329142400173;2138.1554286057076;2160.9135634574754;2247.2584047264363;51229.48770512285;79379;92901.5354923221;94141.5292923531;94463;9117.632355146648;9473.857892131624;9599.136077752895;9635.554666800035;9966.2525310602;13135.737285254241;13217.405216765268;13221.471141154438;13298.601041968757;13702.177869327872;8002.9599852000365;8075.192480751878;8077.27304542594;8114.594270286462;8252.33981281508;7402.444816638774;7584.431167662337;7604.885926710993;7855.410844186709;8065.233802788725;4708.387909571802;4749.501302363271;4818.6626936114835;4843.128236917389;4890.926636100461;1924.5854297091626;1950.3661310074283;1960.6470835249793;1965.8230759231737;1970.940871773849;855.8245559660255;936.6955739384591;981.259149342242;981.5533932060895;992.513668302541;18263.908680456512;18717.438476845717;19196.71204931927;19404.417867463715;19792.802071979382;952.79991201847;955.044955044955;962.8892677342055;983.1986930651497;1042.3537406807827;10578.412294984259;10621.81345596318;10789.892101078889;11140.33158010522;11746.236494627821;495449;497520;503627;513299;514409;95080;98195;98462;100148.49925750325;100697;1000.5097502223858;1014.2038499777639;1032.6850310655173;1035.435687550287;1037.5019990404496;17679;17688.55778605545;18053.097345132428;18089.819101808815;18275.817241827943;44266.11467770562;44743.328850066624;45234.32148517709;45340.31989520226;46590.53409465862;58715.70642146762;58798.412015881004;62152.37847621466;63005.68497157485;63068.68465657642;7646.464747467624;8445.49327040355;8725.171108744658;8838.823223535364;9002.459852408876;12934.353282335658;13476.93261533686;13631.591052268448;13747.106438081493;13791.379387927367;6136.417040381157;9876.35803672759;11823.349715765715;12026.939865300617;12037.157398982337;11656.30062196271;11796.782876504478;11825.231359961575;11897.286162830258;11978.520859165536;12035.63893083174;12167.695807604881;12219.389030548615;12325.383730813603;12356;7537.73617923392;7550.509216900884;7710.344620707303;7749.380049595906;7816.765497035098;10102.747431314276;11774.882251177722;12105;12227;12313.322767247888 04:22:06 INFO - PROCESS | 27695 | |3;mootools.html;1364.0383529611613;1461.349699383774;1478.6599082211092;1610.7825443565116;1765.6556971390576;7768.728094516693;8709.608067636957;8917;8926.59830307636;9224.077592240772;8883.067277935821;9081.772955676111;9085;9087.545622718872;9087.591058402371;1967.4687834284734;2042.5302180498495;2242.8654280743126;2326.4183954011455;2360.327306717586;2324.1516846351046;2342.3207269891795;2345.44881952741;2349.2364981381033;2350.9882450587725;2309.607366747657;2321.2223904991847;2340.6020976434047;2384.2727967969763;2389.1279682915783;1930.4015755115959;2225.254539729193;2288.9198878039274;2289.175896677195;2297.7127859017623;2215.3907675389237;2233.095596283508;2235.307054813013;2246.5394594108334;2247.056236380724;8735;8792.208701216921;8799.340049496313;8810.515421651806;8816.735497935073;5128;5242.6330156889035;5254.00173966945;5259.158534634478;5260.736963151827;3366.8148251846137;3516.1209697575605;3525.7708248963736;3646.124930016777;3686.963130368689;1143.9771204575861;1177.2230327983489;1195.4500929572407;1203.4644583160498;1215.19796934024;12212.877871221352;12215.816762748565;12246.142770006103;12248.203866748632;12260.693482662915;4555.134524440346;4717.575418212309;4746.430428348551;4822.758862056883;4843.07981483517;10314.690559283234;10318.948405257926;10344.120749736358;10351.896481035094;10355.223358248162;5185.818496352609;5186.481351864859;5192.9740351298005;5194.558462530727;5195.480451954774;4275.294576394922;4709.222978208557;4717.882052948704;4848.224284114524;4853.684510506806;3960.6435420812263;4045.4538637284177;4092.795360232036;4100.7334523255895;4149.419081328617;1234.2594443333928;1261.962141135749;1279.3922886628777;1292.2246652008719;1308.0974127851753;892.6652505310509;978.295627148452;986.6026101384372;999.3204620857741;1004.8794144702537;6056.212692349966;6160.691965401712;6214.316425193225;6279.811605651837;6281.560290779693;445.9955400446019;447.26871564990824;455.05575929945496;458.11355028020887;458.8416996136328;4105.486814148231;4136.958630413657;4155.065110350147;4177.081042170717;4185.602367775056;10935.617253396093;11158.218924675357;11262.774744505065;11286.98417142461;11288.661340159808;10493.108085812639;10940.124790016938;11181.440927953732;11188.944055279671;11192.776144477064;8157.265846073882;8248.628811703487;8288.875666865002;8325.375596830261;8336.374771892133;5956.493698035715;6198.256209254738;6271;6275.497960163085;6297.771934472734;9927.453990030328;10311.484425778832;10358.378497290187;10364.689059328231;10370.637027703995;10211.540480678535;10348.637797677045;10461.953804619478;10603.098736607475;10610.840837387292;7182.96408517954;7761.9611901940125;8059.677612895419;8118;8255.25702686737;8700.651973921225;8778.385513014284;8785.428947118417;8824.602892869709;8827.382083254368;7654.196309387657;7788.805279868048;7958.562279074707;7965.4822436541435;7965.641546130554;7678.385729141543;7693.961530192313;7728.497647652885;7860.3318717909615;7923.6830526778285;6986.441084713312;7030.648467576703;7059.54112982675;7063.894041589278;7071.893921591078;5262.342207224097;5303.178007408857;5341.5459685927135;5415.106507426231;5477.616566840283;5270.31485906845;5326.227696983993;5397.460253974571;5440.211169380497;5466.426025267289 04:22:06 INFO - PROCESS | 27695 | |4;prototype.html;329.5402912936454;329.8960827339388;338.71717116207975;341.40765771386623;341.6873560691967;5358.946410535898;5362.195670649405;5369.5972802039805;5373.355197376315;5437.238786569884;5339.252504649352;5353.812616558421;5366.785328586851;5366.9463305366935;5368.167933970231;3966.4050392441077;4006.5175884922473;4164.271252530795;4186.246475634384;4190.329547272437;4106.404571337154;4147.585241475858;4171.749695018309;4178.7283826551175;4183.489906056372;3887.5140607424073;4097.303458412062;4105.486814148231;4107.753534787922;4143.295639741236;3991.800409979504;4038.7374820636564;4048.251073551388;4161.334186530171;4163.562825903297;3655.268946210742;3657.1954170082804;3662.8717994870317;3669.7614655047337;3687.870924517629;5091.974540127313;5119.923201151985;5136.200770580042;5146.966948055535;5177.197534382177;4550.476695180064;4760.404949381327;4773.594244489188;4775.689580177277;4787.712737235742;5437;5486.259354987065;5496.532794712454;5508.531774799147;5593.161025846115;4076.266272071026;4080.3063479208604;4099.713020088595;4102.876913692594;4109.198706252282;5620.859478513029;5649.209110724501;5675.51758100562;5691.402402747734;5695.572832037614;4095.685937445334;4123;4126.463559737215;4129.009037830899;4147.91704165915;4182.728122672077;4183.288840897055;4227.767472789026;4228.2811921972725;4244.575542445792;4661.487236403993;4703.929441058387;4709.293605959134;4750.527336525688;4826.710397376169;5569.412717375529;5583.162525621108;5587.38538760736;5594.1608758686525;5605.523530499953;1431.0483528453462;1446.320229492137;1454.6581553334959;1458.4530800949644;1461.6711239971135;886.3175354976632;919.9356045076914;921.7142086789025;931.9394239374554;933.4446004627235;4753.740258831343;4787.779116325384;4800.375951126401;4824.662273640882;4844.273358996179;5067.113255180328;5070.391553013662;5083.830718934666;5100.1074811907765;5124.692518448905;4498.460184777848;4790.0180463005;4802.711837289774;4818.277258411266;4825.348577942003;2693.855111577611;2712.9343841459026;2742.122520793327;2774.597683335905;2776.4030733392015;5183.948160518346;5204.5576126028955;5223.712695801692;5229.346331708536;5259.47405259471;5216.817411390583;5220.9738951305;5383.7308134593895;5776.826695199151;5828.318973272258;5792.710364481674;5844.912326315109;5853.209816674779;5883.411658834082;5887.264091988502;5661.207430959586;5698.515626171822;5775.826725198251;5820.970895145497;5821.912671309849;5646.209530665792;5678.387941546935;5683.516901063456;5712.400197979152;5753.424657534213;5877.177195192591;5948.37542058095;5959.718660488016;5962.482135540052;5984.58107932458;3995.9800200998807;4019.537753158424;4074.1647962168277;4106.712530122983;4118.91762164761;5479.287692599936;5648.604597678123;5754.6547207167705;5792.333881603501;5819.912701309569;5557.805476808292;5585.720713964204;5589.5807814413265;5624.465675760796;5641.37944826077;5578.497935185853;5600.243967064394;5621.409751975983;5632.014397480507;5639;5252.684838909678;5479.424660410759;5490.9250819541185;5512.255845460972;5515.393306736336;5520.984840533257;5557.44425557441;5578.553715702815;5579.218909352613;5581.7209139543675;5208.921866171935;5468.425815289337;5490.176473529003;5526.369720932415;5561.888762224652 04:22:06 INFO - PROCESS | 27695 | |5;yui.html;791.4855344026382;811.2698571285844;822.9053658829237;845.0704225352114;850.158343240192;14524.201168935704;15064.698706025873;15374.385024599016;15409.46066887659;15421.306041228143;14008.719825603483;14215.147091174536;15011;15747.133907635076;15796.526104216864;799.1568894815966;799.2606838674218;808.1998821167061;808.296781799832;808.3250485844297;675.9797206083825;778.0740918307224;800.2797482265978;802.2939812964584;804.1556365815899;843.9113893041234;845.2688424512813;846.6740304982595;847.6439895244013;850.306999795168;701.4073108223542;844.4257904624852;845.953472559009;846.2679781988567;846.6444093480753;604.5194070713793;614.4869034356318;615.5506480269429;619.1950464396267;619.5260625621403;15360.155191464464;15376.923115384463;15396.846031539766;15397.923010384877;15410.3835846566;12998.675033124153;13482.325883705775;13528.120672156278;13738.519151829638;14071;11812.704682382922;11867.584634537836;12292.139550231488;13110.672233194151;13475.393607287597;3833.616638336144;3854.325493038707;3881.4565960765517;3888.6305800948867;4041.2927737645796;79712;80607.5969620154;80718.59640701758;81253.18746812575;81746.59126704388;11007.449627518592;11071.557137714562;11455.713607159887;11484.253523520945;11884.524619015316;21454.785452145592;21523.78476215218;21570.46073848135;21580.136794528044;22103.668444973337;8215.09633940266;8327.583620818934;8379.706710265233;8433.662653493915;8722.258608018263;4644.396228490275;4770.284457331428;4880.6095512358925;4919.827806026772;4971.254311853251;3426.3489936911906;3523;3541.2563361694333;3549.0417587251814;3551.271989242199;605.1527860994643;619.5910698938679;622.7975907829973;630.180765005491;644.9742010319535;705.2876594639451;776.2082675670785;782.3271986091956;785.09713829097;817.7056259746487;9353.485558294358;9682.70951871445;9914.305998580174;10338.12125969286;10444.268901176996;670.1388715500558;683.1494788987742;705.0833915909298;719.2914978745931;741.6032422653855;4765.499622539653;4966.975165124151;5006.549410552995;5009.824656137018;5025.648204625714;114583;116161;116415;117982.41008794901;118001;86804.56597716971;87269;89109.55445222733;101960;102357.48821255846;74628.62685686536;87304;89333.97997090146;89612.5519372412;91487;9856.260780441638;9920.255980801614;9934.950325248617;9938;9975;49883.50116498789;50256.49743502518;50325.24512132248;50354.244686330465;52020.73989630028;71619;74434.25565744273;74922.56988564272;75567.62216189103;77896.2210377889;12165.391730413621;12178.634640960785;12206.877931220573;12737.490500379881;12877.484900603871;14731.779023314873;14795.482158124845;14842.628934276298;15028.699426011637;15268.770968435705;13731.45074197021;13847.30763461843;14047.578572642837;14174.433022678977;14510.492132775724;13503.257320847448;13565.353581411853;13678.384472698554;13930;13966.092204006707;13769.449222031408;13814.37835297394;13836.930815345859;14085.436582536993;14712.55862324132;11107.44462776874;11353.148513861328;11475.311481311148;11785.646430607096;11903.761924761284;10898.782024359627;11412.062838321099;11552.711182220512;11613.256915026164;11763.176577639482 04:22:06 INFO - PROCESS | 27695 | __end_tp_report 04:22:06 INFO - PROCESS | 27695 | __start_cc_report 04:22:06 INFO - PROCESS | 27695 | _x_x_mozilla_cycle_collect,889 04:22:06 INFO - PROCESS | 27695 | __end_cc_report 04:22:06 INFO - PROCESS | 27695 | __startTimestamp1466076126050__endTimestamp 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | ------- Summary: start ------- 04:22:06 INFO - PROCESS | 27695 | Number of tests: 6 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | [#0] dojo.html Cycles:165 Average:5423.19 Median:5634.97 stddev:610.91 (10.8%) stddev-sans-first:585.44 04:22:06 INFO - PROCESS | 27695 | Values: 3119.5 3120.3 3143.5 3162.7 3189.6 5341.6 5415.7 5416.8 5466.6 5497.0 5439.7 5460.2 5494.9 5509.1 5510.4 4970.4 5044.9 5049.9 5067.0 5160.4 5043.5 5050.0 5092.0 5104.1 5117.9 4871.1 4926.6 4929.0 4938.9 4972.2 4912.6 4948.4 4951.8 5001.9 5052.2 4953.1 4956.1 4957.9 4984.2 4999.3 5335.1 5439.0 5493.5 5501.2 5522.4 5829.7 5917.8 5918.3 5925.5 5931.4 5705.4 5894.7 5910.8 5975.6 5976.7 5406.5 5460.0 5475.3 5485.4 5527.4 6006.2 6008.6 6016.5 6018.8 6022.4 5609.7 5788.2 5806.8 5809.9 5810.2 5718.4 5772.4 5789.7 5815.2 5818.7 5743.5 5782.7 5784.1 5786.7 5787.8 5638.7 5762.5 5793.9 5800.9 5802.7 4456.7 4481.0 4481.4 4515.2 4523.4 3948.4 3967.6 3973.5 3980.6 4000.8 5326.8 5390.4 5472.5 5477.9 5525.9 5871.9 5876.0 5876.1 5931.6 5945.2 5461.4 5475.5 5480.6 5482.2 5486.5 4896.6 4928.4 4961.6 5032.4 5087.7 5945.7 5947.5 5954.9 5955.1 5989.4 5781.9 5816.6 5816.7 5817.8 5820.1 5919.0 5939.7 5948.1 5949.2 5989.6 5725.8 5726.6 5730.9 5734.6 5770.3 5824.4 5836.2 5886.1 5896.0 5899.1 5668.3 5699.8 5702.5 5776.0 5780.6 5735.7 5777.3 5779.0 5781.8 5791.2 5464.9 5617.9 5633.5 5634.4 5635.0 5673.9 5705.9 5716.7 5798.3 5800.6 5624.5 5634.8 5645.7 5650.4 5690.6 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | [#1] ext.html Cycles:180 Average:59290.81 Median:41932.19 stddev:114509.47 (273.1%) stddev-sans-first:114745.96 04:22:06 INFO - PROCESS | 27695 | Values: 619.3 634.2 641.1 645.1 649.7 32058.7 34706.8 44653.3 45888.0 46050.8 47158.5 47737.0 47762.3 47840.3 47840.5 8796.3 8996.3 9005.5 9010.4 9014.1 8874.1 8963.7 8966.3 8970.2 8971.6 8991.7 9047.7 9048.4 9049.3 9050.6 8962.3 9002.5 9005.4 9023.7 9027.2 8922.2 8975.9 8982.3 8989.1 8992.8 42643.8 42738.0 43141.5 43176.4 43183.0 3399.3 3771.5 3833.8 4004.8 4357.1 32728.0 32870.7 33251.5 34014.8 34281.5 4203.5 4208.4 4244.3 4247.6 4324.3 323150.0 325675.0 325686.0 328315.0 332003.0 52838.0 60493.4 60773.4 61409.4 62464.7 64878.4 64901.7 65230.3 65272.7 65285.7 17431.1 17651.9 17657.5 17659.3 17667.1 12500.2 12633.7 12814.2 13461.7 13575.7 18258.0 18307.7 18429.1 18432.6 18471.5 6736.4 6792.9 6905.0 6993.9 7041.5 962.6 1007.8 1014.3 1060.7 1071.5 32346.9 32605.7 32952.2 33445.5 33487.0 1091.5 1118.2 1120.2 1131.9 1210.6 16268.3 16685.8 16806.8 16876.8 17065.1 534214.0 538387.0 538434.0 539676.0 539703.0 59550.0 59751.4 59824.0 59846.0 59964.7 1253.7 1352.1 1374.4 1395.4 1400.3 31924.8 33903.0 34063.0 34082.7 34091.0 51012.5 51572.0 51651.2 51686.0 51689.7 404323.0 405124.0 405185.0 405318.0 405923.0 22865.2 28859.4 28929.9 29944.3 30187.5 49550.5 49762.3 50003.7 50748.0 51063.7 40695.6 41289.8 41605.0 42464.0 43009.0 41356.0 41543.8 41705.0 41894.8 42202.8 40398.8 41032.2 41848.6 41893.0 41969.6 34517.0 35691.8 36391.8 36444.6 36713.4 27159.6 27764.7 27901.4 27953.7 28033.9 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | [#2] jquery.html Cycles:180 Average:30016.71 Median:411.15 stddev:83397.96 (20284.1%) stddev-sans-first:83602.22 04:22:06 INFO - PROCESS | 27695 | Values: 381.5 385.3 391.2 401.5 420.8 14270.6 16447.9 18722.0 19421.3 19487.3 17688.7 18114.8 18841.2 18872.9 19009.9 5097.4 5230.2 5247.3 5279.8 5340.1 3828.1 5201.5 5227.1 5269.1 6932.3 7372.3 7392.9 7507.5 7526.2 7540.7 7209.4 7399.1 7399.4 7400.2 7404.0 7057.2 7122.0 7138.3 7226.1 7226.9 25693.7 25823.0 26351.7 26814.5 26965.5 2490.5 2532.6 2535.4 2987.9 3202.6 15294.3 15873.4 15953.7 16067.4 16101.0 2054.1 2097.6 2138.2 2160.9 2247.3 51229.5 79379.0 92901.5 94141.5 94463.0 9117.6 9473.9 9599.1 9635.6 9966.3 13135.7 13217.4 13221.5 13298.6 13702.2 8003.0 8075.2 8077.3 8114.6 8252.3 7402.4 7584.4 7604.9 7855.4 8065.2 4708.4 4749.5 4818.7 4843.1 4890.9 1924.6 1950.4 1960.6 1965.8 1970.9 855.8 936.7 981.3 981.6 992.5 18263.9 18717.4 19196.7 19404.4 19792.8 952.8 955.0 962.9 983.2 1042.4 10578.4 10621.8 10789.9 11140.3 11746.2 495449.0 497520.0 503627.0 513299.0 514409.0 95080.0 98195.0 98462.0 100148.5 100697.0 1000.5 1014.2 1032.7 1035.4 1037.5 17679.0 17688.6 18053.1 18089.8 18275.8 44266.1 44743.3 45234.3 45340.3 46590.5 58715.7 58798.4 62152.4 63005.7 63068.7 7646.5 8445.5 8725.2 8838.8 9002.5 12934.4 13476.9 13631.6 13747.1 13791.4 6136.4 9876.4 11823.3 12026.9 12037.2 11656.3 11796.8 11825.2 11897.3 11978.5 12035.6 12167.7 12219.4 12325.4 12356.0 7537.7 7550.5 7710.3 7749.4 7816.8 10102.7 11774.9 12105.0 12227.0 12313.3 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | [#3] mootools.html Cycles:180 Average:5864.60 Median:458.48 stddev:3368.02 (734.6%) stddev-sans-first:3360.49 04:22:06 INFO - PROCESS | 27695 | Values: 1364.0 1461.3 1478.7 1610.8 1765.7 7768.7 8709.6 8917.0 8926.6 9224.1 8883.1 9081.8 9085.0 9087.5 9087.6 1967.5 2042.5 2242.9 2326.4 2360.3 2324.2 2342.3 2345.4 2349.2 2351.0 2309.6 2321.2 2340.6 2384.3 2389.1 1930.4 2225.3 2288.9 2289.2 2297.7 2215.4 2233.1 2235.3 2246.5 2247.1 8735.0 8792.2 8799.3 8810.5 8816.7 5128.0 5242.6 5254.0 5259.2 5260.7 3366.8 3516.1 3525.8 3646.1 3687.0 1144.0 1177.2 1195.5 1203.5 1215.2 12212.9 12215.8 12246.1 12248.2 12260.7 4555.1 4717.6 4746.4 4822.8 4843.1 10314.7 10318.9 10344.1 10351.9 10355.2 5185.8 5186.5 5193.0 5194.6 5195.5 4275.3 4709.2 4717.9 4848.2 4853.7 3960.6 4045.5 4092.8 4100.7 4149.4 1234.3 1262.0 1279.4 1292.2 1308.1 892.7 978.3 986.6 999.3 1004.9 6056.2 6160.7 6214.3 6279.8 6281.6 446.0 447.3 455.1 458.1 458.8 4105.5 4137.0 4155.1 4177.1 4185.6 10935.6 11158.2 11262.8 11287.0 11288.7 10493.1 10940.1 11181.4 11188.9 11192.8 8157.3 8248.6 8288.9 8325.4 8336.4 5956.5 6198.3 6271.0 6275.5 6297.8 9927.5 10311.5 10358.4 10364.7 10370.6 10211.5 10348.6 10462.0 10603.1 10610.8 7183.0 7762.0 8059.7 8118.0 8255.3 8700.7 8778.4 8785.4 8824.6 8827.4 7654.2 7788.8 7958.6 7965.5 7965.6 7678.4 7694.0 7728.5 7860.3 7923.7 6986.4 7030.6 7059.5 7063.9 7071.9 5262.3 5303.2 5341.5 5415.1 5477.6 5270.3 5326.2 5397.5 5440.2 5466.4 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | [#4] prototype.html Cycles:180 Average:4613.31 Median:5194.25 stddev:1352.72 (26.0%) stddev-sans-first:1317.75 04:22:06 INFO - PROCESS | 27695 | Values: 329.5 329.9 338.7 341.4 341.7 5358.9 5362.2 5369.6 5373.4 5437.2 5339.3 5353.8 5366.8 5366.9 5368.2 3966.4 4006.5 4164.3 4186.2 4190.3 4106.4 4147.6 4171.7 4178.7 4183.5 3887.5 4097.3 4105.5 4107.8 4143.3 3991.8 4038.7 4048.3 4161.3 4163.6 3655.3 3657.2 3662.9 3669.8 3687.9 5092.0 5119.9 5136.2 5147.0 5177.2 4550.5 4760.4 4773.6 4775.7 4787.7 5437.0 5486.3 5496.5 5508.5 5593.2 4076.3 4080.3 4099.7 4102.9 4109.2 5620.9 5649.2 5675.5 5691.4 5695.6 4095.7 4123.0 4126.5 4129.0 4147.9 4182.7 4183.3 4227.8 4228.3 4244.6 4661.5 4703.9 4709.3 4750.5 4826.7 5569.4 5583.2 5587.4 5594.2 5605.5 1431.0 1446.3 1454.7 1458.5 1461.7 886.3 919.9 921.7 931.9 933.4 4753.7 4787.8 4800.4 4824.7 4844.3 5067.1 5070.4 5083.8 5100.1 5124.7 4498.5 4790.0 4802.7 4818.3 4825.3 2693.9 2712.9 2742.1 2774.6 2776.4 5183.9 5204.6 5223.7 5229.3 5259.5 5216.8 5221.0 5383.7 5776.8 5828.3 5792.7 5844.9 5853.2 5883.4 5887.3 5661.2 5698.5 5775.8 5821.0 5821.9 5646.2 5678.4 5683.5 5712.4 5753.4 5877.2 5948.4 5959.7 5962.5 5984.6 3996.0 4019.5 4074.2 4106.7 4118.9 5479.3 5648.6 5754.7 5792.3 5819.9 5557.8 5585.7 5589.6 5624.5 5641.4 5578.5 5600.2 5621.4 5632.0 5639.0 5252.7 5479.4 5490.9 5512.3 5515.4 5521.0 5557.4 5578.6 5579.2 5581.7 5208.9 5468.4 5490.2 5526.4 5561.9 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - PROCESS | 27695 | [#5] yui.html Cycles:180 Average:20886.77 Median:4767.89 stddev:29949.27 (628.1%) stddev-sans-first:29995.28 04:22:06 INFO - PROCESS | 27695 | Values: 791.5 811.3 822.9 845.1 850.2 14524.2 15064.7 15374.4 15409.5 15421.3 14008.7 14215.1 15011.0 15747.1 15796.5 799.2 799.3 808.2 808.3 808.3 676.0 778.1 800.3 802.3 804.2 843.9 845.3 846.7 847.6 850.3 701.4 844.4 846.0 846.3 846.6 604.5 614.5 615.6 619.2 619.5 15360.2 15376.9 15396.8 15397.9 15410.4 12998.7 13482.3 13528.1 13738.5 14071.0 11812.7 11867.6 12292.1 13110.7 13475.4 3833.6 3854.3 3881.5 3888.6 4041.3 79712.0 80607.6 80718.6 81253.2 81746.6 11007.4 11071.6 11455.7 11484.3 11884.5 21454.8 21523.8 21570.5 21580.1 22103.7 8215.1 8327.6 8379.7 8433.7 8722.3 4644.4 4770.3 4880.6 4919.8 4971.3 3426.3 3523.0 3541.3 3549.0 3551.3 605.2 619.6 622.8 630.2 645.0 705.3 776.2 782.3 785.1 817.7 9353.5 9682.7 9914.3 10338.1 10444.3 670.1 683.1 705.1 719.3 741.6 4765.5 4967.0 5006.5 5009.8 5025.6 114583.0 116161.0 116415.0 117982.4 118001.0 86804.6 87269.0 89109.6 101960.0 102357.5 74628.6 87304.0 89334.0 89612.6 91487.0 9856.3 9920.3 9935.0 9938.0 9975.0 49883.5 50256.5 50325.2 50354.2 52020.7 71619.0 74434.3 74922.6 75567.6 77896.2 12165.4 12178.6 12206.9 12737.5 12877.5 14731.8 14795.5 14842.6 15028.7 15268.8 13731.5 13847.3 14047.6 14174.4 14510.5 13503.3 13565.4 13678.4 13930.0 13966.1 13769.4 13814.4 13836.9 14085.4 14712.6 11107.4 11353.1 11475.3 11785.6 11903.8 10898.8 11412.1 11552.7 11613.3 11763.2 04:22:06 INFO - PROCESS | 27695 | -------- Summary: end -------- 04:22:06 INFO - PROCESS | 27695 | 04:22:06 INFO - TEST-INFO | 27695: exit 0 04:22:06 INFO - TEST-OK | dromaeo_css | took 1114769ms 04:22:06 INFO - TEST-START | kraken 04:22:06 INFO - operating with platform_type : linux_ 04:22:06 INFO - Initialising browser for kraken test... 04:22:06 INFO - TEST-INFO | started process 27882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajatb0/profile http://localhost:34018/getInfo.html) 04:22:11 INFO - PROCESS | 27882 | __metrics Screen width/height:1600/1200 04:22:11 INFO - PROCESS | 27882 | colorDepth:24 04:22:11 INFO - PROCESS | 27882 | Browser inner width/height: 1024/697 04:22:11 INFO - PROCESS | 27882 | __metrics 04:22:12 INFO - PROCESS | 27882 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:22:13 INFO - TEST-INFO | 27882: exit 0 04:22:13 INFO - Browser initialized. 04:22:13 INFO - Running cycle 1/1 for kraken test... 04:22:13 INFO - TEST-INFO | started process 27965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpajatb0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:25 INFO - PROCESS | 27965 | RSS: Main: 173068288 04:22:25 INFO - PROCESS | 27965 | 04:22:27 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34018/tests/kraken/driver.html?testName=audio-beat-detection) 04:22:28 INFO - PROCESS | 27965 | RSS: Main: 232534016 04:22:28 INFO - PROCESS | 27965 | 04:22:31 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34018/tests/kraken/driver.html?testName=audio-dft) 04:22:31 INFO - PROCESS | 27965 | RSS: Main: 221958144 04:22:31 INFO - PROCESS | 27965 | 04:22:35 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34018/tests/kraken/driver.html?testName=audio-fft) 04:22:35 INFO - PROCESS | 27965 | RSS: Main: 287014912 04:22:35 INFO - PROCESS | 27965 | 04:22:37 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34018/tests/kraken/driver.html?testName=audio-oscillator) 04:22:38 INFO - PROCESS | 27965 | RSS: Main: 197681152 04:22:38 INFO - PROCESS | 27965 | 04:22:40 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34018/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:22:41 INFO - PROCESS | 27965 | RSS: Main: 201609216 04:22:41 INFO - PROCESS | 27965 | 04:22:44 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34018/tests/kraken/driver.html?testName=imaging-darkroom) 04:22:44 INFO - PROCESS | 27965 | RSS: Main: 238096384 04:22:44 INFO - PROCESS | 27965 | 04:22:48 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34018/tests/kraken/driver.html?testName=imaging-desaturate) 04:22:48 INFO - PROCESS | 27965 | RSS: Main: 238157824 04:22:48 INFO - PROCESS | 27965 | 04:22:51 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34018/tests/kraken/driver.html?testName=json-parse-financial) 04:22:52 INFO - PROCESS | 27965 | RSS: Main: 238977024 04:22:52 INFO - PROCESS | 27965 | 04:22:53 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34018/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:22:54 INFO - PROCESS | 27965 | RSS: Main: 224940032 04:22:54 INFO - PROCESS | 27965 | 04:22:55 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:22:56 INFO - PROCESS | 27965 | RSS: Main: 229486592 04:22:56 INFO - PROCESS | 27965 | 04:22:58 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:22:59 INFO - PROCESS | 27965 | RSS: Main: 238374912 04:22:59 INFO - PROCESS | 27965 | 04:23:01 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:23:02 INFO - PROCESS | 27965 | RSS: Main: 240070656 04:23:02 INFO - PROCESS | 27965 | 04:23:05 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:23:05 INFO - PROCESS | 27965 | RSS: Main: 241041408 04:23:05 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | Cycle 1(1): loaded http://localhost:34018/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34018/tests/kraken/driver.html?testName=ai-astar) 04:23:07 INFO - PROCESS | 27965 | RSS: Main: 284610560 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | __start_tp_report 04:23:07 INFO - PROCESS | 27965 | _x_x_mozilla_page_load 04:23:07 INFO - PROCESS | 27965 | _x_x_mozilla_page_load_details 04:23:07 INFO - PROCESS | 27965 | |i|pagename|runs| 04:23:07 INFO - PROCESS | 27965 | |0;ai-astar;112;104;111;112;111;110;109;112;111;110 04:23:07 INFO - PROCESS | 27965 | |1;audio-beat-detection;154;143;134;183;128;127;159;132;159;124 04:23:07 INFO - PROCESS | 27965 | |2;audio-dft;160;160;160;159;160;159;160;160;160;161 04:23:07 INFO - PROCESS | 27965 | |3;audio-fft;75;76;76;115;76;77;75;76;98;75 04:23:07 INFO - PROCESS | 27965 | |4;audio-oscillator;85;85;117;85;85;85;124;85;86;122 04:23:07 INFO - PROCESS | 27965 | |5;imaging-gaussian-blur;117;117;117;117;117;119;118;117;118;118 04:23:07 INFO - PROCESS | 27965 | |6;imaging-darkroom;145;146;145;145;146;146;146;145;146;146 04:23:07 INFO - PROCESS | 27965 | |7;imaging-desaturate;96;96;96;96;96;95;94;95;95;94 04:23:07 INFO - PROCESS | 27965 | |8;json-parse-financial;51;54;56;52;52;52;52;53;53;54 04:23:07 INFO - PROCESS | 27965 | |9;json-stringify-tinderbox;61;63;63;63;63;62;63;63;63;63 04:23:07 INFO - PROCESS | 27965 | |10;stanford-crypto-aes;81;80;80;82;80;81;81;83;121;82 04:23:07 INFO - PROCESS | 27965 | |11;stanford-crypto-ccm;130;127;125;122;122;130;136;121;124;128 04:23:07 INFO - PROCESS | 27965 | |12;stanford-crypto-pbkdf2;164;162;160;160;160;161;161;157;158;160 04:23:07 INFO - PROCESS | 27965 | |13;stanford-crypto-sha256-iterative;63;62;63;63;63;64;63;62;63;62 04:23:07 INFO - PROCESS | 27965 | __end_tp_report 04:23:07 INFO - PROCESS | 27965 | __start_cc_report 04:23:07 INFO - PROCESS | 27965 | _x_x_mozilla_cycle_collect,1627 04:23:07 INFO - PROCESS | 27965 | __end_cc_report 04:23:07 INFO - PROCESS | 27965 | __startTimestamp1466076187586__endTimestamp 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | ------- Summary: start ------- 04:23:07 INFO - PROCESS | 27965 | Number of tests: 14 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.39 (2.2%) stddev-sans-first:2.45 04:23:07 INFO - PROCESS | 27965 | Values: 112.0 104.0 111.0 112.0 111.0 110.0 109.0 112.0 111.0 110.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:148.50 stddev:19.03 (12.8%) stddev-sans-first:19.86 04:23:07 INFO - PROCESS | 27965 | Values: 154.0 143.0 134.0 183.0 128.0 127.0 159.0 132.0 159.0 124.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:23:07 INFO - PROCESS | 27965 | Values: 160.0 160.0 160.0 159.0 160.0 159.0 160.0 160.0 160.0 161.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.58 (17.9%) stddev-sans-first:14.18 04:23:07 INFO - PROCESS | 27965 | Values: 75.0 76.0 76.0 115.0 76.0 77.0 75.0 76.0 98.0 75.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.41 (20.5%) stddev-sans-first:18.01 04:23:07 INFO - PROCESS | 27965 | Values: 85.0 85.0 117.0 85.0 85.0 85.0 124.0 85.0 86.0 122.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 04:23:07 INFO - PROCESS | 27965 | Values: 117.0 117.0 117.0 117.0 117.0 119.0 118.0 117.0 118.0 118.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:23:07 INFO - PROCESS | 27965 | Values: 145.0 146.0 145.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 04:23:07 INFO - PROCESS | 27965 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 94.0 95.0 95.0 94.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.45 (2.7%) stddev-sans-first:1.36 04:23:07 INFO - PROCESS | 27965 | Values: 51.0 54.0 56.0 52.0 52.0 52.0 52.0 53.0 53.0 54.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.33 04:23:07 INFO - PROCESS | 27965 | Values: 61.0 63.0 63.0 63.0 63.0 62.0 63.0 63.0 63.0 63.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:81.00 stddev:12.65 (15.6%) stddev-sans-first:13.33 04:23:07 INFO - PROCESS | 27965 | Values: 81.0 80.0 80.0 82.0 80.0 81.0 81.0 83.0 121.0 82.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.50 stddev:4.67 (3.7%) stddev-sans-first:4.78 04:23:07 INFO - PROCESS | 27965 | Values: 130.0 127.0 125.0 122.0 122.0 130.0 136.0 121.0 124.0 128.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:1.95 (1.2%) stddev-sans-first:1.54 04:23:07 INFO - PROCESS | 27965 | Values: 164.0 162.0 160.0 160.0 160.0 161.0 161.0 157.0 158.0 160.0 04:23:07 INFO - PROCESS | 27965 | 04:23:07 INFO - PROCESS | 27965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:23:07 INFO - PROCESS | 27965 | Values: 63.0 62.0 63.0 63.0 63.0 64.0 63.0 62.0 63.0 62.0 04:23:07 INFO - PROCESS | 27965 | -------- Summary: end -------- 04:23:07 INFO - PROCESS | 27965 | 04:23:08 INFO - TEST-INFO | 27965: exit 0 04:23:08 INFO - TEST-OK | kraken | took 61749ms 04:23:08 INFO - SUITE-END | took 1176s 04:23:08 INFO - Completed test suite (00:19:36) 04:23:08 INFO - javascript benchmark 04:23:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.469690152674, 3120.2667373167315, 3143.481325581279, 3162.683731626836, 3189.5694081299016, 5341.626086173969, 5415.702136382497, 5416.810411635589, 5466.617336786427, 5497.038018346793, 5439.728013599324, 5460.235567020621, 5494.917576236349, 5509.090999984997, 5510.448955104497, 4970.3787026621585, 5044.924326135093, 5049.899002019957, 5067.0, 5160.432352441228, 5043.470435604246, 5050.0, 5091.974540127294, 5104.106781313274, 5117.897642047157, 4871.050145221683, 4926.581240594536, 4928.975355123237, 4938.851834444972, 4972.204447288453, 4912.649021519075, 4948.406191257036, 4951.762059485129, 5001.874953126201, 5052.191649336089, 4953.083679519301, 4956.132676781584, 4957.90084198314, 4984.152694041985, 4999.250112483121, 5335.119705248668, 5438.972805135989, 5493.450654934514, 5501.202325662796, 5522.392536820947, 5829.679367634779, 5917.792877249276, 5918.348981612019, 5925.466707996258, 5931.436513531207, 5705.372409035002, 5894.675792831393, 5910.763569457216, 5975.611585246945, 5976.671283079429, 5406.513413792738, 5460.017196904556, 5475.288212532425, 5485.424030476823, 5527.44725527444, 6006.189164462741, 6008.639481631116, 6016.488598469179, 6018.759249630053, 6022.397760223943, 5609.719514024282, 5788.218590490314, 5806.79676211339, 5809.8547536311935, 5810.244668193108, 5718.370979192286, 5772.365039845614, 5789.739461724148, 5815.185873977646, 5818.709064546756, 5743.4543718346695, 5782.710864456761, 5784.132380142928, 5786.71066446676, 5787.797427090116, 5638.718064096861, 5762.481376676119, 5793.913091303634, 5800.883982320414, 5802.709864506842, 4456.710313829655, 4481.0, 4481.439820022497, 4515.187266292099, 4523.434570678665, 3948.4274780156716, 3967.6230758077936, 3973.543042550086, 3980.6218409251073, 4000.7799571023875, 5326.813561525328, 5390.407055223922, 5472.480114389126, 5477.917831232535, 5525.917111243334, 5871.911921321183, 5875.970620146957, 5876.1479585459865, 5931.614445061057, 5945.1973983512535, 5461.371942226615, 5475.479829416199, 5480.616356855062, 5482.150266708666, 5486.506214440719, 4896.608271338356, 4928.359313289249, 4961.603071754251, 5032.396112466454, 5087.745612719349, 5945.672987985702, 5947.49446297061, 5954.85112872173, 5955.136505206808, 5989.431004054608, 5781.94218057814, 5816.621919575214, 5816.73824677882, 5817.76728930838, 5820.097884827858, 5919.0, 5939.673317967553, 5948.137520059654, 5949.196858424058, 5989.580729349078, 5725.799597014085, 5726.570507211893, 5730.856728581652, 5734.569907256889, 5770.307563092456, 5824.359320474659, 5836.182934389104, 5886.087656413263, 5895.970520147372, 5899.056151015817, 5668.291463567054, 5699.772009119754, 5702.45826646468, 5776.0, 5780.624259423124, 5735.741891614971, 5777.335606405317, 5778.971105144447, 5781.768729250783, 5791.218185545066, 5464.9453505464435, 5617.943820561905, 5633.492985631313, 5634.352049514195, 5634.971825140848, 5673.914891276717, 5705.857353566194, 5716.742746576331, 5798.304203495608, 5800.622959507618, 5624.465675760796, 5634.830955071355, 5645.661260324394, 5650.406707295675, 5690.630109042899], "value": 5381.962026574169, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.3032838057186, 634.2040738872714, 641.0992555459578, 645.1451826330114, 649.7401039584166, 32058.67941320586, 34706.82646586766, 44653.33020004703, 45888.0, 46050.76974615131, 47158.528414715845, 47737.0, 47762.28356574654, 47840.282395764094, 47840.52159478404, 8796.340274479408, 8996.280297576179, 9005.54972251388, 9010.414323069012, 9014.098590140999, 8874.112588741107, 8963.731088067369, 8966.327525435585, 8970.192682658559, 8971.551422428885, 8991.685291014783, 9047.728568142966, 9048.41185322952, 9049.276057915384, 9050.637974481013, 8962.327825413087, 9002.459852408843, 9005.414648047856, 9023.684171053981, 9027.232685221765, 8922.15239552248, 8975.865362019575, 8982.326325525612, 8989.056149104315, 8992.77518062047, 42643.78678106589, 42738.0, 43141.47014563457, 43176.352354714705, 43183.0, 3399.2761168129405, 3771.4908487354405, 3833.8274777635074, 4004.819783109767, 4357.085012147453, 32728.0, 32870.671293287, 33251.5012274816, 34014.82992585046, 34281.48577771335, 4203.516595591515, 4208.416833667313, 4244.3209086546, 4247.5540068293, 4324.2648749712625, 323150.0, 325675.0, 325686.0, 328315.0, 332003.0, 52838.0, 60493.395066048775, 60773.39226607766, 61409.385906140364, 62464.68767656224, 64878.35121648723, 64901.67549162319, 65230.347696522425, 65272.673636631516, 65285.67357163279, 17431.12844357777, 17651.911740441217, 17657.470275891745, 17659.29362825498, 17667.11664416774, 12500.24998500093, 12633.684157896127, 12814.167079139826, 13461.663458413617, 13575.728485430236, 18258.0, 18307.72538411925, 18429.078546072644, 18432.63134737298, 18471.53821154482, 6736.393724564813, 6792.864142717118, 6905.0, 6993.943512762586, 7041.4718896082995, 962.605331813953, 1007.7984403119406, 1014.3457469932, 1060.7136073260176, 1071.49104175516, 32346.8678596248, 32605.67394326074, 32952.176195595304, 33445.49831752526, 33487.0, 1091.5251865438559, 1118.2395970739974, 1120.2438354110943, 1131.9490622921987, 1210.5823490895627, 16268.26792794327, 16685.833141668427, 16806.831931680772, 16876.83123168777, 17065.14674266282, 534214.0, 538387.0, 538434.0, 539676.0, 539703.0, 59550.0, 59751.40248597545, 59824.0, 59846.0, 59964.70017649884, 1253.674044748372, 1352.1278775190144, 1374.3746595299115, 1395.3651088754796, 1400.271858633505, 31924.840375797972, 33903.0, 34063.0, 34082.65917340795, 34091.0, 51012.489875102256, 51572.0, 51651.2252316208, 51686.0, 51689.741551292005, 404323.0, 405124.0, 405185.0, 405318.0, 405923.0, 22865.19971800979, 28859.42281154407, 28929.85535072311, 29944.25139371533, 30187.547186791777, 49550.50449495603, 49762.25356619726, 50003.74998125132, 50748.0, 51063.74468127636, 40695.59304407037, 41289.79355103205, 41605.0, 42464.0, 43009.0, 41356.0, 41543.792281038404, 41705.0, 41894.790526047174, 42202.788986054875, 40398.79800600978, 41032.179356413304, 41848.581514184465, 41893.0, 41969.58030419657, 34517.0, 35691.82154089213, 36391.818040909624, 36444.635553644126, 36713.44929826001, 27159.592606110527, 27764.722352776214, 27901.441971160057, 27953.72046279511, 28033.859830700716], "value": 20342.11656837673, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.47547122706294, 385.331449934364, 391.2448973481181, 401.5161730115211, 420.7832966022497, 14270.64323391913, 16447.917760411183, 18722.0, 19421.320253791102, 19487.317943871967, 17688.734668979974, 18114.818851811477, 18841.24635014598, 18872.905635471838, 19009.904950475262, 5097.388313402397, 5230.2416149658275, 5247.2653828464045, 5279.762410691528, 5340.06548853951, 3828.138668799512, 5201.453847346031, 5227.08526007949, 5269.077911365515, 6932.306769323078, 7372.299631534996, 7392.926070739278, 7507.474476786627, 7526.247375262485, 7540.698372065138, 7209.387202087829, 7399.149097853762, 7399.4450416219, 7400.185979542246, 7403.9629801850915, 7057.188423331331, 7121.9643901780155, 7138.321859423347, 7226.096737907762, 7226.891596626055, 25693.743062569323, 25823.0, 26351.73648263531, 26814.46371072587, 26965.460690786076, 2490.501899620065, 2532.6327682485935, 2535.4287564444185, 2987.9402411951855, 3202.615686117681, 15294.311755970897, 15873.365065397371, 15953.680926381523, 16067.357305707757, 16101.0, 2054.1269960266977, 2097.6329142400173, 2138.1554286057076, 2160.9135634574754, 2247.2584047264363, 51229.48770512285, 79379.0, 92901.5354923221, 94141.5292923531, 94463.0, 9117.632355146648, 9473.857892131624, 9599.136077752895, 9635.554666800035, 9966.2525310602, 13135.737285254241, 13217.405216765268, 13221.471141154438, 13298.601041968757, 13702.177869327872, 8002.9599852000365, 8075.192480751878, 8077.27304542594, 8114.594270286462, 8252.33981281508, 7402.444816638774, 7584.431167662337, 7604.885926710993, 7855.410844186709, 8065.233802788725, 4708.387909571802, 4749.501302363271, 4818.6626936114835, 4843.128236917389, 4890.926636100461, 1924.5854297091626, 1950.3661310074283, 1960.6470835249793, 1965.8230759231737, 1970.940871773849, 855.8245559660255, 936.6955739384591, 981.259149342242, 981.5533932060895, 992.513668302541, 18263.908680456512, 18717.438476845717, 19196.71204931927, 19404.417867463715, 19792.802071979382, 952.79991201847, 955.044955044955, 962.8892677342055, 983.1986930651497, 1042.3537406807827, 10578.412294984259, 10621.81345596318, 10789.892101078889, 11140.33158010522, 11746.236494627821, 495449.0, 497520.0, 503627.0, 513299.0, 514409.0, 95080.0, 98195.0, 98462.0, 100148.49925750325, 100697.0, 1000.5097502223858, 1014.2038499777639, 1032.6850310655173, 1035.435687550287, 1037.5019990404496, 17679.0, 17688.55778605545, 18053.097345132428, 18089.819101808815, 18275.817241827943, 44266.11467770562, 44743.328850066624, 45234.32148517709, 45340.31989520226, 46590.53409465862, 58715.70642146762, 58798.412015881004, 62152.37847621466, 63005.68497157485, 63068.68465657642, 7646.464747467624, 8445.49327040355, 8725.171108744658, 8838.823223535364, 9002.459852408876, 12934.353282335658, 13476.93261533686, 13631.591052268448, 13747.106438081493, 13791.379387927367, 6136.417040381157, 9876.35803672759, 11823.349715765715, 12026.939865300617, 12037.157398982337, 11656.30062196271, 11796.782876504478, 11825.231359961575, 11897.286162830258, 11978.520859165536, 12035.63893083174, 12167.695807604881, 12219.389030548615, 12325.383730813603, 12356.0, 7537.73617923392, 7550.509216900884, 7710.344620707303, 7749.380049595906, 7816.765497035098, 10102.747431314276, 11774.882251177722, 12105.0, 12227.0, 12313.322767247888], "value": 9510.46353673869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.0383529611613, 1461.349699383774, 1478.6599082211092, 1610.7825443565116, 1765.6556971390576, 7768.728094516693, 8709.608067636957, 8917.0, 8926.59830307636, 9224.077592240772, 8883.067277935821, 9081.772955676111, 9085.0, 9087.545622718872, 9087.591058402371, 1967.4687834284734, 2042.5302180498495, 2242.8654280743126, 2326.4183954011455, 2360.327306717586, 2324.1516846351046, 2342.3207269891795, 2345.44881952741, 2349.2364981381033, 2350.9882450587725, 2309.607366747657, 2321.2223904991847, 2340.6020976434047, 2384.2727967969763, 2389.1279682915783, 1930.4015755115959, 2225.254539729193, 2288.9198878039274, 2289.175896677195, 2297.7127859017623, 2215.3907675389237, 2233.095596283508, 2235.307054813013, 2246.5394594108334, 2247.056236380724, 8735.0, 8792.208701216921, 8799.340049496313, 8810.515421651806, 8816.735497935073, 5128.0, 5242.6330156889035, 5254.00173966945, 5259.158534634478, 5260.736963151827, 3366.8148251846137, 3516.1209697575605, 3525.7708248963736, 3646.124930016777, 3686.963130368689, 1143.9771204575861, 1177.2230327983489, 1195.4500929572407, 1203.4644583160498, 1215.19796934024, 12212.877871221352, 12215.816762748565, 12246.142770006103, 12248.203866748632, 12260.693482662915, 4555.134524440346, 4717.575418212309, 4746.430428348551, 4822.758862056883, 4843.07981483517, 10314.690559283234, 10318.948405257926, 10344.120749736358, 10351.896481035094, 10355.223358248162, 5185.818496352609, 5186.481351864859, 5192.9740351298005, 5194.558462530727, 5195.480451954774, 4275.294576394922, 4709.222978208557, 4717.882052948704, 4848.224284114524, 4853.684510506806, 3960.6435420812263, 4045.4538637284177, 4092.795360232036, 4100.7334523255895, 4149.419081328617, 1234.2594443333928, 1261.962141135749, 1279.3922886628777, 1292.2246652008719, 1308.0974127851753, 892.6652505310509, 978.295627148452, 986.6026101384372, 999.3204620857741, 1004.8794144702537, 6056.212692349966, 6160.691965401712, 6214.316425193225, 6279.811605651837, 6281.560290779693, 445.9955400446019, 447.26871564990824, 455.05575929945496, 458.11355028020887, 458.8416996136328, 4105.486814148231, 4136.958630413657, 4155.065110350147, 4177.081042170717, 4185.602367775056, 10935.617253396093, 11158.218924675357, 11262.774744505065, 11286.98417142461, 11288.661340159808, 10493.108085812639, 10940.124790016938, 11181.440927953732, 11188.944055279671, 11192.776144477064, 8157.265846073882, 8248.628811703487, 8288.875666865002, 8325.375596830261, 8336.374771892133, 5956.493698035715, 6198.256209254738, 6271.0, 6275.497960163085, 6297.771934472734, 9927.453990030328, 10311.484425778832, 10358.378497290187, 10364.689059328231, 10370.637027703995, 10211.540480678535, 10348.637797677045, 10461.953804619478, 10603.098736607475, 10610.840837387292, 7182.96408517954, 7761.9611901940125, 8059.677612895419, 8118.0, 8255.25702686737, 8700.651973921225, 8778.385513014284, 8785.428947118417, 8824.602892869709, 8827.382083254368, 7654.196309387657, 7788.805279868048, 7958.562279074707, 7965.4822436541435, 7965.641546130554, 7678.385729141543, 7693.961530192313, 7728.497647652885, 7860.3318717909615, 7923.6830526778285, 6986.441084713312, 7030.648467576703, 7059.54112982675, 7063.894041589278, 7071.893921591078, 5262.342207224097, 5303.178007408857, 5341.5459685927135, 5415.106507426231, 5477.616566840283, 5270.31485906845, 5326.227696983993, 5397.460253974571, 5440.211169380497, 5466.426025267289], "value": 4595.055907818999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.5402912936454, 329.8960827339388, 338.71717116207975, 341.40765771386623, 341.6873560691967, 5358.946410535898, 5362.195670649405, 5369.5972802039805, 5373.355197376315, 5437.238786569884, 5339.252504649352, 5353.812616558421, 5366.785328586851, 5366.9463305366935, 5368.167933970231, 3966.4050392441077, 4006.5175884922473, 4164.271252530795, 4186.246475634384, 4190.329547272437, 4106.404571337154, 4147.585241475858, 4171.749695018309, 4178.7283826551175, 4183.489906056372, 3887.5140607424073, 4097.303458412062, 4105.486814148231, 4107.753534787922, 4143.295639741236, 3991.800409979504, 4038.7374820636564, 4048.251073551388, 4161.334186530171, 4163.562825903297, 3655.268946210742, 3657.1954170082804, 3662.8717994870317, 3669.7614655047337, 3687.870924517629, 5091.974540127313, 5119.923201151985, 5136.200770580042, 5146.966948055535, 5177.197534382177, 4550.476695180064, 4760.404949381327, 4773.594244489188, 4775.689580177277, 4787.712737235742, 5437.0, 5486.259354987065, 5496.532794712454, 5508.531774799147, 5593.161025846115, 4076.266272071026, 4080.3063479208604, 4099.713020088595, 4102.876913692594, 4109.198706252282, 5620.859478513029, 5649.209110724501, 5675.51758100562, 5691.402402747734, 5695.572832037614, 4095.685937445334, 4123.0, 4126.463559737215, 4129.009037830899, 4147.91704165915, 4182.728122672077, 4183.288840897055, 4227.767472789026, 4228.2811921972725, 4244.575542445792, 4661.487236403993, 4703.929441058387, 4709.293605959134, 4750.527336525688, 4826.710397376169, 5569.412717375529, 5583.162525621108, 5587.38538760736, 5594.1608758686525, 5605.523530499953, 1431.0483528453462, 1446.320229492137, 1454.6581553334959, 1458.4530800949644, 1461.6711239971135, 886.3175354976632, 919.9356045076914, 921.7142086789025, 931.9394239374554, 933.4446004627235, 4753.740258831343, 4787.779116325384, 4800.375951126401, 4824.662273640882, 4844.273358996179, 5067.113255180328, 5070.391553013662, 5083.830718934666, 5100.1074811907765, 5124.692518448905, 4498.460184777848, 4790.0180463005, 4802.711837289774, 4818.277258411266, 4825.348577942003, 2693.855111577611, 2712.9343841459026, 2742.122520793327, 2774.597683335905, 2776.4030733392015, 5183.948160518346, 5204.5576126028955, 5223.712695801692, 5229.346331708536, 5259.47405259471, 5216.817411390583, 5220.9738951305, 5383.7308134593895, 5776.826695199151, 5828.318973272258, 5792.710364481674, 5844.912326315109, 5853.209816674779, 5883.411658834082, 5887.264091988502, 5661.207430959586, 5698.515626171822, 5775.826725198251, 5820.970895145497, 5821.912671309849, 5646.209530665792, 5678.387941546935, 5683.516901063456, 5712.400197979152, 5753.424657534213, 5877.177195192591, 5948.37542058095, 5959.718660488016, 5962.482135540052, 5984.58107932458, 3995.9800200998807, 4019.537753158424, 4074.1647962168277, 4106.712530122983, 4118.91762164761, 5479.287692599936, 5648.604597678123, 5754.6547207167705, 5792.333881603501, 5819.912701309569, 5557.805476808292, 5585.720713964204, 5589.5807814413265, 5624.465675760796, 5641.37944826077, 5578.497935185853, 5600.243967064394, 5621.409751975983, 5632.014397480507, 5639.0, 5252.684838909678, 5479.424660410759, 5490.9250819541185, 5512.255845460972, 5515.393306736336, 5520.984840533257, 5557.44425557441, 5578.553715702815, 5579.218909352613, 5581.7209139543675, 5208.921866171935, 5468.425815289337, 5490.176473529003, 5526.369720932415, 5561.888762224652], "value": 4184.478914699237, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.4855344026382, 811.2698571285844, 822.9053658829237, 845.0704225352114, 850.158343240192, 14524.201168935704, 15064.698706025873, 15374.385024599016, 15409.46066887659, 15421.306041228143, 14008.719825603483, 14215.147091174536, 15011.0, 15747.133907635076, 15796.526104216864, 799.1568894815966, 799.2606838674218, 808.1998821167061, 808.296781799832, 808.3250485844297, 675.9797206083825, 778.0740918307224, 800.2797482265978, 802.2939812964584, 804.1556365815899, 843.9113893041234, 845.2688424512813, 846.6740304982595, 847.6439895244013, 850.306999795168, 701.4073108223542, 844.4257904624852, 845.953472559009, 846.2679781988567, 846.6444093480753, 604.5194070713793, 614.4869034356318, 615.5506480269429, 619.1950464396267, 619.5260625621403, 15360.155191464464, 15376.923115384463, 15396.846031539766, 15397.923010384877, 15410.3835846566, 12998.675033124153, 13482.325883705775, 13528.120672156278, 13738.519151829638, 14071.0, 11812.704682382922, 11867.584634537836, 12292.139550231488, 13110.672233194151, 13475.393607287597, 3833.616638336144, 3854.325493038707, 3881.4565960765517, 3888.6305800948867, 4041.2927737645796, 79712.0, 80607.5969620154, 80718.59640701758, 81253.18746812575, 81746.59126704388, 11007.449627518592, 11071.557137714562, 11455.713607159887, 11484.253523520945, 11884.524619015316, 21454.785452145592, 21523.78476215218, 21570.46073848135, 21580.136794528044, 22103.668444973337, 8215.09633940266, 8327.583620818934, 8379.706710265233, 8433.662653493915, 8722.258608018263, 4644.396228490275, 4770.284457331428, 4880.6095512358925, 4919.827806026772, 4971.254311853251, 3426.3489936911906, 3523.0, 3541.2563361694333, 3549.0417587251814, 3551.271989242199, 605.1527860994643, 619.5910698938679, 622.7975907829973, 630.180765005491, 644.9742010319535, 705.2876594639451, 776.2082675670785, 782.3271986091956, 785.09713829097, 817.7056259746487, 9353.485558294358, 9682.70951871445, 9914.305998580174, 10338.12125969286, 10444.268901176996, 670.1388715500558, 683.1494788987742, 705.0833915909298, 719.2914978745931, 741.6032422653855, 4765.499622539653, 4966.975165124151, 5006.549410552995, 5009.824656137018, 5025.648204625714, 114583.0, 116161.0, 116415.0, 117982.41008794901, 118001.0, 86804.56597716971, 87269.0, 89109.55445222733, 101960.0, 102357.48821255846, 74628.62685686536, 87304.0, 89333.97997090146, 89612.5519372412, 91487.0, 9856.260780441638, 9920.255980801614, 9934.950325248617, 9938.0, 9975.0, 49883.50116498789, 50256.49743502518, 50325.24512132248, 50354.244686330465, 52020.73989630028, 71619.0, 74434.25565744273, 74922.56988564272, 75567.62216189103, 77896.2210377889, 12165.391730413621, 12178.634640960785, 12206.877931220573, 12737.490500379881, 12877.484900603871, 14731.779023314873, 14795.482158124845, 14842.628934276298, 15028.699426011637, 15268.770968435705, 13731.45074197021, 13847.30763461843, 14047.578572642837, 14174.433022678977, 14510.492132775724, 13503.257320847448, 13565.353581411853, 13678.384472698554, 13930.0, 13966.092204006707, 13769.449222031408, 13814.37835297394, 13836.930815345859, 14085.436582536993, 14712.55862324132, 11107.44462776874, 11353.148513861328, 11475.311481311148, 11785.646430607096, 11903.761924761284, 10898.782024359627, 11412.062838321099, 11552.711182220512, 11613.256915026164, 11763.176577639482], "value": 7622.973072251861, "unit": "score"}], "name": "dromaeo_css", "value": 7310.385128311004, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 111.0, 112.0, 111.0, 110.0, 109.0, 112.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 143.0, 134.0, 183.0, 128.0, 127.0, 159.0, 132.0, 159.0, 124.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 159.0, 160.0, 160.0, 160.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 115.0, 76.0, 77.0, 75.0, 76.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 85.0, 85.0, 85.0, 124.0, 85.0, 86.0, 122.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0, 117.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 54.0, 56.0, 52.0, 52.0, 52.0, 52.0, 53.0, 53.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 82.0, 80.0, 81.0, 81.0, 83.0, 121.0, 82.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 125.0, 122.0, 122.0, 130.0, 136.0, 121.0, 124.0, 128.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 160.0, 160.0, 160.0, 161.0, 161.0, 157.0, 158.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 63.0, 64.0, 63.0, 62.0, 63.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1500.8999999999996, "alertThreshold": 2.0}]} 04:23:08 INFO - Return code: 0 04:23:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:23:08 INFO - # TBPL SUCCESS # 04:23:08 INFO - Running post-action listener: _resource_record_post_action 04:23:08 INFO - ##### 04:23:08 INFO - ##### Finished run-tests step (success) 04:23:08 INFO - ##### 04:23:08 INFO - Running post-run listener: _resource_record_post_run 04:23:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 292429824; Read time: 0; Write time: 173056 04:23:08 INFO - TinderboxPrint: CPU usage
13.2% 04:23:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:23:08 INFO - TinderboxPrint: I/O write bytes / time
292,429,824 / 173,056 04:23:08 INFO - TinderboxPrint: CPU idle
8,276.3 (86.8%) 04:23:08 INFO - TinderboxPrint: CPU user
1,212.5 (12.7%) 04:23:08 INFO - TinderboxPrint: Swap in / out
0 / 0 04:23:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1429504; Read time: 0; Write time: 48 04:23:08 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 291000320; Read time: 0; Write time: 173008 04:23:09 INFO - Running post-run listener: _upload_blobber_files 04:23:09 INFO - Blob upload gear active. 04:23:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:23:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:23:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:23:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:23:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:23:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:23:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:10 INFO - (blobuploader) - INFO - Done attempting. 04:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:23:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:16 INFO - (blobuploader) - INFO - Done attempting. 04:23:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:23:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:17 INFO - (blobuploader) - INFO - Done attempting. 04:23:17 INFO - (blobuploader) - INFO - Iteration through files over. 04:23:17 INFO - Return code: 0 04:23:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:23:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:23:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0287ae13b56ebdf5f086e9f1ac32ea7a934c7247a6c239d5f6168fff2670fdd9efb066451cf5e0a84dbcf8598a7ca42ddbbbe183d560f0bf84b0d0a2e622378", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8163057728245746a8e442f1baea9c2f328d6d16036cb83b9f63a057a07da04a78a9dab69317f655c9ca61e020850770899e47ceb5dcf193fa251f84759f5e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6258ffaefaa1373f67b2634b9d1aaaf7c295a720bc420f5104c9be32300feda2991aa57be88db3b11ad8f3788c8a65e0410ed92e00010af7aea1da872c174e82"} 04:23:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:23:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:23:17 INFO - Contents: 04:23:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0287ae13b56ebdf5f086e9f1ac32ea7a934c7247a6c239d5f6168fff2670fdd9efb066451cf5e0a84dbcf8598a7ca42ddbbbe183d560f0bf84b0d0a2e622378", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8163057728245746a8e442f1baea9c2f328d6d16036cb83b9f63a057a07da04a78a9dab69317f655c9ca61e020850770899e47ceb5dcf193fa251f84759f5e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6258ffaefaa1373f67b2634b9d1aaaf7c295a720bc420f5104c9be32300feda2991aa57be88db3b11ad8f3788c8a65e0410ed92e00010af7aea1da872c174e82"} 04:23:17 INFO - Running post-run listener: copy_logs_to_upload_dir 04:23:17 INFO - Copying logs to upload dir... 04:23:17 INFO - mkdir: /builds/slave/test/build/upload/logs 04:23:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.204682 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-16 04:23:17.192601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:17.196069) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0287ae13b56ebdf5f086e9f1ac32ea7a934c7247a6c239d5f6168fff2670fdd9efb066451cf5e0a84dbcf8598a7ca42ddbbbe183d560f0bf84b0d0a2e622378", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8163057728245746a8e442f1baea9c2f328d6d16036cb83b9f63a057a07da04a78a9dab69317f655c9ca61e020850770899e47ceb5dcf193fa251f84759f5e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6258ffaefaa1373f67b2634b9d1aaaf7c295a720bc420f5104c9be32300feda2991aa57be88db3b11ad8f3788c8a65e0410ed92e00010af7aea1da872c174e82"} build_url:https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/daMUosetThufbPcrk1RdBw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0287ae13b56ebdf5f086e9f1ac32ea7a934c7247a6c239d5f6168fff2670fdd9efb066451cf5e0a84dbcf8598a7ca42ddbbbe183d560f0bf84b0d0a2e622378", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8163057728245746a8e442f1baea9c2f328d6d16036cb83b9f63a057a07da04a78a9dab69317f655c9ca61e020850770899e47ceb5dcf193fa251f84759f5e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6258ffaefaa1373f67b2634b9d1aaaf7c295a720bc420f5104c9be32300feda2991aa57be88db3b11ad8f3788c8a65e0410ed92e00010af7aea1da872c174e82"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:17.221538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:17.221884) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1466073936.96885-135044429 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 04:23:17.307029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 04:23:17.307347) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 04:23:17.307638) ========= ========= Total master_lag: 0.17 =========