builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1472519728.07 results: success (0) buildid: 20160829173530 builduid: e719c450bbf348dcb54fbfc2249261ef revision: 7293879d87d780790cb0f67e98226b7d4de6d4e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.073977) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.074783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.075125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.112026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.112359) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 18:15:28-- 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% 224M=0s 2016-08-29 18:15:28 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129159 ========= master_lag: 0.36 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.598833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.599171) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017608 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.639721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:28.640089) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7293879d87d780790cb0f67e98226b7d4de6d4e1 --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 7293879d87d780790cb0f67e98226b7d4de6d4e1 --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=97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 18:15:28,931 truncating revision to first 12 chars 2016-08-29 18:15:28,932 Setting DEBUG logging. 2016-08-29 18:15:28,932 attempt 1/10 2016-08-29 18:15:28,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7293879d87d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 18:15:29,195 unpacking tar archive at: mozilla-central-7293879d87d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.566799 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:29.221762) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:29.222095) ========= script_repo_revision: 7293879d87d780790cb0f67e98226b7d4de6d4e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:29.222527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:29.222857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 18:15:29.234003) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-29 18:15:29.234313) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:15:29 INFO - MultiFileLogger online at 20160829 18:15:29 in /builds/slave/test 18:15:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:15:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:15:29 INFO - {'append_to_log': False, 18:15:29 INFO - 'base_work_dir': '/builds/slave/test', 18:15:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:15:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:15:29 INFO - 'branch': 'Firefox-Non-PGO', 18:15:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:15:29 INFO - 'config_files': ('talos/linux_config.py',), 18:15:29 INFO - 'default_actions': ('clobber', 18:15:29 INFO - 'read-buildbot-config', 18:15:29 INFO - 'download-and-extract', 18:15:29 INFO - 'populate-webroot', 18:15:29 INFO - 'create-virtualenv', 18:15:29 INFO - 'install', 18:15:29 INFO - 'run-tests'), 18:15:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:15:29 INFO - 'download_minidump_stackwalk': True, 18:15:29 INFO - 'download_symbols': 'ondemand', 18:15:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:15:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:15:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:15:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:15:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:15:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:15:29 INFO - 'installer_path': 'installer.exe', 18:15:29 INFO - 'log_level': 'info', 18:15:29 INFO - 'log_name': 'talos', 18:15:29 INFO - 'log_to_console': True, 18:15:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:15:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:15:29 INFO - 'opt_config_files': (), 18:15:29 INFO - 'pip_index': False, 18:15:29 INFO - 'sps_profile': False, 18:15:29 INFO - 'sps_profile_interval': 0, 18:15:29 INFO - 'suite': 'dromaeojs-e10s', 18:15:29 INFO - 'system_bits': '32', 18:15:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:15:29 INFO - 'title': 'talos-linux64-ix-068', 18:15:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:15:29 INFO - 'use_talos_json': True, 18:15:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:15:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:15:29 INFO - 'work_dir': 'build'} 18:15:29 INFO - [mozharness: 2016-08-30 01:15:29.619587Z] Running clobber step. 18:15:29 INFO - Running pre-action listener: _resource_record_pre_action 18:15:29 INFO - Running main action method: clobber 18:15:29 INFO - rmtree: /builds/slave/test/build 18:15:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:15:30 INFO - Running post-action listener: _resource_record_post_action 18:15:30 INFO - [mozharness: 2016-08-30 01:15:30.072631Z] Finished clobber step (success) 18:15:30 INFO - [mozharness: 2016-08-30 01:15:30.072736Z] Running read-buildbot-config step. 18:15:30 INFO - Running pre-action listener: _resource_record_pre_action 18:15:30 INFO - Running main action method: read_buildbot_config 18:15:30 INFO - Using buildbot properties: 18:15:30 INFO - { 18:15:30 INFO - "project": "", 18:15:30 INFO - "product": "firefox", 18:15:30 INFO - "script_repo_revision": "production", 18:15:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:15:30 INFO - "repository": "", 18:15:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:15:30 INFO - "buildid": "20160829173530", 18:15:30 INFO - "pgo_build": "False", 18:15:30 INFO - "basedir": "/builds/slave/test", 18:15:30 INFO - "buildnumber": 448, 18:15:30 INFO - "slavename": "talos-linux64-ix-068", 18:15:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:15:30 INFO - "platform": "ubuntu64_hw", 18:15:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:15:30 INFO - "branch": "mozilla-central", 18:15:30 INFO - "repo_path": "mozilla-central", 18:15:30 INFO - "revision": "7293879d87d780790cb0f67e98226b7d4de6d4e1", 18:15:30 INFO - "stage_platform": "linux64", 18:15:30 INFO - "builduid": "e719c450bbf348dcb54fbfc2249261ef", 18:15:30 INFO - "slavebuilddir": "test" 18:15:30 INFO - } 18:15:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:15:30 INFO - Running post-action listener: _resource_record_post_action 18:15:30 INFO - [mozharness: 2016-08-30 01:15:30.075239Z] Finished read-buildbot-config step (success) 18:15:30 INFO - [mozharness: 2016-08-30 01:15:30.075330Z] Running download-and-extract step. 18:15:30 INFO - Running pre-action listener: _resource_record_pre_action 18:15:30 INFO - Running main action method: download_and_extract 18:15:30 INFO - mkdir: /builds/slave/test/build/tests 18:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:30 INFO - trying https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:15:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:30 INFO - Downloaded 1361 bytes. 18:15:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:15:30 INFO - Using the following test package requirements: 18:15:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:15:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:15:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:15:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'jsshell-linux-x86_64.zip'], 18:15:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:15:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:15:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:15:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:15:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:15:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:15:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:15:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:30 INFO - trying https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:15:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:36 INFO - Downloaded 20307782 bytes. 18:15:36 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 18:15:40 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 18:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:40 INFO - trying https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:15:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:41 INFO - Downloaded 20307782 bytes. 18:15:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 18:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:46 INFO - trying https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:15:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:46 INFO - Downloaded 14413998 bytes. 18:15:46 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 18:15:47 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')]} 18:15:47 INFO - trying https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:15:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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 18:15:48 INFO - Downloaded 55868703 bytes. 18:15:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:15:48 INFO - mkdir: /builds/slave/test/properties 18:15:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:15:48 INFO - Writing to file /builds/slave/test/properties/build_url 18:15:48 INFO - Contents: 18:15:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:15:49 INFO - Running post-action listener: _resource_record_post_action 18:15:49 INFO - Running post-action listener: set_extra_try_arguments 18:15:49 INFO - [mozharness: 2016-08-30 01:15:49.071095Z] Finished download-and-extract step (success) 18:15:49 INFO - [mozharness: 2016-08-30 01:15:49.071325Z] Running populate-webroot step. 18:15:49 INFO - Running pre-action listener: _resource_record_pre_action 18:15:49 INFO - Running main action method: populate_webroot 18:15:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:15:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:15:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:15:49 INFO - '--tppagecycles', 18:15:49 INFO - '7'], 18:15:49 INFO - 'tests': ['tsvgm']}}, 18:15:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:15:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:15:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:15:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:15:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:15:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['damp', 'tps']}, 18:15:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'tests': ['damp', 'tps']}, 18:15:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['dromaeo_dom']}, 18:15:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:15:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['basic_compositor_video']}, 18:15:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:15:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['a11yr', 18:15:49 INFO - 'ts_paint', 18:15:49 INFO - 'tpaint', 18:15:49 INFO - 'sessionrestore', 18:15:49 INFO - 'sessionrestore_no_auto_restore', 18:15:49 INFO - 'tabpaint']}, 18:15:49 INFO - 'other-e10s': {'tests': ['a11yr', 18:15:49 INFO - 'ts_paint', 18:15:49 INFO - 'tpaint', 18:15:49 INFO - 'sessionrestore', 18:15:49 INFO - 'sessionrestore_no_auto_restore', 18:15:49 INFO - 'tabpaint']}, 18:15:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:15:49 INFO - 'ts_paint', 18:15:49 INFO - 'tpaint', 18:15:49 INFO - 'sessionrestore', 18:15:49 INFO - 'sessionrestore_no_auto_restore', 18:15:49 INFO - 'tabpaint']}, 18:15:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:15:49 INFO - 'ts_paint', 18:15:49 INFO - 'tpaint', 18:15:49 INFO - 'sessionrestore', 18:15:49 INFO - 'sessionrestore_no_auto_restore', 18:15:49 INFO - 'tabpaint']}, 18:15:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['a11yr', 18:15:49 INFO - 'ts_paint', 18:15:49 INFO - 'tpaint', 18:15:49 INFO - 'sessionrestore', 18:15:49 INFO - 'sessionrestore_no_auto_restore', 18:15:49 INFO - 'tabpaint']}, 18:15:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['a11yr', 18:15:49 INFO - 'ts_paint', 18:15:49 INFO - 'tpaint', 18:15:49 INFO - 'sessionrestore', 18:15:49 INFO - 'sessionrestore_no_auto_restore', 18:15:49 INFO - 'tabpaint']}, 18:15:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['tsvgx', 18:15:49 INFO - 'tsvgr_opacity', 18:15:49 INFO - 'tart', 18:15:49 INFO - 'tscrollx', 18:15:49 INFO - 'cart']}, 18:15:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:15:49 INFO - 'tsvgr_opacity', 18:15:49 INFO - 'tart', 18:15:49 INFO - 'tscrollx', 18:15:49 INFO - 'cart']}, 18:15:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'talos_options': ['--disable-e10s'], 18:15:49 INFO - 'tests': ['tp5o']}, 18:15:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'tests': ['tp5o']}, 18:15:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'talos_options': ['--disable-e10s', 18:15:49 INFO - '--xperf_path', 18:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:49 INFO - 'tests': ['tp5n']}, 18:15:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:15:49 INFO - 'talos_options': ['--xperf_path', 18:15:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:15:49 INFO - 'tests': ['tp5n']}}, 18:15:49 INFO - 'talos.zip': {'path': '', 18:15:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:15:49 INFO - Running post-action listener: _resource_record_post_action 18:15:49 INFO - [mozharness: 2016-08-30 01:15:49.091605Z] Finished populate-webroot step (success) 18:15:49 INFO - [mozharness: 2016-08-30 01:15:49.091695Z] Running create-virtualenv step. 18:15:49 INFO - Running pre-action listener: _resource_record_pre_action 18:15:49 INFO - Running main action method: create_virtualenv 18:15:49 INFO - Creating virtualenv /builds/slave/test/build/venv 18:15:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:15:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:15:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:15:49 INFO - Using real prefix '/usr' 18:15:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:15:49 INFO - Installing distribute.............................................................................................................................................................................................done. 18:15:51 INFO - Installing pip.................done. 18:15:51 INFO - Return code: 0 18:15:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:15:51 INFO - Using env: {'DISPLAY': ':0', 18:15:51 INFO - 'HOME': '/home/cltbld', 18:15:51 INFO - 'LANG': 'en_US.UTF-8', 18:15:51 INFO - 'LANGUAGE': 'en_US:en', 18:15:51 INFO - 'LOGNAME': 'cltbld', 18:15:51 INFO - 'MAIL': '/var/mail/cltbld', 18:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:51 INFO - 'MOZ_NO_REMOTE': '1', 18:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:51 INFO - 'NO_EM_RESTART': '1', 18:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:51 INFO - 'PWD': '/builds/slave/test', 18:15:51 INFO - 'SHELL': '/bin/bash', 18:15:51 INFO - 'SHLVL': '1', 18:15:51 INFO - 'TERM': 'linux', 18:15:51 INFO - 'TMOUT': '86400', 18:15:51 INFO - 'USER': 'cltbld', 18:15:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:51 INFO - '_': '/tools/buildbot/bin/python'} 18:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:15:51 INFO - Cleaning up... 18:15:51 INFO - Return code: 0 18:15:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:15:51 INFO - Using env: {'DISPLAY': ':0', 18:15:51 INFO - 'HOME': '/home/cltbld', 18:15:51 INFO - 'LANG': 'en_US.UTF-8', 18:15:51 INFO - 'LANGUAGE': 'en_US:en', 18:15:51 INFO - 'LOGNAME': 'cltbld', 18:15:51 INFO - 'MAIL': '/var/mail/cltbld', 18:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:51 INFO - 'MOZ_NO_REMOTE': '1', 18:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:51 INFO - 'NO_EM_RESTART': '1', 18:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:51 INFO - 'PWD': '/builds/slave/test', 18:15:51 INFO - 'SHELL': '/bin/bash', 18:15:51 INFO - 'SHLVL': '1', 18:15:51 INFO - 'TERM': 'linux', 18:15:51 INFO - 'TMOUT': '86400', 18:15:51 INFO - 'USER': 'cltbld', 18:15:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:51 INFO - '_': '/tools/buildbot/bin/python'} 18:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:52 INFO - Downloading/unpacking psutil>=3.1.1 18:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:15:54 INFO - Installing collected packages: psutil 18:15:54 INFO - Running setup.py install for psutil 18:15:54 INFO - building 'psutil._psutil_linux' extension 18:15:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:15:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:15:54 INFO - building 'psutil._psutil_posix' extension 18:15:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:15:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:15:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:15:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:15:54 INFO - Successfully installed psutil 18:15:54 INFO - Cleaning up... 18:15:54 INFO - Return code: 0 18:15:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:15:54 INFO - Using env: {'DISPLAY': ':0', 18:15:54 INFO - 'HOME': '/home/cltbld', 18:15:54 INFO - 'LANG': 'en_US.UTF-8', 18:15:54 INFO - 'LANGUAGE': 'en_US:en', 18:15:54 INFO - 'LOGNAME': 'cltbld', 18:15:54 INFO - 'MAIL': '/var/mail/cltbld', 18:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:54 INFO - 'MOZ_NO_REMOTE': '1', 18:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:54 INFO - 'NO_EM_RESTART': '1', 18:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:54 INFO - 'PWD': '/builds/slave/test', 18:15:54 INFO - 'SHELL': '/bin/bash', 18:15:54 INFO - 'SHLVL': '1', 18:15:54 INFO - 'TERM': 'linux', 18:15:54 INFO - 'TMOUT': '86400', 18:15:54 INFO - 'USER': 'cltbld', 18:15:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:54 INFO - '_': '/tools/buildbot/bin/python'} 18:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:15:56 INFO - Installing collected packages: mozsystemmonitor 18:15:56 INFO - Running setup.py install for mozsystemmonitor 18:15:56 INFO - Successfully installed mozsystemmonitor 18:15:56 INFO - Cleaning up... 18:15:56 INFO - Return code: 0 18:15:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:15: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')]} 18:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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')]} 18:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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', '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 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:15: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 jsonschema==2.5.1 18:15:56 INFO - Using env: {'DISPLAY': ':0', 18:15:56 INFO - 'HOME': '/home/cltbld', 18:15:56 INFO - 'LANG': 'en_US.UTF-8', 18:15:56 INFO - 'LANGUAGE': 'en_US:en', 18:15:56 INFO - 'LOGNAME': 'cltbld', 18:15:56 INFO - 'MAIL': '/var/mail/cltbld', 18:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:56 INFO - 'MOZ_NO_REMOTE': '1', 18:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:56 INFO - 'NO_EM_RESTART': '1', 18:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:56 INFO - 'PWD': '/builds/slave/test', 18:15:56 INFO - 'SHELL': '/bin/bash', 18:15:56 INFO - 'SHLVL': '1', 18:15:56 INFO - 'TERM': 'linux', 18:15:56 INFO - 'TMOUT': '86400', 18:15:56 INFO - 'USER': 'cltbld', 18:15:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:56 INFO - '_': '/tools/buildbot/bin/python'} 18:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:57 INFO - Downloading/unpacking jsonschema==2.5.1 18:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:15:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:15:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:15:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15:59 INFO - Downloading functools32-3.2.3-2.tar.gz 18:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:15:59 INFO - warning: no files found matching '*.txt' 18:15:59 INFO - no previously-included directories found matching 'build' 18:15:59 INFO - no previously-included directories found matching 'dist' 18:15:59 INFO - no previously-included directories found matching '.git*' 18:15:59 INFO - Installing collected packages: jsonschema, functools32 18:15:59 INFO - Running setup.py install for functools32 18:15:59 INFO - warning: no files found matching '*.txt' 18:15:59 INFO - no previously-included directories found matching 'build' 18:15:59 INFO - no previously-included directories found matching 'dist' 18:15:59 INFO - no previously-included directories found matching '.git*' 18:15:59 INFO - Successfully installed jsonschema functools32 18:15:59 INFO - Cleaning up... 18:15:59 INFO - Return code: 0 18:15:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:15: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')]} 18:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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')]} 18:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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', '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 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:15: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 functools32==3.2.3-2 18:15:59 INFO - Using env: {'DISPLAY': ':0', 18:15:59 INFO - 'HOME': '/home/cltbld', 18:15:59 INFO - 'LANG': 'en_US.UTF-8', 18:15:59 INFO - 'LANGUAGE': 'en_US:en', 18:15:59 INFO - 'LOGNAME': 'cltbld', 18:15:59 INFO - 'MAIL': '/var/mail/cltbld', 18:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:59 INFO - 'MOZ_NO_REMOTE': '1', 18:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:59 INFO - 'NO_EM_RESTART': '1', 18:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:59 INFO - 'PWD': '/builds/slave/test', 18:15:59 INFO - 'SHELL': '/bin/bash', 18:15:59 INFO - 'SHLVL': '1', 18:15:59 INFO - 'TERM': 'linux', 18:15:59 INFO - 'TMOUT': '86400', 18:15:59 INFO - 'USER': 'cltbld', 18:15:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:59 INFO - '_': '/tools/buildbot/bin/python'} 18:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:15:59 INFO - Cleaning up... 18:15:59 INFO - Return code: 0 18:15:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:15: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')]} 18:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15: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')]} 18:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:15:59 INFO - Using env: {'DISPLAY': ':0', 18:15:59 INFO - 'HOME': '/home/cltbld', 18:15:59 INFO - 'LANG': 'en_US.UTF-8', 18:15:59 INFO - 'LANGUAGE': 'en_US:en', 18:15:59 INFO - 'LOGNAME': 'cltbld', 18:15:59 INFO - 'MAIL': '/var/mail/cltbld', 18:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:15:59 INFO - 'MOZ_NO_REMOTE': '1', 18:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:15:59 INFO - 'NO_EM_RESTART': '1', 18:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:15:59 INFO - 'PWD': '/builds/slave/test', 18:15:59 INFO - 'SHELL': '/bin/bash', 18:15:59 INFO - 'SHLVL': '1', 18:15:59 INFO - 'TERM': 'linux', 18:15:59 INFO - 'TMOUT': '86400', 18:15:59 INFO - 'USER': 'cltbld', 18:15:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:15:59 INFO - '_': '/tools/buildbot/bin/python'} 18:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:15:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:15: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 18:16:01 INFO - Downloading blobuploader-1.2.4.tar.gz 18:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:16:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16: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 18:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:16:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:02 INFO - Downloading docopt-0.6.1.tar.gz 18:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:16:02 INFO - Installing collected packages: blobuploader, requests, docopt 18:16:02 INFO - Running setup.py install for blobuploader 18:16:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:16:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:16:02 INFO - Running setup.py install for requests 18:16:03 INFO - Running setup.py install for docopt 18:16:03 INFO - Successfully installed blobuploader requests docopt 18:16:03 INFO - Cleaning up... 18:16:03 INFO - Return code: 0 18:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:03 INFO - Using env: {'DISPLAY': ':0', 18:16:03 INFO - 'HOME': '/home/cltbld', 18:16:03 INFO - 'LANG': 'en_US.UTF-8', 18:16:03 INFO - 'LANGUAGE': 'en_US:en', 18:16:03 INFO - 'LOGNAME': 'cltbld', 18:16:03 INFO - 'MAIL': '/var/mail/cltbld', 18:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:03 INFO - 'MOZ_NO_REMOTE': '1', 18:16:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:03 INFO - 'NO_EM_RESTART': '1', 18:16:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:03 INFO - 'PWD': '/builds/slave/test', 18:16:03 INFO - 'SHELL': '/bin/bash', 18:16:03 INFO - 'SHLVL': '1', 18:16:03 INFO - 'TERM': 'linux', 18:16:03 INFO - 'TMOUT': '86400', 18:16:03 INFO - 'USER': 'cltbld', 18:16:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:03 INFO - '_': '/tools/buildbot/bin/python'} 18:16:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:03 INFO - Running setup.py (path:/tmp/pip-0kiEXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:03 INFO - Running setup.py (path:/tmp/pip-nur7mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:03 INFO - Running setup.py (path:/tmp/pip-vDkFag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:03 INFO - Running setup.py (path:/tmp/pip-IXDjCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:03 INFO - Running setup.py (path:/tmp/pip-YOJotN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:03 INFO - Running setup.py (path:/tmp/pip-8ZBGUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:03 INFO - Running setup.py (path:/tmp/pip-2vJWU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:03 INFO - Running setup.py (path:/tmp/pip-KidUn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:04 INFO - Running setup.py (path:/tmp/pip-WPSHIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:04 INFO - Running setup.py (path:/tmp/pip-wPNYiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:04 INFO - Running setup.py (path:/tmp/pip-YsK0jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:04 INFO - Running setup.py (path:/tmp/pip-tQRWHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:04 INFO - Running setup.py (path:/tmp/pip-BWgrRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:04 INFO - Running setup.py (path:/tmp/pip-apGfp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:04 INFO - Running setup.py (path:/tmp/pip-_suwke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:04 INFO - Running setup.py (path:/tmp/pip-4aUG_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:04 INFO - Running setup.py (path:/tmp/pip-jzDvZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:16:04 INFO - Running setup.py install for manifestparser 18:16:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:16:04 INFO - Running setup.py install for mozcrash 18:16:04 INFO - Running setup.py install for mozdebug 18:16:04 INFO - Running setup.py install for mozdevice 18:16:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Running setup.py install for mozfile 18:16:05 INFO - Running setup.py install for mozhttpd 18:16:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Running setup.py install for mozinfo 18:16:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Running setup.py install for mozInstall 18:16:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Running setup.py install for mozleak 18:16:05 INFO - Running setup.py install for mozlog 18:16:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Running setup.py install for moznetwork 18:16:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:16:05 INFO - Running setup.py install for mozprocess 18:16:05 INFO - Running setup.py install for mozprofile 18:16:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:16:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:16:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:16:06 INFO - Running setup.py install for mozrunner 18:16:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:16:06 INFO - Running setup.py install for mozscreenshot 18:16:06 INFO - Running setup.py install for moztest 18:16:06 INFO - Running setup.py install for mozversion 18:16:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:16:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:16:06 INFO - Cleaning up... 18:16:06 INFO - Return code: 0 18:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:06 INFO - Using env: {'DISPLAY': ':0', 18:16:06 INFO - 'HOME': '/home/cltbld', 18:16:06 INFO - 'LANG': 'en_US.UTF-8', 18:16:06 INFO - 'LANGUAGE': 'en_US:en', 18:16:06 INFO - 'LOGNAME': 'cltbld', 18:16:06 INFO - 'MAIL': '/var/mail/cltbld', 18:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:06 INFO - 'MOZ_NO_REMOTE': '1', 18:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:06 INFO - 'NO_EM_RESTART': '1', 18:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:06 INFO - 'PWD': '/builds/slave/test', 18:16:06 INFO - 'SHELL': '/bin/bash', 18:16:06 INFO - 'SHLVL': '1', 18:16:06 INFO - 'TERM': 'linux', 18:16:06 INFO - 'TMOUT': '86400', 18:16:06 INFO - 'USER': 'cltbld', 18:16:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:06 INFO - '_': '/tools/buildbot/bin/python'} 18:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:16:06 INFO - Running setup.py (path:/tmp/pip-7XbOLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:16:06 INFO - Running setup.py (path:/tmp/pip-uiTmLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:16:06 INFO - Running setup.py (path:/tmp/pip-GAKclD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:16:06 INFO - Running setup.py (path:/tmp/pip-O08f32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:16:06 INFO - Running setup.py (path:/tmp/pip-XC62Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:16:07 INFO - Running setup.py (path:/tmp/pip-btaYrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:16:07 INFO - Running setup.py (path:/tmp/pip-A_V3bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:16:07 INFO - Running setup.py (path:/tmp/pip-xZyxhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:16:07 INFO - Running setup.py (path:/tmp/pip-Um8Dr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:16:07 INFO - Running setup.py (path:/tmp/pip-z9XGLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:16:07 INFO - Running setup.py (path:/tmp/pip-hm0lKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:16:07 INFO - Running setup.py (path:/tmp/pip-OibsRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:16:07 INFO - Running setup.py (path:/tmp/pip-r6YX_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:16:07 INFO - Running setup.py (path:/tmp/pip-_hX1e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:07 INFO - Running setup.py (path:/tmp/pip-l2BnbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:16:07 INFO - Running setup.py (path:/tmp/pip-lr2CYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:16:07 INFO - Running setup.py (path:/tmp/pip-doV_tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:16:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:16:09 INFO - Downloading blessings-1.6.tar.gz 18:16:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:16:09 INFO - Installing collected packages: blessings 18:16:09 INFO - Running setup.py install for blessings 18:16:10 INFO - Successfully installed blessings 18:16:10 INFO - Cleaning up... 18:16:10 INFO - Return code: 0 18:16:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:10 INFO - Reading from file tmpfile_stdout 18:16:10 INFO - Current package versions: 18:16:10 INFO - argparse == 1.2.1 18:16:10 INFO - blessings == 1.6 18:16:10 INFO - blobuploader == 1.2.4 18:16:10 INFO - docopt == 0.6.1 18:16:10 INFO - functools32 == 3.2.3-2 18:16:10 INFO - jsonschema == 2.5.1 18:16:10 INFO - manifestparser == 1.1 18:16:10 INFO - mozInstall == 1.12 18:16:10 INFO - mozcrash == 0.17 18:16:10 INFO - mozdebug == 0.1 18:16:10 INFO - mozdevice == 0.48 18:16:10 INFO - mozfile == 1.2 18:16:10 INFO - mozhttpd == 0.7 18:16:10 INFO - mozinfo == 0.9 18:16:10 INFO - mozleak == 0.1 18:16:10 INFO - mozlog == 3.3 18:16:10 INFO - moznetwork == 0.27 18:16:10 INFO - mozprocess == 0.23 18:16:10 INFO - mozprofile == 0.28 18:16:10 INFO - mozrunner == 6.12 18:16:10 INFO - mozscreenshot == 0.1 18:16:10 INFO - mozsystemmonitor == 0.3 18:16:10 INFO - moztest == 0.7 18:16:10 INFO - mozversion == 1.4 18:16:10 INFO - psutil == 3.1.1 18:16:10 INFO - requests == 1.2.3 18:16:10 INFO - wsgiref == 0.1.2 18:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:16:10 INFO - Using env: {'DISPLAY': ':0', 18:16:10 INFO - 'HOME': '/home/cltbld', 18:16:10 INFO - 'LANG': 'en_US.UTF-8', 18:16:10 INFO - 'LANGUAGE': 'en_US:en', 18:16:10 INFO - 'LOGNAME': 'cltbld', 18:16:10 INFO - 'MAIL': '/var/mail/cltbld', 18:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:10 INFO - 'MOZ_NO_REMOTE': '1', 18:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:10 INFO - 'NO_EM_RESTART': '1', 18:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:10 INFO - 'PWD': '/builds/slave/test', 18:16:10 INFO - 'SHELL': '/bin/bash', 18:16:10 INFO - 'SHLVL': '1', 18:16:10 INFO - 'TERM': 'linux', 18:16:10 INFO - 'TMOUT': '86400', 18:16:10 INFO - 'USER': 'cltbld', 18:16:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:10 INFO - '_': '/tools/buildbot/bin/python'} 18:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:16:10 INFO - Cleaning up... 18:16:10 INFO - Return code: 0 18:16:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:16:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:16:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:16:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f356a651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18e8230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:16:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:16:10 INFO - Using env: {'DISPLAY': ':0', 18:16:10 INFO - 'HOME': '/home/cltbld', 18:16:10 INFO - 'LANG': 'en_US.UTF-8', 18:16:10 INFO - 'LANGUAGE': 'en_US:en', 18:16:10 INFO - 'LOGNAME': 'cltbld', 18:16:10 INFO - 'MAIL': '/var/mail/cltbld', 18:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:10 INFO - 'MOZ_NO_REMOTE': '1', 18:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:10 INFO - 'NO_EM_RESTART': '1', 18:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:10 INFO - 'PWD': '/builds/slave/test', 18:16:10 INFO - 'SHELL': '/bin/bash', 18:16:10 INFO - 'SHLVL': '1', 18:16:10 INFO - 'TERM': 'linux', 18:16:10 INFO - 'TMOUT': '86400', 18:16:10 INFO - 'USER': 'cltbld', 18:16:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:10 INFO - '_': '/tools/buildbot/bin/python'} 18:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:16:10 INFO - Cleaning up... 18:16:10 INFO - Return code: 0 18:16:10 INFO - Running post-action listener: _resource_record_post_action 18:16:10 INFO - Running post-action listener: _start_resource_monitoring 18:16:10 INFO - Starting resource monitoring. 18:16:10 INFO - [mozharness: 2016-08-30 01:16:10.782695Z] Finished create-virtualenv step (success) 18:16:10 INFO - [mozharness: 2016-08-30 01:16:10.783211Z] Running install step. 18:16:10 INFO - Running pre-action listener: _resource_record_pre_action 18:16:10 INFO - Running main action method: install 18:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:16:10 INFO - Reading from file tmpfile_stdout 18:16:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:16:11 INFO - Reading from file tmpfile_stdout 18:16:11 INFO - Output received: 18:16:11 INFO - Usage: mozinstall [options] installer 18:16:11 INFO - Options: 18:16:11 INFO - -h, --help show this help message and exit 18:16:11 INFO - -d DEST, --destination=DEST 18:16:11 INFO - Directory to install application into. [default: 18:16:11 INFO - "/builds/slave/test"] 18:16:11 INFO - --app=APP Application being installed. [default: firefox] 18:16:11 INFO - mkdir: /builds/slave/test/build/application 18:16:11 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'] 18:16:11 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 18:16:27 INFO - Reading from file tmpfile_stdout 18:16:27 INFO - Output received: 18:16:27 INFO - /builds/slave/test/build/application/firefox/firefox 18:16:27 INFO - Running post-action listener: _resource_record_post_action 18:16:27 INFO - [mozharness: 2016-08-30 01:16:27.232402Z] Finished install step (success) 18:16:27 INFO - [mozharness: 2016-08-30 01:16:27.232686Z] Running run-tests step. 18:16:27 INFO - Running pre-action listener: _resource_record_pre_action 18:16:27 INFO - Running main action method: run_tests 18:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:16:27 INFO - Python 2.7.3 18:16:27 INFO - Return code: 0 18:16:27 INFO - grabbing minidump binary from tooltool 18:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:27 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 0x18e2090>, '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 0x18e59b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18e5e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:16:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:16:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:16:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:16:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:16:27 INFO - Return code: 0 18:16:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:16:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:16:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:16:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:16:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:16:27 INFO - Using env: {'DISPLAY': ':0', 18:16:27 INFO - 'HOME': '/home/cltbld', 18:16:27 INFO - 'LANG': 'en_US.UTF-8', 18:16:27 INFO - 'LANGUAGE': 'en_US:en', 18:16:27 INFO - 'LOGNAME': 'cltbld', 18:16:27 INFO - 'MAIL': '/var/mail/cltbld', 18:16:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:16:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:16:27 INFO - 'MOZ_NO_REMOTE': '1', 18:16:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:16:27 INFO - 'NO_EM_RESTART': '1', 18:16:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:16:27 INFO - 'PWD': '/builds/slave/test', 18:16:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:16:27 INFO - 'SHELL': '/bin/bash', 18:16:27 INFO - 'SHLVL': '1', 18:16:27 INFO - 'TERM': 'linux', 18:16:27 INFO - 'TMOUT': '86400', 18:16:27 INFO - 'USER': 'cltbld', 18:16:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929', 18:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:16:27 INFO - '_': '/tools/buildbot/bin/python'} 18:16:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:16:27 INFO - mozversion application_buildid: 20160829173530 18:16:27 INFO - mozversion application_changeset: 7293879d87d780790cb0f67e98226b7d4de6d4e1 18:16:27 INFO - mozversion application_display_name: Nightly 18:16:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:16:27 INFO - mozversion application_name: Firefox 18:16:27 INFO - mozversion application_remotingname: firefox 18:16:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:16:27 INFO - mozversion application_vendor: Mozilla 18:16:27 INFO - mozversion application_version: 51.0a1 18:16:27 INFO - mozversion platform_buildid: 20160829173530 18:16:27 INFO - mozversion platform_changeset: 7293879d87d780790cb0f67e98226b7d4de6d4e1 18:16:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:16:27 INFO - mozversion platform_version: 51.0a1 18:16:27 INFO - using testdate: 1472519787 18:16:27 INFO - actual date: 1472519787 18:16:27 INFO - starting webserver on 'localhost:41523' 18:16:27 INFO - SUITE-START | Running 2 tests 18:16:27 INFO - TEST-START | dromaeo_css 18:16:27 INFO - operating with platform_type : linux_ 18:16:27 INFO - Initialising browser for dromaeo_css test... 18:16:27 INFO - TEST-INFO | started process 22873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqPQqlp/profile http://localhost:41523/getInfo.html) 18:16:32 INFO - PROCESS | 22873 | __metrics Screen width/height:1600/1200 18:16:32 INFO - PROCESS | 22873 | colorDepth:24 18:16:32 INFO - PROCESS | 22873 | Browser inner width/height: 1024/697 18:16:32 INFO - PROCESS | 22873 | __metrics 18:16:33 ERROR - PROCESS | 22873 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 18:16:34 INFO - TEST-INFO | 22873: exit 0 18:16:34 INFO - Browser initialized. 18:16:34 INFO - Running cycle 1/1 for dromaeo_css test... 18:16:34 INFO - TEST-INFO | started process 22991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqPQqlp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:16:46 INFO - PROCESS | 22991 | RSS: Main: 192503808 18:16:46 INFO - PROCESS | 22991 | 18:17:36 INFO - PROCESS | 22991 | 1472519856378 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:19:49 INFO - PROCESS | 22991 | Cycle 1(1): loaded http://localhost:41523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41523/tests/dromaeo/cssquery-ext.html) 18:19:50 INFO - PROCESS | 22991 | RSS: Main: 212488192 18:19:50 INFO - PROCESS | 22991 | 18:22:52 INFO - PROCESS | 22991 | Cycle 1(1): loaded http://localhost:41523/tests/dromaeo/cssquery-ext.html (next: http://localhost:41523/tests/dromaeo/cssquery-jquery.html) 18:22:53 INFO - PROCESS | 22991 | RSS: Main: 205393920 18:22:53 INFO - PROCESS | 22991 | 18:25:55 INFO - PROCESS | 22991 | Cycle 1(1): loaded http://localhost:41523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41523/tests/dromaeo/cssquery-mootools.html) 18:25:56 INFO - PROCESS | 22991 | RSS: Main: 201113600 18:25:56 INFO - PROCESS | 22991 | 18:28:58 INFO - PROCESS | 22991 | Cycle 1(1): loaded http://localhost:41523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41523/tests/dromaeo/cssquery-prototype.html) 18:28:58 INFO - PROCESS | 22991 | RSS: Main: 194547712 18:28:58 INFO - PROCESS | 22991 | 18:32:01 INFO - PROCESS | 22991 | Cycle 1(1): loaded http://localhost:41523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41523/tests/dromaeo/cssquery-yui.html) 18:32:02 INFO - PROCESS | 22991 | RSS: Main: 197742592 18:32:02 INFO - PROCESS | 22991 | 18:35:04 INFO - PROCESS | 22991 | Cycle 1(1): loaded http://localhost:41523/tests/dromaeo/cssquery-yui.html (next: http://localhost:41523/tests/dromaeo/cssquery-dojo.html) 18:35:05 INFO - PROCESS | 22991 | RSS: Main: 198549504 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | __start_tp_report 18:35:05 INFO - PROCESS | 22991 | _x_x_mozilla_page_load 18:35:05 INFO - PROCESS | 22991 | _x_x_mozilla_page_load_details 18:35:05 INFO - PROCESS | 22991 | |i|pagename|runs| 18:35:05 INFO - PROCESS | 22991 | |0;dojo.html;2590.9222723318303;2606.9869650651744;2618.646482724833;2634.09123852271;2662.454196889639;4723.456802467717;4776.761161941902;4834.299026641135;4846.878828029301;4854.36893203883;4726.432828060629;4771.737554434505;4816.662833601649;4843.903121937568;4902.828401005965;4387.254166791645;4417.31531612599;4425;4474.776261186944;4537.7277363358135;4411.669124815636;4438.800253988562;4477.664175186857;4484.125595508877;4519.457665080195;4326.653867690608;4358.5205627380965;4390.912181756379;4447.866564003085;4468.865934021985;4405.691601587891;4419.337099435078;4445.733256004618;4451.866444006685;4478.104379124188;4326.545712700153;4336.588024137702;4347.69566130371;4370.650347972186;4428.468583769936;4711.905761884777;4727.787249573743;4760.1907675694865;4785.425748910153;4785.853989542158;5062.797488100471;5084.644074914758;5085.974570127163;5091.032703786306;5159.69041857486;5161.122609156415;5169.793208271664;5170.560502357304;5173.663711858717;5227.738613069331;4740.881477963009;4753.952460475421;4787.497312782178;4818.036392721399;4818.903621927542;5232.450592687789;5234.633575649668;5238.266642670029;5238.8166414176085;5241.475852414728;5029.119904016856;5037.773300201499;5037.949620503748;5040.873978150502;5049.444561098277;5028.823991160292;5073.746312684425;5103.897922041539;5106.387233532;5177.870553236124;5027.924581131286;5049.545540901263;5078.898422031539;5088.92366614501;5145.76844042019;5038.168702164176;5050.520200580939;5054.848354549369;5054.873628159326;5059.924101138486;4262.339337402707;4320.870373888788;4369.60673539383;4373.169097871394;4410.911781764346;3779.055236190952;3793.412021136728;3796.0699628591174;3832.3676593362343;3840.2127563849344;4451.065276292015;4452.0873220989615;4460.576245256695;4472.1757821829915;4510.639148868083;5051.949480505222;5132.3327967364;5154.7938082476285;5180.171172612364;5245.527902488794;4429.512753597101;4431.955680443154;4443.466783985878;4459.264221403432;4501.7974191161475;4583.152116858392;4591.563801438858;4612.838550650711;4613.653975951817;4680.648951328664;4703.670743047954;4761.381020467317;4792.2332426811545;4826.3243145958895;4860.1251774680895;5096.133657278346;5149.382074151126;5153.768080436314;5153.896922061463;5261.736913154404;4839.516048395132;4845.685030473008;4846.612271018381;4854.368932038812;4907.828226012072;4980.726060066731;5074.5432911036705;5095.13382724945;5113.64204505681;5155.458676838878;5142;5196.844094677166;5198.350206224222;5216.921746173886;5218.243354713622;5044.571211446922;5044.798208071636;5053.36832895888;5056.115179843586;5074.543291103819;4816.277558366273;4883.658143929891;4964.280179374043;5000.549950504472;5047.318611987482;4878.853634390974;4893.7063776173545;4905.803767849389;4923.679960802537;4970.527799859007;5021.046001259749;5034.521720436553;5034.773435195499;5040.36995375578;5085.77114029877;4834.709917404967;4887.0714564232685;4933.703977761345;4938.48145944685;4956.677815941952 18:35:05 INFO - PROCESS | 22991 | |1;ext.html;526.5077152862074;533.9507867041264;541.7805788655596;545.1686178577669;577.48603742669;33162.834185829066;37063.62936370636;37064.629353706456;37221.069473263145;37293.62706372936;37916.43125353122;38712;38904;38942.8052859736;39008;7559.092908850946;7704.229577042279;7706.845863082735;7707.267809558083;7711.26742959418;7400.925990740077;7548.131964824061;7557.093148822121;7566.508176968479;7573.2805383488485;7527.13437954634;7569.470137090406;7573.659185336645;7588.962055189744;7647.082350117966;7487.326140647313;7505.737299194502;7508.774736757906;7510.549367037996;7527.736529221451;7521.135069467026;7597.924020759777;7603.163651998276;7614.352780013705;7670.117936437326;35926.64073359259;36285.0928726784;36396.090097747765;36406.63593364059;36428.81785591055;2881.7118288171223;3039.5136778115616;3072.7695422843376;3229.0797122819886;3599.226166374242;27711.307217319525;27757.861210693816;27955.58066629002;28058.85970570134;28838;3148.874045038219;3200.135963289922;3222.9033129006166;3231.127595549212;3272.541844141822;232869.83565082235;233171;233241;233532;233978;51124.48875511272;51219.48780512147;51469.742651286506;51578.48421515737;51687.74156129271;32137.51793723096;32594.185145371557;32637.83681081627;34678.13304667403;34742.13144671353;14370.281485925661;14434.566962991126;14521.709565808625;14536.345864436125;14536.709265814836;11121.221514493907;11228.831567526493;11241.943790280997;11245.775084498264;11270.549178032787;17339.13304334778;17340.219690113976;17358.91320543389;17383.174766649572;17531.211095500734;6766.221884483249;6820.420264277493;6855.6572171391235;6942.618156001468;7021.560580081071;747.4356860570234;889.7063968890251;902.7878448564582;915.199200699388;942.665353799405;26283.60574591383;27160.592591111148;27555.448891022468;27962.300942476195;28116.8594157032;879.55582430872;894.4096896048707;964.8215080210183;1030.5002073994108;1034.250168627739;14013.509527166703;14235.715285694228;14919.477818276308;14942.402303907722;14998.625034374229;358097;361760;362035;362130;362217;48192;48578.757106214245;48634.75682621564;48677;48859.75570122198;1082.9187810914054;1142.657202839145;1146.7591805720724;1148.0404651903862;1161.7618388230392;25712;26636.467270654866;26930;27436.31409214706;27441;41024;41220;41338.79330603328;41422;41422.1715565693;301305;302585;304378;304691;305349;22375.44061398478;22793.658095128256;22909;24625.261242162764;25022.874885625457;39855.6395774872;40058;40297.798511007255;40739;41371.793141034104;35021.47467788036;35132.824335878155;35262;35746.64253357433;36408.08979775527;35108.12229694176;35108.824455877555;35514.64485355114;35548.82225588855;35771.82114089413;34394.82802585971;34509.13727156841;34692.132696682784;34864.30271394507;34975;30148;32280.515792262664;32771.836140820094;32855.17862053468;32920.341593167526;24546.263612091665;24619.87690061538;24953.625695614217;25048.74951250464;25530.361740956625 18:35:05 INFO - PROCESS | 22991 | |2;jquery.html;342.5683638615344;350.98245087745613;352.1442893768143;364.71369974569933;382.3423711216708;15272.541823745292;16361.181940902952;16494.917525412387;16513.83486165138;16528.586785330357;13322.733545329087;13739.24434156121;13878.444862205524;14463.92768036161;14670.926645366759;4564.520725323843;4630.606398456127;4710.364100846393;4729.9054018919605;4735.85792426226;3374.9493757593655;4640.883977900546;4723.976380118094;5284.788608455677;5538.113901775717;5516.227728118067;5525.0883604205255;5532.087205611069;5533.723313834313;5535.363433205172;5304.283921670563;5475.288212532365;5516.503514683657;5523.171524271352;5532.059549876491;5352.2239275305255;5356.625036247464;5356.839294821123;5358.089124848785;5368.812091576815;11795.88204117965;11973.580924667682;11984.64046078619;12125.757484850254;12142.939285303517;1815.174095786414;1815.3374018483291;1908;2126.904289306985;2240.003198576634;8796.47221166732;8947.239484643813;8948.955255223747;9411;9487.051294870527;1613.2417763651183;1613.6127329440967;1638.066302207742;1640.2045008171028;1687.4370313019574;65966;67191;67749;68704;68852.6557367215;8951.149640784115;9104.590293436679;9302.813943721223;9432.339736218537;9502.809943801085;12927.418266178045;12949.870501295054;12959.740805183843;12992.155509891827;13006.479740810262;6913.274106218875;7113.608751518716;7153.785386438415;7249.420046396381;7250.4199664026755;6917.89623155653;6944.687489063004;7149.60677162761;7170.713171473187;7170.749023784142;3731.272401881607;3942.15243722601;3985.1431942132;4069.064115253449;4083.0813067059676;1555.883308751848;1646.4978181654471;1676.6311411489453;1748.5453782016766;1777.7866656001104;808.5997431271559;816.3428440105772;883.1962913748458;914.6295750221171;930.9860352094724;15630.765538516931;15989.760153597705;16104;16296.918515407348;16718.58203544921;814.352589691197;825.7852958230903;827.7806381308958;846.6317152038882;865.8008658008567;9043.864342034874;9044.638214471479;9220.677276295297;9249.398789078688;9496.43021418717;351467;356680;360090;364819;371664;70527.29472705207;72806.63596682089;75533.24466755372;76078.23921760712;76736;856.4433118472917;879.4942907828024;879.6965047058754;879.9164079412445;882.5102068351998;14547;14657;14834.406623734929;14841.777373339193;15045.774313385527;36208.27583448369;36365.363558639394;36599.45100823436;37309.62690373061;37480.625193747714;48423.75788121037;48954;49573.504264956886;49639.25541116814;49671;6604.801855944329;6914.619695916773;7031.542949708252;7194.820129496805;7423.035005449257;11093.278936869077;11805.350705711267;11815.468303926173;11838.467268972745;12061.698457538632;5065.961477896949;9791.412515249107;10054.19566434669;10160.796784064129;10587.529976019;9701.223902087957;9897.208223342259;9904.653337133166;9994.750131246778;10043.246756493438;9903.95048024784;9918.504074796376;10000.649977251052;10317.226208034277;10508.94745526298;6839.487038472035;6849.554778939353;7063;7140.7143714252925;7245.094363204599;9642.469664168539;10000.949995249977;10157.187425005834;10242.129418999171;10533.894661053599 18:35:05 INFO - PROCESS | 22991 | |3;mootools.html;1308.3000594681841;1377.1186440677966;1412.4562043613212;1637.8280280570548;1666.6999940010794;6842.96578517108;7310.853782924339;7478.925210747891;7728.381729461644;7734.806629834257;7739;7842.098158711749;7844.764657060283;7856.528608283507;7861.882071768928;2128.5104425982036;2139.101577337518;2156.0621129808505;2158.7949144831214;2159.5356998245375;2094.2356040045424;2113.3871177358546;2174.499865031044;2196.1325276515768;2197.4726065744185;2150.827933765303;2155.6766485027215;2158.4280165756086;2181.0076415231033;2184.5740080684272;2136.6367717488065;2139.037433155079;2145.8497905146646;2148.731408573928;2158.8704677719306;2074.9377518674464;2104.400245929918;2104.98947505263;2108.8102070813547;2112.461322362803;7636.885446718304;7714.6914123435;7730.033745781778;7802.024746906637;7805.102413222438;4355.738655680638;4493.393391892086;4497.280435130396;4499.4150760400935;4502.977485112553;2836.205862358543;2881.884724611013;2900.419916016805;2912.8689208985434;2914;923.7413524213231;941.199980016987;967.3000772046878;972.9880923839198;978.2907392140642;10319.79360412795;10350.378977261389;10401.323913945569;10423.426711530863;10436.686899392955;3867.883963481044;4060.4721386219603;4131.235721391552;4161.271777438997;4178.498580170399;8819.779505512286;8838.027816940132;8846.424982376126;8848.955755221183;8857.070007649105;4435.866923992286;4458.35353873693;4498.932516012263;4524.615407690383;4532.365468834366;3646.9817650912105;3951.269015232191;4048.149888523384;4057.878263652095;4058.898527536835;3540.8937731868086;3548.3790336690977;3599.7141814947695;3618.692411145082;3723.1436769543157;1164.1618035014776;1165.1901928160016;1187.8396416483838;1197.5449329254827;1199.220506670671;674.5817593092314;789.5223389849174;801.4229754576695;802.2098233240254;816.9387295952828;4725.3384526166365;4831.661783675109;4848.345473361122;4905.3623029006;5031.899362012739;383.86948437531373;398.5715355992262;398.9122393073519;400.46737838674494;404.0343578846559;3270.8037517749012;3290.4241757692785;3311;3361.8991430257133;3400.710939570115;8583.656653733906;9104.544772761468;9228.215601673934;9238.399504032217;9256.72229833106;9179.862302065474;9197.862032069525;9208.12522810332;9223.723288301362;9231.815363692689;6981.127359080115;7023.7892863213165;7037.929620703728;7083.079199704005;7149.428045756327;4751.786169622306;4785.353977213032;4997.475265097112;5071.949280507295;5171.172612382151;8309.501429913982;8583.570821458778;8634.30925525969;8784.077671844365;8795.648174072965;8578.4424012439;8621.612027458654;8783.956080219557;8833.955830220808;8843.867341990004;5957.940420595912;6283.2460104787715;6342.112104305494;6462.063000864942;6711.899321510084;7445.143808461879;7469.477136600386;7470.103587569526;7479.439042071757;7505.737299194502;6349.238091429058;6534.085228067979;6592.8351791205605;6646.2356828965285;6652;6338.397852204033;6438.066480360228;6482.092507049111;6706.899396509154;6792.354726300993;5920.822375328747;6159.353267906985;6162.7534898605345;6167.167432396569;6184.103305020657;4264.850730224427;4305.31115021595;4308.414951029357;4385.583369579885;4423.093265880422;4290.935635965526;4329.2640251156745;4439.911201775882;4453.309736990772;4461.13007963444 18:35:05 INFO - PROCESS | 22991 | |4;prototype.html;298.1800049862877;302.2790644313312;302.8319282798049;305.38922155688624;305.5920346337639;4980.4521502634725;5035.748212589369;5037.53911365704;5042.546170844624;5083.856132370215;4922.21244600864;4940.382452193476;4967.739678446307;4974.154393753061;4979.228219625964;3698.278835627054;3774.2451509698035;3859.1316953685478;3886.727929044968;3892.6691231245377;3857.3442514772414;3859.7298189126773;3860.40163774614;3895.1235971906235;3901.882943511699;3898.8635397761086;3899.25914076326;3906.3749800032;3910.7262491625597;3917.4515567820526;3812.961870381316;3834.3481608126685;3873.205992771475;3905.1994341159993;3918.7060970427187;3390.4575267957257;3394.389009978203;3396.745244106702;3406.744494162948;3412.06168303716;4820.975895120537;4838.129136755382;4853.272009198613;4886.411916127237;4895.437024742129;4451.799669014902;4451.977740111279;4456.242438785382;4463.263561512346;4464.8883777905485;4921;5146.356705411824;5154.510321519487;5193.324867767204;5198.896022079575;3663.780173189617;3664.6152154023976;3670.4127339625798;3683.1344634010984;3686.760360576554;5474.890502189974;5485.750842154697;5489.862753431156;5493.7802487900435;5512.145617429305;3664.670179683841;3694.2796154750104;3713.2150886834875;3718.3678774608384;3742.401215805458;3768.453574231721;3776;3798.525184351956;3799.7530160539477;3810.8666196682984;4360.563943605614;4370.104128653618;4373.190959672471;4375.562443755599;4378.824847006148;4848.321235027099;5122.513361230677;5214.739263036833;5220.686758794409;5234.738263086831;1282.435728279554;1291.761024210524;1296.682312833343;1298.1691717300935;1298.214580178997;798.5408390175556;815.2906970935325;836.2390224895316;838.3963546246692;848.855694531931;4316.287812510964;4386.780660967002;4529.411176547093;4577.633789296849;4593.747343896118;5337.226102215157;5339.893202135935;5346.652467589594;5362.946370536322;5363.946360536344;4566.442792036471;4566.70316429431;4570.451545814523;4574;4588.49526552079;2705.2830999785074;2809.2555472799722;2824.2233385819063;2828.2363761784613;2831.6460442444695;4976.800927962913;4977.129002424634;4985.202367621163;4991.725455100004;4995.850124496271;5194.246834209094;5424.566034717213;5425.294711687534;5436.592255580847;5437.700926449004;4971.204607262821;5017.347744793154;5041.344625198701;5052.520010598987;5057.367829021372;5401.8919621606565;5405.351357837085;5426.538744206787;5427.96451330751;5432.9185062223305;5156.896862062813;5180.326557547494;5255.500727430888;5300.7879684813715;5321.467853214647;4921.606271498343;4948.529889660476;4962.404511458648;4976.353074100344;5025.472325405926;3703.6851917568874;3762.548494180716;3766.472693822922;3775.7923314217983;3779.8110094495714;5129.8717532062;5304.60215483848;5367.141257398954;5389.407165211745;5416.51251387377;5146.099432599205;5149.201873709581;5151.433342332265;5158.303629010185;5184.766685499086;5172.353455818023;5183.248428977852;5209.426963033988;5214.556762675215;5223.3209682741;4937.530934561211;5116.334876466036;5120.769565369493;5144.742762861917;5164.018836421068;4941.2835138905375;5032.924506132338;5185.09260879337;5209.192575150858;5212.478752124909;5098.731064676183;5104.3619547556555;5110.514501122388;5116.4627714090975;5129.7691603877165 18:35:05 INFO - PROCESS | 22991 | |5;yui.html;592.128178335075;595.8629515211499;655.4526969980067;688.3667026335769;688.8450098727786;11884.346360950145;12251.63245102646;12599.118061735682;12697.936510317448;12772.552960646379;12974.740505189915;13247.536336228233;13263;13276.07067505275;13316.067875248737;605.9484943779784;721.3976329764653;736.4292673178276;737.9852402951938;738.1584993107834;721.3075447570338;742.2911119880501;749.6589051981363;753.6457864803562;755.2523002227782;780.1963977103565;784.568487331968;784.9803754906116;785.2540086917422;787.9172686867854;778.6534991928594;779.4349096904756;780.3445106110865;780.4926797581561;781.6287263549825;567.980475047287;568.4599630351183;574.6322353693639;574.6322353693639;574.7672192761938;11968.461419236155;11979.640610781691;11997.520099196021;12087.576934807328;12170.939145304304;12661.74676506474;13000.479980800757;13216.405261763244;13259.46962121514;13411.329433528284;8673.176048275403;8858;8869.645214191425;9084.591193396313;9209.861852072225;3152.4956007038763;3166.6358368787655;3175.3490534440384;3180.666030066856;3230.9838450807597;61376.386236137514;62294;63967;64672;65211.34788652148;8736.737897862948;8851.247643950208;8932.763079371447;9117.270618350516;9121.954390228006;19922.90038549827;19983.800161998195;20023.09896054681;20050.799492004895;20145.29491467821;6448.838779030561;6490.188726409199;6644.8671026579195;6649.667516624246;6726.1256036715895;3569.268299998546;3586.1572530455323;3595.748297619194;3606.477060826218;3657.561092668897;2638.300850274679;2752.1881045091745;2758.5586306191312;2759.751622353998;2760.7653349465118;474.7104266397564;475.3369050174987;485.4393175881862;489.6596865178738;493.3019777015483;507.98984020319386;512.0833707663242;522.6393788286147;529.7298377827336;533.9880925645879;7553.169151393342;7996.800079998046;8220.958895205486;8261.876071858927;8615.827683446296;463.6036189058374;532.1937265043463;541.5694522854341;553.0211525599747;557.2616283424479;3688.9262214755554;3720.5907350191455;3750.0999760057935;3835.4055121456217;3928.155446578999;53278.73360633172;86586.13413865906;89006.55496722474;91185;91718.08281917228;76269.61865190639;76490.23509764942;77606.6119669398;79749.60125199337;81377.18622813815;67187.32812671909;69554.30445695478;70735.2926470739;71287.58411743071;72014.27985720076;6721.764738234138;7059.254746372929;7071.032455979511;7301.561906285639;7328.193898671036;39634;40283.3957490632;40490.39264410977;41012.38481422721;42338.364924525544;33940.83029584836;47184.7640761794;57161.71419142878;58312.70843645755;60854;8937.419067760575;9248.445093294424;9455.669051583161;9519.52402379892;9583.520823958635;9806.460644664612;9859.753506162404;10080.395176289447;10109.898901010896;10145.34055286404;9262.814743705223;9364.765880853032;9447.669331573363;9505.95247023788;9517.714468565953;9290.256779457763;9411.52942352866;9433.151016408281;9825.164860986895;9844.950775246078;9528.571214295513;9620.903790962;9653.324267301221;9655.372400793925;9674.467904265333;7269.781906542812;7507.873818927204;7518.812029699301;7773.533587984739;7918.920810791818;7475;7711.26742959418;7918.802029949297;7998.600069996361;8135.837283254184 18:35:05 INFO - PROCESS | 22991 | __end_tp_report 18:35:05 INFO - PROCESS | 22991 | __start_cc_report 18:35:05 INFO - PROCESS | 22991 | _x_x_mozilla_cycle_collect,367 18:35:05 INFO - PROCESS | 22991 | __end_cc_report 18:35:05 INFO - PROCESS | 22991 | __startTimestamp1472520904995__endTimestamp 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | ------- Summary: start ------- 18:35:05 INFO - PROCESS | 22991 | Number of tests: 6 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | [#0] dojo.html Cycles:165 Average:4741.78 Median:4854.37 stddev:500.96 (10.3%) stddev-sans-first:473.22 18:35:05 INFO - PROCESS | 22991 | Values: 2590.9 2607.0 2618.6 2634.1 2662.5 4723.5 4776.8 4834.3 4846.9 4854.4 4726.4 4771.7 4816.7 4843.9 4902.8 4387.3 4417.3 4425.0 4474.8 4537.7 4411.7 4438.8 4477.7 4484.1 4519.5 4326.7 4358.5 4390.9 4447.9 4468.9 4405.7 4419.3 4445.7 4451.9 4478.1 4326.5 4336.6 4347.7 4370.7 4428.5 4711.9 4727.8 4760.2 4785.4 4785.9 5062.8 5084.6 5086.0 5091.0 5159.7 5161.1 5169.8 5170.6 5173.7 5227.7 4740.9 4754.0 4787.5 4818.0 4818.9 5232.5 5234.6 5238.3 5238.8 5241.5 5029.1 5037.8 5037.9 5040.9 5049.4 5028.8 5073.7 5103.9 5106.4 5177.9 5027.9 5049.5 5078.9 5088.9 5145.8 5038.2 5050.5 5054.8 5054.9 5059.9 4262.3 4320.9 4369.6 4373.2 4410.9 3779.1 3793.4 3796.1 3832.4 3840.2 4451.1 4452.1 4460.6 4472.2 4510.6 5051.9 5132.3 5154.8 5180.2 5245.5 4429.5 4432.0 4443.5 4459.3 4501.8 4583.2 4591.6 4612.8 4613.7 4680.6 4703.7 4761.4 4792.2 4826.3 4860.1 5096.1 5149.4 5153.8 5153.9 5261.7 4839.5 4845.7 4846.6 4854.4 4907.8 4980.7 5074.5 5095.1 5113.6 5155.5 5142.0 5196.8 5198.4 5216.9 5218.2 5044.6 5044.8 5053.4 5056.1 5074.5 4816.3 4883.7 4964.3 5000.5 5047.3 4878.9 4893.7 4905.8 4923.7 4970.5 5021.0 5034.5 5034.8 5040.4 5085.8 4834.7 4887.1 4933.7 4938.5 4956.7 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | [#1] ext.html Cycles:180 Average:44603.44 Median:35197.41 stddev:79901.29 (227.0%) stddev-sans-first:80056.90 18:35:05 INFO - PROCESS | 22991 | Values: 526.5 534.0 541.8 545.2 577.5 33162.8 37063.6 37064.6 37221.1 37293.6 37916.4 38712.0 38904.0 38942.8 39008.0 7559.1 7704.2 7706.8 7707.3 7711.3 7400.9 7548.1 7557.1 7566.5 7573.3 7527.1 7569.5 7573.7 7589.0 7647.1 7487.3 7505.7 7508.8 7510.5 7527.7 7521.1 7597.9 7603.2 7614.4 7670.1 35926.6 36285.1 36396.1 36406.6 36428.8 2881.7 3039.5 3072.8 3229.1 3599.2 27711.3 27757.9 27955.6 28058.9 28838.0 3148.9 3200.1 3222.9 3231.1 3272.5 232869.8 233171.0 233241.0 233532.0 233978.0 51124.5 51219.5 51469.7 51578.5 51687.7 32137.5 32594.2 32637.8 34678.1 34742.1 14370.3 14434.6 14521.7 14536.3 14536.7 11121.2 11228.8 11241.9 11245.8 11270.5 17339.1 17340.2 17358.9 17383.2 17531.2 6766.2 6820.4 6855.7 6942.6 7021.6 747.4 889.7 902.8 915.2 942.7 26283.6 27160.6 27555.4 27962.3 28116.9 879.6 894.4 964.8 1030.5 1034.3 14013.5 14235.7 14919.5 14942.4 14998.6 358097.0 361760.0 362035.0 362130.0 362217.0 48192.0 48578.8 48634.8 48677.0 48859.8 1082.9 1142.7 1146.8 1148.0 1161.8 25712.0 26636.5 26930.0 27436.3 27441.0 41024.0 41220.0 41338.8 41422.0 41422.2 301305.0 302585.0 304378.0 304691.0 305349.0 22375.4 22793.7 22909.0 24625.3 25022.9 39855.6 40058.0 40297.8 40739.0 41371.8 35021.5 35132.8 35262.0 35746.6 36408.1 35108.1 35108.8 35514.6 35548.8 35771.8 34394.8 34509.1 34692.1 34864.3 34975.0 30148.0 32280.5 32771.8 32855.2 32920.3 24546.3 24619.9 24953.6 25048.7 25530.4 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | [#2] jquery.html Cycles:180 Average:22777.34 Median:49263.75 stddev:59781.19 (121.3%) stddev-sans-first:59925.16 18:35:05 INFO - PROCESS | 22991 | Values: 342.6 351.0 352.1 364.7 382.3 15272.5 16361.2 16494.9 16513.8 16528.6 13322.7 13739.2 13878.4 14463.9 14670.9 4564.5 4630.6 4710.4 4729.9 4735.9 3374.9 4640.9 4724.0 5284.8 5538.1 5516.2 5525.1 5532.1 5533.7 5535.4 5304.3 5475.3 5516.5 5523.2 5532.1 5352.2 5356.6 5356.8 5358.1 5368.8 11795.9 11973.6 11984.6 12125.8 12142.9 1815.2 1815.3 1908.0 2126.9 2240.0 8796.5 8947.2 8949.0 9411.0 9487.1 1613.2 1613.6 1638.1 1640.2 1687.4 65966.0 67191.0 67749.0 68704.0 68852.7 8951.1 9104.6 9302.8 9432.3 9502.8 12927.4 12949.9 12959.7 12992.2 13006.5 6913.3 7113.6 7153.8 7249.4 7250.4 6917.9 6944.7 7149.6 7170.7 7170.7 3731.3 3942.2 3985.1 4069.1 4083.1 1555.9 1646.5 1676.6 1748.5 1777.8 808.6 816.3 883.2 914.6 931.0 15630.8 15989.8 16104.0 16296.9 16718.6 814.4 825.8 827.8 846.6 865.8 9043.9 9044.6 9220.7 9249.4 9496.4 351467.0 356680.0 360090.0 364819.0 371664.0 70527.3 72806.6 75533.2 76078.2 76736.0 856.4 879.5 879.7 879.9 882.5 14547.0 14657.0 14834.4 14841.8 15045.8 36208.3 36365.4 36599.5 37309.6 37480.6 48423.8 48954.0 49573.5 49639.3 49671.0 6604.8 6914.6 7031.5 7194.8 7423.0 11093.3 11805.4 11815.5 11838.5 12061.7 5066.0 9791.4 10054.2 10160.8 10587.5 9701.2 9897.2 9904.7 9994.8 10043.2 9904.0 9918.5 10000.6 10317.2 10508.9 6839.5 6849.6 7063.0 7140.7 7245.1 9642.5 10000.9 10157.2 10242.1 10533.9 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | [#3] mootools.html Cycles:180 Average:4967.94 Median:4738.56 stddev:2800.92 (59.1%) stddev-sans-first:2795.27 18:35:05 INFO - PROCESS | 22991 | Values: 1308.3 1377.1 1412.5 1637.8 1666.7 6843.0 7310.9 7478.9 7728.4 7734.8 7739.0 7842.1 7844.8 7856.5 7861.9 2128.5 2139.1 2156.1 2158.8 2159.5 2094.2 2113.4 2174.5 2196.1 2197.5 2150.8 2155.7 2158.4 2181.0 2184.6 2136.6 2139.0 2145.8 2148.7 2158.9 2074.9 2104.4 2105.0 2108.8 2112.5 7636.9 7714.7 7730.0 7802.0 7805.1 4355.7 4493.4 4497.3 4499.4 4503.0 2836.2 2881.9 2900.4 2912.9 2914.0 923.7 941.2 967.3 973.0 978.3 10319.8 10350.4 10401.3 10423.4 10436.7 3867.9 4060.5 4131.2 4161.3 4178.5 8819.8 8838.0 8846.4 8849.0 8857.1 4435.9 4458.4 4498.9 4524.6 4532.4 3647.0 3951.3 4048.1 4057.9 4058.9 3540.9 3548.4 3599.7 3618.7 3723.1 1164.2 1165.2 1187.8 1197.5 1199.2 674.6 789.5 801.4 802.2 816.9 4725.3 4831.7 4848.3 4905.4 5031.9 383.9 398.6 398.9 400.5 404.0 3270.8 3290.4 3311.0 3361.9 3400.7 8583.7 9104.5 9228.2 9238.4 9256.7 9179.9 9197.9 9208.1 9223.7 9231.8 6981.1 7023.8 7037.9 7083.1 7149.4 4751.8 4785.4 4997.5 5071.9 5171.2 8309.5 8583.6 8634.3 8784.1 8795.6 8578.4 8621.6 8784.0 8834.0 8843.9 5957.9 6283.2 6342.1 6462.1 6711.9 7445.1 7469.5 7470.1 7479.4 7505.7 6349.2 6534.1 6592.8 6646.2 6652.0 6338.4 6438.1 6482.1 6706.9 6792.4 5920.8 6159.4 6162.8 6167.2 6184.1 4264.9 4305.3 4308.4 4385.6 4423.1 4290.9 4329.3 4439.9 4453.3 4461.1 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | [#4] prototype.html Cycles:180 Average:4302.30 Median:4940.83 stddev:1260.77 (25.5%) stddev-sans-first:1227.96 18:35:05 INFO - PROCESS | 22991 | Values: 298.2 302.3 302.8 305.4 305.6 4980.5 5035.7 5037.5 5042.5 5083.9 4922.2 4940.4 4967.7 4974.2 4979.2 3698.3 3774.2 3859.1 3886.7 3892.7 3857.3 3859.7 3860.4 3895.1 3901.9 3898.9 3899.3 3906.4 3910.7 3917.5 3813.0 3834.3 3873.2 3905.2 3918.7 3390.5 3394.4 3396.7 3406.7 3412.1 4821.0 4838.1 4853.3 4886.4 4895.4 4451.8 4452.0 4456.2 4463.3 4464.9 4921.0 5146.4 5154.5 5193.3 5198.9 3663.8 3664.6 3670.4 3683.1 3686.8 5474.9 5485.8 5489.9 5493.8 5512.1 3664.7 3694.3 3713.2 3718.4 3742.4 3768.5 3776.0 3798.5 3799.8 3810.9 4360.6 4370.1 4373.2 4375.6 4378.8 4848.3 5122.5 5214.7 5220.7 5234.7 1282.4 1291.8 1296.7 1298.2 1298.2 798.5 815.3 836.2 838.4 848.9 4316.3 4386.8 4529.4 4577.6 4593.7 5337.2 5339.9 5346.7 5362.9 5363.9 4566.4 4566.7 4570.5 4574.0 4588.5 2705.3 2809.3 2824.2 2828.2 2831.6 4976.8 4977.1 4985.2 4991.7 4995.9 5194.2 5424.6 5425.3 5436.6 5437.7 4971.2 5017.3 5041.3 5052.5 5057.4 5401.9 5405.4 5426.5 5428.0 5432.9 5156.9 5180.3 5255.5 5300.8 5321.5 4921.6 4948.5 4962.4 4976.4 5025.5 3703.7 3762.5 3766.5 3775.8 3779.8 5129.9 5304.6 5367.1 5389.4 5416.5 5146.1 5149.2 5151.4 5158.3 5184.8 5172.4 5183.2 5209.4 5214.6 5223.3 4937.5 5116.3 5120.8 5144.7 5164.0 4941.3 5032.9 5185.1 5209.2 5212.5 5098.7 5104.4 5110.5 5116.5 5129.8 18:35:05 INFO - PROCESS | 22991 | 18:35:05 INFO - PROCESS | 22991 | [#5] yui.html Cycles:180 Average:16099.18 Median:6647.27 stddev:23139.17 (348.1%) stddev-sans-first:23174.79 18:35:05 INFO - PROCESS | 22991 | Values: 592.1 595.9 655.5 688.4 688.8 11884.3 12251.6 12599.1 12697.9 12772.6 12974.7 13247.5 13263.0 13276.1 13316.1 605.9 721.4 736.4 738.0 738.2 721.3 742.3 749.7 753.6 755.3 780.2 784.6 785.0 785.3 787.9 778.7 779.4 780.3 780.5 781.6 568.0 568.5 574.6 574.6 574.8 11968.5 11979.6 11997.5 12087.6 12170.9 12661.7 13000.5 13216.4 13259.5 13411.3 8673.2 8858.0 8869.6 9084.6 9209.9 3152.5 3166.6 3175.3 3180.7 3231.0 61376.4 62294.0 63967.0 64672.0 65211.3 8736.7 8851.2 8932.8 9117.3 9122.0 19922.9 19983.8 20023.1 20050.8 20145.3 6448.8 6490.2 6644.9 6649.7 6726.1 3569.3 3586.2 3595.7 3606.5 3657.6 2638.3 2752.2 2758.6 2759.8 2760.8 474.7 475.3 485.4 489.7 493.3 508.0 512.1 522.6 529.7 534.0 7553.2 7996.8 8221.0 8261.9 8615.8 463.6 532.2 541.6 553.0 557.3 3688.9 3720.6 3750.1 3835.4 3928.2 53278.7 86586.1 89006.6 91185.0 91718.1 76269.6 76490.2 77606.6 79749.6 81377.2 67187.3 69554.3 70735.3 71287.6 72014.3 6721.8 7059.3 7071.0 7301.6 7328.2 39634.0 40283.4 40490.4 41012.4 42338.4 33940.8 47184.8 57161.7 58312.7 60854.0 8937.4 9248.4 9455.7 9519.5 9583.5 9806.5 9859.8 10080.4 10109.9 10145.3 9262.8 9364.8 9447.7 9506.0 9517.7 9290.3 9411.5 9433.2 9825.2 9845.0 9528.6 9620.9 9653.3 9655.4 9674.5 7269.8 7507.9 7518.8 7773.5 7918.9 7475.0 7711.3 7918.8 7998.6 8135.8 18:35:05 INFO - PROCESS | 22991 | -------- Summary: end -------- 18:35:05 INFO - PROCESS | 22991 | 18:35:06 INFO - TEST-INFO | 22991: exit 0 18:35:06 INFO - TEST-OK | dromaeo_css | took 1118621ms 18:35:06 INFO - TEST-START | kraken 18:35:06 INFO - operating with platform_type : linux_ 18:35:06 INFO - Initialising browser for kraken test... 18:35:06 INFO - TEST-INFO | started process 23349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt10wqy/profile http://localhost:41523/getInfo.html) 18:35:11 INFO - PROCESS | 23349 | __metrics Screen width/height:1600/1200 18:35:11 INFO - PROCESS | 23349 | colorDepth:24 18:35:11 INFO - PROCESS | 23349 | Browser inner width/height: 1024/697 18:35:11 INFO - PROCESS | 23349 | __metrics 18:35:11 ERROR - PROCESS | 23349 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 18:35:12 INFO - TEST-INFO | 23349: exit 0 18:35:12 INFO - Browser initialized. 18:35:12 INFO - Running cycle 1/1 for kraken test... 18:35:12 INFO - TEST-INFO | started process 23468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt10wqy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:35:25 INFO - PROCESS | 23468 | RSS: Main: 193052672 18:35:25 INFO - PROCESS | 23468 | 18:35:28 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41523/tests/kraken/driver.html?testName=audio-beat-detection) 18:35:29 INFO - PROCESS | 23468 | RSS: Main: 205291520 18:35:29 INFO - PROCESS | 23468 | 18:35:31 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41523/tests/kraken/driver.html?testName=audio-dft) 18:35:32 INFO - PROCESS | 23468 | RSS: Main: 204816384 18:35:32 INFO - PROCESS | 23468 | 18:35:35 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41523/tests/kraken/driver.html?testName=audio-fft) 18:35:36 INFO - PROCESS | 23468 | RSS: Main: 197259264 18:35:36 INFO - PROCESS | 23468 | 18:35:38 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41523/tests/kraken/driver.html?testName=audio-oscillator) 18:35:38 INFO - PROCESS | 23468 | RSS: Main: 198348800 18:35:38 INFO - PROCESS | 23468 | 18:35:41 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:35:41 INFO - PROCESS | 23468 | RSS: Main: 198144000 18:35:41 INFO - PROCESS | 23468 | 18:35:44 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41523/tests/kraken/driver.html?testName=imaging-darkroom) 18:35:45 INFO - PROCESS | 23468 | RSS: Main: 198262784 18:35:45 INFO - PROCESS | 23468 | 18:35:49 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41523/tests/kraken/driver.html?testName=imaging-desaturate) 18:35:49 INFO - PROCESS | 23468 | RSS: Main: 194015232 18:35:49 INFO - PROCESS | 23468 | 18:35:52 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41523/tests/kraken/driver.html?testName=json-parse-financial) 18:35:53 INFO - PROCESS | 23468 | RSS: Main: 196169728 18:35:53 INFO - PROCESS | 23468 | 18:35:54 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:35:55 INFO - PROCESS | 23468 | RSS: Main: 197066752 18:35:55 INFO - PROCESS | 23468 | 18:35:57 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:35:58 INFO - PROCESS | 23468 | RSS: Main: 196354048 18:35:58 INFO - PROCESS | 23468 | 18:36:00 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:36:01 INFO - PROCESS | 23468 | RSS: Main: 196907008 18:36:01 INFO - PROCESS | 23468 | 18:36:03 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:36:04 INFO - PROCESS | 23468 | RSS: Main: 197177344 18:36:04 INFO - PROCESS | 23468 | 18:36:07 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:36:08 INFO - PROCESS | 23468 | RSS: Main: 197136384 18:36:08 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | Cycle 1(1): loaded http://localhost:41523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41523/tests/kraken/driver.html?testName=ai-astar) 18:36:10 INFO - PROCESS | 23468 | RSS: Main: 200105984 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | __start_tp_report 18:36:10 INFO - PROCESS | 23468 | _x_x_mozilla_page_load 18:36:10 INFO - PROCESS | 23468 | _x_x_mozilla_page_load_details 18:36:10 INFO - PROCESS | 23468 | |i|pagename|runs| 18:36:10 INFO - PROCESS | 23468 | |0;ai-astar;111;116;116;116;118;115;115;115;117;135 18:36:10 INFO - PROCESS | 23468 | |1;audio-beat-detection;156;125;148;184;126;161;156;125;187;130 18:36:10 INFO - PROCESS | 23468 | |2;audio-dft;172;166;165;162;162;164;164;161;167;166 18:36:10 INFO - PROCESS | 23468 | |3;audio-fft;78;78;78;167;78;76;75;76;166;77 18:36:10 INFO - PROCESS | 23468 | |4;audio-oscillator;84;84;142;84;85;84;144;87;85;155 18:36:10 INFO - PROCESS | 23468 | |5;imaging-gaussian-blur;117;121;117;119;119;119;118;118;118;119 18:36:10 INFO - PROCESS | 23468 | |6;imaging-darkroom;148;148;148;149;148;149;149;150;150;149 18:36:10 INFO - PROCESS | 23468 | |7;imaging-desaturate;97;97;96;95;96;98;96;96;95;95 18:36:10 INFO - PROCESS | 23468 | |8;json-parse-financial;65;67;65;66;66;67;68;66;65;66 18:36:10 INFO - PROCESS | 23468 | |9;json-stringify-tinderbox;65;66;65;65;66;66;66;66;66;66 18:36:10 INFO - PROCESS | 23468 | |10;stanford-crypto-aes;85;85;85;90;87;84;86;83;85;82 18:36:10 INFO - PROCESS | 23468 | |11;stanford-crypto-ccm;144;154;147;144;138;135;135;144;191;139 18:36:10 INFO - PROCESS | 23468 | |12;stanford-crypto-pbkdf2;176;175;172;179;173;176;176;172;175;173 18:36:10 INFO - PROCESS | 23468 | |13;stanford-crypto-sha256-iterative;71;70;70;70;77;69;69;69;69;70 18:36:10 INFO - PROCESS | 23468 | __end_tp_report 18:36:10 INFO - PROCESS | 23468 | __start_cc_report 18:36:10 INFO - PROCESS | 23468 | _x_x_mozilla_cycle_collect,898 18:36:10 INFO - PROCESS | 23468 | __end_cc_report 18:36:10 INFO - PROCESS | 23468 | __startTimestamp1472520970316__endTimestamp 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | ------- Summary: start ------- 18:36:10 INFO - PROCESS | 23468 | Number of tests: 14 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#0] ai-astar Cycles:10 Average:117.40 Median:116.00 stddev:6.45 (5.6%) stddev-sans-first:6.41 18:36:10 INFO - PROCESS | 23468 | Values: 111.0 116.0 116.0 116.0 118.0 115.0 115.0 115.0 117.0 135.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:156.00 stddev:23.45 (15.0%) stddev-sans-first:24.76 18:36:10 INFO - PROCESS | 23468 | Values: 156.0 125.0 148.0 184.0 126.0 161.0 156.0 125.0 187.0 130.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.50 stddev:3.18 (1.9%) stddev-sans-first:2.09 18:36:10 INFO - PROCESS | 23468 | Values: 172.0 166.0 165.0 162.0 162.0 164.0 164.0 161.0 167.0 166.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#3] audio-fft Cycles:10 Average:94.90 Median:77.50 stddev:37.75 (48.7%) stddev-sans-first:39.54 18:36:10 INFO - PROCESS | 23468 | Values: 78.0 78.0 78.0 167.0 78.0 76.0 75.0 76.0 166.0 77.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:84.00 stddev:30.28 (36.0%) stddev-sans-first:31.29 18:36:10 INFO - PROCESS | 23468 | Values: 84.0 84.0 142.0 84.0 85.0 84.0 144.0 87.0 85.0 155.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:1.18 (1.0%) stddev-sans-first:1.12 18:36:10 INFO - PROCESS | 23468 | Values: 117.0 121.0 117.0 119.0 119.0 119.0 118.0 118.0 118.0 119.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 18:36:10 INFO - PROCESS | 23468 | Values: 148.0 148.0 148.0 149.0 148.0 149.0 149.0 150.0 150.0 149.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 18:36:10 INFO - PROCESS | 23468 | Values: 97.0 97.0 96.0 95.0 96.0 98.0 96.0 96.0 95.0 95.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 18:36:10 INFO - PROCESS | 23468 | Values: 65.0 67.0 65.0 66.0 66.0 67.0 68.0 66.0 65.0 66.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 18:36:10 INFO - PROCESS | 23468 | Values: 65.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.00 stddev:2.20 (2.6%) stddev-sans-first:2.33 18:36:10 INFO - PROCESS | 23468 | Values: 85.0 85.0 85.0 90.0 87.0 84.0 86.0 83.0 85.0 82.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:144.00 stddev:16.48 (11.4%) stddev-sans-first:17.44 18:36:10 INFO - PROCESS | 23468 | Values: 144.0 154.0 147.0 144.0 138.0 135.0 135.0 144.0 191.0 139.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.50 stddev:2.21 (1.3%) stddev-sans-first:2.30 18:36:10 INFO - PROCESS | 23468 | Values: 176.0 175.0 172.0 179.0 173.0 176.0 176.0 172.0 175.0 173.0 18:36:10 INFO - PROCESS | 23468 | 18:36:10 INFO - PROCESS | 23468 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.41 (3.4%) stddev-sans-first:2.55 18:36:10 INFO - PROCESS | 23468 | Values: 71.0 70.0 70.0 70.0 77.0 69.0 69.0 69.0 69.0 70.0 18:36:10 INFO - PROCESS | 23468 | -------- Summary: end -------- 18:36:10 INFO - PROCESS | 23468 | 18:36:11 INFO - TEST-INFO | 23468: exit 0 18:36:11 INFO - TEST-OK | kraken | took 65380ms 18:36:11 INFO - SUITE-END | took 1184s 18:36:11 INFO - Completed test suite (00:19:44) 18:36:11 INFO - javascript benchmark 18:36:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6187.1675628644525, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.9222723318303, 2606.9869650651744, 2618.646482724833, 2634.09123852271, 2662.454196889639, 4723.456802467717, 4776.761161941902, 4834.299026641135, 4846.878828029301, 4854.36893203883, 4726.432828060629, 4771.737554434505, 4816.662833601649, 4843.903121937568, 4902.828401005965, 4387.254166791645, 4417.31531612599, 4425.0, 4474.776261186944, 4537.7277363358135, 4411.669124815636, 4438.800253988562, 4477.664175186857, 4484.125595508877, 4519.457665080195, 4326.653867690608, 4358.5205627380965, 4390.912181756379, 4447.866564003085, 4468.865934021985, 4405.691601587891, 4419.337099435078, 4445.733256004618, 4451.866444006685, 4478.104379124188, 4326.545712700153, 4336.588024137702, 4347.69566130371, 4370.650347972186, 4428.468583769936, 4711.905761884777, 4727.787249573743, 4760.1907675694865, 4785.425748910153, 4785.853989542158, 5062.797488100471, 5084.644074914758, 5085.974570127163, 5091.032703786306, 5159.69041857486, 5161.122609156415, 5169.793208271664, 5170.560502357304, 5173.663711858717, 5227.738613069331, 4740.881477963009, 4753.952460475421, 4787.497312782178, 4818.036392721399, 4818.903621927542, 5232.450592687789, 5234.633575649668, 5238.266642670029, 5238.8166414176085, 5241.475852414728, 5029.119904016856, 5037.773300201499, 5037.949620503748, 5040.873978150502, 5049.444561098277, 5028.823991160292, 5073.746312684425, 5103.897922041539, 5106.387233532, 5177.870553236124, 5027.924581131286, 5049.545540901263, 5078.898422031539, 5088.92366614501, 5145.76844042019, 5038.168702164176, 5050.520200580939, 5054.848354549369, 5054.873628159326, 5059.924101138486, 4262.339337402707, 4320.870373888788, 4369.60673539383, 4373.169097871394, 4410.911781764346, 3779.055236190952, 3793.412021136728, 3796.0699628591174, 3832.3676593362343, 3840.2127563849344, 4451.065276292015, 4452.0873220989615, 4460.576245256695, 4472.1757821829915, 4510.639148868083, 5051.949480505222, 5132.3327967364, 5154.7938082476285, 5180.171172612364, 5245.527902488794, 4429.512753597101, 4431.955680443154, 4443.466783985878, 4459.264221403432, 4501.7974191161475, 4583.152116858392, 4591.563801438858, 4612.838550650711, 4613.653975951817, 4680.648951328664, 4703.670743047954, 4761.381020467317, 4792.2332426811545, 4826.3243145958895, 4860.1251774680895, 5096.133657278346, 5149.382074151126, 5153.768080436314, 5153.896922061463, 5261.736913154404, 4839.516048395132, 4845.685030473008, 4846.612271018381, 4854.368932038812, 4907.828226012072, 4980.726060066731, 5074.5432911036705, 5095.13382724945, 5113.64204505681, 5155.458676838878, 5142.0, 5196.844094677166, 5198.350206224222, 5216.921746173886, 5218.243354713622, 5044.571211446922, 5044.798208071636, 5053.36832895888, 5056.115179843586, 5074.543291103819, 4816.277558366273, 4883.658143929891, 4964.280179374043, 5000.549950504472, 5047.318611987482, 4878.853634390974, 4893.7063776173545, 4905.803767849389, 4923.679960802537, 4970.527799859007, 5021.046001259749, 5034.521720436553, 5034.773435195499, 5040.36995375578, 5085.77114029877, 4834.709917404967, 4887.0714564232685, 4933.703977761345, 4938.48145944685, 4956.677815941952], "value": 4708.991313146306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.5077152862074, 533.9507867041264, 541.7805788655596, 545.1686178577669, 577.48603742669, 33162.834185829066, 37063.62936370636, 37064.629353706456, 37221.069473263145, 37293.62706372936, 37916.43125353122, 38712.0, 38904.0, 38942.8052859736, 39008.0, 7559.092908850946, 7704.229577042279, 7706.845863082735, 7707.267809558083, 7711.26742959418, 7400.925990740077, 7548.131964824061, 7557.093148822121, 7566.508176968479, 7573.2805383488485, 7527.13437954634, 7569.470137090406, 7573.659185336645, 7588.962055189744, 7647.082350117966, 7487.326140647313, 7505.737299194502, 7508.774736757906, 7510.549367037996, 7527.736529221451, 7521.135069467026, 7597.924020759777, 7603.163651998276, 7614.352780013705, 7670.117936437326, 35926.64073359259, 36285.0928726784, 36396.090097747765, 36406.63593364059, 36428.81785591055, 2881.7118288171223, 3039.5136778115616, 3072.7695422843376, 3229.0797122819886, 3599.226166374242, 27711.307217319525, 27757.861210693816, 27955.58066629002, 28058.85970570134, 28838.0, 3148.874045038219, 3200.135963289922, 3222.9033129006166, 3231.127595549212, 3272.541844141822, 232869.83565082235, 233171.0, 233241.0, 233532.0, 233978.0, 51124.48875511272, 51219.48780512147, 51469.742651286506, 51578.48421515737, 51687.74156129271, 32137.51793723096, 32594.185145371557, 32637.83681081627, 34678.13304667403, 34742.13144671353, 14370.281485925661, 14434.566962991126, 14521.709565808625, 14536.345864436125, 14536.709265814836, 11121.221514493907, 11228.831567526493, 11241.943790280997, 11245.775084498264, 11270.549178032787, 17339.13304334778, 17340.219690113976, 17358.91320543389, 17383.174766649572, 17531.211095500734, 6766.221884483249, 6820.420264277493, 6855.6572171391235, 6942.618156001468, 7021.560580081071, 747.4356860570234, 889.7063968890251, 902.7878448564582, 915.199200699388, 942.665353799405, 26283.60574591383, 27160.592591111148, 27555.448891022468, 27962.300942476195, 28116.8594157032, 879.55582430872, 894.4096896048707, 964.8215080210183, 1030.5002073994108, 1034.250168627739, 14013.509527166703, 14235.715285694228, 14919.477818276308, 14942.402303907722, 14998.625034374229, 358097.0, 361760.0, 362035.0, 362130.0, 362217.0, 48192.0, 48578.757106214245, 48634.75682621564, 48677.0, 48859.75570122198, 1082.9187810914054, 1142.657202839145, 1146.7591805720724, 1148.0404651903862, 1161.7618388230392, 25712.0, 26636.467270654866, 26930.0, 27436.31409214706, 27441.0, 41024.0, 41220.0, 41338.79330603328, 41422.0, 41422.1715565693, 301305.0, 302585.0, 304378.0, 304691.0, 305349.0, 22375.44061398478, 22793.658095128256, 22909.0, 24625.261242162764, 25022.874885625457, 39855.6395774872, 40058.0, 40297.798511007255, 40739.0, 41371.793141034104, 35021.47467788036, 35132.824335878155, 35262.0, 35746.64253357433, 36408.08979775527, 35108.12229694176, 35108.824455877555, 35514.64485355114, 35548.82225588855, 35771.82114089413, 34394.82802585971, 34509.13727156841, 34692.132696682784, 34864.30271394507, 34975.0, 30148.0, 32280.515792262664, 32771.836140820094, 32855.17862053468, 32920.341593167526, 24546.263612091665, 24619.87690061538, 24953.625695614217, 25048.74951250464, 25530.361740956625], "value": 16757.431698038297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.5683638615344, 350.98245087745613, 352.1442893768143, 364.71369974569933, 382.3423711216708, 15272.541823745292, 16361.181940902952, 16494.917525412387, 16513.83486165138, 16528.586785330357, 13322.733545329087, 13739.24434156121, 13878.444862205524, 14463.92768036161, 14670.926645366759, 4564.520725323843, 4630.606398456127, 4710.364100846393, 4729.9054018919605, 4735.85792426226, 3374.9493757593655, 4640.883977900546, 4723.976380118094, 5284.788608455677, 5538.113901775717, 5516.227728118067, 5525.0883604205255, 5532.087205611069, 5533.723313834313, 5535.363433205172, 5304.283921670563, 5475.288212532365, 5516.503514683657, 5523.171524271352, 5532.059549876491, 5352.2239275305255, 5356.625036247464, 5356.839294821123, 5358.089124848785, 5368.812091576815, 11795.88204117965, 11973.580924667682, 11984.64046078619, 12125.757484850254, 12142.939285303517, 1815.174095786414, 1815.3374018483291, 1908.0, 2126.904289306985, 2240.003198576634, 8796.47221166732, 8947.239484643813, 8948.955255223747, 9411.0, 9487.051294870527, 1613.2417763651183, 1613.6127329440967, 1638.066302207742, 1640.2045008171028, 1687.4370313019574, 65966.0, 67191.0, 67749.0, 68704.0, 68852.6557367215, 8951.149640784115, 9104.590293436679, 9302.813943721223, 9432.339736218537, 9502.809943801085, 12927.418266178045, 12949.870501295054, 12959.740805183843, 12992.155509891827, 13006.479740810262, 6913.274106218875, 7113.608751518716, 7153.785386438415, 7249.420046396381, 7250.4199664026755, 6917.89623155653, 6944.687489063004, 7149.60677162761, 7170.713171473187, 7170.749023784142, 3731.272401881607, 3942.15243722601, 3985.1431942132, 4069.064115253449, 4083.0813067059676, 1555.883308751848, 1646.4978181654471, 1676.6311411489453, 1748.5453782016766, 1777.7866656001104, 808.5997431271559, 816.3428440105772, 883.1962913748458, 914.6295750221171, 930.9860352094724, 15630.765538516931, 15989.760153597705, 16104.0, 16296.918515407348, 16718.58203544921, 814.352589691197, 825.7852958230903, 827.7806381308958, 846.6317152038882, 865.8008658008567, 9043.864342034874, 9044.638214471479, 9220.677276295297, 9249.398789078688, 9496.43021418717, 351467.0, 356680.0, 360090.0, 364819.0, 371664.0, 70527.29472705207, 72806.63596682089, 75533.24466755372, 76078.23921760712, 76736.0, 856.4433118472917, 879.4942907828024, 879.6965047058754, 879.9164079412445, 882.5102068351998, 14547.0, 14657.0, 14834.406623734929, 14841.777373339193, 15045.774313385527, 36208.27583448369, 36365.363558639394, 36599.45100823436, 37309.62690373061, 37480.625193747714, 48423.75788121037, 48954.0, 49573.504264956886, 49639.25541116814, 49671.0, 6604.801855944329, 6914.619695916773, 7031.542949708252, 7194.820129496805, 7423.035005449257, 11093.278936869077, 11805.350705711267, 11815.468303926173, 11838.467268972745, 12061.698457538632, 5065.961477896949, 9791.412515249107, 10054.19566434669, 10160.796784064129, 10587.529976019, 9701.223902087957, 9897.208223342259, 9904.653337133166, 9994.750131246778, 10043.246756493438, 9903.95048024784, 9918.504074796376, 10000.649977251052, 10317.226208034277, 10508.94745526298, 6839.487038472035, 6849.554778939353, 7063.0, 7140.7143714252925, 7245.094363204599, 9642.469664168539, 10000.949995249977, 10157.187425005834, 10242.129418999171, 10533.894661053599], "value": 7751.400883306319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.3000594681841, 1377.1186440677966, 1412.4562043613212, 1637.8280280570548, 1666.6999940010794, 6842.96578517108, 7310.853782924339, 7478.925210747891, 7728.381729461644, 7734.806629834257, 7739.0, 7842.098158711749, 7844.764657060283, 7856.528608283507, 7861.882071768928, 2128.5104425982036, 2139.101577337518, 2156.0621129808505, 2158.7949144831214, 2159.5356998245375, 2094.2356040045424, 2113.3871177358546, 2174.499865031044, 2196.1325276515768, 2197.4726065744185, 2150.827933765303, 2155.6766485027215, 2158.4280165756086, 2181.0076415231033, 2184.5740080684272, 2136.6367717488065, 2139.037433155079, 2145.8497905146646, 2148.731408573928, 2158.8704677719306, 2074.9377518674464, 2104.400245929918, 2104.98947505263, 2108.8102070813547, 2112.461322362803, 7636.885446718304, 7714.6914123435, 7730.033745781778, 7802.024746906637, 7805.102413222438, 4355.738655680638, 4493.393391892086, 4497.280435130396, 4499.4150760400935, 4502.977485112553, 2836.205862358543, 2881.884724611013, 2900.419916016805, 2912.8689208985434, 2914.0, 923.7413524213231, 941.199980016987, 967.3000772046878, 972.9880923839198, 978.2907392140642, 10319.79360412795, 10350.378977261389, 10401.323913945569, 10423.426711530863, 10436.686899392955, 3867.883963481044, 4060.4721386219603, 4131.235721391552, 4161.271777438997, 4178.498580170399, 8819.779505512286, 8838.027816940132, 8846.424982376126, 8848.955755221183, 8857.070007649105, 4435.866923992286, 4458.35353873693, 4498.932516012263, 4524.615407690383, 4532.365468834366, 3646.9817650912105, 3951.269015232191, 4048.149888523384, 4057.878263652095, 4058.898527536835, 3540.8937731868086, 3548.3790336690977, 3599.7141814947695, 3618.692411145082, 3723.1436769543157, 1164.1618035014776, 1165.1901928160016, 1187.8396416483838, 1197.5449329254827, 1199.220506670671, 674.5817593092314, 789.5223389849174, 801.4229754576695, 802.2098233240254, 816.9387295952828, 4725.3384526166365, 4831.661783675109, 4848.345473361122, 4905.3623029006, 5031.899362012739, 383.86948437531373, 398.5715355992262, 398.9122393073519, 400.46737838674494, 404.0343578846559, 3270.8037517749012, 3290.4241757692785, 3311.0, 3361.8991430257133, 3400.710939570115, 8583.656653733906, 9104.544772761468, 9228.215601673934, 9238.399504032217, 9256.72229833106, 9179.862302065474, 9197.862032069525, 9208.12522810332, 9223.723288301362, 9231.815363692689, 6981.127359080115, 7023.7892863213165, 7037.929620703728, 7083.079199704005, 7149.428045756327, 4751.786169622306, 4785.353977213032, 4997.475265097112, 5071.949280507295, 5171.172612382151, 8309.501429913982, 8583.570821458778, 8634.30925525969, 8784.077671844365, 8795.648174072965, 8578.4424012439, 8621.612027458654, 8783.956080219557, 8833.955830220808, 8843.867341990004, 5957.940420595912, 6283.2460104787715, 6342.112104305494, 6462.063000864942, 6711.899321510084, 7445.143808461879, 7469.477136600386, 7470.103587569526, 7479.439042071757, 7505.737299194502, 6349.238091429058, 6534.085228067979, 6592.8351791205605, 6646.2356828965285, 6652.0, 6338.397852204033, 6438.066480360228, 6482.092507049111, 6706.899396509154, 6792.354726300993, 5920.822375328747, 6159.353267906985, 6162.7534898605345, 6167.167432396569, 6184.103305020657, 4264.850730224427, 4305.31115021595, 4308.414951029357, 4385.583369579885, 4423.093265880422, 4290.935635965526, 4329.2640251156745, 4439.911201775882, 4453.309736990772, 4461.13007963444], "value": 3941.1634922728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.1800049862877, 302.2790644313312, 302.8319282798049, 305.38922155688624, 305.5920346337639, 4980.4521502634725, 5035.748212589369, 5037.53911365704, 5042.546170844624, 5083.856132370215, 4922.21244600864, 4940.382452193476, 4967.739678446307, 4974.154393753061, 4979.228219625964, 3698.278835627054, 3774.2451509698035, 3859.1316953685478, 3886.727929044968, 3892.6691231245377, 3857.3442514772414, 3859.7298189126773, 3860.40163774614, 3895.1235971906235, 3901.882943511699, 3898.8635397761086, 3899.25914076326, 3906.3749800032, 3910.7262491625597, 3917.4515567820526, 3812.961870381316, 3834.3481608126685, 3873.205992771475, 3905.1994341159993, 3918.7060970427187, 3390.4575267957257, 3394.389009978203, 3396.745244106702, 3406.744494162948, 3412.06168303716, 4820.975895120537, 4838.129136755382, 4853.272009198613, 4886.411916127237, 4895.437024742129, 4451.799669014902, 4451.977740111279, 4456.242438785382, 4463.263561512346, 4464.8883777905485, 4921.0, 5146.356705411824, 5154.510321519487, 5193.324867767204, 5198.896022079575, 3663.780173189617, 3664.6152154023976, 3670.4127339625798, 3683.1344634010984, 3686.760360576554, 5474.890502189974, 5485.750842154697, 5489.862753431156, 5493.7802487900435, 5512.145617429305, 3664.670179683841, 3694.2796154750104, 3713.2150886834875, 3718.3678774608384, 3742.401215805458, 3768.453574231721, 3776.0, 3798.525184351956, 3799.7530160539477, 3810.8666196682984, 4360.563943605614, 4370.104128653618, 4373.190959672471, 4375.562443755599, 4378.824847006148, 4848.321235027099, 5122.513361230677, 5214.739263036833, 5220.686758794409, 5234.738263086831, 1282.435728279554, 1291.761024210524, 1296.682312833343, 1298.1691717300935, 1298.214580178997, 798.5408390175556, 815.2906970935325, 836.2390224895316, 838.3963546246692, 848.855694531931, 4316.287812510964, 4386.780660967002, 4529.411176547093, 4577.633789296849, 4593.747343896118, 5337.226102215157, 5339.893202135935, 5346.652467589594, 5362.946370536322, 5363.946360536344, 4566.442792036471, 4566.70316429431, 4570.451545814523, 4574.0, 4588.49526552079, 2705.2830999785074, 2809.2555472799722, 2824.2233385819063, 2828.2363761784613, 2831.6460442444695, 4976.800927962913, 4977.129002424634, 4985.202367621163, 4991.725455100004, 4995.850124496271, 5194.246834209094, 5424.566034717213, 5425.294711687534, 5436.592255580847, 5437.700926449004, 4971.204607262821, 5017.347744793154, 5041.344625198701, 5052.520010598987, 5057.367829021372, 5401.8919621606565, 5405.351357837085, 5426.538744206787, 5427.96451330751, 5432.9185062223305, 5156.896862062813, 5180.326557547494, 5255.500727430888, 5300.7879684813715, 5321.467853214647, 4921.606271498343, 4948.529889660476, 4962.404511458648, 4976.353074100344, 5025.472325405926, 3703.6851917568874, 3762.548494180716, 3766.472693822922, 3775.7923314217983, 3779.8110094495714, 5129.8717532062, 5304.60215483848, 5367.141257398954, 5389.407165211745, 5416.51251387377, 5146.099432599205, 5149.201873709581, 5151.433342332265, 5158.303629010185, 5184.766685499086, 5172.353455818023, 5183.248428977852, 5209.426963033988, 5214.556762675215, 5223.3209682741, 4937.530934561211, 5116.334876466036, 5120.769565369493, 5144.742762861917, 5164.018836421068, 4941.2835138905375, 5032.924506132338, 5185.09260879337, 5209.192575150858, 5212.478752124909, 5098.731064676183, 5104.3619547556555, 5110.514501122388, 5116.4627714090975, 5129.7691603877165], "value": 3895.4970093721677, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.128178335075, 595.8629515211499, 655.4526969980067, 688.3667026335769, 688.8450098727786, 11884.346360950145, 12251.63245102646, 12599.118061735682, 12697.936510317448, 12772.552960646379, 12974.740505189915, 13247.536336228233, 13263.0, 13276.07067505275, 13316.067875248737, 605.9484943779784, 721.3976329764653, 736.4292673178276, 737.9852402951938, 738.1584993107834, 721.3075447570338, 742.2911119880501, 749.6589051981363, 753.6457864803562, 755.2523002227782, 780.1963977103565, 784.568487331968, 784.9803754906116, 785.2540086917422, 787.9172686867854, 778.6534991928594, 779.4349096904756, 780.3445106110865, 780.4926797581561, 781.6287263549825, 567.980475047287, 568.4599630351183, 574.6322353693639, 574.6322353693639, 574.7672192761938, 11968.461419236155, 11979.640610781691, 11997.520099196021, 12087.576934807328, 12170.939145304304, 12661.74676506474, 13000.479980800757, 13216.405261763244, 13259.46962121514, 13411.329433528284, 8673.176048275403, 8858.0, 8869.645214191425, 9084.591193396313, 9209.861852072225, 3152.4956007038763, 3166.6358368787655, 3175.3490534440384, 3180.666030066856, 3230.9838450807597, 61376.386236137514, 62294.0, 63967.0, 64672.0, 65211.34788652148, 8736.737897862948, 8851.247643950208, 8932.763079371447, 9117.270618350516, 9121.954390228006, 19922.90038549827, 19983.800161998195, 20023.09896054681, 20050.799492004895, 20145.29491467821, 6448.838779030561, 6490.188726409199, 6644.8671026579195, 6649.667516624246, 6726.1256036715895, 3569.268299998546, 3586.1572530455323, 3595.748297619194, 3606.477060826218, 3657.561092668897, 2638.300850274679, 2752.1881045091745, 2758.5586306191312, 2759.751622353998, 2760.7653349465118, 474.7104266397564, 475.3369050174987, 485.4393175881862, 489.6596865178738, 493.3019777015483, 507.98984020319386, 512.0833707663242, 522.6393788286147, 529.7298377827336, 533.9880925645879, 7553.169151393342, 7996.800079998046, 8220.958895205486, 8261.876071858927, 8615.827683446296, 463.6036189058374, 532.1937265043463, 541.5694522854341, 553.0211525599747, 557.2616283424479, 3688.9262214755554, 3720.5907350191455, 3750.0999760057935, 3835.4055121456217, 3928.155446578999, 53278.73360633172, 86586.13413865906, 89006.55496722474, 91185.0, 91718.08281917228, 76269.61865190639, 76490.23509764942, 77606.6119669398, 79749.60125199337, 81377.18622813815, 67187.32812671909, 69554.30445695478, 70735.2926470739, 71287.58411743071, 72014.27985720076, 6721.764738234138, 7059.254746372929, 7071.032455979511, 7301.561906285639, 7328.193898671036, 39634.0, 40283.3957490632, 40490.39264410977, 41012.38481422721, 42338.364924525544, 33940.83029584836, 47184.7640761794, 57161.71419142878, 58312.70843645755, 60854.0, 8937.419067760575, 9248.445093294424, 9455.669051583161, 9519.52402379892, 9583.520823958635, 9806.460644664612, 9859.753506162404, 10080.395176289447, 10109.898901010896, 10145.34055286404, 9262.814743705223, 9364.765880853032, 9447.669331573363, 9505.95247023788, 9517.714468565953, 9290.256779457763, 9411.52942352866, 9433.151016408281, 9825.164860986895, 9844.950775246078, 9528.571214295513, 9620.903790962, 9653.324267301221, 9655.372400793925, 9674.467904265333, 7269.781906542812, 7507.873818927204, 7518.812029699301, 7773.533587984739, 7918.920810791818, 7475.0, 7711.26742959418, 7918.802029949297, 7998.600069996361, 8135.837283254184], "value": 5973.116794037181, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1603.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 116.0, 116.0, 118.0, 115.0, 115.0, 115.0, 117.0, 135.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 148.0, 184.0, 126.0, 161.0, 156.0, 125.0, 187.0, 130.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 165.0, 162.0, 162.0, 164.0, 164.0, 161.0, 167.0, 166.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 167.0, 78.0, 76.0, 75.0, 76.0, 166.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 142.0, 84.0, 85.0, 84.0, 144.0, 87.0, 85.0, 155.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 121.0, 117.0, 119.0, 119.0, 119.0, 118.0, 118.0, 118.0, 119.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 150.0, 150.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 95.0, 96.0, 98.0, 96.0, 96.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 66.0, 66.0, 67.0, 68.0, 66.0, 65.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 90.0, 87.0, 84.0, 86.0, 83.0, 85.0, 82.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 154.0, 147.0, 144.0, 138.0, 135.0, 135.0, 144.0, 191.0, 139.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 172.0, 179.0, 173.0, 176.0, 176.0, 172.0, 175.0, 173.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 70.0, 77.0, 69.0, 69.0, 69.0, 69.0, 70.0], "value": 70.4, "unit": "score"}]}]} 18:36:12 INFO - Return code: 0 18:36:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:36:12 ERROR - # TBPL SUCCESS # 18:36:12 INFO - Running post-action listener: _resource_record_post_action 18:36:12 INFO - [mozharness: 2016-08-30 01:36:12.128194Z] Finished run-tests step (success) 18:36:12 INFO - Running post-run listener: _resource_record_post_run 18:36:12 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 151552; Write bytes: 405196800; Read time: 140; Write time: 309600 18:36:12 INFO - TinderboxPrint: CPU usage
13.4% 18:36:12 INFO - TinderboxPrint: I/O read bytes / time
151,552 / 140 18:36:12 INFO - TinderboxPrint: I/O write bytes / time
405,196,800 / 309,600 18:36:12 INFO - TinderboxPrint: CPU idle
8,295.3 (86.6%) 18:36:12 INFO - TinderboxPrint: CPU user
1,219.2 (12.7%) 18:36:12 INFO - TinderboxPrint: Swap in / out
0 / 0 18:36:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113668096; Read time: 0; Write time: 86708 18:36:12 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 151552; Write bytes: 291528704; Read time: 140; Write time: 222892 18:36:12 INFO - Running post-run listener: _upload_blobber_files 18:36:12 INFO - Blob upload gear active. 18:36:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:36: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 18:36: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:36: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:36:13 INFO - (blobuploader) - INFO - Open directory for files ... 18:36:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:36:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:14 INFO - (blobuploader) - INFO - Done attempting. 18:36:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:36:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:36:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:17 INFO - (blobuploader) - INFO - Done attempting. 18:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:36:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:36:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:36:18 INFO - (blobuploader) - INFO - Done attempting. 18:36:18 INFO - (blobuploader) - INFO - Iteration through files over. 18:36:18 INFO - Return code: 0 18:36:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:36:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:36:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9663c19cb397948fd4e94ad71b11bdf861bf266b60b82f1b610561af6f8cbe2fe6a71e4f9dc041f366f46c8719d0f7559fa80345e0093b5c338307e00bda4819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2ea2fd850471bbd09fccd5f295c91748e8fb12fe0617cda8bd69b7eb9baab8535de0d36e26c1568b597c7eb38b49ff4e23943a64af7d0bd4a70c896d02227a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcf263a89b44437e07a51411ae92db4b483f17f89fb5b88af943889a3dd8872a350e96cf79215ad22a767adee2a1ec48c7941201e359ff35f5dcfa46224d3c67"} 18:36:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:36:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:36:18 INFO - Contents: 18:36:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9663c19cb397948fd4e94ad71b11bdf861bf266b60b82f1b610561af6f8cbe2fe6a71e4f9dc041f366f46c8719d0f7559fa80345e0093b5c338307e00bda4819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2ea2fd850471bbd09fccd5f295c91748e8fb12fe0617cda8bd69b7eb9baab8535de0d36e26c1568b597c7eb38b49ff4e23943a64af7d0bd4a70c896d02227a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcf263a89b44437e07a51411ae92db4b483f17f89fb5b88af943889a3dd8872a350e96cf79215ad22a767adee2a1ec48c7941201e359ff35f5dcfa46224d3c67"} 18:36:18 INFO - Running post-run listener: copy_logs_to_upload_dir 18:36:18 INFO - Copying logs to upload dir... 18:36:18 INFO - mkdir: /builds/slave/test/build/upload/logs 18:36:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.181148 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-29 18:36:18.411983) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 18:36:18.415061) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929 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-Non-PGO/sha512/9663c19cb397948fd4e94ad71b11bdf861bf266b60b82f1b610561af6f8cbe2fe6a71e4f9dc041f366f46c8719d0f7559fa80345e0093b5c338307e00bda4819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2ea2fd850471bbd09fccd5f295c91748e8fb12fe0617cda8bd69b7eb9baab8535de0d36e26c1568b597c7eb38b49ff4e23943a64af7d0bd4a70c896d02227a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcf263a89b44437e07a51411ae92db4b483f17f89fb5b88af943889a3dd8872a350e96cf79215ad22a767adee2a1ec48c7941201e359ff35f5dcfa46224d3c67"} build_url:https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/Er5BLUC3Siidl0rw56MISQ/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-Non-PGO/sha512/9663c19cb397948fd4e94ad71b11bdf861bf266b60b82f1b610561af6f8cbe2fe6a71e4f9dc041f366f46c8719d0f7559fa80345e0093b5c338307e00bda4819", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a2ea2fd850471bbd09fccd5f295c91748e8fb12fe0617cda8bd69b7eb9baab8535de0d36e26c1568b597c7eb38b49ff4e23943a64af7d0bd4a70c896d02227a7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dcf263a89b44437e07a51411ae92db4b483f17f89fb5b88af943889a3dd8872a350e96cf79215ad22a767adee2a1ec48c7941201e359ff35f5dcfa46224d3c67"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 18:36:18.440107) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:36:18.440428) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1472515813.237537-1862474929 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 18:36:18.524746) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 18:36:18.525153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 18:36:18.525468) ========= ========= Total master_lag: 0.49 =========