builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-067 starttime: 1469196662.62 results: success (0) buildid: 20160722043019 builduid: 5d7edf34424d49a9be4c8f3bd278aaca revision: e0bc88708ffed39aaab1fbc0ac461d93561195de ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.619837) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.620288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.620589) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.642996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.643412) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-22 07:11:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-07-22 07:11:03 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079317 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.739863) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.740255) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023002 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:02.790210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 07:11:02.793623) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0bc88708ffed39aaab1fbc0ac461d93561195de --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 e0bc88708ffed39aaab1fbc0ac461d93561195de --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=e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-22 07:11:03,379 truncating revision to first 12 chars 2016-07-22 07:11:03,379 Setting DEBUG logging. 2016-07-22 07:11:03,379 attempt 1/10 2016-07-22 07:11:03,379 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0bc88708ffe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-22 07:11:04,409 unpacking tar archive at: mozilla-central-e0bc88708ffe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.359123 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-22 07:11:04.170445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:04.170774) ========= script_repo_revision: e0bc88708ffed39aaab1fbc0ac461d93561195de ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:04.171182) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:04.171487) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-22 07:11:04.182220) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-22 07:11:04.182638) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:11:04 INFO - MultiFileLogger online at 20160722 07:11:04 in /builds/slave/test 07:11:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:11:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:11:04 INFO - {'append_to_log': False, 07:11:04 INFO - 'base_work_dir': '/builds/slave/test', 07:11:04 INFO - 'blob_upload_branch': 'Firefox', 07:11:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:11:04 INFO - 'branch': 'Firefox', 07:11:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:11:04 INFO - 'config_files': ('talos/linux_config.py',), 07:11:04 INFO - 'default_actions': ('clobber', 07:11:04 INFO - 'read-buildbot-config', 07:11:04 INFO - 'download-and-extract', 07:11:04 INFO - 'populate-webroot', 07:11:04 INFO - 'create-virtualenv', 07:11:04 INFO - 'install', 07:11:04 INFO - 'run-tests'), 07:11:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:11:04 INFO - 'download_minidump_stackwalk': True, 07:11:04 INFO - 'download_symbols': 'ondemand', 07:11:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:11:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:11:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:11:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:11:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:11:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:11:04 INFO - 'installer_path': 'installer.exe', 07:11:04 INFO - 'log_level': 'info', 07:11:04 INFO - 'log_name': 'talos', 07:11:04 INFO - 'log_to_console': True, 07:11:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:11:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:11:04 INFO - 'opt_config_files': (), 07:11:04 INFO - 'pip_index': False, 07:11:04 INFO - 'sps_profile': False, 07:11:04 INFO - 'sps_profile_interval': 0, 07:11:04 INFO - 'suite': 'dromaeojs-e10s', 07:11:04 INFO - 'system_bits': '32', 07:11:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:11:04 INFO - 'title': 'talos-linux64-ix-067', 07:11:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:11:04 INFO - 'use_talos_json': True, 07:11:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:11:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:11:04 INFO - 'work_dir': 'build'} 07:11:04 INFO - [mozharness: 2016-07-22 14:11:04.858634Z] Running clobber step. 07:11:04 INFO - Running pre-action listener: _resource_record_pre_action 07:11:04 INFO - Running main action method: clobber 07:11:04 INFO - rmtree: /builds/slave/test/build 07:11:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:11:05 INFO - Running post-action listener: _resource_record_post_action 07:11:05 INFO - [mozharness: 2016-07-22 14:11:05.328920Z] Finished clobber step (success) 07:11:05 INFO - [mozharness: 2016-07-22 14:11:05.329021Z] Running read-buildbot-config step. 07:11:05 INFO - Running pre-action listener: _resource_record_pre_action 07:11:05 INFO - Running main action method: read_buildbot_config 07:11:05 INFO - Using buildbot properties: 07:11:05 INFO - { 07:11:05 INFO - "project": "", 07:11:05 INFO - "product": "firefox", 07:11:05 INFO - "script_repo_revision": "production", 07:11:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:11:05 INFO - "repository": "", 07:11:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:11:05 INFO - "buildid": "20160722043019", 07:11:05 INFO - "pgo_build": "True", 07:11:05 INFO - "basedir": "/builds/slave/test", 07:11:05 INFO - "buildnumber": 13, 07:11:05 INFO - "slavename": "talos-linux64-ix-067", 07:11:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:11:05 INFO - "platform": "ubuntu64_hw", 07:11:05 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:11:05 INFO - "branch": "mozilla-central", 07:11:05 INFO - "repo_path": "mozilla-central", 07:11:05 INFO - "revision": "e0bc88708ffed39aaab1fbc0ac461d93561195de", 07:11:05 INFO - "stage_platform": "linux64-pgo", 07:11:05 INFO - "builduid": "5d7edf34424d49a9be4c8f3bd278aaca", 07:11:05 INFO - "slavebuilddir": "test" 07:11:05 INFO - } 07:11:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:11:05 INFO - Running post-action listener: _resource_record_post_action 07:11:05 INFO - [mozharness: 2016-07-22 14:11:05.331463Z] Finished read-buildbot-config step (success) 07:11:05 INFO - [mozharness: 2016-07-22 14:11:05.331551Z] Running download-and-extract step. 07:11:05 INFO - Running pre-action listener: _resource_record_pre_action 07:11:05 INFO - Running main action method: download_and_extract 07:11:05 INFO - mkdir: /builds/slave/test/build/tests 07:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:05 INFO - https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:11:07 INFO - Downloaded 1361 bytes. 07:11:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:11:07 INFO - Using the following test package requirements: 07:11:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:11:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:11:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:11:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'jsshell-linux-x86_64.zip'], 07:11:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:11:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:11:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:11:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:11:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:11:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:11:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:11:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:11:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:07 INFO - https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:11:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:11:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:11:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:11:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:11:09 INFO - Downloaded 24309595 bytes. 07:11:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:11:10 INFO - Return code: 0 07:11:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:11: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')]} 07:11:10 INFO - https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:11:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:11:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:11:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:11:14 INFO - Downloaded 24309595 bytes. 07:11:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:11:16 INFO - Return code: 0 07:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:16 INFO - https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:11:17 INFO - Downloaded 14403289 bytes. 07:11:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:11:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:11:17 INFO - Return code: 0 07:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:17 INFO - https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:11:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:11:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:11:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:11:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:11:18 INFO - Downloaded 60834382 bytes. 07:11:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:11:18 INFO - mkdir: /builds/slave/test/properties 07:11:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:18 INFO - Contents: 07:11:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:11:19 INFO - Running post-action listener: _resource_record_post_action 07:11:19 INFO - Running post-action listener: set_extra_try_arguments 07:11:19 INFO - [mozharness: 2016-07-22 14:11:19.353122Z] Finished download-and-extract step (success) 07:11:19 INFO - [mozharness: 2016-07-22 14:11:19.353399Z] Running populate-webroot step. 07:11:19 INFO - Running pre-action listener: _resource_record_pre_action 07:11:19 INFO - Running main action method: populate_webroot 07:11:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:11:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:11:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:11:19 INFO - '--tppagecycles', 07:11:19 INFO - '7'], 07:11:19 INFO - 'tests': ['tsvgm']}}, 07:11:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:11:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:11:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:11:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:11:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['damp', 'tps']}, 07:11:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'tests': ['damp', 'tps']}, 07:11:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['dromaeo_dom']}, 07:11:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['basic_compositor_video']}, 07:11:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:11:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['a11yr', 07:11:19 INFO - 'ts_paint', 07:11:19 INFO - 'tpaint', 07:11:19 INFO - 'sessionrestore', 07:11:19 INFO - 'sessionrestore_no_auto_restore', 07:11:19 INFO - 'tabpaint']}, 07:11:19 INFO - 'other-e10s': {'tests': ['a11yr', 07:11:19 INFO - 'ts_paint', 07:11:19 INFO - 'tpaint', 07:11:19 INFO - 'sessionrestore', 07:11:19 INFO - 'sessionrestore_no_auto_restore', 07:11:19 INFO - 'tabpaint']}, 07:11:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:11:19 INFO - 'ts_paint', 07:11:19 INFO - 'tpaint', 07:11:19 INFO - 'sessionrestore', 07:11:19 INFO - 'sessionrestore_no_auto_restore', 07:11:19 INFO - 'tabpaint']}, 07:11:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:11:19 INFO - 'ts_paint', 07:11:19 INFO - 'tpaint', 07:11:19 INFO - 'sessionrestore', 07:11:19 INFO - 'sessionrestore_no_auto_restore', 07:11:19 INFO - 'tabpaint']}, 07:11:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['a11yr', 07:11:19 INFO - 'ts_paint', 07:11:19 INFO - 'tpaint', 07:11:19 INFO - 'sessionrestore', 07:11:19 INFO - 'sessionrestore_no_auto_restore', 07:11:19 INFO - 'tabpaint']}, 07:11:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['a11yr', 07:11:19 INFO - 'ts_paint', 07:11:19 INFO - 'tpaint', 07:11:19 INFO - 'sessionrestore', 07:11:19 INFO - 'sessionrestore_no_auto_restore', 07:11:19 INFO - 'tabpaint']}, 07:11:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['tsvgx', 07:11:19 INFO - 'tsvgr_opacity', 07:11:19 INFO - 'tart', 07:11:19 INFO - 'tscrollx', 07:11:19 INFO - 'cart']}, 07:11:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:11:19 INFO - 'tsvgr_opacity', 07:11:19 INFO - 'tart', 07:11:19 INFO - 'tscrollx', 07:11:19 INFO - 'cart']}, 07:11:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'talos_options': ['--disable-e10s'], 07:11:19 INFO - 'tests': ['tp5o']}, 07:11:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'tests': ['tp5o']}, 07:11:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'talos_options': ['--disable-e10s', 07:11:19 INFO - '--xperf_path', 07:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:19 INFO - 'tests': ['tp5n']}, 07:11:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:11:19 INFO - 'talos_options': ['--xperf_path', 07:11:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:19 INFO - 'tests': ['tp5n']}}, 07:11:19 INFO - 'talos.zip': {'path': '', 07:11:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:11:19 INFO - Running post-action listener: _resource_record_post_action 07:11:19 INFO - [mozharness: 2016-07-22 14:11:19.375604Z] Finished populate-webroot step (success) 07:11:19 INFO - [mozharness: 2016-07-22 14:11:19.375693Z] Running create-virtualenv step. 07:11:19 INFO - Running pre-action listener: _resource_record_pre_action 07:11:19 INFO - Running main action method: create_virtualenv 07:11:19 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:11:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:19 INFO - Using real prefix '/usr' 07:11:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:20 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:21 INFO - Installing pip.................done. 07:11:21 INFO - Return code: 0 07:11:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:11:21 INFO - Using env: {'DISPLAY': ':0', 07:11:21 INFO - 'HOME': '/home/cltbld', 07:11:21 INFO - 'LANG': 'en_US.UTF-8', 07:11:21 INFO - 'LANGUAGE': 'en_US:en', 07:11:21 INFO - 'LOGNAME': 'cltbld', 07:11:21 INFO - 'MAIL': '/var/mail/cltbld', 07:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:21 INFO - 'MOZ_NO_REMOTE': '1', 07:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:21 INFO - 'NO_EM_RESTART': '1', 07:11:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:21 INFO - 'PWD': '/builds/slave/test', 07:11:21 INFO - 'SHELL': '/bin/bash', 07:11:21 INFO - 'SHLVL': '1', 07:11:21 INFO - 'TERM': 'linux', 07:11:21 INFO - 'TMOUT': '86400', 07:11:21 INFO - 'USER': 'cltbld', 07:11:21 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:21 INFO - '_': '/tools/buildbot/bin/python'} 07:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:11:22 INFO - Cleaning up... 07:11:22 INFO - Return code: 0 07:11:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:11:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:11:22 INFO - Using env: {'DISPLAY': ':0', 07:11:22 INFO - 'HOME': '/home/cltbld', 07:11:22 INFO - 'LANG': 'en_US.UTF-8', 07:11:22 INFO - 'LANGUAGE': 'en_US:en', 07:11:22 INFO - 'LOGNAME': 'cltbld', 07:11:22 INFO - 'MAIL': '/var/mail/cltbld', 07:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:22 INFO - 'MOZ_NO_REMOTE': '1', 07:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:22 INFO - 'NO_EM_RESTART': '1', 07:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:22 INFO - 'PWD': '/builds/slave/test', 07:11:22 INFO - 'SHELL': '/bin/bash', 07:11:22 INFO - 'SHLVL': '1', 07:11:22 INFO - 'TERM': 'linux', 07:11:22 INFO - 'TMOUT': '86400', 07:11:22 INFO - 'USER': 'cltbld', 07:11:22 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:22 INFO - '_': '/tools/buildbot/bin/python'} 07:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:22 INFO - Downloading/unpacking psutil>=3.1.1 07:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:24 INFO - Installing collected packages: psutil 07:11:24 INFO - Running setup.py install for psutil 07:11:24 INFO - building 'psutil._psutil_linux' extension 07:11:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:11:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:11:24 INFO - building 'psutil._psutil_posix' extension 07:11:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:11:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:11:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:24 INFO - Successfully installed psutil 07:11:24 INFO - Cleaning up... 07:11:24 INFO - Return code: 0 07:11:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:11:24 INFO - Using env: {'DISPLAY': ':0', 07:11:24 INFO - 'HOME': '/home/cltbld', 07:11:24 INFO - 'LANG': 'en_US.UTF-8', 07:11:24 INFO - 'LANGUAGE': 'en_US:en', 07:11:24 INFO - 'LOGNAME': 'cltbld', 07:11:24 INFO - 'MAIL': '/var/mail/cltbld', 07:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:24 INFO - 'MOZ_NO_REMOTE': '1', 07:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:24 INFO - 'NO_EM_RESTART': '1', 07:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:24 INFO - 'PWD': '/builds/slave/test', 07:11:24 INFO - 'SHELL': '/bin/bash', 07:11:24 INFO - 'SHLVL': '1', 07:11:24 INFO - 'TERM': 'linux', 07:11:24 INFO - 'TMOUT': '86400', 07:11:24 INFO - 'USER': 'cltbld', 07:11:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:24 INFO - '_': '/tools/buildbot/bin/python'} 07:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:11:27 INFO - Installing collected packages: mozsystemmonitor 07:11:27 INFO - Running setup.py install for mozsystemmonitor 07:11:27 INFO - Successfully installed mozsystemmonitor 07:11:27 INFO - Cleaning up... 07:11:27 INFO - Return code: 0 07:11:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:27 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:11:27 INFO - Using env: {'DISPLAY': ':0', 07:11:27 INFO - 'HOME': '/home/cltbld', 07:11:27 INFO - 'LANG': 'en_US.UTF-8', 07:11:27 INFO - 'LANGUAGE': 'en_US:en', 07:11:27 INFO - 'LOGNAME': 'cltbld', 07:11:27 INFO - 'MAIL': '/var/mail/cltbld', 07:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:27 INFO - 'MOZ_NO_REMOTE': '1', 07:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:27 INFO - 'NO_EM_RESTART': '1', 07:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:27 INFO - 'PWD': '/builds/slave/test', 07:11:27 INFO - 'SHELL': '/bin/bash', 07:11:27 INFO - 'SHLVL': '1', 07:11:27 INFO - 'TERM': 'linux', 07:11:27 INFO - 'TMOUT': '86400', 07:11:27 INFO - 'USER': 'cltbld', 07:11:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:27 INFO - '_': '/tools/buildbot/bin/python'} 07:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:27 INFO - Downloading/unpacking jsonschema==2.5.1 07:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:29 INFO - warning: no files found matching '*.txt' 07:11:29 INFO - no previously-included directories found matching 'build' 07:11:29 INFO - no previously-included directories found matching 'dist' 07:11:29 INFO - no previously-included directories found matching '.git*' 07:11:29 INFO - Installing collected packages: jsonschema, functools32 07:11:29 INFO - Running setup.py install for functools32 07:11:29 INFO - warning: no files found matching '*.txt' 07:11:29 INFO - no previously-included directories found matching 'build' 07:11:29 INFO - no previously-included directories found matching 'dist' 07:11:29 INFO - no previously-included directories found matching '.git*' 07:11:29 INFO - Successfully installed jsonschema functools32 07:11:29 INFO - Cleaning up... 07:11:29 INFO - Return code: 0 07:11:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:29 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:11:29 INFO - Using env: {'DISPLAY': ':0', 07:11:29 INFO - 'HOME': '/home/cltbld', 07:11:29 INFO - 'LANG': 'en_US.UTF-8', 07:11:29 INFO - 'LANGUAGE': 'en_US:en', 07:11:29 INFO - 'LOGNAME': 'cltbld', 07:11:29 INFO - 'MAIL': '/var/mail/cltbld', 07:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:29 INFO - 'MOZ_NO_REMOTE': '1', 07:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:29 INFO - 'NO_EM_RESTART': '1', 07:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:29 INFO - 'PWD': '/builds/slave/test', 07:11:29 INFO - 'SHELL': '/bin/bash', 07:11:29 INFO - 'SHLVL': '1', 07:11:29 INFO - 'TERM': 'linux', 07:11:29 INFO - 'TMOUT': '86400', 07:11:29 INFO - 'USER': 'cltbld', 07:11:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:29 INFO - '_': '/tools/buildbot/bin/python'} 07:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:30 INFO - Downloading/unpacking blobuploader==1.2.4 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:31 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:32 INFO - Downloading docopt-0.6.1.tar.gz 07:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:32 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:32 INFO - Running setup.py install for blobuploader 07:11:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:32 INFO - Running setup.py install for requests 07:11:33 INFO - Running setup.py install for docopt 07:11:33 INFO - Successfully installed blobuploader requests docopt 07:11:33 INFO - Cleaning up... 07:11:33 INFO - Return code: 0 07:11:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:33 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:33 INFO - Using env: {'DISPLAY': ':0', 07:11:33 INFO - 'HOME': '/home/cltbld', 07:11:33 INFO - 'LANG': 'en_US.UTF-8', 07:11:33 INFO - 'LANGUAGE': 'en_US:en', 07:11:33 INFO - 'LOGNAME': 'cltbld', 07:11:33 INFO - 'MAIL': '/var/mail/cltbld', 07:11:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:33 INFO - 'MOZ_NO_REMOTE': '1', 07:11:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:33 INFO - 'NO_EM_RESTART': '1', 07:11:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:33 INFO - 'PWD': '/builds/slave/test', 07:11:33 INFO - 'SHELL': '/bin/bash', 07:11:33 INFO - 'SHLVL': '1', 07:11:33 INFO - 'TERM': 'linux', 07:11:33 INFO - 'TMOUT': '86400', 07:11:33 INFO - 'USER': 'cltbld', 07:11:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:33 INFO - '_': '/tools/buildbot/bin/python'} 07:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:33 INFO - Running setup.py (path:/tmp/pip-f6HKtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:33 INFO - Running setup.py (path:/tmp/pip-TNhJDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:33 INFO - Running setup.py (path:/tmp/pip-BkHHUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:33 INFO - Running setup.py (path:/tmp/pip-TbGHJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:33 INFO - Running setup.py (path:/tmp/pip-HCnmfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:33 INFO - Running setup.py (path:/tmp/pip-DwA7YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:34 INFO - Running setup.py (path:/tmp/pip-enMjHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:34 INFO - Running setup.py (path:/tmp/pip-HtBYV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:34 INFO - Running setup.py (path:/tmp/pip-6B8nZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:34 INFO - Running setup.py (path:/tmp/pip-e2rrQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:34 INFO - Running setup.py (path:/tmp/pip-YE7VSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:34 INFO - Running setup.py (path:/tmp/pip-gUkmsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:34 INFO - Running setup.py (path:/tmp/pip-PiUuvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:34 INFO - Running setup.py (path:/tmp/pip-kNr1Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:34 INFO - Running setup.py (path:/tmp/pip-iX2Zcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:34 INFO - Running setup.py (path:/tmp/pip-AIXhFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:34 INFO - Running setup.py (path:/tmp/pip-yhFzYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:34 INFO - Running setup.py install for manifestparser 07:11:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:34 INFO - Running setup.py install for mozcrash 07:11:35 INFO - Running setup.py install for mozdebug 07:11:35 INFO - Running setup.py install for mozdevice 07:11:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Running setup.py install for mozfile 07:11:35 INFO - Running setup.py install for mozhttpd 07:11:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Running setup.py install for mozinfo 07:11:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Running setup.py install for mozInstall 07:11:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Running setup.py install for mozleak 07:11:35 INFO - Running setup.py install for mozlog 07:11:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Running setup.py install for moznetwork 07:11:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:35 INFO - Running setup.py install for mozprocess 07:11:36 INFO - Running setup.py install for mozprofile 07:11:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:36 INFO - Running setup.py install for mozrunner 07:11:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:36 INFO - Running setup.py install for mozscreenshot 07:11:36 INFO - Running setup.py install for moztest 07:11:36 INFO - Running setup.py install for mozversion 07:11:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:36 INFO - Cleaning up... 07:11:36 INFO - Return code: 0 07:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:36 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:36 INFO - Using env: {'DISPLAY': ':0', 07:11:36 INFO - 'HOME': '/home/cltbld', 07:11:36 INFO - 'LANG': 'en_US.UTF-8', 07:11:36 INFO - 'LANGUAGE': 'en_US:en', 07:11:36 INFO - 'LOGNAME': 'cltbld', 07:11:36 INFO - 'MAIL': '/var/mail/cltbld', 07:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:36 INFO - 'MOZ_NO_REMOTE': '1', 07:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:36 INFO - 'NO_EM_RESTART': '1', 07:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:36 INFO - 'PWD': '/builds/slave/test', 07:11:36 INFO - 'SHELL': '/bin/bash', 07:11:36 INFO - 'SHLVL': '1', 07:11:36 INFO - 'TERM': 'linux', 07:11:36 INFO - 'TMOUT': '86400', 07:11:36 INFO - 'USER': 'cltbld', 07:11:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:36 INFO - '_': '/tools/buildbot/bin/python'} 07:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:36 INFO - Running setup.py (path:/tmp/pip-zOjhFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:36 INFO - Running setup.py (path:/tmp/pip-153izS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:36 INFO - Running setup.py (path:/tmp/pip-lVfiVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:37 INFO - Running setup.py (path:/tmp/pip-FWc8lZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:37 INFO - Running setup.py (path:/tmp/pip-SMiOEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:37 INFO - Running setup.py (path:/tmp/pip-4HIQcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:37 INFO - Running setup.py (path:/tmp/pip-jyrvq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:37 INFO - Running setup.py (path:/tmp/pip-3KuvtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:37 INFO - Running setup.py (path:/tmp/pip-YY4N9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:37 INFO - Running setup.py (path:/tmp/pip-a6TZqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:37 INFO - Running setup.py (path:/tmp/pip-Xvc_zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:37 INFO - Running setup.py (path:/tmp/pip-FNPzH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:37 INFO - Running setup.py (path:/tmp/pip-kjRdjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:37 INFO - Running setup.py (path:/tmp/pip-hd1gUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:37 INFO - Running setup.py (path:/tmp/pip-RSsYkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:37 INFO - Running setup.py (path:/tmp/pip-5xGija-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:38 INFO - Running setup.py (path:/tmp/pip-rU3Rdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:11:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:11:39 INFO - Downloading blessings-1.6.tar.gz 07:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:40 INFO - Installing collected packages: blessings 07:11:40 INFO - Running setup.py install for blessings 07:11:40 INFO - Successfully installed blessings 07:11:40 INFO - Cleaning up... 07:11:40 INFO - Return code: 0 07:11:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:40 INFO - Reading from file tmpfile_stdout 07:11:40 INFO - Current package versions: 07:11:40 INFO - argparse == 1.2.1 07:11:40 INFO - blessings == 1.6 07:11:40 INFO - blobuploader == 1.2.4 07:11:40 INFO - docopt == 0.6.1 07:11:40 INFO - functools32 == 3.2.3-2 07:11:40 INFO - jsonschema == 2.5.1 07:11:40 INFO - manifestparser == 1.1 07:11:40 INFO - mozInstall == 1.12 07:11:40 INFO - mozcrash == 0.17 07:11:40 INFO - mozdebug == 0.1 07:11:40 INFO - mozdevice == 0.48 07:11:40 INFO - mozfile == 1.2 07:11:40 INFO - mozhttpd == 0.7 07:11:40 INFO - mozinfo == 0.9 07:11:40 INFO - mozleak == 0.1 07:11:40 INFO - mozlog == 3.3 07:11:40 INFO - moznetwork == 0.27 07:11:40 INFO - mozprocess == 0.23 07:11:40 INFO - mozprofile == 0.28 07:11:40 INFO - mozrunner == 6.12 07:11:40 INFO - mozscreenshot == 0.1 07:11:40 INFO - mozsystemmonitor == 0.3 07:11:40 INFO - moztest == 0.7 07:11:40 INFO - mozversion == 1.4 07:11:40 INFO - psutil == 3.1.1 07:11:40 INFO - requests == 1.2.3 07:11:40 INFO - wsgiref == 0.1.2 07:11:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:40 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:11:40 INFO - Using env: {'DISPLAY': ':0', 07:11:40 INFO - 'HOME': '/home/cltbld', 07:11:40 INFO - 'LANG': 'en_US.UTF-8', 07:11:40 INFO - 'LANGUAGE': 'en_US:en', 07:11:40 INFO - 'LOGNAME': 'cltbld', 07:11:40 INFO - 'MAIL': '/var/mail/cltbld', 07:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:40 INFO - 'MOZ_NO_REMOTE': '1', 07:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:40 INFO - 'NO_EM_RESTART': '1', 07:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:40 INFO - 'PWD': '/builds/slave/test', 07:11:40 INFO - 'SHELL': '/bin/bash', 07:11:40 INFO - 'SHLVL': '1', 07:11:40 INFO - 'TERM': 'linux', 07:11:40 INFO - 'TMOUT': '86400', 07:11:40 INFO - 'USER': 'cltbld', 07:11:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:40 INFO - '_': '/tools/buildbot/bin/python'} 07:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:11:40 INFO - Cleaning up... 07:11:40 INFO - Return code: 0 07:11:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:11:40 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 0x1b76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cd98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e37180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:11:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:11:40 INFO - Using env: {'DISPLAY': ':0', 07:11:40 INFO - 'HOME': '/home/cltbld', 07:11:40 INFO - 'LANG': 'en_US.UTF-8', 07:11:40 INFO - 'LANGUAGE': 'en_US:en', 07:11:40 INFO - 'LOGNAME': 'cltbld', 07:11:40 INFO - 'MAIL': '/var/mail/cltbld', 07:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:40 INFO - 'MOZ_NO_REMOTE': '1', 07:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:40 INFO - 'NO_EM_RESTART': '1', 07:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:40 INFO - 'PWD': '/builds/slave/test', 07:11:40 INFO - 'SHELL': '/bin/bash', 07:11:40 INFO - 'SHLVL': '1', 07:11:40 INFO - 'TERM': 'linux', 07:11:40 INFO - 'TMOUT': '86400', 07:11:40 INFO - 'USER': 'cltbld', 07:11:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:40 INFO - '_': '/tools/buildbot/bin/python'} 07:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:11:40 INFO - Cleaning up... 07:11:40 INFO - Return code: 0 07:11:40 INFO - Running post-action listener: _resource_record_post_action 07:11:40 INFO - Running post-action listener: _start_resource_monitoring 07:11:40 INFO - Starting resource monitoring. 07:11:40 INFO - [mozharness: 2016-07-22 14:11:40.898981Z] Finished create-virtualenv step (success) 07:11:40 INFO - [mozharness: 2016-07-22 14:11:40.899461Z] Running install step. 07:11:40 INFO - Running pre-action listener: _resource_record_pre_action 07:11:40 INFO - Running main action method: install 07:11:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:41 INFO - Reading from file tmpfile_stdout 07:11:41 INFO - Detecting whether we're running mozinstall >=1.0... 07:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:11:41 INFO - Reading from file tmpfile_stdout 07:11:41 INFO - Output received: 07:11:41 INFO - Usage: mozinstall [options] installer 07:11:41 INFO - Options: 07:11:41 INFO - -h, --help show this help message and exit 07:11:41 INFO - -d DEST, --destination=DEST 07:11:41 INFO - Directory to install application into. [default: 07:11:41 INFO - "/builds/slave/test"] 07:11:41 INFO - --app=APP Application being installed. [default: firefox] 07:11:41 INFO - mkdir: /builds/slave/test/build/application 07:11:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:11:58 INFO - Reading from file tmpfile_stdout 07:11:58 INFO - Output received: 07:11:58 INFO - /builds/slave/test/build/application/firefox/firefox 07:11:58 INFO - Running post-action listener: _resource_record_post_action 07:11:58 INFO - [mozharness: 2016-07-22 14:11:58.514735Z] Finished install step (success) 07:11:58 INFO - [mozharness: 2016-07-22 14:11:58.515010Z] Running run-tests step. 07:11:58 INFO - Running pre-action listener: _resource_record_pre_action 07:11:58 INFO - Running main action method: run_tests 07:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:11:58 INFO - Python 2.7.3 07:11:58 INFO - Return code: 0 07:11:58 INFO - grabbing minidump binary from tooltool 07:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:11:58 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 0x1e353b0>, '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 0x1e362b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e36740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:11:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:11:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:11:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:11:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:58 INFO - Return code: 0 07:11:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:11:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:11:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:11:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:11:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:11:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:11:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:11:58 INFO - Using env: {'DISPLAY': ':0', 07:11:58 INFO - 'HOME': '/home/cltbld', 07:11:58 INFO - 'LANG': 'en_US.UTF-8', 07:11:58 INFO - 'LANGUAGE': 'en_US:en', 07:11:58 INFO - 'LOGNAME': 'cltbld', 07:11:58 INFO - 'MAIL': '/var/mail/cltbld', 07:11:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:11:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:58 INFO - 'MOZ_NO_REMOTE': '1', 07:11:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:58 INFO - 'NO_EM_RESTART': '1', 07:11:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:58 INFO - 'PWD': '/builds/slave/test', 07:11:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:11:58 INFO - 'SHELL': '/bin/bash', 07:11:58 INFO - 'SHLVL': '1', 07:11:58 INFO - 'TERM': 'linux', 07:11:58 INFO - 'TMOUT': '86400', 07:11:58 INFO - 'USER': 'cltbld', 07:11:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208', 07:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:58 INFO - '_': '/tools/buildbot/bin/python'} 07:11:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:11:58 INFO - mozversion application_buildid: 20160722043019 07:11:58 INFO - mozversion application_changeset: e0bc88708ffed39aaab1fbc0ac461d93561195de 07:11:58 INFO - mozversion application_display_name: Nightly 07:11:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:58 INFO - mozversion application_name: Firefox 07:11:58 INFO - mozversion application_remotingname: firefox 07:11:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:11:58 INFO - mozversion application_vendor: Mozilla 07:11:58 INFO - mozversion application_version: 50.0a1 07:11:58 INFO - mozversion platform_buildid: 20160722043019 07:11:58 INFO - mozversion platform_changeset: e0bc88708ffed39aaab1fbc0ac461d93561195de 07:11:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:11:58 INFO - mozversion platform_version: 50.0a1 07:11:58 INFO - using testdate: 1469196718 07:11:58 INFO - actual date: 1469196718 07:11:58 INFO - starting webserver on 'localhost:49328' 07:11:58 INFO - SUITE-START | Running 2 tests 07:11:58 INFO - TEST-START | dromaeo_css 07:11:58 INFO - operating with platform_type : linux_ 07:11:58 INFO - Initialising browser for dromaeo_css test... 07:11:58 INFO - TEST-INFO | started process 3168 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp93TYqy/profile http://localhost:49328/getInfo.html) 07:12:01 INFO - PROCESS | 3168 | JavaScript error: , line 0: uncaught exception: undefined 07:12:03 INFO - PROCESS | 3168 | __metrics Screen width/height:1600/1200 07:12:03 INFO - PROCESS | 3168 | colorDepth:24 07:12:03 INFO - PROCESS | 3168 | Browser inner width/height: 1024/697 07:12:03 INFO - PROCESS | 3168 | __metrics 07:12:03 ERROR - PROCESS | 3168 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:12:04 INFO - TEST-INFO | 3168: exit 0 07:12:04 INFO - Browser initialized. 07:12:04 INFO - Running cycle 1/1 for dromaeo_css test... 07:12:04 INFO - TEST-INFO | started process 3287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp93TYqy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:16 INFO - PROCESS | 3287 | RSS: Main: 168312832 07:12:16 INFO - PROCESS | 3287 | 07:13:05 INFO - PROCESS | 3287 | 1469196785704 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:15:14 INFO - PROCESS | 3287 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49328/tests/dromaeo/cssquery-ext.html) 07:15:15 INFO - PROCESS | 3287 | RSS: Main: 173015040 07:15:15 INFO - PROCESS | 3287 | 07:18:18 INFO - PROCESS | 3287 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-ext.html (next: http://localhost:49328/tests/dromaeo/cssquery-jquery.html) 07:18:18 INFO - PROCESS | 3287 | RSS: Main: 170414080 07:18:18 INFO - PROCESS | 3287 | 07:21:20 INFO - PROCESS | 3287 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49328/tests/dromaeo/cssquery-mootools.html) 07:21:21 INFO - PROCESS | 3287 | RSS: Main: 173486080 07:21:21 INFO - PROCESS | 3287 | 07:24:23 INFO - PROCESS | 3287 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49328/tests/dromaeo/cssquery-prototype.html) 07:24:23 INFO - PROCESS | 3287 | RSS: Main: 168288256 07:24:23 INFO - PROCESS | 3287 | 07:27:26 INFO - PROCESS | 3287 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49328/tests/dromaeo/cssquery-yui.html) 07:27:26 INFO - PROCESS | 3287 | RSS: Main: 170332160 07:27:26 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | Cycle 1(1): loaded http://localhost:49328/tests/dromaeo/cssquery-yui.html (next: http://localhost:49328/tests/dromaeo/cssquery-dojo.html) 07:30:29 INFO - PROCESS | 3287 | RSS: Main: 173740032 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | __start_tp_report 07:30:29 INFO - PROCESS | 3287 | _x_x_mozilla_page_load 07:30:29 INFO - PROCESS | 3287 | _x_x_mozilla_page_load_details 07:30:29 INFO - PROCESS | 3287 | |i|pagename|runs| 07:30:29 INFO - PROCESS | 3287 | |0;dojo.html;3132.498800191969;3133.467310557205;3136.9215769605757;3142.607174103237;3159.1786135604752;5578.553715702744;5613.578981576383;5654.151877218419;5666;5701.515371193448;5397.487238712326;5552.472515111058;5595.888082238353;5599.132134519145;5658.094704847225;4973.5026497350245;5018.121828679985;5129.2562578426105;5146.536811686948;5159.948400515985;5101;5154.819581314655;5209.426963034063;5215.295935048758;5266.289050978126;5046.873828154307;5078.542931136179;5094.79620815167;5109.642325037249;5162.251473536317;5093.134167191586;5097.974510127426;5100.260462232993;5125.749458793486;5128.487151284841;5050.191969284933;5076.974615126901;5083.262926875583;5084.3644544431945;5106.412762532282;5395.838124856221;5500.22996780451;5508.724563771835;5596.804111856106;5665.348484924245;5969.791057313017;5987.3413924468705;5988.041913293852;5992.34084250732;6013.579049466539;6026.2165918430765;6035.7283922223605;6037.034074548095;6037.78867739627;6049.727762250709;5463.726813659341;5563.082091454905;5616.466435688603;5652.406497317805;5682.630629009184;6185.041318595625;6207.286162091417;6215;6230.6573138476915;6252.3122456529745;5947.791827286024;5960;5965.701714914237;5970.701464926737;5982.820515384546;5812.738426770806;5946.13781001761;5981.37195594465;5990.850228744316;6022.066579680157;5859;5922.703864806828;5934.37689042653;5967.701614919237;5994.520438364921;5996.430339117776;6004.189434426296;6016.819495415057;6019.4883434908525;6022.97609406402;4358.912821743547;4430.4683437987005;4454.77726113693;4459.777011149495;4462.308342206963;4038.273110840077;4050.1697152083752;4054.736442131252;4073.327900896319;4080.020795009236;5773.220615216976;5778.075507918797;5801.477866991991;5808.564357673192;5825.446582574648;5936.198613187251;6006.759729610854;6077.696115194222;6116.785912493041;6140.385961403913;5756.42435756421;5772.6536407815665;5778.88442231153;5787.768489260382;5811.796587119515;5037.269595908573;5037.420696619935;5040.1179793535985;5050.191969284897;5084.46613105626;6119.112728654321;6126.914660831567;6150.7539698411565;6230.190075290183;6296.779612713624;6098.0852872069545;6113.871604717183;6118.112873633209;6120.44915957566;6122.785702500391;6201.989767761054;6204.503639708722;6259.530535209969;6266.436020758154;6292.339304373158;5800.042992906123;5868.853278667897;5900.675462849585;5978.402159784161;5996.520278377807;6015.6691381974415;6037.818865434044;6064.696765161636;6066.575339726353;6072.180255665428;5893.322267939242;5901.0558310670085;5905.35041145465;5909.23179986599;5914.674692891932;5796.59423840344;5851.444112809277;5854.829034193093;5868.911966320594;5943.64338139713;5888.764449422147;5895.380984996514;5899.882002360015;5904.350521442552;5948.791792287249;5933.436323549256;5952.107183922446;5952.791652292149;6008.939910600838;6015.097735339734;5693.4021927696995;5706.885862282648;5725.169850371756;5753.367129615823;5893.734781934738 07:30:29 INFO - PROCESS | 3287 | |1;ext.html;559.2650770570011;579.6956597786163;605.5670195809995;615.1572345886134;622.8224955887573;38724.41913371298;42735.35896961548;42900.14199716004;43028.354574681405;43031.13937721248;43030.56969430313;43374.13251734971;43624.12751744971;43684.34473482901;43920.12159756803;8821.426607270507;8980.550972451383;9009.819803603925;9010.459372437643;9031.864522032174;8885.289176865868;8892.955535222347;8945.0607686193;8948.373613847034;9014.504202268872;9011.774705632379;9013.819723605524;9043.321750868678;9056.230220431271;9059.320550958671;8967.730968070968;8998.999999999967;9007.099290071006;9020.18818306349;9047.230985366252;8869.467831930106;8877.822443551157;8881;8931.419457735226;8933.821323573557;41512.58487415117;41852.79073604643;41904;41922.37116443256;42289.15421691549;3683.7605555638797;3705.1663375740513;3743.756655817363;3765.416360464105;3782.394816829294;32923;33343.83328083344;33517.49723754146;33657.32685346279;33663;4406.669499787528;4407.642170360445;4418.6023257906945;4439.800208990603;4452.844150454751;399597;402952;403500;405790;407162.96418518014;58159.41840581625;58691.70654146702;58771.41228587745;58817;58870.41129588735;35079.141294457586;35972.460413093824;36154.8192259037;37457.81271093627;37682.8115859419;16832;16876.746848797276;16994.745078823827;17026.23381947815;17039;12770.29763363024;12821;12892.742145157044;12903.612891613267;12935.28855912915;19426.34876035553;19435.640273995457;19437.373215067033;19526.73041372458;19564.43592355149;6916.308369163144;7044.330788575077;7257.129144502694;7282.308180722823;7402.370798482081;951.8429459139164;1012.1042877053713;1076.7577295108538;1095.742500512379;1137.2964582618176;33874.66125338765;34120.48819267713;34351.31297374088;34606.480902786476;34613.480797788055;1100.3287994323457;1187.1274613159321;1224.1186345831165;1248.4194849395076;1250.8874201321926;16856.91571542159;17252.568685782706;17471.213795379237;17578.384756533716;17629.118544073;602598;605713;606814;610744;613411;58753.41246587565;59111;59665.40334596685;59748.70125649344;59829;1322.7420652972578;1358.531306699187;1364.6179069860455;1378.3659516622465;1379.3241311757367;31803.20491987626;32716.83641581872;33719.831400842835;33762.15594610154;34003.319933601684;51611.2258316118;51716;51911.48088519218;51946.740266298424;51961.48038519567;478360;481216;481822;483585;484925;27629.585556216272;28190.71809281963;28973.130806075853;29022.27444313909;30446.543301850932;48488.84624610088;48749;49813.750931245115;50076.248856267914;50339;40960;42278.36582451204;42360.1527969445;42504.362434562885;43761;42538.78730606451;42923.57076429196;43579.34630980601;44130.77934610307;44295;41837;42056.36915446332;43064;43274.78362608167;43289;33070.83464582662;37186;37423;37449.6255037457;38367.42448863213;29329.266768330963;29473.85263073671;29595;29675.40649186961;29685.703142968294 07:30:29 INFO - PROCESS | 3287 | |2;jquery.html;372.3632588274051;379.8457181915827;393.7007874015748;395.60834773574163;416.83951678603745;16683.499495015138;18308.176132074055;20024;20233.291834785785;20336.89831550842;12109;12153.392330383489;12353.197042192274;12388.690282742937;12494.625161245154;5286.867828304304;5453.991011662835;5456.727163641822;5459.945400546003;5473.261109750172;5312.1766126250495;5363.865903352408;5805.593608447411;5838.970805145989;5851.063829787235;5695.288088988877;5841.211436456067;5842.21130147431;5842.707864606774;5843.18195452637;5791.884162316751;6786.219584747768;7044.260352662948;7047.506674532785;7078.115235595525;6751.223609284946;6825;6870.62211578363;6960.721571137148;6981.930180698178;26013;26977.46045079107;27507.449851003068;27755.444891102266;27954.16137515878;2595.3511622094475;2908.5637154426795;3341.933161336784;3348.815815130167;3409.6590340965954;16248.106354150517;16436.83563164365;16610.50168494947;16823.158842057972;17412.564685882826;2070.823979961705;2085.1971990783504;2087.008670881319;2096.119629755506;2178.4227179797367;100524;101363.49318253435;103310;103656;107727.46136269347;17911.73132403015;18247.543811404557;18670.253189872252;18714.71927921082;18738.344157954678;32715.50926736101;32910.341793164;32936.505952410254;32936.505952410735;33098.338033239685;10178;10225.130863876506;10392.688219353431;10432.530536125892;10658.840117398246;8501.829963400698;8524.829503410021;8600.311975041981;8772.210501054808;8834.293256539462;8688.565571721389;8753;8896.822063558693;8954.238889694449;8960.775980600407;3380;3392.1180493071483;3641.635836416337;3650.324689932371;3799.240151969562;963.6964356227766;965.3242730088966;983.5524836199512;989.8614194012844;996.7159359582485;20427.693584596243;20600.175992960114;20835;20845.478863028544;20997.265095721577;1010.8483727440796;1023.9436830974367;1024.3137098144261;1026.3944272879037;1082.312731415541;10643.41461219625;11186.16103792219;11307;11360.318380897173;11498.94250528742;466730.66538669035;470397;470464;483230;520236;90788.5460572693;91342;94040;107262.46368768107;108379.45810270899;1008.5108722269694;1028.4651980970004;1066.6000249906285;1068.3910171202494;1072.8873468285874;16281;18693.906530467262;19234.66650771899;19333.709994349814;19379.709304360164;44194.558054419045;44614.77692611516;45132.32301515414;45203.77398112988;45467;60079.39920600738;61831;62755.6862215686;64299;64541.67729161324;8505;8577.35669824778;8631.136886311318;8677.479351238946;8906.554672266491;11770.823437648613;13404.865951340362;13733.244671543162;13803.41260755026;13876.514321998682;10946.671599852018;11116.44417779124;11561.248518846249;11637.650870473899;11747.353895535827;11498.94250528742;11631.76736465283;11656.650300491;11738.58914937973;12204.32876191818;10954.671359859218;10976.945115274373;11401.885981140082;11426.885731142582;11716.94547490696;8011.919880801117;8170.591470426336;8375.329973601976;8595.44129631572;8596.527191004305;9172.403793753385;10424;10577.31247468912;10778.461076945965;10837.67486975392 07:30:29 INFO - PROCESS | 3287 | |3;mootools.html;1486.5466032859977;1517.6054225901266;1680.8235135310792;1818.8090250523694;1818.818118188182;8061.798455038627;8809.559522023888;8810.030896601369;9446.574904129313;9456.479893605849;8806.86789698155;9184.219341355976;9191.90808091919;9212.585433655484;9218.078192180796;2420.8426452280546;2442.815234611221;2452.5217582571404;2459.1638842793445;2470.0243403855466;2383.5222162259424;2407.217654262363;2473.6165894286414;2478.120267305108;2480.8139389545768;2409.421738782697;2440.73151953285;2448.2655203438985;2467.7902378297777;2478.2689106713565;2384.3919800450776;2410.216679579135;2412.1436889904007;2414.8792560372;2416.214730212679;2362.4566349739484;2375.4417711837705;2376.9286921392386;2381.499885024147;2393.2820153953917;9145.725628231165;9251.167394934488;9254.491002994833;9284.25725941923;9312.34813563051;5499.532539734128;5547.11246200606;5578.86052848682;5609.747561359749;5611.551075913917;3592.444997111561;3701.3152566775234;3808.352580061396;3832.405977073558;3833.6358045985585;1185.3836005277208;1228.342836582433;1235.2464996352219;1235.7096082420624;1259.2885019963692;12937.870621293761;12976.87023129766;12987.805182922359;13057.934710326483;13074.346282685829;4728.692634978715;4736.289556566542;4758.78585463655;4957.578605818546;5027.1956486962645;10832.566697332019;10913.618023369145;10924.180686448548;10934.781304373868;10968.670939871816;5602.887942241132;5627.380988091389;5628.887422251532;5630.239917611152;5641;4555.06621142665;4962.454130045692;5019.272205530177;5073.365829271341;5125.077486052546;3856.4986551748093;3940;4031.879043628696;4072.6945479089186;4117.814698338522;1234.5185377702703;1252.8872401483911;1261.9525793591297;1272.7136394311206;1284.9935750321188;915.8580420034905;1002.6540843409012;1021.3565453764081;1035.534009695625;1035.9689209323733;6011.909821352683;6066.4540191382985;6283.8114856554375;6407.173955422682;6409;468.5572134333091;479.05980777850266;485.02751982276015;488.3626866938679;490.6491858321246;4091.365838295069;4173.061061261192;4183.058811767328;4199.181159673834;4243.257429949746;11042.33745975244;11265.098792096613;11478.942605287088;11498.655040348804;11519.19365644397;11363.715907102389;11507.827382589268;11531.365774882293;11538.19232653723;11571.42142892852;8369.916300836914;8401.243888050105;8423.410361274651;8516.829663406697;8651.740447786577;6243.562950593415;6279.434850863444;6282.905756413749;6291.339409362135;6456.225252969673;10085.647002355176;10472.633457828939;10555.577776888838;10606.098481629147;10665.573377064831;10668.359898406121;10830.891691082988;10858.78282434331;10866.511007004861;10972;7176.354128128285;7907.84184316299;7910.485818421784;7954.125046245024;8043.356531477585;8986.730398087806;9028.052054534443;9073.274138069071;9093.863592045993;9108.906931168302;7920.564368959763;7996.56018918965;8051.597420129087;8068.277675780328;8195.631196596049;7965.960170199112;8071.071826739765;8108.391870609846;8173.18268173178;8319.83360332778;7350.816229594303;7439.404847612286;7451.701931922879;7500.549967001997;7533.849323013618;5460.208269800936;5482;5560.694161821139;5582.190582365615;5608.803691870765;5568.276124103841;5584.3857175711455;5643.463870932255;5699.401562835843;5718.714064296685 07:30:29 INFO - PROCESS | 3287 | |4;prototype.html;325.3233274788439;327.355110432448;331.72301128557655;336.13445378151266;340.73763202334186;5433.510984011438;5478.506934375905;5619.6066275360745;5645.774169033239;5657.745401456928;5489.066858634032;5513.393526712059;5516.613837031399;5526.226328314039;5548.167774833777;4313.425599656119;4333.804978775946;4362.476502819666;4362.912741745163;4375.6499480041675;4210.894727631803;4256.616904478597;4345.717528360647;4347;4352.411369850013;4274;4281.116308824123;4281.165172791307;4284.464441944757;4300.505441874193;4293.978530107345;4298.892527686801;4304.182205380967;4323.351497275403;4333.8699839004885;3540.345036168317;3798.297314996707;3833.7891415972113;3838.7907809040344;3847.76913385195;5394.622376433651;5425.267588875491;5428.565714742811;5433.157860531624;5469.480399362054;4912.164931961575;4943.752812359367;4952.356193694833;4954.975225123887;4979.278004689336;5552.167784631062;5750.769969201227;5806.545105662167;5809.448102430262;5809.543321723568;4109.547949725527;4135.648469880034;4142.08874047709;4158.438610787535;4164.4586203793615;6050.69746512677;6091.969540152315;6127.938720612781;6133.172021777048;6140.9385906140815;4128.752274863457;4190.979045104755;4223.619874211336;4231.9576804231565;4233.576642335804;4273.487181538236;4274.358846173099;4280.208161490134;4288;4291.163223171514;4873.585745211697;4902.828401005948;4916.5575098240615;4938.061768264019;4941.209406495015;5760.855978600569;5822.359540450547;5855.151003104611;5888.293404791452;5889.0283103287475;1468.4126349460087;1484.5154845154846;1487.8884083693765;1488.6576087499936;1496.2120266281906;885.8449771289999;935.3592788939599;939.6899023322287;952.8951815300311;956.4070276428658;4983.9252411213865;4992.879450343536;5000.149974504343;5011.924821127686;5015.27278544609;5200.739963001911;5291.550218231493;5293.920591191135;5311.7344132793205;5319.0745090200235;4676.63829765966;4939.506049395031;4968;5010.549050585392;5038.974805126024;2824.519831628587;2831.858407079638;2850.2731803390416;2850.957235641467;2879.424115176973;5411.783528658888;5440.292761941001;5453.972730136324;5458.863528411742;5481.013417584873;5190.714510701872;5366.651167674088;5375.521731523862;5400.513953744104;5408.242846001563;5409.891802163935;5426.430224826416;5426.8371948841595;5455.236266922634;5495.505404513613;5134.383873935151;5336.466353364633;5360.437154098763;5367.838964831061;5369.436209197978;5049.368828896388;5212.530872221519;5239.659422137549;5245.796765358635;5254.605904557097;5461.453854614507;5468.8865910373925;5485.451454854483;5526.834194974157;5548;4003.499562554681;4088.2436749201493;4195.49654041517;4202.075543380452;4212.199682060399;5970.343262241063;6004.309504406874;6007.639541627516;6013.6692481913915;6030.30651475086;5652.85867853307;5790.623609465371;5848.912266316093;5886.735096920564;5891.587588868738;5809.157672137601;5816.36020037804;5841.94158058414;5848.736806843787;5857.824265272048;5746.741396637078;5752.252207213036;5788.623739456922;5790.536757059509;5813.970930145322;5600.439956004367;5801.709914504342;5830.5044071254415;5879.853003674943;5881.5588830837005;5681.602287839812;5694;5730;5746.195532625519;5751.913721294268 07:30:29 INFO - PROCESS | 3287 | |5;yui.html;711.4486273138317;724.4023680463615;754.777340684498;776.2974508070198;829.3116713128097;15171.544853654394;15636.061836289831;15712.371505139781;15721.921390393047;15739.213039348015;13954.651133721662;14002.929985350085;14032.649183770385;14052.367643456044;14079.084859484126;662.3475876261879;795.4670370851514;803.1687203744111;812.6586833529902;816.9836603267931;815.8082850530151;817.9304759095454;818.5211651184035;819.1317203763999;819.8893149424811;859.4542465534399;863.5768473448028;864.6671031652827;864.7319331007376;865.5153114256005;861.0700443520982;867.7526904832124;868.4702331577732;869.5521806269776;869.8434281829268;627.3600927054379;630.4767043354005;630.8517498387876;631.3907079668096;632.617266553733;14286.214258215794;14347;14356.138631682132;14401.20793356365;14517.128972261698;14443.133411995208;15065.397384104623;15090;15149.697006059818;15225.543233703007;12447.315397653125;12494.187877787916;12607.747845043139;12676.556320528829;12714.364281785965;3963.3064213762764;4022.939655905164;4081.877543673665;4097.508299004138;4181.770002649853;75419;75424.62287688581;75515.62242188754;75690.62154689246;75719.62140189264;11149.498272577754;11379.431028448544;11599.88400115988;11733.178677492493;11923.344216068199;22325.441863953532;22427;22563.774362256496;22612.0955161795;22939.42651433694;8669.869951950726;8702.173293537104;8740;8773.736787896374;8910.376273660782;4697;4809.807607695723;4812.639052071108;4839.443464001614;5040.47075057121;3673.1918977824835;3771.2080463102507;3775.8300876460626;3782.981085094557;3795.4686343911876;678.7997540725498;698.3784431855653;705.4885208223997;725.1298441869777;729.6242435145904;656.9310222426672;693.6115775165923;740.6373667999173;758.8634045871796;763.050002746573;10030.348027378197;10459;10506.579736810594;10520.947395262974;10610.628627997983;744.6537360127567;756.7011030642865;773.4585789947059;775.1937984496174;785.340314136117;4687.437507499122;4770.54370678902;4953;4963.45402005779;4995.925061124086;69048.6547567259;69330.30669693339;69568;69724;130391;98093.50953245188;98134.5093274529;99959;102924;103123;55441.168382474294;56611.43388566062;61275;74761.25238747761;87219.56390218009;9927;10139.2395570334;10146.340487868265;10235.385876847413;10307.639232626821;50458.2431263524;50875.74562127166;51240.74379628078;51869.481305187976;52440.47559524356;73447.63276183585;73706.63146684233;78896;79020;81484.18515814767;13521;13557.728845422838;13642.522511712043;13644.59066227975;13649.181049137083;15325;15433.5369938902;15616.609584760017;15757.684846303238;16182.757258640895;13699.657508562366;13774.931125344308;13903.791443128159;14533.128012319296;14660.266986650411;14329.498467554002;14509.201993890438;14574.562763117123;15176.620584485476;15279.61800954985;13923.443062277396;13984.230867302396;14026.158430494203;14100.36548355306;14374.3531541083;11892.524299027942;12029.15795894314;12277.938610306892;12298.20061695987;12366.381680916098;11067.225294229327;12124.515019399125;12268;12471.750564988468;12550.43523041447 07:30:29 INFO - PROCESS | 3287 | __end_tp_report 07:30:29 INFO - PROCESS | 3287 | __start_cc_report 07:30:29 INFO - PROCESS | 3287 | _x_x_mozilla_cycle_collect,338 07:30:29 INFO - PROCESS | 3287 | __end_cc_report 07:30:29 INFO - PROCESS | 3287 | __startTimestamp1469197829787__endTimestamp 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | ------- Summary: start ------- 07:30:29 INFO - PROCESS | 3287 | Number of tests: 6 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | [#0] dojo.html Cycles:165 Average:5582.70 Median:5851.44 stddev:668.00 (11.4%) stddev-sans-first:641.80 07:30:29 INFO - PROCESS | 3287 | Values: 3132.5 3133.5 3136.9 3142.6 3159.2 5578.6 5613.6 5654.2 5666.0 5701.5 5397.5 5552.5 5595.9 5599.1 5658.1 4973.5 5018.1 5129.3 5146.5 5159.9 5101.0 5154.8 5209.4 5215.3 5266.3 5046.9 5078.5 5094.8 5109.6 5162.3 5093.1 5098.0 5100.3 5125.7 5128.5 5050.2 5077.0 5083.3 5084.4 5106.4 5395.8 5500.2 5508.7 5596.8 5665.3 5969.8 5987.3 5988.0 5992.3 6013.6 6026.2 6035.7 6037.0 6037.8 6049.7 5463.7 5563.1 5616.5 5652.4 5682.6 6185.0 6207.3 6215.0 6230.7 6252.3 5947.8 5960.0 5965.7 5970.7 5982.8 5812.7 5946.1 5981.4 5990.9 6022.1 5859.0 5922.7 5934.4 5967.7 5994.5 5996.4 6004.2 6016.8 6019.5 6023.0 4358.9 4430.5 4454.8 4459.8 4462.3 4038.3 4050.2 4054.7 4073.3 4080.0 5773.2 5778.1 5801.5 5808.6 5825.4 5936.2 6006.8 6077.7 6116.8 6140.4 5756.4 5772.7 5778.9 5787.8 5811.8 5037.3 5037.4 5040.1 5050.2 5084.5 6119.1 6126.9 6150.8 6230.2 6296.8 6098.1 6113.9 6118.1 6120.4 6122.8 6202.0 6204.5 6259.5 6266.4 6292.3 5800.0 5868.9 5900.7 5978.4 5996.5 6015.7 6037.8 6064.7 6066.6 6072.2 5893.3 5901.1 5905.4 5909.2 5914.7 5796.6 5851.4 5854.8 5868.9 5943.6 5888.8 5895.4 5899.9 5904.4 5948.8 5933.4 5952.1 5952.8 6008.9 6015.1 5693.4 5706.9 5725.2 5753.4 5893.7 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | [#1] ext.html Cycles:180 Average:64796.99 Median:42521.57 stddev:134349.39 (316.0%) stddev-sans-first:134639.71 07:30:29 INFO - PROCESS | 3287 | Values: 559.3 579.7 605.6 615.2 622.8 38724.4 42735.4 42900.1 43028.4 43031.1 43030.6 43374.1 43624.1 43684.3 43920.1 8821.4 8980.6 9009.8 9010.5 9031.9 8885.3 8893.0 8945.1 8948.4 9014.5 9011.8 9013.8 9043.3 9056.2 9059.3 8967.7 8999.0 9007.1 9020.2 9047.2 8869.5 8877.8 8881.0 8931.4 8933.8 41512.6 41852.8 41904.0 41922.4 42289.2 3683.8 3705.2 3743.8 3765.4 3782.4 32923.0 33343.8 33517.5 33657.3 33663.0 4406.7 4407.6 4418.6 4439.8 4452.8 399597.0 402952.0 403500.0 405790.0 407163.0 58159.4 58691.7 58771.4 58817.0 58870.4 35079.1 35972.5 36154.8 37457.8 37682.8 16832.0 16876.7 16994.7 17026.2 17039.0 12770.3 12821.0 12892.7 12903.6 12935.3 19426.3 19435.6 19437.4 19526.7 19564.4 6916.3 7044.3 7257.1 7282.3 7402.4 951.8 1012.1 1076.8 1095.7 1137.3 33874.7 34120.5 34351.3 34606.5 34613.5 1100.3 1187.1 1224.1 1248.4 1250.9 16856.9 17252.6 17471.2 17578.4 17629.1 602598.0 605713.0 606814.0 610744.0 613411.0 58753.4 59111.0 59665.4 59748.7 59829.0 1322.7 1358.5 1364.6 1378.4 1379.3 31803.2 32716.8 33719.8 33762.2 34003.3 51611.2 51716.0 51911.5 51946.7 51961.5 478360.0 481216.0 481822.0 483585.0 484925.0 27629.6 28190.7 28973.1 29022.3 30446.5 48488.8 48749.0 49813.8 50076.2 50339.0 40960.0 42278.4 42360.2 42504.4 43761.0 42538.8 42923.6 43579.3 44130.8 44295.0 41837.0 42056.4 43064.0 43274.8 43289.0 33070.8 37186.0 37423.0 37449.6 38367.4 29329.3 29473.9 29595.0 29675.4 29685.7 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | [#2] jquery.html Cycles:180 Average:30959.31 Median:27854.80 stddev:80146.13 (287.7%) stddev-sans-first:80338.06 07:30:29 INFO - PROCESS | 3287 | Values: 372.4 379.8 393.7 395.6 416.8 16683.5 18308.2 20024.0 20233.3 20336.9 12109.0 12153.4 12353.2 12388.7 12494.6 5286.9 5454.0 5456.7 5459.9 5473.3 5312.2 5363.9 5805.6 5839.0 5851.1 5695.3 5841.2 5842.2 5842.7 5843.2 5791.9 6786.2 7044.3 7047.5 7078.1 6751.2 6825.0 6870.6 6960.7 6981.9 26013.0 26977.5 27507.4 27755.4 27954.2 2595.4 2908.6 3341.9 3348.8 3409.7 16248.1 16436.8 16610.5 16823.2 17412.6 2070.8 2085.2 2087.0 2096.1 2178.4 100524.0 101363.5 103310.0 103656.0 107727.5 17911.7 18247.5 18670.3 18714.7 18738.3 32715.5 32910.3 32936.5 32936.5 33098.3 10178.0 10225.1 10392.7 10432.5 10658.8 8501.8 8524.8 8600.3 8772.2 8834.3 8688.6 8753.0 8896.8 8954.2 8960.8 3380.0 3392.1 3641.6 3650.3 3799.2 963.7 965.3 983.6 989.9 996.7 20427.7 20600.2 20835.0 20845.5 20997.3 1010.8 1023.9 1024.3 1026.4 1082.3 10643.4 11186.2 11307.0 11360.3 11498.9 466730.7 470397.0 470464.0 483230.0 520236.0 90788.5 91342.0 94040.0 107262.5 108379.5 1008.5 1028.5 1066.6 1068.4 1072.9 16281.0 18693.9 19234.7 19333.7 19379.7 44194.6 44614.8 45132.3 45203.8 45467.0 60079.4 61831.0 62755.7 64299.0 64541.7 8505.0 8577.4 8631.1 8677.5 8906.6 11770.8 13404.9 13733.2 13803.4 13876.5 10946.7 11116.4 11561.2 11637.7 11747.4 11498.9 11631.8 11656.7 11738.6 12204.3 10954.7 10976.9 11401.9 11426.9 11716.9 8011.9 8170.6 8375.3 8595.4 8596.5 9172.4 10424.0 10577.3 10778.5 10837.7 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | [#3] mootools.html Cycles:180 Average:6076.79 Median:2598.62 stddev:3479.73 (133.9%) stddev-sans-first:3472.40 07:30:29 INFO - PROCESS | 3287 | Values: 1486.5 1517.6 1680.8 1818.8 1818.8 8061.8 8809.6 8810.0 9446.6 9456.5 8806.9 9184.2 9191.9 9212.6 9218.1 2420.8 2442.8 2452.5 2459.2 2470.0 2383.5 2407.2 2473.6 2478.1 2480.8 2409.4 2440.7 2448.3 2467.8 2478.3 2384.4 2410.2 2412.1 2414.9 2416.2 2362.5 2375.4 2376.9 2381.5 2393.3 9145.7 9251.2 9254.5 9284.3 9312.3 5499.5 5547.1 5578.9 5609.7 5611.6 3592.4 3701.3 3808.4 3832.4 3833.6 1185.4 1228.3 1235.2 1235.7 1259.3 12937.9 12976.9 12987.8 13057.9 13074.3 4728.7 4736.3 4758.8 4957.6 5027.2 10832.6 10913.6 10924.2 10934.8 10968.7 5602.9 5627.4 5628.9 5630.2 5641.0 4555.1 4962.5 5019.3 5073.4 5125.1 3856.5 3940.0 4031.9 4072.7 4117.8 1234.5 1252.9 1262.0 1272.7 1285.0 915.9 1002.7 1021.4 1035.5 1036.0 6011.9 6066.5 6283.8 6407.2 6409.0 468.6 479.1 485.0 488.4 490.6 4091.4 4173.1 4183.1 4199.2 4243.3 11042.3 11265.1 11478.9 11498.7 11519.2 11363.7 11507.8 11531.4 11538.2 11571.4 8369.9 8401.2 8423.4 8516.8 8651.7 6243.6 6279.4 6282.9 6291.3 6456.2 10085.6 10472.6 10555.6 10606.1 10665.6 10668.4 10830.9 10858.8 10866.5 10972.0 7176.4 7907.8 7910.5 7954.1 8043.4 8986.7 9028.1 9073.3 9093.9 9108.9 7920.6 7996.6 8051.6 8068.3 8195.6 7966.0 8071.1 8108.4 8173.2 8319.8 7350.8 7439.4 7451.7 7500.5 7533.8 5460.2 5482.0 5560.7 5582.2 5608.8 5568.3 5584.4 5643.5 5699.4 5718.7 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | [#4] prototype.html Cycles:180 Average:4718.77 Median:5315.40 stddev:1368.20 (25.7%) stddev-sans-first:1331.70 07:30:29 INFO - PROCESS | 3287 | Values: 325.3 327.4 331.7 336.1 340.7 5433.5 5478.5 5619.6 5645.8 5657.7 5489.1 5513.4 5516.6 5526.2 5548.2 4313.4 4333.8 4362.5 4362.9 4375.6 4210.9 4256.6 4345.7 4347.0 4352.4 4274.0 4281.1 4281.2 4284.5 4300.5 4294.0 4298.9 4304.2 4323.4 4333.9 3540.3 3798.3 3833.8 3838.8 3847.8 5394.6 5425.3 5428.6 5433.2 5469.5 4912.2 4943.8 4952.4 4955.0 4979.3 5552.2 5750.8 5806.5 5809.4 5809.5 4109.5 4135.6 4142.1 4158.4 4164.5 6050.7 6092.0 6127.9 6133.2 6140.9 4128.8 4191.0 4223.6 4232.0 4233.6 4273.5 4274.4 4280.2 4288.0 4291.2 4873.6 4902.8 4916.6 4938.1 4941.2 5760.9 5822.4 5855.2 5888.3 5889.0 1468.4 1484.5 1487.9 1488.7 1496.2 885.8 935.4 939.7 952.9 956.4 4983.9 4992.9 5000.1 5011.9 5015.3 5200.7 5291.6 5293.9 5311.7 5319.1 4676.6 4939.5 4968.0 5010.5 5039.0 2824.5 2831.9 2850.3 2851.0 2879.4 5411.8 5440.3 5454.0 5458.9 5481.0 5190.7 5366.7 5375.5 5400.5 5408.2 5409.9 5426.4 5426.8 5455.2 5495.5 5134.4 5336.5 5360.4 5367.8 5369.4 5049.4 5212.5 5239.7 5245.8 5254.6 5461.5 5468.9 5485.5 5526.8 5548.0 4003.5 4088.2 4195.5 4202.1 4212.2 5970.3 6004.3 6007.6 6013.7 6030.3 5652.9 5790.6 5848.9 5886.7 5891.6 5809.2 5816.4 5841.9 5848.7 5857.8 5746.7 5752.3 5788.6 5790.5 5814.0 5600.4 5801.7 5830.5 5879.9 5881.6 5681.6 5694.0 5730.0 5746.2 5751.9 07:30:29 INFO - PROCESS | 3287 | 07:30:29 INFO - PROCESS | 3287 | [#5] yui.html Cycles:180 Average:19704.91 Median:4139.64 stddev:26814.03 (647.7%) stddev-sans-first:26851.32 07:30:29 INFO - PROCESS | 3287 | Values: 711.4 724.4 754.8 776.3 829.3 15171.5 15636.1 15712.4 15721.9 15739.2 13954.7 14002.9 14032.6 14052.4 14079.1 662.3 795.5 803.2 812.7 817.0 815.8 817.9 818.5 819.1 819.9 859.5 863.6 864.7 864.7 865.5 861.1 867.8 868.5 869.6 869.8 627.4 630.5 630.9 631.4 632.6 14286.2 14347.0 14356.1 14401.2 14517.1 14443.1 15065.4 15090.0 15149.7 15225.5 12447.3 12494.2 12607.7 12676.6 12714.4 3963.3 4022.9 4081.9 4097.5 4181.8 75419.0 75424.6 75515.6 75690.6 75719.6 11149.5 11379.4 11599.9 11733.2 11923.3 22325.4 22427.0 22563.8 22612.1 22939.4 8669.9 8702.2 8740.0 8773.7 8910.4 4697.0 4809.8 4812.6 4839.4 5040.5 3673.2 3771.2 3775.8 3783.0 3795.5 678.8 698.4 705.5 725.1 729.6 656.9 693.6 740.6 758.9 763.1 10030.3 10459.0 10506.6 10520.9 10610.6 744.7 756.7 773.5 775.2 785.3 4687.4 4770.5 4953.0 4963.5 4995.9 69048.7 69330.3 69568.0 69724.0 130391.0 98093.5 98134.5 99959.0 102924.0 103123.0 55441.2 56611.4 61275.0 74761.3 87219.6 9927.0 10139.2 10146.3 10235.4 10307.6 50458.2 50875.7 51240.7 51869.5 52440.5 73447.6 73706.6 78896.0 79020.0 81484.2 13521.0 13557.7 13642.5 13644.6 13649.2 15325.0 15433.5 15616.6 15757.7 16182.8 13699.7 13774.9 13903.8 14533.1 14660.3 14329.5 14509.2 14574.6 15176.6 15279.6 13923.4 13984.2 14026.2 14100.4 14374.4 11892.5 12029.2 12277.9 12298.2 12366.4 11067.2 12124.5 12268.0 12471.8 12550.4 07:30:29 INFO - PROCESS | 3287 | -------- Summary: end -------- 07:30:29 INFO - PROCESS | 3287 | 07:30:30 INFO - TEST-INFO | 3287: exit 0 07:30:30 INFO - TEST-OK | dromaeo_css | took 1111795ms 07:30:30 INFO - TEST-START | kraken 07:30:30 INFO - operating with platform_type : linux_ 07:30:30 INFO - Initialising browser for kraken test... 07:30:30 INFO - TEST-INFO | started process 3545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwRAHu/profile http://localhost:49328/getInfo.html) 07:30:33 INFO - PROCESS | 3545 | JavaScript error: , line 0: uncaught exception: undefined 07:30:34 INFO - PROCESS | 3545 | __metrics Screen width/height:1600/1200 07:30:34 INFO - PROCESS | 3545 | colorDepth:24 07:30:34 INFO - PROCESS | 3545 | Browser inner width/height: 1024/697 07:30:34 INFO - PROCESS | 3545 | __metrics 07:30:35 ERROR - PROCESS | 3545 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 07:30:35 INFO - TEST-INFO | 3545: exit 0 07:30:35 INFO - Browser initialized. 07:30:35 INFO - Running cycle 1/1 for kraken test... 07:30:35 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRwRAHu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:47 INFO - PROCESS | 3663 | RSS: Main: 167989248 07:30:47 INFO - PROCESS | 3663 | 07:30:50 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:51 INFO - PROCESS | 3663 | RSS: Main: 173314048 07:30:51 INFO - PROCESS | 3663 | 07:30:53 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-dft) 07:30:54 INFO - PROCESS | 3663 | RSS: Main: 172093440 07:30:54 INFO - PROCESS | 3663 | 07:30:57 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-fft) 07:30:57 INFO - PROCESS | 3663 | RSS: Main: 168779776 07:30:57 INFO - PROCESS | 3663 | 07:30:59 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49328/tests/kraken/driver.html?testName=audio-oscillator) 07:31:00 INFO - PROCESS | 3663 | RSS: Main: 169222144 07:31:00 INFO - PROCESS | 3663 | 07:31:02 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49328/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:31:03 INFO - PROCESS | 3663 | RSS: Main: 169373696 07:31:03 INFO - PROCESS | 3663 | 07:31:06 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49328/tests/kraken/driver.html?testName=imaging-darkroom) 07:31:07 INFO - PROCESS | 3663 | RSS: Main: 169140224 07:31:07 INFO - PROCESS | 3663 | 07:31:10 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49328/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:11 INFO - PROCESS | 3663 | RSS: Main: 170139648 07:31:11 INFO - PROCESS | 3663 | 07:31:14 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49328/tests/kraken/driver.html?testName=json-parse-financial) 07:31:14 INFO - PROCESS | 3663 | RSS: Main: 169938944 07:31:14 INFO - PROCESS | 3663 | 07:31:16 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49328/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:16 INFO - PROCESS | 3663 | RSS: Main: 169668608 07:31:16 INFO - PROCESS | 3663 | 07:31:18 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:31:19 INFO - PROCESS | 3663 | RSS: Main: 170147840 07:31:19 INFO - PROCESS | 3663 | 07:31:21 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:31:22 INFO - PROCESS | 3663 | RSS: Main: 170594304 07:31:22 INFO - PROCESS | 3663 | 07:31:24 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:31:25 INFO - PROCESS | 3663 | RSS: Main: 170577920 07:31:25 INFO - PROCESS | 3663 | 07:31:27 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:31:28 INFO - PROCESS | 3663 | RSS: Main: 170864640 07:31:28 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | Cycle 1(1): loaded http://localhost:49328/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49328/tests/kraken/driver.html?testName=ai-astar) 07:31:30 INFO - PROCESS | 3663 | RSS: Main: 171343872 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | __start_tp_report 07:31:30 INFO - PROCESS | 3663 | _x_x_mozilla_page_load 07:31:30 INFO - PROCESS | 3663 | _x_x_mozilla_page_load_details 07:31:30 INFO - PROCESS | 3663 | |i|pagename|runs| 07:31:30 INFO - PROCESS | 3663 | |0;ai-astar;105;114;107;112;112;114;114;113;114;112 07:31:30 INFO - PROCESS | 3663 | |1;audio-beat-detection;152;119;149;184;123;148;142;120;181;119 07:31:30 INFO - PROCESS | 3663 | |2;audio-dft;163;162;163;164;163;163;173;165;164;162 07:31:30 INFO - PROCESS | 3663 | |3;audio-fft;76;78;76;166;77;76;75;75;162;76 07:31:30 INFO - PROCESS | 3663 | |4;audio-oscillator;84;83;164;84;84;83;149;84;85;146 07:31:30 INFO - PROCESS | 3663 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;118;117;117 07:31:30 INFO - PROCESS | 3663 | |6;imaging-darkroom;146;147;146;147;148;147;147;147;148;150 07:31:30 INFO - PROCESS | 3663 | |7;imaging-desaturate;96;98;95;95;96;95;96;96;95;95 07:31:30 INFO - PROCESS | 3663 | |8;json-parse-financial;55;56;56;55;57;54;59;55;57;55 07:31:30 INFO - PROCESS | 3663 | |9;json-stringify-tinderbox;63;64;63;63;63;62;63;65;64;64 07:31:30 INFO - PROCESS | 3663 | |10;stanford-crypto-aes;82;76;76;77;75;80;76;76;82;75 07:31:30 INFO - PROCESS | 3663 | |11;stanford-crypto-ccm;126;128;130;121;124;142;126;126;161;133 07:31:30 INFO - PROCESS | 3663 | |12;stanford-crypto-pbkdf2;159;155;159;160;163;161;158;155;157;158 07:31:30 INFO - PROCESS | 3663 | |13;stanford-crypto-sha256-iterative;64;63;69;64;63;63;64;63;63;63 07:31:30 INFO - PROCESS | 3663 | __end_tp_report 07:31:30 INFO - PROCESS | 3663 | __start_cc_report 07:31:30 INFO - PROCESS | 3663 | _x_x_mozilla_cycle_collect,909 07:31:30 INFO - PROCESS | 3663 | __end_cc_report 07:31:30 INFO - PROCESS | 3663 | __startTimestamp1469197890529__endTimestamp 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | ------- Summary: start ------- 07:31:30 INFO - PROCESS | 3663 | Number of tests: 14 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:3.16 (2.8%) stddev-sans-first:2.24 07:31:30 INFO - PROCESS | 3663 | Values: 105.0 114.0 107.0 112.0 112.0 114.0 114.0 113.0 114.0 112.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:148.50 stddev:24.37 (16.4%) stddev-sans-first:25.66 07:31:30 INFO - PROCESS | 3663 | Values: 152.0 119.0 149.0 184.0 123.0 148.0 142.0 120.0 181.0 119.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.22 (2.0%) stddev-sans-first:3.39 07:31:30 INFO - PROCESS | 3663 | Values: 163.0 162.0 163.0 164.0 163.0 163.0 173.0 165.0 164.0 162.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:37.07 (48.8%) stddev-sans-first:38.77 07:31:30 INFO - PROCESS | 3663 | Values: 76.0 78.0 76.0 166.0 77.0 76.0 75.0 75.0 162.0 76.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:84.00 stddev:33.71 (40.1%) stddev-sans-first:34.92 07:31:30 INFO - PROCESS | 3663 | Values: 84.0 83.0 164.0 84.0 84.0 83.0 149.0 84.0 85.0 146.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:31:30 INFO - PROCESS | 3663 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.16 (0.8%) stddev-sans-first:1.13 07:31:30 INFO - PROCESS | 3663 | Values: 146.0 147.0 146.0 147.0 148.0 147.0 147.0 147.0 148.0 150.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 07:31:30 INFO - PROCESS | 3663 | Values: 96.0 98.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.45 (2.6%) stddev-sans-first:1.50 07:31:30 INFO - PROCESS | 3663 | Values: 55.0 56.0 56.0 55.0 57.0 54.0 59.0 55.0 57.0 55.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 07:31:30 INFO - PROCESS | 3663 | Values: 63.0 64.0 63.0 63.0 63.0 62.0 63.0 65.0 64.0 64.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:2.76 (3.6%) stddev-sans-first:2.40 07:31:30 INFO - PROCESS | 3663 | Values: 82.0 76.0 76.0 77.0 75.0 80.0 76.0 76.0 82.0 75.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:129.00 stddev:11.80 (9.2%) stddev-sans-first:12.34 07:31:30 INFO - PROCESS | 3663 | Values: 126.0 128.0 130.0 121.0 124.0 142.0 126.0 126.0 161.0 133.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.00 stddev:2.51 (1.6%) stddev-sans-first:2.65 07:31:30 INFO - PROCESS | 3663 | Values: 159.0 155.0 159.0 160.0 163.0 161.0 158.0 155.0 157.0 158.0 07:31:30 INFO - PROCESS | 3663 | 07:31:30 INFO - PROCESS | 3663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:63.50 stddev:1.85 (2.9%) stddev-sans-first:1.96 07:31:30 INFO - PROCESS | 3663 | Values: 64.0 63.0 69.0 64.0 63.0 63.0 64.0 63.0 63.0 63.0 07:31:30 INFO - PROCESS | 3663 | -------- Summary: end -------- 07:31:30 INFO - PROCESS | 3663 | 07:31:31 INFO - TEST-INFO | 3663: exit 0 07:31:31 INFO - TEST-OK | kraken | took 60924ms 07:31:31 INFO - SUITE-END | took 1172s 07:31:31 INFO - Completed test suite (00:19:32) 07:31:31 INFO - javascript benchmark 07:31:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7541.101364677816, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3132.498800191969, 3133.467310557205, 3136.9215769605757, 3142.607174103237, 3159.1786135604752, 5578.553715702744, 5613.578981576383, 5654.151877218419, 5666.0, 5701.515371193448, 5397.487238712326, 5552.472515111058, 5595.888082238353, 5599.132134519145, 5658.094704847225, 4973.5026497350245, 5018.121828679985, 5129.2562578426105, 5146.536811686948, 5159.948400515985, 5101.0, 5154.819581314655, 5209.426963034063, 5215.295935048758, 5266.289050978126, 5046.873828154307, 5078.542931136179, 5094.79620815167, 5109.642325037249, 5162.251473536317, 5093.134167191586, 5097.974510127426, 5100.260462232993, 5125.749458793486, 5128.487151284841, 5050.191969284933, 5076.974615126901, 5083.262926875583, 5084.3644544431945, 5106.412762532282, 5395.838124856221, 5500.22996780451, 5508.724563771835, 5596.804111856106, 5665.348484924245, 5969.791057313017, 5987.3413924468705, 5988.041913293852, 5992.34084250732, 6013.579049466539, 6026.2165918430765, 6035.7283922223605, 6037.034074548095, 6037.78867739627, 6049.727762250709, 5463.726813659341, 5563.082091454905, 5616.466435688603, 5652.406497317805, 5682.630629009184, 6185.041318595625, 6207.286162091417, 6215.0, 6230.6573138476915, 6252.3122456529745, 5947.791827286024, 5960.0, 5965.701714914237, 5970.701464926737, 5982.820515384546, 5812.738426770806, 5946.13781001761, 5981.37195594465, 5990.850228744316, 6022.066579680157, 5859.0, 5922.703864806828, 5934.37689042653, 5967.701614919237, 5994.520438364921, 5996.430339117776, 6004.189434426296, 6016.819495415057, 6019.4883434908525, 6022.97609406402, 4358.912821743547, 4430.4683437987005, 4454.77726113693, 4459.777011149495, 4462.308342206963, 4038.273110840077, 4050.1697152083752, 4054.736442131252, 4073.327900896319, 4080.020795009236, 5773.220615216976, 5778.075507918797, 5801.477866991991, 5808.564357673192, 5825.446582574648, 5936.198613187251, 6006.759729610854, 6077.696115194222, 6116.785912493041, 6140.385961403913, 5756.42435756421, 5772.6536407815665, 5778.88442231153, 5787.768489260382, 5811.796587119515, 5037.269595908573, 5037.420696619935, 5040.1179793535985, 5050.191969284897, 5084.46613105626, 6119.112728654321, 6126.914660831567, 6150.7539698411565, 6230.190075290183, 6296.779612713624, 6098.0852872069545, 6113.871604717183, 6118.112873633209, 6120.44915957566, 6122.785702500391, 6201.989767761054, 6204.503639708722, 6259.530535209969, 6266.436020758154, 6292.339304373158, 5800.042992906123, 5868.853278667897, 5900.675462849585, 5978.402159784161, 5996.520278377807, 6015.6691381974415, 6037.818865434044, 6064.696765161636, 6066.575339726353, 6072.180255665428, 5893.322267939242, 5901.0558310670085, 5905.35041145465, 5909.23179986599, 5914.674692891932, 5796.59423840344, 5851.444112809277, 5854.829034193093, 5868.911966320594, 5943.64338139713, 5888.764449422147, 5895.380984996514, 5899.882002360015, 5904.350521442552, 5948.791792287249, 5933.436323549256, 5952.107183922446, 5952.791652292149, 6008.939910600838, 6015.097735339734, 5693.4021927696995, 5706.885862282648, 5725.169850371756, 5753.367129615823, 5893.734781934738], "value": 5534.52095802492, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.2650770570011, 579.6956597786163, 605.5670195809995, 615.1572345886134, 622.8224955887573, 38724.41913371298, 42735.35896961548, 42900.14199716004, 43028.354574681405, 43031.13937721248, 43030.56969430313, 43374.13251734971, 43624.12751744971, 43684.34473482901, 43920.12159756803, 8821.426607270507, 8980.550972451383, 9009.819803603925, 9010.459372437643, 9031.864522032174, 8885.289176865868, 8892.955535222347, 8945.0607686193, 8948.373613847034, 9014.504202268872, 9011.774705632379, 9013.819723605524, 9043.321750868678, 9056.230220431271, 9059.320550958671, 8967.730968070968, 8998.999999999967, 9007.099290071006, 9020.18818306349, 9047.230985366252, 8869.467831930106, 8877.822443551157, 8881.0, 8931.419457735226, 8933.821323573557, 41512.58487415117, 41852.79073604643, 41904.0, 41922.37116443256, 42289.15421691549, 3683.7605555638797, 3705.1663375740513, 3743.756655817363, 3765.416360464105, 3782.394816829294, 32923.0, 33343.83328083344, 33517.49723754146, 33657.32685346279, 33663.0, 4406.669499787528, 4407.642170360445, 4418.6023257906945, 4439.800208990603, 4452.844150454751, 399597.0, 402952.0, 403500.0, 405790.0, 407162.96418518014, 58159.41840581625, 58691.70654146702, 58771.41228587745, 58817.0, 58870.41129588735, 35079.141294457586, 35972.460413093824, 36154.8192259037, 37457.81271093627, 37682.8115859419, 16832.0, 16876.746848797276, 16994.745078823827, 17026.23381947815, 17039.0, 12770.29763363024, 12821.0, 12892.742145157044, 12903.612891613267, 12935.28855912915, 19426.34876035553, 19435.640273995457, 19437.373215067033, 19526.73041372458, 19564.43592355149, 6916.308369163144, 7044.330788575077, 7257.129144502694, 7282.308180722823, 7402.370798482081, 951.8429459139164, 1012.1042877053713, 1076.7577295108538, 1095.742500512379, 1137.2964582618176, 33874.66125338765, 34120.48819267713, 34351.31297374088, 34606.480902786476, 34613.480797788055, 1100.3287994323457, 1187.1274613159321, 1224.1186345831165, 1248.4194849395076, 1250.8874201321926, 16856.91571542159, 17252.568685782706, 17471.213795379237, 17578.384756533716, 17629.118544073, 602598.0, 605713.0, 606814.0, 610744.0, 613411.0, 58753.41246587565, 59111.0, 59665.40334596685, 59748.70125649344, 59829.0, 1322.7420652972578, 1358.531306699187, 1364.6179069860455, 1378.3659516622465, 1379.3241311757367, 31803.20491987626, 32716.83641581872, 33719.831400842835, 33762.15594610154, 34003.319933601684, 51611.2258316118, 51716.0, 51911.48088519218, 51946.740266298424, 51961.48038519567, 478360.0, 481216.0, 481822.0, 483585.0, 484925.0, 27629.585556216272, 28190.71809281963, 28973.130806075853, 29022.27444313909, 30446.543301850932, 48488.84624610088, 48749.0, 49813.750931245115, 50076.248856267914, 50339.0, 40960.0, 42278.36582451204, 42360.1527969445, 42504.362434562885, 43761.0, 42538.78730606451, 42923.57076429196, 43579.34630980601, 44130.77934610307, 44295.0, 41837.0, 42056.36915446332, 43064.0, 43274.78362608167, 43289.0, 33070.83464582662, 37186.0, 37423.0, 37449.6255037457, 38367.42448863213, 29329.266768330963, 29473.85263073671, 29595.0, 29675.40649186961, 29685.703142968294], "value": 20422.624444008, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.3632588274051, 379.8457181915827, 393.7007874015748, 395.60834773574163, 416.83951678603745, 16683.499495015138, 18308.176132074055, 20024.0, 20233.291834785785, 20336.89831550842, 12109.0, 12153.392330383489, 12353.197042192274, 12388.690282742937, 12494.625161245154, 5286.867828304304, 5453.991011662835, 5456.727163641822, 5459.945400546003, 5473.261109750172, 5312.1766126250495, 5363.865903352408, 5805.593608447411, 5838.970805145989, 5851.063829787235, 5695.288088988877, 5841.211436456067, 5842.21130147431, 5842.707864606774, 5843.18195452637, 5791.884162316751, 6786.219584747768, 7044.260352662948, 7047.506674532785, 7078.115235595525, 6751.223609284946, 6825.0, 6870.62211578363, 6960.721571137148, 6981.930180698178, 26013.0, 26977.46045079107, 27507.449851003068, 27755.444891102266, 27954.16137515878, 2595.3511622094475, 2908.5637154426795, 3341.933161336784, 3348.815815130167, 3409.6590340965954, 16248.106354150517, 16436.83563164365, 16610.50168494947, 16823.158842057972, 17412.564685882826, 2070.823979961705, 2085.1971990783504, 2087.008670881319, 2096.119629755506, 2178.4227179797367, 100524.0, 101363.49318253435, 103310.0, 103656.0, 107727.46136269347, 17911.73132403015, 18247.543811404557, 18670.253189872252, 18714.71927921082, 18738.344157954678, 32715.50926736101, 32910.341793164, 32936.505952410254, 32936.505952410735, 33098.338033239685, 10178.0, 10225.130863876506, 10392.688219353431, 10432.530536125892, 10658.840117398246, 8501.829963400698, 8524.829503410021, 8600.311975041981, 8772.210501054808, 8834.293256539462, 8688.565571721389, 8753.0, 8896.822063558693, 8954.238889694449, 8960.775980600407, 3380.0, 3392.1180493071483, 3641.635836416337, 3650.324689932371, 3799.240151969562, 963.6964356227766, 965.3242730088966, 983.5524836199512, 989.8614194012844, 996.7159359582485, 20427.693584596243, 20600.175992960114, 20835.0, 20845.478863028544, 20997.265095721577, 1010.8483727440796, 1023.9436830974367, 1024.3137098144261, 1026.3944272879037, 1082.312731415541, 10643.41461219625, 11186.16103792219, 11307.0, 11360.318380897173, 11498.94250528742, 466730.66538669035, 470397.0, 470464.0, 483230.0, 520236.0, 90788.5460572693, 91342.0, 94040.0, 107262.46368768107, 108379.45810270899, 1008.5108722269694, 1028.4651980970004, 1066.6000249906285, 1068.3910171202494, 1072.8873468285874, 16281.0, 18693.906530467262, 19234.66650771899, 19333.709994349814, 19379.709304360164, 44194.558054419045, 44614.77692611516, 45132.32301515414, 45203.77398112988, 45467.0, 60079.39920600738, 61831.0, 62755.6862215686, 64299.0, 64541.67729161324, 8505.0, 8577.35669824778, 8631.136886311318, 8677.479351238946, 8906.554672266491, 11770.823437648613, 13404.865951340362, 13733.244671543162, 13803.41260755026, 13876.514321998682, 10946.671599852018, 11116.44417779124, 11561.248518846249, 11637.650870473899, 11747.353895535827, 11498.94250528742, 11631.76736465283, 11656.650300491, 11738.58914937973, 12204.32876191818, 10954.671359859218, 10976.945115274373, 11401.885981140082, 11426.885731142582, 11716.94547490696, 8011.919880801117, 8170.591470426336, 8375.329973601976, 8595.44129631572, 8596.527191004305, 9172.403793753385, 10424.0, 10577.31247468912, 10778.461076945965, 10837.67486975392], "value": 10374.6093480705, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1486.5466032859977, 1517.6054225901266, 1680.8235135310792, 1818.8090250523694, 1818.818118188182, 8061.798455038627, 8809.559522023888, 8810.030896601369, 9446.574904129313, 9456.479893605849, 8806.86789698155, 9184.219341355976, 9191.90808091919, 9212.585433655484, 9218.078192180796, 2420.8426452280546, 2442.815234611221, 2452.5217582571404, 2459.1638842793445, 2470.0243403855466, 2383.5222162259424, 2407.217654262363, 2473.6165894286414, 2478.120267305108, 2480.8139389545768, 2409.421738782697, 2440.73151953285, 2448.2655203438985, 2467.7902378297777, 2478.2689106713565, 2384.3919800450776, 2410.216679579135, 2412.1436889904007, 2414.8792560372, 2416.214730212679, 2362.4566349739484, 2375.4417711837705, 2376.9286921392386, 2381.499885024147, 2393.2820153953917, 9145.725628231165, 9251.167394934488, 9254.491002994833, 9284.25725941923, 9312.34813563051, 5499.532539734128, 5547.11246200606, 5578.86052848682, 5609.747561359749, 5611.551075913917, 3592.444997111561, 3701.3152566775234, 3808.352580061396, 3832.405977073558, 3833.6358045985585, 1185.3836005277208, 1228.342836582433, 1235.2464996352219, 1235.7096082420624, 1259.2885019963692, 12937.870621293761, 12976.87023129766, 12987.805182922359, 13057.934710326483, 13074.346282685829, 4728.692634978715, 4736.289556566542, 4758.78585463655, 4957.578605818546, 5027.1956486962645, 10832.566697332019, 10913.618023369145, 10924.180686448548, 10934.781304373868, 10968.670939871816, 5602.887942241132, 5627.380988091389, 5628.887422251532, 5630.239917611152, 5641.0, 4555.06621142665, 4962.454130045692, 5019.272205530177, 5073.365829271341, 5125.077486052546, 3856.4986551748093, 3940.0, 4031.879043628696, 4072.6945479089186, 4117.814698338522, 1234.5185377702703, 1252.8872401483911, 1261.9525793591297, 1272.7136394311206, 1284.9935750321188, 915.8580420034905, 1002.6540843409012, 1021.3565453764081, 1035.534009695625, 1035.9689209323733, 6011.909821352683, 6066.4540191382985, 6283.8114856554375, 6407.173955422682, 6409.0, 468.5572134333091, 479.05980777850266, 485.02751982276015, 488.3626866938679, 490.6491858321246, 4091.365838295069, 4173.061061261192, 4183.058811767328, 4199.181159673834, 4243.257429949746, 11042.33745975244, 11265.098792096613, 11478.942605287088, 11498.655040348804, 11519.19365644397, 11363.715907102389, 11507.827382589268, 11531.365774882293, 11538.19232653723, 11571.42142892852, 8369.916300836914, 8401.243888050105, 8423.410361274651, 8516.829663406697, 8651.740447786577, 6243.562950593415, 6279.434850863444, 6282.905756413749, 6291.339409362135, 6456.225252969673, 10085.647002355176, 10472.633457828939, 10555.577776888838, 10606.098481629147, 10665.573377064831, 10668.359898406121, 10830.891691082988, 10858.78282434331, 10866.511007004861, 10972.0, 7176.354128128285, 7907.84184316299, 7910.485818421784, 7954.125046245024, 8043.356531477585, 8986.730398087806, 9028.052054534443, 9073.274138069071, 9093.863592045993, 9108.906931168302, 7920.564368959763, 7996.56018918965, 8051.597420129087, 8068.277675780328, 8195.631196596049, 7965.960170199112, 8071.071826739765, 8108.391870609846, 8173.18268173178, 8319.83360332778, 7350.816229594303, 7439.404847612286, 7451.701931922879, 7500.549967001997, 7533.849323013618, 5460.208269800936, 5482.0, 5560.694161821139, 5582.190582365615, 5608.803691870765, 5568.276124103841, 5584.3857175711455, 5643.463870932255, 5699.401562835843, 5718.714064296685], "value": 4777.0661893177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.3233274788439, 327.355110432448, 331.72301128557655, 336.13445378151266, 340.73763202334186, 5433.510984011438, 5478.506934375905, 5619.6066275360745, 5645.774169033239, 5657.745401456928, 5489.066858634032, 5513.393526712059, 5516.613837031399, 5526.226328314039, 5548.167774833777, 4313.425599656119, 4333.804978775946, 4362.476502819666, 4362.912741745163, 4375.6499480041675, 4210.894727631803, 4256.616904478597, 4345.717528360647, 4347.0, 4352.411369850013, 4274.0, 4281.116308824123, 4281.165172791307, 4284.464441944757, 4300.505441874193, 4293.978530107345, 4298.892527686801, 4304.182205380967, 4323.351497275403, 4333.8699839004885, 3540.345036168317, 3798.297314996707, 3833.7891415972113, 3838.7907809040344, 3847.76913385195, 5394.622376433651, 5425.267588875491, 5428.565714742811, 5433.157860531624, 5469.480399362054, 4912.164931961575, 4943.752812359367, 4952.356193694833, 4954.975225123887, 4979.278004689336, 5552.167784631062, 5750.769969201227, 5806.545105662167, 5809.448102430262, 5809.543321723568, 4109.547949725527, 4135.648469880034, 4142.08874047709, 4158.438610787535, 4164.4586203793615, 6050.69746512677, 6091.969540152315, 6127.938720612781, 6133.172021777048, 6140.9385906140815, 4128.752274863457, 4190.979045104755, 4223.619874211336, 4231.9576804231565, 4233.576642335804, 4273.487181538236, 4274.358846173099, 4280.208161490134, 4288.0, 4291.163223171514, 4873.585745211697, 4902.828401005948, 4916.5575098240615, 4938.061768264019, 4941.209406495015, 5760.855978600569, 5822.359540450547, 5855.151003104611, 5888.293404791452, 5889.0283103287475, 1468.4126349460087, 1484.5154845154846, 1487.8884083693765, 1488.6576087499936, 1496.2120266281906, 885.8449771289999, 935.3592788939599, 939.6899023322287, 952.8951815300311, 956.4070276428658, 4983.9252411213865, 4992.879450343536, 5000.149974504343, 5011.924821127686, 5015.27278544609, 5200.739963001911, 5291.550218231493, 5293.920591191135, 5311.7344132793205, 5319.0745090200235, 4676.63829765966, 4939.506049395031, 4968.0, 5010.549050585392, 5038.974805126024, 2824.519831628587, 2831.858407079638, 2850.2731803390416, 2850.957235641467, 2879.424115176973, 5411.783528658888, 5440.292761941001, 5453.972730136324, 5458.863528411742, 5481.013417584873, 5190.714510701872, 5366.651167674088, 5375.521731523862, 5400.513953744104, 5408.242846001563, 5409.891802163935, 5426.430224826416, 5426.8371948841595, 5455.236266922634, 5495.505404513613, 5134.383873935151, 5336.466353364633, 5360.437154098763, 5367.838964831061, 5369.436209197978, 5049.368828896388, 5212.530872221519, 5239.659422137549, 5245.796765358635, 5254.605904557097, 5461.453854614507, 5468.8865910373925, 5485.451454854483, 5526.834194974157, 5548.0, 4003.499562554681, 4088.2436749201493, 4195.49654041517, 4202.075543380452, 4212.199682060399, 5970.343262241063, 6004.309504406874, 6007.639541627516, 6013.6692481913915, 6030.30651475086, 5652.85867853307, 5790.623609465371, 5848.912266316093, 5886.735096920564, 5891.587588868738, 5809.157672137601, 5816.36020037804, 5841.94158058414, 5848.736806843787, 5857.824265272048, 5746.741396637078, 5752.252207213036, 5788.623739456922, 5790.536757059509, 5813.970930145322, 5600.439956004367, 5801.709914504342, 5830.5044071254415, 5879.853003674943, 5881.5588830837005, 5681.602287839812, 5694.0, 5730.0, 5746.195532625519, 5751.913721294268], "value": 4280.051542681568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.4486273138317, 724.4023680463615, 754.777340684498, 776.2974508070198, 829.3116713128097, 15171.544853654394, 15636.061836289831, 15712.371505139781, 15721.921390393047, 15739.213039348015, 13954.651133721662, 14002.929985350085, 14032.649183770385, 14052.367643456044, 14079.084859484126, 662.3475876261879, 795.4670370851514, 803.1687203744111, 812.6586833529902, 816.9836603267931, 815.8082850530151, 817.9304759095454, 818.5211651184035, 819.1317203763999, 819.8893149424811, 859.4542465534399, 863.5768473448028, 864.6671031652827, 864.7319331007376, 865.5153114256005, 861.0700443520982, 867.7526904832124, 868.4702331577732, 869.5521806269776, 869.8434281829268, 627.3600927054379, 630.4767043354005, 630.8517498387876, 631.3907079668096, 632.617266553733, 14286.214258215794, 14347.0, 14356.138631682132, 14401.20793356365, 14517.128972261698, 14443.133411995208, 15065.397384104623, 15090.0, 15149.697006059818, 15225.543233703007, 12447.315397653125, 12494.187877787916, 12607.747845043139, 12676.556320528829, 12714.364281785965, 3963.3064213762764, 4022.939655905164, 4081.877543673665, 4097.508299004138, 4181.770002649853, 75419.0, 75424.62287688581, 75515.62242188754, 75690.62154689246, 75719.62140189264, 11149.498272577754, 11379.431028448544, 11599.88400115988, 11733.178677492493, 11923.344216068199, 22325.441863953532, 22427.0, 22563.774362256496, 22612.0955161795, 22939.42651433694, 8669.869951950726, 8702.173293537104, 8740.0, 8773.736787896374, 8910.376273660782, 4697.0, 4809.807607695723, 4812.639052071108, 4839.443464001614, 5040.47075057121, 3673.1918977824835, 3771.2080463102507, 3775.8300876460626, 3782.981085094557, 3795.4686343911876, 678.7997540725498, 698.3784431855653, 705.4885208223997, 725.1298441869777, 729.6242435145904, 656.9310222426672, 693.6115775165923, 740.6373667999173, 758.8634045871796, 763.050002746573, 10030.348027378197, 10459.0, 10506.579736810594, 10520.947395262974, 10610.628627997983, 744.6537360127567, 756.7011030642865, 773.4585789947059, 775.1937984496174, 785.340314136117, 4687.437507499122, 4770.54370678902, 4953.0, 4963.45402005779, 4995.925061124086, 69048.6547567259, 69330.30669693339, 69568.0, 69724.0, 130391.0, 98093.50953245188, 98134.5093274529, 99959.0, 102924.0, 103123.0, 55441.168382474294, 56611.43388566062, 61275.0, 74761.25238747761, 87219.56390218009, 9927.0, 10139.2395570334, 10146.340487868265, 10235.385876847413, 10307.639232626821, 50458.2431263524, 50875.74562127166, 51240.74379628078, 51869.481305187976, 52440.47559524356, 73447.63276183585, 73706.63146684233, 78896.0, 79020.0, 81484.18515814767, 13521.0, 13557.728845422838, 13642.522511712043, 13644.59066227975, 13649.181049137083, 15325.0, 15433.5369938902, 15616.609584760017, 15757.684846303238, 16182.757258640895, 13699.657508562366, 13774.931125344308, 13903.791443128159, 14533.128012319296, 14660.266986650411, 14329.498467554002, 14509.201993890438, 14574.562763117123, 15176.620584485476, 15279.61800954985, 13923.443062277396, 13984.230867302396, 14026.158430494203, 14100.36548355306, 14374.3531541083, 11892.524299027942, 12029.15795894314, 12277.938610306892, 12298.20061695987, 12366.381680916098, 11067.225294229327, 12124.515019399125, 12268.0, 12471.750564988468, 12550.43523041447], "value": 7669.905708644258, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 107.0, 112.0, 112.0, 114.0, 114.0, 113.0, 114.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 119.0, 149.0, 184.0, 123.0, 148.0, 142.0, 120.0, 181.0, 119.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 164.0, 163.0, 163.0, 173.0, 165.0, 164.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 166.0, 77.0, 76.0, 75.0, 75.0, 162.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 164.0, 84.0, 84.0, 83.0, 149.0, 84.0, 85.0, 146.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 150.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 57.0, 54.0, 59.0, 55.0, 57.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 65.0, 64.0, 64.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 76.0, 77.0, 75.0, 80.0, 76.0, 76.0, 82.0, 75.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 130.0, 121.0, 124.0, 142.0, 126.0, 126.0, 161.0, 133.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 159.0, 160.0, 163.0, 161.0, 158.0, 155.0, 157.0, 158.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 69.0, 64.0, 63.0, 63.0, 64.0, 63.0, 63.0, 63.0], "value": 63.9, "unit": "score"}]}]} 07:31:31 INFO - Return code: 0 07:31:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:31:31 ERROR - # TBPL SUCCESS # 07:31:31 INFO - Running post-action listener: _resource_record_post_action 07:31:31 INFO - [mozharness: 2016-07-22 14:31:31.834525Z] Finished run-tests step (success) 07:31:31 INFO - Running post-run listener: _resource_record_post_run 07:31:31 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 563695616; Read time: 0; Write time: 469136 07:31:31 INFO - TinderboxPrint: CPU usage
13.4% 07:31:31 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:31:31 INFO - TinderboxPrint: I/O write bytes / time
563,695,616 / 469,136 07:31:31 INFO - TinderboxPrint: CPU idle
8,219.1 (86.6%) 07:31:31 INFO - TinderboxPrint: CPU user
1,217.4 (12.8%) 07:31:31 INFO - TinderboxPrint: Swap in / out
0 / 0 07:31:31 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 268980224; Read time: 0; Write time: 259404 07:31:31 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 294477824; Read time: 0; Write time: 209712 07:31:32 INFO - Running post-run listener: _upload_blobber_files 07:31:32 INFO - Blob upload gear active. 07:31:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:32 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 07:31:32 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'] 07:31:32 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 07:31:32 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:31:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:33 INFO - (blobuploader) - INFO - Done attempting. 07:31:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:31:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:31:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:55 INFO - (blobuploader) - INFO - Done attempting. 07:31:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:31:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:31:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:56 INFO - (blobuploader) - INFO - Done attempting. 07:31:56 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:56 INFO - Return code: 0 07:31:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e7f14c6bb3e084cba754bb6cbcd6d5b14b588dc3ecacdccd28ba598f6d1919a0a09d24ecb95e13eb013d6f7bffcd8dbb0613df9c3c5f520760a33bc3bd3e208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce590fbd181e6c64c223ead833f4ddcb5a0f96f1aceb2538aae7f1d1b418f0e3235fea83db0166d7935c1b5f5345dadb4f18fb72b88ef4d3be4ad7a5fd5ebb60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68506a9e88ce162d16fe41d9264429c1a3f7f7a26321be2928d69765046922de931bd0f330b3074a729398e98a09316e6ed7293a31a9f87760f737218cba453b"} 07:31:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:56 INFO - Contents: 07:31:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e7f14c6bb3e084cba754bb6cbcd6d5b14b588dc3ecacdccd28ba598f6d1919a0a09d24ecb95e13eb013d6f7bffcd8dbb0613df9c3c5f520760a33bc3bd3e208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce590fbd181e6c64c223ead833f4ddcb5a0f96f1aceb2538aae7f1d1b418f0e3235fea83db0166d7935c1b5f5345dadb4f18fb72b88ef4d3be4ad7a5fd5ebb60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68506a9e88ce162d16fe41d9264429c1a3f7f7a26321be2928d69765046922de931bd0f330b3074a729398e98a09316e6ed7293a31a9f87760f737218cba453b"} 07:31:56 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:56 INFO - Copying logs to upload dir... 07:31:56 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.187513 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-22 07:31:56.367418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 07:31:56.370731) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e7f14c6bb3e084cba754bb6cbcd6d5b14b588dc3ecacdccd28ba598f6d1919a0a09d24ecb95e13eb013d6f7bffcd8dbb0613df9c3c5f520760a33bc3bd3e208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce590fbd181e6c64c223ead833f4ddcb5a0f96f1aceb2538aae7f1d1b418f0e3235fea83db0166d7935c1b5f5345dadb4f18fb72b88ef4d3be4ad7a5fd5ebb60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68506a9e88ce162d16fe41d9264429c1a3f7f7a26321be2928d69765046922de931bd0f330b3074a729398e98a09316e6ed7293a31a9f87760f737218cba453b"} build_url:https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011605 build_url: 'https://queue.taskcluster.net/v1/task/ApwVd8T3TQac2rea_Kp1AA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e7f14c6bb3e084cba754bb6cbcd6d5b14b588dc3ecacdccd28ba598f6d1919a0a09d24ecb95e13eb013d6f7bffcd8dbb0613df9c3c5f520760a33bc3bd3e208", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce590fbd181e6c64c223ead833f4ddcb5a0f96f1aceb2538aae7f1d1b418f0e3235fea83db0166d7935c1b5f5345dadb4f18fb72b88ef4d3be4ad7a5fd5ebb60", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68506a9e88ce162d16fe41d9264429c1a3f7f7a26321be2928d69765046922de931bd0f330b3074a729398e98a09316e6ed7293a31a9f87760f737218cba453b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-22 07:31:56.395590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 07:31:56.395882) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1469194204.122113-464048208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004808 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-22 07:31:56.479252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 07:31:56.479592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-22 07:31:56.479880) ========= ========= Total master_lag: 0.15 =========