builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1471660235.61 results: success (0) buildid: 20160819181715 builduid: 08c5c470a89e447fb81d794f50295f7a revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.611943) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.612583) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.612957) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.656938) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.657480) ========= 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=cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-19 19:30:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.0M=0s 2016-08-19 19:30:35 (40.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157965 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.843750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.844029) ========= 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=cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021974 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.897707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:35.898032) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f97a056ae6235de7855fd8aaa04fb1c8d183bd06 --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 f97a056ae6235de7855fd8aaa04fb1c8d183bd06 --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=cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-19 19:30:36,100 truncating revision to first 12 chars 2016-08-19 19:30:36,100 Setting DEBUG logging. 2016-08-19 19:30:36,100 attempt 1/10 2016-08-19 19:30:36,100 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f97a056ae623?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-19 19:30:36,623 unpacking tar archive at: mozilla-central-f97a056ae623/testing/mozharness/ program finished with exit code 0 elapsedTime=0.839344 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:36.751170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:36.751476) ========= script_repo_revision: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:36.751900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:36.752157) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-19 19:30:36.763160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-19 19:30:36.763462) ========= /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=cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:30:37 INFO - MultiFileLogger online at 20160819 19:30:37 in /builds/slave/test 19:30:37 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 19:30:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:30:37 INFO - {'append_to_log': False, 19:30:37 INFO - 'base_work_dir': '/builds/slave/test', 19:30:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:30:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:30:37 INFO - 'branch': 'Firefox-Non-PGO', 19:30:37 INFO - 'buildbot_json_path': 'buildprops.json', 19:30:37 INFO - 'config_files': ('talos/linux_config.py',), 19:30:37 INFO - 'default_actions': ('clobber', 19:30:37 INFO - 'read-buildbot-config', 19:30:37 INFO - 'download-and-extract', 19:30:37 INFO - 'populate-webroot', 19:30:37 INFO - 'create-virtualenv', 19:30:37 INFO - 'install', 19:30:37 INFO - 'run-tests'), 19:30:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:30:37 INFO - 'download_minidump_stackwalk': True, 19:30:37 INFO - 'download_symbols': 'ondemand', 19:30:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:30:37 INFO - 'tooltool.py': '/tools/tooltool.py', 19:30:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:30:37 INFO - '/tools/misc-python/virtualenv.py')}, 19:30:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:30:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:30:37 INFO - 'installer_path': 'installer.exe', 19:30:37 INFO - 'log_level': 'info', 19:30:37 INFO - 'log_name': 'talos', 19:30:37 INFO - 'log_to_console': True, 19:30:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:30:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:30:37 INFO - 'opt_config_files': (), 19:30:37 INFO - 'pip_index': False, 19:30:37 INFO - 'sps_profile': False, 19:30:37 INFO - 'sps_profile_interval': 0, 19:30:37 INFO - 'suite': 'dromaeojs-e10s', 19:30:37 INFO - 'system_bits': '32', 19:30:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:30:37 INFO - 'title': 'talos-linux64-ix-054', 19:30:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:30:37 INFO - 'use_talos_json': True, 19:30:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:30:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:30:37 INFO - 'work_dir': 'build'} 19:30:37 INFO - [mozharness: 2016-08-20 02:30:37.172683Z] Running clobber step. 19:30:37 INFO - Running pre-action listener: _resource_record_pre_action 19:30:37 INFO - Running main action method: clobber 19:30:37 INFO - rmtree: /builds/slave/test/build 19:30:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:30:37 INFO - Running post-action listener: _resource_record_post_action 19:30:37 INFO - [mozharness: 2016-08-20 02:30:37.581299Z] Finished clobber step (success) 19:30:37 INFO - [mozharness: 2016-08-20 02:30:37.581399Z] Running read-buildbot-config step. 19:30:37 INFO - Running pre-action listener: _resource_record_pre_action 19:30:37 INFO - Running main action method: read_buildbot_config 19:30:37 INFO - Using buildbot properties: 19:30:37 INFO - { 19:30:37 INFO - "project": "", 19:30:37 INFO - "product": "firefox", 19:30:37 INFO - "script_repo_revision": "production", 19:30:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:30:37 INFO - "repository": "", 19:30:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:30:37 INFO - "buildid": "20160819181715", 19:30:37 INFO - "pgo_build": "False", 19:30:37 INFO - "basedir": "/builds/slave/test", 19:30:37 INFO - "buildnumber": 429, 19:30:37 INFO - "slavename": "talos-linux64-ix-054", 19:30:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:30:37 INFO - "platform": "ubuntu64_hw", 19:30:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:30:37 INFO - "branch": "mozilla-central", 19:30:37 INFO - "repo_path": "mozilla-central", 19:30:37 INFO - "revision": "f97a056ae6235de7855fd8aaa04fb1c8d183bd06", 19:30:37 INFO - "stage_platform": "linux64", 19:30:37 INFO - "builduid": "08c5c470a89e447fb81d794f50295f7a", 19:30:37 INFO - "slavebuilddir": "test" 19:30:37 INFO - } 19:30:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 19:30:37 INFO - Running post-action listener: _resource_record_post_action 19:30:37 INFO - [mozharness: 2016-08-20 02:30:37.583810Z] Finished read-buildbot-config step (success) 19:30:37 INFO - [mozharness: 2016-08-20 02:30:37.583898Z] Running download-and-extract step. 19:30:37 INFO - Running pre-action listener: _resource_record_pre_action 19:30:37 INFO - Running main action method: download_and_extract 19:30:37 INFO - mkdir: /builds/slave/test/build/tests 19:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:37 INFO - trying https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:30:37 INFO - Downloading https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:38 INFO - Downloaded 1361 bytes. 19:30:38 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 19:30:38 INFO - Using the following test package requirements: 19:30:38 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:38 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:30:38 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:30:38 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'jsshell-linux-x86_64.zip'], 19:30:38 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:30:38 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:38 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:30:38 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:30:38 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:30:38 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:38 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:30:38 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:30:38 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')]} 19:30:38 INFO - trying https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:30:38 INFO - Downloading https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:40 INFO - Downloaded 20330094 bytes. 19:30:40 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 19:30:44 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 19:30:44 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')]} 19:30:44 INFO - trying https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 19:30:44 INFO - Downloading https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:45 INFO - Downloaded 20330094 bytes. 19:30:45 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 19:30:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:50 INFO - trying https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 19:30:50 INFO - Downloading https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:51 INFO - Downloaded 14413981 bytes. 19:30:51 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 19:30: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')]} 19:30:51 INFO - trying https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:30:51 INFO - Downloading https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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 19:30:53 INFO - Downloaded 55792234 bytes. 19:30:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:30:53 INFO - mkdir: /builds/slave/test/properties 19:30:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:30:53 INFO - Writing to file /builds/slave/test/properties/build_url 19:30:53 INFO - Contents: 19:30:53 INFO - build_url:https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 19:30:54 INFO - Running post-action listener: _resource_record_post_action 19:30:54 INFO - Running post-action listener: set_extra_try_arguments 19:30:54 INFO - [mozharness: 2016-08-20 02:30:54.449679Z] Finished download-and-extract step (success) 19:30:54 INFO - [mozharness: 2016-08-20 02:30:54.449913Z] Running populate-webroot step. 19:30:54 INFO - Running pre-action listener: _resource_record_pre_action 19:30:54 INFO - Running main action method: populate_webroot 19:30:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:30:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:30:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:30:54 INFO - '--tppagecycles', 19:30:54 INFO - '7'], 19:30:54 INFO - 'tests': ['tsvgm']}}, 19:30:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:30:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:30:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:30:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:30:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['damp', 'tps']}, 19:30:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'tests': ['damp', 'tps']}, 19:30:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['dromaeo_dom']}, 19:30:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:30:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['basic_compositor_video']}, 19:30:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:30:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['a11yr', 19:30:54 INFO - 'ts_paint', 19:30:54 INFO - 'tpaint', 19:30:54 INFO - 'sessionrestore', 19:30:54 INFO - 'sessionrestore_no_auto_restore', 19:30:54 INFO - 'tabpaint']}, 19:30:54 INFO - 'other-e10s': {'tests': ['a11yr', 19:30:54 INFO - 'ts_paint', 19:30:54 INFO - 'tpaint', 19:30:54 INFO - 'sessionrestore', 19:30:54 INFO - 'sessionrestore_no_auto_restore', 19:30:54 INFO - 'tabpaint']}, 19:30:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:30:54 INFO - 'ts_paint', 19:30:54 INFO - 'tpaint', 19:30:54 INFO - 'sessionrestore', 19:30:54 INFO - 'sessionrestore_no_auto_restore', 19:30:54 INFO - 'tabpaint']}, 19:30:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:30:54 INFO - 'ts_paint', 19:30:54 INFO - 'tpaint', 19:30:54 INFO - 'sessionrestore', 19:30:54 INFO - 'sessionrestore_no_auto_restore', 19:30:54 INFO - 'tabpaint']}, 19:30:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['a11yr', 19:30:54 INFO - 'ts_paint', 19:30:54 INFO - 'tpaint', 19:30:54 INFO - 'sessionrestore', 19:30:54 INFO - 'sessionrestore_no_auto_restore', 19:30:54 INFO - 'tabpaint']}, 19:30:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['a11yr', 19:30:54 INFO - 'ts_paint', 19:30:54 INFO - 'tpaint', 19:30:54 INFO - 'sessionrestore', 19:30:54 INFO - 'sessionrestore_no_auto_restore', 19:30:54 INFO - 'tabpaint']}, 19:30:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['tsvgx', 19:30:54 INFO - 'tsvgr_opacity', 19:30:54 INFO - 'tart', 19:30:54 INFO - 'tscrollx', 19:30:54 INFO - 'cart']}, 19:30:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:30:54 INFO - 'tsvgr_opacity', 19:30:54 INFO - 'tart', 19:30:54 INFO - 'tscrollx', 19:30:54 INFO - 'cart']}, 19:30:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'talos_options': ['--disable-e10s'], 19:30:54 INFO - 'tests': ['tp5o']}, 19:30:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'tests': ['tp5o']}, 19:30:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'talos_options': ['--disable-e10s', 19:30:54 INFO - '--xperf_path', 19:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:54 INFO - 'tests': ['tp5n']}, 19:30:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:30:54 INFO - 'talos_options': ['--xperf_path', 19:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:54 INFO - 'tests': ['tp5n']}}, 19:30:54 INFO - 'talos.zip': {'path': '', 19:30:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:30:54 INFO - Running post-action listener: _resource_record_post_action 19:30:54 INFO - [mozharness: 2016-08-20 02:30:54.470575Z] Finished populate-webroot step (success) 19:30:54 INFO - [mozharness: 2016-08-20 02:30:54.470663Z] Running create-virtualenv step. 19:30:54 INFO - Running pre-action listener: _resource_record_pre_action 19:30:54 INFO - Running main action method: create_virtualenv 19:30:54 INFO - Creating virtualenv /builds/slave/test/build/venv 19:30:54 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 19:30:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:30:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:30:54 INFO - Using real prefix '/usr' 19:30:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:30:55 INFO - Installing distribute.............................................................................................................................................................................................done. 19:30:57 INFO - Installing pip.................done. 19:30:57 INFO - Return code: 0 19:30:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:30:57 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')]} 19:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:57 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')]} 19:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:57 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 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:30:57 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 19:30:57 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 19:30:57 INFO - Using env: {'DISPLAY': ':0', 19:30:57 INFO - 'HOME': '/home/cltbld', 19:30:57 INFO - 'LANG': 'en_US.UTF-8', 19:30:57 INFO - 'LANGUAGE': 'en_US:en', 19:30:57 INFO - 'LOGNAME': 'cltbld', 19:30:57 INFO - 'MAIL': '/var/mail/cltbld', 19:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:57 INFO - 'MOZ_NO_REMOTE': '1', 19:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:57 INFO - 'NO_EM_RESTART': '1', 19:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:57 INFO - 'PWD': '/builds/slave/test', 19:30:57 INFO - 'SHELL': '/bin/bash', 19:30:57 INFO - 'SHLVL': '1', 19:30:57 INFO - 'TERM': 'linux', 19:30:57 INFO - 'TMOUT': '86400', 19:30:57 INFO - 'USER': 'cltbld', 19:30:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:57 INFO - '_': '/tools/buildbot/bin/python'} 19:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:57 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 19:30:57 INFO - Cleaning up... 19:30:57 INFO - Return code: 0 19:30:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:30:57 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')]} 19:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:57 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')]} 19:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:57 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 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:30:57 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 19:30:57 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 19:30:57 INFO - Using env: {'DISPLAY': ':0', 19:30:57 INFO - 'HOME': '/home/cltbld', 19:30:57 INFO - 'LANG': 'en_US.UTF-8', 19:30:57 INFO - 'LANGUAGE': 'en_US:en', 19:30:57 INFO - 'LOGNAME': 'cltbld', 19:30:57 INFO - 'MAIL': '/var/mail/cltbld', 19:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:57 INFO - 'MOZ_NO_REMOTE': '1', 19:30:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:57 INFO - 'NO_EM_RESTART': '1', 19:30:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:57 INFO - 'PWD': '/builds/slave/test', 19:30:57 INFO - 'SHELL': '/bin/bash', 19:30:57 INFO - 'SHLVL': '1', 19:30:57 INFO - 'TERM': 'linux', 19:30:57 INFO - 'TMOUT': '86400', 19:30:57 INFO - 'USER': 'cltbld', 19:30:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:57 INFO - '_': '/tools/buildbot/bin/python'} 19:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:57 INFO - Downloading/unpacking psutil>=3.1.1 19:30: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 19:30: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 19:30: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 19:30: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 19:30: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 19:30: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 19:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:30:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:59 INFO - Installing collected packages: psutil 19:30:59 INFO - Running setup.py install for psutil 19:30:59 INFO - building 'psutil._psutil_linux' extension 19:30:59 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 19:31:01 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 19:31:01 INFO - building 'psutil._psutil_posix' extension 19:31:01 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 19:31:01 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 19:31:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:31:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:31:01 INFO - Successfully installed psutil 19:31:01 INFO - Cleaning up... 19:31:01 INFO - Return code: 0 19:31:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:31:01 INFO - Using env: {'DISPLAY': ':0', 19:31:01 INFO - 'HOME': '/home/cltbld', 19:31:01 INFO - 'LANG': 'en_US.UTF-8', 19:31:01 INFO - 'LANGUAGE': 'en_US:en', 19:31:01 INFO - 'LOGNAME': 'cltbld', 19:31:01 INFO - 'MAIL': '/var/mail/cltbld', 19:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:01 INFO - 'MOZ_NO_REMOTE': '1', 19:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:01 INFO - 'NO_EM_RESTART': '1', 19:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:01 INFO - 'PWD': '/builds/slave/test', 19:31:01 INFO - 'SHELL': '/bin/bash', 19:31:01 INFO - 'SHLVL': '1', 19:31:01 INFO - 'TERM': 'linux', 19:31:01 INFO - 'TMOUT': '86400', 19:31:01 INFO - 'USER': 'cltbld', 19:31:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:01 INFO - '_': '/tools/buildbot/bin/python'} 19:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31: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 19:31:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:31:03 INFO - Installing collected packages: mozsystemmonitor 19:31:03 INFO - Running setup.py install for mozsystemmonitor 19:31:03 INFO - Successfully installed mozsystemmonitor 19:31:03 INFO - Cleaning up... 19:31:03 INFO - Return code: 0 19:31:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:31: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')]} 19:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31: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')]} 19:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:31:03 INFO - Using env: {'DISPLAY': ':0', 19:31:03 INFO - 'HOME': '/home/cltbld', 19:31:03 INFO - 'LANG': 'en_US.UTF-8', 19:31:03 INFO - 'LANGUAGE': 'en_US:en', 19:31:03 INFO - 'LOGNAME': 'cltbld', 19:31:03 INFO - 'MAIL': '/var/mail/cltbld', 19:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:03 INFO - 'MOZ_NO_REMOTE': '1', 19:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:03 INFO - 'NO_EM_RESTART': '1', 19:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:03 INFO - 'PWD': '/builds/slave/test', 19:31:03 INFO - 'SHELL': '/bin/bash', 19:31:03 INFO - 'SHLVL': '1', 19:31:03 INFO - 'TERM': 'linux', 19:31:03 INFO - 'TMOUT': '86400', 19:31:03 INFO - 'USER': 'cltbld', 19:31:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:03 INFO - '_': '/tools/buildbot/bin/python'} 19:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:03 INFO - Downloading/unpacking jsonschema==2.5.1 19:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:31:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:05 INFO - Downloading functools32-3.2.3-2.tar.gz 19:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:31:06 INFO - warning: no files found matching '*.txt' 19:31:06 INFO - no previously-included directories found matching 'build' 19:31:06 INFO - no previously-included directories found matching 'dist' 19:31:06 INFO - no previously-included directories found matching '.git*' 19:31:06 INFO - Installing collected packages: jsonschema, functools32 19:31:06 INFO - Running setup.py install for functools32 19:31:06 INFO - warning: no files found matching '*.txt' 19:31:06 INFO - no previously-included directories found matching 'build' 19:31:06 INFO - no previously-included directories found matching 'dist' 19:31:06 INFO - no previously-included directories found matching '.git*' 19:31:06 INFO - Successfully installed jsonschema functools32 19:31:06 INFO - Cleaning up... 19:31:06 INFO - Return code: 0 19:31:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:31: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')]} 19:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31: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')]} 19:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:31:06 INFO - Using env: {'DISPLAY': ':0', 19:31:06 INFO - 'HOME': '/home/cltbld', 19:31:06 INFO - 'LANG': 'en_US.UTF-8', 19:31:06 INFO - 'LANGUAGE': 'en_US:en', 19:31:06 INFO - 'LOGNAME': 'cltbld', 19:31:06 INFO - 'MAIL': '/var/mail/cltbld', 19:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:06 INFO - 'MOZ_NO_REMOTE': '1', 19:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:06 INFO - 'NO_EM_RESTART': '1', 19:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:06 INFO - 'PWD': '/builds/slave/test', 19:31:06 INFO - 'SHELL': '/bin/bash', 19:31:06 INFO - 'SHLVL': '1', 19:31:06 INFO - 'TERM': 'linux', 19:31:06 INFO - 'TMOUT': '86400', 19:31:06 INFO - 'USER': 'cltbld', 19:31:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:06 INFO - '_': '/tools/buildbot/bin/python'} 19:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:31:06 INFO - Cleaning up... 19:31:06 INFO - Return code: 0 19:31:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:31: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')]} 19:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31: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')]} 19:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:31:06 INFO - Using env: {'DISPLAY': ':0', 19:31:06 INFO - 'HOME': '/home/cltbld', 19:31:06 INFO - 'LANG': 'en_US.UTF-8', 19:31:06 INFO - 'LANGUAGE': 'en_US:en', 19:31:06 INFO - 'LOGNAME': 'cltbld', 19:31:06 INFO - 'MAIL': '/var/mail/cltbld', 19:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:06 INFO - 'MOZ_NO_REMOTE': '1', 19:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:06 INFO - 'NO_EM_RESTART': '1', 19:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:06 INFO - 'PWD': '/builds/slave/test', 19:31:06 INFO - 'SHELL': '/bin/bash', 19:31:06 INFO - 'SHLVL': '1', 19:31:06 INFO - 'TERM': 'linux', 19:31:06 INFO - 'TMOUT': '86400', 19:31:06 INFO - 'USER': 'cltbld', 19:31:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:06 INFO - '_': '/tools/buildbot/bin/python'} 19:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:06 INFO - Downloading/unpacking blobuploader==1.2.4 19:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:31:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:31:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:31:09 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 19:31:09 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 19:31:09 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 19:31:09 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 19:31:09 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 19:31:09 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 19:31:09 INFO - Downloading docopt-0.6.1.tar.gz 19:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:31:09 INFO - Installing collected packages: blobuploader, requests, docopt 19:31:09 INFO - Running setup.py install for blobuploader 19:31:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:31:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:31:09 INFO - Running setup.py install for requests 19:31:09 INFO - Running setup.py install for docopt 19:31:09 INFO - Successfully installed blobuploader requests docopt 19:31:09 INFO - Cleaning up... 19:31:09 INFO - Return code: 0 19:31:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:31:09 INFO - Using env: {'DISPLAY': ':0', 19:31:09 INFO - 'HOME': '/home/cltbld', 19:31:09 INFO - 'LANG': 'en_US.UTF-8', 19:31:09 INFO - 'LANGUAGE': 'en_US:en', 19:31:09 INFO - 'LOGNAME': 'cltbld', 19:31:09 INFO - 'MAIL': '/var/mail/cltbld', 19:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:09 INFO - 'MOZ_NO_REMOTE': '1', 19:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:09 INFO - 'NO_EM_RESTART': '1', 19:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:09 INFO - 'PWD': '/builds/slave/test', 19:31:09 INFO - 'SHELL': '/bin/bash', 19:31:09 INFO - 'SHLVL': '1', 19:31:09 INFO - 'TERM': 'linux', 19:31:09 INFO - 'TMOUT': '86400', 19:31:09 INFO - 'USER': 'cltbld', 19:31:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:09 INFO - '_': '/tools/buildbot/bin/python'} 19:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:31:10 INFO - Running setup.py (path:/tmp/pip-avGPXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:31:10 INFO - Running setup.py (path:/tmp/pip-ZGrIt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:31:10 INFO - Running setup.py (path:/tmp/pip-x6oQEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:31:10 INFO - Running setup.py (path:/tmp/pip-9Khnef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:31:10 INFO - Running setup.py (path:/tmp/pip-Nqxbzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:31:10 INFO - Running setup.py (path:/tmp/pip-H7f8sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:31:10 INFO - Running setup.py (path:/tmp/pip-TMd126-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:31:10 INFO - Running setup.py (path:/tmp/pip-FeRMpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:31:10 INFO - Running setup.py (path:/tmp/pip-kF_7b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:31:10 INFO - Running setup.py (path:/tmp/pip-5kdlX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:31:10 INFO - Running setup.py (path:/tmp/pip-YuJlx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:31:10 INFO - Running setup.py (path:/tmp/pip-_qqdI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:31:11 INFO - Running setup.py (path:/tmp/pip-hmuUW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:31:11 INFO - Running setup.py (path:/tmp/pip-RHkxEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:11 INFO - Running setup.py (path:/tmp/pip-v7LwpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:31:11 INFO - Running setup.py (path:/tmp/pip-h5CmWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:31:11 INFO - Running setup.py (path:/tmp/pip-QPekjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:31:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:31:11 INFO - Running setup.py install for manifestparser 19:31:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:31:11 INFO - Running setup.py install for mozcrash 19:31:11 INFO - Running setup.py install for mozdebug 19:31:11 INFO - Running setup.py install for mozdevice 19:31:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:31:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:31:11 INFO - Running setup.py install for mozfile 19:31:11 INFO - Running setup.py install for mozhttpd 19:31:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Running setup.py install for mozinfo 19:31:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Running setup.py install for mozInstall 19:31:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Running setup.py install for mozleak 19:31:12 INFO - Running setup.py install for mozlog 19:31:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Running setup.py install for moznetwork 19:31:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Running setup.py install for mozprocess 19:31:12 INFO - Running setup.py install for mozprofile 19:31:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Running setup.py install for mozrunner 19:31:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:31:12 INFO - Running setup.py install for mozscreenshot 19:31:12 INFO - Running setup.py install for moztest 19:31:13 INFO - Running setup.py install for mozversion 19:31:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:31:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:31:13 INFO - Cleaning up... 19:31:13 INFO - Return code: 0 19:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:13 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 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:13 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 19:31:13 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 19:31:13 INFO - Using env: {'DISPLAY': ':0', 19:31:13 INFO - 'HOME': '/home/cltbld', 19:31:13 INFO - 'LANG': 'en_US.UTF-8', 19:31:13 INFO - 'LANGUAGE': 'en_US:en', 19:31:13 INFO - 'LOGNAME': 'cltbld', 19:31:13 INFO - 'MAIL': '/var/mail/cltbld', 19:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:13 INFO - 'MOZ_NO_REMOTE': '1', 19:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:13 INFO - 'NO_EM_RESTART': '1', 19:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:13 INFO - 'PWD': '/builds/slave/test', 19:31:13 INFO - 'SHELL': '/bin/bash', 19:31:13 INFO - 'SHLVL': '1', 19:31:13 INFO - 'TERM': 'linux', 19:31:13 INFO - 'TMOUT': '86400', 19:31:13 INFO - 'USER': 'cltbld', 19:31:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:13 INFO - '_': '/tools/buildbot/bin/python'} 19:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:31:13 INFO - Running setup.py (path:/tmp/pip-m90MFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:31:13 INFO - Running setup.py (path:/tmp/pip-2gEMSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:31:13 INFO - Running setup.py (path:/tmp/pip-LkaVCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:31:13 INFO - Running setup.py (path:/tmp/pip-Sz6eP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:31:13 INFO - Running setup.py (path:/tmp/pip-dMd2q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:31:13 INFO - Running setup.py (path:/tmp/pip-NCsC6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:31:13 INFO - Running setup.py (path:/tmp/pip-o3S_Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:31:13 INFO - Running setup.py (path:/tmp/pip-LMf5hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:31:13 INFO - Running setup.py (path:/tmp/pip-mj4FqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:31:14 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)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:31:14 INFO - Running setup.py (path:/tmp/pip-zIEQWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:31:14 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)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:31:14 INFO - Running setup.py (path:/tmp/pip-nOPN7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:31:14 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)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:31:14 INFO - Running setup.py (path:/tmp/pip-BfpJgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:31:14 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)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:31:14 INFO - Running setup.py (path:/tmp/pip-H3rkRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:31:14 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)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:31:14 INFO - Running setup.py (path:/tmp/pip-_ImYUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:14 INFO - Running setup.py (path:/tmp/pip-ejaBxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:31:14 INFO - Running setup.py (path:/tmp/pip-o4lyf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:31:14 INFO - Running setup.py (path:/tmp/pip-OYR238-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:31:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:31:16 INFO - Downloading blessings-1.6.tar.gz 19:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:31:16 INFO - Installing collected packages: blessings 19:31:16 INFO - Running setup.py install for blessings 19:31:16 INFO - Successfully installed blessings 19:31:16 INFO - Cleaning up... 19:31:16 INFO - Return code: 0 19:31:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:31:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:31:17 INFO - Reading from file tmpfile_stdout 19:31:17 INFO - Current package versions: 19:31:17 INFO - argparse == 1.2.1 19:31:17 INFO - blessings == 1.6 19:31:17 INFO - blobuploader == 1.2.4 19:31:17 INFO - docopt == 0.6.1 19:31:17 INFO - functools32 == 3.2.3-2 19:31:17 INFO - jsonschema == 2.5.1 19:31:17 INFO - manifestparser == 1.1 19:31:17 INFO - mozInstall == 1.12 19:31:17 INFO - mozcrash == 0.17 19:31:17 INFO - mozdebug == 0.1 19:31:17 INFO - mozdevice == 0.48 19:31:17 INFO - mozfile == 1.2 19:31:17 INFO - mozhttpd == 0.7 19:31:17 INFO - mozinfo == 0.9 19:31:17 INFO - mozleak == 0.1 19:31:17 INFO - mozlog == 3.3 19:31:17 INFO - moznetwork == 0.27 19:31:17 INFO - mozprocess == 0.23 19:31:17 INFO - mozprofile == 0.28 19:31:17 INFO - mozrunner == 6.12 19:31:17 INFO - mozscreenshot == 0.1 19:31:17 INFO - mozsystemmonitor == 0.3 19:31:17 INFO - moztest == 0.7 19:31:17 INFO - mozversion == 1.4 19:31:17 INFO - psutil == 3.1.1 19:31:17 INFO - requests == 1.2.3 19:31:17 INFO - wsgiref == 0.1.2 19:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:17 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 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:17 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 19:31:17 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 19:31:17 INFO - Using env: {'DISPLAY': ':0', 19:31:17 INFO - 'HOME': '/home/cltbld', 19:31:17 INFO - 'LANG': 'en_US.UTF-8', 19:31:17 INFO - 'LANGUAGE': 'en_US:en', 19:31:17 INFO - 'LOGNAME': 'cltbld', 19:31:17 INFO - 'MAIL': '/var/mail/cltbld', 19:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:17 INFO - 'MOZ_NO_REMOTE': '1', 19:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:17 INFO - 'NO_EM_RESTART': '1', 19:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:17 INFO - 'PWD': '/builds/slave/test', 19:31:17 INFO - 'SHELL': '/bin/bash', 19:31:17 INFO - 'SHLVL': '1', 19:31:17 INFO - 'TERM': 'linux', 19:31:17 INFO - 'TMOUT': '86400', 19:31:17 INFO - 'USER': 'cltbld', 19:31:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:17 INFO - '_': '/tools/buildbot/bin/python'} 19:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 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)) 19:31:17 INFO - Cleaning up... 19:31:17 INFO - Return code: 0 19:31:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:17 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 0x7fe435463f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x270b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27da230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, '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': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', '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 19:31:17 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 19:31:17 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 19:31:17 INFO - Using env: {'DISPLAY': ':0', 19:31:17 INFO - 'HOME': '/home/cltbld', 19:31:17 INFO - 'LANG': 'en_US.UTF-8', 19:31:17 INFO - 'LANGUAGE': 'en_US:en', 19:31:17 INFO - 'LOGNAME': 'cltbld', 19:31:17 INFO - 'MAIL': '/var/mail/cltbld', 19:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:17 INFO - 'MOZ_NO_REMOTE': '1', 19:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:17 INFO - 'NO_EM_RESTART': '1', 19:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:17 INFO - 'PWD': '/builds/slave/test', 19:31:17 INFO - 'SHELL': '/bin/bash', 19:31:17 INFO - 'SHLVL': '1', 19:31:17 INFO - 'TERM': 'linux', 19:31:17 INFO - 'TMOUT': '86400', 19:31:17 INFO - 'USER': 'cltbld', 19:31:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:17 INFO - '_': '/tools/buildbot/bin/python'} 19:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:31:17 INFO - Cleaning up... 19:31:17 INFO - Return code: 0 19:31:17 INFO - Running post-action listener: _resource_record_post_action 19:31:17 INFO - Running post-action listener: _start_resource_monitoring 19:31:17 INFO - Starting resource monitoring. 19:31:17 INFO - [mozharness: 2016-08-20 02:31:17.518125Z] Finished create-virtualenv step (success) 19:31:17 INFO - [mozharness: 2016-08-20 02:31:17.519127Z] Running install step. 19:31:17 INFO - Running pre-action listener: _resource_record_pre_action 19:31:17 INFO - Running main action method: install 19:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:31:17 INFO - Reading from file tmpfile_stdout 19:31:17 INFO - Detecting whether we're running mozinstall >=1.0... 19:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:31:17 INFO - Reading from file tmpfile_stdout 19:31:17 INFO - Output received: 19:31:17 INFO - Usage: mozinstall [options] installer 19:31:17 INFO - Options: 19:31:17 INFO - -h, --help show this help message and exit 19:31:17 INFO - -d DEST, --destination=DEST 19:31:17 INFO - Directory to install application into. [default: 19:31:17 INFO - "/builds/slave/test"] 19:31:17 INFO - --app=APP Application being installed. [default: firefox] 19:31:17 INFO - mkdir: /builds/slave/test/build/application 19:31:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:31:33 INFO - Reading from file tmpfile_stdout 19:31:33 INFO - Output received: 19:31:33 INFO - /builds/slave/test/build/application/firefox/firefox 19:31:33 INFO - Running post-action listener: _resource_record_post_action 19:31:33 INFO - [mozharness: 2016-08-20 02:31:33.907662Z] Finished install step (success) 19:31:33 INFO - [mozharness: 2016-08-20 02:31:33.907914Z] Running run-tests step. 19:31:33 INFO - Running pre-action listener: _resource_record_pre_action 19:31:33 INFO - Running main action method: run_tests 19:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:31:33 INFO - Python 2.7.3 19:31:33 INFO - Return code: 0 19:31:33 INFO - grabbing minidump binary from tooltool 19:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:33 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 0x27d4090>, '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 0x27d79b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27d7e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:31:33 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 19:31:33 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 19:31:33 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 19:31:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:31:34 INFO - Return code: 0 19:31:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:31:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:31:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:31:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:31:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:31:34 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/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 19:31:34 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/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 19:31:34 INFO - Using env: {'DISPLAY': ':0', 19:31:34 INFO - 'HOME': '/home/cltbld', 19:31:34 INFO - 'LANG': 'en_US.UTF-8', 19:31:34 INFO - 'LANGUAGE': 'en_US:en', 19:31:34 INFO - 'LOGNAME': 'cltbld', 19:31:34 INFO - 'MAIL': '/var/mail/cltbld', 19:31:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:31:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:34 INFO - 'MOZ_NO_REMOTE': '1', 19:31:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:34 INFO - 'NO_EM_RESTART': '1', 19:31:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:34 INFO - 'PWD': '/builds/slave/test', 19:31:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:31:34 INFO - 'SHELL': '/bin/bash', 19:31:34 INFO - 'SHLVL': '1', 19:31:34 INFO - 'TERM': 'linux', 19:31:34 INFO - 'TMOUT': '86400', 19:31:34 INFO - 'USER': 'cltbld', 19:31:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683', 19:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:34 INFO - '_': '/tools/buildbot/bin/python'} 19:31:34 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/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 19:31:34 INFO - mozversion application_buildid: 20160819181715 19:31:34 INFO - mozversion application_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 19:31:34 INFO - mozversion application_display_name: Nightly 19:31:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:31:34 INFO - mozversion application_name: Firefox 19:31:34 INFO - mozversion application_remotingname: firefox 19:31:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:31:34 INFO - mozversion application_vendor: Mozilla 19:31:34 INFO - mozversion application_version: 51.0a1 19:31:34 INFO - mozversion platform_buildid: 20160819181715 19:31:34 INFO - mozversion platform_changeset: f97a056ae6235de7855fd8aaa04fb1c8d183bd06 19:31:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:31:34 INFO - mozversion platform_version: 51.0a1 19:31:34 INFO - using testdate: 1471660294 19:31:34 INFO - actual date: 1471660294 19:31:34 INFO - starting webserver on 'localhost:35745' 19:31:34 INFO - SUITE-START | Running 2 tests 19:31:34 INFO - TEST-START | dromaeo_css 19:31:34 INFO - operating with platform_type : linux_ 19:31:34 INFO - Initialising browser for dromaeo_css test... 19:31:34 INFO - TEST-INFO | started process 3326 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmrx7h/profile http://localhost:35745/getInfo.html) 19:31:41 INFO - PROCESS | 3326 | __metrics Screen width/height:1600/1200 19:31:41 INFO - PROCESS | 3326 | colorDepth:24 19:31:41 INFO - PROCESS | 3326 | Browser inner width/height: 1024/697 19:31:41 INFO - PROCESS | 3326 | __metrics 19:31:41 ERROR - PROCESS | 3326 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 19:31:42 INFO - TEST-INFO | 3326: exit 0 19:31:42 INFO - Browser initialized. 19:31:42 INFO - Running cycle 1/1 for dromaeo_css test... 19:31:42 INFO - TEST-INFO | started process 3445 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUmrx7h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:55 INFO - PROCESS | 3445 | RSS: Main: 188252160 19:31:55 INFO - PROCESS | 3445 | 19:32:44 INFO - PROCESS | 3445 | 1471660364897 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] 19:34:57 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:35745/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35745/tests/dromaeo/cssquery-ext.html) 19:34:58 INFO - PROCESS | 3445 | RSS: Main: 199176192 19:34:58 INFO - PROCESS | 3445 | 19:38:01 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:35745/tests/dromaeo/cssquery-ext.html (next: http://localhost:35745/tests/dromaeo/cssquery-jquery.html) 19:38:01 INFO - PROCESS | 3445 | RSS: Main: 198897664 19:38:01 INFO - PROCESS | 3445 | 19:41:03 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:35745/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35745/tests/dromaeo/cssquery-mootools.html) 19:41:04 INFO - PROCESS | 3445 | RSS: Main: 199909376 19:41:04 INFO - PROCESS | 3445 | 19:44:06 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:35745/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35745/tests/dromaeo/cssquery-prototype.html) 19:44:07 INFO - PROCESS | 3445 | RSS: Main: 197455872 19:44:07 INFO - PROCESS | 3445 | 19:47:09 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:35745/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35745/tests/dromaeo/cssquery-yui.html) 19:47:10 INFO - PROCESS | 3445 | RSS: Main: 199397376 19:47:10 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | Cycle 1(1): loaded http://localhost:35745/tests/dromaeo/cssquery-yui.html (next: http://localhost:35745/tests/dromaeo/cssquery-dojo.html) 19:50:13 INFO - PROCESS | 3445 | RSS: Main: 200704000 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | __start_tp_report 19:50:13 INFO - PROCESS | 3445 | _x_x_mozilla_page_load 19:50:13 INFO - PROCESS | 3445 | _x_x_mozilla_page_load_details 19:50:13 INFO - PROCESS | 3445 | |i|pagename|runs| 19:50:13 INFO - PROCESS | 3445 | |0;dojo.html;2605.4137818990725;2635.9341016474586;2642.682878054633;2653.509100816348;2662.693790214126;4654.162250794856;4709.64677649176;4710.081534100852;4731.030138821542;4750.548697873705;4676.298555216711;4692.976535117328;4740.857774266778;4748.90502189956;4754.049190161964;4217.578242175789;4361.563843615645;4409.845655402061;4476.9776151119195;4534.274516077428;4471.284594464886;4479.3952816369865;4516.954830451703;4522.638188944893;4524.411826462555;4255.17024180285;4293.592108749664;4348.804303806304;4370.453693288339;4433.733975961452;4393.340998850166;4403.955960440387;4406.449193850769;4416.0947005864045;4419.049904270597;4349.760763158025;4375.78121093944;4392.494863090754;4399.340098985146;4414.4040554525045;4682.672212945095;4731.858044258678;4747.382840230783;4798.616110711135;4807.423109226916;5140.640155189139;5147.0992576298995;5147.819826306099;5156.510131537498;5163.432022477525;5065;5101.617378696613;5107.131787596118;5132.28148059272;5135.460776618476;4756.476787553366;4811.013742182844;4815.614750819926;4821;4837.32277481153;5296.947030529723;5297.973510132425;5306.310179676618;5307.177387504943;5309.973450132802;4940.086084074458;4969;5097.235414687752;5100.336956195671;5100.336956195671;4966;5010.2735103409805;5038.193888977746;5092.796288148506;5115.667481613683;5089.033083714083;5100.872478188001;5106.208537676666;5117.744112794346;5118.078745825787;4907.607391408679;5089.236614507853;5098.643094983316;5121.1550094234035;5139.152039913372;4196.769177695195;4226.387173859835;4232.026633874226;4282.164977829356;4289.892752681146;3739.364308067635;3749.6250374962833;3749.8687545935763;3757.28611563802;3762.266358060152;4364.323529852878;4414.668899832461;4438.933415998763;4439.1121775645;4441.222786012435;5097.6941383517105;5177.197534382177;5179.249008893689;5179.974100129551;5191.610629202825;4440.178566965122;4471.1728330259;4476.4180656514445;4480.081583275421;4484.417025786692;4537.886552836206;4564.7717614119165;4613.792379342937;4643;4659.65052621048;4854.80580776765;4862.197737373364;4877.439094504178;4883.121038213014;4889.3888263967;5190.6107041972755;5195.454477279831;5204.687718736888;5204.921926171186;5222.3472065991755;4711.952880471152;4731.69243999139;4747.264174053027;4862.5380588844;4864.513548645107;4972.975135124301;4982.078315511642;4987.9002419950675;4999.550040496373;5052.065367906949;5123.33396658447;5129.025485157808;5129.563987061141;5132.820351287836;5133;4782.545658162469;4910.288008238714;4947.3073769671555;4950.851474455772;4968.354113965162;4870.902581948412;4914.066327397783;4967.528084831935;5018.874528136826;5028.547430731252;4904.043711476371;4910.091633047898;4929.778159982738;4930.630202734881;4943.233798761198;4883.072216278895;4911.754412279301;4949.628777841748;5043.470435604356;5062.924056139234;4908.263760435963;4928.334674818853;4929.285253638131;4932.03825254072;4943.159662857251 19:50:13 INFO - PROCESS | 3445 | |1;ext.html;530.8699368654679;545.9372172200198;559.5355854640649;561.550759392486;578.2396149063983;34359.31281374371;38551.22897542051;38572.61427385725;38600.42099368508;38648;38223.426648600296;38757;38812.80593597028;38827.41758873612;39137.21725565487;7516.8120796979965;7648.541087534738;7653.15815260321;7669.6165191740465;7677.078750549942;7541.660625271876;7578.280063393969;7584.4690871639;7602.50583712057;7611.2769286917655;7593.81015474612;7675.3092221700035;7681.462297639167;7695.192004839495;7711.228877112272;7529.397648188132;7554.131274903401;7599.7340093096755;7623.771286861403;7633.122190948029;7305.305995930378;7351.963240183818;7363.41092712587;7394.149672787645;7414.962925185394;36379.81810090959;36693;36891.26217475662;36895.4465683015;36905.630943690485;2704.1211606228053;2708.702042775293;2754.600582915486;2760.4479104179245;2839.630847989748;28584.142475725763;28892.855535722396;29152.854235728897;31631.84184079088;32062.358752825046;3358.4962255661603;3413.7269018478464;3450.8274586270586;3511.087117349482;3527.5061491391225;252936;257089.71455142603;258045;258490;259511;53036;53428;53557.73221133948;53822.46177538253;53950.73024634852;32181.839090804864;33131;33311.16722081919;56040.43959560352;56201;13273.278977809527;13584.388702508213;13617.182969021891;13652.590422287347;13664.453421863014;10077.042680945446;10160.237982151368;10163.18694504438;10170.745731356776;10219.591216351411;17621.383251586132;17757.64937590273;17793.911030444764;17895.73156402655;17964.640707185783;6761.3238676132;6786.93213067863;6943.479239057091;7105.396041336441;7183.281671832775;768.500474691455;952.4237836109193;955.9617615295449;958.8561715742555;999.9950000249952;26214.475710485684;28446.85776571104;28650.570241446396;28786.02375681475;29213.7078629211;863.494855509534;892.2148509311894;914.8078903430221;932.1563984593953;957.4064080270138;14621.780673289697;14983.775243371358;15066.849331506544;15333.846661533242;15352.462663806713;383053;387594;387693;388193;388593;49238;49742.751286243336;49833.25250121251;49842.75078624584;49852.25221621679;1076.34343050739;1093.191038631407;1156.849609550753;1181.0551558752964;1195.8086706126978;25155.226715992747;26908.730912690622;28209.71790282071;28267.293317667223;28648;42896;42914.78542607267;43361;43377.132457351305;43380.78309608432;319149;319184;319312;320332;320619;24415;25023.499530009663;25053.87473062623;25497.23508294754;25522.617160742233;38077;40599;41836.1632767349;42010.36984445174;42101.36847947222;35682.82158589191;35717.46423803593;35741;36155.457668135525;36158.819205903805;35337.293254135286;35454.290914182086;35999.46000809938;36146.45780313245;36421.45367819432;28747.5687864678;31705.682943171196;35351.29297414089;35471;36957.63042369649;30253.848730756206;32876;34189.31621367509;34258.48612270868;34576.30847382988;25110.49779004373;25342.493150137263;25773.613395799453;26610.467790643692;27203 19:50:13 INFO - PROCESS | 3445 | |2;jquery.html;361.72508893241144;366.94495825626154;371.1945079178183;383.45932235547883;387.0922686300624;15660.921695391522;16564.420245291418;16856.15719214039;17002.40491582795;17078.146092695348;15018.474353397633;15305.693886122272;15376.23118844059;15450.922745386257;15590.06459612424;4717.433907931053;5020.648554601179;5053.949460505385;5073.568746656539;5085.135526960407;3674.3018826423026;4977.278294647274;5626.690532020737;5910.34986151523;5920.970395148018;5965.731542080595;6015.248093988252;6020.96989515054;6022.5483088768515;6028.39716028398;5665.745041473144;5752.309722833266;5780.046292361755;5782.797602083949;5789.478946894799;4546.318052292149;5030.044291584587;5051.393832740058;5063.443021267694;5070.72111033893;11720.589779357682;12355.876441235563;12448.315342656151;12451.439685214187;12452.626421207378;1851.9537011574685;2143.9785602144093;2262.28737947546;2279.4871153990384;2324.2678556254896;8731.388802783807;8747.518886461243;9086.636534538611;9127.31545134111;9348;1569.199708148841;1645.1774112943529;1687.190148728605;1699.515638043164;1739.9391021314193;63905.68047159781;67588;68714;70728.29271707269;70847.64576177087;9834.311598188058;9965.80068398628;9972.152367048737;10065.899341006496;10184.338018028953;13055.21668699881;13434.723701248366;13490.988175886847;13496.257705826078;13512.054156209168;5369.5972802040005;5468.28912241406;5490.725463726798;5649.293838270216;7099.609521476265;6395.2645445773405;6450.9354906450335;6507;6612.206535215805;6619.50353723463;4092.3043082676018;4191.972966623197;4218.325067989168;4317.740935543878;4320.632746216606;1585.4213212177704;1684.6041180322613;1776.165202354891;1821.4171465131296;1853.3513270355268;751.0536723728142;812.9471584346999;830.588858515039;852.5438890193717;859.1923591823665;16082.919585401998;16662;16934.49196524106;17174.141292935303;17296.654066918592;767.1167284316988;821.7493664432405;843.4854738609444;850.5024560631975;876.3777717820419;9135;9538.52307384628;9579.425234485952;9632.566534505964;10003.749906252257;349876.75184872246;352697;354138;355708;364239;69961.65019174974;73668.26331736615;74425;74951.25048749443;74997;896.878921345623;912.4023764434173;936.6534382278601;975.302658599105;987;14908.32912518961;15938.442154524537;16172.919135404247;16272.349106035626;16326.755098673291;37518.43722344113;37775.433368500046;37780.811095944344;38445.6155438442;39448.802755987184;47257;48407.75796121138;54777;55428;56184.15723764065;7156.713731450684;7398.704051837866;7611.581363025087;7665.118511371264;7749.3413059890545;6687.565308254948;8434.578271086544;9541.666041688508;10236.692899213036;10926.836097458385;9849.704508864745;9897.25770567196;10032.097111260022;10147;10192.286539942133;9704.70885873425;9808.16630586408;9929.106380425796;9937.950310248403;9999;9758.707238782848;9986.950065249628;10144.74638134023;10335.896641033494;10737.409442480426;7549.962250188714;7573.242675732383;7586.3930885527925;7613.7641502362385;7737.0715514138665;8854.601542930455;9863.901360986585;9959.551820167964;10081.596736130472;10379.117774988908 19:50:13 INFO - PROCESS | 3445 | |3;mootools.html;1349.7502961952039;1389.541451321064;1446.2768615692155;1573.7718030885515;1627.9267432965516;6397.808065758035;7039.401650859671;7189.317014883584;7771.417143714216;7808.64861081252;7080.575165490074;7344.485885987983;7349.889751653729;7354.705811767536;7355.742549010785;2152.7739587343376;2167.6640120781303;2172.5003249252604;2180.1388451561625;2180.4330873972804;2076.9376918692465;2108.061912448961;2124.7875212478784;2137.0276524181536;2140.2295173737443;2087.6242276390244;2110.2930518276394;2134.157007981846;2134.6691262854283;2157.8813165275906;2058.897055147244;2067.8759274443582;2068.6586713192305;2073.906674199657;2081.3131666550003;2043.2235750414748;2093.068584479892;2109.6624540073667;2116.7142435771284;2124.746399624229;7325.230850760647;7364.189939106694;7370.668319925616;7642.273983971514;7775.8444831103625;4420.977895110536;4559.977200113978;4571.817127314904;4573.062522182944;4573.748443835588;2796.0633187882086;2851.458222937635;2871.9856400717863;2892.24801551596;2943.587897694303;897.8362147225221;911.6399022386187;945.1493655709847;947.9431234125974;966.6423423333341;10293.279470437072;10304.484775761257;10320.329178603366;10342.224333174967;10373.066424021874;3967.206558688274;4057.1885622875543;4147.91704165915;4228.746275223496;4238.809253583596;8845.4250473719;8845.513496757612;8861.158189971942;8864.601092950832;8871.512066836256;4469.284914413678;4477.977610111929;4488.349189367524;4488.865334039919;4523.751193684379;3600.6759391654878;3882.864099756495;3977.3238549446664;4106.527749308868;4130.91738165235;3591.7844929304324;3650.1969566695284;3732.682721968609;3737.4767532545466;3753.9624603753614;1175.6002958993984;1191.065013964034;1198.394810620631;1203.4764877278412;1209.7217639942687;730.0946825935907;751.9548827070394;758.5676164586133;761.9847603047908;800.4836880212347;4811.206150985118;4929.975350123226;5000.67495612784;5080.364954380702;5188.9740551297755;389.75250715795676;395.1878888883372;402.2658647967471;409.39409673683116;421.70269959678967;3290.1610089427045;3403.197334725611;3416.4704470807064;3417.2140407706365;3425.6745609167087;8959.462432254086;9182.95408522953;9351.438913665066;9371;9378.921424036187;9243.214326782165;9248.445093294424;9249.537523123818;9258.95370523143;9266.768330791649;7000.439964802906;7056.188538318056;7131.643417829087;7172.282771722786;7199.028131202325;5048.59611231108;5115.565176959852;5124.077666020003;5156.071907056616;5157.819476318311;8492.320614350961;8551.572421378782;8600.354973377147;8629.662402327649;8830.470171789713;8663.913360866563;8763.91236087631;8810.339224558056;8810.515421651871;8811.51536665464;5546.389897111234;5999.130126131774;6107.755689772537;6199.752009919733;6229.657368844757;7200.315969982843;7201.675924583511;7205;7258.056452661121;7331.083614548182;6155.261368635793;6216.53375996793;6267.96866015667;6417.101605775289;6423.807285781434;6140.5394595406415;6191.071339299141;6204.472619827366;6208.689565521616;6252.968735156295;5811.651300921958;5931.525477961839;5934.228550288435;5937.554683398676;5942.10868369748;4233.80947857341;4238.237117318912;4281.272183728835;4328.350747387917;4432;4194.979025104855;4255.106427650105;4324.632406245504;4355.912881742411;4458.7324760513175 19:50:13 INFO - PROCESS | 3445 | |4;prototype.html;287.48253144340185;288.56426795538744;302.15246234312747;303.62653935659137;308.9505679091346;4796.280557916314;4835.734034628094;4945.70325780453;4979.456368525755;4986.177280748677;4885.8534243972645;4912.803487860481;4923.261510773385;4926.162552366098;4936;3880.7865567393783;3886.7667939923554;3892.377219644857;3894.260090582787;3895.4351619015224;3597.4423964285447;3894.240623078501;3897.1036661567714;3899.161680238762;3899.78551179685;3776.150366167618;3788.3370410178245;3799.7530160539477;3804.125051238203;3815.427685847131;3763.172102137525;3776.188119554309;3785.337565925952;3790.848366065354;3797.126660867988;3178.9364212715845;3274.1159886830424;3285.178705323669;3285.5400243965864;3287.227501537137;4830.082284365994;4832.033593281358;4839.201531747258;4840.491748366406;4849.660523763338;4330.891727706832;4338.739675619441;4340.500842403101;4345.13097380522;4345.587169218919;4979.377577802775;5090.490950904917;5156.845294641167;5172.922406163911;5175.974120129413;3533.1697051193205;3559.056849934769;3567.6967457766123;3571.2143328467696;3581.301646178996;5350.923219149005;5359.846119257568;5404.189371594253;5437.456254374571;5439.238506609078;3725.273571653556;3725.6088110748524;3725.900859246529;3733.309337772521;3735.1969326594913;3653.342398368266;3743.577440572565;3773.867914622975;3794.886153415402;3807.1814559869763;4335.653147748172;4342.131573685276;4342.544032876503;4355.324924636623;4356.738595684269;5170.104741344859;5179.818706345335;5203.609729270244;5209.609279304067;5211.661242019257;1236.2211806561809;1254.1534464236604;1268.8287081243914;1281.589891234796;1293.715382615823;862.4609618988133;866.6143566113019;887.8357503861806;888.9377194252805;895.6148855991986;4529.569690879362;4534.0478499515475;4535.505471990392;4538.435783782153;4548.158590660738;5279.260903473517;5280.762365693553;5286.682799032071;5291.894162116736;5301.655392399482;4466.352167190305;4524.895923395637;4541.750203738826;4548.930236742274;4550.408446901882;2384.892679829412;2448.6939132608422;2449.6448015037718;2456.287676573809;2471.3821544613847;4374.912501750011;4391.494978077562;4416.797821579329;4418.80115394808;4419.381286619876;4726.527347265314;4746.169420351424;4759.952400476021;4763.76181190939;4776.952230477651;4238.788060596958;4288.463942007249;4337.262665346899;4383.715058521186;4416.299724605986;4625.3404292532605;4632.675712700078;4646.885667021429;4649.953500464952;4655.344655344656;4511.3458548510935;4576.382188404523;4580.954190458053;4593.563611456906;4594.701344412602;4066.34938409853;4390.0025488403335;4400.317950717644;4421.889452763707;4463.5313292103865;3370.25854312051;3371.3257348530883;3375.8987230383127;3386.8645254189555;3392.609849867297;4581.358609794698;4613.400257966443;4636.397268355092;4640.6287496999485;5095.949040509548;5064.215046667772;5172.870678233075;5174.6119041072825;5192.27308176848;5194.506521880416;5174.379074511083;5175.249588809676;5183.714895680623;5189.662671926313;5194.454582268807;4912.1649319615035;5053.797848086182;5078.314427552233;5079.568236699922;5103.668261562986;5192.922106168486;5215.29593504872;5221.765020574007;5229.137192363218;5232.136697445031;5089.091590653505;5112.948870511247;5115.437301896863;5118.155504341742;5123.462036486264 19:50:13 INFO - PROCESS | 3445 | |5;yui.html;566.4844991058137;569.7891780041385;579.5566391710342;602.0998607082413;631.7315141065047;11827.290362578251;12396.380180990947;12411.255324680526;12451.252924824517;12586.874131258684;14218.573442796733;14826.332815023323;14928.402863885432;14968.925155374209;14983.550493485212;766.6013672890108;785.9449838511307;789.7551758954713;790.3558599741222;790.6916302641974;627.7645882793952;749.9287567681089;778.7274453941104;782.5930516131608;786.3630459327934;810.8905297784812;816.0533780814256;819.4264015189361;821.8520666280067;826.3554427546493;809.9797505062362;815.0016230118117;819.7909533069089;819.8729196974418;820.2658620534647;598.1297212555721;598.4015984015984;598.8951933411636;599.3167788720862;599.5263741644096;12672;12675.429605667767;12677.492900283978;12698.873011269861;12714.173578717353;12947.223166610034;13105.86894131056;13230.933845330712;13248.73502529944;13462.596122116352;10111.494425278706;10170.745731356776;10226.795464090677;10319.071283584439;10464.581416743322;3147.7324427423696;3181.3001139749217;3216.131644455984;3226;3267.986924053551;57743.42256577423;59687;60048.69975650094;60214;64647;8942.195202431813;8994.145556172152;9571.521423928776;9898.752531186634;10062.295639305325;15587.844121558639;15630.843691562939;15656.92171539135;16316.347346106022;17423.82576174222;6063.666498342545;6148.6925653717135;6208.851362497862;6315.273743519462;6353.205849268841;3440.9311813763584;3476.5306683597896;3518.9296214075575;3529.2412131391875;3538.239278555123;2765.834049957009;2861.270376054093;2876.6548014238424;2884.2356775454523;2890.523063694509;502.93210416594025;504.009621094551;508.1970486631114;509.8680928339081;518.0183552168695;506.78208370400347;510.6655140882728;545.5635491606698;572.1703529881605;572.7250919558635;7640.197779233101;8123.309518690978;8163.79590510242;8239.670413183525;8362.121977192308;485.39325842696627;520.8801975545646;556.5992485410497;559.541176235483;572.8510587247263;3624.184558474375;3676.3933950897804;3844.1350696093714;3953;3995.680345572347;92937.53531232435;93492.53253733688;94222;95394.52302738442;95411;84551;85930;85944.57027714822;86774;87085;72139;73344;73986;74583.62708186424;76541.99999999888;7276.1996180419055;7280;7510.136334321623;7541.132769731551;7760.68957241704;31529;38718;39132;40320.798396007835;44686;37804.621953781214;43896.56103438925;51031.234531481314;57358.71320643537;60739.39260607514;10773.676789696321;11064.778704426028;11113.777724445628;11160.064572209114;11511.07911367072;12307.87692123103;12811.423485943342;12873.549425770054;12987;13079.476820927057;11110.333379997226;11541.769164616493;11564.306141631529;11618.244814087395;11784.935916661902;10885.23803333759;10962.232643714864;10991.450427478434;11046;11104.555817767521;10716.89283107159;10770.407627580558;11077.224594278323;11296.83054754163;11342.546298147981;9770.169535589555;9781.755456113655;10037.421084364585;10221.846672300071;10365.222608304257;10185.287029908131;10313.845292320471;10358.171346292127;10389.792204155723;10467.895321046692 19:50:13 INFO - PROCESS | 3445 | __end_tp_report 19:50:13 INFO - PROCESS | 3445 | __start_cc_report 19:50:13 INFO - PROCESS | 3445 | _x_x_mozilla_cycle_collect,358 19:50:13 INFO - PROCESS | 3445 | __end_cc_report 19:50:13 INFO - PROCESS | 3445 | __startTimestamp1471661413417__endTimestamp 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | ------- Summary: start ------- 19:50:13 INFO - PROCESS | 3445 | Number of tests: 6 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | [#0] dojo.html Cycles:165 Average:4722.39 Median:4864.51 stddev:504.08 (10.4%) stddev-sans-first:477.49 19:50:13 INFO - PROCESS | 3445 | Values: 2605.4 2635.9 2642.7 2653.5 2662.7 4654.2 4709.6 4710.1 4731.0 4750.5 4676.3 4693.0 4740.9 4748.9 4754.0 4217.6 4361.6 4409.8 4477.0 4534.3 4471.3 4479.4 4517.0 4522.6 4524.4 4255.2 4293.6 4348.8 4370.5 4433.7 4393.3 4404.0 4406.4 4416.1 4419.0 4349.8 4375.8 4392.5 4399.3 4414.4 4682.7 4731.9 4747.4 4798.6 4807.4 5140.6 5147.1 5147.8 5156.5 5163.4 5065.0 5101.6 5107.1 5132.3 5135.5 4756.5 4811.0 4815.6 4821.0 4837.3 5296.9 5298.0 5306.3 5307.2 5310.0 4940.1 4969.0 5097.2 5100.3 5100.3 4966.0 5010.3 5038.2 5092.8 5115.7 5089.0 5100.9 5106.2 5117.7 5118.1 4907.6 5089.2 5098.6 5121.2 5139.2 4196.8 4226.4 4232.0 4282.2 4289.9 3739.4 3749.6 3749.9 3757.3 3762.3 4364.3 4414.7 4438.9 4439.1 4441.2 5097.7 5177.2 5179.2 5180.0 5191.6 4440.2 4471.2 4476.4 4480.1 4484.4 4537.9 4564.8 4613.8 4643.0 4659.7 4854.8 4862.2 4877.4 4883.1 4889.4 5190.6 5195.5 5204.7 5204.9 5222.3 4712.0 4731.7 4747.3 4862.5 4864.5 4973.0 4982.1 4987.9 4999.6 5052.1 5123.3 5129.0 5129.6 5132.8 5133.0 4782.5 4910.3 4947.3 4950.9 4968.4 4870.9 4914.1 4967.5 5018.9 5028.5 4904.0 4910.1 4929.8 4930.6 4943.2 4883.1 4911.8 4949.6 5043.5 5062.9 4908.3 4928.3 4929.3 4932.0 4943.2 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | [#1] ext.html Cycles:180 Average:47039.00 Median:36157.14 stddev:85771.48 (237.2%) stddev-sans-first:85941.01 19:50:13 INFO - PROCESS | 3445 | Values: 530.9 545.9 559.5 561.6 578.2 34359.3 38551.2 38572.6 38600.4 38648.0 38223.4 38757.0 38812.8 38827.4 39137.2 7516.8 7648.5 7653.2 7669.6 7677.1 7541.7 7578.3 7584.5 7602.5 7611.3 7593.8 7675.3 7681.5 7695.2 7711.2 7529.4 7554.1 7599.7 7623.8 7633.1 7305.3 7352.0 7363.4 7394.1 7415.0 36379.8 36693.0 36891.3 36895.4 36905.6 2704.1 2708.7 2754.6 2760.4 2839.6 28584.1 28892.9 29152.9 31631.8 32062.4 3358.5 3413.7 3450.8 3511.1 3527.5 252936.0 257089.7 258045.0 258490.0 259511.0 53036.0 53428.0 53557.7 53822.5 53950.7 32181.8 33131.0 33311.2 56040.4 56201.0 13273.3 13584.4 13617.2 13652.6 13664.5 10077.0 10160.2 10163.2 10170.7 10219.6 17621.4 17757.6 17793.9 17895.7 17964.6 6761.3 6786.9 6943.5 7105.4 7183.3 768.5 952.4 956.0 958.9 1000.0 26214.5 28446.9 28650.6 28786.0 29213.7 863.5 892.2 914.8 932.2 957.4 14621.8 14983.8 15066.8 15333.8 15352.5 383053.0 387594.0 387693.0 388193.0 388593.0 49238.0 49742.8 49833.3 49842.8 49852.3 1076.3 1093.2 1156.8 1181.1 1195.8 25155.2 26908.7 28209.7 28267.3 28648.0 42896.0 42914.8 43361.0 43377.1 43380.8 319149.0 319184.0 319312.0 320332.0 320619.0 24415.0 25023.5 25053.9 25497.2 25522.6 38077.0 40599.0 41836.2 42010.4 42101.4 35682.8 35717.5 35741.0 36155.5 36158.8 35337.3 35454.3 35999.5 36146.5 36421.5 28747.6 31705.7 35351.3 35471.0 36957.6 30253.8 32876.0 34189.3 34258.5 34576.3 25110.5 25342.5 25773.6 26610.5 27203.0 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | [#2] jquery.html Cycles:180 Average:22865.54 Median:5079.35 stddev:58921.81 (1160.0%) stddev-sans-first:59062.87 19:50:13 INFO - PROCESS | 3445 | Values: 361.7 366.9 371.2 383.5 387.1 15660.9 16564.4 16856.2 17002.4 17078.1 15018.5 15305.7 15376.2 15450.9 15590.1 4717.4 5020.6 5053.9 5073.6 5085.1 3674.3 4977.3 5626.7 5910.3 5921.0 5965.7 6015.2 6021.0 6022.5 6028.4 5665.7 5752.3 5780.0 5782.8 5789.5 4546.3 5030.0 5051.4 5063.4 5070.7 11720.6 12355.9 12448.3 12451.4 12452.6 1852.0 2144.0 2262.3 2279.5 2324.3 8731.4 8747.5 9086.6 9127.3 9348.0 1569.2 1645.2 1687.2 1699.5 1739.9 63905.7 67588.0 68714.0 70728.3 70847.6 9834.3 9965.8 9972.2 10065.9 10184.3 13055.2 13434.7 13491.0 13496.3 13512.1 5369.6 5468.3 5490.7 5649.3 7099.6 6395.3 6450.9 6507.0 6612.2 6619.5 4092.3 4192.0 4218.3 4317.7 4320.6 1585.4 1684.6 1776.2 1821.4 1853.4 751.1 812.9 830.6 852.5 859.2 16082.9 16662.0 16934.5 17174.1 17296.7 767.1 821.7 843.5 850.5 876.4 9135.0 9538.5 9579.4 9632.6 10003.7 349876.8 352697.0 354138.0 355708.0 364239.0 69961.7 73668.3 74425.0 74951.3 74997.0 896.9 912.4 936.7 975.3 987.0 14908.3 15938.4 16172.9 16272.3 16326.8 37518.4 37775.4 37780.8 38445.6 39448.8 47257.0 48407.8 54777.0 55428.0 56184.2 7156.7 7398.7 7611.6 7665.1 7749.3 6687.6 8434.6 9541.7 10236.7 10926.8 9849.7 9897.3 10032.1 10147.0 10192.3 9704.7 9808.2 9929.1 9938.0 9999.0 9758.7 9987.0 10144.7 10335.9 10737.4 7550.0 7573.2 7586.4 7613.8 7737.1 8854.6 9863.9 9959.6 10081.6 10379.1 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | [#3] mootools.html Cycles:180 Average:4917.65 Median:4870.59 stddev:2767.96 (56.8%) stddev-sans-first:2762.74 19:50:13 INFO - PROCESS | 3445 | Values: 1349.8 1389.5 1446.3 1573.8 1627.9 6397.8 7039.4 7189.3 7771.4 7808.6 7080.6 7344.5 7349.9 7354.7 7355.7 2152.8 2167.7 2172.5 2180.1 2180.4 2076.9 2108.1 2124.8 2137.0 2140.2 2087.6 2110.3 2134.2 2134.7 2157.9 2058.9 2067.9 2068.7 2073.9 2081.3 2043.2 2093.1 2109.7 2116.7 2124.7 7325.2 7364.2 7370.7 7642.3 7775.8 4421.0 4560.0 4571.8 4573.1 4573.7 2796.1 2851.5 2872.0 2892.2 2943.6 897.8 911.6 945.1 947.9 966.6 10293.3 10304.5 10320.3 10342.2 10373.1 3967.2 4057.2 4147.9 4228.7 4238.8 8845.4 8845.5 8861.2 8864.6 8871.5 4469.3 4478.0 4488.3 4488.9 4523.8 3600.7 3882.9 3977.3 4106.5 4130.9 3591.8 3650.2 3732.7 3737.5 3754.0 1175.6 1191.1 1198.4 1203.5 1209.7 730.1 752.0 758.6 762.0 800.5 4811.2 4930.0 5000.7 5080.4 5189.0 389.8 395.2 402.3 409.4 421.7 3290.2 3403.2 3416.5 3417.2 3425.7 8959.5 9183.0 9351.4 9371.0 9378.9 9243.2 9248.4 9249.5 9259.0 9266.8 7000.4 7056.2 7131.6 7172.3 7199.0 5048.6 5115.6 5124.1 5156.1 5157.8 8492.3 8551.6 8600.4 8629.7 8830.5 8663.9 8763.9 8810.3 8810.5 8811.5 5546.4 5999.1 6107.8 6199.8 6229.7 7200.3 7201.7 7205.0 7258.1 7331.1 6155.3 6216.5 6268.0 6417.1 6423.8 6140.5 6191.1 6204.5 6208.7 6253.0 5811.7 5931.5 5934.2 5937.6 5942.1 4233.8 4238.2 4281.3 4328.4 4432.0 4195.0 4255.1 4324.6 4355.9 4458.7 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | [#4] prototype.html Cycles:180 Average:4132.74 Median:4536.97 stddev:1210.01 (26.7%) stddev-sans-first:1178.48 19:50:13 INFO - PROCESS | 3445 | Values: 287.5 288.6 302.2 303.6 309.0 4796.3 4835.7 4945.7 4979.5 4986.2 4885.9 4912.8 4923.3 4926.2 4936.0 3880.8 3886.8 3892.4 3894.3 3895.4 3597.4 3894.2 3897.1 3899.2 3899.8 3776.2 3788.3 3799.8 3804.1 3815.4 3763.2 3776.2 3785.3 3790.8 3797.1 3178.9 3274.1 3285.2 3285.5 3287.2 4830.1 4832.0 4839.2 4840.5 4849.7 4330.9 4338.7 4340.5 4345.1 4345.6 4979.4 5090.5 5156.8 5172.9 5176.0 3533.2 3559.1 3567.7 3571.2 3581.3 5350.9 5359.8 5404.2 5437.5 5439.2 3725.3 3725.6 3725.9 3733.3 3735.2 3653.3 3743.6 3773.9 3794.9 3807.2 4335.7 4342.1 4342.5 4355.3 4356.7 5170.1 5179.8 5203.6 5209.6 5211.7 1236.2 1254.2 1268.8 1281.6 1293.7 862.5 866.6 887.8 888.9 895.6 4529.6 4534.0 4535.5 4538.4 4548.2 5279.3 5280.8 5286.7 5291.9 5301.7 4466.4 4524.9 4541.8 4548.9 4550.4 2384.9 2448.7 2449.6 2456.3 2471.4 4374.9 4391.5 4416.8 4418.8 4419.4 4726.5 4746.2 4760.0 4763.8 4777.0 4238.8 4288.5 4337.3 4383.7 4416.3 4625.3 4632.7 4646.9 4650.0 4655.3 4511.3 4576.4 4581.0 4593.6 4594.7 4066.3 4390.0 4400.3 4421.9 4463.5 3370.3 3371.3 3375.9 3386.9 3392.6 4581.4 4613.4 4636.4 4640.6 5095.9 5064.2 5172.9 5174.6 5192.3 5194.5 5174.4 5175.2 5183.7 5189.7 5194.5 4912.2 5053.8 5078.3 5079.6 5103.7 5192.9 5215.3 5221.8 5229.1 5232.1 5089.1 5112.9 5115.4 5118.2 5123.5 19:50:13 INFO - PROCESS | 3445 | 19:50:13 INFO - PROCESS | 3445 | [#5] yui.html Cycles:180 Average:16996.17 Median:22585.70 stddev:24459.04 (108.3%) stddev-sans-first:24496.54 19:50:13 INFO - PROCESS | 3445 | Values: 566.5 569.8 579.6 602.1 631.7 11827.3 12396.4 12411.3 12451.3 12586.9 14218.6 14826.3 14928.4 14968.9 14983.6 766.6 785.9 789.8 790.4 790.7 627.8 749.9 778.7 782.6 786.4 810.9 816.1 819.4 821.9 826.4 810.0 815.0 819.8 819.9 820.3 598.1 598.4 598.9 599.3 599.5 12672.0 12675.4 12677.5 12698.9 12714.2 12947.2 13105.9 13230.9 13248.7 13462.6 10111.5 10170.7 10226.8 10319.1 10464.6 3147.7 3181.3 3216.1 3226.0 3268.0 57743.4 59687.0 60048.7 60214.0 64647.0 8942.2 8994.1 9571.5 9898.8 10062.3 15587.8 15630.8 15656.9 16316.3 17423.8 6063.7 6148.7 6208.9 6315.3 6353.2 3440.9 3476.5 3518.9 3529.2 3538.2 2765.8 2861.3 2876.7 2884.2 2890.5 502.9 504.0 508.2 509.9 518.0 506.8 510.7 545.6 572.2 572.7 7640.2 8123.3 8163.8 8239.7 8362.1 485.4 520.9 556.6 559.5 572.9 3624.2 3676.4 3844.1 3953.0 3995.7 92937.5 93492.5 94222.0 95394.5 95411.0 84551.0 85930.0 85944.6 86774.0 87085.0 72139.0 73344.0 73986.0 74583.6 76542.0 7276.2 7280.0 7510.1 7541.1 7760.7 31529.0 38718.0 39132.0 40320.8 44686.0 37804.6 43896.6 51031.2 57358.7 60739.4 10773.7 11064.8 11113.8 11160.1 11511.1 12307.9 12811.4 12873.5 12987.0 13079.5 11110.3 11541.8 11564.3 11618.2 11784.9 10885.2 10962.2 10991.5 11046.0 11104.6 10716.9 10770.4 11077.2 11296.8 11342.5 9770.2 9781.8 10037.4 10221.8 10365.2 10185.3 10313.8 10358.2 10389.8 10467.9 19:50:13 INFO - PROCESS | 3445 | -------- Summary: end -------- 19:50:13 INFO - PROCESS | 3445 | 19:50:14 INFO - TEST-INFO | 3445: exit 0 19:50:14 INFO - TEST-OK | dromaeo_css | took 1120112ms 19:50:14 INFO - TEST-START | kraken 19:50:14 INFO - operating with platform_type : linux_ 19:50:14 INFO - Initialising browser for kraken test... 19:50:14 INFO - TEST-INFO | started process 3795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2jncWt/profile http://localhost:35745/getInfo.html) 19:50:19 INFO - PROCESS | 3795 | __metrics Screen width/height:1600/1200 19:50:19 INFO - PROCESS | 3795 | colorDepth:24 19:50:19 INFO - PROCESS | 3795 | Browser inner width/height: 1024/697 19:50:19 INFO - PROCESS | 3795 | __metrics 19:50:20 ERROR - PROCESS | 3795 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 19:50:21 INFO - TEST-INFO | 3795: exit 0 19:50:21 INFO - Browser initialized. 19:50:21 INFO - Running cycle 1/1 for kraken test... 19:50:21 INFO - TEST-INFO | started process 3916 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2jncWt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:33 INFO - PROCESS | 3916 | RSS: Main: 187215872 19:50:33 INFO - PROCESS | 3916 | 19:50:36 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35745/tests/kraken/driver.html?testName=audio-beat-detection) 19:50:37 INFO - PROCESS | 3916 | RSS: Main: 199897088 19:50:37 INFO - PROCESS | 3916 | 19:50:40 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35745/tests/kraken/driver.html?testName=audio-dft) 19:50:41 INFO - PROCESS | 3916 | RSS: Main: 198717440 19:50:41 INFO - PROCESS | 3916 | 19:50:44 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35745/tests/kraken/driver.html?testName=audio-fft) 19:50:44 INFO - PROCESS | 3916 | RSS: Main: 195366912 19:50:44 INFO - PROCESS | 3916 | 19:50:47 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35745/tests/kraken/driver.html?testName=audio-oscillator) 19:50:47 INFO - PROCESS | 3916 | RSS: Main: 196259840 19:50:47 INFO - PROCESS | 3916 | 19:50:49 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35745/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:50:50 INFO - PROCESS | 3916 | RSS: Main: 196546560 19:50:50 INFO - PROCESS | 3916 | 19:50:53 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35745/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:54 INFO - PROCESS | 3916 | RSS: Main: 197271552 19:50:54 INFO - PROCESS | 3916 | 19:50:58 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35745/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:58 INFO - PROCESS | 3916 | RSS: Main: 194813952 19:50:58 INFO - PROCESS | 3916 | 19:51:01 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35745/tests/kraken/driver.html?testName=json-parse-financial) 19:51:02 INFO - PROCESS | 3916 | RSS: Main: 196153344 19:51:02 INFO - PROCESS | 3916 | 19:51:04 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35745/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:51:04 INFO - PROCESS | 3916 | RSS: Main: 196341760 19:51:04 INFO - PROCESS | 3916 | 19:51:06 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:51:07 INFO - PROCESS | 3916 | RSS: Main: 196497408 19:51:07 INFO - PROCESS | 3916 | 19:51:09 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:51:10 INFO - PROCESS | 3916 | RSS: Main: 196861952 19:51:10 INFO - PROCESS | 3916 | 19:51:13 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:51:13 INFO - PROCESS | 3916 | RSS: Main: 197005312 19:51:13 INFO - PROCESS | 3916 | 19:51:17 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:51:17 INFO - PROCESS | 3916 | RSS: Main: 197279744 19:51:17 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | Cycle 1(1): loaded http://localhost:35745/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35745/tests/kraken/driver.html?testName=ai-astar) 19:51:19 INFO - PROCESS | 3916 | RSS: Main: 200298496 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | __start_tp_report 19:51:19 INFO - PROCESS | 3916 | _x_x_mozilla_page_load 19:51:19 INFO - PROCESS | 3916 | _x_x_mozilla_page_load_details 19:51:19 INFO - PROCESS | 3916 | |i|pagename|runs| 19:51:19 INFO - PROCESS | 3916 | |0;ai-astar;109;117;115;118;119;118;121;120;116;115 19:51:19 INFO - PROCESS | 3916 | |1;audio-beat-detection;152;131;156;182;128;153;151;127;178;131 19:51:19 INFO - PROCESS | 3916 | |2;audio-dft;171;171;164;165;169;164;166;164;166;164 19:51:19 INFO - PROCESS | 3916 | |3;audio-fft;76;78;77;177;80;77;77;78;166;79 19:51:19 INFO - PROCESS | 3916 | |4;audio-oscillator;89;90;143;89;87;90;134;100;93;146 19:51:19 INFO - PROCESS | 3916 | |5;imaging-gaussian-blur;135;120;119;135;119;119;118;118;118;118 19:51:19 INFO - PROCESS | 3916 | |6;imaging-darkroom;148;150;149;150;149;147;148;150;148;148 19:51:19 INFO - PROCESS | 3916 | |7;imaging-desaturate;96;119;111;96;96;96;96;96;98;96 19:51:19 INFO - PROCESS | 3916 | |8;json-parse-financial;65;67;67;67;65;67;68;66;66;65 19:51:19 INFO - PROCESS | 3916 | |9;json-stringify-tinderbox;66;66;78;66;66;67;65;64;68;67 19:51:19 INFO - PROCESS | 3916 | |10;stanford-crypto-aes;86;86;84;85;86;84;87;86;89;85 19:51:19 INFO - PROCESS | 3916 | |11;stanford-crypto-ccm;146;141;148;136;148;154;153;145;159;140 19:51:19 INFO - PROCESS | 3916 | |12;stanford-crypto-pbkdf2;184;177;184;176;178;183;184;181;177;177 19:51:19 INFO - PROCESS | 3916 | |13;stanford-crypto-sha256-iterative;70;71;72;69;70;75;82;72;71;74 19:51:19 INFO - PROCESS | 3916 | __end_tp_report 19:51:19 INFO - PROCESS | 3916 | __start_cc_report 19:51:19 INFO - PROCESS | 3916 | _x_x_mozilla_cycle_collect,957 19:51:19 INFO - PROCESS | 3916 | __end_cc_report 19:51:19 INFO - PROCESS | 3916 | __startTimestamp1471661479751__endTimestamp 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | ------- Summary: start ------- 19:51:19 INFO - PROCESS | 3916 | Number of tests: 14 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#0] ai-astar Cycles:10 Average:116.80 Median:118.00 stddev:3.39 (2.9%) stddev-sans-first:2.12 19:51:19 INFO - PROCESS | 3916 | Values: 109.0 117.0 115.0 118.0 119.0 118.0 121.0 120.0 116.0 115.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#1] audio-beat-detection Cycles:10 Average:148.90 Median:152.50 stddev:19.95 (13.1%) stddev-sans-first:21.13 19:51:19 INFO - PROCESS | 3916 | Values: 152.0 131.0 156.0 182.0 128.0 153.0 151.0 127.0 178.0 131.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:2.88 (1.7%) stddev-sans-first:2.52 19:51:19 INFO - PROCESS | 3916 | Values: 171.0 171.0 164.0 165.0 169.0 164.0 166.0 164.0 166.0 164.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#3] audio-fft Cycles:10 Average:96.50 Median:77.50 stddev:39.63 (51.1%) stddev-sans-first:41.33 19:51:19 INFO - PROCESS | 3916 | Values: 76.0 78.0 77.0 177.0 80.0 77.0 77.0 78.0 166.0 79.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#4] audio-oscillator Cycles:10 Average:106.10 Median:89.00 stddev:24.52 (27.5%) stddev-sans-first:25.21 19:51:19 INFO - PROCESS | 3916 | Values: 89.0 90.0 143.0 89.0 87.0 90.0 134.0 100.0 93.0 146.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#5] imaging-gaussian-blur Cycles:10 Average:121.90 Median:119.00 stddev:6.94 (5.8%) stddev-sans-first:5.50 19:51:19 INFO - PROCESS | 3916 | Values: 135.0 120.0 119.0 135.0 119.0 119.0 118.0 118.0 118.0 118.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 19:51:19 INFO - PROCESS | 3916 | Values: 148.0 150.0 149.0 150.0 149.0 147.0 148.0 150.0 148.0 148.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#7] imaging-desaturate Cycles:10 Average:100.00 Median:96.00 stddev:8.15 (8.5%) stddev-sans-first:8.52 19:51:19 INFO - PROCESS | 3916 | Values: 96.0 119.0 111.0 96.0 96.0 96.0 96.0 96.0 98.0 96.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.01 19:51:19 INFO - PROCESS | 3916 | Values: 65.0 67.0 67.0 67.0 65.0 67.0 68.0 66.0 66.0 65.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:66.50 stddev:3.92 (5.9%) stddev-sans-first:4.13 19:51:19 INFO - PROCESS | 3916 | Values: 66.0 66.0 78.0 66.0 66.0 67.0 65.0 64.0 68.0 67.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.48 (1.7%) stddev-sans-first:1.56 19:51:19 INFO - PROCESS | 3916 | Values: 86.0 86.0 84.0 85.0 86.0 84.0 87.0 86.0 89.0 85.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:148.00 stddev:7.01 (4.7%) stddev-sans-first:7.42 19:51:19 INFO - PROCESS | 3916 | Values: 146.0 141.0 148.0 136.0 148.0 154.0 153.0 145.0 159.0 140.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:182.00 stddev:3.41 (1.9%) stddev-sans-first:3.32 19:51:19 INFO - PROCESS | 3916 | Values: 184.0 177.0 184.0 176.0 178.0 183.0 184.0 181.0 177.0 177.0 19:51:19 INFO - PROCESS | 3916 | 19:51:19 INFO - PROCESS | 3916 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:72.00 stddev:3.78 (5.2%) stddev-sans-first:3.89 19:51:19 INFO - PROCESS | 3916 | Values: 70.0 71.0 72.0 69.0 70.0 75.0 82.0 72.0 71.0 74.0 19:51:19 INFO - PROCESS | 3916 | -------- Summary: end -------- 19:51:19 INFO - PROCESS | 3916 | 19:51:20 INFO - TEST-INFO | 3916: exit 0 19:51:20 INFO - TEST-OK | kraken | took 66487ms 19:51:20 INFO - SUITE-END | took 1186s 19:51:21 INFO - Completed test suite (00:19:47) 19:51:21 INFO - javascript benchmark 19:51:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6233.0494891109065, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.4137818990725, 2635.9341016474586, 2642.682878054633, 2653.509100816348, 2662.693790214126, 4654.162250794856, 4709.64677649176, 4710.081534100852, 4731.030138821542, 4750.548697873705, 4676.298555216711, 4692.976535117328, 4740.857774266778, 4748.90502189956, 4754.049190161964, 4217.578242175789, 4361.563843615645, 4409.845655402061, 4476.9776151119195, 4534.274516077428, 4471.284594464886, 4479.3952816369865, 4516.954830451703, 4522.638188944893, 4524.411826462555, 4255.17024180285, 4293.592108749664, 4348.804303806304, 4370.453693288339, 4433.733975961452, 4393.340998850166, 4403.955960440387, 4406.449193850769, 4416.0947005864045, 4419.049904270597, 4349.760763158025, 4375.78121093944, 4392.494863090754, 4399.340098985146, 4414.4040554525045, 4682.672212945095, 4731.858044258678, 4747.382840230783, 4798.616110711135, 4807.423109226916, 5140.640155189139, 5147.0992576298995, 5147.819826306099, 5156.510131537498, 5163.432022477525, 5065.0, 5101.617378696613, 5107.131787596118, 5132.28148059272, 5135.460776618476, 4756.476787553366, 4811.013742182844, 4815.614750819926, 4821.0, 4837.32277481153, 5296.947030529723, 5297.973510132425, 5306.310179676618, 5307.177387504943, 5309.973450132802, 4940.086084074458, 4969.0, 5097.235414687752, 5100.336956195671, 5100.336956195671, 4966.0, 5010.2735103409805, 5038.193888977746, 5092.796288148506, 5115.667481613683, 5089.033083714083, 5100.872478188001, 5106.208537676666, 5117.744112794346, 5118.078745825787, 4907.607391408679, 5089.236614507853, 5098.643094983316, 5121.1550094234035, 5139.152039913372, 4196.769177695195, 4226.387173859835, 4232.026633874226, 4282.164977829356, 4289.892752681146, 3739.364308067635, 3749.6250374962833, 3749.8687545935763, 3757.28611563802, 3762.266358060152, 4364.323529852878, 4414.668899832461, 4438.933415998763, 4439.1121775645, 4441.222786012435, 5097.6941383517105, 5177.197534382177, 5179.249008893689, 5179.974100129551, 5191.610629202825, 4440.178566965122, 4471.1728330259, 4476.4180656514445, 4480.081583275421, 4484.417025786692, 4537.886552836206, 4564.7717614119165, 4613.792379342937, 4643.0, 4659.65052621048, 4854.80580776765, 4862.197737373364, 4877.439094504178, 4883.121038213014, 4889.3888263967, 5190.6107041972755, 5195.454477279831, 5204.687718736888, 5204.921926171186, 5222.3472065991755, 4711.952880471152, 4731.69243999139, 4747.264174053027, 4862.5380588844, 4864.513548645107, 4972.975135124301, 4982.078315511642, 4987.9002419950675, 4999.550040496373, 5052.065367906949, 5123.33396658447, 5129.025485157808, 5129.563987061141, 5132.820351287836, 5133.0, 4782.545658162469, 4910.288008238714, 4947.3073769671555, 4950.851474455772, 4968.354113965162, 4870.902581948412, 4914.066327397783, 4967.528084831935, 5018.874528136826, 5028.547430731252, 4904.043711476371, 4910.091633047898, 4929.778159982738, 4930.630202734881, 4943.233798761198, 4883.072216278895, 4911.754412279301, 4949.628777841748, 5043.470435604356, 5062.924056139234, 4908.263760435963, 4928.334674818853, 4929.285253638131, 4932.03825254072, 4943.159662857251], "value": 4689.47839440577, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.8699368654679, 545.9372172200198, 559.5355854640649, 561.550759392486, 578.2396149063983, 34359.31281374371, 38551.22897542051, 38572.61427385725, 38600.42099368508, 38648.0, 38223.426648600296, 38757.0, 38812.80593597028, 38827.41758873612, 39137.21725565487, 7516.8120796979965, 7648.541087534738, 7653.15815260321, 7669.6165191740465, 7677.078750549942, 7541.660625271876, 7578.280063393969, 7584.4690871639, 7602.50583712057, 7611.2769286917655, 7593.81015474612, 7675.3092221700035, 7681.462297639167, 7695.192004839495, 7711.228877112272, 7529.397648188132, 7554.131274903401, 7599.7340093096755, 7623.771286861403, 7633.122190948029, 7305.305995930378, 7351.963240183818, 7363.41092712587, 7394.149672787645, 7414.962925185394, 36379.81810090959, 36693.0, 36891.26217475662, 36895.4465683015, 36905.630943690485, 2704.1211606228053, 2708.702042775293, 2754.600582915486, 2760.4479104179245, 2839.630847989748, 28584.142475725763, 28892.855535722396, 29152.854235728897, 31631.84184079088, 32062.358752825046, 3358.4962255661603, 3413.7269018478464, 3450.8274586270586, 3511.087117349482, 3527.5061491391225, 252936.0, 257089.71455142603, 258045.0, 258490.0, 259511.0, 53036.0, 53428.0, 53557.73221133948, 53822.46177538253, 53950.73024634852, 32181.839090804864, 33131.0, 33311.16722081919, 56040.43959560352, 56201.0, 13273.278977809527, 13584.388702508213, 13617.182969021891, 13652.590422287347, 13664.453421863014, 10077.042680945446, 10160.237982151368, 10163.18694504438, 10170.745731356776, 10219.591216351411, 17621.383251586132, 17757.64937590273, 17793.911030444764, 17895.73156402655, 17964.640707185783, 6761.3238676132, 6786.93213067863, 6943.479239057091, 7105.396041336441, 7183.281671832775, 768.500474691455, 952.4237836109193, 955.9617615295449, 958.8561715742555, 999.9950000249952, 26214.475710485684, 28446.85776571104, 28650.570241446396, 28786.02375681475, 29213.7078629211, 863.494855509534, 892.2148509311894, 914.8078903430221, 932.1563984593953, 957.4064080270138, 14621.780673289697, 14983.775243371358, 15066.849331506544, 15333.846661533242, 15352.462663806713, 383053.0, 387594.0, 387693.0, 388193.0, 388593.0, 49238.0, 49742.751286243336, 49833.25250121251, 49842.75078624584, 49852.25221621679, 1076.34343050739, 1093.191038631407, 1156.849609550753, 1181.0551558752964, 1195.8086706126978, 25155.226715992747, 26908.730912690622, 28209.71790282071, 28267.293317667223, 28648.0, 42896.0, 42914.78542607267, 43361.0, 43377.132457351305, 43380.78309608432, 319149.0, 319184.0, 319312.0, 320332.0, 320619.0, 24415.0, 25023.499530009663, 25053.87473062623, 25497.23508294754, 25522.617160742233, 38077.0, 40599.0, 41836.1632767349, 42010.36984445174, 42101.36847947222, 35682.82158589191, 35717.46423803593, 35741.0, 36155.457668135525, 36158.819205903805, 35337.293254135286, 35454.290914182086, 35999.46000809938, 36146.45780313245, 36421.45367819432, 28747.5687864678, 31705.682943171196, 35351.29297414089, 35471.0, 36957.63042369649, 30253.848730756206, 32876.0, 34189.31621367509, 34258.48612270868, 34576.30847382988, 25110.49779004373, 25342.493150137263, 25773.613395799453, 26610.467790643692, 27203.0], "value": 17097.27891685875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.72508893241144, 366.94495825626154, 371.1945079178183, 383.45932235547883, 387.0922686300624, 15660.921695391522, 16564.420245291418, 16856.15719214039, 17002.40491582795, 17078.146092695348, 15018.474353397633, 15305.693886122272, 15376.23118844059, 15450.922745386257, 15590.06459612424, 4717.433907931053, 5020.648554601179, 5053.949460505385, 5073.568746656539, 5085.135526960407, 3674.3018826423026, 4977.278294647274, 5626.690532020737, 5910.34986151523, 5920.970395148018, 5965.731542080595, 6015.248093988252, 6020.96989515054, 6022.5483088768515, 6028.39716028398, 5665.745041473144, 5752.309722833266, 5780.046292361755, 5782.797602083949, 5789.478946894799, 4546.318052292149, 5030.044291584587, 5051.393832740058, 5063.443021267694, 5070.72111033893, 11720.589779357682, 12355.876441235563, 12448.315342656151, 12451.439685214187, 12452.626421207378, 1851.9537011574685, 2143.9785602144093, 2262.28737947546, 2279.4871153990384, 2324.2678556254896, 8731.388802783807, 8747.518886461243, 9086.636534538611, 9127.31545134111, 9348.0, 1569.199708148841, 1645.1774112943529, 1687.190148728605, 1699.515638043164, 1739.9391021314193, 63905.68047159781, 67588.0, 68714.0, 70728.29271707269, 70847.64576177087, 9834.311598188058, 9965.80068398628, 9972.152367048737, 10065.899341006496, 10184.338018028953, 13055.21668699881, 13434.723701248366, 13490.988175886847, 13496.257705826078, 13512.054156209168, 5369.5972802040005, 5468.28912241406, 5490.725463726798, 5649.293838270216, 7099.609521476265, 6395.2645445773405, 6450.9354906450335, 6507.0, 6612.206535215805, 6619.50353723463, 4092.3043082676018, 4191.972966623197, 4218.325067989168, 4317.740935543878, 4320.632746216606, 1585.4213212177704, 1684.6041180322613, 1776.165202354891, 1821.4171465131296, 1853.3513270355268, 751.0536723728142, 812.9471584346999, 830.588858515039, 852.5438890193717, 859.1923591823665, 16082.919585401998, 16662.0, 16934.49196524106, 17174.141292935303, 17296.654066918592, 767.1167284316988, 821.7493664432405, 843.4854738609444, 850.5024560631975, 876.3777717820419, 9135.0, 9538.52307384628, 9579.425234485952, 9632.566534505964, 10003.749906252257, 349876.75184872246, 352697.0, 354138.0, 355708.0, 364239.0, 69961.65019174974, 73668.26331736615, 74425.0, 74951.25048749443, 74997.0, 896.878921345623, 912.4023764434173, 936.6534382278601, 975.302658599105, 987.0, 14908.32912518961, 15938.442154524537, 16172.919135404247, 16272.349106035626, 16326.755098673291, 37518.43722344113, 37775.433368500046, 37780.811095944344, 38445.6155438442, 39448.802755987184, 47257.0, 48407.75796121138, 54777.0, 55428.0, 56184.15723764065, 7156.713731450684, 7398.704051837866, 7611.581363025087, 7665.118511371264, 7749.3413059890545, 6687.565308254948, 8434.578271086544, 9541.666041688508, 10236.692899213036, 10926.836097458385, 9849.704508864745, 9897.25770567196, 10032.097111260022, 10147.0, 10192.286539942133, 9704.70885873425, 9808.16630586408, 9929.106380425796, 9937.950310248403, 9999.0, 9758.707238782848, 9986.950065249628, 10144.74638134023, 10335.896641033494, 10737.409442480426, 7549.962250188714, 7573.242675732383, 7586.3930885527925, 7613.7641502362385, 7737.0715514138665, 8854.601542930455, 9863.901360986585, 9959.551820167964, 10081.596736130472, 10379.117774988908], "value": 7890.989659086841, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.7502961952039, 1389.541451321064, 1446.2768615692155, 1573.7718030885515, 1627.9267432965516, 6397.808065758035, 7039.401650859671, 7189.317014883584, 7771.417143714216, 7808.64861081252, 7080.575165490074, 7344.485885987983, 7349.889751653729, 7354.705811767536, 7355.742549010785, 2152.7739587343376, 2167.6640120781303, 2172.5003249252604, 2180.1388451561625, 2180.4330873972804, 2076.9376918692465, 2108.061912448961, 2124.7875212478784, 2137.0276524181536, 2140.2295173737443, 2087.6242276390244, 2110.2930518276394, 2134.157007981846, 2134.6691262854283, 2157.8813165275906, 2058.897055147244, 2067.8759274443582, 2068.6586713192305, 2073.906674199657, 2081.3131666550003, 2043.2235750414748, 2093.068584479892, 2109.6624540073667, 2116.7142435771284, 2124.746399624229, 7325.230850760647, 7364.189939106694, 7370.668319925616, 7642.273983971514, 7775.8444831103625, 4420.977895110536, 4559.977200113978, 4571.817127314904, 4573.062522182944, 4573.748443835588, 2796.0633187882086, 2851.458222937635, 2871.9856400717863, 2892.24801551596, 2943.587897694303, 897.8362147225221, 911.6399022386187, 945.1493655709847, 947.9431234125974, 966.6423423333341, 10293.279470437072, 10304.484775761257, 10320.329178603366, 10342.224333174967, 10373.066424021874, 3967.206558688274, 4057.1885622875543, 4147.91704165915, 4228.746275223496, 4238.809253583596, 8845.4250473719, 8845.513496757612, 8861.158189971942, 8864.601092950832, 8871.512066836256, 4469.284914413678, 4477.977610111929, 4488.349189367524, 4488.865334039919, 4523.751193684379, 3600.6759391654878, 3882.864099756495, 3977.3238549446664, 4106.527749308868, 4130.91738165235, 3591.7844929304324, 3650.1969566695284, 3732.682721968609, 3737.4767532545466, 3753.9624603753614, 1175.6002958993984, 1191.065013964034, 1198.394810620631, 1203.4764877278412, 1209.7217639942687, 730.0946825935907, 751.9548827070394, 758.5676164586133, 761.9847603047908, 800.4836880212347, 4811.206150985118, 4929.975350123226, 5000.67495612784, 5080.364954380702, 5188.9740551297755, 389.75250715795676, 395.1878888883372, 402.2658647967471, 409.39409673683116, 421.70269959678967, 3290.1610089427045, 3403.197334725611, 3416.4704470807064, 3417.2140407706365, 3425.6745609167087, 8959.462432254086, 9182.95408522953, 9351.438913665066, 9371.0, 9378.921424036187, 9243.214326782165, 9248.445093294424, 9249.537523123818, 9258.95370523143, 9266.768330791649, 7000.439964802906, 7056.188538318056, 7131.643417829087, 7172.282771722786, 7199.028131202325, 5048.59611231108, 5115.565176959852, 5124.077666020003, 5156.071907056616, 5157.819476318311, 8492.320614350961, 8551.572421378782, 8600.354973377147, 8629.662402327649, 8830.470171789713, 8663.913360866563, 8763.91236087631, 8810.339224558056, 8810.515421651871, 8811.51536665464, 5546.389897111234, 5999.130126131774, 6107.755689772537, 6199.752009919733, 6229.657368844757, 7200.315969982843, 7201.675924583511, 7205.0, 7258.056452661121, 7331.083614548182, 6155.261368635793, 6216.53375996793, 6267.96866015667, 6417.101605775289, 6423.807285781434, 6140.5394595406415, 6191.071339299141, 6204.472619827366, 6208.689565521616, 6252.968735156295, 5811.651300921958, 5931.525477961839, 5934.228550288435, 5937.554683398676, 5942.10868369748, 4233.80947857341, 4238.237117318912, 4281.272183728835, 4328.350747387917, 4432.0, 4194.979025104855, 4255.106427650105, 4324.632406245504, 4355.912881742411, 4458.7324760513175], "value": 3908.348425905351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.48253144340185, 288.56426795538744, 302.15246234312747, 303.62653935659137, 308.9505679091346, 4796.280557916314, 4835.734034628094, 4945.70325780453, 4979.456368525755, 4986.177280748677, 4885.8534243972645, 4912.803487860481, 4923.261510773385, 4926.162552366098, 4936.0, 3880.7865567393783, 3886.7667939923554, 3892.377219644857, 3894.260090582787, 3895.4351619015224, 3597.4423964285447, 3894.240623078501, 3897.1036661567714, 3899.161680238762, 3899.78551179685, 3776.150366167618, 3788.3370410178245, 3799.7530160539477, 3804.125051238203, 3815.427685847131, 3763.172102137525, 3776.188119554309, 3785.337565925952, 3790.848366065354, 3797.126660867988, 3178.9364212715845, 3274.1159886830424, 3285.178705323669, 3285.5400243965864, 3287.227501537137, 4830.082284365994, 4832.033593281358, 4839.201531747258, 4840.491748366406, 4849.660523763338, 4330.891727706832, 4338.739675619441, 4340.500842403101, 4345.13097380522, 4345.587169218919, 4979.377577802775, 5090.490950904917, 5156.845294641167, 5172.922406163911, 5175.974120129413, 3533.1697051193205, 3559.056849934769, 3567.6967457766123, 3571.2143328467696, 3581.301646178996, 5350.923219149005, 5359.846119257568, 5404.189371594253, 5437.456254374571, 5439.238506609078, 3725.273571653556, 3725.6088110748524, 3725.900859246529, 3733.309337772521, 3735.1969326594913, 3653.342398368266, 3743.577440572565, 3773.867914622975, 3794.886153415402, 3807.1814559869763, 4335.653147748172, 4342.131573685276, 4342.544032876503, 4355.324924636623, 4356.738595684269, 5170.104741344859, 5179.818706345335, 5203.609729270244, 5209.609279304067, 5211.661242019257, 1236.2211806561809, 1254.1534464236604, 1268.8287081243914, 1281.589891234796, 1293.715382615823, 862.4609618988133, 866.6143566113019, 887.8357503861806, 888.9377194252805, 895.6148855991986, 4529.569690879362, 4534.0478499515475, 4535.505471990392, 4538.435783782153, 4548.158590660738, 5279.260903473517, 5280.762365693553, 5286.682799032071, 5291.894162116736, 5301.655392399482, 4466.352167190305, 4524.895923395637, 4541.750203738826, 4548.930236742274, 4550.408446901882, 2384.892679829412, 2448.6939132608422, 2449.6448015037718, 2456.287676573809, 2471.3821544613847, 4374.912501750011, 4391.494978077562, 4416.797821579329, 4418.80115394808, 4419.381286619876, 4726.527347265314, 4746.169420351424, 4759.952400476021, 4763.76181190939, 4776.952230477651, 4238.788060596958, 4288.463942007249, 4337.262665346899, 4383.715058521186, 4416.299724605986, 4625.3404292532605, 4632.675712700078, 4646.885667021429, 4649.953500464952, 4655.344655344656, 4511.3458548510935, 4576.382188404523, 4580.954190458053, 4593.563611456906, 4594.701344412602, 4066.34938409853, 4390.0025488403335, 4400.317950717644, 4421.889452763707, 4463.5313292103865, 3370.25854312051, 3371.3257348530883, 3375.8987230383127, 3386.8645254189555, 3392.609849867297, 4581.358609794698, 4613.400257966443, 4636.397268355092, 4640.6287496999485, 5095.949040509548, 5064.215046667772, 5172.870678233075, 5174.6119041072825, 5192.27308176848, 5194.506521880416, 5174.379074511083, 5175.249588809676, 5183.714895680623, 5189.662671926313, 5194.454582268807, 4912.1649319615035, 5053.797848086182, 5078.314427552233, 5079.568236699922, 5103.668261562986, 5192.922106168486, 5215.29593504872, 5221.765020574007, 5229.137192363218, 5232.136697445031, 5089.091590653505, 5112.948870511247, 5115.437301896863, 5118.155504341742, 5123.462036486264], "value": 3751.2837362628798, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4844991058137, 569.7891780041385, 579.5566391710342, 602.0998607082413, 631.7315141065047, 11827.290362578251, 12396.380180990947, 12411.255324680526, 12451.252924824517, 12586.874131258684, 14218.573442796733, 14826.332815023323, 14928.402863885432, 14968.925155374209, 14983.550493485212, 766.6013672890108, 785.9449838511307, 789.7551758954713, 790.3558599741222, 790.6916302641974, 627.7645882793952, 749.9287567681089, 778.7274453941104, 782.5930516131608, 786.3630459327934, 810.8905297784812, 816.0533780814256, 819.4264015189361, 821.8520666280067, 826.3554427546493, 809.9797505062362, 815.0016230118117, 819.7909533069089, 819.8729196974418, 820.2658620534647, 598.1297212555721, 598.4015984015984, 598.8951933411636, 599.3167788720862, 599.5263741644096, 12672.0, 12675.429605667767, 12677.492900283978, 12698.873011269861, 12714.173578717353, 12947.223166610034, 13105.86894131056, 13230.933845330712, 13248.73502529944, 13462.596122116352, 10111.494425278706, 10170.745731356776, 10226.795464090677, 10319.071283584439, 10464.581416743322, 3147.7324427423696, 3181.3001139749217, 3216.131644455984, 3226.0, 3267.986924053551, 57743.42256577423, 59687.0, 60048.69975650094, 60214.0, 64647.0, 8942.195202431813, 8994.145556172152, 9571.521423928776, 9898.752531186634, 10062.295639305325, 15587.844121558639, 15630.843691562939, 15656.92171539135, 16316.347346106022, 17423.82576174222, 6063.666498342545, 6148.6925653717135, 6208.851362497862, 6315.273743519462, 6353.205849268841, 3440.9311813763584, 3476.5306683597896, 3518.9296214075575, 3529.2412131391875, 3538.239278555123, 2765.834049957009, 2861.270376054093, 2876.6548014238424, 2884.2356775454523, 2890.523063694509, 502.93210416594025, 504.009621094551, 508.1970486631114, 509.8680928339081, 518.0183552168695, 506.78208370400347, 510.6655140882728, 545.5635491606698, 572.1703529881605, 572.7250919558635, 7640.197779233101, 8123.309518690978, 8163.79590510242, 8239.670413183525, 8362.121977192308, 485.39325842696627, 520.8801975545646, 556.5992485410497, 559.541176235483, 572.8510587247263, 3624.184558474375, 3676.3933950897804, 3844.1350696093714, 3953.0, 3995.680345572347, 92937.53531232435, 93492.53253733688, 94222.0, 95394.52302738442, 95411.0, 84551.0, 85930.0, 85944.57027714822, 86774.0, 87085.0, 72139.0, 73344.0, 73986.0, 74583.62708186424, 76541.99999999888, 7276.1996180419055, 7280.0, 7510.136334321623, 7541.132769731551, 7760.68957241704, 31529.0, 38718.0, 39132.0, 40320.798396007835, 44686.0, 37804.621953781214, 43896.56103438925, 51031.234531481314, 57358.71320643537, 60739.39260607514, 10773.676789696321, 11064.778704426028, 11113.777724445628, 11160.064572209114, 11511.07911367072, 12307.87692123103, 12811.423485943342, 12873.549425770054, 12987.0, 13079.476820927057, 11110.333379997226, 11541.769164616493, 11564.306141631529, 11618.244814087395, 11784.935916661902, 10885.23803333759, 10962.232643714864, 10991.450427478434, 11046.0, 11104.555817767521, 10716.89283107159, 10770.407627580558, 11077.224594278323, 11296.83054754163, 11342.546298147981, 9770.169535589555, 9781.755456113655, 10037.421084364585, 10221.846672300071, 10365.222608304257, 10185.287029908131, 10313.845292320471, 10358.171346292127, 10389.792204155723, 10467.895321046692], "value": 6321.158488236961, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1624.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 115.0, 118.0, 119.0, 118.0, 121.0, 120.0, 116.0, 115.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 131.0, 156.0, 182.0, 128.0, 153.0, 151.0, 127.0, 178.0, 131.0], "value": 148.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 164.0, 165.0, 169.0, 164.0, 166.0, 164.0, 166.0, 164.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 177.0, 80.0, 77.0, 77.0, 78.0, 166.0, 79.0], "value": 96.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 143.0, 89.0, 87.0, 90.0, 134.0, 100.0, 93.0, 146.0], "value": 106.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 120.0, 119.0, 135.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 121.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 150.0, 149.0, 147.0, 148.0, 150.0, 148.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 119.0, 111.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0], "value": 100.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 65.0, 67.0, 68.0, 66.0, 66.0, 65.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 78.0, 66.0, 66.0, 67.0, 65.0, 64.0, 68.0, 67.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 85.0, 86.0, 84.0, 87.0, 86.0, 89.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 141.0, 148.0, 136.0, 148.0, 154.0, 153.0, 145.0, 159.0, 140.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 184.0, 176.0, 178.0, 183.0, 184.0, 181.0, 177.0, 177.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 72.0, 69.0, 70.0, 75.0, 82.0, 72.0, 71.0, 74.0], "value": 72.6, "unit": "score"}]}]} 19:51:21 INFO - Return code: 0 19:51:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:51:21 ERROR - # TBPL SUCCESS # 19:51:21 INFO - Running post-action listener: _resource_record_post_action 19:51:21 INFO - [mozharness: 2016-08-20 02:51:21.549415Z] Finished run-tests step (success) 19:51:21 INFO - Running post-run listener: _resource_record_post_run 19:51:21 INFO - Total resource usage - Wall time: 1203s; CPU: 14.0%; Read bytes: 7663616; Write bytes: 418996224; Read time: 1412; Write time: 287044 19:51:21 INFO - TinderboxPrint: CPU usage
13.9% 19:51:21 INFO - TinderboxPrint: I/O read bytes / time
7,663,616 / 1,412 19:51:21 INFO - TinderboxPrint: I/O write bytes / time
418,996,224 / 287,044 19:51:21 INFO - TinderboxPrint: CPU idle
8,259.1 (86.1%) 19:51:21 INFO - TinderboxPrint: CPU user
1,235.5 (12.9%) 19:51:21 INFO - TinderboxPrint: Swap in / out
0 / 0 19:51:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 83709952; Read time: 168; Write time: 46868 19:51:21 INFO - run-tests - Wall time: 1188s; CPU: 14.0%; Read bytes: 5419008; Write bytes: 335286272; Read time: 1016; Write time: 240176 19:51:22 INFO - Running post-run listener: _upload_blobber_files 19:51:22 INFO - Blob upload gear active. 19:51:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:51:22 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 19:51:22 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'] 19:51:22 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 19:51:22 INFO - (blobuploader) - INFO - Open directory for files ... 19:51:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:51:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:51:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:51:26 INFO - (blobuploader) - INFO - Done attempting. 19:51:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:51:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:51:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:51:27 INFO - (blobuploader) - INFO - Done attempting. 19:51:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:51:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:51:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:51:28 INFO - (blobuploader) - INFO - Done attempting. 19:51:28 INFO - (blobuploader) - INFO - Iteration through files over. 19:51:28 INFO - Return code: 0 19:51:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:51:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:51:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36a58728744d72f2181f11fdcd11d979787697a6b59b586281d4c9d7cb5fda3040abe9274227843c2876de75befe51a4c6e7510ef38a52c2ed446d8277e7f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4f4803bc9b1171c4281b4ae6f9bb254f9afdb1a64168af66a1644f3be75851208544f6559dcad7ea1064274dd38bf69bb87672e26aa4054e46f39fe69ca8a46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0072ed8a757a1cc081800e4de461863dad348ce7f2cd7b87994b1e30853668e44d141ac5508beac82f7ed7f6fe907d174295b83acb8553ef3496d5dce26a03cf"} 19:51:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:51:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:51:28 INFO - Contents: 19:51:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36a58728744d72f2181f11fdcd11d979787697a6b59b586281d4c9d7cb5fda3040abe9274227843c2876de75befe51a4c6e7510ef38a52c2ed446d8277e7f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4f4803bc9b1171c4281b4ae6f9bb254f9afdb1a64168af66a1644f3be75851208544f6559dcad7ea1064274dd38bf69bb87672e26aa4054e46f39fe69ca8a46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0072ed8a757a1cc081800e4de461863dad348ce7f2cd7b87994b1e30853668e44d141ac5508beac82f7ed7f6fe907d174295b83acb8553ef3496d5dce26a03cf"} 19:51:28 INFO - Running post-run listener: copy_logs_to_upload_dir 19:51:28 INFO - Copying logs to upload dir... 19:51:28 INFO - mkdir: /builds/slave/test/build/upload/logs 19:51:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.138592 ========= master_lag: 0.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-08-19 19:51:28.879360) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 19:51:28.884200) ========= 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=cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683 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/36a58728744d72f2181f11fdcd11d979787697a6b59b586281d4c9d7cb5fda3040abe9274227843c2876de75befe51a4c6e7510ef38a52c2ed446d8277e7f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4f4803bc9b1171c4281b4ae6f9bb254f9afdb1a64168af66a1644f3be75851208544f6559dcad7ea1064274dd38bf69bb87672e26aa4054e46f39fe69ca8a46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0072ed8a757a1cc081800e4de461863dad348ce7f2cd7b87994b1e30853668e44d141ac5508beac82f7ed7f6fe907d174295b83acb8553ef3496d5dce26a03cf"} build_url:https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/FM15E68oTE-SpNwlTi-Bcg/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/36a58728744d72f2181f11fdcd11d979787697a6b59b586281d4c9d7cb5fda3040abe9274227843c2876de75befe51a4c6e7510ef38a52c2ed446d8277e7f46c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4f4803bc9b1171c4281b4ae6f9bb254f9afdb1a64168af66a1644f3be75851208544f6559dcad7ea1064274dd38bf69bb87672e26aa4054e46f39fe69ca8a46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0072ed8a757a1cc081800e4de461863dad348ce7f2cd7b87994b1e30853668e44d141ac5508beac82f7ed7f6fe907d174295b83acb8553ef3496d5dce26a03cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-19 19:51:28.917363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:51:28.917811) ========= 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=cbe409c6de289db6ac707de3000001d4-1471650768.460480-1200763683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-19 19:51:29.214149) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 19:51:29.214466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-19 19:51:29.214822) ========= ========= Total master_lag: 1.37 =========