builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1472734718.07 results: success (0) buildid: 20160901030202 builduid: 1aa83d850ef94b42a0c108c49d067f4b revision: b7f7ae14590aced450bb0b0469dfb38edd2c0ace ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.068505) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.068940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.069271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.121573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.121884) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 05:58:38-- 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% 21.4M=0.001s 2016-09-01 05:58:38 (21.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131522 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.466592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.466914) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023160 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.534626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:38.534946) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b7f7ae14590aced450bb0b0469dfb38edd2c0ace --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 b7f7ae14590aced450bb0b0469dfb38edd2c0ace --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=337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 05:58:38,651 truncating revision to first 12 chars 2016-09-01 05:58:38,651 Setting DEBUG logging. 2016-09-01 05:58:38,651 attempt 1/10 2016-09-01 05:58:38,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b7f7ae14590a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 05:58:39,017 unpacking tar archive at: mozilla-central-b7f7ae14590a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689711 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:39.241259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:39.241664) ========= script_repo_revision: b7f7ae14590aced450bb0b0469dfb38edd2c0ace ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:39.242235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:39.242504) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:39.252822) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-01 05:58:39.253198) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:39 INFO - MultiFileLogger online at 20160901 05:58:39 in /builds/slave/test 05:58:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:58:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:39 INFO - {'append_to_log': False, 05:58:39 INFO - 'base_work_dir': '/builds/slave/test', 05:58:39 INFO - 'blob_upload_branch': 'Firefox', 05:58:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:39 INFO - 'branch': 'Firefox', 05:58:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:39 INFO - 'config_files': ('talos/linux_config.py',), 05:58:39 INFO - 'default_actions': ('clobber', 05:58:39 INFO - 'read-buildbot-config', 05:58:39 INFO - 'download-and-extract', 05:58:39 INFO - 'populate-webroot', 05:58:39 INFO - 'create-virtualenv', 05:58:39 INFO - 'install', 05:58:39 INFO - 'run-tests'), 05:58:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:39 INFO - 'download_minidump_stackwalk': True, 05:58:39 INFO - 'download_symbols': 'ondemand', 05:58:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:39 INFO - 'installer_path': 'installer.exe', 05:58:39 INFO - 'log_level': 'info', 05:58:39 INFO - 'log_name': 'talos', 05:58:39 INFO - 'log_to_console': True, 05:58:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:39 INFO - 'opt_config_files': (), 05:58:39 INFO - 'pip_index': False, 05:58:39 INFO - 'sps_profile': False, 05:58:39 INFO - 'sps_profile_interval': 0, 05:58:39 INFO - 'suite': 'dromaeojs', 05:58:39 INFO - 'system_bits': '32', 05:58:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:39 INFO - 'title': 'talos-linux64-ix-060', 05:58:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:39 INFO - 'use_talos_json': True, 05:58:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:39 INFO - 'work_dir': 'build'} 05:58:39 INFO - [mozharness: 2016-09-01 12:58:39.458686Z] Running clobber step. 05:58:39 INFO - Running pre-action listener: _resource_record_pre_action 05:58:39 INFO - Running main action method: clobber 05:58:39 INFO - rmtree: /builds/slave/test/build 05:58:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:40 INFO - Running post-action listener: _resource_record_post_action 05:58:40 INFO - [mozharness: 2016-09-01 12:58:40.421239Z] Finished clobber step (success) 05:58:40 INFO - [mozharness: 2016-09-01 12:58:40.421353Z] Running read-buildbot-config step. 05:58:40 INFO - Running pre-action listener: _resource_record_pre_action 05:58:40 INFO - Running main action method: read_buildbot_config 05:58:40 INFO - Using buildbot properties: 05:58:40 INFO - { 05:58:40 INFO - "project": "", 05:58:40 INFO - "product": "firefox", 05:58:40 INFO - "script_repo_revision": "production", 05:58:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:58:40 INFO - "repository": "", 05:58:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:58:40 INFO - "buildid": "20160901030202", 05:58:40 INFO - "stage_platform": "linux64-pgo", 05:58:40 INFO - "basedir": "/builds/slave/test", 05:58:40 INFO - "nightly_build": "True", 05:58:40 INFO - "buildnumber": 556, 05:58:40 INFO - "slavename": "talos-linux64-ix-060", 05:58:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:58:40 INFO - "platform": "ubuntu64_hw", 05:58:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:58:40 INFO - "branch": "mozilla-central", 05:58:40 INFO - "repo_path": "mozilla-central", 05:58:40 INFO - "revision": "b7f7ae14590aced450bb0b0469dfb38edd2c0ace", 05:58:40 INFO - "pgo_build": "True", 05:58:40 INFO - "builduid": "1aa83d850ef94b42a0c108c49d067f4b", 05:58:40 INFO - "slavebuilddir": "test" 05:58:40 INFO - } 05:58:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:58:40 INFO - Running post-action listener: _resource_record_post_action 05:58:40 INFO - [mozharness: 2016-09-01 12:58:40.423953Z] Finished read-buildbot-config step (success) 05:58:40 INFO - [mozharness: 2016-09-01 12:58:40.424077Z] Running download-and-extract step. 05:58:40 INFO - Running pre-action listener: _resource_record_pre_action 05:58:40 INFO - Running main action method: download_and_extract 05:58:40 INFO - mkdir: /builds/slave/test/build/tests 05:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:40 INFO - trying https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:58:40 INFO - Downloaded 1361 bytes. 05:58:40 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:40 INFO - Using the following test package requirements: 05:58:40 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:40 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:40 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:40 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'jsshell-linux-x86_64.zip'], 05:58:40 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:40 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:40 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:40 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:40 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:40 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:40 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:40 INFO - trying https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:41 INFO - Downloaded 21905487 bytes. 05:58:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:58:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:46 INFO - trying https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:46 INFO - Downloading https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:47 INFO - Downloaded 21905487 bytes. 05:58:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 05:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:52 INFO - trying https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:52 INFO - Downloading https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:58:53 INFO - Downloaded 14413998 bytes. 05:58:53 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 05:58:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:53 INFO - trying https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:58:54 INFO - Downloaded 59735967 bytes. 05:58:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:54 INFO - mkdir: /builds/slave/test/properties 05:58:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:54 INFO - Contents: 05:58:54 INFO - build_url:https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:55 INFO - Running post-action listener: _resource_record_post_action 05:58:55 INFO - Running post-action listener: set_extra_try_arguments 05:58:55 INFO - [mozharness: 2016-09-01 12:58:55.491420Z] Finished download-and-extract step (success) 05:58:55 INFO - [mozharness: 2016-09-01 12:58:55.491645Z] Running populate-webroot step. 05:58:55 INFO - Running pre-action listener: _resource_record_pre_action 05:58:55 INFO - Running main action method: populate_webroot 05:58:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:55 INFO - '--tppagecycles', 05:58:55 INFO - '7'], 05:58:55 INFO - 'tests': ['tsvgm']}}, 05:58:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['damp', 'tps']}, 05:58:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'tests': ['damp', 'tps']}, 05:58:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['dromaeo_dom']}, 05:58:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['basic_compositor_video']}, 05:58:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['a11yr', 05:58:55 INFO - 'ts_paint', 05:58:55 INFO - 'tpaint', 05:58:55 INFO - 'sessionrestore', 05:58:55 INFO - 'sessionrestore_no_auto_restore', 05:58:55 INFO - 'tabpaint']}, 05:58:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:55 INFO - 'ts_paint', 05:58:55 INFO - 'tpaint', 05:58:55 INFO - 'sessionrestore', 05:58:55 INFO - 'sessionrestore_no_auto_restore', 05:58:55 INFO - 'tabpaint']}, 05:58:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:55 INFO - 'ts_paint', 05:58:55 INFO - 'tpaint', 05:58:55 INFO - 'sessionrestore', 05:58:55 INFO - 'sessionrestore_no_auto_restore', 05:58:55 INFO - 'tabpaint']}, 05:58:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:55 INFO - 'ts_paint', 05:58:55 INFO - 'tpaint', 05:58:55 INFO - 'sessionrestore', 05:58:55 INFO - 'sessionrestore_no_auto_restore', 05:58:55 INFO - 'tabpaint']}, 05:58:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['a11yr', 05:58:55 INFO - 'ts_paint', 05:58:55 INFO - 'tpaint', 05:58:55 INFO - 'sessionrestore', 05:58:55 INFO - 'sessionrestore_no_auto_restore', 05:58:55 INFO - 'tabpaint']}, 05:58:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['a11yr', 05:58:55 INFO - 'ts_paint', 05:58:55 INFO - 'tpaint', 05:58:55 INFO - 'sessionrestore', 05:58:55 INFO - 'sessionrestore_no_auto_restore', 05:58:55 INFO - 'tabpaint']}, 05:58:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['tsvgx', 05:58:55 INFO - 'tsvgr_opacity', 05:58:55 INFO - 'tart', 05:58:55 INFO - 'tscrollx', 05:58:55 INFO - 'cart']}, 05:58:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:55 INFO - 'tsvgr_opacity', 05:58:55 INFO - 'tart', 05:58:55 INFO - 'tscrollx', 05:58:55 INFO - 'cart']}, 05:58:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'talos_options': ['--disable-e10s'], 05:58:55 INFO - 'tests': ['tp5o']}, 05:58:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'tests': ['tp5o']}, 05:58:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'talos_options': ['--disable-e10s', 05:58:55 INFO - '--xperf_path', 05:58:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:55 INFO - 'tests': ['tp5n']}, 05:58:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:55 INFO - 'talos_options': ['--xperf_path', 05:58:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:55 INFO - 'tests': ['tp5n']}}, 05:58:55 INFO - 'talos.zip': {'path': '', 05:58:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:55 INFO - Running post-action listener: _resource_record_post_action 05:58:55 INFO - [mozharness: 2016-09-01 12:58:55.510928Z] Finished populate-webroot step (success) 05:58:55 INFO - [mozharness: 2016-09-01 12:58:55.511018Z] Running create-virtualenv step. 05:58:55 INFO - Running pre-action listener: _resource_record_pre_action 05:58:55 INFO - Running main action method: create_virtualenv 05:58:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:55 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 05:58:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:55 INFO - Using real prefix '/usr' 05:58:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:58 INFO - Installing pip.................done. 05:58:58 INFO - Return code: 0 05:58:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:58 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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:58:58 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 05:58:58 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 05:58:58 INFO - Using env: {'DISPLAY': ':0', 05:58:58 INFO - 'HOME': '/home/cltbld', 05:58:58 INFO - 'LANG': 'en_US.UTF-8', 05:58:58 INFO - 'LANGUAGE': 'en_US:en', 05:58:58 INFO - 'LOGNAME': 'cltbld', 05:58:58 INFO - 'MAIL': '/var/mail/cltbld', 05:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:58 INFO - 'MOZ_NO_REMOTE': '1', 05:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:58 INFO - 'NO_EM_RESTART': '1', 05:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:58 INFO - 'PWD': '/builds/slave/test', 05:58:58 INFO - 'SHELL': '/bin/bash', 05:58:58 INFO - 'SHLVL': '1', 05:58:58 INFO - 'TERM': 'linux', 05:58:58 INFO - 'TMOUT': '86400', 05:58:58 INFO - 'USER': 'cltbld', 05:58:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:58 INFO - '_': '/tools/buildbot/bin/python'} 05:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:58 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 05:58:58 INFO - Cleaning up... 05:58:58 INFO - Return code: 0 05:58:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:58 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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:58:58 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 05:58:58 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 05:58:58 INFO - Using env: {'DISPLAY': ':0', 05:58:58 INFO - 'HOME': '/home/cltbld', 05:58:58 INFO - 'LANG': 'en_US.UTF-8', 05:58:58 INFO - 'LANGUAGE': 'en_US:en', 05:58:58 INFO - 'LOGNAME': 'cltbld', 05:58:58 INFO - 'MAIL': '/var/mail/cltbld', 05:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:58 INFO - 'MOZ_NO_REMOTE': '1', 05:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:58 INFO - 'NO_EM_RESTART': '1', 05:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:58 INFO - 'PWD': '/builds/slave/test', 05:58:58 INFO - 'SHELL': '/bin/bash', 05:58:58 INFO - 'SHLVL': '1', 05:58:58 INFO - 'TERM': 'linux', 05:58:58 INFO - 'TMOUT': '86400', 05:58:58 INFO - 'USER': 'cltbld', 05:58:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:58 INFO - '_': '/tools/buildbot/bin/python'} 05:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:58 INFO - Downloading/unpacking psutil>=3.1.1 05:58:58 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 05:58:58 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 05:58:58 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 05:58:58 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 05:58:58 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 05:58:58 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 05:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:00 INFO - Installing collected packages: psutil 05:59:00 INFO - Running setup.py install for psutil 05:59:00 INFO - building 'psutil._psutil_linux' extension 05:59:00 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 05:59:00 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 05:59:00 INFO - building 'psutil._psutil_posix' extension 05:59:00 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 05:59:00 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 05:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:59:00 INFO - Successfully installed psutil 05:59:00 INFO - Cleaning up... 05:59:01 INFO - Return code: 0 05:59:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:59:01 INFO - Using env: {'DISPLAY': ':0', 05:59:01 INFO - 'HOME': '/home/cltbld', 05:59:01 INFO - 'LANG': 'en_US.UTF-8', 05:59:01 INFO - 'LANGUAGE': 'en_US:en', 05:59:01 INFO - 'LOGNAME': 'cltbld', 05:59:01 INFO - 'MAIL': '/var/mail/cltbld', 05:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:01 INFO - 'MOZ_NO_REMOTE': '1', 05:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:01 INFO - 'NO_EM_RESTART': '1', 05:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:01 INFO - 'PWD': '/builds/slave/test', 05:59:01 INFO - 'SHELL': '/bin/bash', 05:59:01 INFO - 'SHLVL': '1', 05:59:01 INFO - 'TERM': 'linux', 05:59:01 INFO - 'TMOUT': '86400', 05:59:01 INFO - 'USER': 'cltbld', 05:59:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:01 INFO - '_': '/tools/buildbot/bin/python'} 05:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:59:03 INFO - Installing collected packages: mozsystemmonitor 05:59:03 INFO - Running setup.py install for mozsystemmonitor 05:59:03 INFO - Successfully installed mozsystemmonitor 05:59:03 INFO - Cleaning up... 05:59:03 INFO - Return code: 0 05:59:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:03 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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:03 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 05:59:03 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 05:59:03 INFO - Using env: {'DISPLAY': ':0', 05:59:03 INFO - 'HOME': '/home/cltbld', 05:59:03 INFO - 'LANG': 'en_US.UTF-8', 05:59:03 INFO - 'LANGUAGE': 'en_US:en', 05:59:03 INFO - 'LOGNAME': 'cltbld', 05:59:03 INFO - 'MAIL': '/var/mail/cltbld', 05:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:03 INFO - 'MOZ_NO_REMOTE': '1', 05:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:03 INFO - 'NO_EM_RESTART': '1', 05:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:03 INFO - 'PWD': '/builds/slave/test', 05:59:03 INFO - 'SHELL': '/bin/bash', 05:59:03 INFO - 'SHLVL': '1', 05:59:03 INFO - 'TERM': 'linux', 05:59:03 INFO - 'TMOUT': '86400', 05:59:03 INFO - 'USER': 'cltbld', 05:59:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:03 INFO - '_': '/tools/buildbot/bin/python'} 05:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:03 INFO - Downloading/unpacking jsonschema==2.5.1 05:59:03 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 05:59:03 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 05:59:03 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 05:59:03 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 05:59:03 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 05:59:03 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 05:59:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:59:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:59:05 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 05:59:05 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 05:59:05 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 05:59:05 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 05:59:05 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 05:59:05 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 05:59:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:05 INFO - warning: no files found matching '*.txt' 05:59:05 INFO - no previously-included directories found matching 'build' 05:59:05 INFO - no previously-included directories found matching 'dist' 05:59:05 INFO - no previously-included directories found matching '.git*' 05:59:05 INFO - Installing collected packages: jsonschema, functools32 05:59:05 INFO - Running setup.py install for functools32 05:59:05 INFO - warning: no files found matching '*.txt' 05:59:05 INFO - no previously-included directories found matching 'build' 05:59:05 INFO - no previously-included directories found matching 'dist' 05:59:05 INFO - no previously-included directories found matching '.git*' 05:59:05 INFO - Successfully installed jsonschema functools32 05:59:05 INFO - Cleaning up... 05:59:05 INFO - Return code: 0 05:59:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:05 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:05 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:59:05 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 functools32==3.2.3-2 05:59:05 INFO - Using env: {'DISPLAY': ':0', 05:59:05 INFO - 'HOME': '/home/cltbld', 05:59:05 INFO - 'LANG': 'en_US.UTF-8', 05:59:05 INFO - 'LANGUAGE': 'en_US:en', 05:59:05 INFO - 'LOGNAME': 'cltbld', 05:59:05 INFO - 'MAIL': '/var/mail/cltbld', 05:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:05 INFO - 'MOZ_NO_REMOTE': '1', 05:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:05 INFO - 'NO_EM_RESTART': '1', 05:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:05 INFO - 'PWD': '/builds/slave/test', 05:59:05 INFO - 'SHELL': '/bin/bash', 05:59:05 INFO - 'SHLVL': '1', 05:59:05 INFO - 'TERM': 'linux', 05:59:05 INFO - 'TMOUT': '86400', 05:59:05 INFO - 'USER': 'cltbld', 05:59:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:05 INFO - '_': '/tools/buildbot/bin/python'} 05:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:59:06 INFO - Cleaning up... 05:59:06 INFO - Return code: 0 05:59:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:59:06 INFO - Using env: {'DISPLAY': ':0', 05:59:06 INFO - 'HOME': '/home/cltbld', 05:59:06 INFO - 'LANG': 'en_US.UTF-8', 05:59:06 INFO - 'LANGUAGE': 'en_US:en', 05:59:06 INFO - 'LOGNAME': 'cltbld', 05:59:06 INFO - 'MAIL': '/var/mail/cltbld', 05:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:06 INFO - 'MOZ_NO_REMOTE': '1', 05:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:06 INFO - 'NO_EM_RESTART': '1', 05:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:06 INFO - 'PWD': '/builds/slave/test', 05:59:06 INFO - 'SHELL': '/bin/bash', 05:59:06 INFO - 'SHLVL': '1', 05:59:06 INFO - 'TERM': 'linux', 05:59:06 INFO - 'TMOUT': '86400', 05:59:06 INFO - 'USER': 'cltbld', 05:59:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:06 INFO - '_': '/tools/buildbot/bin/python'} 05:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:08 INFO - Downloading docopt-0.6.1.tar.gz 05:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:08 INFO - Running setup.py install for blobuploader 05:59:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:09 INFO - Running setup.py install for requests 05:59:09 INFO - Running setup.py install for docopt 05:59:09 INFO - Successfully installed blobuploader requests docopt 05:59:09 INFO - Cleaning up... 05:59:09 INFO - Return code: 0 05:59:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:09 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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:09 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 05:59:09 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 05:59:09 INFO - Using env: {'DISPLAY': ':0', 05:59:09 INFO - 'HOME': '/home/cltbld', 05:59:09 INFO - 'LANG': 'en_US.UTF-8', 05:59:09 INFO - 'LANGUAGE': 'en_US:en', 05:59:09 INFO - 'LOGNAME': 'cltbld', 05:59:09 INFO - 'MAIL': '/var/mail/cltbld', 05:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:09 INFO - 'MOZ_NO_REMOTE': '1', 05:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:09 INFO - 'NO_EM_RESTART': '1', 05:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:09 INFO - 'PWD': '/builds/slave/test', 05:59:09 INFO - 'SHELL': '/bin/bash', 05:59:09 INFO - 'SHLVL': '1', 05:59:09 INFO - 'TERM': 'linux', 05:59:09 INFO - 'TMOUT': '86400', 05:59:09 INFO - 'USER': 'cltbld', 05:59:09 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:09 INFO - '_': '/tools/buildbot/bin/python'} 05:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:09 INFO - Running setup.py (path:/tmp/pip-lN0_mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:09 INFO - Running setup.py (path:/tmp/pip-d8AGnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:09 INFO - Running setup.py (path:/tmp/pip-336b6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:10 INFO - Running setup.py (path:/tmp/pip-G4jkrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:10 INFO - Running setup.py (path:/tmp/pip-r0p4Fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:10 INFO - Running setup.py (path:/tmp/pip-EAiSxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:10 INFO - Running setup.py (path:/tmp/pip-ZJL2vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:10 INFO - Running setup.py (path:/tmp/pip-BuQE2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:10 INFO - Running setup.py (path:/tmp/pip-vXbyiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:10 INFO - Running setup.py (path:/tmp/pip-MlQ0BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:10 INFO - Running setup.py (path:/tmp/pip-1e9p8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:10 INFO - Running setup.py (path:/tmp/pip-VPO1lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:10 INFO - Running setup.py (path:/tmp/pip-sZd5gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:10 INFO - Running setup.py (path:/tmp/pip-J9J2rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:10 INFO - Running setup.py (path:/tmp/pip-Dj9kz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:10 INFO - Running setup.py (path:/tmp/pip-FEBSjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:10 INFO - Running setup.py (path:/tmp/pip-32gJnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:11 INFO - Running setup.py install for manifestparser 05:59:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Running setup.py install for mozcrash 05:59:11 INFO - Running setup.py install for mozdebug 05:59:11 INFO - Running setup.py install for mozdevice 05:59:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Running setup.py install for mozfile 05:59:11 INFO - Running setup.py install for mozhttpd 05:59:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Running setup.py install for mozinfo 05:59:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Running setup.py install for mozInstall 05:59:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Running setup.py install for mozleak 05:59:11 INFO - Running setup.py install for mozlog 05:59:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:12 INFO - Running setup.py install for moznetwork 05:59:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:12 INFO - Running setup.py install for mozprocess 05:59:12 INFO - Running setup.py install for mozprofile 05:59:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:12 INFO - Running setup.py install for mozrunner 05:59:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:12 INFO - Running setup.py install for mozscreenshot 05:59:12 INFO - Running setup.py install for moztest 05:59:12 INFO - Running setup.py install for mozversion 05:59:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:12 INFO - Cleaning up... 05:59:12 INFO - Return code: 0 05:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:12 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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:12 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 05:59:12 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 05:59:12 INFO - Using env: {'DISPLAY': ':0', 05:59:12 INFO - 'HOME': '/home/cltbld', 05:59:12 INFO - 'LANG': 'en_US.UTF-8', 05:59:12 INFO - 'LANGUAGE': 'en_US:en', 05:59:12 INFO - 'LOGNAME': 'cltbld', 05:59:12 INFO - 'MAIL': '/var/mail/cltbld', 05:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:12 INFO - 'MOZ_NO_REMOTE': '1', 05:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:12 INFO - 'NO_EM_RESTART': '1', 05:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:12 INFO - 'PWD': '/builds/slave/test', 05:59:12 INFO - 'SHELL': '/bin/bash', 05:59:12 INFO - 'SHLVL': '1', 05:59:12 INFO - 'TERM': 'linux', 05:59:12 INFO - 'TMOUT': '86400', 05:59:12 INFO - 'USER': 'cltbld', 05:59:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:12 INFO - '_': '/tools/buildbot/bin/python'} 05:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:13 INFO - Running setup.py (path:/tmp/pip-nHdISp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:13 INFO - Running setup.py (path:/tmp/pip-1D5RlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:13 INFO - Running setup.py (path:/tmp/pip-wrKNLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:13 INFO - Running setup.py (path:/tmp/pip-xGrdfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:13 INFO - Running setup.py (path:/tmp/pip-_qpZCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:13 INFO - Running setup.py (path:/tmp/pip-Ne6Rdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:13 INFO - Running setup.py (path:/tmp/pip-4K4KLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:13 INFO - Running setup.py (path:/tmp/pip-kS5nsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:13 INFO - Running setup.py (path:/tmp/pip-RM0kqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:13 INFO - Running setup.py (path:/tmp/pip-LnoyKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:13 INFO - Running setup.py (path:/tmp/pip-v01fmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:13 INFO - Running setup.py (path:/tmp/pip-766rbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:13 INFO - Running setup.py (path:/tmp/pip-t3L1so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:13 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)) 05:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:13 INFO - Running setup.py (path:/tmp/pip-0hFBOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:14 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)) 05:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:14 INFO - Running setup.py (path:/tmp/pip-77sD3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:14 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)) 05:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:14 INFO - Running setup.py (path:/tmp/pip-jR2Zh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:14 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)) 05:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:14 INFO - Running setup.py (path:/tmp/pip-r3T8P2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:14 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)) 05:59:14 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)) 05:59:14 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)) 05:59:14 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)) 05:59:14 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)) 05:59:14 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)) 05:59:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:14 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 05:59:14 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 05:59:14 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 05:59:14 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 05:59:14 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 05:59:14 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 05:59:16 INFO - Downloading blessings-1.6.tar.gz 05:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:16 INFO - Installing collected packages: blessings 05:59:16 INFO - Running setup.py install for blessings 05:59:16 INFO - Successfully installed blessings 05:59:16 INFO - Cleaning up... 05:59:16 INFO - Return code: 0 05:59:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:16 INFO - Reading from file tmpfile_stdout 05:59:16 INFO - Current package versions: 05:59:16 INFO - argparse == 1.2.1 05:59:16 INFO - blessings == 1.6 05:59:16 INFO - blobuploader == 1.2.4 05:59:16 INFO - docopt == 0.6.1 05:59:16 INFO - functools32 == 3.2.3-2 05:59:16 INFO - jsonschema == 2.5.1 05:59:16 INFO - manifestparser == 1.1 05:59:16 INFO - mozInstall == 1.12 05:59:16 INFO - mozcrash == 0.17 05:59:16 INFO - mozdebug == 0.1 05:59:16 INFO - mozdevice == 0.48 05:59:16 INFO - mozfile == 1.2 05:59:16 INFO - mozhttpd == 0.7 05:59:16 INFO - mozinfo == 0.9 05:59:16 INFO - mozleak == 0.1 05:59:16 INFO - mozlog == 3.3 05:59:16 INFO - moznetwork == 0.27 05:59:16 INFO - mozprocess == 0.23 05:59:16 INFO - mozprofile == 0.28 05:59:16 INFO - mozrunner == 6.12 05:59:16 INFO - mozscreenshot == 0.1 05:59:16 INFO - mozsystemmonitor == 0.3 05:59:16 INFO - moztest == 0.7 05:59:16 INFO - mozversion == 1.4 05:59:16 INFO - psutil == 3.1.1 05:59:16 INFO - requests == 1.2.3 05:59:16 INFO - wsgiref == 0.1.2 05:59:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:16 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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:16 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 05:59:16 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 05:59:16 INFO - Using env: {'DISPLAY': ':0', 05:59:16 INFO - 'HOME': '/home/cltbld', 05:59:16 INFO - 'LANG': 'en_US.UTF-8', 05:59:16 INFO - 'LANGUAGE': 'en_US:en', 05:59:16 INFO - 'LOGNAME': 'cltbld', 05:59:16 INFO - 'MAIL': '/var/mail/cltbld', 05:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:16 INFO - 'MOZ_NO_REMOTE': '1', 05:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:16 INFO - 'NO_EM_RESTART': '1', 05:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:16 INFO - 'PWD': '/builds/slave/test', 05:59:16 INFO - 'SHELL': '/bin/bash', 05:59:16 INFO - 'SHLVL': '1', 05:59:16 INFO - 'TERM': 'linux', 05:59:16 INFO - 'TMOUT': '86400', 05:59:16 INFO - 'USER': 'cltbld', 05:59:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:16 INFO - '_': '/tools/buildbot/bin/python'} 05:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 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)) 05:59:16 INFO - Cleaning up... 05:59:16 INFO - Return code: 0 05:59:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:16 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 0x7ffb15dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15d88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a5850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, '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': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', '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 05:59:16 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 05:59:16 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 05:59:16 INFO - Using env: {'DISPLAY': ':0', 05:59:16 INFO - 'HOME': '/home/cltbld', 05:59:16 INFO - 'LANG': 'en_US.UTF-8', 05:59:16 INFO - 'LANGUAGE': 'en_US:en', 05:59:16 INFO - 'LOGNAME': 'cltbld', 05:59:16 INFO - 'MAIL': '/var/mail/cltbld', 05:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:16 INFO - 'MOZ_NO_REMOTE': '1', 05:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:16 INFO - 'NO_EM_RESTART': '1', 05:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:16 INFO - 'PWD': '/builds/slave/test', 05:59:16 INFO - 'SHELL': '/bin/bash', 05:59:16 INFO - 'SHLVL': '1', 05:59:16 INFO - 'TERM': 'linux', 05:59:16 INFO - 'TMOUT': '86400', 05:59:16 INFO - 'USER': 'cltbld', 05:59:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:16 INFO - '_': '/tools/buildbot/bin/python'} 05:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:59:17 INFO - Cleaning up... 05:59:17 INFO - Return code: 0 05:59:17 INFO - Running post-action listener: _resource_record_post_action 05:59:17 INFO - Running post-action listener: _start_resource_monitoring 05:59:17 INFO - Starting resource monitoring. 05:59:17 INFO - [mozharness: 2016-09-01 12:59:17.092238Z] Finished create-virtualenv step (success) 05:59:17 INFO - [mozharness: 2016-09-01 12:59:17.092740Z] Running install step. 05:59:17 INFO - Running pre-action listener: _resource_record_pre_action 05:59:17 INFO - Running main action method: install 05:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:17 INFO - Reading from file tmpfile_stdout 05:59:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:17 INFO - Reading from file tmpfile_stdout 05:59:17 INFO - Output received: 05:59:17 INFO - Usage: mozinstall [options] installer 05:59:17 INFO - Options: 05:59:17 INFO - -h, --help show this help message and exit 05:59:17 INFO - -d DEST, --destination=DEST 05:59:17 INFO - Directory to install application into. [default: 05:59:17 INFO - "/builds/slave/test"] 05:59:17 INFO - --app=APP Application being installed. [default: firefox] 05:59:17 INFO - mkdir: /builds/slave/test/build/application 05:59:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:59:34 INFO - Reading from file tmpfile_stdout 05:59:34 INFO - Output received: 05:59:34 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:34 INFO - Running post-action listener: _resource_record_post_action 05:59:34 INFO - [mozharness: 2016-09-01 12:59:34.402691Z] Finished install step (success) 05:59:34 INFO - [mozharness: 2016-09-01 12:59:34.402968Z] Running run-tests step. 05:59:34 INFO - Running pre-action listener: _resource_record_pre_action 05:59:34 INFO - Running main action method: run_tests 05:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:34 INFO - Python 2.7.3 05:59:34 INFO - Return code: 0 05:59:34 INFO - grabbing minidump binary from tooltool 05:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:34 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 0x16a0370>, '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 0x16a38f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a3d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:34 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 05:59:34 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 05:59:34 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 05:59:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:34 INFO - Return code: 0 05:59:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:59:34 INFO - Using env: {'DISPLAY': ':0', 05:59:34 INFO - 'HOME': '/home/cltbld', 05:59:34 INFO - 'LANG': 'en_US.UTF-8', 05:59:34 INFO - 'LANGUAGE': 'en_US:en', 05:59:34 INFO - 'LOGNAME': 'cltbld', 05:59:34 INFO - 'MAIL': '/var/mail/cltbld', 05:59:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:34 INFO - 'MOZ_NO_REMOTE': '1', 05:59:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:34 INFO - 'NO_EM_RESTART': '1', 05:59:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:34 INFO - 'PWD': '/builds/slave/test', 05:59:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:34 INFO - 'SHELL': '/bin/bash', 05:59:34 INFO - 'SHLVL': '1', 05:59:34 INFO - 'TERM': 'linux', 05:59:34 INFO - 'TMOUT': '86400', 05:59:34 INFO - 'USER': 'cltbld', 05:59:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308', 05:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:34 INFO - '_': '/tools/buildbot/bin/python'} 05:59:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:59:34 INFO - mozversion application_buildid: 20160901030202 05:59:34 INFO - mozversion application_changeset: b7f7ae14590aced450bb0b0469dfb38edd2c0ace 05:59:34 INFO - mozversion application_display_name: Nightly 05:59:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:34 INFO - mozversion application_name: Firefox 05:59:34 INFO - mozversion application_remotingname: firefox 05:59:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:59:34 INFO - mozversion application_vendor: Mozilla 05:59:34 INFO - mozversion application_version: 51.0a1 05:59:34 INFO - mozversion platform_buildid: 20160901030202 05:59:34 INFO - mozversion platform_changeset: b7f7ae14590aced450bb0b0469dfb38edd2c0ace 05:59:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:59:34 INFO - mozversion platform_version: 51.0a1 05:59:34 INFO - using testdate: 1472734774 05:59:34 INFO - actual date: 1472734774 05:59:34 INFO - starting webserver on 'localhost:46720' 05:59:34 INFO - SUITE-START | Running 2 tests 05:59:34 INFO - TEST-START | dromaeo_css 05:59:34 INFO - operating with platform_type : linux_ 05:59:34 INFO - Initialising browser for dromaeo_css test... 05:59:34 INFO - TEST-INFO | started process 12332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvS9g1o/profile http://localhost:46720/getInfo.html) 05:59:39 INFO - PROCESS | 12332 | __metrics Screen width/height:1600/1200 05:59:39 INFO - PROCESS | 12332 | colorDepth:24 05:59:39 INFO - PROCESS | 12332 | Browser inner width/height: 1024/697 05:59:39 INFO - PROCESS | 12332 | __metrics 05:59:39 INFO - PROCESS | 12332 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:59:39 INFO - PROCESS | 12332 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:40 INFO - PROCESS | 12332 | console.error: PushService: 05:59:40 INFO - PROCESS | 12332 | stateChangeProcessEnqueue: Error transitioning state 05:59:40 INFO - PROCESS | 12332 | UnknownError 05:59:40 INFO - TEST-INFO | 12332: exit 0 05:59:40 INFO - Browser initialized. 05:59:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:40 INFO - TEST-INFO | started process 12416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvS9g1o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:53 INFO - PROCESS | 12416 | RSS: Main: 180355072 05:59:53 INFO - PROCESS | 12416 | 06:00:43 INFO - PROCESS | 12416 | 1472734843757 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] 06:02:54 INFO - PROCESS | 12416 | Cycle 1(1): loaded http://localhost:46720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46720/tests/dromaeo/cssquery-ext.html) 06:02:55 INFO - PROCESS | 12416 | RSS: Main: 283684864 06:02:55 INFO - PROCESS | 12416 | 06:05:57 INFO - PROCESS | 12416 | Cycle 1(1): loaded http://localhost:46720/tests/dromaeo/cssquery-ext.html (next: http://localhost:46720/tests/dromaeo/cssquery-jquery.html) 06:05:58 INFO - PROCESS | 12416 | RSS: Main: 274518016 06:05:58 INFO - PROCESS | 12416 | 06:09:00 INFO - PROCESS | 12416 | Cycle 1(1): loaded http://localhost:46720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46720/tests/dromaeo/cssquery-mootools.html) 06:09:00 INFO - PROCESS | 12416 | RSS: Main: 215019520 06:09:00 INFO - PROCESS | 12416 | 06:12:02 INFO - PROCESS | 12416 | Cycle 1(1): loaded http://localhost:46720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46720/tests/dromaeo/cssquery-prototype.html) 06:12:03 INFO - PROCESS | 12416 | RSS: Main: 260128768 06:12:03 INFO - PROCESS | 12416 | 06:15:06 INFO - PROCESS | 12416 | Cycle 1(1): loaded http://localhost:46720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46720/tests/dromaeo/cssquery-yui.html) 06:15:06 INFO - PROCESS | 12416 | RSS: Main: 216170496 06:15:06 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | Cycle 1(1): loaded http://localhost:46720/tests/dromaeo/cssquery-yui.html (next: http://localhost:46720/tests/dromaeo/cssquery-dojo.html) 06:18:09 INFO - PROCESS | 12416 | RSS: Main: 309030912 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | __start_tp_report 06:18:09 INFO - PROCESS | 12416 | _x_x_mozilla_page_load 06:18:09 INFO - PROCESS | 12416 | _x_x_mozilla_page_load_details 06:18:09 INFO - PROCESS | 12416 | |i|pagename|runs| 06:18:09 INFO - PROCESS | 12416 | |0;dojo.html;2974.6281714785646;2987.925301867453;2996.1460983619672;3026.077046500819;3052.9694703052965;5241.84274471766;5256.474352564742;5351.946480535194;5354.9196762048605;5356.1162408202645;5374.328208973879;5411.891762164754;5436.728163591814;5466.890662186754;5488.53347465465;4828.87927801806;4881.096997055556;4915.754212289389;4930.827421040264;5043.495650434946;4936.80252789888;4984.37695288089;4986.601071914256;4997.625178111638;5003.624728145385;4751.026039661879;4851.078295123951;4866.7566621668775;4934.80260789568;4980.850574482772;4832.903341933142;4859.635527335464;4865.416150062015;4961.330220420233;4968.552830245259;4883.169861123618;4897.926531102036;4914.3611330527165;4916.164252077119;4966.453690094087;5177.326947496839;5333;5412.134058550652;5412.5940554458175;5417.241586177938;5758.107493338539;5759.136129580555;5764.625299355528;5766.192733017381;5842.707864606753;5764.07774756037;5815.447532484407;5831.125331200312;5831.912521312183;5834.066549352126;5167.586593072545;5340.49265319794;5380.811671591476;5404.351477822686;5409.5672346212605;5948.613340132878;5949.0481522956115;5950.434708702666;6002.369751176151;6016.127661489059;5695.316562012585;5703.54371650267;5703.857403564944;5704.515116215168;5705.828825135252;5582.302212223472;5627.465390787868;5644.6613203207935;5786.392428795;5791.623544469596;5680.943190568124;5684.77260909559;5687.118496633028;5739.282589676291;5754.510866576388;5643.238162847963;5698.1737648041635;5704.8859022819315;5706.201131841545;5709.3434255060365;4351.847685331061;4375.7155784873885;4391.560843915583;4425.557444255549;4428.446444194476;3920.1179734559496;3929.980350098231;3946.2699400610977;3970.7220494565104;3986.5016872890887;5421.349438067457;5435.537979271727;5440.591955603346;5440.891182176334;5453.100238460689;5499.422560631157;5707.429257074259;5766.654000759968;5769.221155144001;5784.363719990798;5488.451154884479;5492.231087647732;5527.198556209408;5527.861803454945;5554.638948468337;4995.300657907896;5004.599632029429;5007.624428167902;5011.473795251519;5058.873528161752;5782.392848750821;5918.496927761188;5957.344692083867;6004.699765011645;6012.699365031731;5775.768969241183;5902.321233058254;5905;5910;5911.349751527415;6024.518038556993;6024.7288872001745;6026.578139530367;6035.637861728311;6086.69566521681;5661.377248502579;5703.144528320785;5712.885742285214;5714.714264286852;5735.111057785883;5580.135079062752;5660.122680984454;5680.147977803363;5683.033884239607;5838.94161058401;5571.777128914798;5619.719014049363;5623.606347555632;5623.606347555796;5675.772969081356;5612.635178713534;5622.437756224344;5624.212610234488;5625.5218306442775;5625.943740562706;5364.222187782828;5591.664500130005;5599.272094627672;5630.887382252414;5655.406182350958;5687.886242275049;5688.77244910199;5693.772249109989;5694.430556944438;5752.482276595127;5398.244245805512;5399.271098401666;5581.10702287632;5591.524720398649;5596.0206963780365 06:18:09 INFO - PROCESS | 12416 | |1;ext.html;550.2472751716522;579.904315787895;612.2805703298623;614.7325913227747;615.8306465721926;32108.67891321086;33005.50491742623;43836.3424548632;44607.55392446074;44660.776696116554;45859.770701146444;46294.305585416165;46310.76844615772;46323.53676463234;46336.536634633645;8732.95633521833;8992.460452372847;8997.460152390844;9013.098690131;9039.367244292902;8963.641454341818;9021.684241051564;9034.819303613924;9044.8643270351;9050.275977921783;8851.468911865277;8882.422642528247;8890.288776897865;8897.33270004749;8900.19898209161;9043.638254469814;9048.230900373475;9082.77293067672;9094.772630684285;9095.772605684844;8926.464412135292;9000.59497322622;9003.549822508849;9008.1892629663;9017;42465.78767106176;42623.45895033626;42751;42770.14459710789;42900.14199716019;3587.443946188319;3597;3643.2531331077066;3699.445083237536;3944.2111577684577;32487.51268730971;33126;33504.497432538534;33557.832210839035;33705.831470842735;4331.633872381081;4388.49532303786;4426.535213802536;4541.273396256616;4610.170169369512;336153;337216;340083;340166;340603;58806;59063;59213;59245.40754592485;59249.111263331084;63543.6822815883;63594;63668.68165659142;63700;63709.36290637127;16291.185440727917;17147.399841005754;17362.826371736373;17388.782785204916;17400.564985875455;12159.5136194553;12695;12704.745905081847;12705;12714.300713460663;17972.272033093774;19216.039198040322;19370.322038728576;19433.31983380575;19535.804641953684;6853.588784672936;7064.929350706427;7121.323474269936;7323.450741194325;7425.62871856405;943.6744323208619;948.7438391634358;1093.5461783359817;1097.9945100274447;1112.7607564373536;30694.285001247816;32251.838740806146;32599.837000814845;32915.50626740601;33281.500777488356;1037.7301901505664;1086.6848613902039;1140.7433327501246;1152.9192956493132;1155.8447381662909;16200.351985920666;17169.227384767717;17189.914050429667;17198.91400542989;17349.87225830317;619302;626364;627008;627271;627640;60919.390806091375;61697;61700;61722.074168887506;61826.381736182964;1218.9268643881396;1305.9608211753662;1329.195836518892;1343.187371640163;1363.5023216526095;31494.055178344686;32425.675743242267;33710.157246069044;33719;34013.14967125842;51206.23190652069;51619.741901290254;51633.225501616755;51683.22475162951;51834.222486663486;400416;400732;400947;401005;401167;25567.744322556537;27346;28268;28460.430791383642;29694.95185818373;47499;48380.274295886295;48628.5137148624;48989.510104898494;49270.50729492659;41284.1743165129;41419.37870931878;41663.7916810414;43528.56471435245;43674.34488482739;40726.59273407228;41218.38172427476;41493.37759933543;41896;42258.154836902475;40349.79825100856;40650.1869962605;40876.38685419781;41905.1618967625;42135.36796948109;35675.82162089277;37786.43320350142;38258.42612360761;38510.80744596259;38977.41533876937;27505.724942750316;28581.714182857904;28616.427671446872;28654.426911461236;28842 06:18:09 INFO - PROCESS | 12416 | |2;jquery.html;376.719344088654;394.57780175212514;409.6129157945742;411.38703332035266;416.7520325406382;15691.960045194122;19179.232830686775;19234.80765192348;19360.225590976363;19621.607567848634;19107.808921910775;19367;19442.70835937462;19607.215711371562;19912;5226.320578324812;5725.541956643479;5850.912236316437;5895.675737834417;5941.376155503674;4271.594198551148;5838.970805145968;6196.2874269459135;6472.967635161841;6492.091107244966;6334;6544.509161812859;6548.70530826114;6548.8035358939305;6558.80323590293;6507.609543427409;6527.543071984963;6555.344465553454;6558.672066396661;6560.639164845931;5095.414027386861;5341.252224688546;5378.031954248234;5809.941900580982;5810.1865738796605;13885.791713124312;14056.367463464168;14145.929270353685;18245.54386140357;22423.551528969492;2195.868247905131;2211.1487077475126;2501.58723810571;2642.643243162187;2776.639036925207;10083.697489075339;10356.275060745751;10656.467176641137;10668.893311066946;12094.818577721342;1776.7512548243255;1869.084148767108;1906.1670693547799;1938.4766113149371;1951.3365455745115;78007;83608;84722.57638711829;85505.99999999937;85606;10695.73260668474;10703.83944240837;11085.889141108648;11094.278871873303;11128.777424451466;15636.3745450183;15687.294071766797;15736.763948540782;15745.055296682236;15759.842401576067;7790.376769858398;8057.516549006961;8117.863499110129;8276.29651479631;8323.417360784808;7598.772036838904;7635.198304177981;7716.807079823049;7810.804729881685;7886.132525422199;4765.499622539653;4835.44392394872;4861.490208533935;4924.581410580141;4929.926051109236;1822.9361972330905;1830.5240637434363;1863.0312237636354;1874.2877706471727;1944.5527528668204;816.8447994880953;899.6221586933503;912.3203213605906;956.4404823178379;1069.5080263078914;17403.129843507773;18379.448616541526;18744.25022999065;18800.247990080243;19066.52333691641;926.9212116970133;946.2997381937316;970.4419958523877;988.461288597716;1003.007023047178;10097.192224622013;10409.323393979366;10560.841587376195;10574;10587.311824731369;451269;460125;476260;476495;479351;91445.08554914499;92403.537982311;94242;96301;97147.51426242964;1001.7960486928786;1061.6231237910586;1065.4725910674265;1078.487718333785;1079.3631757263252;17141;17248.568785779953;17902.55243618868;17982.910085450014;18289.994050326826;42590.78704606457;42684.5731542693;45028;45560;46017.76991115023;60844.39155608564;61205.38794611997;61840;62286.37713622806;62405.687971559855;7429.4799364044;7767.417443691633;7802.609869506616;8071;8126.878096828434;12646.620601381974;12651.620451386472;13122.868771312547;13271.023366237661;13424.463021479032;11219.943900280772;11401.942990284995;11427.542898284308;11727.589534366256;11829;11046.061084807881;11171.21801473889;11368.829467558158;11686.474108665301;11888.643340699793;11048.232282834708;11239.775204495701;11711.472983715583;11910.821337680116;12218.327991960528;7809.33620642229;7951.3638908886;8002.9599852000365;8186.099529051919;8215.72656238284;9507.952460237655;11338.773224535627;11412.258203216765;11682.88317116852;11698.415079246173 06:18:09 INFO - PROCESS | 12416 | |3;mootools.html;1347.036868638923;1475.7343678137938;1506.1866592040299;1625.967480650387;1796.5957659526607;8462.153784621534;8934;8945.150210729986;9125.452472851634;9126.178643922045;8641.870371944426;8738.86891696625;8744.606492707828;8751.781205469866;8755.562221888897;2383.9880800596015;2415.830891837572;2417.323149518129;2417.830751847371;2418.117387153694;2355.4700192456644;2383.332666853275;2419.5765740995344;2421.2010036687852;2421.987890060547;2378.9643155352596;2405.6992875890514;2408.638704194367;2408.95182096358;2415.3478560788576;2296.8047715944167;2332.7783860533223;2342.9765702343016;2343.8124950003958;2358.9646155307682;2217.868886867693;2241.0699559682876;2249.6175650139517;2263.2757517594214;2265.3090807303765;8509.872351914726;8640.481571105754;8722.127787221227;8723.171298726611;8772.605232764541;5185.922211166836;5347.759350829222;5353.678779273256;5355;5359.892802143974;3419.6580341965855;3446.5864096308605;3454.447288433864;3458.792472451661;3516.894493165209;1047.3872784421123;1070.0209308482729;1076.0638244727058;1089.6186334782842;1102.228440091931;12708.682282942907;12739.36303184837;12814.615561533168;12823.487060517567;12824.80762788559;4547.884698981143;4682;4860.392450943632;4886.877828054256;4897.975510122426;9981.950090249647;9993.250506211918;10002.799944001079;10003.14973227284;10005.14956228714;5506.752196151183;5551.250581171571;5557.110862262019;5562.276904002535;5566.944330556724;4381.605655491021;4902.558769710743;5078.4413714491375;5103.489651034941;5211.869703257373;3710.2950439416422;3800.1449673823167;3822.980885095557;3892.766434013968;3913.8434462621176;1156.3697784707354;1169.2283093158474;1179.728662407634;1180.6399048290355;1190.7916114679897;878.3544095090103;961.4135377419768;973.2116985241977;976.2190247801872;986.6448078691665;5817.680027598438;5927.347991720907;5976;6053.969730151409;6410.55126141175;465.4344970860421;473.67789902865695;483.3233473137565;487.65620237732315;490.53644306131076;4146.481689788777;4234.788260586958;4242.342436922282;4263.744175349489;4297.441332626739;11156.832647510293;11428.542858285575;11495.540178392937;11516.942415288038;11548.249363791494;10479.47602619866;10957.06864916475;11361;11428.771424571629;11431.771364572829;8340.833183336421;8526.701565445179;8532.57337133141;8533.232009119209;8537.487750734852;6051.5461340400525;6193.194884664965;6230.844228894314;6321.462675672619;6349.396807303298;10202.693919182437;10459.391509929063;10528.420936848546;10531.262811603114;10625.681229563126;10075.34510256831;10337.328073675188;10455.268131230741;10619.522121504706;10772.730681732706;7000.684969176501;7758;7913;8010.239027292398;8163.79590510242;8809.295256379603;8907.955460222658;8912.153345432174;8922.509261990393;8928.642854285756;7614;7640.465167438226;7676.462647614837;7828.491148075357;8003.31971782405;7719.961400192963;7739.845203096019;7786.299233069051;7860.724874629361;8013.2387423194705;6975.546589471668;7072.893906591303;7087.220405755466;7088.184858741311;7103.289671032855;4925.064237794808;5197.428282888804;5208.5312321891215;5217.191335343028;5559.944400555943;5348.224507446476;5363.141897296414;5376.1398176291605;5500.367457742411;5543.202906009396 06:18:09 INFO - PROCESS | 12416 | |4;prototype.html;332.9500574913761;334.50159262698577;337.5729701927061;339.1352052266719;351.13970771609564;5168.3539557555305;5251.818340873311;5306.575473962083;5327.467253274675;5376.946230537698;5214.530692237698;5256.710880901558;5295.761690723926;5298.973505132479;5329.360476742787;4178.268802959486;4182.22628813669;4188.9946412860845;4195.307774217251;4218.493780746315;4165.979170104145;4167.791610419482;4208.789560521977;4220.620144187023;4221.873343799691;4178.582141785812;4182.749035057906;4188.476440444944;4190.057237121654;4197.433346498215;4160.126373461592;4160.500739911215;4191.455110835603;4195.286801243796;4201.34879093741;3627.8911632650797;3732.104294969188;3748.3253014457387;3757.7369584129124;3763.680087192592;5100.489951004907;5117.078925793356;5119.667221630582;5136.512031357015;5155.9742201288755;4761.428628564559;4770.451398089194;4771.880702982418;4779.450363208241;4796.544328288807;5327.345616762932;5416.647917885364;5444.945550544483;5470.753816078286;5534.806281780158;4036.455078564415;4037.253108174997;4050.534188568323;4053.250148722496;4093.7543747374957;5737.942620573783;5756.934967031071;5759.481646651821;5778.27771528559;5804.071348584206;4118.629323360912;4204.4324016257415;4212.7472351659;4232.767197804089;4233.555476674905;4225.366195070764;4226.647472808733;4227.175700738388;4227.936580951288;4231.449911511484;4736.4316282046375;4743.857684269477;4752.2158843790385;4753.764021354473;4792.736399497991;5329.360476742816;5454.745298667046;5532.972335138298;5560.694161821139;5565.805196818092;1393.1501783911806;1416.4065426395305;1456.1990905002206;1456.621278467585;1461.4300422835104;1007.7631756537207;1026.630413051301;1046.7697106636529;1049.2917280835406;1052.6473631333588;5264.499872512105;5272.261883336336;5281.102212623863;5283.550898173621;5309.946900531023;5563.944360556424;5605.720653417797;5608.887822243532;5609.915851262234;5622.662640241517;5107.03379199011;5274.393444753902;5295.4439783822145;5313.388960269541;5327.653702509325;2658.9468210636064;2660.629775665534;2669.1325319271314;2671.986640066787;2678.1429942418627;5123.795048198105;5151.80588035413;5165.431802501722;5184.922226166611;5196.298499702491;4797.2564252540915;5070.414088814731;5073.3911930568565;5073.746312684351;5093.592512599057;5157.6532677631585;5158.793648254103;5173.249878767558;5185.948140518546;5188.844334669966;4904.6566740327835;4911.354696176821;4962.776675049559;4983.501649834988;5026.623003274696;4690.39024926771;4873.5379386183295;4904.288878112582;4904.449686163247;4933.58064564516;5098.694078355311;5117.795288188579;5124.718140502308;5128.640995130305;5138.922916156335;3805.752626079296;3838.213166300846;3839.884803455901;3853.094522787199;3865.16898866745;4777.331173635764;4836.886028241979;4920;5387.791005687649;5468.589855760754;5440.6735595864375;5471.534919531884;5518.696471694096;5530.142827861688;5568.554515638658;5500.339959204921;5515.062439385234;5520.696361700145;5526.944730552643;5542.72286385671;5270.497908096174;5519.751611177427;5526.25922834322;5529.45645003303;5534.335879694462;5551.972885016285;5567.331920169606;5590.944090559043;5596.565494009956;5605.775768969195;5204.869878252923;5395.244665746877;5426.240326354393;5435.483629055233;5498.285222920995 06:18:09 INFO - PROCESS | 12416 | |5;yui.html;756.6330329790054;777.9338756205722;805.7421625079974;816.5345752920836;850.6980022092159;14372.281385930713;14979.625509362244;15272.083674979494;15301.158436286;15352.923235383822;14511.346989385476;14618.342174602141;14645.487407940724;14671.633209169777;15141.545753627408;646.2180761278859;778.6651739751904;781.2421950707818;795.8050277681976;800.3117319105564;783.4398405140323;785.8860465232538;786.0920636664662;786.1705900275207;790.1308560583341;851.8296340731847;852.6078004118082;853.3727710133078;853.7737499562621;857.5240741388527;683.4327508168209;816.7223144130994;835.1106072033265;843.5444859775714;846.7713717296357;620.1906512001835;620.4725982914532;624.0327492386828;626.962382257066;627.05314974389;13924.37340319678;13946.16323020622;13961.511347102803;14007;14008.22954737489;13627.318634068357;14012.789450689097;14339.71320573593;14375.137491750529;14415.639609009753;12548.435320410603;12560.874391256062;12649.367531623382;12700;13077.476900923952;4314.115606300701;4345.69580129391;4359.10638319147;4403.2954727243805;4430.689851710382;80484.59757701232;81842;81913;82032;83345.58327208325;11381.044217534614;11493.712657183638;11532.711682208012;11647.184697071123;12068.577599783965;18224.27102915895;18256.452306430827;18280.45158645243;18302.816971830376;18316.908415457838;8229.218224268685;8294.709685161111;8344.874826877602;8452.66189352419;8753.912460875437;4360.847370342023;4488.820447182142;4535;4545.909081818345;4596.402467679247;3245.659205783406;3370.443876760356;3377.9866040187844;3378.679025492574;3379.763416560817;556.5213916032209;558.1209594888068;566.931968163823;570.7945139749687;571.4143003421443;683.719674933275;683.7470136049693;697.9336962988508;703.2299631903059;707.1337611426064;9021.548922553977;9118;9408.43549387039;9621.711348659552;9707.563159657833;569.0894568690063;633.8447080465315;636.8376064103717;683.805115542078;693.414065114977;4594.678372513892;4770.260609605447;4879.463259041502;4898.069366820364;4934.55588996992;100830;101973.49013255035;104972.47513762383;127211.36394317969;133467;60571.69714151401;69449.65275173692;93874.53062734779;94210;95758.52120739491;54468.72765636226;69865.65067174734;82791;83135;83610.5819470911;9364.344495885494;9948.35335703177;10031.147352475122;10209.336393134423;10220.591176352862;49766.004679906924;50440.495595045046;51900;52127;52260.21609675934;68290.65854670695;69969.30030699831;76235.61882190553;76935;77231.61384193043;12467.625971220878;12813.8077928833;12881.35593220354;13161.670958226121;13248.47006119783;13199.604011879659;13341.733165336833;13444.327783610976;13448.865511344762;14383.208923509308;12119.75760484803;12123.454444550192;12363;14441.277936102942;14931.85068149348;14531.273436328353;14584.270786460847;14825.481108161162;15201.391944322104;15832.208389580705;13122.60632181036;14602.561923142322;14724.852751472348;14814.77777833355;15292;11859.407029648655;12180.147389682637;12376.566820161252;12577.245365278113;12579.119461637598;12229.816552751538;12416.317102559446;12606.621801345975;12625.305608191271;12748.745025099632 06:18:09 INFO - PROCESS | 12416 | __end_tp_report 06:18:09 INFO - PROCESS | 12416 | __start_cc_report 06:18:09 INFO - PROCESS | 12416 | _x_x_mozilla_cycle_collect,860 06:18:09 INFO - PROCESS | 12416 | __end_cc_report 06:18:09 INFO - PROCESS | 12416 | __startTimestamp1472735889797__endTimestamp 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | ------- Summary: start ------- 06:18:09 INFO - PROCESS | 12416 | Number of tests: 6 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | [#0] dojo.html Cycles:165 Average:5354.49 Median:5582.30 stddev:620.80 (11.1%) stddev-sans-first:593.97 06:18:09 INFO - PROCESS | 12416 | Values: 2974.6 2987.9 2996.1 3026.1 3053.0 5241.8 5256.5 5351.9 5354.9 5356.1 5374.3 5411.9 5436.7 5466.9 5488.5 4828.9 4881.1 4915.8 4930.8 5043.5 4936.8 4984.4 4986.6 4997.6 5003.6 4751.0 4851.1 4866.8 4934.8 4980.9 4832.9 4859.6 4865.4 4961.3 4968.6 4883.2 4897.9 4914.4 4916.2 4966.5 5177.3 5333.0 5412.1 5412.6 5417.2 5758.1 5759.1 5764.6 5766.2 5842.7 5764.1 5815.4 5831.1 5831.9 5834.1 5167.6 5340.5 5380.8 5404.4 5409.6 5948.6 5949.0 5950.4 6002.4 6016.1 5695.3 5703.5 5703.9 5704.5 5705.8 5582.3 5627.5 5644.7 5786.4 5791.6 5680.9 5684.8 5687.1 5739.3 5754.5 5643.2 5698.2 5704.9 5706.2 5709.3 4351.8 4375.7 4391.6 4425.6 4428.4 3920.1 3930.0 3946.3 3970.7 3986.5 5421.3 5435.5 5440.6 5440.9 5453.1 5499.4 5707.4 5766.7 5769.2 5784.4 5488.5 5492.2 5527.2 5527.9 5554.6 4995.3 5004.6 5007.6 5011.5 5058.9 5782.4 5918.5 5957.3 6004.7 6012.7 5775.8 5902.3 5905.0 5910.0 5911.3 6024.5 6024.7 6026.6 6035.6 6086.7 5661.4 5703.1 5712.9 5714.7 5735.1 5580.1 5660.1 5680.1 5683.0 5838.9 5571.8 5619.7 5623.6 5623.6 5675.8 5612.6 5622.4 5624.2 5625.5 5625.9 5364.2 5591.7 5599.3 5630.9 5655.4 5687.9 5688.8 5693.8 5694.4 5752.5 5398.2 5399.3 5581.1 5591.5 5596.0 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | [#1] ext.html Cycles:180 Average:61840.79 Median:42020.26 stddev:125528.37 (298.7%) stddev-sans-first:125796.16 06:18:09 INFO - PROCESS | 12416 | Values: 550.2 579.9 612.3 614.7 615.8 32108.7 33005.5 43836.3 44607.6 44660.8 45859.8 46294.3 46310.8 46323.5 46336.5 8733.0 8992.5 8997.5 9013.1 9039.4 8963.6 9021.7 9034.8 9044.9 9050.3 8851.5 8882.4 8890.3 8897.3 8900.2 9043.6 9048.2 9082.8 9094.8 9095.8 8926.5 9000.6 9003.5 9008.2 9017.0 42465.8 42623.5 42751.0 42770.1 42900.1 3587.4 3597.0 3643.3 3699.4 3944.2 32487.5 33126.0 33504.5 33557.8 33705.8 4331.6 4388.5 4426.5 4541.3 4610.2 336153.0 337216.0 340083.0 340166.0 340603.0 58806.0 59063.0 59213.0 59245.4 59249.1 63543.7 63594.0 63668.7 63700.0 63709.4 16291.2 17147.4 17362.8 17388.8 17400.6 12159.5 12695.0 12704.7 12705.0 12714.3 17972.3 19216.0 19370.3 19433.3 19535.8 6853.6 7064.9 7121.3 7323.5 7425.6 943.7 948.7 1093.5 1098.0 1112.8 30694.3 32251.8 32599.8 32915.5 33281.5 1037.7 1086.7 1140.7 1152.9 1155.8 16200.4 17169.2 17189.9 17198.9 17349.9 619302.0 626364.0 627008.0 627271.0 627640.0 60919.4 61697.0 61700.0 61722.1 61826.4 1218.9 1306.0 1329.2 1343.2 1363.5 31494.1 32425.7 33710.2 33719.0 34013.1 51206.2 51619.7 51633.2 51683.2 51834.2 400416.0 400732.0 400947.0 401005.0 401167.0 25567.7 27346.0 28268.0 28460.4 29695.0 47499.0 48380.3 48628.5 48989.5 49270.5 41284.2 41419.4 41663.8 43528.6 43674.3 40726.6 41218.4 41493.4 41896.0 42258.2 40349.8 40650.2 40876.4 41905.2 42135.4 35675.8 37786.4 38258.4 38510.8 38977.4 27505.7 28581.7 28616.4 28654.4 28842.0 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | [#2] jquery.html Cycles:180 Average:28508.79 Median:1576.68 stddev:77609.22 (4922.3%) stddev-sans-first:77798.19 06:18:09 INFO - PROCESS | 12416 | Values: 376.7 394.6 409.6 411.4 416.8 15692.0 19179.2 19234.8 19360.2 19621.6 19107.8 19367.0 19442.7 19607.2 19912.0 5226.3 5725.5 5850.9 5895.7 5941.4 4271.6 5839.0 6196.3 6473.0 6492.1 6334.0 6544.5 6548.7 6548.8 6558.8 6507.6 6527.5 6555.3 6558.7 6560.6 5095.4 5341.3 5378.0 5809.9 5810.2 13885.8 14056.4 14145.9 18245.5 22423.6 2195.9 2211.1 2501.6 2642.6 2776.6 10083.7 10356.3 10656.5 10668.9 12094.8 1776.8 1869.1 1906.2 1938.5 1951.3 78007.0 83608.0 84722.6 85506.0 85606.0 10695.7 10703.8 11085.9 11094.3 11128.8 15636.4 15687.3 15736.8 15745.1 15759.8 7790.4 8057.5 8117.9 8276.3 8323.4 7598.8 7635.2 7716.8 7810.8 7886.1 4765.5 4835.4 4861.5 4924.6 4929.9 1822.9 1830.5 1863.0 1874.3 1944.6 816.8 899.6 912.3 956.4 1069.5 17403.1 18379.4 18744.3 18800.2 19066.5 926.9 946.3 970.4 988.5 1003.0 10097.2 10409.3 10560.8 10574.0 10587.3 451269.0 460125.0 476260.0 476495.0 479351.0 91445.1 92403.5 94242.0 96301.0 97147.5 1001.8 1061.6 1065.5 1078.5 1079.4 17141.0 17248.6 17902.6 17982.9 18290.0 42590.8 42684.6 45028.0 45560.0 46017.8 60844.4 61205.4 61840.0 62286.4 62405.7 7429.5 7767.4 7802.6 8071.0 8126.9 12646.6 12651.6 13122.9 13271.0 13424.5 11219.9 11401.9 11427.5 11727.6 11829.0 11046.1 11171.2 11368.8 11686.5 11888.6 11048.2 11239.8 11711.5 11910.8 12218.3 7809.3 7951.4 8003.0 8186.1 8215.7 9508.0 11338.8 11412.3 11682.9 11698.4 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | [#3] mootools.html Cycles:180 Average:5900.98 Median:2687.27 stddev:3402.48 (126.6%) stddev-sans-first:3394.81 06:18:09 INFO - PROCESS | 12416 | Values: 1347.0 1475.7 1506.2 1626.0 1796.6 8462.2 8934.0 8945.2 9125.5 9126.2 8641.9 8738.9 8744.6 8751.8 8755.6 2384.0 2415.8 2417.3 2417.8 2418.1 2355.5 2383.3 2419.6 2421.2 2422.0 2379.0 2405.7 2408.6 2409.0 2415.3 2296.8 2332.8 2343.0 2343.8 2359.0 2217.9 2241.1 2249.6 2263.3 2265.3 8509.9 8640.5 8722.1 8723.2 8772.6 5185.9 5347.8 5353.7 5355.0 5359.9 3419.7 3446.6 3454.4 3458.8 3516.9 1047.4 1070.0 1076.1 1089.6 1102.2 12708.7 12739.4 12814.6 12823.5 12824.8 4547.9 4682.0 4860.4 4886.9 4898.0 9982.0 9993.3 10002.8 10003.1 10005.1 5506.8 5551.3 5557.1 5562.3 5566.9 4381.6 4902.6 5078.4 5103.5 5211.9 3710.3 3800.1 3823.0 3892.8 3913.8 1156.4 1169.2 1179.7 1180.6 1190.8 878.4 961.4 973.2 976.2 986.6 5817.7 5927.3 5976.0 6054.0 6410.6 465.4 473.7 483.3 487.7 490.5 4146.5 4234.8 4242.3 4263.7 4297.4 11156.8 11428.5 11495.5 11516.9 11548.2 10479.5 10957.1 11361.0 11428.8 11431.8 8340.8 8526.7 8532.6 8533.2 8537.5 6051.5 6193.2 6230.8 6321.5 6349.4 10202.7 10459.4 10528.4 10531.3 10625.7 10075.3 10337.3 10455.3 10619.5 10772.7 7000.7 7758.0 7913.0 8010.2 8163.8 8809.3 8908.0 8912.2 8922.5 8928.6 7614.0 7640.5 7676.5 7828.5 8003.3 7720.0 7739.8 7786.3 7860.7 8013.2 6975.5 7072.9 7087.2 7088.2 7103.3 4925.1 5197.4 5208.5 5217.2 5559.9 5348.2 5363.1 5376.1 5500.4 5543.2 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | [#4] prototype.html Cycles:180 Average:4533.60 Median:5073.57 stddev:1281.50 (25.3%) stddev-sans-first:1245.70 06:18:09 INFO - PROCESS | 12416 | Values: 333.0 334.5 337.6 339.1 351.1 5168.4 5251.8 5306.6 5327.5 5376.9 5214.5 5256.7 5295.8 5299.0 5329.4 4178.3 4182.2 4189.0 4195.3 4218.5 4166.0 4167.8 4208.8 4220.6 4221.9 4178.6 4182.7 4188.5 4190.1 4197.4 4160.1 4160.5 4191.5 4195.3 4201.3 3627.9 3732.1 3748.3 3757.7 3763.7 5100.5 5117.1 5119.7 5136.5 5156.0 4761.4 4770.5 4771.9 4779.5 4796.5 5327.3 5416.6 5444.9 5470.8 5534.8 4036.5 4037.3 4050.5 4053.3 4093.8 5737.9 5756.9 5759.5 5778.3 5804.1 4118.6 4204.4 4212.7 4232.8 4233.6 4225.4 4226.6 4227.2 4227.9 4231.4 4736.4 4743.9 4752.2 4753.8 4792.7 5329.4 5454.7 5533.0 5560.7 5565.8 1393.2 1416.4 1456.2 1456.6 1461.4 1007.8 1026.6 1046.8 1049.3 1052.6 5264.5 5272.3 5281.1 5283.6 5309.9 5563.9 5605.7 5608.9 5609.9 5622.7 5107.0 5274.4 5295.4 5313.4 5327.7 2658.9 2660.6 2669.1 2672.0 2678.1 5123.8 5151.8 5165.4 5184.9 5196.3 4797.3 5070.4 5073.4 5073.7 5093.6 5157.7 5158.8 5173.2 5185.9 5188.8 4904.7 4911.4 4962.8 4983.5 5026.6 4690.4 4873.5 4904.3 4904.4 4933.6 5098.7 5117.8 5124.7 5128.6 5138.9 3805.8 3838.2 3839.9 3853.1 3865.2 4777.3 4836.9 4920.0 5387.8 5468.6 5440.7 5471.5 5518.7 5530.1 5568.6 5500.3 5515.1 5520.7 5526.9 5542.7 5270.5 5519.8 5526.3 5529.5 5534.3 5552.0 5567.3 5590.9 5596.6 5605.8 5204.9 5395.2 5426.2 5435.5 5498.3 06:18:09 INFO - PROCESS | 12416 | 06:18:09 INFO - PROCESS | 12416 | [#5] yui.html Cycles:180 Average:20112.20 Median:4540.45 stddev:28568.62 (629.2%) stddev-sans-first:28611.80 06:18:09 INFO - PROCESS | 12416 | Values: 756.6 777.9 805.7 816.5 850.7 14372.3 14979.6 15272.1 15301.2 15352.9 14511.3 14618.3 14645.5 14671.6 15141.5 646.2 778.7 781.2 795.8 800.3 783.4 785.9 786.1 786.2 790.1 851.8 852.6 853.4 853.8 857.5 683.4 816.7 835.1 843.5 846.8 620.2 620.5 624.0 627.0 627.1 13924.4 13946.2 13961.5 14007.0 14008.2 13627.3 14012.8 14339.7 14375.1 14415.6 12548.4 12560.9 12649.4 12700.0 13077.5 4314.1 4345.7 4359.1 4403.3 4430.7 80484.6 81842.0 81913.0 82032.0 83345.6 11381.0 11493.7 11532.7 11647.2 12068.6 18224.3 18256.5 18280.5 18302.8 18316.9 8229.2 8294.7 8344.9 8452.7 8753.9 4360.8 4488.8 4535.0 4545.9 4596.4 3245.7 3370.4 3378.0 3378.7 3379.8 556.5 558.1 566.9 570.8 571.4 683.7 683.7 697.9 703.2 707.1 9021.5 9118.0 9408.4 9621.7 9707.6 569.1 633.8 636.8 683.8 693.4 4594.7 4770.3 4879.5 4898.1 4934.6 100830.0 101973.5 104972.5 127211.4 133467.0 60571.7 69449.7 93874.5 94210.0 95758.5 54468.7 69865.7 82791.0 83135.0 83610.6 9364.3 9948.4 10031.1 10209.3 10220.6 49766.0 50440.5 51900.0 52127.0 52260.2 68290.7 69969.3 76235.6 76935.0 77231.6 12467.6 12813.8 12881.4 13161.7 13248.5 13199.6 13341.7 13444.3 13448.9 14383.2 12119.8 12123.5 12363.0 14441.3 14931.9 14531.3 14584.3 14825.5 15201.4 15832.2 13122.6 14602.6 14724.9 14814.8 15292.0 11859.4 12180.1 12376.6 12577.2 12579.1 12229.8 12416.3 12606.6 12625.3 12748.7 06:18:09 INFO - PROCESS | 12416 | -------- Summary: end -------- 06:18:09 INFO - PROCESS | 12416 | 06:18:10 INFO - TEST-INFO | 12416: exit 0 06:18:10 INFO - TEST-OK | dromaeo_css | took 1116084ms 06:18:10 INFO - TEST-START | kraken 06:18:10 INFO - operating with platform_type : linux_ 06:18:10 INFO - Initialising browser for kraken test... 06:18:10 INFO - TEST-INFO | started process 12725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprevlNj/profile http://localhost:46720/getInfo.html) 06:18:15 INFO - PROCESS | 12725 | __metrics Screen width/height:1600/1200 06:18:15 INFO - PROCESS | 12725 | colorDepth:24 06:18:15 INFO - PROCESS | 12725 | Browser inner width/height: 1024/697 06:18:15 INFO - PROCESS | 12725 | __metrics 06:18:15 INFO - PROCESS | 12725 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:18:15 INFO - PROCESS | 12725 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:18:16 INFO - PROCESS | 12725 | console.error: PushService: 06:18:16 INFO - PROCESS | 12725 | stateChangeProcessEnqueue: Error transitioning state 06:18:16 INFO - PROCESS | 12725 | UnknownError 06:18:16 INFO - TEST-INFO | 12725: exit 0 06:18:16 INFO - Browser initialized. 06:18:16 INFO - Running cycle 1/1 for kraken test... 06:18:16 INFO - TEST-INFO | started process 12808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprevlNj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:28 INFO - PROCESS | 12808 | RSS: Main: 180211712 06:18:28 INFO - PROCESS | 12808 | 06:18:31 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46720/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:32 INFO - PROCESS | 12808 | RSS: Main: 233271296 06:18:32 INFO - PROCESS | 12808 | 06:18:34 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46720/tests/kraken/driver.html?testName=audio-dft) 06:18:35 INFO - PROCESS | 12808 | RSS: Main: 224071680 06:18:35 INFO - PROCESS | 12808 | 06:18:38 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46720/tests/kraken/driver.html?testName=audio-fft) 06:18:39 INFO - PROCESS | 12808 | RSS: Main: 300122112 06:18:39 INFO - PROCESS | 12808 | 06:18:41 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46720/tests/kraken/driver.html?testName=audio-oscillator) 06:18:41 INFO - PROCESS | 12808 | RSS: Main: 211021824 06:18:41 INFO - PROCESS | 12808 | 06:18:43 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:44 INFO - PROCESS | 12808 | RSS: Main: 213684224 06:18:44 INFO - PROCESS | 12808 | 06:18:47 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46720/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:48 INFO - PROCESS | 12808 | RSS: Main: 252096512 06:18:48 INFO - PROCESS | 12808 | 06:18:51 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46720/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:52 INFO - PROCESS | 12808 | RSS: Main: 251301888 06:18:52 INFO - PROCESS | 12808 | 06:18:54 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46720/tests/kraken/driver.html?testName=json-parse-financial) 06:18:55 INFO - PROCESS | 12808 | RSS: Main: 251817984 06:18:55 INFO - PROCESS | 12808 | 06:18:57 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:57 INFO - PROCESS | 12808 | RSS: Main: 213368832 06:18:57 INFO - PROCESS | 12808 | 06:18:59 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:19:00 INFO - PROCESS | 12808 | RSS: Main: 220061696 06:19:00 INFO - PROCESS | 12808 | 06:19:02 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:02 INFO - PROCESS | 12808 | RSS: Main: 222330880 06:19:02 INFO - PROCESS | 12808 | 06:19:05 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:05 INFO - PROCESS | 12808 | RSS: Main: 223342592 06:19:05 INFO - PROCESS | 12808 | 06:19:08 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:09 INFO - PROCESS | 12808 | RSS: Main: 221159424 06:19:09 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | Cycle 1(1): loaded http://localhost:46720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46720/tests/kraken/driver.html?testName=ai-astar) 06:19:11 INFO - PROCESS | 12808 | RSS: Main: 272097280 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | __start_tp_report 06:19:11 INFO - PROCESS | 12808 | _x_x_mozilla_page_load 06:19:11 INFO - PROCESS | 12808 | _x_x_mozilla_page_load_details 06:19:11 INFO - PROCESS | 12808 | |i|pagename|runs| 06:19:11 INFO - PROCESS | 12808 | |0;ai-astar;113;112;131;110;111;112;112;112;112;113 06:19:11 INFO - PROCESS | 12808 | |1;audio-beat-detection;148;127;155;180;121;145;145;119;173;122 06:19:11 INFO - PROCESS | 12808 | |2;audio-dft;160;161;161;161;162;163;163;162;161;162 06:19:11 INFO - PROCESS | 12808 | |3;audio-fft;74;74;75;176;75;75;75;76;156;76 06:19:11 INFO - PROCESS | 12808 | |4;audio-oscillator;82;82;138;82;82;82;136;82;83;139 06:19:11 INFO - PROCESS | 12808 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;118;116 06:19:11 INFO - PROCESS | 12808 | |6;imaging-darkroom;147;145;145;145;146;147;146;146;147;146 06:19:11 INFO - PROCESS | 12808 | |7;imaging-desaturate;95;96;96;95;95;96;96;95;95;95 06:19:11 INFO - PROCESS | 12808 | |8;json-parse-financial;54;50;53;52;53;54;53;52;52;52 06:19:11 INFO - PROCESS | 12808 | |9;json-stringify-tinderbox;62;63;62;62;63;63;62;63;64;63 06:19:11 INFO - PROCESS | 12808 | |10;stanford-crypto-aes;85;86;79;79;79;79;78;78;79;78 06:19:11 INFO - PROCESS | 12808 | |11;stanford-crypto-ccm;126;131;122;126;127;131;125;122;161;123 06:19:11 INFO - PROCESS | 12808 | |12;stanford-crypto-pbkdf2;166;172;170;166;164;165;166;163;172;168 06:19:11 INFO - PROCESS | 12808 | |13;stanford-crypto-sha256-iterative;66;67;70;65;67;64;71;67;64;64 06:19:11 INFO - PROCESS | 12808 | __end_tp_report 06:19:11 INFO - PROCESS | 12808 | __start_cc_report 06:19:11 INFO - PROCESS | 12808 | _x_x_mozilla_cycle_collect,1730 06:19:11 INFO - PROCESS | 12808 | __end_cc_report 06:19:11 INFO - PROCESS | 12808 | __startTimestamp1472735951260__endTimestamp 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | ------- Summary: start ------- 06:19:11 INFO - PROCESS | 12808 | Number of tests: 14 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#0] ai-astar Cycles:10 Average:113.80 Median:112.00 stddev:6.11 (5.5%) stddev-sans-first:6.47 06:19:11 INFO - PROCESS | 12808 | Values: 113.0 112.0 131.0 110.0 111.0 112.0 112.0 112.0 112.0 113.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:146.50 stddev:21.60 (14.7%) stddev-sans-first:22.85 06:19:11 INFO - PROCESS | 12808 | Values: 148.0 127.0 155.0 180.0 121.0 145.0 145.0 119.0 173.0 122.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 06:19:11 INFO - PROCESS | 12808 | Values: 160.0 161.0 161.0 161.0 162.0 163.0 163.0 162.0 161.0 162.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:38.66 (51.6%) stddev-sans-first:40.38 06:19:11 INFO - PROCESS | 12808 | Values: 74.0 74.0 75.0 176.0 75.0 75.0 75.0 76.0 156.0 76.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#4] audio-oscillator Cycles:10 Average:98.80 Median:82.00 stddev:26.83 (32.7%) stddev-sans-first:27.76 06:19:11 INFO - PROCESS | 12808 | Values: 82.0 82.0 138.0 82.0 82.0 82.0 136.0 82.0 83.0 139.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:19:11 INFO - PROCESS | 12808 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 06:19:11 INFO - PROCESS | 12808 | Values: 147.0 145.0 145.0 145.0 146.0 147.0 146.0 146.0 147.0 146.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:19:11 INFO - PROCESS | 12808 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:1.18 (2.2%) stddev-sans-first:1.12 06:19:11 INFO - PROCESS | 12808 | Values: 54.0 50.0 53.0 52.0 53.0 54.0 53.0 52.0 52.0 52.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:19:11 INFO - PROCESS | 12808 | Values: 62.0 63.0 62.0 62.0 63.0 63.0 62.0 63.0 64.0 63.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:2.94 (3.7%) stddev-sans-first:2.51 06:19:11 INFO - PROCESS | 12808 | Values: 85.0 86.0 79.0 79.0 79.0 79.0 78.0 78.0 79.0 78.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:126.50 stddev:11.56 (9.1%) stddev-sans-first:12.19 06:19:11 INFO - PROCESS | 12808 | Values: 126.0 131.0 122.0 126.0 127.0 131.0 125.0 122.0 161.0 123.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.00 stddev:3.19 (1.9%) stddev-sans-first:3.35 06:19:11 INFO - PROCESS | 12808 | Values: 166.0 172.0 170.0 166.0 164.0 165.0 166.0 163.0 172.0 168.0 06:19:11 INFO - PROCESS | 12808 | 06:19:11 INFO - PROCESS | 12808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:2.46 (3.7%) stddev-sans-first:2.60 06:19:11 INFO - PROCESS | 12808 | Values: 66.0 67.0 70.0 65.0 67.0 64.0 71.0 67.0 64.0 64.0 06:19:11 INFO - PROCESS | 12808 | -------- Summary: end -------- 06:19:11 INFO - PROCESS | 12808 | 06:19:12 INFO - TEST-INFO | 12808: exit 0 06:19:12 INFO - TEST-OK | kraken | took 61724ms 06:19:12 INFO - SUITE-END | took 1177s 06:19:12 INFO - Completed test suite (00:19:38) 06:19:12 INFO - javascript benchmark 06:19:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2974.6281714785646, 2987.925301867453, 2996.1460983619672, 3026.077046500819, 3052.9694703052965, 5241.84274471766, 5256.474352564742, 5351.946480535194, 5354.9196762048605, 5356.1162408202645, 5374.328208973879, 5411.891762164754, 5436.728163591814, 5466.890662186754, 5488.53347465465, 4828.87927801806, 4881.096997055556, 4915.754212289389, 4930.827421040264, 5043.495650434946, 4936.80252789888, 4984.37695288089, 4986.601071914256, 4997.625178111638, 5003.624728145385, 4751.026039661879, 4851.078295123951, 4866.7566621668775, 4934.80260789568, 4980.850574482772, 4832.903341933142, 4859.635527335464, 4865.416150062015, 4961.330220420233, 4968.552830245259, 4883.169861123618, 4897.926531102036, 4914.3611330527165, 4916.164252077119, 4966.453690094087, 5177.326947496839, 5333.0, 5412.134058550652, 5412.5940554458175, 5417.241586177938, 5758.107493338539, 5759.136129580555, 5764.625299355528, 5766.192733017381, 5842.707864606753, 5764.07774756037, 5815.447532484407, 5831.125331200312, 5831.912521312183, 5834.066549352126, 5167.586593072545, 5340.49265319794, 5380.811671591476, 5404.351477822686, 5409.5672346212605, 5948.613340132878, 5949.0481522956115, 5950.434708702666, 6002.369751176151, 6016.127661489059, 5695.316562012585, 5703.54371650267, 5703.857403564944, 5704.515116215168, 5705.828825135252, 5582.302212223472, 5627.465390787868, 5644.6613203207935, 5786.392428795, 5791.623544469596, 5680.943190568124, 5684.77260909559, 5687.118496633028, 5739.282589676291, 5754.510866576388, 5643.238162847963, 5698.1737648041635, 5704.8859022819315, 5706.201131841545, 5709.3434255060365, 4351.847685331061, 4375.7155784873885, 4391.560843915583, 4425.557444255549, 4428.446444194476, 3920.1179734559496, 3929.980350098231, 3946.2699400610977, 3970.7220494565104, 3986.5016872890887, 5421.349438067457, 5435.537979271727, 5440.591955603346, 5440.891182176334, 5453.100238460689, 5499.422560631157, 5707.429257074259, 5766.654000759968, 5769.221155144001, 5784.363719990798, 5488.451154884479, 5492.231087647732, 5527.198556209408, 5527.861803454945, 5554.638948468337, 4995.300657907896, 5004.599632029429, 5007.624428167902, 5011.473795251519, 5058.873528161752, 5782.392848750821, 5918.496927761188, 5957.344692083867, 6004.699765011645, 6012.699365031731, 5775.768969241183, 5902.321233058254, 5905.0, 5910.0, 5911.349751527415, 6024.518038556993, 6024.7288872001745, 6026.578139530367, 6035.637861728311, 6086.69566521681, 5661.377248502579, 5703.144528320785, 5712.885742285214, 5714.714264286852, 5735.111057785883, 5580.135079062752, 5660.122680984454, 5680.147977803363, 5683.033884239607, 5838.94161058401, 5571.777128914798, 5619.719014049363, 5623.606347555632, 5623.606347555796, 5675.772969081356, 5612.635178713534, 5622.437756224344, 5624.212610234488, 5625.5218306442775, 5625.943740562706, 5364.222187782828, 5591.664500130005, 5599.272094627672, 5630.887382252414, 5655.406182350958, 5687.886242275049, 5688.77244910199, 5693.772249109989, 5694.430556944438, 5752.482276595127, 5398.244245805512, 5399.271098401666, 5581.10702287632, 5591.524720398649, 5596.0206963780365], "value": 5311.043998659014, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2472751716522, 579.904315787895, 612.2805703298623, 614.7325913227747, 615.8306465721926, 32108.67891321086, 33005.50491742623, 43836.3424548632, 44607.55392446074, 44660.776696116554, 45859.770701146444, 46294.305585416165, 46310.76844615772, 46323.53676463234, 46336.536634633645, 8732.95633521833, 8992.460452372847, 8997.460152390844, 9013.098690131, 9039.367244292902, 8963.641454341818, 9021.684241051564, 9034.819303613924, 9044.8643270351, 9050.275977921783, 8851.468911865277, 8882.422642528247, 8890.288776897865, 8897.33270004749, 8900.19898209161, 9043.638254469814, 9048.230900373475, 9082.77293067672, 9094.772630684285, 9095.772605684844, 8926.464412135292, 9000.59497322622, 9003.549822508849, 9008.1892629663, 9017.0, 42465.78767106176, 42623.45895033626, 42751.0, 42770.14459710789, 42900.14199716019, 3587.443946188319, 3597.0, 3643.2531331077066, 3699.445083237536, 3944.2111577684577, 32487.51268730971, 33126.0, 33504.497432538534, 33557.832210839035, 33705.831470842735, 4331.633872381081, 4388.49532303786, 4426.535213802536, 4541.273396256616, 4610.170169369512, 336153.0, 337216.0, 340083.0, 340166.0, 340603.0, 58806.0, 59063.0, 59213.0, 59245.40754592485, 59249.111263331084, 63543.6822815883, 63594.0, 63668.68165659142, 63700.0, 63709.36290637127, 16291.185440727917, 17147.399841005754, 17362.826371736373, 17388.782785204916, 17400.564985875455, 12159.5136194553, 12695.0, 12704.745905081847, 12705.0, 12714.300713460663, 17972.272033093774, 19216.039198040322, 19370.322038728576, 19433.31983380575, 19535.804641953684, 6853.588784672936, 7064.929350706427, 7121.323474269936, 7323.450741194325, 7425.62871856405, 943.6744323208619, 948.7438391634358, 1093.5461783359817, 1097.9945100274447, 1112.7607564373536, 30694.285001247816, 32251.838740806146, 32599.837000814845, 32915.50626740601, 33281.500777488356, 1037.7301901505664, 1086.6848613902039, 1140.7433327501246, 1152.9192956493132, 1155.8447381662909, 16200.351985920666, 17169.227384767717, 17189.914050429667, 17198.91400542989, 17349.87225830317, 619302.0, 626364.0, 627008.0, 627271.0, 627640.0, 60919.390806091375, 61697.0, 61700.0, 61722.074168887506, 61826.381736182964, 1218.9268643881396, 1305.9608211753662, 1329.195836518892, 1343.187371640163, 1363.5023216526095, 31494.055178344686, 32425.675743242267, 33710.157246069044, 33719.0, 34013.14967125842, 51206.23190652069, 51619.741901290254, 51633.225501616755, 51683.22475162951, 51834.222486663486, 400416.0, 400732.0, 400947.0, 401005.0, 401167.0, 25567.744322556537, 27346.0, 28268.0, 28460.430791383642, 29694.95185818373, 47499.0, 48380.274295886295, 48628.5137148624, 48989.510104898494, 49270.50729492659, 41284.1743165129, 41419.37870931878, 41663.7916810414, 43528.56471435245, 43674.34488482739, 40726.59273407228, 41218.38172427476, 41493.37759933543, 41896.0, 42258.154836902475, 40349.79825100856, 40650.1869962605, 40876.38685419781, 41905.1618967625, 42135.36796948109, 35675.82162089277, 37786.43320350142, 38258.42612360761, 38510.80744596259, 38977.41533876937, 27505.724942750316, 28581.714182857904, 28616.427671446872, 28654.426911461236, 28842.0], "value": 20361.8695901122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.719344088654, 394.57780175212514, 409.6129157945742, 411.38703332035266, 416.7520325406382, 15691.960045194122, 19179.232830686775, 19234.80765192348, 19360.225590976363, 19621.607567848634, 19107.808921910775, 19367.0, 19442.70835937462, 19607.215711371562, 19912.0, 5226.320578324812, 5725.541956643479, 5850.912236316437, 5895.675737834417, 5941.376155503674, 4271.594198551148, 5838.970805145968, 6196.2874269459135, 6472.967635161841, 6492.091107244966, 6334.0, 6544.509161812859, 6548.70530826114, 6548.8035358939305, 6558.80323590293, 6507.609543427409, 6527.543071984963, 6555.344465553454, 6558.672066396661, 6560.639164845931, 5095.414027386861, 5341.252224688546, 5378.031954248234, 5809.941900580982, 5810.1865738796605, 13885.791713124312, 14056.367463464168, 14145.929270353685, 18245.54386140357, 22423.551528969492, 2195.868247905131, 2211.1487077475126, 2501.58723810571, 2642.643243162187, 2776.639036925207, 10083.697489075339, 10356.275060745751, 10656.467176641137, 10668.893311066946, 12094.818577721342, 1776.7512548243255, 1869.084148767108, 1906.1670693547799, 1938.4766113149371, 1951.3365455745115, 78007.0, 83608.0, 84722.57638711829, 85505.99999999937, 85606.0, 10695.73260668474, 10703.83944240837, 11085.889141108648, 11094.278871873303, 11128.777424451466, 15636.3745450183, 15687.294071766797, 15736.763948540782, 15745.055296682236, 15759.842401576067, 7790.376769858398, 8057.516549006961, 8117.863499110129, 8276.29651479631, 8323.417360784808, 7598.772036838904, 7635.198304177981, 7716.807079823049, 7810.804729881685, 7886.132525422199, 4765.499622539653, 4835.44392394872, 4861.490208533935, 4924.581410580141, 4929.926051109236, 1822.9361972330905, 1830.5240637434363, 1863.0312237636354, 1874.2877706471727, 1944.5527528668204, 816.8447994880953, 899.6221586933503, 912.3203213605906, 956.4404823178379, 1069.5080263078914, 17403.129843507773, 18379.448616541526, 18744.25022999065, 18800.247990080243, 19066.52333691641, 926.9212116970133, 946.2997381937316, 970.4419958523877, 988.461288597716, 1003.007023047178, 10097.192224622013, 10409.323393979366, 10560.841587376195, 10574.0, 10587.311824731369, 451269.0, 460125.0, 476260.0, 476495.0, 479351.0, 91445.08554914499, 92403.537982311, 94242.0, 96301.0, 97147.51426242964, 1001.7960486928786, 1061.6231237910586, 1065.4725910674265, 1078.487718333785, 1079.3631757263252, 17141.0, 17248.568785779953, 17902.55243618868, 17982.910085450014, 18289.994050326826, 42590.78704606457, 42684.5731542693, 45028.0, 45560.0, 46017.76991115023, 60844.39155608564, 61205.38794611997, 61840.0, 62286.37713622806, 62405.687971559855, 7429.4799364044, 7767.417443691633, 7802.609869506616, 8071.0, 8126.878096828434, 12646.620601381974, 12651.620451386472, 13122.868771312547, 13271.023366237661, 13424.463021479032, 11219.943900280772, 11401.942990284995, 11427.542898284308, 11727.589534366256, 11829.0, 11046.061084807881, 11171.21801473889, 11368.829467558158, 11686.474108665301, 11888.643340699793, 11048.232282834708, 11239.775204495701, 11711.472983715583, 11910.821337680116, 12218.327991960528, 7809.33620642229, 7951.3638908886, 8002.9599852000365, 8186.099529051919, 8215.72656238284, 9507.952460237655, 11338.773224535627, 11412.258203216765, 11682.88317116852, 11698.415079246173], "value": 9162.487017095737, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.036868638923, 1475.7343678137938, 1506.1866592040299, 1625.967480650387, 1796.5957659526607, 8462.153784621534, 8934.0, 8945.150210729986, 9125.452472851634, 9126.178643922045, 8641.870371944426, 8738.86891696625, 8744.606492707828, 8751.781205469866, 8755.562221888897, 2383.9880800596015, 2415.830891837572, 2417.323149518129, 2417.830751847371, 2418.117387153694, 2355.4700192456644, 2383.332666853275, 2419.5765740995344, 2421.2010036687852, 2421.987890060547, 2378.9643155352596, 2405.6992875890514, 2408.638704194367, 2408.95182096358, 2415.3478560788576, 2296.8047715944167, 2332.7783860533223, 2342.9765702343016, 2343.8124950003958, 2358.9646155307682, 2217.868886867693, 2241.0699559682876, 2249.6175650139517, 2263.2757517594214, 2265.3090807303765, 8509.872351914726, 8640.481571105754, 8722.127787221227, 8723.171298726611, 8772.605232764541, 5185.922211166836, 5347.759350829222, 5353.678779273256, 5355.0, 5359.892802143974, 3419.6580341965855, 3446.5864096308605, 3454.447288433864, 3458.792472451661, 3516.894493165209, 1047.3872784421123, 1070.0209308482729, 1076.0638244727058, 1089.6186334782842, 1102.228440091931, 12708.682282942907, 12739.36303184837, 12814.615561533168, 12823.487060517567, 12824.80762788559, 4547.884698981143, 4682.0, 4860.392450943632, 4886.877828054256, 4897.975510122426, 9981.950090249647, 9993.250506211918, 10002.799944001079, 10003.14973227284, 10005.14956228714, 5506.752196151183, 5551.250581171571, 5557.110862262019, 5562.276904002535, 5566.944330556724, 4381.605655491021, 4902.558769710743, 5078.4413714491375, 5103.489651034941, 5211.869703257373, 3710.2950439416422, 3800.1449673823167, 3822.980885095557, 3892.766434013968, 3913.8434462621176, 1156.3697784707354, 1169.2283093158474, 1179.728662407634, 1180.6399048290355, 1190.7916114679897, 878.3544095090103, 961.4135377419768, 973.2116985241977, 976.2190247801872, 986.6448078691665, 5817.680027598438, 5927.347991720907, 5976.0, 6053.969730151409, 6410.55126141175, 465.4344970860421, 473.67789902865695, 483.3233473137565, 487.65620237732315, 490.53644306131076, 4146.481689788777, 4234.788260586958, 4242.342436922282, 4263.744175349489, 4297.441332626739, 11156.832647510293, 11428.542858285575, 11495.540178392937, 11516.942415288038, 11548.249363791494, 10479.47602619866, 10957.06864916475, 11361.0, 11428.771424571629, 11431.771364572829, 8340.833183336421, 8526.701565445179, 8532.57337133141, 8533.232009119209, 8537.487750734852, 6051.5461340400525, 6193.194884664965, 6230.844228894314, 6321.462675672619, 6349.396807303298, 10202.693919182437, 10459.391509929063, 10528.420936848546, 10531.262811603114, 10625.681229563126, 10075.34510256831, 10337.328073675188, 10455.268131230741, 10619.522121504706, 10772.730681732706, 7000.684969176501, 7758.0, 7913.0, 8010.239027292398, 8163.79590510242, 8809.295256379603, 8907.955460222658, 8912.153345432174, 8922.509261990393, 8928.642854285756, 7614.0, 7640.465167438226, 7676.462647614837, 7828.491148075357, 8003.31971782405, 7719.961400192963, 7739.845203096019, 7786.299233069051, 7860.724874629361, 8013.2387423194705, 6975.546589471668, 7072.893906591303, 7087.220405755466, 7088.184858741311, 7103.289671032855, 4925.064237794808, 5197.428282888804, 5208.5312321891215, 5217.191335343028, 5559.944400555943, 5348.224507446476, 5363.141897296414, 5376.1398176291605, 5500.367457742411, 5543.202906009396], "value": 4617.432895878051, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9500574913761, 334.50159262698577, 337.5729701927061, 339.1352052266719, 351.13970771609564, 5168.3539557555305, 5251.818340873311, 5306.575473962083, 5327.467253274675, 5376.946230537698, 5214.530692237698, 5256.710880901558, 5295.761690723926, 5298.973505132479, 5329.360476742787, 4178.268802959486, 4182.22628813669, 4188.9946412860845, 4195.307774217251, 4218.493780746315, 4165.979170104145, 4167.791610419482, 4208.789560521977, 4220.620144187023, 4221.873343799691, 4178.582141785812, 4182.749035057906, 4188.476440444944, 4190.057237121654, 4197.433346498215, 4160.126373461592, 4160.500739911215, 4191.455110835603, 4195.286801243796, 4201.34879093741, 3627.8911632650797, 3732.104294969188, 3748.3253014457387, 3757.7369584129124, 3763.680087192592, 5100.489951004907, 5117.078925793356, 5119.667221630582, 5136.512031357015, 5155.9742201288755, 4761.428628564559, 4770.451398089194, 4771.880702982418, 4779.450363208241, 4796.544328288807, 5327.345616762932, 5416.647917885364, 5444.945550544483, 5470.753816078286, 5534.806281780158, 4036.455078564415, 4037.253108174997, 4050.534188568323, 4053.250148722496, 4093.7543747374957, 5737.942620573783, 5756.934967031071, 5759.481646651821, 5778.27771528559, 5804.071348584206, 4118.629323360912, 4204.4324016257415, 4212.7472351659, 4232.767197804089, 4233.555476674905, 4225.366195070764, 4226.647472808733, 4227.175700738388, 4227.936580951288, 4231.449911511484, 4736.4316282046375, 4743.857684269477, 4752.2158843790385, 4753.764021354473, 4792.736399497991, 5329.360476742816, 5454.745298667046, 5532.972335138298, 5560.694161821139, 5565.805196818092, 1393.1501783911806, 1416.4065426395305, 1456.1990905002206, 1456.621278467585, 1461.4300422835104, 1007.7631756537207, 1026.630413051301, 1046.7697106636529, 1049.2917280835406, 1052.6473631333588, 5264.499872512105, 5272.261883336336, 5281.102212623863, 5283.550898173621, 5309.946900531023, 5563.944360556424, 5605.720653417797, 5608.887822243532, 5609.915851262234, 5622.662640241517, 5107.03379199011, 5274.393444753902, 5295.4439783822145, 5313.388960269541, 5327.653702509325, 2658.9468210636064, 2660.629775665534, 2669.1325319271314, 2671.986640066787, 2678.1429942418627, 5123.795048198105, 5151.80588035413, 5165.431802501722, 5184.922226166611, 5196.298499702491, 4797.2564252540915, 5070.414088814731, 5073.3911930568565, 5073.746312684351, 5093.592512599057, 5157.6532677631585, 5158.793648254103, 5173.249878767558, 5185.948140518546, 5188.844334669966, 4904.6566740327835, 4911.354696176821, 4962.776675049559, 4983.501649834988, 5026.623003274696, 4690.39024926771, 4873.5379386183295, 4904.288878112582, 4904.449686163247, 4933.58064564516, 5098.694078355311, 5117.795288188579, 5124.718140502308, 5128.640995130305, 5138.922916156335, 3805.752626079296, 3838.213166300846, 3839.884803455901, 3853.094522787199, 3865.16898866745, 4777.331173635764, 4836.886028241979, 4920.0, 5387.791005687649, 5468.589855760754, 5440.6735595864375, 5471.534919531884, 5518.696471694096, 5530.142827861688, 5568.554515638658, 5500.339959204921, 5515.062439385234, 5520.696361700145, 5526.944730552643, 5542.72286385671, 5270.497908096174, 5519.751611177427, 5526.25922834322, 5529.45645003303, 5534.335879694462, 5551.972885016285, 5567.331920169606, 5590.944090559043, 5596.565494009956, 5605.775768969195, 5204.869878252923, 5395.244665746877, 5426.240326354393, 5435.483629055233, 5498.285222920995], "value": 4136.077581150008, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.6330329790054, 777.9338756205722, 805.7421625079974, 816.5345752920836, 850.6980022092159, 14372.281385930713, 14979.625509362244, 15272.083674979494, 15301.158436286, 15352.923235383822, 14511.346989385476, 14618.342174602141, 14645.487407940724, 14671.633209169777, 15141.545753627408, 646.2180761278859, 778.6651739751904, 781.2421950707818, 795.8050277681976, 800.3117319105564, 783.4398405140323, 785.8860465232538, 786.0920636664662, 786.1705900275207, 790.1308560583341, 851.8296340731847, 852.6078004118082, 853.3727710133078, 853.7737499562621, 857.5240741388527, 683.4327508168209, 816.7223144130994, 835.1106072033265, 843.5444859775714, 846.7713717296357, 620.1906512001835, 620.4725982914532, 624.0327492386828, 626.962382257066, 627.05314974389, 13924.37340319678, 13946.16323020622, 13961.511347102803, 14007.0, 14008.22954737489, 13627.318634068357, 14012.789450689097, 14339.71320573593, 14375.137491750529, 14415.639609009753, 12548.435320410603, 12560.874391256062, 12649.367531623382, 12700.0, 13077.476900923952, 4314.115606300701, 4345.69580129391, 4359.10638319147, 4403.2954727243805, 4430.689851710382, 80484.59757701232, 81842.0, 81913.0, 82032.0, 83345.58327208325, 11381.044217534614, 11493.712657183638, 11532.711682208012, 11647.184697071123, 12068.577599783965, 18224.27102915895, 18256.452306430827, 18280.45158645243, 18302.816971830376, 18316.908415457838, 8229.218224268685, 8294.709685161111, 8344.874826877602, 8452.66189352419, 8753.912460875437, 4360.847370342023, 4488.820447182142, 4535.0, 4545.909081818345, 4596.402467679247, 3245.659205783406, 3370.443876760356, 3377.9866040187844, 3378.679025492574, 3379.763416560817, 556.5213916032209, 558.1209594888068, 566.931968163823, 570.7945139749687, 571.4143003421443, 683.719674933275, 683.7470136049693, 697.9336962988508, 703.2299631903059, 707.1337611426064, 9021.548922553977, 9118.0, 9408.43549387039, 9621.711348659552, 9707.563159657833, 569.0894568690063, 633.8447080465315, 636.8376064103717, 683.805115542078, 693.414065114977, 4594.678372513892, 4770.260609605447, 4879.463259041502, 4898.069366820364, 4934.55588996992, 100830.0, 101973.49013255035, 104972.47513762383, 127211.36394317969, 133467.0, 60571.69714151401, 69449.65275173692, 93874.53062734779, 94210.0, 95758.52120739491, 54468.72765636226, 69865.65067174734, 82791.0, 83135.0, 83610.5819470911, 9364.344495885494, 9948.35335703177, 10031.147352475122, 10209.336393134423, 10220.591176352862, 49766.004679906924, 50440.495595045046, 51900.0, 52127.0, 52260.21609675934, 68290.65854670695, 69969.30030699831, 76235.61882190553, 76935.0, 77231.61384193043, 12467.625971220878, 12813.8077928833, 12881.35593220354, 13161.670958226121, 13248.47006119783, 13199.604011879659, 13341.733165336833, 13444.327783610976, 13448.865511344762, 14383.208923509308, 12119.75760484803, 12123.454444550192, 12363.0, 14441.277936102942, 14931.85068149348, 14531.273436328353, 14584.270786460847, 14825.481108161162, 15201.391944322104, 15832.208389580705, 13122.60632181036, 14602.561923142322, 14724.852751472348, 14814.77777833355, 15292.0, 11859.407029648655, 12180.147389682637, 12376.566820161252, 12577.245365278113, 12579.119461637598, 12229.816552751538, 12416.317102559446, 12606.621801345975, 12625.305608191271, 12748.745025099632], "value": 7459.694735333826, "unit": "score"}], "name": "dromaeo_css", "value": 7215.968853305976, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 131.0, 110.0, 111.0, 112.0, 112.0, 112.0, 112.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 155.0, 180.0, 121.0, 145.0, 145.0, 119.0, 173.0, 122.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 162.0, 163.0, 163.0, 162.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 176.0, 75.0, 75.0, 75.0, 76.0, 156.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 138.0, 82.0, 82.0, 82.0, 136.0, 82.0, 83.0, 139.0], "value": 98.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 53.0, 52.0, 53.0, 54.0, 53.0, 52.0, 52.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 64.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 79.0, 79.0, 79.0, 79.0, 78.0, 78.0, 79.0, 78.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 122.0, 126.0, 127.0, 131.0, 125.0, 122.0, 161.0, 123.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 170.0, 166.0, 164.0, 165.0, 166.0, 163.0, 172.0, 168.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 70.0, 65.0, 67.0, 64.0, 71.0, 67.0, 64.0, 64.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1527.5, "alertThreshold": 2.0}]} 06:19:12 INFO - Return code: 0 06:19:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:19:13 INFO - # TBPL SUCCESS # 06:19:13 INFO - Running post-action listener: _resource_record_post_action 06:19:13 INFO - [mozharness: 2016-09-01 13:19:13.049476Z] Finished run-tests step (success) 06:19:13 INFO - Running post-run listener: _resource_record_post_run 06:19:13 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 16384; Write bytes: 424206336; Read time: 388; Write time: 277600 06:19:13 INFO - TinderboxPrint: CPU usage
13.1% 06:19:13 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 388 06:19:13 INFO - TinderboxPrint: I/O write bytes / time
424,206,336 / 277,600 06:19:13 INFO - TinderboxPrint: CPU idle
8,281.3 (86.9%) 06:19:13 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 06:19:13 INFO - TinderboxPrint: Swap in / out
0 / 0 06:19:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 135233536; Read time: 88; Write time: 97652 06:19:13 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288972800; Read time: 288; Write time: 179948 06:19:13 INFO - Running post-run listener: _upload_blobber_files 06:19:13 INFO - Blob upload gear active. 06:19:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:13 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 06:19:13 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'] 06:19:13 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 06:19:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:19:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:14 INFO - (blobuploader) - INFO - Done attempting. 06:19:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:19:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:19:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:15 INFO - (blobuploader) - INFO - Done attempting. 06:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:19:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:19:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:20 INFO - (blobuploader) - INFO - Done attempting. 06:19:20 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:20 INFO - Return code: 0 06:19:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bff5ee7bf59cd09b07a412d431f76084be8c4d1a2453bf45c95e8c4c18e3426d2bfc1a0bd6baefa7c5b1c0b36d4a408c9b2d83108b4e8f241fd486ade2921546", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411f2e6ded3ff482ef66a083c8f124958e0c2d538c57b194a9aa6bfcf7bbd77e2fcee8723c00cc0b22cc1854695dffdf2efc09f3c57039db2daddce391b6dc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ab78d3698bae60aba6e865751ec2943bd52816fff95d614ed3e3a541111b29ca900415b2e641cc5df09ebe8afc90533913c99ada8f4689314a16c66bbafe7f"} 06:19:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:20 INFO - Contents: 06:19:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bff5ee7bf59cd09b07a412d431f76084be8c4d1a2453bf45c95e8c4c18e3426d2bfc1a0bd6baefa7c5b1c0b36d4a408c9b2d83108b4e8f241fd486ade2921546", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411f2e6ded3ff482ef66a083c8f124958e0c2d538c57b194a9aa6bfcf7bbd77e2fcee8723c00cc0b22cc1854695dffdf2efc09f3c57039db2daddce391b6dc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ab78d3698bae60aba6e865751ec2943bd52816fff95d614ed3e3a541111b29ca900415b2e641cc5df09ebe8afc90533913c99ada8f4689314a16c66bbafe7f"} 06:19:20 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:20 INFO - Copying logs to upload dir... 06:19:20 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.993349 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-01 06:19:20.259161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:20.262483) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bff5ee7bf59cd09b07a412d431f76084be8c4d1a2453bf45c95e8c4c18e3426d2bfc1a0bd6baefa7c5b1c0b36d4a408c9b2d83108b4e8f241fd486ade2921546", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411f2e6ded3ff482ef66a083c8f124958e0c2d538c57b194a9aa6bfcf7bbd77e2fcee8723c00cc0b22cc1854695dffdf2efc09f3c57039db2daddce391b6dc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ab78d3698bae60aba6e865751ec2943bd52816fff95d614ed3e3a541111b29ca900415b2e641cc5df09ebe8afc90533913c99ada8f4689314a16c66bbafe7f"} build_url:https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bff5ee7bf59cd09b07a412d431f76084be8c4d1a2453bf45c95e8c4c18e3426d2bfc1a0bd6baefa7c5b1c0b36d4a408c9b2d83108b4e8f241fd486ade2921546", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/411f2e6ded3ff482ef66a083c8f124958e0c2d538c57b194a9aa6bfcf7bbd77e2fcee8723c00cc0b22cc1854695dffdf2efc09f3c57039db2daddce391b6dc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ab78d3698bae60aba6e865751ec2943bd52816fff95d614ed3e3a541111b29ca900415b2e641cc5df09ebe8afc90533913c99ada8f4689314a16c66bbafe7f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:20.287711) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:20.288094) ========= 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=337fe3f4b1febe37b85fccc40000019e-1472734059.71302-64468308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:20.372705) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:19:20.373021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:19:20.373309) ========= ========= Total master_lag: 0.38 =========