builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1472734714.48 results: success (0) buildid: 20160901030202 builduid: 1aa83d850ef94b42a0c108c49d067f4b revision: b7f7ae14590aced450bb0b0469dfb38edd2c0ace ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.476825) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.480225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.480522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.520252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.520524) ========= 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=5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 05:58:35-- 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% 46.3M=0s 2016-09-01 05:58:35 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096239 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.648263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.648548) ========= 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=5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023224 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.717449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:34.717770) ========= 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=5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 05:58:35,624 truncating revision to first 12 chars 2016-09-01 05:58:35,624 Setting DEBUG logging. 2016-09-01 05:58:35,624 attempt 1/10 2016-09-01 05:58:35,624 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:36,107 unpacking tar archive at: mozilla-central-b7f7ae14590a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.853843 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:35.592291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:35.592610) ========= script_repo_revision: b7f7ae14590aced450bb0b0469dfb38edd2c0ace ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:35.593017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:35.593311) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 05:58:35.612746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-01 05:58:35.613097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:58:36 INFO - MultiFileLogger online at 20160901 05:58:36 in /builds/slave/test 05:58:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:58:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:58:36 INFO - {'append_to_log': False, 05:58:36 INFO - 'base_work_dir': '/builds/slave/test', 05:58:36 INFO - 'blob_upload_branch': 'Firefox', 05:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:58:36 INFO - 'branch': 'Firefox', 05:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:58:36 INFO - 'config_files': ('talos/linux_config.py',), 05:58:36 INFO - 'default_actions': ('clobber', 05:58:36 INFO - 'read-buildbot-config', 05:58:36 INFO - 'download-and-extract', 05:58:36 INFO - 'populate-webroot', 05:58:36 INFO - 'create-virtualenv', 05:58:36 INFO - 'install', 05:58:36 INFO - 'run-tests'), 05:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:58:36 INFO - 'download_minidump_stackwalk': True, 05:58:36 INFO - 'download_symbols': 'ondemand', 05:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:58:36 INFO - 'installer_path': 'installer.exe', 05:58:36 INFO - 'log_level': 'info', 05:58:36 INFO - 'log_name': 'talos', 05:58:36 INFO - 'log_to_console': True, 05:58:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:58:36 INFO - 'opt_config_files': (), 05:58:36 INFO - 'pip_index': False, 05:58:36 INFO - 'sps_profile': False, 05:58:36 INFO - 'sps_profile_interval': 0, 05:58:36 INFO - 'suite': 'dromaeojs-e10s', 05:58:36 INFO - 'system_bits': '32', 05:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:58:36 INFO - 'title': 'talos-linux64-ix-039', 05:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:58:36 INFO - 'use_talos_json': True, 05:58:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:58:36 INFO - 'work_dir': 'build'} 05:58:36 INFO - [mozharness: 2016-09-01 12:58:36.611644Z] Running clobber step. 05:58:36 INFO - Running pre-action listener: _resource_record_pre_action 05:58:36 INFO - Running main action method: clobber 05:58:36 INFO - rmtree: /builds/slave/test/build 05:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:37 INFO - Running post-action listener: _resource_record_post_action 05:58:37 INFO - [mozharness: 2016-09-01 12:58:37.084080Z] Finished clobber step (success) 05:58:37 INFO - [mozharness: 2016-09-01 12:58:37.084182Z] Running read-buildbot-config step. 05:58:37 INFO - Running pre-action listener: _resource_record_pre_action 05:58:37 INFO - Running main action method: read_buildbot_config 05:58:37 INFO - Using buildbot properties: 05:58:37 INFO - { 05:58:37 INFO - "project": "", 05:58:37 INFO - "product": "firefox", 05:58:37 INFO - "script_repo_revision": "production", 05:58:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:58:37 INFO - "repository": "", 05:58:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:58:37 INFO - "buildid": "20160901030202", 05:58:37 INFO - "stage_platform": "linux64-pgo", 05:58:37 INFO - "basedir": "/builds/slave/test", 05:58:37 INFO - "nightly_build": "True", 05:58:37 INFO - "buildnumber": 335, 05:58:37 INFO - "slavename": "talos-linux64-ix-039", 05:58:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:58:37 INFO - "platform": "ubuntu64_hw", 05:58:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:58:37 INFO - "branch": "mozilla-central", 05:58:37 INFO - "repo_path": "mozilla-central", 05:58:37 INFO - "revision": "b7f7ae14590aced450bb0b0469dfb38edd2c0ace", 05:58:37 INFO - "pgo_build": "True", 05:58:37 INFO - "builduid": "1aa83d850ef94b42a0c108c49d067f4b", 05:58:37 INFO - "slavebuilddir": "test" 05:58:37 INFO - } 05:58:37 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:37 INFO - Running post-action listener: _resource_record_post_action 05:58:37 INFO - [mozharness: 2016-09-01 12:58:37.087003Z] Finished read-buildbot-config step (success) 05:58:37 INFO - [mozharness: 2016-09-01 12:58:37.087093Z] Running download-and-extract step. 05:58:37 INFO - Running pre-action listener: _resource_record_pre_action 05:58:37 INFO - Running main action method: download_and_extract 05:58:37 INFO - mkdir: /builds/slave/test/build/tests 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:37 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:37 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:37 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:37 INFO - Downloaded 1361 bytes. 05:58:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:58:37 INFO - Using the following test package requirements: 05:58:37 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'jsshell-linux-x86_64.zip'], 05:58:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:37 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:37 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:37 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:37 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:39 INFO - Downloaded 21905487 bytes. 05:58:39 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:43 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:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:43 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:43 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:43 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:44 INFO - Downloaded 21905487 bytes. 05:58:44 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:48 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:48 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:48 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:48 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:50 INFO - Downloaded 14413998 bytes. 05:58:50 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:50 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:50 INFO - trying https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:58:50 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:50 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:52 INFO - Downloaded 59735967 bytes. 05:58:52 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:52 INFO - mkdir: /builds/slave/test/properties 05:58:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:52 INFO - Contents: 05:58:52 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:53 INFO - Running post-action listener: _resource_record_post_action 05:58:53 INFO - Running post-action listener: set_extra_try_arguments 05:58:53 INFO - [mozharness: 2016-09-01 12:58:53.620987Z] Finished download-and-extract step (success) 05:58:53 INFO - [mozharness: 2016-09-01 12:58:53.621216Z] Running populate-webroot step. 05:58:53 INFO - Running pre-action listener: _resource_record_pre_action 05:58:53 INFO - Running main action method: populate_webroot 05:58:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:53 INFO - '--tppagecycles', 05:58:53 INFO - '7'], 05:58:53 INFO - 'tests': ['tsvgm']}}, 05:58:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['damp', 'tps']}, 05:58:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'tests': ['damp', 'tps']}, 05:58:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['dromaeo_dom']}, 05:58:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['basic_compositor_video']}, 05:58:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['a11yr', 05:58:53 INFO - 'ts_paint', 05:58:53 INFO - 'tpaint', 05:58:53 INFO - 'sessionrestore', 05:58:53 INFO - 'sessionrestore_no_auto_restore', 05:58:53 INFO - 'tabpaint']}, 05:58:53 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:53 INFO - 'ts_paint', 05:58:53 INFO - 'tpaint', 05:58:53 INFO - 'sessionrestore', 05:58:53 INFO - 'sessionrestore_no_auto_restore', 05:58:53 INFO - 'tabpaint']}, 05:58:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:53 INFO - 'ts_paint', 05:58:53 INFO - 'tpaint', 05:58:53 INFO - 'sessionrestore', 05:58:53 INFO - 'sessionrestore_no_auto_restore', 05:58:53 INFO - 'tabpaint']}, 05:58:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:53 INFO - 'ts_paint', 05:58:53 INFO - 'tpaint', 05:58:53 INFO - 'sessionrestore', 05:58:53 INFO - 'sessionrestore_no_auto_restore', 05:58:53 INFO - 'tabpaint']}, 05:58:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['a11yr', 05:58:53 INFO - 'ts_paint', 05:58:53 INFO - 'tpaint', 05:58:53 INFO - 'sessionrestore', 05:58:53 INFO - 'sessionrestore_no_auto_restore', 05:58:53 INFO - 'tabpaint']}, 05:58:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['a11yr', 05:58:53 INFO - 'ts_paint', 05:58:53 INFO - 'tpaint', 05:58:53 INFO - 'sessionrestore', 05:58:53 INFO - 'sessionrestore_no_auto_restore', 05:58:53 INFO - 'tabpaint']}, 05:58:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['tsvgx', 05:58:53 INFO - 'tsvgr_opacity', 05:58:53 INFO - 'tart', 05:58:53 INFO - 'tscrollx', 05:58:53 INFO - 'cart']}, 05:58:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:53 INFO - 'tsvgr_opacity', 05:58:53 INFO - 'tart', 05:58:53 INFO - 'tscrollx', 05:58:53 INFO - 'cart']}, 05:58:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'talos_options': ['--disable-e10s'], 05:58:53 INFO - 'tests': ['tp5o']}, 05:58:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'tests': ['tp5o']}, 05:58:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'talos_options': ['--disable-e10s', 05:58:53 INFO - '--xperf_path', 05:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:53 INFO - 'tests': ['tp5n']}, 05:58:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:53 INFO - 'talos_options': ['--xperf_path', 05:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:53 INFO - 'tests': ['tp5n']}}, 05:58:53 INFO - 'talos.zip': {'path': '', 05:58:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:53 INFO - Running post-action listener: _resource_record_post_action 05:58:53 INFO - [mozharness: 2016-09-01 12:58:53.645433Z] Finished populate-webroot step (success) 05:58:53 INFO - [mozharness: 2016-09-01 12:58:53.645524Z] Running create-virtualenv step. 05:58:53 INFO - Running pre-action listener: _resource_record_pre_action 05:58:53 INFO - Running main action method: create_virtualenv 05:58:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:53 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:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:53 INFO - Using real prefix '/usr' 05:58:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:56 INFO - Installing pip.................done. 05:58:56 INFO - Return code: 0 05:58:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:56 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 05:58:56 INFO - 'HOME': '/home/cltbld', 05:58:56 INFO - 'LANG': 'en_US.UTF-8', 05:58:56 INFO - 'LANGUAGE': 'en_US:en', 05:58:56 INFO - 'LOGNAME': 'cltbld', 05:58:56 INFO - 'MAIL': '/var/mail/cltbld', 05:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:56 INFO - 'MOZ_NO_REMOTE': '1', 05:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:56 INFO - 'NO_EM_RESTART': '1', 05:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:56 INFO - 'PWD': '/builds/slave/test', 05:58:56 INFO - 'SHELL': '/bin/bash', 05:58:56 INFO - 'SHLVL': '1', 05:58:56 INFO - 'TERM': 'linux', 05:58:56 INFO - 'TMOUT': '86400', 05:58:56 INFO - 'USER': 'cltbld', 05:58:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:56 INFO - '_': '/tools/buildbot/bin/python'} 05:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:56 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:56 INFO - Cleaning up... 05:58:56 INFO - Return code: 0 05:58:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:56 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 05:58:56 INFO - 'HOME': '/home/cltbld', 05:58:56 INFO - 'LANG': 'en_US.UTF-8', 05:58:56 INFO - 'LANGUAGE': 'en_US:en', 05:58:56 INFO - 'LOGNAME': 'cltbld', 05:58:56 INFO - 'MAIL': '/var/mail/cltbld', 05:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:56 INFO - 'MOZ_NO_REMOTE': '1', 05:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:56 INFO - 'NO_EM_RESTART': '1', 05:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:56 INFO - 'PWD': '/builds/slave/test', 05:58:56 INFO - 'SHELL': '/bin/bash', 05:58:56 INFO - 'SHLVL': '1', 05:58:56 INFO - 'TERM': 'linux', 05:58:56 INFO - 'TMOUT': '86400', 05:58:56 INFO - 'USER': 'cltbld', 05:58:56 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:56 INFO - '_': '/tools/buildbot/bin/python'} 05:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:56 INFO - Downloading/unpacking psutil>=3.1.1 05:58:56 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:56 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:56 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:56 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:56 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:56 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 - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:58 INFO - Installing collected packages: psutil 05:58:58 INFO - Running setup.py install for psutil 05:58:58 INFO - building 'psutil._psutil_linux' extension 05:58:58 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:58:58 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:58:58 INFO - building 'psutil._psutil_posix' extension 05:58:58 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:58:59 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:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:59 INFO - Successfully installed psutil 05:58:59 INFO - Cleaning up... 05:58:59 INFO - Return code: 0 05:58:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:59 INFO - Using env: {'DISPLAY': ':0', 05:58:59 INFO - 'HOME': '/home/cltbld', 05:58:59 INFO - 'LANG': 'en_US.UTF-8', 05:58:59 INFO - 'LANGUAGE': 'en_US:en', 05:58:59 INFO - 'LOGNAME': 'cltbld', 05:58:59 INFO - 'MAIL': '/var/mail/cltbld', 05:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:59 INFO - 'MOZ_NO_REMOTE': '1', 05:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:59 INFO - 'NO_EM_RESTART': '1', 05:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:59 INFO - 'PWD': '/builds/slave/test', 05:58:59 INFO - 'SHELL': '/bin/bash', 05:58:59 INFO - 'SHLVL': '1', 05:58:59 INFO - 'TERM': 'linux', 05:58:59 INFO - 'TMOUT': '86400', 05:58:59 INFO - 'USER': 'cltbld', 05:58:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:59 INFO - '_': '/tools/buildbot/bin/python'} 05:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:59:01 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:01 INFO - Installing collected packages: mozsystemmonitor 05:59:01 INFO - Running setup.py install for mozsystemmonitor 05:59:01 INFO - Successfully installed mozsystemmonitor 05:59:01 INFO - Cleaning up... 05:59:01 INFO - Return code: 0 05:59:01 INFO - Installing jsonschema==2.5.1 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', '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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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', 'jsonschema==2.5.1'] 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 jsonschema==2.5.1 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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 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 jsonschema==2.5.1 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 jsonschema-2.5.1-py2.py3-none-any.whl 05:59:03 INFO - Downloading/unpacking functools32 (from 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:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:59:03 INFO - warning: no files found matching '*.txt' 05:59:03 INFO - no previously-included directories found matching 'build' 05:59:03 INFO - no previously-included directories found matching 'dist' 05:59:03 INFO - no previously-included directories found matching '.git*' 05:59:03 INFO - Installing collected packages: jsonschema, functools32 05:59:03 INFO - Running setup.py install for functools32 05:59:03 INFO - warning: no files found matching '*.txt' 05:59:04 INFO - no previously-included directories found matching 'build' 05:59:04 INFO - no previously-included directories found matching 'dist' 05:59:04 INFO - no previously-included directories found matching '.git*' 05:59:04 INFO - Successfully installed jsonschema functools32 05:59:04 INFO - Cleaning up... 05:59:04 INFO - Return code: 0 05:59:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:59:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:04 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:04 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:04 INFO - Using env: {'DISPLAY': ':0', 05:59:04 INFO - 'HOME': '/home/cltbld', 05:59:04 INFO - 'LANG': 'en_US.UTF-8', 05:59:04 INFO - 'LANGUAGE': 'en_US:en', 05:59:04 INFO - 'LOGNAME': 'cltbld', 05:59:04 INFO - 'MAIL': '/var/mail/cltbld', 05:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:04 INFO - 'MOZ_NO_REMOTE': '1', 05:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:04 INFO - 'NO_EM_RESTART': '1', 05:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:04 INFO - 'PWD': '/builds/slave/test', 05:59:04 INFO - 'SHELL': '/bin/bash', 05:59:04 INFO - 'SHLVL': '1', 05:59:04 INFO - 'TERM': 'linux', 05:59:04 INFO - 'TMOUT': '86400', 05:59:04 INFO - 'USER': 'cltbld', 05:59:04 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:04 INFO - '_': '/tools/buildbot/bin/python'} 05:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:59:04 INFO - Cleaning up... 05:59:04 INFO - Return code: 0 05:59:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:59:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:04 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:04 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:04 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:04 INFO - Using env: {'DISPLAY': ':0', 05:59:04 INFO - 'HOME': '/home/cltbld', 05:59:04 INFO - 'LANG': 'en_US.UTF-8', 05:59:04 INFO - 'LANGUAGE': 'en_US:en', 05:59:04 INFO - 'LOGNAME': 'cltbld', 05:59:04 INFO - 'MAIL': '/var/mail/cltbld', 05:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:04 INFO - 'MOZ_NO_REMOTE': '1', 05:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:04 INFO - 'NO_EM_RESTART': '1', 05:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:04 INFO - 'PWD': '/builds/slave/test', 05:59:04 INFO - 'SHELL': '/bin/bash', 05:59:04 INFO - 'SHLVL': '1', 05:59:04 INFO - 'TERM': 'linux', 05:59:04 INFO - 'TMOUT': '86400', 05:59:04 INFO - 'USER': 'cltbld', 05:59:04 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:04 INFO - '_': '/tools/buildbot/bin/python'} 05:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:59:04 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:04 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:04 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:04 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:04 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:04 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 - Downloading blobuploader-1.2.4.tar.gz 05:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:59:06 INFO - Downloading/unpacking requests==1.2.3. (from 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:59:06 INFO - Downloading/unpacking docopt==0.6.1 (from 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:07 INFO - Downloading docopt-0.6.1.tar.gz 05:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:59:07 INFO - Installing collected packages: blobuploader, requests, docopt 05:59:07 INFO - Running setup.py install for blobuploader 05:59:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:59:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:59:07 INFO - Running setup.py install for requests 05:59:07 INFO - Running setup.py install for docopt 05:59:07 INFO - Successfully installed blobuploader requests docopt 05:59:07 INFO - Cleaning up... 05:59:07 INFO - Return code: 0 05:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:07 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 05:59:07 INFO - 'HOME': '/home/cltbld', 05:59:07 INFO - 'LANG': 'en_US.UTF-8', 05:59:07 INFO - 'LANGUAGE': 'en_US:en', 05:59:07 INFO - 'LOGNAME': 'cltbld', 05:59:07 INFO - 'MAIL': '/var/mail/cltbld', 05:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:07 INFO - 'MOZ_NO_REMOTE': '1', 05:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:07 INFO - 'NO_EM_RESTART': '1', 05:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:07 INFO - 'PWD': '/builds/slave/test', 05:59:07 INFO - 'SHELL': '/bin/bash', 05:59:07 INFO - 'SHLVL': '1', 05:59:07 INFO - 'TERM': 'linux', 05:59:07 INFO - 'TMOUT': '86400', 05:59:07 INFO - 'USER': 'cltbld', 05:59:07 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:07 INFO - '_': '/tools/buildbot/bin/python'} 05:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:07 INFO - Running setup.py (path:/tmp/pip-7MPtPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:08 INFO - Running setup.py (path:/tmp/pip-sOSvUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:08 INFO - Running setup.py (path:/tmp/pip-gj6nHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:08 INFO - Running setup.py (path:/tmp/pip-K1D6PL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:08 INFO - Running setup.py (path:/tmp/pip-EporA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:08 INFO - Running setup.py (path:/tmp/pip-WgX363-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:08 INFO - Running setup.py (path:/tmp/pip-iLHZMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:08 INFO - Running setup.py (path:/tmp/pip-IuQbsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:08 INFO - Running setup.py (path:/tmp/pip-gXIcxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:08 INFO - Running setup.py (path:/tmp/pip-tPYYBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:08 INFO - Running setup.py (path:/tmp/pip-0GrPaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:08 INFO - Running setup.py (path:/tmp/pip-3TXPHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:08 INFO - Running setup.py (path:/tmp/pip-jNg0nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:08 INFO - Running setup.py (path:/tmp/pip-40FVH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:09 INFO - Running setup.py (path:/tmp/pip-bJEnRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:09 INFO - Running setup.py (path:/tmp/pip-uGiF8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:09 INFO - Running setup.py (path:/tmp/pip-Ek4KBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:59:09 INFO - Running setup.py install for manifestparser 05:59:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:59:09 INFO - Running setup.py install for mozcrash 05:59:09 INFO - Running setup.py install for mozdebug 05:59:09 INFO - Running setup.py install for mozdevice 05:59:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:59:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:59:09 INFO - Running setup.py install for mozfile 05:59:09 INFO - Running setup.py install for mozhttpd 05:59:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:59:09 INFO - Running setup.py install for mozinfo 05:59:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:59:09 INFO - Running setup.py install for mozInstall 05:59:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Running setup.py install for mozleak 05:59:10 INFO - Running setup.py install for mozlog 05:59:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Running setup.py install for moznetwork 05:59:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Running setup.py install for mozprocess 05:59:10 INFO - Running setup.py install for mozprofile 05:59:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Running setup.py install for mozrunner 05:59:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:59:10 INFO - Running setup.py install for mozscreenshot 05:59:10 INFO - Running setup.py install for moztest 05:59:10 INFO - Running setup.py install for mozversion 05:59:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:59:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:59:11 INFO - Cleaning up... 05:59:11 INFO - Return code: 0 05:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:11 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 05:59:11 INFO - 'HOME': '/home/cltbld', 05:59:11 INFO - 'LANG': 'en_US.UTF-8', 05:59:11 INFO - 'LANGUAGE': 'en_US:en', 05:59:11 INFO - 'LOGNAME': 'cltbld', 05:59:11 INFO - 'MAIL': '/var/mail/cltbld', 05:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:11 INFO - 'MOZ_NO_REMOTE': '1', 05:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:11 INFO - 'NO_EM_RESTART': '1', 05:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:11 INFO - 'PWD': '/builds/slave/test', 05:59:11 INFO - 'SHELL': '/bin/bash', 05:59:11 INFO - 'SHLVL': '1', 05:59:11 INFO - 'TERM': 'linux', 05:59:11 INFO - 'TMOUT': '86400', 05:59:11 INFO - 'USER': 'cltbld', 05:59:11 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:11 INFO - '_': '/tools/buildbot/bin/python'} 05:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:59:11 INFO - Running setup.py (path:/tmp/pip-dAr3np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:59:11 INFO - Running setup.py (path:/tmp/pip-ESBw7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:59:11 INFO - Running setup.py (path:/tmp/pip-7ILSJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:59:11 INFO - Running setup.py (path:/tmp/pip-7YStwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:59:11 INFO - Running setup.py (path:/tmp/pip-h_YKtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:59:11 INFO - Running setup.py (path:/tmp/pip-RKBGjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:59:11 INFO - Running setup.py (path:/tmp/pip-y359aL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:59:11 INFO - Running setup.py (path:/tmp/pip-NXrZAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:59:11 INFO - Running setup.py (path:/tmp/pip-E4MyGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:59:11 INFO - Running setup.py (path:/tmp/pip-EqpHyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:59:11 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:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:59:11 INFO - Running setup.py (path:/tmp/pip-ZKOLxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:59:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:59:12 INFO - Running setup.py (path:/tmp/pip-rl1beJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:59:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:59:12 INFO - Running setup.py (path:/tmp/pip-F6b5kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:59:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:59:12 INFO - Running setup.py (path:/tmp/pip-xrvvFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:59:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:12 INFO - Running setup.py (path:/tmp/pip-OI2kVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:59:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:59:12 INFO - Running setup.py (path:/tmp/pip-g5wLWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:59:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:59:12 INFO - Running setup.py (path:/tmp/pip-jhFF8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:59:12 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:12 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:12 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:12 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:12 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:12 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:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:59:14 INFO - Downloading blessings-1.6.tar.gz 05:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:59:14 INFO - Installing collected packages: blessings 05:59:14 INFO - Running setup.py install for blessings 05:59:14 INFO - Successfully installed blessings 05:59:14 INFO - Cleaning up... 05:59:14 INFO - Return code: 0 05:59:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:59:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:14 INFO - Reading from file tmpfile_stdout 05:59:14 INFO - Current package versions: 05:59:14 INFO - argparse == 1.2.1 05:59:14 INFO - blessings == 1.6 05:59:14 INFO - blobuploader == 1.2.4 05:59:14 INFO - docopt == 0.6.1 05:59:14 INFO - functools32 == 3.2.3-2 05:59:14 INFO - jsonschema == 2.5.1 05:59:14 INFO - manifestparser == 1.1 05:59:14 INFO - mozInstall == 1.12 05:59:14 INFO - mozcrash == 0.17 05:59:14 INFO - mozdebug == 0.1 05:59:14 INFO - mozdevice == 0.48 05:59:14 INFO - mozfile == 1.2 05:59:14 INFO - mozhttpd == 0.7 05:59:14 INFO - mozinfo == 0.9 05:59:14 INFO - mozleak == 0.1 05:59:14 INFO - mozlog == 3.3 05:59:14 INFO - moznetwork == 0.27 05:59:14 INFO - mozprocess == 0.23 05:59:14 INFO - mozprofile == 0.28 05:59:14 INFO - mozrunner == 6.12 05:59:14 INFO - mozscreenshot == 0.1 05:59:14 INFO - mozsystemmonitor == 0.3 05:59:14 INFO - moztest == 0.7 05:59:14 INFO - mozversion == 1.4 05:59:14 INFO - psutil == 3.1.1 05:59:14 INFO - requests == 1.2.3 05:59:14 INFO - wsgiref == 0.1.2 05:59:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:59:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:14 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:14 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:14 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:14 INFO - Using env: {'DISPLAY': ':0', 05:59:14 INFO - 'HOME': '/home/cltbld', 05:59:14 INFO - 'LANG': 'en_US.UTF-8', 05:59:14 INFO - 'LANGUAGE': 'en_US:en', 05:59:14 INFO - 'LOGNAME': 'cltbld', 05:59:14 INFO - 'MAIL': '/var/mail/cltbld', 05:59:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:14 INFO - 'MOZ_NO_REMOTE': '1', 05:59:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:14 INFO - 'NO_EM_RESTART': '1', 05:59:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:14 INFO - 'PWD': '/builds/slave/test', 05:59:14 INFO - 'SHELL': '/bin/bash', 05:59:14 INFO - 'SHLVL': '1', 05:59:14 INFO - 'TERM': 'linux', 05:59:14 INFO - 'TMOUT': '86400', 05:59:14 INFO - 'USER': 'cltbld', 05:59:14 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:59:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:14 INFO - '_': '/tools/buildbot/bin/python'} 05:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 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:15 INFO - Cleaning up... 05:59:15 INFO - Return code: 0 05:59:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:59:15 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:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:15 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:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:59:15 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 0x7fdfcee26f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ff850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, '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': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 05:59:15 INFO - 'HOME': '/home/cltbld', 05:59:15 INFO - 'LANG': 'en_US.UTF-8', 05:59:15 INFO - 'LANGUAGE': 'en_US:en', 05:59:15 INFO - 'LOGNAME': 'cltbld', 05:59:15 INFO - 'MAIL': '/var/mail/cltbld', 05:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:15 INFO - 'MOZ_NO_REMOTE': '1', 05:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:15 INFO - 'NO_EM_RESTART': '1', 05:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:15 INFO - 'PWD': '/builds/slave/test', 05:59:15 INFO - 'SHELL': '/bin/bash', 05:59:15 INFO - 'SHLVL': '1', 05:59:15 INFO - 'TERM': 'linux', 05:59:15 INFO - 'TMOUT': '86400', 05:59:15 INFO - 'USER': 'cltbld', 05:59:15 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:15 INFO - '_': '/tools/buildbot/bin/python'} 05:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:59:15 INFO - Cleaning up... 05:59:15 INFO - Return code: 0 05:59:15 INFO - Running post-action listener: _resource_record_post_action 05:59:15 INFO - Running post-action listener: _start_resource_monitoring 05:59:15 INFO - Starting resource monitoring. 05:59:15 INFO - [mozharness: 2016-09-01 12:59:15.369238Z] Finished create-virtualenv step (success) 05:59:15 INFO - [mozharness: 2016-09-01 12:59:15.369747Z] Running install step. 05:59:15 INFO - Running pre-action listener: _resource_record_pre_action 05:59:15 INFO - Running main action method: install 05:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:59:15 INFO - Reading from file tmpfile_stdout 05:59:15 INFO - Detecting whether we're running mozinstall >=1.0... 05:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:59:15 INFO - Reading from file tmpfile_stdout 05:59:15 INFO - Output received: 05:59:15 INFO - Usage: mozinstall [options] installer 05:59:15 INFO - Options: 05:59:15 INFO - -h, --help show this help message and exit 05:59:15 INFO - -d DEST, --destination=DEST 05:59:15 INFO - Directory to install application into. [default: 05:59:15 INFO - "/builds/slave/test"] 05:59:15 INFO - --app=APP Application being installed. [default: firefox] 05:59:15 INFO - mkdir: /builds/slave/test/build/application 05:59:15 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:15 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:32 INFO - Reading from file tmpfile_stdout 05:59:32 INFO - Output received: 05:59:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:59:32 INFO - Running post-action listener: _resource_record_post_action 05:59:32 INFO - [mozharness: 2016-09-01 12:59:32.674979Z] Finished install step (success) 05:59:32 INFO - [mozharness: 2016-09-01 12:59:32.675258Z] Running run-tests step. 05:59:32 INFO - Running pre-action listener: _resource_record_pre_action 05:59:32 INFO - Running main action method: run_tests 05:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:59:32 INFO - Python 2.7.3 05:59:32 INFO - Return code: 0 05:59:32 INFO - grabbing minidump binary from tooltool 05:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:59:32 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 0x26fa370>, '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 0x26fd8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26fdd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:59:32 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:32 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:32 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:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:59:32 INFO - Return code: 0 05:59:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:59:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:59:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:59:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:59:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:59:32 INFO - Using env: {'DISPLAY': ':0', 05:59:32 INFO - 'HOME': '/home/cltbld', 05:59:32 INFO - 'LANG': 'en_US.UTF-8', 05:59:32 INFO - 'LANGUAGE': 'en_US:en', 05:59:32 INFO - 'LOGNAME': 'cltbld', 05:59:32 INFO - 'MAIL': '/var/mail/cltbld', 05:59:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:59:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:59:32 INFO - 'MOZ_NO_REMOTE': '1', 05:59:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:59:32 INFO - 'NO_EM_RESTART': '1', 05:59:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:59:32 INFO - 'PWD': '/builds/slave/test', 05:59:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:59:32 INFO - 'SHELL': '/bin/bash', 05:59:32 INFO - 'SHLVL': '1', 05:59:32 INFO - 'TERM': 'linux', 05:59:32 INFO - 'TMOUT': '86400', 05:59:32 INFO - 'USER': 'cltbld', 05:59:32 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490', 05:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:59:32 INFO - '_': '/tools/buildbot/bin/python'} 05:59:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cOQiQZnuTX65CtipARKP1A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:59:32 INFO - mozversion application_buildid: 20160901030202 05:59:32 INFO - mozversion application_changeset: b7f7ae14590aced450bb0b0469dfb38edd2c0ace 05:59:32 INFO - mozversion application_display_name: Nightly 05:59:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:59:32 INFO - mozversion application_name: Firefox 05:59:32 INFO - mozversion application_remotingname: firefox 05:59:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:59:32 INFO - mozversion application_vendor: Mozilla 05:59:32 INFO - mozversion application_version: 51.0a1 05:59:32 INFO - mozversion platform_buildid: 20160901030202 05:59:32 INFO - mozversion platform_changeset: b7f7ae14590aced450bb0b0469dfb38edd2c0ace 05:59:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:59:32 INFO - mozversion platform_version: 51.0a1 05:59:32 INFO - using testdate: 1472734772 05:59:32 INFO - actual date: 1472734772 05:59:32 INFO - starting webserver on 'localhost:58067' 05:59:32 INFO - SUITE-START | Running 2 tests 05:59:32 INFO - TEST-START | dromaeo_css 05:59:32 INFO - operating with platform_type : linux_ 05:59:32 INFO - Initialising browser for dromaeo_css test... 05:59:32 INFO - TEST-INFO | started process 15119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSFPiy/profile http://localhost:58067/getInfo.html) 05:59:38 INFO - PROCESS | 15119 | __metrics Screen width/height:1600/1200 05:59:38 INFO - PROCESS | 15119 | colorDepth:24 05:59:38 INFO - PROCESS | 15119 | Browser inner width/height: 1024/697 05:59:38 INFO - PROCESS | 15119 | __metrics 05:59:38 ERROR - PROCESS | 15119 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 05:59:39 INFO - TEST-INFO | 15119: exit 0 05:59:39 INFO - Browser initialized. 05:59:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:39 INFO - TEST-INFO | started process 15241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSFPiy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:51 INFO - PROCESS | 15241 | RSS: Main: 191791104 05:59:51 INFO - PROCESS | 15241 | 06:00:41 INFO - PROCESS | 15241 | 1472734841546 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:51 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:58067/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58067/tests/dromaeo/cssquery-ext.html) 06:02:53 INFO - PROCESS | 15241 | RSS: Main: 207118336 06:02:53 INFO - PROCESS | 15241 | 06:05:55 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:58067/tests/dromaeo/cssquery-ext.html (next: http://localhost:58067/tests/dromaeo/cssquery-jquery.html) 06:05:55 INFO - PROCESS | 15241 | RSS: Main: 202223616 06:05:55 INFO - PROCESS | 15241 | 06:08:57 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:58067/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58067/tests/dromaeo/cssquery-mootools.html) 06:08:58 INFO - PROCESS | 15241 | RSS: Main: 197259264 06:08:58 INFO - PROCESS | 15241 | 06:12:00 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:58067/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58067/tests/dromaeo/cssquery-prototype.html) 06:12:00 INFO - PROCESS | 15241 | RSS: Main: 194080768 06:12:00 INFO - PROCESS | 15241 | 06:15:03 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:58067/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58067/tests/dromaeo/cssquery-yui.html) 06:15:03 INFO - PROCESS | 15241 | RSS: Main: 197337088 06:15:03 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:58067/tests/dromaeo/cssquery-yui.html (next: http://localhost:58067/tests/dromaeo/cssquery-dojo.html) 06:18:06 INFO - PROCESS | 15241 | RSS: Main: 198025216 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | __start_tp_report 06:18:06 INFO - PROCESS | 15241 | _x_x_mozilla_page_load 06:18:06 INFO - PROCESS | 15241 | _x_x_mozilla_page_load_details 06:18:06 INFO - PROCESS | 15241 | |i|pagename|runs| 06:18:06 INFO - PROCESS | 15241 | |0;dojo.html;3078.892238771643;3090.7527397808162;3099.054788289572;3107.5649409082735;3122.734567561757;5307.681539107647;5485.862853428661;5563;5573.470520300575;5580.414056524068;5495.670259784406;5548.4174161713045;5555.694436805974;5557.833265002047;5616.52259557938;4977.278294647265;5076.517730815585;5090.9236361454605;5140.820071297505;5170.922436163461;5081.212412076134;5086;5094.184930411135;5149.382074151107;5149.639525233217;4943.8516844494725;5039.420466646346;5070.2394640803805;5086.3387759591205;5098.5921126309995;5071.492850714936;5075.670081444731;5077.517635824628;5086.898262034775;5138.203578445347;4998.600391890276;5015.899682006376;5064.3163172971545;5065.037642847884;5087;5274.446183150752;5420.268263784378;5525.557955363562;5533.778648854041;5594.748236329375;5911.497522710575;5926.644401335933;5934.109883517507;5935.10973353996;5955.076963070731;5947.078202878561;5956.791512297049;5958.791442299499;5963.910541341883;5969;5326.866828329284;5456.945430545684;5502.669839809624;5508.504234618824;5541.113421852525;6045.909311360333;6058.606190597597;6075.817725468243;6078;6129.356417576179;5727.427257274239;5773.509251713567;5773.566982476331;5787.363390027093;5795.797147099831;5542.972285138549;5803.187553742479;5856.180134781134;5891.528677705774;5958.6424814511265;5704.71476426177;5750.482456578844;5793.826185214451;5865.325487568899;5871.911921321183;5795.768169273182;5869.73586188614;5879.20630714848;5882.55880808941;5897.498712609477;4511.210538155809;4570.6800523963;4574.359589657451;4628.467726211461;4634.397528321297;4012.0772222389014;4113.794310284474;4115.053537686289;4116.876493705194;4151.81673223136;5405.459454054563;5516.834494965157;5569.610127291051;5698.7435565399655;5713.028785106542;5895.823125306248;5896.380880007623;5896.64620122794;5961.01643228871;5977;5576.10782274834;5586.13414920688;5596.636218645856;5600.52395546375;5600.859978500489;4872;4943.8022479101155;5029.59763218949;5066.189409694505;5112.590992720573;6199.597026193283;6204.937950620526;6235.999999999909;6243.656598887105;6249.25008998923;6026.909596356146;6041.6677082759115;6045.818625441244;6055.530503124424;6142.078688196806;5978.760849565969;6093.29927058394;6141;6227.532935029982;6257.530685198537;5872.911906321494;5899.026660600953;5909.6158749681135;5953.166556681981;5979.790707325223;6010.7295171716505;6016.458518733335;6022.668753218615;6025.6083354581815;6028.5177185825905;5611.354694210055;5771.9134212986;5800.796972105956;5811.476967072984;5857.414258574279;5812.796552120655;5825.82522524308;5834.095715164156;5837.970810145922;5891;5804.332501762351;5804.361520232686;5805.245318108618;5817.127430885232;5828.388019257917;5650.745716442852;5759.0209664356325;5812.94187058124;5845.18167456548;5897.115432685132;5686.630369026;5687.033204355187;5690.174924635988;5727.828165154885;5765.740541675551 06:18:06 INFO - PROCESS | 15241 | |1;ext.html;542.9939852973936;582.8105865593681;583.903655896777;600.3336296710651;627.5481653209694;38495.42256866146;43050.784746076264;43072.78463607677;43120.78439607798;43132.118109370225;43434;44134.33798493025;44162;44167;44243;8860.911390886105;8943.686970956018;8945.15021072997;9030.232430243404;9033.864492032624;8871.157240062184;8877.68928087517;8930.687425940094;8934.285257179443;8968.865467018;8960.955195224014;8982.910170898273;8985.191332780048;9043.683471078513;9075.092490750905;8851.291896648285;8897.510636914967;8923.643054277822;8987.281017518582;9001.279897608176;8796.736097917073;8902.33232507558;8923.063078376741;8926.642934282621;8932.196102350754;41088.58911410878;41248.79375603133;41450.37824432636;41457;41462.585374146474;3596.6762991330643;3663.655260633197;3798.924021519554;4146.91706165875;4153.439285696422;32100.518492222636;32383.190420239447;32545.6745432545;32774.6722532774;32857.34285314304;4231.915361692749;4290.69965102443;4315.654747620183;4362.520122786491;4433.290673492258;339019;340058;341754.2912285447;342448;344411;55029.322507587305;55340.72329638326;55458;55586.72206639022;55658.44341556533;35783.28433431317;36550.238205931986;36612;58951.41048589545;59132.79105693926;15582;15710.293036813371;15889.68220635604;15927.442539511061;16061;11934.28394296345;12067.034637229;12073.45669444877;12082.516699331929;12104.75790484203;18593.16330765119;18659.160337784833;18728.719069213974;18748.718769218474;18840.52898677544;7175.641217939082;7346.926530734624;7407.962960185165;7484.1393239777035;7523.623818809037;940.9905900941039;972.8054389122204;1035.0477560644226;1040.5733649203942;1064.893510648929;31713;31818.363632727214;32046.519302210487;32388;32544.186395340304;1028.280203857303;1071.8606581144556;1128.0975219824109;1166.4517676691942;1173.4778023779336;16031.873784612122;16834.158292085347;17060.914695426443;17099.401520946707;17104.14479276031;511911;516577;519422;520874;521205;56381.71809140928;57100.42899570951;57199.85400802913;57518;57658.13512797312;1329.1759109352263;1350.0617071135664;1363.2297751770218;1369.869862363074;1370.451819272299;29475.852620736758;30871.31046051811;30881.845590771904;31342.686573134888;31726;50076;50248.497515024384;50527.49472505228;50562.49437505725;50618.493815061374;438704;439774.8011259923;440389;440828;440977;28067.123554729224;44432.33351499665;45028.77485612551;45284.62234486631;46161.307580386994;46639.53360466487;46922;47110.52889471062;49944.250836238214;50840.491595085055;41402.171956560094;42320.15359692727;42770.78614606907;43845.78077109594;44534.3319850209;42706.57293427026;42765.48122357622;43490.565094348654;43708;44004.33993490036;41781.58218417899;41823.37264941089;42377.36433953432;42708.35937461003;44200.33699494575;36334.27331453409;40201.39697904475;40867.795661021504;41891.162176755686;42066.369004464344;28780.42439151247;29033;29157.7084229155;29334;29522.261943451587 06:18:06 INFO - PROCESS | 15241 | |2;jquery.html;392.84482629361423;395.70915377197775;402.9979850100749;406.31738679019253;420.02554074547044;18392.90803545982;19835;19840.900795496003;20001.99999999998;20685.79314206861;18090.728639070425;18270;18364.081795910184;18539.25842966283;18714.251429942786;5562.3047119110215;5572.359178694442;5780;5841.269841269841;5883.0881213411985;5847.970760146193;5875.236219291486;5877.118432235156;5896.23348964634;5906.763729450817;5650.0959846424585;5778.768849246025;5816.243888294516;5830.737616807254;5834.824955251349;5814.302283725959;5869.442402971711;5910.527157827363;5960.254968128984;6038.547108966845;5728.369879313273;5731.598788084836;5775.942240577582;5781.566382521286;5790.420957904218;14039.719205615831;14101.788473172808;14124.788128178085;14287.285635718277;14331.211783351911;2135.263334149716;2245.5396643688005;2250.9774902250933;2268.9886550567307;2359.3747656870773;9970.800583988352;10140.543675534545;10287.691369258935;12481.126321157522;14176.787348189786;1854.5178253654012;1922.1926790747918;1926.9421917342502;1964.803519648038;1971.842252619787;79743.60128199322;84896.72654910182;85010.57494712487;85030.57484712599;85788.28164450952;11013.669589912315;11100.44497775108;11255.943720281346;11366.772664546663;11484.425778711031;15619.453319133776;15625.531234062997;15634.687306254038;15685.764713529306;15697.450589229322;7705.961470192613;7807.336376407955;8001.919980800234;8314.334853211729;8399.496030238206;7637.694492220249;7665.731699390494;7701.961490192513;7855.371570274365;7930.484518506279;4685.906281874343;4745.667803253808;4775.570198682135;4868.269759536027;4906.828261010847;1971.4184315626924;1986.754966887408;2017.3947815655245;2026.402211347656;2035.288307568005;832.4422636833336;902.4477898015404;911.8404279251105;941.7033634405141;1018.7453136715822;18077.367292144976;19012.61974760497;19554.120064597126;20011.399658010283;20329.49176270605;954.5227386306847;960.4093482508207;975.6780262513354;989.7773001074845;997.3268044070223;9002.324825638103;10982.505787239594;11248.100151987821;11267.32396056223;11287.209895307415;413133.93433033244;467117;468664;469263;469461;59102.70448647729;62134.37865621376;91461;95452;99313;998.8701468809008;1059.8940105989493;1063.0963680871353;1091.8689757229183;1100.9614663486739;17297.740533892254;17378.52282555997;17890.463286101436;18072.819271807115;18369.357072502396;29541.940327448316;32774.180645484055;41474;43503.824808760066;43886.34170487381;59126.40873591209;59151;60246.397536025834;61812.38187618066;62024;8224.095349511668;8317;8374.246317831425;8387.454815436977;8860.822783544165;11200.607978720705;13543.59369218925;13659.385327660479;13764.793528096887;13891.861081389461;11728.530858765555;11745.17783755129;11815.350155741517;11869.821952670543;12401.565945191875;11835.585754498552;11884.46519906589;11995.880041199825;12018.819717704417;12381.876181238073;10788.136949043901;10862.511186996446;11608.419579021183;12032.09759268041;12118.878811211775;8203.343732501506;8382.245597896219;8430.747077587683;8587;8597;11549.769004620028;11650.53397864076;11848.70378240551;11925.10561707858;11940.462679179283 06:18:06 INFO - PROCESS | 15241 | |3;mootools.html;1481.1483397046698;1495.3495229575135;1658.3035125247402;1759.6832570137385;1775.9556011099721;7664.233576642347;8747.256483198928;9021.774455638595;9407.38851974623;9433.433993960367;8954.820903581924;9312.068793120701;9316.767080822983;9338.25293976482;9417.152456278933;2429.829911906163;2443.9124589557655;2449.6937882764655;2457.287386657876;2457.5453541094867;2399.4961058177714;2406.2420337593603;2456.0298682020593;2462.938426539342;2466.05057053035;2434;2438.280707191374;2441.377448750575;2445.9877700611473;2455.9754402456015;2384.2727967969763;2411.3489357873277;2411.505641343529;2417.758224177577;2455.84037037592;2370.265217782493;2389.1637926725507;2399.256230568529;2404.663347131403;2406.506666133456;8977.057408972028;9102.86345704815;9247.72256832296;9338.206252468548;9338.626454941794;5518.255035570187;5617.988762022835;5644.604877658566;5651.717414129277;5674.177244299594;3324.6010478742464;3463.9134021649406;3467.514547963287;3510.7717998330027;3516.43737002081;1177.3642233194064;1192.546832203757;1250.762355152518;1263.7535680542298;1265.8860702536724;12784.296863672495;12908.290044047573;12914.612561623073;12980.221186728826;13014.544490942772;4846.176150054499;4855.587275081587;4935.235038569028;4954.1082605130705;5105.412877519058;10172.08451239392;10216.642417515352;10249.33379330341;10282.948585257025;10292.536835842255;5562.610617256753;5595.104783234663;5603.355614104348;5603.719814009283;5615.831525054255;4301.096769678403;4946.109700253917;5067.113255180328;5075.543201111917;5089.4147173074825;3931.5871833457645;4081.571434999342;4083.1833633273463;4112.444819949328;4119.0937993641355;1325.4101924643442;1346.1990115881035;1346.602752188107;1351.0340106823471;1355.159800923414;776.8640487914593;866.9306455483546;874.6545114679666;929.4284015330524;950.1591091883732;5958.523318134626;6020.849478763066;6133.233345831771;6284.4344009039405;6470.320616335312;899.9730008099767;953.1040821627648;994.28908330544;995.6067353395513;1001.1290177545582;3867.497225360685;4008.4588580541836;4046.2716710991717;4074.083331250504;4139.089400331922;11176.497057632427;11352.091832653368;11491.54033838637;11542.711432214262;11595.884041159481;11302.378369189773;11362.261453005529;11404.258723182966;11462.312261264351;11471.827922581168;8428.145807922247;8450.577471126542;8471.279941205066;8581.656733730706;8742.213200811957;6014.458698717136;6026.096085587197;6058.666773327509;6150.138980542638;6336.936630633634;10360.176453601158;10366.844497332697;10476.109530689977;10592.8940710595;10632.36205827622;10653.360798352123;10703.785924281627;10716.624918127829;10763.3541987481;10781.460926953778;6693.196816382066;7505;7636.656350464354;7683.154852966281;7752.496087754504;9030.413023153475;9037.909620903969;9075.591598378222;9084.273258139465;9095.317851161057;7984;8147.566562975165;8162.7143049992965;8201.917980820115;8434.32525397979;7680.385569154566;7812.453128281193;7850.803729906798;7910.169432209535;8113.310368618498;7231.602261875647;7261.3101755333155;7308.488405811542;7350.70597176107;7404.00045993784;5245.239440281214;5262.26328314044;5301.1783173608155;5331.440198779227;5425.348958124892;5167.379914410295;5201.479852014768;5214.634975551675;5289.312389389354;5335.093034184276 06:18:06 INFO - PROCESS | 15241 | |4;prototype.html;326.9542264083029;331.0779479150566;334.2129285532571;341.84446077034943;343.78513429106806;5451.781928722847;5528.861778455541;5594.916076258854;5628.577856660757;5668.858278543028;5469.644473109245;5486.149646804752;5499.0132154188195;5509.724513774316;5510.889782204354;4309.491677912722;4313.460817397825;4323.286657701483;4346.456692913386;4371.322445021026;4257.638100761439;4283.1433713257475;4292.763897985609;4342.848000319989;4364.869053928372;4275.251830929575;4282.764447955361;4286.97856510717;4289.6353809926195;4296.462942132233;4281.529031806499;4287.699861009731;4292.484901811803;4300.8709738707885;4300.9139817203795;3711.740178187528;3797.4303854421782;3802.619738026203;3804.771713697159;3810.1808111256214;5403;5408.675479471244;5424.783008679648;5439.700816455093;5447;4930.235813448921;4940.55535001848;4941.777620007108;4942.184539551005;4945.184044632631;5599;5793.246877905887;5797.652140871562;5800.53595712342;5816.738246778905;4100.815463304159;4103.815328310233;4108.1783643271465;4117.21772863158;4119.8352065917325;6027.728752206117;6089.756409743605;6150.354212807681;6167.4757645600175;6175.752969881154;4045.3931910213114;4206.747595144301;4229.492460904711;4242.85150019754;4247.3628955656895;4213.536510983789;4217.536071032184;4226.197022565702;4233.1956928183545;4244.978775106167;4858.7570621468785;4894;4909.87725306863;4921.704697718148;4980.850574482699;5746.367899531048;5797.275340582427;5892.823215303548;5925.762969481172;5932.940670593239;1450.55032939789;1468.4786900650329;1471.5364660132025;1472;1479.9270528866487;893.5755516129786;923.8774888510358;941.5339406993445;950.4249928792981;952.5951470625096;4864.246041863446;4891.535304146171;4907.901841963141;4908.730019848871;4964.429090654548;5231.633785635046;5232.424433312332;5247.291615631917;5253.185756207794;5258.50044245796;4707.74028466338;4917.975410122926;4949.307097006422;4952.727599982036;4966.950330496721;2723.6731592208666;2773.7503624673877;2795.8602069896424;2802.3326120958;2802.9719702802713;5375.865603359869;5392.299001129828;5400.405955344909;5400.675959442446;5499.697516636624;5177.637565370388;5307.911878064988;5391.81128660495;5399.595030372738;5410;5354.108781258077;5358.946410535923;5364.9731751341;5374.677519348852;5419.051665958442;5189.6107791915;5272.420033796203;5281.577473802164;5297.867553311198;5330.200469929541;4866.537678920497;5092.898142037213;5106.693598384109;5110.233464980282;5152.732797569058;5334.413214546475;5339.434783260256;5409.486098820606;5500.734830988815;5501.817109321515;3860.9227815442973;4062.674986001172;4064.1058967027207;4155.231282212801;4156.272652285777;5817.7963771267805;5888.558358123072;5901.881962360643;5907.91138132937;5914.290285165807;5680.4319568042865;5785.656808992365;5803.3616302207565;5804.94195058044;5829.854253643693;5713.628614140068;5719.399463056319;5730.770769169353;5742.59801813869;5779.479846813807;5663.66018038919;5707.800226992035;5723.7996670116345;5741.712914354349;5742.511886489695;5480.72596370172;5670.177824215383;5677.971610141923;5725.6850873202375;5727.8568035799435;5569.944300556943;5572.60991730575;5599.412061733459;5624.606277560531;5632.239647647515 06:18:06 INFO - PROCESS | 15241 | |5;yui.html;742.3059439424136;772.8724760414532;776.8290975985285;817.1664901800164;837.4891316297054;14819.110853348806;15363.155026473525;15373.615659608515;15439.922800385983;15637.765433518493;15573.143477108755;15641.296141673623;15714.135722535257;15727.056376617382;15731.134787586678;640.3116649601674;760.1106705154955;780.3795982194155;801.3308887079296;802.1016461563029;788.5071830106184;792.0970094092739;793.1592511937336;795.5624406576388;795.7930937956144;841.8274253777992;843.3379796859466;847.3517758914436;848.1433751910553;848.3298194426395;830.5930094253832;832.4214670803793;837.7905523619095;840.8906842110548;843.2158092973532;616.8642898562309;619.8946179149556;620.0203678188451;621.4748537485817;625.2434554189437;11920.88079119215;12027.51889924402;12093.45579448927;12171.93914030433;12204.145709800317;15681.215939202993;15891.205439728083;16223.675526489404;16318.347266109342;16432.342706291733;11605.535778568847;11693.239939403911;11994.16040877139;12035.338056406894;12406.379681016004;3812.294725475796;3844.2503711776217;3888.4556162137324;3989.5412027616903;4027.617376349242;86747.56626216891;86777.56611216966;86831.13168868357;87380;90291.54854225753;11313.943430282796;11346.432678366049;11545.595904143314;11629.709257268636;11675.065994720402;19913.800861991484;20665.380038598865;21174.941252937293;21185.364439066852;21223.15107395687;8093.392995525359;8216.671333146727;8383;8557.529335886462;8580.914190858137;4595.310703394451;4647.790849411717;4716.669833111718;4733.763311834395;4799.3760811094335;3346.2972775716885;3465;3465.0471120441575;3473.1838018065732;3483.1292176955762;585.2625691628579;592.6266452135213;593.1192179613271;607.2803727582829;608.5192697768713;650.6811662285446;694.6561452081152;738.7894450081701;748.5284270909401;793.9523628582187;8993.595288212045;9392.342536022414;9620.230381569458;9712.805743885225;10075.09324160829;661.4820774112798;733.1641928201855;744.3821628048814;761.4828147173878;761.824780300534;4648.1865673507;4931.161702510582;4957;5029.547340739351;5104.1067813133295;128507;128605;130782;132095.33952330178;133302.3367429582;62200;62427;64016.67991660012;96902.51548742212;113737;75917;77602.22397776177;82424;86709.5664521686;87639.56180219186;9744.75638109053;9778;9792.09054234446;9860.211183105477;9995.650152244636;50974.235386469976;51502;51591;52345.21482177694;52434.73782631062;71545.64227178831;73818.63090684512;75793;79030.25818450912;79110.6044469797;13456.192628441933;13520.661983450493;13550.728985420039;13625.523106691218;13676.179429234278;14737.410503580166;14946.327415266556;15022.699546009237;15383.69232615319;15437.536873893801;13580.173126537578;13958.79061814094;14492.565223043326;14671.486497972519;15554.688906222038;13402.530911418053;13539.323033848072;13953.860461395661;14679.926600366929;14707.41170353174;12915.870841291468;13122.081454298108;13320.467181312639;13472.797908031584;13944.79082813779;11442.60136523173;11549.769004620028;11692.70768230767;11881.1089168311;11919.642410727693;11309.264897781617;12143.210691305037;12365.814512782135;12430.192037517532;12783.61649150527 06:18:06 INFO - PROCESS | 15241 | __end_tp_report 06:18:06 INFO - PROCESS | 15241 | __start_cc_report 06:18:06 INFO - PROCESS | 15241 | _x_x_mozilla_cycle_collect,341 06:18:06 INFO - PROCESS | 15241 | __end_cc_report 06:18:06 INFO - PROCESS | 15241 | __startTimestamp1472735886837__endTimestamp 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | ------- Summary: start ------- 06:18:06 INFO - PROCESS | 15241 | Number of tests: 6 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | [#0] dojo.html Cycles:165 Average:5508.57 Median:5727.43 stddev:635.88 (11.1%) stddev-sans-first:608.60 06:18:06 INFO - PROCESS | 15241 | Values: 3078.9 3090.8 3099.1 3107.6 3122.7 5307.7 5485.9 5563.0 5573.5 5580.4 5495.7 5548.4 5555.7 5557.8 5616.5 4977.3 5076.5 5090.9 5140.8 5170.9 5081.2 5086.0 5094.2 5149.4 5149.6 4943.9 5039.4 5070.2 5086.3 5098.6 5071.5 5075.7 5077.5 5086.9 5138.2 4998.6 5015.9 5064.3 5065.0 5087.0 5274.4 5420.3 5525.6 5533.8 5594.7 5911.5 5926.6 5934.1 5935.1 5955.1 5947.1 5956.8 5958.8 5963.9 5969.0 5326.9 5456.9 5502.7 5508.5 5541.1 6045.9 6058.6 6075.8 6078.0 6129.4 5727.4 5773.5 5773.6 5787.4 5795.8 5543.0 5803.2 5856.2 5891.5 5958.6 5704.7 5750.5 5793.8 5865.3 5871.9 5795.8 5869.7 5879.2 5882.6 5897.5 4511.2 4570.7 4574.4 4628.5 4634.4 4012.1 4113.8 4115.1 4116.9 4151.8 5405.5 5516.8 5569.6 5698.7 5713.0 5895.8 5896.4 5896.6 5961.0 5977.0 5576.1 5586.1 5596.6 5600.5 5600.9 4872.0 4943.8 5029.6 5066.2 5112.6 6199.6 6204.9 6236.0 6243.7 6249.3 6026.9 6041.7 6045.8 6055.5 6142.1 5978.8 6093.3 6141.0 6227.5 6257.5 5872.9 5899.0 5909.6 5953.2 5979.8 6010.7 6016.5 6022.7 6025.6 6028.5 5611.4 5771.9 5800.8 5811.5 5857.4 5812.8 5825.8 5834.1 5838.0 5891.0 5804.3 5804.4 5805.2 5817.1 5828.4 5650.7 5759.0 5812.9 5845.2 5897.1 5686.6 5687.0 5690.2 5727.8 5765.7 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | [#1] ext.html Cycles:180 Average:59647.71 Median:43096.78 stddev:116252.99 (269.7%) stddev-sans-first:116494.41 06:18:06 INFO - PROCESS | 15241 | Values: 543.0 582.8 583.9 600.3 627.5 38495.4 43050.8 43072.8 43120.8 43132.1 43434.0 44134.3 44162.0 44167.0 44243.0 8860.9 8943.7 8945.2 9030.2 9033.9 8871.2 8877.7 8930.7 8934.3 8968.9 8961.0 8982.9 8985.2 9043.7 9075.1 8851.3 8897.5 8923.6 8987.3 9001.3 8796.7 8902.3 8923.1 8926.6 8932.2 41088.6 41248.8 41450.4 41457.0 41462.6 3596.7 3663.7 3798.9 4146.9 4153.4 32100.5 32383.2 32545.7 32774.7 32857.3 4231.9 4290.7 4315.7 4362.5 4433.3 339019.0 340058.0 341754.3 342448.0 344411.0 55029.3 55340.7 55458.0 55586.7 55658.4 35783.3 36550.2 36612.0 58951.4 59132.8 15582.0 15710.3 15889.7 15927.4 16061.0 11934.3 12067.0 12073.5 12082.5 12104.8 18593.2 18659.2 18728.7 18748.7 18840.5 7175.6 7346.9 7408.0 7484.1 7523.6 941.0 972.8 1035.0 1040.6 1064.9 31713.0 31818.4 32046.5 32388.0 32544.2 1028.3 1071.9 1128.1 1166.5 1173.5 16031.9 16834.2 17060.9 17099.4 17104.1 511911.0 516577.0 519422.0 520874.0 521205.0 56381.7 57100.4 57199.9 57518.0 57658.1 1329.2 1350.1 1363.2 1369.9 1370.5 29475.9 30871.3 30881.8 31342.7 31726.0 50076.0 50248.5 50527.5 50562.5 50618.5 438704.0 439774.8 440389.0 440828.0 440977.0 28067.1 44432.3 45028.8 45284.6 46161.3 46639.5 46922.0 47110.5 49944.3 50840.5 41402.2 42320.2 42770.8 43845.8 44534.3 42706.6 42765.5 43490.6 43708.0 44004.3 41781.6 41823.4 42377.4 42708.4 44200.3 36334.3 40201.4 40867.8 41891.2 42066.4 28780.4 29033.0 29157.7 29334.0 29522.3 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | [#2] jquery.html Cycles:180 Average:27692.18 Median:394.28 stddev:75642.98 (19185.2%) stddev-sans-first:75827.41 06:18:06 INFO - PROCESS | 15241 | Values: 392.8 395.7 403.0 406.3 420.0 18392.9 19835.0 19840.9 20002.0 20685.8 18090.7 18270.0 18364.1 18539.3 18714.3 5562.3 5572.4 5780.0 5841.3 5883.1 5848.0 5875.2 5877.1 5896.2 5906.8 5650.1 5778.8 5816.2 5830.7 5834.8 5814.3 5869.4 5910.5 5960.3 6038.5 5728.4 5731.6 5775.9 5781.6 5790.4 14039.7 14101.8 14124.8 14287.3 14331.2 2135.3 2245.5 2251.0 2269.0 2359.4 9970.8 10140.5 10287.7 12481.1 14176.8 1854.5 1922.2 1926.9 1964.8 1971.8 79743.6 84896.7 85010.6 85030.6 85788.3 11013.7 11100.4 11255.9 11366.8 11484.4 15619.5 15625.5 15634.7 15685.8 15697.5 7706.0 7807.3 8001.9 8314.3 8399.5 7637.7 7665.7 7702.0 7855.4 7930.5 4685.9 4745.7 4775.6 4868.3 4906.8 1971.4 1986.8 2017.4 2026.4 2035.3 832.4 902.4 911.8 941.7 1018.7 18077.4 19012.6 19554.1 20011.4 20329.5 954.5 960.4 975.7 989.8 997.3 9002.3 10982.5 11248.1 11267.3 11287.2 413133.9 467117.0 468664.0 469263.0 469461.0 59102.7 62134.4 91461.0 95452.0 99313.0 998.9 1059.9 1063.1 1091.9 1101.0 17297.7 17378.5 17890.5 18072.8 18369.4 29541.9 32774.2 41474.0 43503.8 43886.3 59126.4 59151.0 60246.4 61812.4 62024.0 8224.1 8317.0 8374.2 8387.5 8860.8 11200.6 13543.6 13659.4 13764.8 13891.9 11728.5 11745.2 11815.4 11869.8 12401.6 11835.6 11884.5 11995.9 12018.8 12381.9 10788.1 10862.5 11608.4 12032.1 12118.9 8203.3 8382.2 8430.7 8587.0 8597.0 11549.8 11650.5 11848.7 11925.1 11940.5 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | [#3] mootools.html Cycles:180 Average:6016.57 Median:4950.11 stddev:3431.67 (69.3%) stddev-sans-first:3424.37 06:18:06 INFO - PROCESS | 15241 | Values: 1481.1 1495.3 1658.3 1759.7 1776.0 7664.2 8747.3 9021.8 9407.4 9433.4 8954.8 9312.1 9316.8 9338.3 9417.2 2429.8 2443.9 2449.7 2457.3 2457.5 2399.5 2406.2 2456.0 2462.9 2466.1 2434.0 2438.3 2441.4 2446.0 2456.0 2384.3 2411.3 2411.5 2417.8 2455.8 2370.3 2389.2 2399.3 2404.7 2406.5 8977.1 9102.9 9247.7 9338.2 9338.6 5518.3 5618.0 5644.6 5651.7 5674.2 3324.6 3463.9 3467.5 3510.8 3516.4 1177.4 1192.5 1250.8 1263.8 1265.9 12784.3 12908.3 12914.6 12980.2 13014.5 4846.2 4855.6 4935.2 4954.1 5105.4 10172.1 10216.6 10249.3 10282.9 10292.5 5562.6 5595.1 5603.4 5603.7 5615.8 4301.1 4946.1 5067.1 5075.5 5089.4 3931.6 4081.6 4083.2 4112.4 4119.1 1325.4 1346.2 1346.6 1351.0 1355.2 776.9 866.9 874.7 929.4 950.2 5958.5 6020.8 6133.2 6284.4 6470.3 900.0 953.1 994.3 995.6 1001.1 3867.5 4008.5 4046.3 4074.1 4139.1 11176.5 11352.1 11491.5 11542.7 11595.9 11302.4 11362.3 11404.3 11462.3 11471.8 8428.1 8450.6 8471.3 8581.7 8742.2 6014.5 6026.1 6058.7 6150.1 6336.9 10360.2 10366.8 10476.1 10592.9 10632.4 10653.4 10703.8 10716.6 10763.4 10781.5 6693.2 7505.0 7636.7 7683.2 7752.5 9030.4 9037.9 9075.6 9084.3 9095.3 7984.0 8147.6 8162.7 8201.9 8434.3 7680.4 7812.5 7850.8 7910.2 8113.3 7231.6 7261.3 7308.5 7350.7 7404.0 5245.2 5262.3 5301.2 5331.4 5425.3 5167.4 5201.5 5214.6 5289.3 5335.1 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | [#4] prototype.html Cycles:180 Average:4680.91 Median:5255.84 stddev:1355.84 (25.8%) stddev-sans-first:1319.67 06:18:06 INFO - PROCESS | 15241 | Values: 327.0 331.1 334.2 341.8 343.8 5451.8 5528.9 5594.9 5628.6 5668.9 5469.6 5486.1 5499.0 5509.7 5510.9 4309.5 4313.5 4323.3 4346.5 4371.3 4257.6 4283.1 4292.8 4342.8 4364.9 4275.3 4282.8 4287.0 4289.6 4296.5 4281.5 4287.7 4292.5 4300.9 4300.9 3711.7 3797.4 3802.6 3804.8 3810.2 5403.0 5408.7 5424.8 5439.7 5447.0 4930.2 4940.6 4941.8 4942.2 4945.2 5599.0 5793.2 5797.7 5800.5 5816.7 4100.8 4103.8 4108.2 4117.2 4119.8 6027.7 6089.8 6150.4 6167.5 6175.8 4045.4 4206.7 4229.5 4242.9 4247.4 4213.5 4217.5 4226.2 4233.2 4245.0 4858.8 4894.0 4909.9 4921.7 4980.9 5746.4 5797.3 5892.8 5925.8 5932.9 1450.6 1468.5 1471.5 1472.0 1479.9 893.6 923.9 941.5 950.4 952.6 4864.2 4891.5 4907.9 4908.7 4964.4 5231.6 5232.4 5247.3 5253.2 5258.5 4707.7 4918.0 4949.3 4952.7 4967.0 2723.7 2773.8 2795.9 2802.3 2803.0 5375.9 5392.3 5400.4 5400.7 5499.7 5177.6 5307.9 5391.8 5399.6 5410.0 5354.1 5358.9 5365.0 5374.7 5419.1 5189.6 5272.4 5281.6 5297.9 5330.2 4866.5 5092.9 5106.7 5110.2 5152.7 5334.4 5339.4 5409.5 5500.7 5501.8 3860.9 4062.7 4064.1 4155.2 4156.3 5817.8 5888.6 5901.9 5907.9 5914.3 5680.4 5785.7 5803.4 5804.9 5829.9 5713.6 5719.4 5730.8 5742.6 5779.5 5663.7 5707.8 5723.8 5741.7 5742.5 5480.7 5670.2 5678.0 5725.7 5727.9 5569.9 5572.6 5599.4 5624.6 5632.2 06:18:06 INFO - PROCESS | 15241 | 06:18:06 INFO - PROCESS | 15241 | [#5] yui.html Cycles:180 Average:21032.60 Median:4725.22 stddev:30854.09 (653.0%) stddev-sans-first:30903.03 06:18:06 INFO - PROCESS | 15241 | Values: 742.3 772.9 776.8 817.2 837.5 14819.1 15363.2 15373.6 15439.9 15637.8 15573.1 15641.3 15714.1 15727.1 15731.1 640.3 760.1 780.4 801.3 802.1 788.5 792.1 793.2 795.6 795.8 841.8 843.3 847.4 848.1 848.3 830.6 832.4 837.8 840.9 843.2 616.9 619.9 620.0 621.5 625.2 11920.9 12027.5 12093.5 12171.9 12204.1 15681.2 15891.2 16223.7 16318.3 16432.3 11605.5 11693.2 11994.2 12035.3 12406.4 3812.3 3844.3 3888.5 3989.5 4027.6 86747.6 86777.6 86831.1 87380.0 90291.5 11313.9 11346.4 11545.6 11629.7 11675.1 19913.8 20665.4 21174.9 21185.4 21223.2 8093.4 8216.7 8383.0 8557.5 8580.9 4595.3 4647.8 4716.7 4733.8 4799.4 3346.3 3465.0 3465.0 3473.2 3483.1 585.3 592.6 593.1 607.3 608.5 650.7 694.7 738.8 748.5 794.0 8993.6 9392.3 9620.2 9712.8 10075.1 661.5 733.2 744.4 761.5 761.8 4648.2 4931.2 4957.0 5029.5 5104.1 128507.0 128605.0 130782.0 132095.3 133302.3 62200.0 62427.0 64016.7 96902.5 113737.0 75917.0 77602.2 82424.0 86709.6 87639.6 9744.8 9778.0 9792.1 9860.2 9995.7 50974.2 51502.0 51591.0 52345.2 52434.7 71545.6 73818.6 75793.0 79030.3 79110.6 13456.2 13520.7 13550.7 13625.5 13676.2 14737.4 14946.3 15022.7 15383.7 15437.5 13580.2 13958.8 14492.6 14671.5 15554.7 13402.5 13539.3 13953.9 14679.9 14707.4 12915.9 13122.1 13320.5 13472.8 13944.8 11442.6 11549.8 11692.7 11881.1 11919.6 11309.3 12143.2 12365.8 12430.2 12783.6 06:18:06 INFO - PROCESS | 15241 | -------- Summary: end -------- 06:18:06 INFO - PROCESS | 15241 | 06:18:07 INFO - TEST-INFO | 15241: exit 0 06:18:07 INFO - TEST-OK | dromaeo_css | took 1114940ms 06:18:07 INFO - TEST-START | kraken 06:18:07 INFO - operating with platform_type : linux_ 06:18:07 INFO - Initialising browser for kraken test... 06:18:07 INFO - TEST-INFO | started process 15597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGNz3Lw/profile http://localhost:58067/getInfo.html) 06:18:13 INFO - PROCESS | 15597 | __metrics Screen width/height:1600/1200 06:18:13 INFO - PROCESS | 15597 | colorDepth:24 06:18:13 INFO - PROCESS | 15597 | Browser inner width/height: 1024/697 06:18:13 INFO - PROCESS | 15597 | __metrics 06:18:13 ERROR - PROCESS | 15597 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 06:18:14 INFO - TEST-INFO | 15597: exit 0 06:18:14 INFO - Browser initialized. 06:18:14 INFO - Running cycle 1/1 for kraken test... 06:18:14 INFO - TEST-INFO | started process 15719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGNz3Lw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:18:26 INFO - PROCESS | 15719 | RSS: Main: 191983616 06:18:26 INFO - PROCESS | 15719 | 06:18:29 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58067/tests/kraken/driver.html?testName=audio-beat-detection) 06:18:30 INFO - PROCESS | 15719 | RSS: Main: 205344768 06:18:30 INFO - PROCESS | 15719 | 06:18:33 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58067/tests/kraken/driver.html?testName=audio-dft) 06:18:33 INFO - PROCESS | 15719 | RSS: Main: 205119488 06:18:33 INFO - PROCESS | 15719 | 06:18:36 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58067/tests/kraken/driver.html?testName=audio-fft) 06:18:37 INFO - PROCESS | 15719 | RSS: Main: 197885952 06:18:37 INFO - PROCESS | 15719 | 06:18:39 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58067/tests/kraken/driver.html?testName=audio-oscillator) 06:18:40 INFO - PROCESS | 15719 | RSS: Main: 199036928 06:18:40 INFO - PROCESS | 15719 | 06:18:42 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58067/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:42 INFO - PROCESS | 15719 | RSS: Main: 198991872 06:18:42 INFO - PROCESS | 15719 | 06:18:45 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58067/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:46 INFO - PROCESS | 15719 | RSS: Main: 199458816 06:18:46 INFO - PROCESS | 15719 | 06:18:50 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58067/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:50 INFO - PROCESS | 15719 | RSS: Main: 197156864 06:18:50 INFO - PROCESS | 15719 | 06:18:53 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58067/tests/kraken/driver.html?testName=json-parse-financial) 06:18:54 INFO - PROCESS | 15719 | RSS: Main: 199327744 06:18:54 INFO - PROCESS | 15719 | 06:18:55 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58067/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:56 INFO - PROCESS | 15719 | RSS: Main: 199217152 06:18:56 INFO - PROCESS | 15719 | 06:18:58 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:58 INFO - PROCESS | 15719 | RSS: Main: 199258112 06:18:58 INFO - PROCESS | 15719 | 06:19:00 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:19:01 INFO - PROCESS | 15719 | RSS: Main: 199786496 06:19:01 INFO - PROCESS | 15719 | 06:19:04 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:19:04 INFO - PROCESS | 15719 | RSS: Main: 200073216 06:19:04 INFO - PROCESS | 15719 | 06:19:07 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:19:08 INFO - PROCESS | 15719 | RSS: Main: 199757824 06:19:08 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | Cycle 1(1): loaded http://localhost:58067/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58067/tests/kraken/driver.html?testName=ai-astar) 06:19:10 INFO - PROCESS | 15719 | RSS: Main: 201392128 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | __start_tp_report 06:19:10 INFO - PROCESS | 15719 | _x_x_mozilla_page_load 06:19:10 INFO - PROCESS | 15719 | _x_x_mozilla_page_load_details 06:19:10 INFO - PROCESS | 15719 | |i|pagename|runs| 06:19:10 INFO - PROCESS | 15719 | |0;ai-astar;106;112;112;112;114;113;112;112;114;130 06:19:10 INFO - PROCESS | 15719 | |1;audio-beat-detection;149;126;145;186;124;150;152;125;176;119 06:19:10 INFO - PROCESS | 15719 | |2;audio-dft;162;165;167;170;164;163;167;163;165;163 06:19:10 INFO - PROCESS | 15719 | |3;audio-fft;76;77;77;186;76;76;76;82;173;80 06:19:10 INFO - PROCESS | 15719 | |4;audio-oscillator;83;82;152;87;83;83;148;82;83;141 06:19:10 INFO - PROCESS | 15719 | |5;imaging-gaussian-blur;119;119;118;118;119;119;119;118;118;119 06:19:10 INFO - PROCESS | 15719 | |6;imaging-darkroom;148;148;148;149;154;148;147;147;147;146 06:19:10 INFO - PROCESS | 15719 | |7;imaging-desaturate;97;96;95;95;96;96;96;96;96;95 06:19:10 INFO - PROCESS | 15719 | |8;json-parse-financial;52;53;53;54;55;55;54;55;55;55 06:19:10 INFO - PROCESS | 15719 | |9;json-stringify-tinderbox;62;63;63;63;65;62;62;62;62;62 06:19:10 INFO - PROCESS | 15719 | |10;stanford-crypto-aes;80;80;79;81;83;80;80;80;87;79 06:19:10 INFO - PROCESS | 15719 | |11;stanford-crypto-ccm;135;138;126;135;141;126;140;130;176;126 06:19:10 INFO - PROCESS | 15719 | |12;stanford-crypto-pbkdf2;166;170;172;165;166;164;169;165;173;167 06:19:10 INFO - PROCESS | 15719 | |13;stanford-crypto-sha256-iterative;67;68;67;66;67;66;69;70;66;64 06:19:10 INFO - PROCESS | 15719 | __end_tp_report 06:19:10 INFO - PROCESS | 15719 | __start_cc_report 06:19:10 INFO - PROCESS | 15719 | _x_x_mozilla_cycle_collect,782 06:19:10 INFO - PROCESS | 15719 | __end_cc_report 06:19:10 INFO - PROCESS | 15719 | __startTimestamp1472735950290__endTimestamp 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | ------- Summary: start ------- 06:19:10 INFO - PROCESS | 15719 | Number of tests: 14 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#0] ai-astar Cycles:10 Average:113.70 Median:112.50 stddev:6.15 (5.5%) stddev-sans-first:5.85 06:19:10 INFO - PROCESS | 15719 | Values: 106.0 112.0 112.0 112.0 114.0 113.0 112.0 112.0 114.0 130.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:149.50 stddev:22.63 (15.1%) stddev-sans-first:23.96 06:19:10 INFO - PROCESS | 15719 | Values: 149.0 126.0 145.0 186.0 124.0 150.0 152.0 125.0 176.0 119.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.47 (1.5%) stddev-sans-first:2.39 06:19:10 INFO - PROCESS | 15719 | Values: 162.0 165.0 167.0 170.0 164.0 163.0 167.0 163.0 165.0 163.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#3] audio-fft Cycles:10 Average:97.90 Median:76.50 stddev:43.16 (56.4%) stddev-sans-first:45.05 06:19:10 INFO - PROCESS | 15719 | Values: 76.0 77.0 77.0 186.0 76.0 76.0 76.0 82.0 173.0 80.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:83.00 stddev:30.92 (37.3%) stddev-sans-first:31.99 06:19:10 INFO - PROCESS | 15719 | Values: 83.0 82.0 152.0 87.0 83.0 83.0 148.0 82.0 83.0 141.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:19:10 INFO - PROCESS | 15719 | Values: 119.0 119.0 118.0 118.0 119.0 119.0 119.0 118.0 118.0 119.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:2.20 (1.5%) stddev-sans-first:2.33 06:19:10 INFO - PROCESS | 15719 | Values: 148.0 148.0 148.0 149.0 154.0 148.0 147.0 147.0 147.0 146.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 06:19:10 INFO - PROCESS | 15719 | Values: 97.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:55.00 stddev:1.10 (2.0%) stddev-sans-first:0.87 06:19:10 INFO - PROCESS | 15719 | Values: 52.0 53.0 53.0 54.0 55.0 55.0 54.0 55.0 55.0 55.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 06:19:10 INFO - PROCESS | 15719 | Values: 62.0 63.0 63.0 63.0 65.0 62.0 62.0 62.0 62.0 62.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:2.42 (3.0%) stddev-sans-first:2.55 06:19:10 INFO - PROCESS | 15719 | Values: 80.0 80.0 79.0 81.0 83.0 80.0 80.0 80.0 87.0 79.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:136.50 stddev:14.78 (10.8%) stddev-sans-first:15.65 06:19:10 INFO - PROCESS | 15719 | Values: 135.0 138.0 126.0 135.0 141.0 126.0 140.0 130.0 176.0 126.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:3.13 (1.9%) stddev-sans-first:3.26 06:19:10 INFO - PROCESS | 15719 | Values: 166.0 170.0 172.0 165.0 166.0 164.0 169.0 165.0 173.0 167.0 06:19:10 INFO - PROCESS | 15719 | 06:19:10 INFO - PROCESS | 15719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 06:19:10 INFO - PROCESS | 15719 | Values: 67.0 68.0 67.0 66.0 67.0 66.0 69.0 70.0 66.0 64.0 06:19:10 INFO - PROCESS | 15719 | -------- Summary: end -------- 06:19:10 INFO - PROCESS | 15719 | 06:19:11 INFO - TEST-INFO | 15719: exit 0 06:19:11 INFO - TEST-OK | kraken | took 63669ms 06:19:11 INFO - SUITE-END | took 1178s 06:19:11 INFO - Completed test suite (00:19:39) 06:19:11 INFO - javascript benchmark 06:19:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7337.584064749901, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.892238771643, 3090.7527397808162, 3099.054788289572, 3107.5649409082735, 3122.734567561757, 5307.681539107647, 5485.862853428661, 5563.0, 5573.470520300575, 5580.414056524068, 5495.670259784406, 5548.4174161713045, 5555.694436805974, 5557.833265002047, 5616.52259557938, 4977.278294647265, 5076.517730815585, 5090.9236361454605, 5140.820071297505, 5170.922436163461, 5081.212412076134, 5086.0, 5094.184930411135, 5149.382074151107, 5149.639525233217, 4943.8516844494725, 5039.420466646346, 5070.2394640803805, 5086.3387759591205, 5098.5921126309995, 5071.492850714936, 5075.670081444731, 5077.517635824628, 5086.898262034775, 5138.203578445347, 4998.600391890276, 5015.899682006376, 5064.3163172971545, 5065.037642847884, 5087.0, 5274.446183150752, 5420.268263784378, 5525.557955363562, 5533.778648854041, 5594.748236329375, 5911.497522710575, 5926.644401335933, 5934.109883517507, 5935.10973353996, 5955.076963070731, 5947.078202878561, 5956.791512297049, 5958.791442299499, 5963.910541341883, 5969.0, 5326.866828329284, 5456.945430545684, 5502.669839809624, 5508.504234618824, 5541.113421852525, 6045.909311360333, 6058.606190597597, 6075.817725468243, 6078.0, 6129.356417576179, 5727.427257274239, 5773.509251713567, 5773.566982476331, 5787.363390027093, 5795.797147099831, 5542.972285138549, 5803.187553742479, 5856.180134781134, 5891.528677705774, 5958.6424814511265, 5704.71476426177, 5750.482456578844, 5793.826185214451, 5865.325487568899, 5871.911921321183, 5795.768169273182, 5869.73586188614, 5879.20630714848, 5882.55880808941, 5897.498712609477, 4511.210538155809, 4570.6800523963, 4574.359589657451, 4628.467726211461, 4634.397528321297, 4012.0772222389014, 4113.794310284474, 4115.053537686289, 4116.876493705194, 4151.81673223136, 5405.459454054563, 5516.834494965157, 5569.610127291051, 5698.7435565399655, 5713.028785106542, 5895.823125306248, 5896.380880007623, 5896.64620122794, 5961.01643228871, 5977.0, 5576.10782274834, 5586.13414920688, 5596.636218645856, 5600.52395546375, 5600.859978500489, 4872.0, 4943.8022479101155, 5029.59763218949, 5066.189409694505, 5112.590992720573, 6199.597026193283, 6204.937950620526, 6235.999999999909, 6243.656598887105, 6249.25008998923, 6026.909596356146, 6041.6677082759115, 6045.818625441244, 6055.530503124424, 6142.078688196806, 5978.760849565969, 6093.29927058394, 6141.0, 6227.532935029982, 6257.530685198537, 5872.911906321494, 5899.026660600953, 5909.6158749681135, 5953.166556681981, 5979.790707325223, 6010.7295171716505, 6016.458518733335, 6022.668753218615, 6025.6083354581815, 6028.5177185825905, 5611.354694210055, 5771.9134212986, 5800.796972105956, 5811.476967072984, 5857.414258574279, 5812.796552120655, 5825.82522524308, 5834.095715164156, 5837.970810145922, 5891.0, 5804.332501762351, 5804.361520232686, 5805.245318108618, 5817.127430885232, 5828.388019257917, 5650.745716442852, 5759.0209664356325, 5812.94187058124, 5845.18167456548, 5897.115432685132, 5686.630369026, 5687.033204355187, 5690.174924635988, 5727.828165154885, 5765.740541675551], "value": 5464.463833646597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.9939852973936, 582.8105865593681, 583.903655896777, 600.3336296710651, 627.5481653209694, 38495.42256866146, 43050.784746076264, 43072.78463607677, 43120.78439607798, 43132.118109370225, 43434.0, 44134.33798493025, 44162.0, 44167.0, 44243.0, 8860.911390886105, 8943.686970956018, 8945.15021072997, 9030.232430243404, 9033.864492032624, 8871.157240062184, 8877.68928087517, 8930.687425940094, 8934.285257179443, 8968.865467018, 8960.955195224014, 8982.910170898273, 8985.191332780048, 9043.683471078513, 9075.092490750905, 8851.291896648285, 8897.510636914967, 8923.643054277822, 8987.281017518582, 9001.279897608176, 8796.736097917073, 8902.33232507558, 8923.063078376741, 8926.642934282621, 8932.196102350754, 41088.58911410878, 41248.79375603133, 41450.37824432636, 41457.0, 41462.585374146474, 3596.6762991330643, 3663.655260633197, 3798.924021519554, 4146.91706165875, 4153.439285696422, 32100.518492222636, 32383.190420239447, 32545.6745432545, 32774.6722532774, 32857.34285314304, 4231.915361692749, 4290.69965102443, 4315.654747620183, 4362.520122786491, 4433.290673492258, 339019.0, 340058.0, 341754.2912285447, 342448.0, 344411.0, 55029.322507587305, 55340.72329638326, 55458.0, 55586.72206639022, 55658.44341556533, 35783.28433431317, 36550.238205931986, 36612.0, 58951.41048589545, 59132.79105693926, 15582.0, 15710.293036813371, 15889.68220635604, 15927.442539511061, 16061.0, 11934.28394296345, 12067.034637229, 12073.45669444877, 12082.516699331929, 12104.75790484203, 18593.16330765119, 18659.160337784833, 18728.719069213974, 18748.718769218474, 18840.52898677544, 7175.641217939082, 7346.926530734624, 7407.962960185165, 7484.1393239777035, 7523.623818809037, 940.9905900941039, 972.8054389122204, 1035.0477560644226, 1040.5733649203942, 1064.893510648929, 31713.0, 31818.363632727214, 32046.519302210487, 32388.0, 32544.186395340304, 1028.280203857303, 1071.8606581144556, 1128.0975219824109, 1166.4517676691942, 1173.4778023779336, 16031.873784612122, 16834.158292085347, 17060.914695426443, 17099.401520946707, 17104.14479276031, 511911.0, 516577.0, 519422.0, 520874.0, 521205.0, 56381.71809140928, 57100.42899570951, 57199.85400802913, 57518.0, 57658.13512797312, 1329.1759109352263, 1350.0617071135664, 1363.2297751770218, 1369.869862363074, 1370.451819272299, 29475.852620736758, 30871.31046051811, 30881.845590771904, 31342.686573134888, 31726.0, 50076.0, 50248.497515024384, 50527.49472505228, 50562.49437505725, 50618.493815061374, 438704.0, 439774.8011259923, 440389.0, 440828.0, 440977.0, 28067.123554729224, 44432.33351499665, 45028.77485612551, 45284.62234486631, 46161.307580386994, 46639.53360466487, 46922.0, 47110.52889471062, 49944.250836238214, 50840.491595085055, 41402.171956560094, 42320.15359692727, 42770.78614606907, 43845.78077109594, 44534.3319850209, 42706.57293427026, 42765.48122357622, 43490.565094348654, 43708.0, 44004.33993490036, 41781.58218417899, 41823.37264941089, 42377.36433953432, 42708.35937461003, 44200.33699494575, 36334.27331453409, 40201.39697904475, 40867.795661021504, 41891.162176755686, 42066.369004464344, 28780.42439151247, 29033.0, 29157.7084229155, 29334.0, 29522.261943451587], "value": 20213.37310728372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.84482629361423, 395.70915377197775, 402.9979850100749, 406.31738679019253, 420.02554074547044, 18392.90803545982, 19835.0, 19840.900795496003, 20001.99999999998, 20685.79314206861, 18090.728639070425, 18270.0, 18364.081795910184, 18539.25842966283, 18714.251429942786, 5562.3047119110215, 5572.359178694442, 5780.0, 5841.269841269841, 5883.0881213411985, 5847.970760146193, 5875.236219291486, 5877.118432235156, 5896.23348964634, 5906.763729450817, 5650.0959846424585, 5778.768849246025, 5816.243888294516, 5830.737616807254, 5834.824955251349, 5814.302283725959, 5869.442402971711, 5910.527157827363, 5960.254968128984, 6038.547108966845, 5728.369879313273, 5731.598788084836, 5775.942240577582, 5781.566382521286, 5790.420957904218, 14039.719205615831, 14101.788473172808, 14124.788128178085, 14287.285635718277, 14331.211783351911, 2135.263334149716, 2245.5396643688005, 2250.9774902250933, 2268.9886550567307, 2359.3747656870773, 9970.800583988352, 10140.543675534545, 10287.691369258935, 12481.126321157522, 14176.787348189786, 1854.5178253654012, 1922.1926790747918, 1926.9421917342502, 1964.803519648038, 1971.842252619787, 79743.60128199322, 84896.72654910182, 85010.57494712487, 85030.57484712599, 85788.28164450952, 11013.669589912315, 11100.44497775108, 11255.943720281346, 11366.772664546663, 11484.425778711031, 15619.453319133776, 15625.531234062997, 15634.687306254038, 15685.764713529306, 15697.450589229322, 7705.961470192613, 7807.336376407955, 8001.919980800234, 8314.334853211729, 8399.496030238206, 7637.694492220249, 7665.731699390494, 7701.961490192513, 7855.371570274365, 7930.484518506279, 4685.906281874343, 4745.667803253808, 4775.570198682135, 4868.269759536027, 4906.828261010847, 1971.4184315626924, 1986.754966887408, 2017.3947815655245, 2026.402211347656, 2035.288307568005, 832.4422636833336, 902.4477898015404, 911.8404279251105, 941.7033634405141, 1018.7453136715822, 18077.367292144976, 19012.61974760497, 19554.120064597126, 20011.399658010283, 20329.49176270605, 954.5227386306847, 960.4093482508207, 975.6780262513354, 989.7773001074845, 997.3268044070223, 9002.324825638103, 10982.505787239594, 11248.100151987821, 11267.32396056223, 11287.209895307415, 413133.93433033244, 467117.0, 468664.0, 469263.0, 469461.0, 59102.70448647729, 62134.37865621376, 91461.0, 95452.0, 99313.0, 998.8701468809008, 1059.8940105989493, 1063.0963680871353, 1091.8689757229183, 1100.9614663486739, 17297.740533892254, 17378.52282555997, 17890.463286101436, 18072.819271807115, 18369.357072502396, 29541.940327448316, 32774.180645484055, 41474.0, 43503.824808760066, 43886.34170487381, 59126.40873591209, 59151.0, 60246.397536025834, 61812.38187618066, 62024.0, 8224.095349511668, 8317.0, 8374.246317831425, 8387.454815436977, 8860.822783544165, 11200.607978720705, 13543.59369218925, 13659.385327660479, 13764.793528096887, 13891.861081389461, 11728.530858765555, 11745.17783755129, 11815.350155741517, 11869.821952670543, 12401.565945191875, 11835.585754498552, 11884.46519906589, 11995.880041199825, 12018.819717704417, 12381.876181238073, 10788.136949043901, 10862.511186996446, 11608.419579021183, 12032.09759268041, 12118.878811211775, 8203.343732501506, 8382.245597896219, 8430.747077587683, 8587.0, 8597.0, 11549.769004620028, 11650.53397864076, 11848.70378240551, 11925.10561707858, 11940.462679179283], "value": 9104.389775846677, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.1483397046698, 1495.3495229575135, 1658.3035125247402, 1759.6832570137385, 1775.9556011099721, 7664.233576642347, 8747.256483198928, 9021.774455638595, 9407.38851974623, 9433.433993960367, 8954.820903581924, 9312.068793120701, 9316.767080822983, 9338.25293976482, 9417.152456278933, 2429.829911906163, 2443.9124589557655, 2449.6937882764655, 2457.287386657876, 2457.5453541094867, 2399.4961058177714, 2406.2420337593603, 2456.0298682020593, 2462.938426539342, 2466.05057053035, 2434.0, 2438.280707191374, 2441.377448750575, 2445.9877700611473, 2455.9754402456015, 2384.2727967969763, 2411.3489357873277, 2411.505641343529, 2417.758224177577, 2455.84037037592, 2370.265217782493, 2389.1637926725507, 2399.256230568529, 2404.663347131403, 2406.506666133456, 8977.057408972028, 9102.86345704815, 9247.72256832296, 9338.206252468548, 9338.626454941794, 5518.255035570187, 5617.988762022835, 5644.604877658566, 5651.717414129277, 5674.177244299594, 3324.6010478742464, 3463.9134021649406, 3467.514547963287, 3510.7717998330027, 3516.43737002081, 1177.3642233194064, 1192.546832203757, 1250.762355152518, 1263.7535680542298, 1265.8860702536724, 12784.296863672495, 12908.290044047573, 12914.612561623073, 12980.221186728826, 13014.544490942772, 4846.176150054499, 4855.587275081587, 4935.235038569028, 4954.1082605130705, 5105.412877519058, 10172.08451239392, 10216.642417515352, 10249.33379330341, 10282.948585257025, 10292.536835842255, 5562.610617256753, 5595.104783234663, 5603.355614104348, 5603.719814009283, 5615.831525054255, 4301.096769678403, 4946.109700253917, 5067.113255180328, 5075.543201111917, 5089.4147173074825, 3931.5871833457645, 4081.571434999342, 4083.1833633273463, 4112.444819949328, 4119.0937993641355, 1325.4101924643442, 1346.1990115881035, 1346.602752188107, 1351.0340106823471, 1355.159800923414, 776.8640487914593, 866.9306455483546, 874.6545114679666, 929.4284015330524, 950.1591091883732, 5958.523318134626, 6020.849478763066, 6133.233345831771, 6284.4344009039405, 6470.320616335312, 899.9730008099767, 953.1040821627648, 994.28908330544, 995.6067353395513, 1001.1290177545582, 3867.497225360685, 4008.4588580541836, 4046.2716710991717, 4074.083331250504, 4139.089400331922, 11176.497057632427, 11352.091832653368, 11491.54033838637, 11542.711432214262, 11595.884041159481, 11302.378369189773, 11362.261453005529, 11404.258723182966, 11462.312261264351, 11471.827922581168, 8428.145807922247, 8450.577471126542, 8471.279941205066, 8581.656733730706, 8742.213200811957, 6014.458698717136, 6026.096085587197, 6058.666773327509, 6150.138980542638, 6336.936630633634, 10360.176453601158, 10366.844497332697, 10476.109530689977, 10592.8940710595, 10632.36205827622, 10653.360798352123, 10703.785924281627, 10716.624918127829, 10763.3541987481, 10781.460926953778, 6693.196816382066, 7505.0, 7636.656350464354, 7683.154852966281, 7752.496087754504, 9030.413023153475, 9037.909620903969, 9075.591598378222, 9084.273258139465, 9095.317851161057, 7984.0, 8147.566562975165, 8162.7143049992965, 8201.917980820115, 8434.32525397979, 7680.385569154566, 7812.453128281193, 7850.803729906798, 7910.169432209535, 8113.310368618498, 7231.602261875647, 7261.3101755333155, 7308.488405811542, 7350.70597176107, 7404.00045993784, 5245.239440281214, 5262.26328314044, 5301.1783173608155, 5331.440198779227, 5425.348958124892, 5167.379914410295, 5201.479852014768, 5214.634975551675, 5289.312389389354, 5335.093034184276], "value": 4806.345121677922, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.9542264083029, 331.0779479150566, 334.2129285532571, 341.84446077034943, 343.78513429106806, 5451.781928722847, 5528.861778455541, 5594.916076258854, 5628.577856660757, 5668.858278543028, 5469.644473109245, 5486.149646804752, 5499.0132154188195, 5509.724513774316, 5510.889782204354, 4309.491677912722, 4313.460817397825, 4323.286657701483, 4346.456692913386, 4371.322445021026, 4257.638100761439, 4283.1433713257475, 4292.763897985609, 4342.848000319989, 4364.869053928372, 4275.251830929575, 4282.764447955361, 4286.97856510717, 4289.6353809926195, 4296.462942132233, 4281.529031806499, 4287.699861009731, 4292.484901811803, 4300.8709738707885, 4300.9139817203795, 3711.740178187528, 3797.4303854421782, 3802.619738026203, 3804.771713697159, 3810.1808111256214, 5403.0, 5408.675479471244, 5424.783008679648, 5439.700816455093, 5447.0, 4930.235813448921, 4940.55535001848, 4941.777620007108, 4942.184539551005, 4945.184044632631, 5599.0, 5793.246877905887, 5797.652140871562, 5800.53595712342, 5816.738246778905, 4100.815463304159, 4103.815328310233, 4108.1783643271465, 4117.21772863158, 4119.8352065917325, 6027.728752206117, 6089.756409743605, 6150.354212807681, 6167.4757645600175, 6175.752969881154, 4045.3931910213114, 4206.747595144301, 4229.492460904711, 4242.85150019754, 4247.3628955656895, 4213.536510983789, 4217.536071032184, 4226.197022565702, 4233.1956928183545, 4244.978775106167, 4858.7570621468785, 4894.0, 4909.87725306863, 4921.704697718148, 4980.850574482699, 5746.367899531048, 5797.275340582427, 5892.823215303548, 5925.762969481172, 5932.940670593239, 1450.55032939789, 1468.4786900650329, 1471.5364660132025, 1472.0, 1479.9270528866487, 893.5755516129786, 923.8774888510358, 941.5339406993445, 950.4249928792981, 952.5951470625096, 4864.246041863446, 4891.535304146171, 4907.901841963141, 4908.730019848871, 4964.429090654548, 5231.633785635046, 5232.424433312332, 5247.291615631917, 5253.185756207794, 5258.50044245796, 4707.74028466338, 4917.975410122926, 4949.307097006422, 4952.727599982036, 4966.950330496721, 2723.6731592208666, 2773.7503624673877, 2795.8602069896424, 2802.3326120958, 2802.9719702802713, 5375.865603359869, 5392.299001129828, 5400.405955344909, 5400.675959442446, 5499.697516636624, 5177.637565370388, 5307.911878064988, 5391.81128660495, 5399.595030372738, 5410.0, 5354.108781258077, 5358.946410535923, 5364.9731751341, 5374.677519348852, 5419.051665958442, 5189.6107791915, 5272.420033796203, 5281.577473802164, 5297.867553311198, 5330.200469929541, 4866.537678920497, 5092.898142037213, 5106.693598384109, 5110.233464980282, 5152.732797569058, 5334.413214546475, 5339.434783260256, 5409.486098820606, 5500.734830988815, 5501.817109321515, 3860.9227815442973, 4062.674986001172, 4064.1058967027207, 4155.231282212801, 4156.272652285777, 5817.7963771267805, 5888.558358123072, 5901.881962360643, 5907.91138132937, 5914.290285165807, 5680.4319568042865, 5785.656808992365, 5803.3616302207565, 5804.94195058044, 5829.854253643693, 5713.628614140068, 5719.399463056319, 5730.770769169353, 5742.59801813869, 5779.479846813807, 5663.66018038919, 5707.800226992035, 5723.7996670116345, 5741.712914354349, 5742.511886489695, 5480.72596370172, 5670.177824215383, 5677.971610141923, 5725.6850873202375, 5727.8568035799435, 5569.944300556943, 5572.60991730575, 5599.412061733459, 5624.606277560531, 5632.239647647515], "value": 4247.889685318082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.3059439424136, 772.8724760414532, 776.8290975985285, 817.1664901800164, 837.4891316297054, 14819.110853348806, 15363.155026473525, 15373.615659608515, 15439.922800385983, 15637.765433518493, 15573.143477108755, 15641.296141673623, 15714.135722535257, 15727.056376617382, 15731.134787586678, 640.3116649601674, 760.1106705154955, 780.3795982194155, 801.3308887079296, 802.1016461563029, 788.5071830106184, 792.0970094092739, 793.1592511937336, 795.5624406576388, 795.7930937956144, 841.8274253777992, 843.3379796859466, 847.3517758914436, 848.1433751910553, 848.3298194426395, 830.5930094253832, 832.4214670803793, 837.7905523619095, 840.8906842110548, 843.2158092973532, 616.8642898562309, 619.8946179149556, 620.0203678188451, 621.4748537485817, 625.2434554189437, 11920.88079119215, 12027.51889924402, 12093.45579448927, 12171.93914030433, 12204.145709800317, 15681.215939202993, 15891.205439728083, 16223.675526489404, 16318.347266109342, 16432.342706291733, 11605.535778568847, 11693.239939403911, 11994.16040877139, 12035.338056406894, 12406.379681016004, 3812.294725475796, 3844.2503711776217, 3888.4556162137324, 3989.5412027616903, 4027.617376349242, 86747.56626216891, 86777.56611216966, 86831.13168868357, 87380.0, 90291.54854225753, 11313.943430282796, 11346.432678366049, 11545.595904143314, 11629.709257268636, 11675.065994720402, 19913.800861991484, 20665.380038598865, 21174.941252937293, 21185.364439066852, 21223.15107395687, 8093.392995525359, 8216.671333146727, 8383.0, 8557.529335886462, 8580.914190858137, 4595.310703394451, 4647.790849411717, 4716.669833111718, 4733.763311834395, 4799.3760811094335, 3346.2972775716885, 3465.0, 3465.0471120441575, 3473.1838018065732, 3483.1292176955762, 585.2625691628579, 592.6266452135213, 593.1192179613271, 607.2803727582829, 608.5192697768713, 650.6811662285446, 694.6561452081152, 738.7894450081701, 748.5284270909401, 793.9523628582187, 8993.595288212045, 9392.342536022414, 9620.230381569458, 9712.805743885225, 10075.09324160829, 661.4820774112798, 733.1641928201855, 744.3821628048814, 761.4828147173878, 761.824780300534, 4648.1865673507, 4931.161702510582, 4957.0, 5029.547340739351, 5104.1067813133295, 128507.0, 128605.0, 130782.0, 132095.33952330178, 133302.3367429582, 62200.0, 62427.0, 64016.67991660012, 96902.51548742212, 113737.0, 75917.0, 77602.22397776177, 82424.0, 86709.5664521686, 87639.56180219186, 9744.75638109053, 9778.0, 9792.09054234446, 9860.211183105477, 9995.650152244636, 50974.235386469976, 51502.0, 51591.0, 52345.21482177694, 52434.73782631062, 71545.64227178831, 73818.63090684512, 75793.0, 79030.25818450912, 79110.6044469797, 13456.192628441933, 13520.661983450493, 13550.728985420039, 13625.523106691218, 13676.179429234278, 14737.410503580166, 14946.327415266556, 15022.699546009237, 15383.69232615319, 15437.536873893801, 13580.173126537578, 13958.79061814094, 14492.565223043326, 14671.486497972519, 15554.688906222038, 13402.530911418053, 13539.323033848072, 13953.860461395661, 14679.926600366929, 14707.41170353174, 12915.870841291468, 13122.081454298108, 13320.467181312639, 13472.797908031584, 13944.79082813779, 11442.60136523173, 11549.769004620028, 11692.70768230767, 11881.1089168311, 11919.642410727693, 11309.264897781617, 12143.210691305037, 12365.814512782135, 12430.192037517532, 12783.61649150527], "value": 7600.635484362931, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 112.0, 114.0, 113.0, 112.0, 112.0, 114.0, 130.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 145.0, 186.0, 124.0, 150.0, 152.0, 125.0, 176.0, 119.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 167.0, 170.0, 164.0, 163.0, 167.0, 163.0, 165.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 186.0, 76.0, 76.0, 76.0, 82.0, 173.0, 80.0], "value": 97.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 152.0, 87.0, 83.0, 83.0, 148.0, 82.0, 83.0, 141.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 119.0, 119.0, 119.0, 118.0, 118.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 154.0, 148.0, 147.0, 147.0, 147.0, 146.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 54.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 65.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 81.0, 83.0, 80.0, 80.0, 80.0, 87.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 126.0, 135.0, 141.0, 126.0, 140.0, 130.0, 176.0, 126.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 172.0, 165.0, 166.0, 164.0, 169.0, 165.0, 173.0, 167.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 66.0, 67.0, 66.0, 69.0, 70.0, 66.0, 64.0], "value": 67.0, "unit": "score"}]}]} 06:19:12 INFO - Return code: 0 06:19:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:19:12 ERROR - # TBPL SUCCESS # 06:19:12 INFO - Running post-action listener: _resource_record_post_action 06:19:12 INFO - [mozharness: 2016-09-01 13:19:12.121714Z] Finished run-tests step (success) 06:19:12 INFO - Running post-run listener: _resource_record_post_run 06:19:12 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407732224; Read time: 20; Write time: 538516 06:19:12 INFO - TinderboxPrint: CPU usage
13.5% 06:19:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:19:12 INFO - TinderboxPrint: I/O write bytes / time
407,732,224 / 538,516 06:19:12 INFO - TinderboxPrint: CPU idle
8,249.2 (86.5%) 06:19:12 INFO - TinderboxPrint: CPU user
1,223.5 (12.8%) 06:19:12 INFO - TinderboxPrint: Swap in / out
0 / 0 06:19:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118353920; Read time: 0; Write time: 208800 06:19:12 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289378304; Read time: 0; Write time: 329716 06:19:12 INFO - Running post-run listener: _upload_blobber_files 06:19:12 INFO - Blob upload gear active. 06:19:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:19:12 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:12 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:12 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:13 INFO - (blobuploader) - INFO - Open directory for files ... 06:19:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:19:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:19:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:16 INFO - (blobuploader) - INFO - Done attempting. 06:19:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:19:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:19:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:17 INFO - (blobuploader) - INFO - Done attempting. 06:19:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:19:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:19:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:19:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:19:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:19:18 INFO - (blobuploader) - INFO - Done attempting. 06:19:18 INFO - (blobuploader) - INFO - Iteration through files over. 06:19:18 INFO - Return code: 0 06:19:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:19:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:19:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8427eab42600ed6ba5d4fd20337e4185f99ed10f57cbcf455b2431a67df763e24b2b0fd9acd2709cabf4c9e3b32e909b0531a4db006a4341098354c64a6a72fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ca517b3554a17527fcd25c75b87b3d4cd9b666375c00ce3a5728563b787c0508f3c91c203b91220fc64dc61cd3606547a7f8e1a7900da74fef46175b4017a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee11b61870b9bd4db1b86ec6ae23459247e01d07a97689a9193de9eb053208125e901af8b41e69c89efb7a44c39793a9926c95447c7b1cb25856ce313df7ea6"} 06:19:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:19:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:19:18 INFO - Contents: 06:19:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8427eab42600ed6ba5d4fd20337e4185f99ed10f57cbcf455b2431a67df763e24b2b0fd9acd2709cabf4c9e3b32e909b0531a4db006a4341098354c64a6a72fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ca517b3554a17527fcd25c75b87b3d4cd9b666375c00ce3a5728563b787c0508f3c91c203b91220fc64dc61cd3606547a7f8e1a7900da74fef46175b4017a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee11b61870b9bd4db1b86ec6ae23459247e01d07a97689a9193de9eb053208125e901af8b41e69c89efb7a44c39793a9926c95447c7b1cb25856ce313df7ea6"} 06:19:18 INFO - Running post-run listener: copy_logs_to_upload_dir 06:19:18 INFO - Copying logs to upload dir... 06:19:18 INFO - mkdir: /builds/slave/test/build/upload/logs 06:19:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.816552 ========= 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:17.440291) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:17.443599) ========= 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=5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8427eab42600ed6ba5d4fd20337e4185f99ed10f57cbcf455b2431a67df763e24b2b0fd9acd2709cabf4c9e3b32e909b0531a4db006a4341098354c64a6a72fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ca517b3554a17527fcd25c75b87b3d4cd9b666375c00ce3a5728563b787c0508f3c91c203b91220fc64dc61cd3606547a7f8e1a7900da74fef46175b4017a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee11b61870b9bd4db1b86ec6ae23459247e01d07a97689a9193de9eb053208125e901af8b41e69c89efb7a44c39793a9926c95447c7b1cb25856ce313df7ea6"} 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.011433 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8427eab42600ed6ba5d4fd20337e4185f99ed10f57cbcf455b2431a67df763e24b2b0fd9acd2709cabf4c9e3b32e909b0531a4db006a4341098354c64a6a72fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac5ca517b3554a17527fcd25c75b87b3d4cd9b666375c00ce3a5728563b787c0508f3c91c203b91220fc64dc61cd3606547a7f8e1a7900da74fef46175b4017a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ee11b61870b9bd4db1b86ec6ae23459247e01d07a97689a9193de9eb053208125e901af8b41e69c89efb7a44c39793a9926c95447c7b1cb25856ce313df7ea6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:17.469178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:17.469502) ========= 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=5bd038846534b2fdfa68eeae000001e2-1472734460.335800-1566730490 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 06:19:17.554975) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:19:17.555439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 06:19:17.555895) ========= ========= Total master_lag: 0.20 =========