builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1469150281.15 results: success (0) buildid: 20160721163009 builduid: 7c37a33bc9954f66814f145af95d0fd1 revision: 2e3390571fdb3a1ff3d2f7f828adf67dbc237bc8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.149070) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.149532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.149804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.166065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.166485) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 18:18:01-- 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% 131K=0.09s 2016-07-21 18:18:01 (131 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.206212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.387053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.387401) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022039 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.438607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:01.439174) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2e3390571fdb3a1ff3d2f7f828adf67dbc237bc8 --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 2e3390571fdb3a1ff3d2f7f828adf67dbc237bc8 --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=03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 18:18:01,584 truncating revision to first 12 chars 2016-07-21 18:18:01,584 Setting DEBUG logging. 2016-07-21 18:18:01,584 attempt 1/10 2016-07-21 18:18:01,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2e3390571fdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 18:18:02,068 unpacking tar archive at: mozilla-central-2e3390571fdb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.822571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:02.275917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:02.276234) ========= script_repo_revision: 2e3390571fdb3a1ff3d2f7f828adf67dbc237bc8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:02.276632) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:02.276896) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 18:18:02.286074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-21 18:18:02.286471) ========= /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=03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:18:02 INFO - MultiFileLogger online at 20160721 18:18:02 in /builds/slave/test 18:18:02 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 18:18:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:18:02 INFO - {'append_to_log': False, 18:18:02 INFO - 'base_work_dir': '/builds/slave/test', 18:18:02 INFO - 'blob_upload_branch': 'Firefox', 18:18:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:18:02 INFO - 'branch': 'Firefox', 18:18:02 INFO - 'buildbot_json_path': 'buildprops.json', 18:18:02 INFO - 'config_files': ('talos/linux_config.py',), 18:18:02 INFO - 'default_actions': ('clobber', 18:18:02 INFO - 'read-buildbot-config', 18:18:02 INFO - 'download-and-extract', 18:18:02 INFO - 'populate-webroot', 18:18:02 INFO - 'create-virtualenv', 18:18:02 INFO - 'install', 18:18:02 INFO - 'run-tests'), 18:18:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:18:02 INFO - 'download_minidump_stackwalk': True, 18:18:02 INFO - 'download_symbols': 'ondemand', 18:18:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:18:02 INFO - 'tooltool.py': '/tools/tooltool.py', 18:18:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:18:02 INFO - '/tools/misc-python/virtualenv.py')}, 18:18:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:18:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:18:02 INFO - 'installer_path': 'installer.exe', 18:18:02 INFO - 'log_level': 'info', 18:18:02 INFO - 'log_name': 'talos', 18:18:02 INFO - 'log_to_console': True, 18:18:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:18:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:18:02 INFO - 'opt_config_files': (), 18:18:02 INFO - 'pip_index': False, 18:18:02 INFO - 'sps_profile': False, 18:18:02 INFO - 'sps_profile_interval': 0, 18:18:02 INFO - 'suite': 'dromaeojs-e10s', 18:18:02 INFO - 'system_bits': '32', 18:18:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:18:02 INFO - 'title': 'talos-linux64-ix-047', 18:18:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:18:02 INFO - 'use_talos_json': True, 18:18:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:18:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:18:02 INFO - 'work_dir': 'build'} 18:18:02 INFO - [mozharness: 2016-07-22 01:18:02.522877Z] Running clobber step. 18:18:02 INFO - Running pre-action listener: _resource_record_pre_action 18:18:02 INFO - Running main action method: clobber 18:18:02 INFO - rmtree: /builds/slave/test/build 18:18:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:18:03 INFO - Running post-action listener: _resource_record_post_action 18:18:03 INFO - [mozharness: 2016-07-22 01:18:03.514625Z] Finished clobber step (success) 18:18:03 INFO - [mozharness: 2016-07-22 01:18:03.514729Z] Running read-buildbot-config step. 18:18:03 INFO - Running pre-action listener: _resource_record_pre_action 18:18:03 INFO - Running main action method: read_buildbot_config 18:18:03 INFO - Using buildbot properties: 18:18:03 INFO - { 18:18:03 INFO - "project": "", 18:18:03 INFO - "product": "firefox", 18:18:03 INFO - "script_repo_revision": "production", 18:18:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:18:03 INFO - "repository": "", 18:18:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:18:03 INFO - "buildid": "20160721163009", 18:18:03 INFO - "pgo_build": "True", 18:18:03 INFO - "basedir": "/builds/slave/test", 18:18:03 INFO - "buildnumber": 299, 18:18:03 INFO - "slavename": "talos-linux64-ix-047", 18:18:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:18:03 INFO - "platform": "ubuntu64_hw", 18:18:03 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 18:18:03 INFO - "branch": "mozilla-central", 18:18:03 INFO - "repo_path": "mozilla-central", 18:18:03 INFO - "revision": "2e3390571fdb3a1ff3d2f7f828adf67dbc237bc8", 18:18:03 INFO - "stage_platform": "linux64-pgo", 18:18:03 INFO - "builduid": "7c37a33bc9954f66814f145af95d0fd1", 18:18:03 INFO - "slavebuilddir": "test" 18:18:03 INFO - } 18:18:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:18:03 INFO - Running post-action listener: _resource_record_post_action 18:18:03 INFO - [mozharness: 2016-07-22 01:18:03.517180Z] Finished read-buildbot-config step (success) 18:18:03 INFO - [mozharness: 2016-07-22 01:18:03.517292Z] Running download-and-extract step. 18:18:03 INFO - Running pre-action listener: _resource_record_pre_action 18:18:03 INFO - Running main action method: download_and_extract 18:18:03 INFO - mkdir: /builds/slave/test/build/tests 18:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:03 INFO - https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:18:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:07 INFO - Downloaded 1361 bytes. 18:18:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:18:07 INFO - Using the following test package requirements: 18:18:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:18:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:18:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'jsshell-linux-x86_64.zip'], 18:18:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:18:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:18:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:18:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:18:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:18:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:18:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:18:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:18: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')]} 18:18:07 INFO - https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:11 INFO - Downloaded 24306748 bytes. 18:18:11 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'] 18:18:11 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 18:18:13 INFO - Return code: 0 18:18:13 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 18:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:13 INFO - https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:18:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:18:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:15 INFO - Downloaded 24306748 bytes. 18:18:15 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'] 18:18:15 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 18:18:17 INFO - Return code: 0 18:18: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')]} 18:18:17 INFO - https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:18:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:18:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:18 INFO - Downloaded 14403317 bytes. 18:18:18 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'] 18:18:18 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 18:18:18 INFO - Return code: 0 18:18:18 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')]} 18:18:18 INFO - https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AvjISu27QlukmQqG8Pgg5g/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 18:18:21 INFO - Downloaded 60870021 bytes. 18:18:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:21 INFO - mkdir: /builds/slave/test/properties 18:18:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:18:21 INFO - Writing to file /builds/slave/test/properties/build_url 18:18:21 INFO - Contents: 18:18:21 INFO - build_url:https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:18:22 INFO - Running post-action listener: _resource_record_post_action 18:18:22 INFO - Running post-action listener: set_extra_try_arguments 18:18:22 INFO - [mozharness: 2016-07-22 01:18:22.193184Z] Finished download-and-extract step (success) 18:18:22 INFO - [mozharness: 2016-07-22 01:18:22.193462Z] Running populate-webroot step. 18:18:22 INFO - Running pre-action listener: _resource_record_pre_action 18:18:22 INFO - Running main action method: populate_webroot 18:18:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:18:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:18:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:18:22 INFO - '--tppagecycles', 18:18:22 INFO - '7'], 18:18:22 INFO - 'tests': ['tsvgm']}}, 18:18:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:18:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:18:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:18:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:18:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:18:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['damp', 'tps']}, 18:18:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'tests': ['damp', 'tps']}, 18:18:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['dromaeo_dom']}, 18:18:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:18:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['basic_compositor_video']}, 18:18:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:18:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['a11yr', 18:18:22 INFO - 'ts_paint', 18:18:22 INFO - 'tpaint', 18:18:22 INFO - 'sessionrestore', 18:18:22 INFO - 'sessionrestore_no_auto_restore', 18:18:22 INFO - 'tabpaint']}, 18:18:22 INFO - 'other-e10s': {'tests': ['a11yr', 18:18:22 INFO - 'ts_paint', 18:18:22 INFO - 'tpaint', 18:18:22 INFO - 'sessionrestore', 18:18:22 INFO - 'sessionrestore_no_auto_restore', 18:18:22 INFO - 'tabpaint']}, 18:18:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:18:22 INFO - 'ts_paint', 18:18:22 INFO - 'tpaint', 18:18:22 INFO - 'sessionrestore', 18:18:22 INFO - 'sessionrestore_no_auto_restore', 18:18:22 INFO - 'tabpaint']}, 18:18:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:18:22 INFO - 'ts_paint', 18:18:22 INFO - 'tpaint', 18:18:22 INFO - 'sessionrestore', 18:18:22 INFO - 'sessionrestore_no_auto_restore', 18:18:22 INFO - 'tabpaint']}, 18:18:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['a11yr', 18:18:22 INFO - 'ts_paint', 18:18:22 INFO - 'tpaint', 18:18:22 INFO - 'sessionrestore', 18:18:22 INFO - 'sessionrestore_no_auto_restore', 18:18:22 INFO - 'tabpaint']}, 18:18:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['a11yr', 18:18:22 INFO - 'ts_paint', 18:18:22 INFO - 'tpaint', 18:18:22 INFO - 'sessionrestore', 18:18:22 INFO - 'sessionrestore_no_auto_restore', 18:18:22 INFO - 'tabpaint']}, 18:18:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['tsvgx', 18:18:22 INFO - 'tsvgr_opacity', 18:18:22 INFO - 'tart', 18:18:22 INFO - 'tscrollx', 18:18:22 INFO - 'cart']}, 18:18:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:18:22 INFO - 'tsvgr_opacity', 18:18:22 INFO - 'tart', 18:18:22 INFO - 'tscrollx', 18:18:22 INFO - 'cart']}, 18:18:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'talos_options': ['--disable-e10s'], 18:18:22 INFO - 'tests': ['tp5o']}, 18:18:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'tests': ['tp5o']}, 18:18:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'talos_options': ['--disable-e10s', 18:18:22 INFO - '--xperf_path', 18:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:22 INFO - 'tests': ['tp5n']}, 18:18:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:18:22 INFO - 'talos_options': ['--xperf_path', 18:18:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:18:22 INFO - 'tests': ['tp5n']}}, 18:18:22 INFO - 'talos.zip': {'path': '', 18:18:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:18:22 INFO - Running post-action listener: _resource_record_post_action 18:18:22 INFO - [mozharness: 2016-07-22 01:18:22.211807Z] Finished populate-webroot step (success) 18:18:22 INFO - [mozharness: 2016-07-22 01:18:22.211896Z] Running create-virtualenv step. 18:18:22 INFO - Running pre-action listener: _resource_record_pre_action 18:18:22 INFO - Running main action method: create_virtualenv 18:18:22 INFO - Creating virtualenv /builds/slave/test/build/venv 18:18:22 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 18:18:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:18:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:18:22 INFO - Using real prefix '/usr' 18:18:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:18:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:18:24 INFO - Installing pip.................done. 18:18:24 INFO - Return code: 0 18:18:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18: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', 'pip>=1.5'] in /builds/slave/test/build 18:18: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 pip>=1.5 18:18:24 INFO - Using env: {'DISPLAY': ':0', 18:18:24 INFO - 'HOME': '/home/cltbld', 18:18:24 INFO - 'LANG': 'en_US.UTF-8', 18:18:24 INFO - 'LANGUAGE': 'en_US:en', 18:18:24 INFO - 'LOGNAME': 'cltbld', 18:18:24 INFO - 'MAIL': '/var/mail/cltbld', 18:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:24 INFO - 'MOZ_NO_REMOTE': '1', 18:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:24 INFO - 'NO_EM_RESTART': '1', 18:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:24 INFO - 'PWD': '/builds/slave/test', 18:18:24 INFO - 'SHELL': '/bin/bash', 18:18:24 INFO - 'SHLVL': '1', 18:18:24 INFO - 'TERM': 'linux', 18:18:24 INFO - 'TMOUT': '86400', 18:18:24 INFO - 'USER': 'cltbld', 18:18:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:24 INFO - '_': '/tools/buildbot/bin/python'} 18:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:24 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 18:18:24 INFO - Cleaning up... 18:18:25 INFO - Return code: 0 18:18:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:18:25 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')]} 18:18:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:25 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')]} 18:18:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:25 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 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18:25 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 18:18:25 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 18:18:25 INFO - Using env: {'DISPLAY': ':0', 18:18:25 INFO - 'HOME': '/home/cltbld', 18:18:25 INFO - 'LANG': 'en_US.UTF-8', 18:18:25 INFO - 'LANGUAGE': 'en_US:en', 18:18:25 INFO - 'LOGNAME': 'cltbld', 18:18:25 INFO - 'MAIL': '/var/mail/cltbld', 18:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:25 INFO - 'MOZ_NO_REMOTE': '1', 18:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:25 INFO - 'NO_EM_RESTART': '1', 18:18:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:25 INFO - 'PWD': '/builds/slave/test', 18:18:25 INFO - 'SHELL': '/bin/bash', 18:18:25 INFO - 'SHLVL': '1', 18:18:25 INFO - 'TERM': 'linux', 18:18:25 INFO - 'TMOUT': '86400', 18:18:25 INFO - 'USER': 'cltbld', 18:18:25 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:25 INFO - '_': '/tools/buildbot/bin/python'} 18:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:25 INFO - Downloading/unpacking psutil>=3.1.1 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:27 INFO - Installing collected packages: psutil 18:18:27 INFO - Running setup.py install for psutil 18:18:27 INFO - building 'psutil._psutil_linux' extension 18:18:27 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 18:18:27 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 18:18:27 INFO - building 'psutil._psutil_posix' extension 18:18:27 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 18:18:27 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 18:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:18:27 INFO - Successfully installed psutil 18:18:27 INFO - Cleaning up... 18:18:27 INFO - Return code: 0 18:18:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:18: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 mozsystemmonitor==0.3 18:18:27 INFO - Using env: {'DISPLAY': ':0', 18:18:27 INFO - 'HOME': '/home/cltbld', 18:18:27 INFO - 'LANG': 'en_US.UTF-8', 18:18:27 INFO - 'LANGUAGE': 'en_US:en', 18:18:27 INFO - 'LOGNAME': 'cltbld', 18:18:27 INFO - 'MAIL': '/var/mail/cltbld', 18:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:27 INFO - 'MOZ_NO_REMOTE': '1', 18:18:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:27 INFO - 'NO_EM_RESTART': '1', 18:18:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:27 INFO - 'PWD': '/builds/slave/test', 18:18:27 INFO - 'SHELL': '/bin/bash', 18:18:27 INFO - 'SHLVL': '1', 18:18:27 INFO - 'TERM': 'linux', 18:18:27 INFO - 'TMOUT': '86400', 18:18:27 INFO - 'USER': 'cltbld', 18:18:27 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:27 INFO - '_': '/tools/buildbot/bin/python'} 18:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:18:28 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 18:18:28 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 18:18:28 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 18:18:28 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 18:18:28 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 18:18:28 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 18:18:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:18:29 INFO - Installing collected packages: mozsystemmonitor 18:18:29 INFO - Running setup.py install for mozsystemmonitor 18:18:30 INFO - Successfully installed mozsystemmonitor 18:18:30 INFO - Cleaning up... 18:18:30 INFO - Return code: 0 18:18:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:30 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 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18:30 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 18:18:30 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 18:18:30 INFO - Using env: {'DISPLAY': ':0', 18:18:30 INFO - 'HOME': '/home/cltbld', 18:18:30 INFO - 'LANG': 'en_US.UTF-8', 18:18:30 INFO - 'LANGUAGE': 'en_US:en', 18:18:30 INFO - 'LOGNAME': 'cltbld', 18:18:30 INFO - 'MAIL': '/var/mail/cltbld', 18:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:30 INFO - 'MOZ_NO_REMOTE': '1', 18:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:30 INFO - 'NO_EM_RESTART': '1', 18:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:30 INFO - 'PWD': '/builds/slave/test', 18:18:30 INFO - 'SHELL': '/bin/bash', 18:18:30 INFO - 'SHLVL': '1', 18:18:30 INFO - 'TERM': 'linux', 18:18:30 INFO - 'TMOUT': '86400', 18:18:30 INFO - 'USER': 'cltbld', 18:18:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:30 INFO - '_': '/tools/buildbot/bin/python'} 18:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:30 INFO - Downloading/unpacking jsonschema==2.5.1 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:32 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:32 INFO - warning: no files found matching '*.txt' 18:18:32 INFO - no previously-included directories found matching 'build' 18:18:32 INFO - no previously-included directories found matching 'dist' 18:18:32 INFO - no previously-included directories found matching '.git*' 18:18:32 INFO - Installing collected packages: jsonschema, functools32 18:18:32 INFO - Running setup.py install for functools32 18:18:32 INFO - warning: no files found matching '*.txt' 18:18:32 INFO - no previously-included directories found matching 'build' 18:18:32 INFO - no previously-included directories found matching 'dist' 18:18:32 INFO - no previously-included directories found matching '.git*' 18:18:32 INFO - Successfully installed jsonschema functools32 18:18:32 INFO - Cleaning up... 18:18:32 INFO - Return code: 0 18:18:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:32 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 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18:32 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 18:18:32 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 18:18:32 INFO - Using env: {'DISPLAY': ':0', 18:18:32 INFO - 'HOME': '/home/cltbld', 18:18:32 INFO - 'LANG': 'en_US.UTF-8', 18:18:32 INFO - 'LANGUAGE': 'en_US:en', 18:18:32 INFO - 'LOGNAME': 'cltbld', 18:18:32 INFO - 'MAIL': '/var/mail/cltbld', 18:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:32 INFO - 'MOZ_NO_REMOTE': '1', 18:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:32 INFO - 'NO_EM_RESTART': '1', 18:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:32 INFO - 'PWD': '/builds/slave/test', 18:18:32 INFO - 'SHELL': '/bin/bash', 18:18:32 INFO - 'SHLVL': '1', 18:18:32 INFO - 'TERM': 'linux', 18:18:32 INFO - 'TMOUT': '86400', 18:18:32 INFO - 'USER': 'cltbld', 18:18:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:32 INFO - '_': '/tools/buildbot/bin/python'} 18:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:32 INFO - Downloading/unpacking blobuploader==1.2.4 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18: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 18:18:34 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:34 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 18:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:35 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 18:18:35 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 18:18:35 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 18:18:35 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 18:18:35 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 18:18:35 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 18:18:35 INFO - Downloading docopt-0.6.1.tar.gz 18:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:35 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:35 INFO - Running setup.py install for blobuploader 18:18:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:35 INFO - Running setup.py install for requests 18:18:36 INFO - Running setup.py install for docopt 18:18:36 INFO - Successfully installed blobuploader requests docopt 18:18:36 INFO - Cleaning up... 18:18:36 INFO - Return code: 0 18:18:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18: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')]} 18:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:36 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 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18:36 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 18:18:36 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 18:18:36 INFO - Using env: {'DISPLAY': ':0', 18:18:36 INFO - 'HOME': '/home/cltbld', 18:18:36 INFO - 'LANG': 'en_US.UTF-8', 18:18:36 INFO - 'LANGUAGE': 'en_US:en', 18:18:36 INFO - 'LOGNAME': 'cltbld', 18:18:36 INFO - 'MAIL': '/var/mail/cltbld', 18:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:36 INFO - 'MOZ_NO_REMOTE': '1', 18:18:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:36 INFO - 'NO_EM_RESTART': '1', 18:18:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:36 INFO - 'PWD': '/builds/slave/test', 18:18:36 INFO - 'SHELL': '/bin/bash', 18:18:36 INFO - 'SHLVL': '1', 18:18:36 INFO - 'TERM': 'linux', 18:18:36 INFO - 'TMOUT': '86400', 18:18:36 INFO - 'USER': 'cltbld', 18:18:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:36 INFO - '_': '/tools/buildbot/bin/python'} 18:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:36 INFO - Running setup.py (path:/tmp/pip-mcyXt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:36 INFO - Running setup.py (path:/tmp/pip-C3sTZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:36 INFO - Running setup.py (path:/tmp/pip-WwDV9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:36 INFO - Running setup.py (path:/tmp/pip-ExvgjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:36 INFO - Running setup.py (path:/tmp/pip-Dfvd3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:36 INFO - Running setup.py (path:/tmp/pip-t01TTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:36 INFO - Running setup.py (path:/tmp/pip-Roxeda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:36 INFO - Running setup.py (path:/tmp/pip-c_LXd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:36 INFO - Running setup.py (path:/tmp/pip-wt5b26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:37 INFO - Running setup.py (path:/tmp/pip-4BdhGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:37 INFO - Running setup.py (path:/tmp/pip-pR_lHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:37 INFO - Running setup.py (path:/tmp/pip-Jcds0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:37 INFO - Running setup.py (path:/tmp/pip-ZE0z0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:37 INFO - Running setup.py (path:/tmp/pip-1oRHLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:37 INFO - Running setup.py (path:/tmp/pip-_x2dgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:37 INFO - Running setup.py (path:/tmp/pip-sJi1mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:37 INFO - Running setup.py (path:/tmp/pip-I6QbHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:37 INFO - Running setup.py install for manifestparser 18:18:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:37 INFO - Running setup.py install for mozcrash 18:18:37 INFO - Running setup.py install for mozdebug 18:18:37 INFO - Running setup.py install for mozdevice 18:18:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Running setup.py install for mozfile 18:18:38 INFO - Running setup.py install for mozhttpd 18:18:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Running setup.py install for mozinfo 18:18:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Running setup.py install for mozInstall 18:18:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Running setup.py install for mozleak 18:18:38 INFO - Running setup.py install for mozlog 18:18:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Running setup.py install for moznetwork 18:18:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Running setup.py install for mozprocess 18:18:38 INFO - Running setup.py install for mozprofile 18:18:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:38 INFO - Running setup.py install for mozrunner 18:18:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:39 INFO - Running setup.py install for mozscreenshot 18:18:39 INFO - Running setup.py install for moztest 18:18:39 INFO - Running setup.py install for mozversion 18:18:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:39 INFO - Cleaning up... 18:18:39 INFO - Return code: 0 18:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:39 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 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18:39 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 18:18:39 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 18:18:39 INFO - Using env: {'DISPLAY': ':0', 18:18:39 INFO - 'HOME': '/home/cltbld', 18:18:39 INFO - 'LANG': 'en_US.UTF-8', 18:18:39 INFO - 'LANGUAGE': 'en_US:en', 18:18:39 INFO - 'LOGNAME': 'cltbld', 18:18:39 INFO - 'MAIL': '/var/mail/cltbld', 18:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:39 INFO - 'MOZ_NO_REMOTE': '1', 18:18:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:39 INFO - 'NO_EM_RESTART': '1', 18:18:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:39 INFO - 'PWD': '/builds/slave/test', 18:18:39 INFO - 'SHELL': '/bin/bash', 18:18:39 INFO - 'SHLVL': '1', 18:18:39 INFO - 'TERM': 'linux', 18:18:39 INFO - 'TMOUT': '86400', 18:18:39 INFO - 'USER': 'cltbld', 18:18:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:39 INFO - '_': '/tools/buildbot/bin/python'} 18:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:39 INFO - Running setup.py (path:/tmp/pip-cElnyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:39 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)) 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:39 INFO - Running setup.py (path:/tmp/pip-tsn0fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:39 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)) 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:39 INFO - Running setup.py (path:/tmp/pip-oreOnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:39 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)) 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:39 INFO - Running setup.py (path:/tmp/pip-NsN_bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:39 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)) 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:39 INFO - Running setup.py (path:/tmp/pip-QmhmUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:39 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)) 18:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:39 INFO - Running setup.py (path:/tmp/pip-bU28iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:40 INFO - Running setup.py (path:/tmp/pip-jeEDsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:40 INFO - Running setup.py (path:/tmp/pip-qDHtiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:40 INFO - Running setup.py (path:/tmp/pip-vaPwMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:40 INFO - Running setup.py (path:/tmp/pip-bfknc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:40 INFO - Running setup.py (path:/tmp/pip-fYhgNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:40 INFO - Running setup.py (path:/tmp/pip-ZqBFrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:40 INFO - Running setup.py (path:/tmp/pip-LD_xT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:40 INFO - Running setup.py (path:/tmp/pip-wZHO24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:40 INFO - Running setup.py (path:/tmp/pip-jU1gVl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:40 INFO - Running setup.py (path:/tmp/pip-ofSqej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:40 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)) 18:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:40 INFO - Running setup.py (path:/tmp/pip-U0pTJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 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)) 18:18:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:40 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 18:18:40 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 18:18:40 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 18:18:40 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 18:18:40 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 18:18:40 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 18:18:42 INFO - Downloading blessings-1.6.tar.gz 18:18:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:18:42 INFO - Installing collected packages: blessings 18:18:42 INFO - Running setup.py install for blessings 18:18:42 INFO - Successfully installed blessings 18:18:42 INFO - Cleaning up... 18:18:43 INFO - Return code: 0 18:18:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:43 INFO - Reading from file tmpfile_stdout 18:18:43 INFO - Current package versions: 18:18:43 INFO - argparse == 1.2.1 18:18:43 INFO - blessings == 1.6 18:18:43 INFO - blobuploader == 1.2.4 18:18:43 INFO - docopt == 0.6.1 18:18:43 INFO - functools32 == 3.2.3-2 18:18:43 INFO - jsonschema == 2.5.1 18:18:43 INFO - manifestparser == 1.1 18:18:43 INFO - mozInstall == 1.12 18:18:43 INFO - mozcrash == 0.17 18:18:43 INFO - mozdebug == 0.1 18:18:43 INFO - mozdevice == 0.48 18:18:43 INFO - mozfile == 1.2 18:18:43 INFO - mozhttpd == 0.7 18:18:43 INFO - mozinfo == 0.9 18:18:43 INFO - mozleak == 0.1 18:18:43 INFO - mozlog == 3.3 18:18:43 INFO - moznetwork == 0.27 18:18:43 INFO - mozprocess == 0.23 18:18:43 INFO - mozprofile == 0.28 18:18:43 INFO - mozrunner == 6.12 18:18:43 INFO - mozscreenshot == 0.1 18:18:43 INFO - mozsystemmonitor == 0.3 18:18:43 INFO - moztest == 0.7 18:18:43 INFO - mozversion == 1.4 18:18:43 INFO - psutil == 3.1.1 18:18:43 INFO - requests == 1.2.3 18:18:43 INFO - wsgiref == 0.1.2 18:18:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:43 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 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18:43 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 18:18:43 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 18:18:43 INFO - Using env: {'DISPLAY': ':0', 18:18:43 INFO - 'HOME': '/home/cltbld', 18:18:43 INFO - 'LANG': 'en_US.UTF-8', 18:18:43 INFO - 'LANGUAGE': 'en_US:en', 18:18:43 INFO - 'LOGNAME': 'cltbld', 18:18:43 INFO - 'MAIL': '/var/mail/cltbld', 18:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:43 INFO - 'MOZ_NO_REMOTE': '1', 18:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:43 INFO - 'NO_EM_RESTART': '1', 18:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:43 INFO - 'PWD': '/builds/slave/test', 18:18:43 INFO - 'SHELL': '/bin/bash', 18:18:43 INFO - 'SHLVL': '1', 18:18:43 INFO - 'TERM': 'linux', 18:18:43 INFO - 'TMOUT': '86400', 18:18:43 INFO - 'USER': 'cltbld', 18:18:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:43 INFO - '_': '/tools/buildbot/bin/python'} 18:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 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)) 18:18:43 INFO - Cleaning up... 18:18:43 INFO - Return code: 0 18:18:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:18:43 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 0x1241030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1502180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, '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': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', '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 18:18:43 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 18:18:43 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 18:18:43 INFO - Using env: {'DISPLAY': ':0', 18:18:43 INFO - 'HOME': '/home/cltbld', 18:18:43 INFO - 'LANG': 'en_US.UTF-8', 18:18:43 INFO - 'LANGUAGE': 'en_US:en', 18:18:43 INFO - 'LOGNAME': 'cltbld', 18:18:43 INFO - 'MAIL': '/var/mail/cltbld', 18:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:43 INFO - 'MOZ_NO_REMOTE': '1', 18:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:43 INFO - 'NO_EM_RESTART': '1', 18:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:43 INFO - 'PWD': '/builds/slave/test', 18:18:43 INFO - 'SHELL': '/bin/bash', 18:18:43 INFO - 'SHLVL': '1', 18:18:43 INFO - 'TERM': 'linux', 18:18:43 INFO - 'TMOUT': '86400', 18:18:43 INFO - 'USER': 'cltbld', 18:18:43 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:43 INFO - '_': '/tools/buildbot/bin/python'} 18:18:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:18:43 INFO - Cleaning up... 18:18:43 INFO - Return code: 0 18:18:43 INFO - Running post-action listener: _resource_record_post_action 18:18:43 INFO - Running post-action listener: _start_resource_monitoring 18:18:43 INFO - Starting resource monitoring. 18:18:43 INFO - [mozharness: 2016-07-22 01:18:43.697702Z] Finished create-virtualenv step (success) 18:18:43 INFO - [mozharness: 2016-07-22 01:18:43.698189Z] Running install step. 18:18:43 INFO - Running pre-action listener: _resource_record_pre_action 18:18:43 INFO - Running main action method: install 18:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:43 INFO - Reading from file tmpfile_stdout 18:18:43 INFO - Detecting whether we're running mozinstall >=1.0... 18:18:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:18:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:18:43 INFO - Reading from file tmpfile_stdout 18:18:43 INFO - Output received: 18:18:43 INFO - Usage: mozinstall [options] installer 18:18:43 INFO - Options: 18:18:43 INFO - -h, --help show this help message and exit 18:18:43 INFO - -d DEST, --destination=DEST 18:18:43 INFO - Directory to install application into. [default: 18:18:43 INFO - "/builds/slave/test"] 18:18:43 INFO - --app=APP Application being installed. [default: firefox] 18:18:43 INFO - mkdir: /builds/slave/test/build/application 18:18:43 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'] 18:18:43 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 18:19:01 INFO - Reading from file tmpfile_stdout 18:19:01 INFO - Output received: 18:19:01 INFO - /builds/slave/test/build/application/firefox/firefox 18:19:01 INFO - Running post-action listener: _resource_record_post_action 18:19:01 INFO - [mozharness: 2016-07-22 01:19:01.277065Z] Finished install step (success) 18:19:01 INFO - [mozharness: 2016-07-22 01:19:01.277502Z] Running run-tests step. 18:19:01 INFO - Running pre-action listener: _resource_record_pre_action 18:19:01 INFO - Running main action method: run_tests 18:19:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:19:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:19:01 INFO - Python 2.7.3 18:19:01 INFO - Return code: 0 18:19:01 INFO - grabbing minidump binary from tooltool 18:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:19:01 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 0x15003b0>, '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 0x15012b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1501740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:19:01 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 18:19:01 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 18:19:01 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 18:19:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:19:01 INFO - Return code: 0 18:19:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:19:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:19:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:19:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:19:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:19:01 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/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:19:01 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/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 18:19:01 INFO - Using env: {'DISPLAY': ':0', 18:19:01 INFO - 'HOME': '/home/cltbld', 18:19:01 INFO - 'LANG': 'en_US.UTF-8', 18:19:01 INFO - 'LANGUAGE': 'en_US:en', 18:19:01 INFO - 'LOGNAME': 'cltbld', 18:19:01 INFO - 'MAIL': '/var/mail/cltbld', 18:19:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:19:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:19:01 INFO - 'MOZ_NO_REMOTE': '1', 18:19:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:19:01 INFO - 'NO_EM_RESTART': '1', 18:19:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:19:01 INFO - 'PWD': '/builds/slave/test', 18:19:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:19:01 INFO - 'SHELL': '/bin/bash', 18:19:01 INFO - 'SHLVL': '1', 18:19:01 INFO - 'TERM': 'linux', 18:19:01 INFO - 'TMOUT': '86400', 18:19:01 INFO - 'USER': 'cltbld', 18:19:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368', 18:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:19:01 INFO - '_': '/tools/buildbot/bin/python'} 18:19:01 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/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 18:19:01 INFO - mozversion application_buildid: 20160721163009 18:19:01 INFO - mozversion application_changeset: 2e3390571fdb3a1ff3d2f7f828adf67dbc237bc8 18:19:01 INFO - mozversion application_display_name: Nightly 18:19:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:19:01 INFO - mozversion application_name: Firefox 18:19:01 INFO - mozversion application_remotingname: firefox 18:19:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:19:01 INFO - mozversion application_vendor: Mozilla 18:19:01 INFO - mozversion application_version: 50.0a1 18:19:01 INFO - mozversion platform_buildid: 20160721163009 18:19:01 INFO - mozversion platform_changeset: 2e3390571fdb3a1ff3d2f7f828adf67dbc237bc8 18:19:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:19:01 INFO - mozversion platform_version: 50.0a1 18:19:01 INFO - using testdate: 1469150341 18:19:01 INFO - actual date: 1469150341 18:19:01 INFO - starting webserver on 'localhost:56641' 18:19:01 INFO - SUITE-START | Running 2 tests 18:19:01 INFO - TEST-START | dromaeo_css 18:19:01 INFO - operating with platform_type : linux_ 18:19:01 INFO - Initialising browser for dromaeo_css test... 18:19:01 INFO - TEST-INFO | started process 9087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGV5TaR/profile http://localhost:56641/getInfo.html) 18:19:04 INFO - PROCESS | 9087 | JavaScript error: , line 0: uncaught exception: undefined 18:19:06 INFO - PROCESS | 9087 | __metrics Screen width/height:1600/1200 18:19:06 INFO - PROCESS | 9087 | colorDepth:24 18:19:06 INFO - PROCESS | 9087 | Browser inner width/height: 1024/697 18:19:06 INFO - PROCESS | 9087 | __metrics 18:19:06 ERROR - PROCESS | 9087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:19:07 INFO - TEST-INFO | 9087: exit 0 18:19:07 INFO - Browser initialized. 18:19:07 INFO - Running cycle 1/1 for dromaeo_css test... 18:19:07 INFO - TEST-INFO | started process 9209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGV5TaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:19:19 INFO - PROCESS | 9209 | RSS: Main: 167698432 18:19:19 INFO - PROCESS | 9209 | 18:20:08 INFO - PROCESS | 9209 | 1469150408848 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] 18:22:17 INFO - PROCESS | 9209 | Cycle 1(1): loaded http://localhost:56641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56641/tests/dromaeo/cssquery-ext.html) 18:22:18 INFO - PROCESS | 9209 | RSS: Main: 172380160 18:22:18 INFO - PROCESS | 9209 | 18:25:20 INFO - PROCESS | 9209 | Cycle 1(1): loaded http://localhost:56641/tests/dromaeo/cssquery-ext.html (next: http://localhost:56641/tests/dromaeo/cssquery-jquery.html) 18:25:21 INFO - PROCESS | 9209 | RSS: Main: 169328640 18:25:21 INFO - PROCESS | 9209 | 18:28:22 INFO - PROCESS | 9209 | Cycle 1(1): loaded http://localhost:56641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56641/tests/dromaeo/cssquery-mootools.html) 18:28:23 INFO - PROCESS | 9209 | RSS: Main: 173531136 18:28:23 INFO - PROCESS | 9209 | 18:31:25 INFO - PROCESS | 9209 | Cycle 1(1): loaded http://localhost:56641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56641/tests/dromaeo/cssquery-prototype.html) 18:31:25 INFO - PROCESS | 9209 | RSS: Main: 167636992 18:31:25 INFO - PROCESS | 9209 | 18:34:28 INFO - PROCESS | 9209 | Cycle 1(1): loaded http://localhost:56641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56641/tests/dromaeo/cssquery-yui.html) 18:34:29 INFO - PROCESS | 9209 | RSS: Main: 170180608 18:34:29 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | Cycle 1(1): loaded http://localhost:56641/tests/dromaeo/cssquery-yui.html (next: http://localhost:56641/tests/dromaeo/cssquery-dojo.html) 18:37:32 INFO - PROCESS | 9209 | RSS: Main: 172916736 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | __start_tp_report 18:37:32 INFO - PROCESS | 9209 | _x_x_mozilla_page_load 18:37:32 INFO - PROCESS | 9209 | _x_x_mozilla_page_load_details 18:37:32 INFO - PROCESS | 9209 | |i|pagename|runs| 18:37:32 INFO - PROCESS | 9209 | |0;dojo.html;3077.3229889424324;3119.064280715786;3131.358071595323;3140.2934339773556;3143.669914658962;5396.379416367119;5411.0530657135;5460.726963651817;5510.256115424427;5603.439656034395;5344.706041167734;5358.410574836765;5364.517193452589;5427.728613569326;5435.864103397417;4844.685095468801;4877.585405240558;4901.411830580318;5003.649744517885;5006.97496512517;4895.657303988704;5026.5727413169925;5029.798808047673;5049.444561098277;5100.311457953185;4884.902301953976;4907.730074845882;5005;5031.723255220962;5084;4991.925121123186;4999.675021123651;5003.54968052877;5019.498050194988;5032.521910418504;4925.507449255082;4939.925901111486;4941.7034977901085;4960.776765045582;4990.226514890198;5382.085045542228;5427.511523962823;5438.45615438453;5442.809501667422;5494.890102197974;5850.64896106235;5850.824475265749;5857.414258574151;5874.118882167666;5906.940930590725;5911.054231323011;5917.822465326047;5918.556108291852;5920.259967504062;5924.674142922137;5280.788768449257;5412.052890744104;5430.185472179126;5431.646942948656;5499.835004949858;5993.190919225936;5999.640021598718;6004;6019.337872833985;6026;5759.568032397587;5762.596618236683;5763.971180144156;5769.1634712967225;5771.480566749013;5689.203511508392;5748.770049197985;5769.336526299446;5771.85570360736;5859.912101318484;5601.243832082617;5693.4875861172695;5760.107183386582;5835.4748072673665;5867.354590994987;5799.18811366409;5841.970790146022;5864.179014937912;5872.823815285548;5893.174955506232;4345.869623911224;4410.845620403271;4435.512093669694;4438.511763705989;4461.107778444324;3884.7863367515056;3980.482537270136;4005.799710014546;4013.3779264214095;4024.335984562573;5611.102223644198;5614.466625670637;5652.208690783294;5664.97167514168;5702.714864256854;5781.306243250837;5933.495652869468;5936.554758393051;5939.465448109604;5949.583529153005;5509.283793106871;5537.640053396516;5560.582956278296;5589.8602534936135;5645.802396916089;4935.827246046371;5030;5032.370953630796;5033.6224783141415;5050.292958985745;5840.883182336414;5990.850228744229;5998.790042348497;6006.609570377911;6028;5801.6519008859605;5828.562857785768;5849.707514624337;5949.196858424058;5982.371850955587;6059.787907423219;6098.969505152446;6109.75560977556;6114.205153330038;6125.448709616156;5716.399778023248;5750.30996280449;5807.128930660266;5807.506361959281;5815.156802263564;5799.362070172362;5829.854253643693;5835.328937172279;5896.970515147397;5937.228160339128;5702.287214098238;5738.454846789548;5747.339056008613;5753.309602847685;5753.3958934311295;5573.8606534835335;5723.685197314021;5724.198612194379;5744.712764361849;5753.1370294456165;5616.382197958303;5648.774049037993;5682.289713785777;5723.484886360247;5728.026235540052;5753.71231438418;5777.3356064051495;5787.479126878433;5805.274340707411;5807.361190268983;5465.480779325958;5471.480209380103;5650.152477128464;5667.291588551431;5684.204211410323 18:37:32 INFO - PROCESS | 9209 | |1;ext.html;556.9860753481163;598.9790357337491;604.7278724573941;613.9593389205297;635.7552342348195;39565.4065189022;43278;43311.56688433119;43322.35016474756;43367.78316108415;44048.55951440485;44511;44553.77723111388;44559.55440445594;44649.330260046125;9031.503267320295;9031.909680903189;9116.772080698003;9127.497987610679;9195.678151264707;8983.640654373818;9102.317326200528;9168.679096231634;9171.312151588625;9217.124373184537;9198.540072996357;9205.493697846616;9267.44395336282;9270.304727145458;9275.72172834816;9120.042395548438;9212.815743685122;9216.40093393934;9223.21602663771;9224.907750922472;9010.819783604291;9045.3668243223;9069.546522673905;9082.77293067672;9083.500407477586;41185.79407102945;41192.1761564767;41646.37530437046;41658.583414166074;41770.373444398356;3153.6057992750907;3199.63204231514;3645.54430696163;3817.522809648794;3936.9015774605577;32668.4064752877;33131.17172070693;33490.49764253538;34197.14507137317;34587.82706086453;4329.480462344539;4333.619266259763;4390.209762242795;4392.670549708752;4592.586667199935;374273;375554;375831.12084439676;376366;377382;62235.6888215556;62345.32410069172;62661;62727.37272627215;62755.09693933664;66417;66549.33450665529;66708;66717;66858.66570667115;16450.506484805475;16932.407365742387;17027.233774480177;17298.394556190473;17305.13474326304;13252.536161234311;13505.32473376347;13507.459701611826;13515.459381624822;13520.121192122677;20177.293794717116;20306;20335.898320508302;20419.489512762004;20491.59016819685;7305.8447757911545;7364.594947277844;7364.889526657104;7562.886556701654;7581.50720203185;959.7840485890619;997.9351342162736;1036.9066783989326;1117.0951529261324;1124.2692250037542;33463.498047529305;33838.49242261368;34111.488327675106;34131.31737365239;34182;994.3685759542742;1060.750723579958;1122.2088427658482;1191.1304747534348;1197.6646538969103;15792.289346979414;16957.745633815503;17018.48944531666;17107.48677539676;17127.229274682668;610184;613553;614318;615708;615889;60827;60948.08577871336;61749;61758.69120654458;61761;1332.413737955316;1362.6933939863452;1378.3797291218991;1390.8122403475604;1403.7997512127188;29966.016688144686;32171;32242.193945151557;32272;32276.83861580771;52750.2087468696;52834.47165528449;52906.2064069047;53017.879284828174;53083.20375194452;486970;487357;490471;490614;491623;28992.275193120342;29438;29492.55761163627;29578.408431831675;29581.704182957896;49108.508914910395;50255.246171308194;50660.493395065576;51346.22980655368;51438.22842657288;41928.790356048026;42406.78796605997;43067;43273;44570.77714611406;42117.78941105275;43429.348559770995;43643.66952949741;43913.34129987989;44208.68434867462;39136.2172756549;41031.17937641171;42842.57157428386;43163;45087.774561126986;33689.32621347608;39094.609053909095;39113;39354.60645393509;40043.599564003984;28723;28759;29084.563731544466;29251.26871828136;29358 18:37:32 INFO - PROCESS | 9209 | |2;jquery.html;341.8547117475074;360.74567429961877;377.1664621187177;377.18716166660846;393.3627523412073;18071.36750213743;19962.101705423254;19991.700124498144;20668.689969650448;20754.169833206655;17978.640427191447;18614.906925465388;19088.141033653483;19614.313499027536;19624.60750784987;5200.115980283352;5318.734063296839;5353.170258609902;5353.464653534655;5749.885002299972;5785.103308987113;5855.209546711182;5857.794977175799;5858.677772722499;5860.912086318709;5730.7421166047625;5752.626079304852;5802.622829516089;5850.4734573888345;5852.385499522553;5710.114932185518;5808.273965754281;5825.796097136601;5858.150568167634;5871.500922421599;5015.172496538067;5077.2637967494875;5125.948740512585;5193.37679478465;5198.298229738974;12924.159929604639;12941.611751647466;13042.674118099918;13105;13114.868851311556;2245.9887700561394;2311.1217737259904;2377.9524409511887;2441.865697386643;2796.846173460459;9257.814843703156;9466;9609.663661771874;10074.798504029879;10116.08955194036;1890.5273681579606;1994.8703334283225;2009.4976255936017;2030.2995466564012;2054.815066644009;84514;85364.57317713434;85650.75081827973;86098;87539;10882.61910833117;10906.781864362669;11176.720581985515;11293.71765705864;11432.828507572392;15410.768838467431;15417.306221219847;15461.613459663598;15476.071435713668;15481.380744770084;8191.836163276701;8367.874481882776;8387.329013679013;8447.311741983136;8608.612612432456;8172.591370431454;8223.54770487629;8453.281471074904;8484;8534.103919088531;4364.498082720528;4448.733076015449;4635.351050852883;4754.904901901942;4803.471618122004;1869.270745015114;1975.901204939776;1987.0958713785194;2028.8884111374016;2073.1603700501323;931.9301052421096;971.1842052675786;1011.4386515483977;1012.9848052279222;1040.552562398176;19683.409497714805;19751.60496790085;19884.50288742793;20058.39824805258;20279.493012674506;1000.8548760429696;1007.652359935821;1017.7811770469384;1034.3690348887174;1052.2686732720686;10730.248882578144;10846.67459976202;10869.239153259196;11126.499307531181;11192.496337664661;426728;432020;437136;542509;548125;62896;73538.26461735422;80705;98446;102808;988.081084591337;1005.4972513743129;1019.5785010599825;1021.9080282774586;1035.6691651228136;17016.744748829024;17017;17932.91033544824;17975;18189.54526136857;39505;41473.79263103665;42874;42987;43710.344344834215;55228.723856380464;59446.70276648762;61099.69450152721;62248.086431788906;62778.68610656918;6853.931460685529;7328.34044935937;7385.9630701846145;7563.584002879675;7942.285194332538;11130.721731956766;12688.17526860751;12746.745065098832;12982.221066736027;13178.275194864374;11242.718932026437;11338.659840204808;11361.318320900773;11555.537778488766;11733.471993760131;11161.330320180816;11175.441227938732;11259.605913792979;11602.593909213138;11605.129615278718;5891.94108058931;8262.83474330522;11254.606088786853;11426.657200284004;11473.655790326304;7246.202917678946;7324.780256592311;7421.591812450151;7485.251474852471;7558.924410756042;10939.617113400993;11307.943460282646;11484;11599.88400115988;11705.122115841516 18:37:32 INFO - PROCESS | 9209 | |3;mootools.html;1256.1834807375205;1379.124256097378;1379.5171689908534;1735.158448152645;1802.297104129389;7693.846123077535;8376.874346884802;8506.74479765608;8896.11038896111;8909.68816091437;8502.362322825782;8831.955840220806;8852;8856.51289179095;8893.555322233895;2345.589521833681;2378.9048438062455;2387.0451819272257;2388.0567175965484;2398.268528098929;2328.5459335429596;2377.762223777626;2398.2925037114005;2398.292503711409;2400.9159679411223;2360.0677732295735;2372.1697405907967;2386.2006227913585;2391.5216956608747;2394.736578976311;2334.789868911789;2339.894704738291;2370.8814559272055;2379.5954687703133;2386.1886958434216;2258.2096266306826;2261.796438320559;2264.79616834484;2279.726432828055;2281.1559722902634;8808.779780505474;8900.73297801067;8914.37599368038;8918.73243802687;8960.551972401354;5151.536361727425;5259.737013149327;5284.154535274338;5310.575153987672;5316.680999140025;3403.3533628610485;3470.7917524948584;3475.2528206435736;3498.7900725956524;3559.911002224965;1133.2747041893194;1138.9487473063732;1156.7570810129882;1163.2322667039714;1169.7485040716288;11925.165238433314;11937.701557461047;12012.459439325165;12058.397080145958;12097.818532722016;4500.774961251925;4659.557342052567;4747.477777444478;4792.520747925179;4798.856034318976;10339.793204136025;10382.948085259526;10400.843987340197;10418.479076046167;10428.687139385831;5271.103912334912;5286.947130528645;5295.258663787073;5303.628745987821;5317.069512835315;4221.387898754663;4683.578477937002;4732.1718699227495;4775.546323099369;4892.266160075946;3958.6437220650278;4024.1348110155873;4065.918681626351;4152.667786577066;4155.563665815106;1314.2508770001198;1345.905786594929;1359.306753555674;1360.4966162519734;1368.404743936371;848.7665891879659;997.3816233935007;1009.7627057641448;1016.4511163971521;1027.6660085472251;5883.382244864313;6028.397160284024;6050.969745151246;6136.570440069152;6192.318844927055;441.28952386657454;444.51103785835323;447.90370070434363;448.652294471787;454.8408057180027;4267.103908179317;4302.315178385036;4311.9784401077795;4387.451568553931;4414.668899832525;10645.680629581126;10894.455277236106;10963.56145754177;10968.616098436676;10997.670069897917;10762.78474430507;10849.67450976472;10856.837147442795;10873.673789786319;10900.1279897608;7755.487679902478;8066.838663226703;8119.147489513516;8145.918540814635;8258.174182581693;6039.396060393926;6185.659788711664;6267.874642507216;6323.525735569942;6429.132067170872;9932.801343972935;10046.497675116068;10238.846417303597;10248.282620216512;10256.487175641338;10188.286819922534;10212.795744085226;10230.335028223439;10339.431331276852;10381.532831022772;6901.275366086488;7437.479376443597;7552;7725.459217854696;7844.058712954482;8522.829543409222;8531.146885311418;8562.871556926775;8575.571221439028;8580.485170889766;7658.693652253847;7738.2261773822165;7861.1352751198465;8000.319972802145;8043.115257321807;7589.772306830804;7660.387169026576;7689.423293252917;7759.92240077592;7895.092064412436;6959.130108736408;7070.469714771516;7072.752453664097;7073.893891591733;7087.255838136922;5152.922706159486;5198.194279886472;5289.391719952255;5300.2049692546425;5488.588355873246;5292.550133238564;5311.787528498817;5391.353037635352;5438.6192966493545;5477.589180811376 18:37:32 INFO - PROCESS | 9209 | |4;prototype.html;298.8968805762011;304.8262490380484;325.175679652082;328.24994886683925;330.482794426722;5438.646487978289;5497.8075767348155;5563.36021357544;5666.914996275054;5671.914921276184;5476.808311709091;5502.367227768807;5522;5529.612927095105;5532.585056120787;4323.675724320673;4330.358481326389;4342.891427714301;4373.540778218289;4378.584034516732;4117;4287.957120428802;4321.2653848845775;4380.904773806548;4382.517923028464;4251.2135254977775;4255.702100852942;4260.936085958713;4263.424437700917;4267.679924005696;4268.1890440816305;4280.700350975433;4314.266574682311;4323.567643235683;4336;3524.9823750881337;3794.146317078663;3802.3535998880257;3807.8286477108595;3813.237352529505;5403.7027963462;5420.186971954199;5429.592780541475;5441.755121019563;5448.782048718046;4921.163402221631;4925.950740492585;4931.728754918478;4932.506749325039;4943.283223932545;5574.470425309589;5782.508486778629;5851.4148585141575;5851.736671849777;5862.765489380419;4108.958910410887;4112.444819949328;4119.958800412018;4129.834806607732;4153.273177194009;6100.45095941363;6112.572119951606;6123.4488895999575;6147.477464415575;6177.598456100339;4116.711830171919;4119.485064366954;4163.271427500236;4245.745255284693;4249.150169966019;4188.748675079505;4195.748255104703;4196.223698615766;4204.138151678899;4208.6633069354375;4845.6608037437745;4871.269309603588;4879.512048795092;4880.951190488121;4884;5787.498563369185;5833.358330583633;5854.18041474194;5945.435183657545;5950.9107363389585;1462.656275775192;1482.2514630111941;1488.6501672107047;1490.9776353354707;1490.9776353354707;891.5898686604105;932.421898422982;938.9953050234706;948.9572969216401;958.942463452195;4968.416423459853;5001.924971125436;5086.287919691246;5104.2343648453025;5133.743312834344;5287.4930644766055;5313.343328335832;5351.394581625496;5379.757910894019;5408.3509978802795;4998.625103117281;5021.322121513549;5128.9230661540105;5375.973120134374;5795.33353664334;3202.343519578481;3222.9194270143435;3243.6756324367375;3247.5386076265777;3295.5715756951445;6039.391672899526;6246.500279977591;6288.591241569284;6319.46284565817;6349.587276826992;6083.239595050619;6117.938820611737;6120.1737765401995;6128.662923539159;6144.754209831557;6229.595076320024;6293.842653933688;6295.905561416583;6298.464630506458;6303.810885673437;5796.246487956539;6009.36901625323;6042.3655516170165;6046.667433291212;6052.84867878289;5939.376365481562;5971.701414929149;5974.761009559743;5980.43185897339;6032.607880487754;5949.78029503942;6169.537284703575;6247.656378899204;6253.374662533893;6277.717502712298;3898.7270891037356;4003.1593365392428;4130.586941305845;4130.938035929524;4139.730917490354;5928.199693041384;5956.731947062306;5973.880522389615;5994.730237139252;6011.368806275278;5655.208270842168;5666.03677374839;5800.59395842287;5850.853728656818;5851.678157701367;5750.827475175752;5771.336296325976;5790.449907258803;5796.217510636179;5799.246098007232;5698.8290351289525;5719.742611582572;5731.312242530923;5736.42635736423;5792.53659707214;5722.828315150552;5805.068440437721;5806.767729290781;5876.588638795414;5879.353271140257;5655.660660360391;5756.395578464369;5766.5675074368755;5774.682392468455;5787.7395517200985 18:37:32 INFO - PROCESS | 9209 | |5;yui.html;740.9444291678126;761.0676920772055;832.3965125284169;842.9409941304108;846.0608724316004;14369.784453233196;14842.406303747865;14877.62805929851;14933.5519934402;14934.925325373359;14939.850601493981;15145.242737863091;15207.315670794813;15254.237288135577;15302.693946121071;654.4731491149622;787.5629025890643;787.6927998080753;811.3063330852125;814.222417591202;802.5987006496752;811.4036183405193;812.2040400407575;814.0191069760924;815.9673613055471;863.3309185381348;864.7016779211193;867.761365624452;868.3964644572025;869.2090197919894;858.9226969572705;860.561113831944;864.0322838420977;864.1444969480232;865.2688478235912;631.3749388105788;637.0285314894776;637.2703254773259;637.5505268785495;639.0510092512615;14874.851251487564;14976.925115374353;14984.100953942798;15063.54809355721;15088.17015064182;15147.166905820175;15206.391744330214;15245.23773811305;15404.306806193748;15451.768223476656;12588.748225035539;12638.747225055447;12695.365231738468;12851.35743212845;12980.221186728826;3979.283728928792;4026.255142798592;4137.54487006429;4196.769177695225;4198.580141985777;80997;81781.9999999994;83877.58061209715;85043.5747821263;85133.57433212794;10063.200530744736;10142.340747851365;10307.381557106597;10655.84016239757;12224.205426647239;19998;20543.79456205449;20579;21400.678989814853;21525.461863453227;8175.5503447309775;8293.460925039853;8816.647334106563;8852.114788521225;8929.955350223207;4899.902001959941;4923.975380123076;4968.801247950114;5005.72468514228;5014.272930425068;3471.5139880416764;3563.590187128513;3573.6783689468075;3588;3599.280143971216;637.1557686065981;639.8144538083997;641.9518536109811;673.8753330633848;678.1963373402534;611.1108337369117;634.5431289471574;696.1298377028714;731.9231480694557;739.8298391369907;9306.208972237435;9962.900370996198;10216.948915255376;10278.126359259546;10344.741381465523;611.729946510815;629.0532748213909;667.8597494526107;675.5170053411834;739.2422766664213;4397.626201772821;4866.31871537985;4905.190643543775;4907.582855457326;4932.827351042696;69829;117976.41011794886;118055.40972295083;118462.40768796101;122461.38769306097;64750.676246619405;102460;103007;104809;107082;59532.70233648804;59927.700361498784;91796;92109.53945230365;95308;9044.954775226082;9194.97802762367;9196.816063678556;9418.764530886783;9469.810603787748;51212.97574048424;51449;52009;53049;53441.198382023525;60706.39293607184;79072;79748.60125699334;80804;80914;11458.770824583295;11794.52821887115;11875.940620296844;12010.699732506408;12103.515859365527;12382.442790074649;12619.747605047663;12814.359282035675;13020.414081366172;13422;12137;12480.563180288646;12550.435230414836;13028.609141725763;13039.217646940835;12482.313472759086;12710.910015048807;13263.80104298417;13653.689964273839;13733.176009439465;12692.936535317263;12784;13010.934945325213;13312.06815522904;13384.732305354033;10241.487925603838;10473.528691208761;10549.261551691616;10596.417197054236;10662.8400573993;9316.534173291444;10761.515731791931;10844.728881778019;10882.347059176474;11153.609623663133 18:37:32 INFO - PROCESS | 9209 | __end_tp_report 18:37:32 INFO - PROCESS | 9209 | __start_cc_report 18:37:32 INFO - PROCESS | 9209 | _x_x_mozilla_cycle_collect,371 18:37:32 INFO - PROCESS | 9209 | __end_cc_report 18:37:32 INFO - PROCESS | 9209 | __startTimestamp1469151452328__endTimestamp 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | ------- Summary: start ------- 18:37:32 INFO - PROCESS | 9209 | Number of tests: 6 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | [#0] dojo.html Cycles:165 Average:5433.12 Median:5682.29 stddev:628.30 (11.1%) stddev-sans-first:602.43 18:37:32 INFO - PROCESS | 9209 | Values: 3077.3 3119.1 3131.4 3140.3 3143.7 5396.4 5411.1 5460.7 5510.3 5603.4 5344.7 5358.4 5364.5 5427.7 5435.9 4844.7 4877.6 4901.4 5003.6 5007.0 4895.7 5026.6 5029.8 5049.4 5100.3 4884.9 4907.7 5005.0 5031.7 5084.0 4991.9 4999.7 5003.5 5019.5 5032.5 4925.5 4939.9 4941.7 4960.8 4990.2 5382.1 5427.5 5438.5 5442.8 5494.9 5850.6 5850.8 5857.4 5874.1 5906.9 5911.1 5917.8 5918.6 5920.3 5924.7 5280.8 5412.1 5430.2 5431.6 5499.8 5993.2 5999.6 6004.0 6019.3 6026.0 5759.6 5762.6 5764.0 5769.2 5771.5 5689.2 5748.8 5769.3 5771.9 5859.9 5601.2 5693.5 5760.1 5835.5 5867.4 5799.2 5842.0 5864.2 5872.8 5893.2 4345.9 4410.8 4435.5 4438.5 4461.1 3884.8 3980.5 4005.8 4013.4 4024.3 5611.1 5614.5 5652.2 5665.0 5702.7 5781.3 5933.5 5936.6 5939.5 5949.6 5509.3 5537.6 5560.6 5589.9 5645.8 4935.8 5030.0 5032.4 5033.6 5050.3 5840.9 5990.9 5998.8 6006.6 6028.0 5801.7 5828.6 5849.7 5949.2 5982.4 6059.8 6099.0 6109.8 6114.2 6125.4 5716.4 5750.3 5807.1 5807.5 5815.2 5799.4 5829.9 5835.3 5897.0 5937.2 5702.3 5738.5 5747.3 5753.3 5753.4 5573.9 5723.7 5724.2 5744.7 5753.1 5616.4 5648.8 5682.3 5723.5 5728.0 5753.7 5777.3 5787.5 5805.3 5807.4 5465.5 5471.5 5650.2 5667.3 5684.2 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | [#1] ext.html Cycles:180 Average:65542.17 Median:23827.98 stddev:133679.66 (561.0%) stddev-sans-first:133965.62 18:37:32 INFO - PROCESS | 9209 | Values: 557.0 599.0 604.7 614.0 635.8 39565.4 43278.0 43311.6 43322.4 43367.8 44048.6 44511.0 44553.8 44559.6 44649.3 9031.5 9031.9 9116.8 9127.5 9195.7 8983.6 9102.3 9168.7 9171.3 9217.1 9198.5 9205.5 9267.4 9270.3 9275.7 9120.0 9212.8 9216.4 9223.2 9224.9 9010.8 9045.4 9069.5 9082.8 9083.5 41185.8 41192.2 41646.4 41658.6 41770.4 3153.6 3199.6 3645.5 3817.5 3936.9 32668.4 33131.2 33490.5 34197.1 34587.8 4329.5 4333.6 4390.2 4392.7 4592.6 374273.0 375554.0 375831.1 376366.0 377382.0 62235.7 62345.3 62661.0 62727.4 62755.1 66417.0 66549.3 66708.0 66717.0 66858.7 16450.5 16932.4 17027.2 17298.4 17305.1 13252.5 13505.3 13507.5 13515.5 13520.1 20177.3 20306.0 20335.9 20419.5 20491.6 7305.8 7364.6 7364.9 7562.9 7581.5 959.8 997.9 1036.9 1117.1 1124.3 33463.5 33838.5 34111.5 34131.3 34182.0 994.4 1060.8 1122.2 1191.1 1197.7 15792.3 16957.7 17018.5 17107.5 17127.2 610184.0 613553.0 614318.0 615708.0 615889.0 60827.0 60948.1 61749.0 61758.7 61761.0 1332.4 1362.7 1378.4 1390.8 1403.8 29966.0 32171.0 32242.2 32272.0 32276.8 52750.2 52834.5 52906.2 53017.9 53083.2 486970.0 487357.0 490471.0 490614.0 491623.0 28992.3 29438.0 29492.6 29578.4 29581.7 49108.5 50255.2 50660.5 51346.2 51438.2 41928.8 42406.8 43067.0 43273.0 44570.8 42117.8 43429.3 43643.7 43913.3 44208.7 39136.2 41031.2 42842.6 43163.0 45087.8 33689.3 39094.6 39113.0 39354.6 40043.6 28723.0 28759.0 29084.6 29251.3 29358.0 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | [#2] jquery.html Cycles:180 Average:28227.76 Median:2409.91 stddev:79371.60 (3293.6%) stddev-sans-first:79566.64 18:37:32 INFO - PROCESS | 9209 | Values: 341.9 360.7 377.2 377.2 393.4 18071.4 19962.1 19991.7 20668.7 20754.2 17978.6 18614.9 19088.1 19614.3 19624.6 5200.1 5318.7 5353.2 5353.5 5749.9 5785.1 5855.2 5857.8 5858.7 5860.9 5730.7 5752.6 5802.6 5850.5 5852.4 5710.1 5808.3 5825.8 5858.2 5871.5 5015.2 5077.3 5125.9 5193.4 5198.3 12924.2 12941.6 13042.7 13105.0 13114.9 2246.0 2311.1 2378.0 2441.9 2796.8 9257.8 9466.0 9609.7 10074.8 10116.1 1890.5 1994.9 2009.5 2030.3 2054.8 84514.0 85364.6 85650.8 86098.0 87539.0 10882.6 10906.8 11176.7 11293.7 11432.8 15410.8 15417.3 15461.6 15476.1 15481.4 8191.8 8367.9 8387.3 8447.3 8608.6 8172.6 8223.5 8453.3 8484.0 8534.1 4364.5 4448.7 4635.4 4754.9 4803.5 1869.3 1975.9 1987.1 2028.9 2073.2 931.9 971.2 1011.4 1013.0 1040.6 19683.4 19751.6 19884.5 20058.4 20279.5 1000.9 1007.7 1017.8 1034.4 1052.3 10730.2 10846.7 10869.2 11126.5 11192.5 426728.0 432020.0 437136.0 542509.0 548125.0 62896.0 73538.3 80705.0 98446.0 102808.0 988.1 1005.5 1019.6 1021.9 1035.7 17016.7 17017.0 17932.9 17975.0 18189.5 39505.0 41473.8 42874.0 42987.0 43710.3 55228.7 59446.7 61099.7 62248.1 62778.7 6853.9 7328.3 7386.0 7563.6 7942.3 11130.7 12688.2 12746.7 12982.2 13178.3 11242.7 11338.7 11361.3 11555.5 11733.5 11161.3 11175.4 11259.6 11602.6 11605.1 5891.9 8262.8 11254.6 11426.7 11473.7 7246.2 7324.8 7421.6 7485.3 7558.9 10939.6 11307.9 11484.0 11599.9 11705.1 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | [#3] mootools.html Cycles:180 Average:5818.57 Median:448.28 stddev:3286.35 (733.1%) stddev-sans-first:3277.67 18:37:32 INFO - PROCESS | 9209 | Values: 1256.2 1379.1 1379.5 1735.2 1802.3 7693.8 8376.9 8506.7 8896.1 8909.7 8502.4 8832.0 8852.0 8856.5 8893.6 2345.6 2378.9 2387.0 2388.1 2398.3 2328.5 2377.8 2398.3 2398.3 2400.9 2360.1 2372.2 2386.2 2391.5 2394.7 2334.8 2339.9 2370.9 2379.6 2386.2 2258.2 2261.8 2264.8 2279.7 2281.2 8808.8 8900.7 8914.4 8918.7 8960.6 5151.5 5259.7 5284.2 5310.6 5316.7 3403.4 3470.8 3475.3 3498.8 3559.9 1133.3 1138.9 1156.8 1163.2 1169.7 11925.2 11937.7 12012.5 12058.4 12097.8 4500.8 4659.6 4747.5 4792.5 4798.9 10339.8 10382.9 10400.8 10418.5 10428.7 5271.1 5286.9 5295.3 5303.6 5317.1 4221.4 4683.6 4732.2 4775.5 4892.3 3958.6 4024.1 4065.9 4152.7 4155.6 1314.3 1345.9 1359.3 1360.5 1368.4 848.8 997.4 1009.8 1016.5 1027.7 5883.4 6028.4 6051.0 6136.6 6192.3 441.3 444.5 447.9 448.7 454.8 4267.1 4302.3 4312.0 4387.5 4414.7 10645.7 10894.5 10963.6 10968.6 10997.7 10762.8 10849.7 10856.8 10873.7 10900.1 7755.5 8066.8 8119.1 8145.9 8258.2 6039.4 6185.7 6267.9 6323.5 6429.1 9932.8 10046.5 10238.8 10248.3 10256.5 10188.3 10212.8 10230.3 10339.4 10381.5 6901.3 7437.5 7552.0 7725.5 7844.1 8522.8 8531.1 8562.9 8575.6 8580.5 7658.7 7738.2 7861.1 8000.3 8043.1 7589.8 7660.4 7689.4 7759.9 7895.1 6959.1 7070.5 7072.8 7073.9 7087.3 5152.9 5198.2 5289.4 5300.2 5488.6 5292.6 5311.8 5391.4 5438.6 5477.6 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | [#4] prototype.html Cycles:180 Average:4858.28 Median:5487.31 stddev:1449.64 (26.4%) stddev-sans-first:1412.73 18:37:32 INFO - PROCESS | 9209 | Values: 298.9 304.8 325.2 328.2 330.5 5438.6 5497.8 5563.4 5666.9 5671.9 5476.8 5502.4 5522.0 5529.6 5532.6 4323.7 4330.4 4342.9 4373.5 4378.6 4117.0 4288.0 4321.3 4380.9 4382.5 4251.2 4255.7 4260.9 4263.4 4267.7 4268.2 4280.7 4314.3 4323.6 4336.0 3525.0 3794.1 3802.4 3807.8 3813.2 5403.7 5420.2 5429.6 5441.8 5448.8 4921.2 4926.0 4931.7 4932.5 4943.3 5574.5 5782.5 5851.4 5851.7 5862.8 4109.0 4112.4 4120.0 4129.8 4153.3 6100.5 6112.6 6123.4 6147.5 6177.6 4116.7 4119.5 4163.3 4245.7 4249.2 4188.7 4195.7 4196.2 4204.1 4208.7 4845.7 4871.3 4879.5 4881.0 4884.0 5787.5 5833.4 5854.2 5945.4 5950.9 1462.7 1482.3 1488.7 1491.0 1491.0 891.6 932.4 939.0 949.0 958.9 4968.4 5001.9 5086.3 5104.2 5133.7 5287.5 5313.3 5351.4 5379.8 5408.4 4998.6 5021.3 5128.9 5376.0 5795.3 3202.3 3222.9 3243.7 3247.5 3295.6 6039.4 6246.5 6288.6 6319.5 6349.6 6083.2 6117.9 6120.2 6128.7 6144.8 6229.6 6293.8 6295.9 6298.5 6303.8 5796.2 6009.4 6042.4 6046.7 6052.8 5939.4 5971.7 5974.8 5980.4 6032.6 5949.8 6169.5 6247.7 6253.4 6277.7 3898.7 4003.2 4130.6 4130.9 4139.7 5928.2 5956.7 5973.9 5994.7 6011.4 5655.2 5666.0 5800.6 5850.9 5851.7 5750.8 5771.3 5790.4 5796.2 5799.2 5698.8 5719.7 5731.3 5736.4 5792.5 5722.8 5805.1 5806.8 5876.6 5879.4 5655.7 5756.4 5766.6 5774.7 5787.7 18:37:32 INFO - PROCESS | 9209 | 18:37:32 INFO - PROCESS | 9209 | [#5] yui.html Cycles:180 Average:20516.28 Median:4631.97 stddev:29863.02 (644.7%) stddev-sans-first:29909.87 18:37:32 INFO - PROCESS | 9209 | Values: 740.9 761.1 832.4 842.9 846.1 14369.8 14842.4 14877.6 14933.6 14934.9 14939.9 15145.2 15207.3 15254.2 15302.7 654.5 787.6 787.7 811.3 814.2 802.6 811.4 812.2 814.0 816.0 863.3 864.7 867.8 868.4 869.2 858.9 860.6 864.0 864.1 865.3 631.4 637.0 637.3 637.6 639.1 14874.9 14976.9 14984.1 15063.5 15088.2 15147.2 15206.4 15245.2 15404.3 15451.8 12588.7 12638.7 12695.4 12851.4 12980.2 3979.3 4026.3 4137.5 4196.8 4198.6 80997.0 81782.0 83877.6 85043.6 85133.6 10063.2 10142.3 10307.4 10655.8 12224.2 19998.0 20543.8 20579.0 21400.7 21525.5 8175.6 8293.5 8816.6 8852.1 8930.0 4899.9 4924.0 4968.8 5005.7 5014.3 3471.5 3563.6 3573.7 3588.0 3599.3 637.2 639.8 642.0 673.9 678.2 611.1 634.5 696.1 731.9 739.8 9306.2 9962.9 10216.9 10278.1 10344.7 611.7 629.1 667.9 675.5 739.2 4397.6 4866.3 4905.2 4907.6 4932.8 69829.0 117976.4 118055.4 118462.4 122461.4 64750.7 102460.0 103007.0 104809.0 107082.0 59532.7 59927.7 91796.0 92109.5 95308.0 9045.0 9195.0 9196.8 9418.8 9469.8 51213.0 51449.0 52009.0 53049.0 53441.2 60706.4 79072.0 79748.6 80804.0 80914.0 11458.8 11794.5 11875.9 12010.7 12103.5 12382.4 12619.7 12814.4 13020.4 13422.0 12137.0 12480.6 12550.4 13028.6 13039.2 12482.3 12710.9 13263.8 13653.7 13733.2 12692.9 12784.0 13010.9 13312.1 13384.7 10241.5 10473.5 10549.3 10596.4 10662.8 9316.5 10761.5 10844.7 10882.3 11153.6 18:37:32 INFO - PROCESS | 9209 | -------- Summary: end -------- 18:37:32 INFO - PROCESS | 9209 | 18:37:33 INFO - TEST-INFO | 9209: exit 0 18:37:33 INFO - TEST-OK | dromaeo_css | took 1111536ms 18:37:33 INFO - TEST-START | kraken 18:37:33 INFO - operating with platform_type : linux_ 18:37:33 INFO - Initialising browser for kraken test... 18:37:33 INFO - TEST-INFO | started process 9457 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGhvFt/profile http://localhost:56641/getInfo.html) 18:37:36 INFO - PROCESS | 9457 | JavaScript error: , line 0: uncaught exception: undefined 18:37:37 INFO - PROCESS | 9457 | __metrics Screen width/height:1600/1200 18:37:37 INFO - PROCESS | 9457 | colorDepth:24 18:37:37 INFO - PROCESS | 9457 | Browser inner width/height: 1024/697 18:37:37 INFO - PROCESS | 9457 | __metrics 18:37:38 ERROR - PROCESS | 9457 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:37:38 INFO - TEST-INFO | 9457: exit 0 18:37:38 INFO - Browser initialized. 18:37:38 INFO - Running cycle 1/1 for kraken test... 18:37:38 INFO - TEST-INFO | started process 9575 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGhvFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:37:50 INFO - PROCESS | 9575 | RSS: Main: 167706624 18:37:50 INFO - PROCESS | 9575 | 18:37:53 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56641/tests/kraken/driver.html?testName=audio-beat-detection) 18:37:54 INFO - PROCESS | 9575 | RSS: Main: 173346816 18:37:54 INFO - PROCESS | 9575 | 18:37:56 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56641/tests/kraken/driver.html?testName=audio-dft) 18:37:57 INFO - PROCESS | 9575 | RSS: Main: 171954176 18:37:57 INFO - PROCESS | 9575 | 18:38:00 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56641/tests/kraken/driver.html?testName=audio-fft) 18:38:00 INFO - PROCESS | 9575 | RSS: Main: 168001536 18:38:00 INFO - PROCESS | 9575 | 18:38:03 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56641/tests/kraken/driver.html?testName=audio-oscillator) 18:38:03 INFO - PROCESS | 9575 | RSS: Main: 169291776 18:38:03 INFO - PROCESS | 9575 | 18:38:05 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:38:06 INFO - PROCESS | 9575 | RSS: Main: 169603072 18:38:06 INFO - PROCESS | 9575 | 18:38:09 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56641/tests/kraken/driver.html?testName=imaging-darkroom) 18:38:10 INFO - PROCESS | 9575 | RSS: Main: 169209856 18:38:10 INFO - PROCESS | 9575 | 18:38:13 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56641/tests/kraken/driver.html?testName=imaging-desaturate) 18:38:14 INFO - PROCESS | 9575 | RSS: Main: 170323968 18:38:14 INFO - PROCESS | 9575 | 18:38:17 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56641/tests/kraken/driver.html?testName=json-parse-financial) 18:38:17 INFO - PROCESS | 9575 | RSS: Main: 170250240 18:38:17 INFO - PROCESS | 9575 | 18:38:19 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:38:20 INFO - PROCESS | 9575 | RSS: Main: 169914368 18:38:20 INFO - PROCESS | 9575 | 18:38:21 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:38:22 INFO - PROCESS | 9575 | RSS: Main: 170360832 18:38:22 INFO - PROCESS | 9575 | 18:38:24 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:38:25 INFO - PROCESS | 9575 | RSS: Main: 170274816 18:38:25 INFO - PROCESS | 9575 | 18:38:27 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:38:28 INFO - PROCESS | 9575 | RSS: Main: 171261952 18:38:28 INFO - PROCESS | 9575 | 18:38:31 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:38:31 INFO - PROCESS | 9575 | RSS: Main: 170889216 18:38:31 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | Cycle 1(1): loaded http://localhost:56641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56641/tests/kraken/driver.html?testName=ai-astar) 18:38:33 INFO - PROCESS | 9575 | RSS: Main: 171167744 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | __start_tp_report 18:38:33 INFO - PROCESS | 9575 | _x_x_mozilla_page_load 18:38:33 INFO - PROCESS | 9575 | _x_x_mozilla_page_load_details 18:38:33 INFO - PROCESS | 9575 | |i|pagename|runs| 18:38:33 INFO - PROCESS | 9575 | |0;ai-astar;102;112;106;111;112;112;115;111;111;112 18:38:33 INFO - PROCESS | 9575 | |1;audio-beat-detection;154;123;148;190;121;146;152;128;180;119 18:38:33 INFO - PROCESS | 9575 | |2;audio-dft;167;163;161;162;162;167;174;164;163;161 18:38:33 INFO - PROCESS | 9575 | |3;audio-fft;74;75;78;166;76;77;77;76;168;75 18:38:33 INFO - PROCESS | 9575 | |4;audio-oscillator;84;83;149;84;85;89;151;84;84;143 18:38:33 INFO - PROCESS | 9575 | |5;imaging-gaussian-blur;117;117;118;117;118;122;118;117;118;117 18:38:33 INFO - PROCESS | 9575 | |6;imaging-darkroom;147;147;148;147;149;147;146;146;147;146 18:38:33 INFO - PROCESS | 9575 | |7;imaging-desaturate;95;98;96;95;96;96;96;101;96;96 18:38:33 INFO - PROCESS | 9575 | |8;json-parse-financial;54;54;56;53;56;53;55;54;55;58 18:38:33 INFO - PROCESS | 9575 | |9;json-stringify-tinderbox;62;63;63;63;63;63;62;62;63;63 18:38:33 INFO - PROCESS | 9575 | |10;stanford-crypto-aes;78;77;77;78;79;77;76;77;82;77 18:38:33 INFO - PROCESS | 9575 | |11;stanford-crypto-ccm;135;131;126;125;128;121;122;134;158;124 18:38:33 INFO - PROCESS | 9575 | |12;stanford-crypto-pbkdf2;162;159;162;159;158;158;166;166;159;156 18:38:33 INFO - PROCESS | 9575 | |13;stanford-crypto-sha256-iterative;63;64;63;68;62;63;63;62;63;63 18:38:33 INFO - PROCESS | 9575 | __end_tp_report 18:38:33 INFO - PROCESS | 9575 | __start_cc_report 18:38:33 INFO - PROCESS | 9575 | _x_x_mozilla_cycle_collect,933 18:38:33 INFO - PROCESS | 9575 | __end_cc_report 18:38:33 INFO - PROCESS | 9575 | __startTimestamp1469151513756__endTimestamp 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | ------- Summary: start ------- 18:38:33 INFO - PROCESS | 9575 | Number of tests: 14 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.69 (3.3%) stddev-sans-first:2.35 18:38:33 INFO - PROCESS | 9575 | Values: 102.0 112.0 106.0 111.0 112.0 112.0 115.0 111.0 111.0 112.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:150.00 stddev:24.50 (16.3%) stddev-sans-first:25.82 18:38:33 INFO - PROCESS | 9575 | Values: 154.0 123.0 148.0 190.0 121.0 146.0 152.0 128.0 180.0 119.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.01 (2.4%) stddev-sans-first:4.14 18:38:33 INFO - PROCESS | 9575 | Values: 167.0 163.0 161.0 162.0 162.0 167.0 174.0 164.0 163.0 161.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:38.39 (50.5%) stddev-sans-first:40.02 18:38:33 INFO - PROCESS | 9575 | Values: 74.0 75.0 78.0 166.0 76.0 77.0 77.0 76.0 168.0 75.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.00 stddev:30.51 (36.3%) stddev-sans-first:31.53 18:38:33 INFO - PROCESS | 9575 | Values: 84.0 83.0 149.0 84.0 85.0 89.0 151.0 84.0 84.0 143.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 18:38:33 INFO - PROCESS | 9575 | Values: 117.0 117.0 118.0 117.0 118.0 122.0 118.0 117.0 118.0 117.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 18:38:33 INFO - PROCESS | 9575 | Values: 147.0 147.0 148.0 147.0 149.0 147.0 146.0 146.0 147.0 146.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.78 (1.9%) stddev-sans-first:1.80 18:38:33 INFO - PROCESS | 9575 | Values: 95.0 98.0 96.0 95.0 96.0 96.0 96.0 101.0 96.0 96.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.55 (2.8%) stddev-sans-first:1.62 18:38:33 INFO - PROCESS | 9575 | Values: 54.0 54.0 56.0 53.0 56.0 53.0 55.0 54.0 55.0 58.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 18:38:33 INFO - PROCESS | 9575 | Values: 62.0 63.0 63.0 63.0 63.0 63.0 62.0 62.0 63.0 63.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:77.50 stddev:1.69 (2.2%) stddev-sans-first:1.79 18:38:33 INFO - PROCESS | 9575 | Values: 78.0 77.0 77.0 78.0 79.0 77.0 76.0 77.0 82.0 77.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:129.50 stddev:10.80 (8.3%) stddev-sans-first:11.33 18:38:33 INFO - PROCESS | 9575 | Values: 135.0 131.0 126.0 125.0 128.0 121.0 122.0 134.0 158.0 124.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:3.41 (2.1%) stddev-sans-first:3.57 18:38:33 INFO - PROCESS | 9575 | Values: 162.0 159.0 162.0 159.0 158.0 158.0 166.0 166.0 159.0 156.0 18:38:33 INFO - PROCESS | 9575 | 18:38:33 INFO - PROCESS | 9575 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:1.71 (2.7%) stddev-sans-first:1.81 18:38:33 INFO - PROCESS | 9575 | Values: 63.0 64.0 63.0 68.0 62.0 63.0 63.0 62.0 63.0 63.0 18:38:33 INFO - PROCESS | 9575 | -------- Summary: end -------- 18:38:33 INFO - PROCESS | 9575 | 18:38:34 INFO - TEST-INFO | 9575: exit 0 18:38:34 INFO - TEST-OK | kraken | took 61686ms 18:38:34 INFO - SUITE-END | took 1173s 18:38:34 INFO - Completed test suite (00:19:33) 18:38:34 INFO - javascript benchmark 18:38:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7303.089313220385, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.3229889424324, 3119.064280715786, 3131.358071595323, 3140.2934339773556, 3143.669914658962, 5396.379416367119, 5411.0530657135, 5460.726963651817, 5510.256115424427, 5603.439656034395, 5344.706041167734, 5358.410574836765, 5364.517193452589, 5427.728613569326, 5435.864103397417, 4844.685095468801, 4877.585405240558, 4901.411830580318, 5003.649744517885, 5006.97496512517, 4895.657303988704, 5026.5727413169925, 5029.798808047673, 5049.444561098277, 5100.311457953185, 4884.902301953976, 4907.730074845882, 5005.0, 5031.723255220962, 5084.0, 4991.925121123186, 4999.675021123651, 5003.54968052877, 5019.498050194988, 5032.521910418504, 4925.507449255082, 4939.925901111486, 4941.7034977901085, 4960.776765045582, 4990.226514890198, 5382.085045542228, 5427.511523962823, 5438.45615438453, 5442.809501667422, 5494.890102197974, 5850.64896106235, 5850.824475265749, 5857.414258574151, 5874.118882167666, 5906.940930590725, 5911.054231323011, 5917.822465326047, 5918.556108291852, 5920.259967504062, 5924.674142922137, 5280.788768449257, 5412.052890744104, 5430.185472179126, 5431.646942948656, 5499.835004949858, 5993.190919225936, 5999.640021598718, 6004.0, 6019.337872833985, 6026.0, 5759.568032397587, 5762.596618236683, 5763.971180144156, 5769.1634712967225, 5771.480566749013, 5689.203511508392, 5748.770049197985, 5769.336526299446, 5771.85570360736, 5859.912101318484, 5601.243832082617, 5693.4875861172695, 5760.107183386582, 5835.4748072673665, 5867.354590994987, 5799.18811366409, 5841.970790146022, 5864.179014937912, 5872.823815285548, 5893.174955506232, 4345.869623911224, 4410.845620403271, 4435.512093669694, 4438.511763705989, 4461.107778444324, 3884.7863367515056, 3980.482537270136, 4005.799710014546, 4013.3779264214095, 4024.335984562573, 5611.102223644198, 5614.466625670637, 5652.208690783294, 5664.97167514168, 5702.714864256854, 5781.306243250837, 5933.495652869468, 5936.554758393051, 5939.465448109604, 5949.583529153005, 5509.283793106871, 5537.640053396516, 5560.582956278296, 5589.8602534936135, 5645.802396916089, 4935.827246046371, 5030.0, 5032.370953630796, 5033.6224783141415, 5050.292958985745, 5840.883182336414, 5990.850228744229, 5998.790042348497, 6006.609570377911, 6028.0, 5801.6519008859605, 5828.562857785768, 5849.707514624337, 5949.196858424058, 5982.371850955587, 6059.787907423219, 6098.969505152446, 6109.75560977556, 6114.205153330038, 6125.448709616156, 5716.399778023248, 5750.30996280449, 5807.128930660266, 5807.506361959281, 5815.156802263564, 5799.362070172362, 5829.854253643693, 5835.328937172279, 5896.970515147397, 5937.228160339128, 5702.287214098238, 5738.454846789548, 5747.339056008613, 5753.309602847685, 5753.3958934311295, 5573.8606534835335, 5723.685197314021, 5724.198612194379, 5744.712764361849, 5753.1370294456165, 5616.382197958303, 5648.774049037993, 5682.289713785777, 5723.484886360247, 5728.026235540052, 5753.71231438418, 5777.3356064051495, 5787.479126878433, 5805.274340707411, 5807.361190268983, 5465.480779325958, 5471.480209380103, 5650.152477128464, 5667.291588551431, 5684.204211410323], "value": 5389.688438938141, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.9860753481163, 598.9790357337491, 604.7278724573941, 613.9593389205297, 635.7552342348195, 39565.4065189022, 43278.0, 43311.56688433119, 43322.35016474756, 43367.78316108415, 44048.55951440485, 44511.0, 44553.77723111388, 44559.55440445594, 44649.330260046125, 9031.503267320295, 9031.909680903189, 9116.772080698003, 9127.497987610679, 9195.678151264707, 8983.640654373818, 9102.317326200528, 9168.679096231634, 9171.312151588625, 9217.124373184537, 9198.540072996357, 9205.493697846616, 9267.44395336282, 9270.304727145458, 9275.72172834816, 9120.042395548438, 9212.815743685122, 9216.40093393934, 9223.21602663771, 9224.907750922472, 9010.819783604291, 9045.3668243223, 9069.546522673905, 9082.77293067672, 9083.500407477586, 41185.79407102945, 41192.1761564767, 41646.37530437046, 41658.583414166074, 41770.373444398356, 3153.6057992750907, 3199.63204231514, 3645.54430696163, 3817.522809648794, 3936.9015774605577, 32668.4064752877, 33131.17172070693, 33490.49764253538, 34197.14507137317, 34587.82706086453, 4329.480462344539, 4333.619266259763, 4390.209762242795, 4392.670549708752, 4592.586667199935, 374273.0, 375554.0, 375831.12084439676, 376366.0, 377382.0, 62235.6888215556, 62345.32410069172, 62661.0, 62727.37272627215, 62755.09693933664, 66417.0, 66549.33450665529, 66708.0, 66717.0, 66858.66570667115, 16450.506484805475, 16932.407365742387, 17027.233774480177, 17298.394556190473, 17305.13474326304, 13252.536161234311, 13505.32473376347, 13507.459701611826, 13515.459381624822, 13520.121192122677, 20177.293794717116, 20306.0, 20335.898320508302, 20419.489512762004, 20491.59016819685, 7305.8447757911545, 7364.594947277844, 7364.889526657104, 7562.886556701654, 7581.50720203185, 959.7840485890619, 997.9351342162736, 1036.9066783989326, 1117.0951529261324, 1124.2692250037542, 33463.498047529305, 33838.49242261368, 34111.488327675106, 34131.31737365239, 34182.0, 994.3685759542742, 1060.750723579958, 1122.2088427658482, 1191.1304747534348, 1197.6646538969103, 15792.289346979414, 16957.745633815503, 17018.48944531666, 17107.48677539676, 17127.229274682668, 610184.0, 613553.0, 614318.0, 615708.0, 615889.0, 60827.0, 60948.08577871336, 61749.0, 61758.69120654458, 61761.0, 1332.413737955316, 1362.6933939863452, 1378.3797291218991, 1390.8122403475604, 1403.7997512127188, 29966.016688144686, 32171.0, 32242.193945151557, 32272.0, 32276.83861580771, 52750.2087468696, 52834.47165528449, 52906.2064069047, 53017.879284828174, 53083.20375194452, 486970.0, 487357.0, 490471.0, 490614.0, 491623.0, 28992.275193120342, 29438.0, 29492.55761163627, 29578.408431831675, 29581.704182957896, 49108.508914910395, 50255.246171308194, 50660.493395065576, 51346.22980655368, 51438.22842657288, 41928.790356048026, 42406.78796605997, 43067.0, 43273.0, 44570.77714611406, 42117.78941105275, 43429.348559770995, 43643.66952949741, 43913.34129987989, 44208.68434867462, 39136.2172756549, 41031.17937641171, 42842.57157428386, 43163.0, 45087.774561126986, 33689.32621347608, 39094.609053909095, 39113.0, 39354.60645393509, 40043.599564003984, 28723.0, 28759.0, 29084.563731544466, 29251.26871828136, 29358.0], "value": 20875.146307646955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8547117475074, 360.74567429961877, 377.1664621187177, 377.18716166660846, 393.3627523412073, 18071.36750213743, 19962.101705423254, 19991.700124498144, 20668.689969650448, 20754.169833206655, 17978.640427191447, 18614.906925465388, 19088.141033653483, 19614.313499027536, 19624.60750784987, 5200.115980283352, 5318.734063296839, 5353.170258609902, 5353.464653534655, 5749.885002299972, 5785.103308987113, 5855.209546711182, 5857.794977175799, 5858.677772722499, 5860.912086318709, 5730.7421166047625, 5752.626079304852, 5802.622829516089, 5850.4734573888345, 5852.385499522553, 5710.114932185518, 5808.273965754281, 5825.796097136601, 5858.150568167634, 5871.500922421599, 5015.172496538067, 5077.2637967494875, 5125.948740512585, 5193.37679478465, 5198.298229738974, 12924.159929604639, 12941.611751647466, 13042.674118099918, 13105.0, 13114.868851311556, 2245.9887700561394, 2311.1217737259904, 2377.9524409511887, 2441.865697386643, 2796.846173460459, 9257.814843703156, 9466.0, 9609.663661771874, 10074.798504029879, 10116.08955194036, 1890.5273681579606, 1994.8703334283225, 2009.4976255936017, 2030.2995466564012, 2054.815066644009, 84514.0, 85364.57317713434, 85650.75081827973, 86098.0, 87539.0, 10882.61910833117, 10906.781864362669, 11176.720581985515, 11293.71765705864, 11432.828507572392, 15410.768838467431, 15417.306221219847, 15461.613459663598, 15476.071435713668, 15481.380744770084, 8191.836163276701, 8367.874481882776, 8387.329013679013, 8447.311741983136, 8608.612612432456, 8172.591370431454, 8223.54770487629, 8453.281471074904, 8484.0, 8534.103919088531, 4364.498082720528, 4448.733076015449, 4635.351050852883, 4754.904901901942, 4803.471618122004, 1869.270745015114, 1975.901204939776, 1987.0958713785194, 2028.8884111374016, 2073.1603700501323, 931.9301052421096, 971.1842052675786, 1011.4386515483977, 1012.9848052279222, 1040.552562398176, 19683.409497714805, 19751.60496790085, 19884.50288742793, 20058.39824805258, 20279.493012674506, 1000.8548760429696, 1007.652359935821, 1017.7811770469384, 1034.3690348887174, 1052.2686732720686, 10730.248882578144, 10846.67459976202, 10869.239153259196, 11126.499307531181, 11192.496337664661, 426728.0, 432020.0, 437136.0, 542509.0, 548125.0, 62896.0, 73538.26461735422, 80705.0, 98446.0, 102808.0, 988.081084591337, 1005.4972513743129, 1019.5785010599825, 1021.9080282774586, 1035.6691651228136, 17016.744748829024, 17017.0, 17932.91033544824, 17975.0, 18189.54526136857, 39505.0, 41473.79263103665, 42874.0, 42987.0, 43710.344344834215, 55228.723856380464, 59446.70276648762, 61099.69450152721, 62248.086431788906, 62778.68610656918, 6853.931460685529, 7328.34044935937, 7385.9630701846145, 7563.584002879675, 7942.285194332538, 11130.721731956766, 12688.17526860751, 12746.745065098832, 12982.221066736027, 13178.275194864374, 11242.718932026437, 11338.659840204808, 11361.318320900773, 11555.537778488766, 11733.471993760131, 11161.330320180816, 11175.441227938732, 11259.605913792979, 11602.593909213138, 11605.129615278718, 5891.94108058931, 8262.83474330522, 11254.606088786853, 11426.657200284004, 11473.655790326304, 7246.202917678946, 7324.780256592311, 7421.591812450151, 7485.251474852471, 7558.924410756042, 10939.617113400993, 11307.943460282646, 11484.0, 11599.88400115988, 11705.122115841516], "value": 8939.760169871493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.1834807375205, 1379.124256097378, 1379.5171689908534, 1735.158448152645, 1802.297104129389, 7693.846123077535, 8376.874346884802, 8506.74479765608, 8896.11038896111, 8909.68816091437, 8502.362322825782, 8831.955840220806, 8852.0, 8856.51289179095, 8893.555322233895, 2345.589521833681, 2378.9048438062455, 2387.0451819272257, 2388.0567175965484, 2398.268528098929, 2328.5459335429596, 2377.762223777626, 2398.2925037114005, 2398.292503711409, 2400.9159679411223, 2360.0677732295735, 2372.1697405907967, 2386.2006227913585, 2391.5216956608747, 2394.736578976311, 2334.789868911789, 2339.894704738291, 2370.8814559272055, 2379.5954687703133, 2386.1886958434216, 2258.2096266306826, 2261.796438320559, 2264.79616834484, 2279.726432828055, 2281.1559722902634, 8808.779780505474, 8900.73297801067, 8914.37599368038, 8918.73243802687, 8960.551972401354, 5151.536361727425, 5259.737013149327, 5284.154535274338, 5310.575153987672, 5316.680999140025, 3403.3533628610485, 3470.7917524948584, 3475.2528206435736, 3498.7900725956524, 3559.911002224965, 1133.2747041893194, 1138.9487473063732, 1156.7570810129882, 1163.2322667039714, 1169.7485040716288, 11925.165238433314, 11937.701557461047, 12012.459439325165, 12058.397080145958, 12097.818532722016, 4500.774961251925, 4659.557342052567, 4747.477777444478, 4792.520747925179, 4798.856034318976, 10339.793204136025, 10382.948085259526, 10400.843987340197, 10418.479076046167, 10428.687139385831, 5271.103912334912, 5286.947130528645, 5295.258663787073, 5303.628745987821, 5317.069512835315, 4221.387898754663, 4683.578477937002, 4732.1718699227495, 4775.546323099369, 4892.266160075946, 3958.6437220650278, 4024.1348110155873, 4065.918681626351, 4152.667786577066, 4155.563665815106, 1314.2508770001198, 1345.905786594929, 1359.306753555674, 1360.4966162519734, 1368.404743936371, 848.7665891879659, 997.3816233935007, 1009.7627057641448, 1016.4511163971521, 1027.6660085472251, 5883.382244864313, 6028.397160284024, 6050.969745151246, 6136.570440069152, 6192.318844927055, 441.28952386657454, 444.51103785835323, 447.90370070434363, 448.652294471787, 454.8408057180027, 4267.103908179317, 4302.315178385036, 4311.9784401077795, 4387.451568553931, 4414.668899832525, 10645.680629581126, 10894.455277236106, 10963.56145754177, 10968.616098436676, 10997.670069897917, 10762.78474430507, 10849.67450976472, 10856.837147442795, 10873.673789786319, 10900.1279897608, 7755.487679902478, 8066.838663226703, 8119.147489513516, 8145.918540814635, 8258.174182581693, 6039.396060393926, 6185.659788711664, 6267.874642507216, 6323.525735569942, 6429.132067170872, 9932.801343972935, 10046.497675116068, 10238.846417303597, 10248.282620216512, 10256.487175641338, 10188.286819922534, 10212.795744085226, 10230.335028223439, 10339.431331276852, 10381.532831022772, 6901.275366086488, 7437.479376443597, 7552.0, 7725.459217854696, 7844.058712954482, 8522.829543409222, 8531.146885311418, 8562.871556926775, 8575.571221439028, 8580.485170889766, 7658.693652253847, 7738.2261773822165, 7861.1352751198465, 8000.319972802145, 8043.115257321807, 7589.772306830804, 7660.387169026576, 7689.423293252917, 7759.92240077592, 7895.092064412436, 6959.130108736408, 7070.469714771516, 7072.752453664097, 7073.893891591733, 7087.255838136922, 5152.922706159486, 5198.194279886472, 5289.391719952255, 5300.2049692546425, 5488.588355873246, 5292.550133238564, 5311.787528498817, 5391.353037635352, 5438.6192966493545, 5477.589180811376], "value": 4592.409065885022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8968805762011, 304.8262490380484, 325.175679652082, 328.24994886683925, 330.482794426722, 5438.646487978289, 5497.8075767348155, 5563.36021357544, 5666.914996275054, 5671.914921276184, 5476.808311709091, 5502.367227768807, 5522.0, 5529.612927095105, 5532.585056120787, 4323.675724320673, 4330.358481326389, 4342.891427714301, 4373.540778218289, 4378.584034516732, 4117.0, 4287.957120428802, 4321.2653848845775, 4380.904773806548, 4382.517923028464, 4251.2135254977775, 4255.702100852942, 4260.936085958713, 4263.424437700917, 4267.679924005696, 4268.1890440816305, 4280.700350975433, 4314.266574682311, 4323.567643235683, 4336.0, 3524.9823750881337, 3794.146317078663, 3802.3535998880257, 3807.8286477108595, 3813.237352529505, 5403.7027963462, 5420.186971954199, 5429.592780541475, 5441.755121019563, 5448.782048718046, 4921.163402221631, 4925.950740492585, 4931.728754918478, 4932.506749325039, 4943.283223932545, 5574.470425309589, 5782.508486778629, 5851.4148585141575, 5851.736671849777, 5862.765489380419, 4108.958910410887, 4112.444819949328, 4119.958800412018, 4129.834806607732, 4153.273177194009, 6100.45095941363, 6112.572119951606, 6123.4488895999575, 6147.477464415575, 6177.598456100339, 4116.711830171919, 4119.485064366954, 4163.271427500236, 4245.745255284693, 4249.150169966019, 4188.748675079505, 4195.748255104703, 4196.223698615766, 4204.138151678899, 4208.6633069354375, 4845.6608037437745, 4871.269309603588, 4879.512048795092, 4880.951190488121, 4884.0, 5787.498563369185, 5833.358330583633, 5854.18041474194, 5945.435183657545, 5950.9107363389585, 1462.656275775192, 1482.2514630111941, 1488.6501672107047, 1490.9776353354707, 1490.9776353354707, 891.5898686604105, 932.421898422982, 938.9953050234706, 948.9572969216401, 958.942463452195, 4968.416423459853, 5001.924971125436, 5086.287919691246, 5104.2343648453025, 5133.743312834344, 5287.4930644766055, 5313.343328335832, 5351.394581625496, 5379.757910894019, 5408.3509978802795, 4998.625103117281, 5021.322121513549, 5128.9230661540105, 5375.973120134374, 5795.33353664334, 3202.343519578481, 3222.9194270143435, 3243.6756324367375, 3247.5386076265777, 3295.5715756951445, 6039.391672899526, 6246.500279977591, 6288.591241569284, 6319.46284565817, 6349.587276826992, 6083.239595050619, 6117.938820611737, 6120.1737765401995, 6128.662923539159, 6144.754209831557, 6229.595076320024, 6293.842653933688, 6295.905561416583, 6298.464630506458, 6303.810885673437, 5796.246487956539, 6009.36901625323, 6042.3655516170165, 6046.667433291212, 6052.84867878289, 5939.376365481562, 5971.701414929149, 5974.761009559743, 5980.43185897339, 6032.607880487754, 5949.78029503942, 6169.537284703575, 6247.656378899204, 6253.374662533893, 6277.717502712298, 3898.7270891037356, 4003.1593365392428, 4130.586941305845, 4130.938035929524, 4139.730917490354, 5928.199693041384, 5956.731947062306, 5973.880522389615, 5994.730237139252, 6011.368806275278, 5655.208270842168, 5666.03677374839, 5800.59395842287, 5850.853728656818, 5851.678157701367, 5750.827475175752, 5771.336296325976, 5790.449907258803, 5796.217510636179, 5799.246098007232, 5698.8290351289525, 5719.742611582572, 5731.312242530923, 5736.42635736423, 5792.53659707214, 5722.828315150552, 5805.068440437721, 5806.767729290781, 5876.588638795414, 5879.353271140257, 5655.660660360391, 5756.395578464369, 5766.5675074368755, 5774.682392468455, 5787.7395517200985], "value": 4386.219336825457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.9444291678126, 761.0676920772055, 832.3965125284169, 842.9409941304108, 846.0608724316004, 14369.784453233196, 14842.406303747865, 14877.62805929851, 14933.5519934402, 14934.925325373359, 14939.850601493981, 15145.242737863091, 15207.315670794813, 15254.237288135577, 15302.693946121071, 654.4731491149622, 787.5629025890643, 787.6927998080753, 811.3063330852125, 814.222417591202, 802.5987006496752, 811.4036183405193, 812.2040400407575, 814.0191069760924, 815.9673613055471, 863.3309185381348, 864.7016779211193, 867.761365624452, 868.3964644572025, 869.2090197919894, 858.9226969572705, 860.561113831944, 864.0322838420977, 864.1444969480232, 865.2688478235912, 631.3749388105788, 637.0285314894776, 637.2703254773259, 637.5505268785495, 639.0510092512615, 14874.851251487564, 14976.925115374353, 14984.100953942798, 15063.54809355721, 15088.17015064182, 15147.166905820175, 15206.391744330214, 15245.23773811305, 15404.306806193748, 15451.768223476656, 12588.748225035539, 12638.747225055447, 12695.365231738468, 12851.35743212845, 12980.221186728826, 3979.283728928792, 4026.255142798592, 4137.54487006429, 4196.769177695225, 4198.580141985777, 80997.0, 81781.9999999994, 83877.58061209715, 85043.5747821263, 85133.57433212794, 10063.200530744736, 10142.340747851365, 10307.381557106597, 10655.84016239757, 12224.205426647239, 19998.0, 20543.79456205449, 20579.0, 21400.678989814853, 21525.461863453227, 8175.5503447309775, 8293.460925039853, 8816.647334106563, 8852.114788521225, 8929.955350223207, 4899.902001959941, 4923.975380123076, 4968.801247950114, 5005.72468514228, 5014.272930425068, 3471.5139880416764, 3563.590187128513, 3573.6783689468075, 3588.0, 3599.280143971216, 637.1557686065981, 639.8144538083997, 641.9518536109811, 673.8753330633848, 678.1963373402534, 611.1108337369117, 634.5431289471574, 696.1298377028714, 731.9231480694557, 739.8298391369907, 9306.208972237435, 9962.900370996198, 10216.948915255376, 10278.126359259546, 10344.741381465523, 611.729946510815, 629.0532748213909, 667.8597494526107, 675.5170053411834, 739.2422766664213, 4397.626201772821, 4866.31871537985, 4905.190643543775, 4907.582855457326, 4932.827351042696, 69829.0, 117976.41011794886, 118055.40972295083, 118462.40768796101, 122461.38769306097, 64750.676246619405, 102460.0, 103007.0, 104809.0, 107082.0, 59532.70233648804, 59927.700361498784, 91796.0, 92109.53945230365, 95308.0, 9044.954775226082, 9194.97802762367, 9196.816063678556, 9418.764530886783, 9469.810603787748, 51212.97574048424, 51449.0, 52009.0, 53049.0, 53441.198382023525, 60706.39293607184, 79072.0, 79748.60125699334, 80804.0, 80914.0, 11458.770824583295, 11794.52821887115, 11875.940620296844, 12010.699732506408, 12103.515859365527, 12382.442790074649, 12619.747605047663, 12814.359282035675, 13020.414081366172, 13422.0, 12137.0, 12480.563180288646, 12550.435230414836, 13028.609141725763, 13039.217646940835, 12482.313472759086, 12710.910015048807, 13263.80104298417, 13653.689964273839, 13733.176009439465, 12692.936535317263, 12784.0, 13010.934945325213, 13312.06815522904, 13384.732305354033, 10241.487925603838, 10473.528691208761, 10549.261551691616, 10596.417197054236, 10662.8400573993, 9316.534173291444, 10761.515731791931, 10844.728881778019, 10882.347059176474, 11153.609623663133], "value": 7487.640295837757, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 111.0, 112.0, 112.0, 115.0, 111.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 148.0, 190.0, 121.0, 146.0, 152.0, 128.0, 180.0, 119.0], "value": 146.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 161.0, 162.0, 162.0, 167.0, 174.0, 164.0, 163.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 78.0, 166.0, 76.0, 77.0, 77.0, 76.0, 168.0, 75.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 149.0, 84.0, 85.0, 89.0, 151.0, 84.0, 84.0, 143.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 122.0, 118.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 149.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 96.0, 95.0, 96.0, 96.0, 96.0, 101.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 53.0, 56.0, 53.0, 55.0, 54.0, 55.0, 58.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 78.0, 79.0, 77.0, 76.0, 77.0, 82.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 126.0, 125.0, 128.0, 121.0, 122.0, 134.0, 158.0, 124.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 159.0, 158.0, 158.0, 166.0, 166.0, 159.0, 156.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 68.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0], "value": 63.4, "unit": "score"}]}]} 18:38:35 INFO - Return code: 0 18:38:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:38:35 ERROR - # TBPL SUCCESS # 18:38:35 INFO - Running post-action listener: _resource_record_post_action 18:38:35 INFO - [mozharness: 2016-07-22 01:38:35.059450Z] Finished run-tests step (success) 18:38:35 INFO - Running post-run listener: _resource_record_post_run 18:38:35 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 554184704; Read time: 236; Write time: 502564 18:38:35 INFO - TinderboxPrint: CPU usage
13.4% 18:38:35 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 236 18:38:35 INFO - TinderboxPrint: I/O write bytes / time
554,184,704 / 502,564 18:38:35 INFO - TinderboxPrint: CPU idle
8,231.8 (86.6%) 18:38:35 INFO - TinderboxPrint: CPU user
1,215.3 (12.8%) 18:38:35 INFO - TinderboxPrint: Swap in / out
0 / 0 18:38:35 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 256925696; Read time: 0; Write time: 251668 18:38:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 297009152; Read time: 236; Write time: 250876 18:38:35 INFO - Running post-run listener: _upload_blobber_files 18:38:35 INFO - Blob upload gear active. 18:38:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:35 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 18:38:35 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'] 18:38:35 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 18:38:36 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:38:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:45 INFO - (blobuploader) - INFO - Done attempting. 18:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:46 INFO - (blobuploader) - INFO - Done attempting. 18:38:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:38:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:47 INFO - (blobuploader) - INFO - Done attempting. 18:38:47 INFO - (blobuploader) - INFO - Iteration through files over. 18:38:47 INFO - Return code: 0 18:38:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:38:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:38:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f008d0725a502b29a59506b34bd897952eda214eacf6207367bc04b52ac14a346034bbcf6161498705551da7b1609ab4657d5ed74d00e231d5fba36bfa191ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3582ad52c2554566efb6e8e0341b3ee3de870f34798398c6810150978e48f4d8e107274dad4ff84b1a7d08cfa4200931e318de5d40bc429bb15e12ad6f3bf450", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceb190dd3e425232dcafb8f54aeeef1246d1a51ad1e688c75832dcc42d38ab378a9df0524a6ec14e7e66263624a60142db686c8c7b8064dbec9ba975941cc9ec"} 18:38:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:38:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:38:47 INFO - Contents: 18:38:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f008d0725a502b29a59506b34bd897952eda214eacf6207367bc04b52ac14a346034bbcf6161498705551da7b1609ab4657d5ed74d00e231d5fba36bfa191ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3582ad52c2554566efb6e8e0341b3ee3de870f34798398c6810150978e48f4d8e107274dad4ff84b1a7d08cfa4200931e318de5d40bc429bb15e12ad6f3bf450", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceb190dd3e425232dcafb8f54aeeef1246d1a51ad1e688c75832dcc42d38ab378a9df0524a6ec14e7e66263624a60142db686c8c7b8064dbec9ba975941cc9ec"} 18:38:47 INFO - Running post-run listener: copy_logs_to_upload_dir 18:38:47 INFO - Copying logs to upload dir... 18:38:47 INFO - mkdir: /builds/slave/test/build/upload/logs 18:38:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.191451 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-07-21 18:38:47.499117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 18:38:47.502650) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368 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/f008d0725a502b29a59506b34bd897952eda214eacf6207367bc04b52ac14a346034bbcf6161498705551da7b1609ab4657d5ed74d00e231d5fba36bfa191ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3582ad52c2554566efb6e8e0341b3ee3de870f34798398c6810150978e48f4d8e107274dad4ff84b1a7d08cfa4200931e318de5d40bc429bb15e12ad6f3bf450", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceb190dd3e425232dcafb8f54aeeef1246d1a51ad1e688c75832dcc42d38ab378a9df0524a6ec14e7e66263624a60142db686c8c7b8064dbec9ba975941cc9ec"} build_url:https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/AvjISu27QlukmQqG8Pgg5g/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/f008d0725a502b29a59506b34bd897952eda214eacf6207367bc04b52ac14a346034bbcf6161498705551da7b1609ab4657d5ed74d00e231d5fba36bfa191ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3582ad52c2554566efb6e8e0341b3ee3de870f34798398c6810150978e48f4d8e107274dad4ff84b1a7d08cfa4200931e318de5d40bc429bb15e12ad6f3bf450", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ceb190dd3e425232dcafb8f54aeeef1246d1a51ad1e688c75832dcc42d38ab378a9df0524a6ec14e7e66263624a60142db686c8c7b8064dbec9ba975941cc9ec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 18:38:47.528076) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:38:47.528419) ========= 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=03627c79f6bb3d1578c4a402000001ba-1469150111.4507-1417936368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 18:38:47.613832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 18:38:47.614134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 18:38:47.614424) ========= ========= Total master_lag: 0.17 =========