builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1475477260.91 results: success (0) buildid: 20161002223356 builduid: 65c899af787f4ac4b2b9800c3b9c0f1f revision: 955840bfd3c20eb24dd5a01be27bdc55c489a285 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:40.905690) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:40.906077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:40.906427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:40.940370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:40.940663) ========= 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=41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-02 23:47:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-10-02 23:47:41 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098563 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.053253) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.053569) ========= 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=41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015075 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.104108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.104425) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 955840bfd3c20eb24dd5a01be27bdc55c489a285 --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 955840bfd3c20eb24dd5a01be27bdc55c489a285 --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=41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-02 23:47:41,219 truncating revision to first 12 chars 2016-10-02 23:47:41,219 Setting DEBUG logging. 2016-10-02 23:47:41,219 attempt 1/10 2016-10-02 23:47:41,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/955840bfd3c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-02 23:47:41,679 unpacking tar archive at: mozilla-central-955840bfd3c2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762981 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.880963) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.881311) ========= script_repo_revision: 955840bfd3c20eb24dd5a01be27bdc55c489a285 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.881740) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.882016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-02 23:47:41.892501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-02 23:47:41.892784) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:47:42 INFO - MultiFileLogger online at 20161002 23:47:42 in /builds/slave/test 23:47:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 23:47:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:47:42 INFO - {'append_to_log': False, 23:47:42 INFO - 'base_work_dir': '/builds/slave/test', 23:47:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:47:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:47:42 INFO - 'branch': 'Firefox-Non-PGO', 23:47:42 INFO - 'buildbot_json_path': 'buildprops.json', 23:47:42 INFO - 'config_files': ('talos/linux_config.py',), 23:47:42 INFO - 'default_actions': ('clobber', 23:47:42 INFO - 'read-buildbot-config', 23:47:42 INFO - 'download-and-extract', 23:47:42 INFO - 'populate-webroot', 23:47:42 INFO - 'create-virtualenv', 23:47:42 INFO - 'install', 23:47:42 INFO - 'run-tests'), 23:47:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:47:42 INFO - 'download_minidump_stackwalk': True, 23:47:42 INFO - 'download_symbols': 'ondemand', 23:47:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:47:42 INFO - 'tooltool.py': '/tools/tooltool.py', 23:47:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:47:42 INFO - '/tools/misc-python/virtualenv.py')}, 23:47:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:47:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:47:42 INFO - 'installer_path': 'installer.exe', 23:47:42 INFO - 'log_level': 'info', 23:47:42 INFO - 'log_name': 'talos', 23:47:42 INFO - 'log_to_console': True, 23:47:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:47:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:47:42 INFO - 'opt_config_files': (), 23:47:42 INFO - 'pip_index': False, 23:47:42 INFO - 'sps_profile': False, 23:47:42 INFO - 'sps_profile_interval': 0, 23:47:42 INFO - 'suite': 'dromaeojs', 23:47:42 INFO - 'system_bits': '32', 23:47:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:47:42 INFO - 'title': 'talos-linux64-ix-026', 23:47:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:47:42 INFO - 'use_talos_json': True, 23:47:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:47:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:47:42 INFO - 'work_dir': 'build'} 23:47:42 INFO - [mozharness: 2016-10-03 06:47:42.096312Z] Running clobber step. 23:47:42 INFO - Running pre-action listener: _resource_record_pre_action 23:47:42 INFO - Running main action method: clobber 23:47:42 INFO - rmtree: /builds/slave/test/build 23:47:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:47:42 INFO - Running post-action listener: _resource_record_post_action 23:47:42 INFO - [mozharness: 2016-10-03 06:47:42.551499Z] Finished clobber step (success) 23:47:42 INFO - [mozharness: 2016-10-03 06:47:42.551599Z] Running read-buildbot-config step. 23:47:42 INFO - Running pre-action listener: _resource_record_pre_action 23:47:42 INFO - Running main action method: read_buildbot_config 23:47:42 INFO - Using buildbot properties: 23:47:42 INFO - { 23:47:42 INFO - "project": "", 23:47:42 INFO - "product": "firefox", 23:47:42 INFO - "script_repo_revision": "production", 23:47:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 23:47:42 INFO - "repository": "", 23:47:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 23:47:42 INFO - "buildid": "20161002223356", 23:47:42 INFO - "pgo_build": "False", 23:47:42 INFO - "basedir": "/builds/slave/test", 23:47:42 INFO - "buildnumber": 229, 23:47:42 INFO - "slavename": "talos-linux64-ix-026", 23:47:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:47:42 INFO - "platform": "ubuntu64_hw", 23:47:42 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 23:47:42 INFO - "branch": "mozilla-central", 23:47:42 INFO - "repo_path": "mozilla-central", 23:47:42 INFO - "revision": "955840bfd3c20eb24dd5a01be27bdc55c489a285", 23:47:42 INFO - "stage_platform": "linux64", 23:47:42 INFO - "builduid": "65c899af787f4ac4b2b9800c3b9c0f1f", 23:47:42 INFO - "slavebuilddir": "test" 23:47:42 INFO - } 23:47:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:47:42 INFO - Running post-action listener: _resource_record_post_action 23:47:42 INFO - [mozharness: 2016-10-03 06:47:42.554026Z] Finished read-buildbot-config step (success) 23:47:42 INFO - [mozharness: 2016-10-03 06:47:42.554114Z] Running download-and-extract step. 23:47:42 INFO - Running pre-action listener: _resource_record_pre_action 23:47:42 INFO - Running main action method: download_and_extract 23:47:42 INFO - mkdir: /builds/slave/test/build/tests 23:47:42 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')]} 23:47:42 INFO - trying https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:47:42 INFO - Downloading https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:47:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:47:43 INFO - Downloaded 1361 bytes. 23:47:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:47:43 INFO - Using the following test package requirements: 23:47:43 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:47:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:47:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:47:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'jsshell-linux-x86_64.zip'], 23:47:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:47:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:47:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:47:43 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:47:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:47:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:47:43 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:47:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:47:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:47:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:47:43 INFO - Fetch https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:47:43 INFO - Http code: 200 23:47:43 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 23:47:43 INFO - x-amz-cf-id: 8zLhS9ImfeTauO1DJZK4O4Fgu_K8HHpJUjy6JFPORrJWPTTRFSsS1Q== 23:47:43 INFO - x-amz-version-id: ic93egK6i0iHKFYpEsopzIQ9xhBRT7fV 23:47:44 INFO - Expected file size: 20420396 23:47:44 INFO - Obtained file size: 20420396 23:47:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:47:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:47:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:47:48 INFO - Fetch https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:47:49 INFO - Http code: 200 23:47:49 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 23:47:49 INFO - x-amz-cf-id: VkkqVvCdmuOHSvBLbg2Eh9C_494gzOSNSqXcwLWmQuoluHSCzLRC2g== 23:47:49 INFO - x-amz-version-id: ic93egK6i0iHKFYpEsopzIQ9xhBRT7fV 23:47:49 INFO - Expected file size: 20420396 23:47:49 INFO - Obtained file size: 20420396 23:47:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:47:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:47:54 INFO - Fetch https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:47:54 INFO - Http code: 200 23:47:54 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 23:47:54 INFO - x-amz-cf-id: SYQJkR9X-b9Nl0Vqk9r80puYyhtTPuCw3NYqZk0tSnqb5a5UkDvovw== 23:47:54 INFO - x-amz-version-id: Syy_4BrOYpgZLL5mHPESwTCaCmRje8e9 23:47:55 INFO - Expected file size: 14408522 23:47:55 INFO - Obtained file size: 14408522 23:47:55 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')]} 23:47:55 INFO - trying https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:47:55 INFO - Downloading https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:47:58 INFO - Downloaded 55820404 bytes. 23:47:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:47:58 INFO - mkdir: /builds/slave/test/properties 23:47:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:47:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:47:58 INFO - Contents: 23:47:58 INFO - build_url:https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:47:58 INFO - Running post-action listener: _resource_record_post_action 23:47:58 INFO - Running post-action listener: set_extra_try_arguments 23:47:58 INFO - [mozharness: 2016-10-03 06:47:58.810611Z] Finished download-and-extract step (success) 23:47:58 INFO - [mozharness: 2016-10-03 06:47:58.810836Z] Running populate-webroot step. 23:47:58 INFO - Running pre-action listener: _resource_record_pre_action 23:47:58 INFO - Running main action method: populate_webroot 23:47:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:47:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:47:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:47:58 INFO - '--tppagecycles', 23:47:58 INFO - '7'], 23:47:58 INFO - 'tests': ['tsvgm']}}, 23:47:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:47:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:47:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:47:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:47:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:47:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:47:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['damp', 'tps']}, 23:47:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'tests': ['damp', 'tps']}, 23:47:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['dromaeo_dom']}, 23:47:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:47:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['basic_compositor_video']}, 23:47:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:47:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['a11yr', 23:47:58 INFO - 'ts_paint', 23:47:58 INFO - 'tpaint', 23:47:58 INFO - 'sessionrestore', 23:47:58 INFO - 'sessionrestore_no_auto_restore', 23:47:58 INFO - 'tabpaint']}, 23:47:58 INFO - 'other-e10s': {'tests': ['a11yr', 23:47:58 INFO - 'ts_paint', 23:47:58 INFO - 'tpaint', 23:47:58 INFO - 'sessionrestore', 23:47:58 INFO - 'sessionrestore_no_auto_restore', 23:47:58 INFO - 'tabpaint']}, 23:47:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:47:58 INFO - 'ts_paint', 23:47:58 INFO - 'tpaint', 23:47:58 INFO - 'sessionrestore', 23:47:58 INFO - 'sessionrestore_no_auto_restore', 23:47:58 INFO - 'tabpaint']}, 23:47:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:47:58 INFO - 'ts_paint', 23:47:58 INFO - 'tpaint', 23:47:58 INFO - 'sessionrestore', 23:47:58 INFO - 'sessionrestore_no_auto_restore', 23:47:58 INFO - 'tabpaint']}, 23:47:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['a11yr', 23:47:58 INFO - 'ts_paint', 23:47:58 INFO - 'tpaint', 23:47:58 INFO - 'sessionrestore', 23:47:58 INFO - 'sessionrestore_no_auto_restore', 23:47:58 INFO - 'tabpaint']}, 23:47:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['a11yr', 23:47:58 INFO - 'ts_paint', 23:47:58 INFO - 'tpaint', 23:47:58 INFO - 'sessionrestore', 23:47:58 INFO - 'sessionrestore_no_auto_restore', 23:47:58 INFO - 'tabpaint']}, 23:47:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['tsvgx', 23:47:58 INFO - 'tsvgr_opacity', 23:47:58 INFO - 'tart', 23:47:58 INFO - 'tscrollx', 23:47:58 INFO - 'cart']}, 23:47:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:47:58 INFO - 'tsvgr_opacity', 23:47:58 INFO - 'tart', 23:47:58 INFO - 'tscrollx', 23:47:58 INFO - 'cart']}, 23:47:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'talos_options': ['--disable-e10s'], 23:47:58 INFO - 'tests': ['tp5o']}, 23:47:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'tests': ['tp5o']}, 23:47:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'talos_options': ['--disable-e10s', 23:47:58 INFO - '--xperf_path', 23:47:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:47:58 INFO - 'tests': ['tp5n']}, 23:47:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:47:58 INFO - 'talos_options': ['--xperf_path', 23:47:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:47:58 INFO - 'tests': ['tp5n']}}, 23:47:58 INFO - 'talos.zip': {'path': '', 23:47:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:47:58 INFO - Running post-action listener: _resource_record_post_action 23:47:58 INFO - [mozharness: 2016-10-03 06:47:58.830172Z] Finished populate-webroot step (success) 23:47:58 INFO - [mozharness: 2016-10-03 06:47:58.830260Z] Running create-virtualenv step. 23:47:58 INFO - Running pre-action listener: _resource_record_pre_action 23:47:58 INFO - Running main action method: create_virtualenv 23:47:58 INFO - Creating virtualenv /builds/slave/test/build/venv 23:47:58 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 23:47:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:47:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:47:58 INFO - Using real prefix '/usr' 23:47:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:47:59 INFO - Installing distribute.............................................................................................................................................................................................done. 23:48:01 INFO - Installing pip.................done. 23:48:01 INFO - Return code: 0 23:48:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:48:01 INFO - Reading from file tmpfile_stdout 23:48:01 INFO - Output received: 23:48:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 23:48:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48: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', 'pip>=1.5'] in /builds/slave/test/build 23:48: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 pip>=1.5 23:48:01 INFO - Using env: {'DISPLAY': ':0', 23:48:01 INFO - 'HOME': '/home/cltbld', 23:48:01 INFO - 'LANG': 'en_US.UTF-8', 23:48:01 INFO - 'LANGUAGE': 'en_US:en', 23:48:01 INFO - 'LOGNAME': 'cltbld', 23:48:01 INFO - 'MAIL': '/var/mail/cltbld', 23:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:01 INFO - 'MOZ_NO_REMOTE': '1', 23:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:01 INFO - 'NO_EM_RESTART': '1', 23:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:01 INFO - 'PWD': '/builds/slave/test', 23:48:01 INFO - 'SHELL': '/bin/bash', 23:48:01 INFO - 'SHLVL': '1', 23:48:01 INFO - 'TERM': 'linux', 23:48:01 INFO - 'TMOUT': '86400', 23:48:01 INFO - 'USER': 'cltbld', 23:48:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:01 INFO - '_': '/tools/buildbot/bin/python'} 23:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:01 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 23:48:01 INFO - Cleaning up... 23:48:01 INFO - Return code: 0 23:48:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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', '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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:48: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 psutil>=3.1.1 23:48:01 INFO - Using env: {'DISPLAY': ':0', 23:48:01 INFO - 'HOME': '/home/cltbld', 23:48:01 INFO - 'LANG': 'en_US.UTF-8', 23:48:01 INFO - 'LANGUAGE': 'en_US:en', 23:48:01 INFO - 'LOGNAME': 'cltbld', 23:48:01 INFO - 'MAIL': '/var/mail/cltbld', 23:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:01 INFO - 'MOZ_NO_REMOTE': '1', 23:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:01 INFO - 'NO_EM_RESTART': '1', 23:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:01 INFO - 'PWD': '/builds/slave/test', 23:48:01 INFO - 'SHELL': '/bin/bash', 23:48:01 INFO - 'SHLVL': '1', 23:48:01 INFO - 'TERM': 'linux', 23:48:01 INFO - 'TMOUT': '86400', 23:48:01 INFO - 'USER': 'cltbld', 23:48:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:01 INFO - '_': '/tools/buildbot/bin/python'} 23:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:02 INFO - Downloading/unpacking psutil>=3.1.1 23:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:48:04 INFO - Installing collected packages: psutil 23:48:04 INFO - Running setup.py install for psutil 23:48:04 INFO - building 'psutil._psutil_linux' extension 23:48:04 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 23:48:04 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 23:48:04 INFO - building 'psutil._psutil_posix' extension 23:48:04 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 23:48:04 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 23:48:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:48:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:48:04 INFO - Successfully installed psutil 23:48:04 INFO - Cleaning up... 23:48:04 INFO - Return code: 0 23:48:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:48:04 INFO - Using env: {'DISPLAY': ':0', 23:48:04 INFO - 'HOME': '/home/cltbld', 23:48:04 INFO - 'LANG': 'en_US.UTF-8', 23:48:04 INFO - 'LANGUAGE': 'en_US:en', 23:48:04 INFO - 'LOGNAME': 'cltbld', 23:48:04 INFO - 'MAIL': '/var/mail/cltbld', 23:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:04 INFO - 'MOZ_NO_REMOTE': '1', 23:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:04 INFO - 'NO_EM_RESTART': '1', 23:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:04 INFO - 'PWD': '/builds/slave/test', 23:48:04 INFO - 'SHELL': '/bin/bash', 23:48:04 INFO - 'SHLVL': '1', 23:48:04 INFO - 'TERM': 'linux', 23:48:04 INFO - 'TMOUT': '86400', 23:48:04 INFO - 'USER': 'cltbld', 23:48:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:04 INFO - '_': '/tools/buildbot/bin/python'} 23:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:48:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:48:06 INFO - Installing collected packages: mozsystemmonitor 23:48:06 INFO - Running setup.py install for mozsystemmonitor 23:48:06 INFO - Successfully installed mozsystemmonitor 23:48:06 INFO - Cleaning up... 23:48:06 INFO - Return code: 0 23:48:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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', '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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:48: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 jsonschema==2.5.1 23:48:06 INFO - Using env: {'DISPLAY': ':0', 23:48:06 INFO - 'HOME': '/home/cltbld', 23:48:06 INFO - 'LANG': 'en_US.UTF-8', 23:48:06 INFO - 'LANGUAGE': 'en_US:en', 23:48:06 INFO - 'LOGNAME': 'cltbld', 23:48:06 INFO - 'MAIL': '/var/mail/cltbld', 23:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:06 INFO - 'MOZ_NO_REMOTE': '1', 23:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:06 INFO - 'NO_EM_RESTART': '1', 23:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:06 INFO - 'PWD': '/builds/slave/test', 23:48:06 INFO - 'SHELL': '/bin/bash', 23:48:06 INFO - 'SHLVL': '1', 23:48:06 INFO - 'TERM': 'linux', 23:48:06 INFO - 'TMOUT': '86400', 23:48:06 INFO - 'USER': 'cltbld', 23:48:06 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:06 INFO - '_': '/tools/buildbot/bin/python'} 23:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:07 INFO - Downloading/unpacking jsonschema==2.5.1 23:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:48:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:48: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 23:48: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 23:48: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 23:48: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 23:48: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 23:48: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 23:48:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:48:09 INFO - warning: no files found matching '*.txt' 23:48:09 INFO - no previously-included directories found matching 'build' 23:48:09 INFO - no previously-included directories found matching 'dist' 23:48:09 INFO - no previously-included directories found matching '.git*' 23:48:09 INFO - Installing collected packages: jsonschema, functools32 23:48:09 INFO - Running setup.py install for functools32 23:48:09 INFO - warning: no files found matching '*.txt' 23:48:09 INFO - no previously-included directories found matching 'build' 23:48:09 INFO - no previously-included directories found matching 'dist' 23:48:09 INFO - no previously-included directories found matching '.git*' 23:48:09 INFO - Successfully installed jsonschema functools32 23:48:09 INFO - Cleaning up... 23:48:09 INFO - Return code: 0 23:48:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:09 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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48:09 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 23:48:09 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 23:48:09 INFO - Using env: {'DISPLAY': ':0', 23:48:09 INFO - 'HOME': '/home/cltbld', 23:48:09 INFO - 'LANG': 'en_US.UTF-8', 23:48:09 INFO - 'LANGUAGE': 'en_US:en', 23:48:09 INFO - 'LOGNAME': 'cltbld', 23:48:09 INFO - 'MAIL': '/var/mail/cltbld', 23:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:09 INFO - 'MOZ_NO_REMOTE': '1', 23:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:09 INFO - 'NO_EM_RESTART': '1', 23:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:09 INFO - 'PWD': '/builds/slave/test', 23:48:09 INFO - 'SHELL': '/bin/bash', 23:48:09 INFO - 'SHLVL': '1', 23:48:09 INFO - 'TERM': 'linux', 23:48:09 INFO - 'TMOUT': '86400', 23:48:09 INFO - 'USER': 'cltbld', 23:48:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:09 INFO - '_': '/tools/buildbot/bin/python'} 23:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:48:09 INFO - Cleaning up... 23:48:09 INFO - Return code: 0 23:48:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:09 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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48:09 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 23:48:09 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 23:48:09 INFO - Using env: {'DISPLAY': ':0', 23:48:09 INFO - 'HOME': '/home/cltbld', 23:48:09 INFO - 'LANG': 'en_US.UTF-8', 23:48:09 INFO - 'LANGUAGE': 'en_US:en', 23:48:09 INFO - 'LOGNAME': 'cltbld', 23:48:09 INFO - 'MAIL': '/var/mail/cltbld', 23:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:09 INFO - 'MOZ_NO_REMOTE': '1', 23:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:09 INFO - 'NO_EM_RESTART': '1', 23:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:09 INFO - 'PWD': '/builds/slave/test', 23:48:09 INFO - 'SHELL': '/bin/bash', 23:48:09 INFO - 'SHLVL': '1', 23:48:09 INFO - 'TERM': 'linux', 23:48:09 INFO - 'TMOUT': '86400', 23:48:09 INFO - 'USER': 'cltbld', 23:48:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:09 INFO - '_': '/tools/buildbot/bin/python'} 23:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:09 INFO - Downloading/unpacking blobuploader==1.2.4 23:48: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 23:48: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 23:48: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 23:48: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 23:48: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 23:48: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 23:48:11 INFO - Downloading blobuploader-1.2.4.tar.gz 23:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:48:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:48:11 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 23:48:11 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 23:48:11 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 23:48:11 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 23:48:11 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 23:48:11 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 23:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:48:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:48:12 INFO - Downloading docopt-0.6.1.tar.gz 23:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:48:12 INFO - Installing collected packages: blobuploader, requests, docopt 23:48:12 INFO - Running setup.py install for blobuploader 23:48:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:48:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:48:12 INFO - Running setup.py install for requests 23:48:13 INFO - Running setup.py install for docopt 23:48:13 INFO - Successfully installed blobuploader requests docopt 23:48:13 INFO - Cleaning up... 23:48:13 INFO - Return code: 0 23:48:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48: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')]} 23:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48: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')]} 23:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:13 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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48:13 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 23:48:13 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 23:48:13 INFO - Using env: {'DISPLAY': ':0', 23:48:13 INFO - 'HOME': '/home/cltbld', 23:48:13 INFO - 'LANG': 'en_US.UTF-8', 23:48:13 INFO - 'LANGUAGE': 'en_US:en', 23:48:13 INFO - 'LOGNAME': 'cltbld', 23:48:13 INFO - 'MAIL': '/var/mail/cltbld', 23:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:13 INFO - 'MOZ_NO_REMOTE': '1', 23:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:13 INFO - 'NO_EM_RESTART': '1', 23:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:13 INFO - 'PWD': '/builds/slave/test', 23:48:13 INFO - 'SHELL': '/bin/bash', 23:48:13 INFO - 'SHLVL': '1', 23:48:13 INFO - 'TERM': 'linux', 23:48:13 INFO - 'TMOUT': '86400', 23:48:13 INFO - 'USER': 'cltbld', 23:48:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:13 INFO - '_': '/tools/buildbot/bin/python'} 23:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:48:13 INFO - Running setup.py (path:/tmp/pip-YAFixN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:48:13 INFO - Running setup.py (path:/tmp/pip-zmoRN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:48:13 INFO - Running setup.py (path:/tmp/pip-2FcaQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:48:13 INFO - Running setup.py (path:/tmp/pip-rSnrwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:48:13 INFO - Running setup.py (path:/tmp/pip-qoLrza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:48:13 INFO - Running setup.py (path:/tmp/pip-3Mg0qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:48:13 INFO - Running setup.py (path:/tmp/pip-MWioAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:48:13 INFO - Running setup.py (path:/tmp/pip-KIJQ3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:48:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:48:13 INFO - Running setup.py (path:/tmp/pip-BOVmlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:48:14 INFO - Running setup.py (path:/tmp/pip-t58iFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:48:14 INFO - Running setup.py (path:/tmp/pip-ek4UpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:48:14 INFO - Running setup.py (path:/tmp/pip-M2MICD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:48:14 INFO - Running setup.py (path:/tmp/pip-f2Vz_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:48:14 INFO - Running setup.py (path:/tmp/pip-lBDGoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:14 INFO - Running setup.py (path:/tmp/pip-GgBEb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:48:14 INFO - Running setup.py (path:/tmp/pip-VjPBhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:48:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:48:14 INFO - Running setup.py (path:/tmp/pip-3dCppZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:48:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:48:14 INFO - Running setup.py install for manifestparser 23:48:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:48:14 INFO - Running setup.py install for mozcrash 23:48:14 INFO - Running setup.py install for mozdebug 23:48:14 INFO - Running setup.py install for mozdevice 23:48:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Running setup.py install for mozfile 23:48:15 INFO - Running setup.py install for mozhttpd 23:48:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Running setup.py install for mozinfo 23:48:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Running setup.py install for mozInstall 23:48:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Running setup.py install for mozleak 23:48:15 INFO - Running setup.py install for mozlog 23:48:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Running setup.py install for moznetwork 23:48:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Running setup.py install for mozprocess 23:48:15 INFO - Running setup.py install for mozprofile 23:48:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:48:15 INFO - Running setup.py install for mozrunner 23:48:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:48:16 INFO - Running setup.py install for mozscreenshot 23:48:16 INFO - Running setup.py install for moztest 23:48:16 INFO - Running setup.py install for mozversion 23:48:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:48:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:48:16 INFO - Cleaning up... 23:48:16 INFO - Return code: 0 23:48:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:16 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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48:16 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 23:48:16 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 23:48:16 INFO - Using env: {'DISPLAY': ':0', 23:48:16 INFO - 'HOME': '/home/cltbld', 23:48:16 INFO - 'LANG': 'en_US.UTF-8', 23:48:16 INFO - 'LANGUAGE': 'en_US:en', 23:48:16 INFO - 'LOGNAME': 'cltbld', 23:48:16 INFO - 'MAIL': '/var/mail/cltbld', 23:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:16 INFO - 'MOZ_NO_REMOTE': '1', 23:48:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:16 INFO - 'NO_EM_RESTART': '1', 23:48:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:16 INFO - 'PWD': '/builds/slave/test', 23:48:16 INFO - 'SHELL': '/bin/bash', 23:48:16 INFO - 'SHLVL': '1', 23:48:16 INFO - 'TERM': 'linux', 23:48:16 INFO - 'TMOUT': '86400', 23:48:16 INFO - 'USER': 'cltbld', 23:48:16 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:16 INFO - '_': '/tools/buildbot/bin/python'} 23:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:48:16 INFO - Running setup.py (path:/tmp/pip-toEVKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:48:16 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)) 23:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:48:16 INFO - Running setup.py (path:/tmp/pip-djZW1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:48:16 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)) 23:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:48:16 INFO - Running setup.py (path:/tmp/pip-TyITpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:48:16 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)) 23:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:48:16 INFO - Running setup.py (path:/tmp/pip-IrwUR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:48:16 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)) 23:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:48:16 INFO - Running setup.py (path:/tmp/pip-meGKvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:48:16 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)) 23:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:48:16 INFO - Running setup.py (path:/tmp/pip-K9ZAxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:48:17 INFO - Running setup.py (path:/tmp/pip-46F4Zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:48:17 INFO - Running setup.py (path:/tmp/pip-bo0BO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:48:17 INFO - Running setup.py (path:/tmp/pip-xIEcKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:48:17 INFO - Running setup.py (path:/tmp/pip-t7IJlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:48:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:48:17 INFO - Running setup.py (path:/tmp/pip-CbFjtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:48:17 INFO - Running setup.py (path:/tmp/pip-Mi39vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:48:17 INFO - Running setup.py (path:/tmp/pip-3_L_9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:48:17 INFO - Running setup.py (path:/tmp/pip-CTbXQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:17 INFO - Running setup.py (path:/tmp/pip-D4PKal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:48:17 INFO - Running setup.py (path:/tmp/pip-jvg0dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:48:17 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)) 23:48:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:48:17 INFO - Running setup.py (path:/tmp/pip-yoBTYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:48:17 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)) 23:48:17 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)) 23:48:17 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)) 23:48:17 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)) 23:48:17 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)) 23:48:17 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)) 23:48:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:48:17 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 23:48:17 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 23:48:17 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 23:48:17 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 23:48:17 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 23:48:17 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 23:48:19 INFO - Downloading blessings-1.6.tar.gz 23:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:48:19 INFO - Installing collected packages: blessings 23:48:19 INFO - Running setup.py install for blessings 23:48:19 INFO - Successfully installed blessings 23:48:19 INFO - Cleaning up... 23:48:20 INFO - Return code: 0 23:48:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:48:20 INFO - Reading from file tmpfile_stdout 23:48:20 INFO - Current package versions: 23:48:20 INFO - argparse == 1.2.1 23:48:20 INFO - blessings == 1.6 23:48:20 INFO - blobuploader == 1.2.4 23:48:20 INFO - docopt == 0.6.1 23:48:20 INFO - functools32 == 3.2.3-2 23:48:20 INFO - jsonschema == 2.5.1 23:48:20 INFO - manifestparser == 1.1 23:48:20 INFO - mozInstall == 1.12 23:48:20 INFO - mozcrash == 0.17 23:48:20 INFO - mozdebug == 0.1 23:48:20 INFO - mozdevice == 0.48 23:48:20 INFO - mozfile == 1.2 23:48:20 INFO - mozhttpd == 0.7 23:48:20 INFO - mozinfo == 0.9 23:48:20 INFO - mozleak == 0.1 23:48:20 INFO - mozlog == 3.4 23:48:20 INFO - moznetwork == 0.27 23:48:20 INFO - mozprocess == 0.23 23:48:20 INFO - mozprofile == 0.28 23:48:20 INFO - mozrunner == 6.12 23:48:20 INFO - mozscreenshot == 0.1 23:48:20 INFO - mozsystemmonitor == 0.3 23:48:20 INFO - moztest == 0.7 23:48:20 INFO - mozversion == 1.4 23:48:20 INFO - psutil == 3.1.1 23:48:20 INFO - requests == 1.2.3 23:48:20 INFO - wsgiref == 0.1.2 23:48:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:48:20 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')]} 23:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:20 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')]} 23:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:20 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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48:20 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 23:48:20 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 23:48:20 INFO - Using env: {'DISPLAY': ':0', 23:48:20 INFO - 'HOME': '/home/cltbld', 23:48:20 INFO - 'LANG': 'en_US.UTF-8', 23:48:20 INFO - 'LANGUAGE': 'en_US:en', 23:48:20 INFO - 'LOGNAME': 'cltbld', 23:48:20 INFO - 'MAIL': '/var/mail/cltbld', 23:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:20 INFO - 'MOZ_NO_REMOTE': '1', 23:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:20 INFO - 'NO_EM_RESTART': '1', 23:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:20 INFO - 'PWD': '/builds/slave/test', 23:48:20 INFO - 'SHELL': '/bin/bash', 23:48:20 INFO - 'SHLVL': '1', 23:48:20 INFO - 'TERM': 'linux', 23:48:20 INFO - 'TMOUT': '86400', 23:48:20 INFO - 'USER': 'cltbld', 23:48:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:20 INFO - '_': '/tools/buildbot/bin/python'} 23:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 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)) 23:48:20 INFO - Cleaning up... 23:48:20 INFO - Return code: 0 23:48:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:48:20 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')]} 23:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:20 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')]} 23:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:48:20 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 0x7f752d56ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, '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': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', '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 23:48:20 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 23:48:20 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 23:48:20 INFO - Using env: {'DISPLAY': ':0', 23:48:20 INFO - 'HOME': '/home/cltbld', 23:48:20 INFO - 'LANG': 'en_US.UTF-8', 23:48:20 INFO - 'LANGUAGE': 'en_US:en', 23:48:20 INFO - 'LOGNAME': 'cltbld', 23:48:20 INFO - 'MAIL': '/var/mail/cltbld', 23:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:20 INFO - 'MOZ_NO_REMOTE': '1', 23:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:20 INFO - 'NO_EM_RESTART': '1', 23:48:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:20 INFO - 'PWD': '/builds/slave/test', 23:48:20 INFO - 'SHELL': '/bin/bash', 23:48:20 INFO - 'SHLVL': '1', 23:48:20 INFO - 'TERM': 'linux', 23:48:20 INFO - 'TMOUT': '86400', 23:48:20 INFO - 'USER': 'cltbld', 23:48:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:20 INFO - '_': '/tools/buildbot/bin/python'} 23:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:48:20 INFO - Cleaning up... 23:48:20 INFO - Return code: 0 23:48:20 INFO - Running post-action listener: _resource_record_post_action 23:48:20 INFO - Running post-action listener: _start_resource_monitoring 23:48:20 INFO - Starting resource monitoring. 23:48:20 INFO - [mozharness: 2016-10-03 06:48:20.725755Z] Finished create-virtualenv step (success) 23:48:20 INFO - [mozharness: 2016-10-03 06:48:20.726212Z] Running install step. 23:48:20 INFO - Running pre-action listener: _resource_record_pre_action 23:48:20 INFO - Running main action method: install 23:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:48:20 INFO - Reading from file tmpfile_stdout 23:48:20 INFO - Detecting whether we're running mozinstall >=1.0... 23:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:48:21 INFO - Reading from file tmpfile_stdout 23:48:21 INFO - Output received: 23:48:21 INFO - Usage: mozinstall [options] installer 23:48:21 INFO - Options: 23:48:21 INFO - -h, --help show this help message and exit 23:48:21 INFO - -d DEST, --destination=DEST 23:48:21 INFO - Directory to install application into. [default: 23:48:21 INFO - "/builds/slave/test"] 23:48:21 INFO - --app=APP Application being installed. [default: firefox] 23:48:21 INFO - mkdir: /builds/slave/test/build/application 23:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:48:37 INFO - Reading from file tmpfile_stdout 23:48:37 INFO - Output received: 23:48:37 INFO - /builds/slave/test/build/application/firefox/firefox 23:48:37 INFO - Running post-action listener: _resource_record_post_action 23:48:37 INFO - [mozharness: 2016-10-03 06:48:37.209831Z] Finished install step (success) 23:48:37 INFO - [mozharness: 2016-10-03 06:48:37.210075Z] Running run-tests step. 23:48:37 INFO - Running pre-action listener: _resource_record_pre_action 23:48:37 INFO - Running main action method: run_tests 23:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:48:37 INFO - Python 2.7.3 23:48:37 INFO - Return code: 0 23:48:37 INFO - grabbing minidump binary from tooltool 23:48: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')]} 23:48:37 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 0x276bf60>, '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 0x276cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:48:37 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 23:48:37 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 23:48:37 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 23:48:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:48:37 INFO - Return code: 0 23:48:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:48:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:48:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:48:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:48:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:48:37 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:48:37 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:48:37 INFO - Using env: {'DISPLAY': ':0', 23:48:37 INFO - 'HOME': '/home/cltbld', 23:48:37 INFO - 'LANG': 'en_US.UTF-8', 23:48:37 INFO - 'LANGUAGE': 'en_US:en', 23:48:37 INFO - 'LOGNAME': 'cltbld', 23:48:37 INFO - 'MAIL': '/var/mail/cltbld', 23:48:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:48:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:48:37 INFO - 'MOZ_NO_REMOTE': '1', 23:48:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:48:37 INFO - 'NO_EM_RESTART': '1', 23:48:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:48:37 INFO - 'PWD': '/builds/slave/test', 23:48:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:48:37 INFO - 'SHELL': '/bin/bash', 23:48:37 INFO - 'SHLVL': '1', 23:48:37 INFO - 'TERM': 'linux', 23:48:37 INFO - 'TMOUT': '86400', 23:48:37 INFO - 'USER': 'cltbld', 23:48:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020', 23:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:48:37 INFO - '_': '/tools/buildbot/bin/python'} 23:48:37 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:48:37 INFO - mozversion application_buildid: 20161002223356 23:48:37 INFO - mozversion application_changeset: 955840bfd3c20eb24dd5a01be27bdc55c489a285 23:48:37 INFO - mozversion application_display_name: Nightly 23:48:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:48:37 INFO - mozversion application_name: Firefox 23:48:37 INFO - mozversion application_remotingname: firefox 23:48:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:48:37 INFO - mozversion application_vendor: Mozilla 23:48:37 INFO - mozversion application_version: 52.0a1 23:48:37 INFO - mozversion platform_buildid: 20161002223356 23:48:37 INFO - mozversion platform_changeset: 955840bfd3c20eb24dd5a01be27bdc55c489a285 23:48:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:48:37 INFO - mozversion platform_version: 52.0a1 23:48:37 INFO - using testdate: 1475477317 23:48:37 INFO - actual date: 1475477317 23:48:37 INFO - starting webserver on 'localhost:57916' 23:48:37 INFO - SUITE-START | Running 2 tests 23:48:37 INFO - TEST-START | dromaeo_css 23:48:37 INFO - operating with platform_type : linux_ 23:48:37 INFO - Initialising browser for dromaeo_css test... 23:48:37 INFO - TEST-INFO | started process 13913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7FF2_3/profile http://localhost:57916/getInfo.html) 23:48:42 INFO - PROCESS | 13913 | __metrics Screen width/height:1600/1200 23:48:42 INFO - PROCESS | 13913 | colorDepth:24 23:48:42 INFO - PROCESS | 13913 | Browser inner width/height: 1024/697 23:48:42 INFO - PROCESS | 13913 | __metrics 23:48:42 INFO - PROCESS | 13913 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:48:42 INFO - PROCESS | 13913 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:48:43 INFO - PROCESS | 13913 | console.error: PushService: 23:48:43 INFO - PROCESS | 13913 | stateChangeProcessEnqueue: Error transitioning state 23:48:43 INFO - PROCESS | 13913 | UnknownError 23:48:43 INFO - TEST-INFO | 13913: exit 0 23:48:43 INFO - Browser initialized. 23:48:43 INFO - Running cycle 1/1 for dromaeo_css test... 23:48:43 INFO - TEST-INFO | started process 13992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7FF2_3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:48:56 INFO - PROCESS | 13992 | RSS: Main: 175812608 23:48:56 INFO - PROCESS | 13992 | 23:49:46 INFO - PROCESS | 13992 | 1475477386926 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] 23:52:00 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:57916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57916/tests/dromaeo/cssquery-ext.html) 23:52:02 INFO - PROCESS | 13992 | RSS: Main: 327294976 23:52:02 INFO - PROCESS | 13992 | 23:55:05 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:57916/tests/dromaeo/cssquery-ext.html (next: http://localhost:57916/tests/dromaeo/cssquery-jquery.html) 23:55:05 INFO - PROCESS | 13992 | RSS: Main: 280596480 23:55:05 INFO - PROCESS | 13992 | 23:58:08 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:57916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57916/tests/dromaeo/cssquery-mootools.html) 23:58:08 INFO - PROCESS | 13992 | RSS: Main: 221270016 23:58:08 INFO - PROCESS | 13992 | 00:01:11 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:57916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57916/tests/dromaeo/cssquery-prototype.html) 00:01:11 INFO - PROCESS | 13992 | RSS: Main: 220737536 00:01:11 INFO - PROCESS | 13992 | 00:04:14 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:57916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57916/tests/dromaeo/cssquery-yui.html) 00:04:15 INFO - PROCESS | 13992 | RSS: Main: 221163520 00:04:15 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | Cycle 1(1): loaded http://localhost:57916/tests/dromaeo/cssquery-yui.html (next: http://localhost:57916/tests/dromaeo/cssquery-dojo.html) 00:07:18 INFO - PROCESS | 13992 | RSS: Main: 308752384 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | __start_tp_report 00:07:18 INFO - PROCESS | 13992 | _x_x_mozilla_page_load 00:07:18 INFO - PROCESS | 13992 | _x_x_mozilla_page_load_details 00:07:18 INFO - PROCESS | 13992 | |i|pagename|runs| 00:07:18 INFO - PROCESS | 13992 | |0;dojo.html;2566.4867026594684;2605.322616119808;2635.3543381871436;2642.9339266518336;2657.787377009838;4553.521880202581;4628.190066738316;4696.822912785353;4797.784099715517;4843.636727245457;4666.743329116905;4697.248440249561;4726.598239149676;4765.094632019914;4821.035792841437;4243.702940794145;4294.849680261192;4341.6526677865695;4354.673399495051;4370.2570563004365;4129.793510324487;4423.402840616508;4432.3573081903105;4444.97765513932;4507.549245075499;4236.788160591989;4394.12117576486;4401.075774087445;4416.757078360689;4517.390152329443;4272.764997925113;4317.740935543846;4334.978325108385;4361.629261512775;4383.101464199832;4353.0423306872435;4357.9782101089295;4367.650587952956;4410.316400957857;4426.048399594103;4743.667943243974;4752.809887604491;4763.190257656172;4782.497837727024;4785.114753770564;4881.829135980259;4917.877053073666;4930.457649658535;5013.974930125362;5101.132807422747;4938.604911607063;4953.083679519301;4974.328465657126;5005.724685142316;5046.596272298208;4649.511801260886;4651.930221046687;4653.139169253631;4694;4712.081144176853;5088.720120393414;5098.821541246039;5100.438951715309;5100.923486147711;5166.767495462713;4867.415910090812;4870.099031679079;4879.121758083508;4905.068037072945;4961.4294356148785;4941.901161976741;5023.321851550067;5075.111855425286;5085.1355269604255;5090.77091530882;4934.5805606523845;4964.453910069889;4970.701757894465;4973.104841128559;5031.899362012739;4820.4456487504385;4963.975180124148;4964.404271487445;4968.552830245295;5014.84955451337;4117.300058989979;4210.663146948298;4223.429836971969;4265.53079161292;4297.462817147856;3700.6854417374825;3715.331240376758;3722.348588996969;3758.8308526115843;3766.642168993941;4355.15074560464;4372.125574885035;4383.167198232326;4414.823407063682;4418.491873434532;4892.8532144035735;4932.1122198004705;4950.3069570260195;4980.551750342414;5016.949830501721;4342.848000319974;4377.190219809346;4380.16776812411;4391.3193455014525;4394.846180383671;4486.798094085774;4507.18870603288;4517.5256598057385;4525.660575456854;4575.313702944519;4616.376789133424;4713;4715.528447155257;4717.575418212446;4758.595519380891;4946.208606622923;5013.072581572421;5060.620453465931;5063.215201643751;5141.203113517411;4758;4759.190937540696;4760.047990401864;4806.7836947336755;4809.182438985311;4927.581155601671;4954.157793175097;4970.65205435616;4983.377077865267;5038.395392552917;4893.779779909842;4948.307236986897;4964;4972.955679307386;5042.974785126051;4868.926966095582;4903.190973489477;4921.040397122527;4948.05986862495;4966.553010229097;4878.967506591826;4887.780049897692;4892.0705066037335;4898.632602554751;4953.083679519301;4745.810167593258;4784.306275590089;4793.832215872428;4848.854534363974;4885.1450996076255;4948.257761335828;4980.800767969386;4994.0011997599895;5024.246363045572;5083.542481176712;4716.174669432904;4767.141914455293;4920.630952678635;4926.236433352836;4926.630502712239 00:07:18 INFO - PROCESS | 13992 | |1;ext.html;549.8323011481498;575.5683237571823;576.0638961687258;578.8523926398773;586.6919867069788;27094.458110837797;37556.624433755656;38512.22975540491;38660.80669596655;42382.36426453606;38907.805460972726;39181.60818391815;39246.21507569847;39250.41124383137;39253.411198832044;7631.084269887608;7782.143964163937;7783.455158138932;7785;7786.454948153631;7605;7690.769276921674;7694.038245219348;7694.076710794712;7695.345895598881;7686;7760.922390776076;7765.378769698411;7767.728129515468;7767.805804854867;7654.770356889302;7695.268949449794;7696.499727517694;7701.152873183945;7702.191269916634;7528.661210245552;7587.279208475186;7591;7592.734254301128;7594.050743657043;37253.44119838205;37417.43873841895;37560.43659345112;37580.248395031944;37599.436008459896;2873.324768679359;2880.135959212249;3124.3438877835683;3338.9499157512655;3341.63242043375;27659.58510622342;28334.149975500768;28378.716212837815;28542.571861422097;29474.410511789858;3372.4772660237704;3381.070205693429;3386.2380964283084;3407.2163402417336;3434.5019972103905;246984;247958;247980;248536;248787;31179.596918138286;31671.683283167335;48927;49221.75389123031;49296.75351623291;33316.83341583276;33471.16322091918;33718.662813372044;33728.32543349119;33788.324233515195;12860.678483037811;12985.026123040621;12990.220586764635;12997.09020368584;12999.480020799063;9333.346665733468;9334.439933604006;9334.906650933404;9340.486273255035;9386.389884657612;7703.1911649277135;7838.098618658813;7888.566128862853;7951.840963180704;7963.283304502623;3069.6623371429123;3128.3430479599083;3137.2784259619957;3144.135362775255;3150.6691797361404;863.6200071968314;872.2760109109424;884.3014018925106;894.8478758611052;954.398728800851;26691;27205.86397068002;27214.863925680642;27468.17595472139;27893.302667433476;780.5238804329355;874.5190145419994;930.9162175404247;936.7939053408239;981.5582987655441;11885.702857428461;14100.576982690536;14977.625559361104;15927;16120.919395403182;371565;373753;374198;374378;374844;48284.275735863994;48407.273890891665;48514.5148548517;48571.5142848567;48690;1080.1574771678104;1115.966521004371;1138.703936976392;1173.7769823733804;1178.4107946026986;26716.332091697863;27795.722042779315;28545.28636784014;28819.27951801138;28911.56632650554;39514;40236.19527609373;40258.597414025484;40308.59691403166;40348.59651403566;301975;305935;306155;306545.4672726622;306722;24760.628590571516;25572.616410754224;25603.359916001504;26686.86656566705;26859.731402685724;41381;43732.56267437285;44736.77631611821;45346.319805202285;49544;34931.12672183216;35157.41791619332;35159.47260791039;38125.046873828374;38891.80554097325;37261.88214353574;38058.238835223696;38214.6178538211;38718.22563548657;39498.33544942792;36019.3174887263;36797;36811.44782828313;36832.44751328786;37129;32680.541612350866;34629.006771449625;34741.82629086838;35053.824730876186;35260;25701.485970280115;25760.484790303715;26016.73983260143;26023.394728706695;26273.868630656725 00:07:18 INFO - PROCESS | 13992 | |2;jquery.html;344.2907610322734;359.9100224943764;366.59308167933597;370;382.91767270036934;12308.199967002138;13153.342332883365;14363.856361436383;16344.83655163448;16992.065436400993;16541.83458165421;16587.41944031959;16981.15094245289;17091.230894609773;17109.40117095902;4702.459217190016;5076.492350764913;5104.5405913467785;5111.718855462948;5111.923321150186;3675.6691897729197;3869.787161706105;5039.370078740158;5077.923831142536;5118.718470484122;5618.550515958714;5895;5914.2015827863115;6008.218931538894;6017.277926648786;5686.033374326333;5827.970860145714;5845.561582881301;5996.640201587897;6004.579679422464;5162;5181.481851814826;5184.948150518484;5186.611004174664;5186.818461353872;19636.70544941827;20255.696164557543;20368.490787730276;20394.796052039437;20543.2809851656;1913.913873875679;1985.0868600443814;1998.1108406759;2139.7860213978634;2298.0577963035075;12552;13216.405261763244;13363.131396459296;13638.249896255702;13805.654858628513;1594.4055944055945;1656.7266401043935;1659.585103724069;1673;1678.5467923660544;62692;64193.358066419205;64968.675156624384;65925.67037164784;67211.327886721;9342.392744471588;9381.812363752686;9617.663381781604;9826.9017309826;10000.949995249977;13386.933065334611;13400.597982060553;13418.060735748404;13429.462821487226;13434.664133396744;6819.5908245505425;6852.6916288767125;6931.306869313028;6989.196242432084;7019.684114214872;6442.8389290268115;6501.1548498694865;6653.600783952978;6685.456707944797;6691.1636045494315;5813.680247586339;5842;6010.66941318223;6045.1234570987845;6119.173911521888;1712.700277451466;1737.5916659584987;1768.9027103509172;1776.7068433708553;1777.2446710148395;821.5358322547742;844.4806444036873;898.955052247385;936.194872409727;943.5848226780195;16555.17224138788;16707.49877503677;17099.48701538931;17418.65162696739;17646.91176544109;848.6859861851154;872.284726524244;884.0584777212248;904.7014485219862;937.5734041011324;9286.303527235485;9852.753681158028;9865.314150500739;9914.702558923243;10057.094861462358;170684;173110;173462;368229;371912;67132.32867671359;77820;79151.60424197842;79866.6006669963;80255;895.0646574329711;915.4004127296631;921.635953798246;930.2418528898926;931.6087243357941;15701.685966280838;15851.969621974535;16065.196740162712;16868.746968795233;17024.999125205813;27581.586276206275;34313.485297721054;36343.45484817677;36383.81808090943;36550.8172459136;47256.87779910395;48910.75544622254;51662.74168629133;51925.7403712979;52463.47536524586;7656.961715191388;7657.425693072931;7805.8829117562145;7871.252231038042;7935.166807485131;9122.452652840851;11530.1928864982;11804;11993.940030299793;12186.268823870241;9795.559199835881;10144.695659130239;10350.068493835592;10431.58273669075;10733.355998640107;9653.324267301221;10198.184145268213;10295.794084118426;10312.742181445525;10332.845007324746;10506;10590.417527036087;10626;10717.9464102679;10832.404217768099;7563.508371955805;7594.8860767087435;7712.498687585289;7832.505944268034;7950.840983180419;8789.824203516022;10021.398716076767;10038.548265328223;10160.187185025328;10485.26603137773 00:07:18 INFO - PROCESS | 13992 | |3;mootools.html;1242.7141757395805;1330.3215360166312;1370.3285390158826;1372.6568357910523;1601.1994002998501;6512.479001679866;7455.627218639073;7687.154413014564;7693.846123077542;7946.562939038351;7783.92216077839;7847;7848.960755196216;7852.882206766903;7862.803429914241;2094.706741056253;2114.5559432519112;2114.6722258050027;2117.3859580721573;2120.183729264229;2048.989755051223;2082.979170208301;2095.0153427888868;2109.6835474678846;2110.2930518276394;2071.078370125295;2073.284716772711;2077.7610574783944;2080.6670932650777;2085.280578200526;2059.969100463494;2062.9690554641693;2068.7620923593827;2075.294399904032;2079.5840831833543;2011.9195232190696;2020.6968954656918;2061.98969005154;2065.535254567725;2066.95866082679;7545.320921117126;7660.578668173248;7733.994580704529;7761.883571746428;7783.766487005399;4291.442112525352;4444.28891377378;4447;4447.933281000755;4449.488308844492;2578.626099215622;2654.1772050664354;2686.1404350607813;2695.3261684578856;2705.998780451226;824.814416756225;826.0706704956923;837.3426859914998;840.9243168114838;841.1252297610478;10376.584936602527;10475.423851688154;10500.632477863315;10514.158867290598;10515;3646.781193128421;3851.326017946848;3906.453096566483;3938.0942383252013;3959.366501359826;8123.3095186908595;8124.172061286282;8130.430869839172;8169.428140030141;8182.427230093836;4387.276099443556;4389.4513185851765;4390.846320378835;4391.385206071152;4394.033312671208;3585.2112535242204;3710.870119545803;3983.2232714620372;4089.7750623715388;4092.1406504633765;3183.2837611537684;3282.901512954615;3315.1214928044087;3340.716039136652;3373.8144402057633;1044.6343779677052;1046.2885238038207;1048.0933992096782;1052.9684109476727;1064.7178497698117;795.3915254830059;832.9750107496785;836.5566249887569;837.8240569480478;851.7827953871723;5035.874103147451;5124.897502050013;5144.279800827887;5196;5204.193350030751;371.5300145316123;384.644204111196;387.3743903595729;390.2838291734642;390.50210980998884;3500.054985153994;3502.1069627244888;3520.1727594015388;3528.6647768462467;3614.6385361464168;9045.095490450902;9415.717528474157;9420.057994200524;9461.763455913657;9486.335956483117;9303.302252331103;9344.859827102599;9349.672761453316;9352.438853668802;9412.388194767318;6816.420604248694;6928.44572434204;7036.401905838061;7042.6126563039525;7048.436125109979;5208.635395522429;5210.791568337376;5270.130428479258;5395.784168633368;5487.478689524489;8712.346574006848;8723.432976856484;8725.563721814011;8774.868376974478;8775.254103401283;8559;8843.336749743667;8949.105089491259;8957.865632015395;8975.237104846161;5528.695921724344;6088.695565221633;6102.694865256631;6125.601835880653;6140.539459540463;6636.568623039487;6988.930110698828;7194.784156475314;7242.239564845615;7445.218252083453;6403.3276505966205;6410.262819775786;6612.933870661232;6620.768273110418;6732.764353247809;6310.968445157745;6375.458086062551;6487.805365839033;6488.837779055561;6599.0761293418;5868;5949.25634295713;5979.282486101695;6002.939970600412;6016.8796624068145;4562.247229207276;4674.088552732184;4719.38647975761;4768.928466072943;4769.260764581495;4503.234450143549;4577.977110114428;4660.324252983366;4701.177293973473;4839.540243676845 00:07:18 INFO - PROCESS | 13992 | |4;prototype.html;293.5816461542302;300.71882789591734;301.81136789506553;305.75845082384916;309.24081380211584;4810.783514741836;4909.091818013666;4926.955313544879;4929.014197160564;4984.4018717753925;4812.711237325763;4854.320395144682;4864.805407783684;4869.561739443449;4873.439554451239;3578.5347904772343;3690.7785532868115;3691.907702307437;3765.284595926779;3821.808909554525;3810.5236845394325;3814.771113733185;3833.8658146964863;3843.9807800960957;3851.9229615407676;3778.263238668461;3783.545974483066;3791.592338864827;3794.981025094871;3820.815547180369;3561.145325121978;3679.374506333903;3699.944500832476;3733.701303895709;3812.0850995760816;3339.933201335984;3345.6821601947777;3346.397648423283;3346.4311067118406;3350.011746534778;4695.1783437898575;4695.5304469552775;4697.741624210667;4706.505816889246;4726.149293127236;4203.684723645708;4319.50325712544;4330.198913201068;4332.978335108336;4350.4115051544595;5029.346184995927;5030.622703297267;5033.295338652591;5035.84892453227;5040.370932928286;3667.6699097081123;3669.87155449558;3679.2641471705765;3701.592824789271;3704.666320124753;5176.0683077046115;5284.497972692588;5293.470652934714;5296.92054619181;5349;3719.6094410087094;3726.9068273293383;3727.7949712765517;3733.272011957642;3753.4423214365734;3770.359038963383;3782.63585259213;3796.6013568575454;3816.2749077675153;3829.5021647186245;4320.524742278347;4333.653307735373;4336.631386332134;4353.760543170093;4371.322445021026;4840.491748366371;4983.25251212321;5013.3983921928875;5057.165567681365;5128.384593848762;1304.621659718671;1311.2591385866954;1315.4540865540694;1316.2694704439127;1322.358656051814;819.8975128108987;821.9630116644765;856.2764464027887;867.1891781184487;874.4753148111082;4329.264025115738;4421.9336709949375;4519.960409105924;4522.728636281834;4524.57475895092;5217.373915130132;5222.164453687392;5232.3721153461065;5234.895302094013;5239.030779305841;4520.50274469808;4531.320301954667;4535.478419981679;4546.74992875395;4566.178087944136;2652.5092857821364;2797.8740956656998;2802.089320970693;2813.3529288263403;2833.5891295762412;4938.728369939688;4948.975255123773;4957.107720610325;4971.527704868032;4973.50264973507;5191.558717509054;5355.30381050461;5384.6769193848495;5406.135018397038;5432.212329212242;4885.291632713237;4912.361393018885;4918.704877707349;4965.30485732005;4979.9004019918675;5278.656887302313;5314.229436731575;5328.626996110235;5341.8782055768725;5343.519083282523;5046.268291097844;5138.203578445347;5145.279660847409;5214;5229.895402092013;4945.455999839943;4945.975270123627;4951.133551628379;4982.402111746469;4997.9500204997485;3376.7805092668896;3377.3583019226267;3398.3033478136426;3432.262063656326;3448.965510344965;4578.855286178456;4632.2819962905805;4746.691465054761;4760.809567617256;4769.260764581495;4506.78316854454;4538.909221815479;4573.908521829611;4623.791929363254;4627.467841198305;4574.382458368211;4591.3801636779945;4595.149897269016;4611.700239484423;4613.3771940787565;4468.123388177039;4497.437820272466;4507.887302817456;4508.661850361171;4520.751358675305;4733.502982186958;4861.805527778849;4996.775145118406;5015.423226329019;5118.846434606968;5019.799208031638;5035.723035233097;5041.395032596112;5044.974775126101;5051.393832740095 00:07:18 INFO - PROCESS | 13992 | |5;yui.html;568.75543516288;577.1256546332305;580.669018659364;635.313861030087;645.6416688737748;12024.879751202485;12432.378381080933;12941.805872911913;12990;12999.350032498372;13029.609111726664;13625.523106691267;13680.247586382746;13711.177329360245;13713.108647937877;738.2801768275915;753.9971837456197;755.7921571567836;756.6632848382473;756.8032311598969;621.9906701399483;639.6162302618415;745.0947099274381;765.1850778920432;771.1363273134069;798.5049269452918;799.6601444386142;799.6841247707152;800.3557136505111;800.3997002248313;793.80551764818;794.9562774047425;795.2683531151325;795.2961628958385;795.4829360915394;482.44277859072827;489.56428778387266;568.8208214412447;584.080073883635;588.4233451217788;11971.46128424223;11984.101192410604;11998;11998.940005300004;12016.279023258632;11008.39453830039;11524.308541487537;11626.825597616042;11813.586524471688;12126.029917606571;10915.890841091566;11182.27315224516;11221.831672524919;11228;11281.717957051058;4057.6348128668265;4068.593140685937;4089.3865920111925;4090.9181816363507;4277.850275240352;61940;63019;63925.360746392405;65329.34670653327;65431.67284163596;9493.715188544355;9523.90476095244;9711.077447642463;9784.853227201455;9848.21214302854;17587.56031099207;17596;17605.647887042443;17608.11959402025;17626.559336016446;6168.629882206992;6181.227346581677;6199.132121502903;6333.904991425133;6413.16628838248;3371.072954937412;3455.2571197192724;3458.3602033623356;3476.4090104682264;3526.559180102487;2597.714251432341;2664.7475686427347;2670.946581068368;2673.4385778986243;2676.598510223482;462.54208333749347;469.8825293676581;472.6100966702484;476.6734786671141;483.1737728484261;464.82801363495724;479.54203735432577;487.19612639144987;513.2070950381594;552.7844140785097;7098;7467;7523.510971786816;7761.689532418753;7865.567393793282;465.4693649239869;472.69274971268266;476.9403824521935;489.2905287333381;513.3403576404377;3596.8561257549927;3681.7606855554304;3792.905177370533;3799.1831756172005;3907.6873850091924;55230;56458.717706412026;72641;75525.24474755183;76623.61688191634;23969.880150599136;24057.639135412985;24285.150019749224;28924.710752892202;61670.0749488758;61341.4792668662;63523.364766353596;63958;68043.31956680567;69443;7790.376769858284;8268.793280168044;8325.167483251626;8336.458130221516;8451.112633173674;40319.3952090713;42361.78819105885;42665.36001960035;42978.57021429871;43000.78499607607;34652.82673586616;39277.60722392739;57173.42826571681;59869.70065149647;60465;10918.781624367628;10956.397398143179;11096.88903110991;11252.718682033015;11737.765244695229;11257.549698012315;11901.345426001306;12294.20087694297;12651.240925544496;13047.913339005634;11117.722056948642;11559.422028898689;12230.205036672587;12255;12262;10416.583336666752;11153;11375.715607109889;11407.600733974272;11426.600068997544;10222.437765922945;10780.191485638765;11185.440727963733;11441.713957150805;11457.885421146015;8948.418352807306;9207;9406.858897116412;9539.09378609031;9541.522923853918;8449.704260350858;8713;8812.339074569305;9212.355135140744;9289.72130836076 00:07:18 INFO - PROCESS | 13992 | __end_tp_report 00:07:18 INFO - PROCESS | 13992 | __start_cc_report 00:07:18 INFO - PROCESS | 13992 | _x_x_mozilla_cycle_collect,1565 00:07:18 INFO - PROCESS | 13992 | __end_cc_report 00:07:18 INFO - PROCESS | 13992 | __startTimestamp1475478438699__endTimestamp 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | ------- Summary: start ------- 00:07:18 INFO - PROCESS | 13992 | Number of tests: 6 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | [#0] dojo.html Cycles:165 Average:4648.52 Median:4784.31 stddev:477.26 (10.0%) stddev-sans-first:449.90 00:07:18 INFO - PROCESS | 13992 | Values: 2566.5 2605.3 2635.4 2642.9 2657.8 4553.5 4628.2 4696.8 4797.8 4843.6 4666.7 4697.2 4726.6 4765.1 4821.0 4243.7 4294.8 4341.7 4354.7 4370.3 4129.8 4423.4 4432.4 4445.0 4507.5 4236.8 4394.1 4401.1 4416.8 4517.4 4272.8 4317.7 4335.0 4361.6 4383.1 4353.0 4358.0 4367.7 4410.3 4426.0 4743.7 4752.8 4763.2 4782.5 4785.1 4881.8 4917.9 4930.5 5014.0 5101.1 4938.6 4953.1 4974.3 5005.7 5046.6 4649.5 4651.9 4653.1 4694.0 4712.1 5088.7 5098.8 5100.4 5100.9 5166.8 4867.4 4870.1 4879.1 4905.1 4961.4 4941.9 5023.3 5075.1 5085.1 5090.8 4934.6 4964.5 4970.7 4973.1 5031.9 4820.4 4964.0 4964.4 4968.6 5014.8 4117.3 4210.7 4223.4 4265.5 4297.5 3700.7 3715.3 3722.3 3758.8 3766.6 4355.2 4372.1 4383.2 4414.8 4418.5 4892.9 4932.1 4950.3 4980.6 5016.9 4342.8 4377.2 4380.2 4391.3 4394.8 4486.8 4507.2 4517.5 4525.7 4575.3 4616.4 4713.0 4715.5 4717.6 4758.6 4946.2 5013.1 5060.6 5063.2 5141.2 4758.0 4759.2 4760.0 4806.8 4809.2 4927.6 4954.2 4970.7 4983.4 5038.4 4893.8 4948.3 4964.0 4973.0 5043.0 4868.9 4903.2 4921.0 4948.1 4966.6 4879.0 4887.8 4892.1 4898.6 4953.1 4745.8 4784.3 4793.8 4848.9 4885.1 4948.3 4980.8 4994.0 5024.2 5083.5 4716.2 4767.1 4920.6 4926.2 4926.6 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | [#1] ext.html Cycles:180 Average:45226.13 Median:205807.72 stddev:82570.53 (40.1%) stddev-sans-first:82734.03 00:07:18 INFO - PROCESS | 13992 | Values: 549.8 575.6 576.1 578.9 586.7 27094.5 37556.6 38512.2 38660.8 42382.4 38907.8 39181.6 39246.2 39250.4 39253.4 7631.1 7782.1 7783.5 7785.0 7786.5 7605.0 7690.8 7694.0 7694.1 7695.3 7686.0 7760.9 7765.4 7767.7 7767.8 7654.8 7695.3 7696.5 7701.2 7702.2 7528.7 7587.3 7591.0 7592.7 7594.1 37253.4 37417.4 37560.4 37580.2 37599.4 2873.3 2880.1 3124.3 3338.9 3341.6 27659.6 28334.1 28378.7 28542.6 29474.4 3372.5 3381.1 3386.2 3407.2 3434.5 246984.0 247958.0 247980.0 248536.0 248787.0 31179.6 31671.7 48927.0 49221.8 49296.8 33316.8 33471.2 33718.7 33728.3 33788.3 12860.7 12985.0 12990.2 12997.1 12999.5 9333.3 9334.4 9334.9 9340.5 9386.4 7703.2 7838.1 7888.6 7951.8 7963.3 3069.7 3128.3 3137.3 3144.1 3150.7 863.6 872.3 884.3 894.8 954.4 26691.0 27205.9 27214.9 27468.2 27893.3 780.5 874.5 930.9 936.8 981.6 11885.7 14100.6 14977.6 15927.0 16120.9 371565.0 373753.0 374198.0 374378.0 374844.0 48284.3 48407.3 48514.5 48571.5 48690.0 1080.2 1116.0 1138.7 1173.8 1178.4 26716.3 27795.7 28545.3 28819.3 28911.6 39514.0 40236.2 40258.6 40308.6 40348.6 301975.0 305935.0 306155.0 306545.5 306722.0 24760.6 25572.6 25603.4 26686.9 26859.7 41381.0 43732.6 44736.8 45346.3 49544.0 34931.1 35157.4 35159.5 38125.0 38891.8 37261.9 38058.2 38214.6 38718.2 39498.3 36019.3 36797.0 36811.4 36832.4 37129.0 32680.5 34629.0 34741.8 35053.8 35260.0 25701.5 25760.5 26016.7 26023.4 26273.9 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | [#2] jquery.html Cycles:180 Average:20324.14 Median:25979.67 stddev:45651.00 (175.7%) stddev-sans-first:45754.41 00:07:18 INFO - PROCESS | 13992 | Values: 344.3 359.9 366.6 370.0 382.9 12308.2 13153.3 14363.9 16344.8 16992.1 16541.8 16587.4 16981.2 17091.2 17109.4 4702.5 5076.5 5104.5 5111.7 5111.9 3675.7 3869.8 5039.4 5077.9 5118.7 5618.6 5895.0 5914.2 6008.2 6017.3 5686.0 5828.0 5845.6 5996.6 6004.6 5162.0 5181.5 5184.9 5186.6 5186.8 19636.7 20255.7 20368.5 20394.8 20543.3 1913.9 1985.1 1998.1 2139.8 2298.1 12552.0 13216.4 13363.1 13638.2 13805.7 1594.4 1656.7 1659.6 1673.0 1678.5 62692.0 64193.4 64968.7 65925.7 67211.3 9342.4 9381.8 9617.7 9826.9 10000.9 13386.9 13400.6 13418.1 13429.5 13434.7 6819.6 6852.7 6931.3 6989.2 7019.7 6442.8 6501.2 6653.6 6685.5 6691.2 5813.7 5842.0 6010.7 6045.1 6119.2 1712.7 1737.6 1768.9 1776.7 1777.2 821.5 844.5 899.0 936.2 943.6 16555.2 16707.5 17099.5 17418.7 17646.9 848.7 872.3 884.1 904.7 937.6 9286.3 9852.8 9865.3 9914.7 10057.1 170684.0 173110.0 173462.0 368229.0 371912.0 67132.3 77820.0 79151.6 79866.6 80255.0 895.1 915.4 921.6 930.2 931.6 15701.7 15852.0 16065.2 16868.7 17025.0 27581.6 34313.5 36343.5 36383.8 36550.8 47256.9 48910.8 51662.7 51925.7 52463.5 7657.0 7657.4 7805.9 7871.3 7935.2 9122.5 11530.2 11804.0 11993.9 12186.3 9795.6 10144.7 10350.1 10431.6 10733.4 9653.3 10198.2 10295.8 10312.7 10332.8 10506.0 10590.4 10626.0 10717.9 10832.4 7563.5 7594.9 7712.5 7832.5 7950.8 8789.8 10021.4 10038.5 10160.2 10485.3 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | [#3] mootools.html Cycles:180 Average:4936.81 Median:5080.39 stddev:2820.62 (55.5%) stddev-sans-first:2814.87 00:07:18 INFO - PROCESS | 13992 | Values: 1242.7 1330.3 1370.3 1372.7 1601.2 6512.5 7455.6 7687.2 7693.8 7946.6 7783.9 7847.0 7849.0 7852.9 7862.8 2094.7 2114.6 2114.7 2117.4 2120.2 2049.0 2083.0 2095.0 2109.7 2110.3 2071.1 2073.3 2077.8 2080.7 2085.3 2060.0 2063.0 2068.8 2075.3 2079.6 2011.9 2020.7 2062.0 2065.5 2067.0 7545.3 7660.6 7734.0 7761.9 7783.8 4291.4 4444.3 4447.0 4447.9 4449.5 2578.6 2654.2 2686.1 2695.3 2706.0 824.8 826.1 837.3 840.9 841.1 10376.6 10475.4 10500.6 10514.2 10515.0 3646.8 3851.3 3906.5 3938.1 3959.4 8123.3 8124.2 8130.4 8169.4 8182.4 4387.3 4389.5 4390.8 4391.4 4394.0 3585.2 3710.9 3983.2 4089.8 4092.1 3183.3 3282.9 3315.1 3340.7 3373.8 1044.6 1046.3 1048.1 1053.0 1064.7 795.4 833.0 836.6 837.8 851.8 5035.9 5124.9 5144.3 5196.0 5204.2 371.5 384.6 387.4 390.3 390.5 3500.1 3502.1 3520.2 3528.7 3614.6 9045.1 9415.7 9420.1 9461.8 9486.3 9303.3 9344.9 9349.7 9352.4 9412.4 6816.4 6928.4 7036.4 7042.6 7048.4 5208.6 5210.8 5270.1 5395.8 5487.5 8712.3 8723.4 8725.6 8774.9 8775.3 8559.0 8843.3 8949.1 8957.9 8975.2 5528.7 6088.7 6102.7 6125.6 6140.5 6636.6 6988.9 7194.8 7242.2 7445.2 6403.3 6410.3 6612.9 6620.8 6732.8 6311.0 6375.5 6487.8 6488.8 6599.1 5868.0 5949.3 5979.3 6002.9 6016.9 4562.2 4674.1 4719.4 4768.9 4769.3 4503.2 4578.0 4660.3 4701.2 4839.5 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | [#4] prototype.html Cycles:180 Average:4165.43 Median:4593.27 stddev:1201.52 (26.2%) stddev-sans-first:1169.22 00:07:18 INFO - PROCESS | 13992 | Values: 293.6 300.7 301.8 305.8 309.2 4810.8 4909.1 4927.0 4929.0 4984.4 4812.7 4854.3 4864.8 4869.6 4873.4 3578.5 3690.8 3691.9 3765.3 3821.8 3810.5 3814.8 3833.9 3844.0 3851.9 3778.3 3783.5 3791.6 3795.0 3820.8 3561.1 3679.4 3699.9 3733.7 3812.1 3339.9 3345.7 3346.4 3346.4 3350.0 4695.2 4695.5 4697.7 4706.5 4726.1 4203.7 4319.5 4330.2 4333.0 4350.4 5029.3 5030.6 5033.3 5035.8 5040.4 3667.7 3669.9 3679.3 3701.6 3704.7 5176.1 5284.5 5293.5 5296.9 5349.0 3719.6 3726.9 3727.8 3733.3 3753.4 3770.4 3782.6 3796.6 3816.3 3829.5 4320.5 4333.7 4336.6 4353.8 4371.3 4840.5 4983.3 5013.4 5057.2 5128.4 1304.6 1311.3 1315.5 1316.3 1322.4 819.9 822.0 856.3 867.2 874.5 4329.3 4421.9 4520.0 4522.7 4524.6 5217.4 5222.2 5232.4 5234.9 5239.0 4520.5 4531.3 4535.5 4546.7 4566.2 2652.5 2797.9 2802.1 2813.4 2833.6 4938.7 4949.0 4957.1 4971.5 4973.5 5191.6 5355.3 5384.7 5406.1 5432.2 4885.3 4912.4 4918.7 4965.3 4979.9 5278.7 5314.2 5328.6 5341.9 5343.5 5046.3 5138.2 5145.3 5214.0 5229.9 4945.5 4946.0 4951.1 4982.4 4998.0 3376.8 3377.4 3398.3 3432.3 3449.0 4578.9 4632.3 4746.7 4760.8 4769.3 4506.8 4538.9 4573.9 4623.8 4627.5 4574.4 4591.4 4595.1 4611.7 4613.4 4468.1 4497.4 4507.9 4508.7 4520.8 4733.5 4861.8 4996.8 5015.4 5118.8 5019.8 5035.7 5041.4 5045.0 5051.4 00:07:18 INFO - PROCESS | 13992 | 00:07:18 INFO - PROCESS | 13992 | [#5] yui.html Cycles:180 Average:14647.00 Median:472.65 stddev:19176.50 (4057.2%) stddev-sans-first:19201.16 00:07:18 INFO - PROCESS | 13992 | Values: 568.8 577.1 580.7 635.3 645.6 12024.9 12432.4 12941.8 12990.0 12999.4 13029.6 13625.5 13680.2 13711.2 13713.1 738.3 754.0 755.8 756.7 756.8 622.0 639.6 745.1 765.2 771.1 798.5 799.7 799.7 800.4 800.4 793.8 795.0 795.3 795.3 795.5 482.4 489.6 568.8 584.1 588.4 11971.5 11984.1 11998.0 11998.9 12016.3 11008.4 11524.3 11626.8 11813.6 12126.0 10915.9 11182.3 11221.8 11228.0 11281.7 4057.6 4068.6 4089.4 4090.9 4277.9 61940.0 63019.0 63925.4 65329.3 65431.7 9493.7 9523.9 9711.1 9784.9 9848.2 17587.6 17596.0 17605.6 17608.1 17626.6 6168.6 6181.2 6199.1 6333.9 6413.2 3371.1 3455.3 3458.4 3476.4 3526.6 2597.7 2664.7 2670.9 2673.4 2676.6 462.5 469.9 472.6 476.7 483.2 464.8 479.5 487.2 513.2 552.8 7098.0 7467.0 7523.5 7761.7 7865.6 465.5 472.7 476.9 489.3 513.3 3596.9 3681.8 3792.9 3799.2 3907.7 55230.0 56458.7 72641.0 75525.2 76623.6 23969.9 24057.6 24285.2 28924.7 61670.1 61341.5 63523.4 63958.0 68043.3 69443.0 7790.4 8268.8 8325.2 8336.5 8451.1 40319.4 42361.8 42665.4 42978.6 43000.8 34652.8 39277.6 57173.4 59869.7 60465.0 10918.8 10956.4 11096.9 11252.7 11737.8 11257.5 11901.3 12294.2 12651.2 13047.9 11117.7 11559.4 12230.2 12255.0 12262.0 10416.6 11153.0 11375.7 11407.6 11426.6 10222.4 10780.2 11185.4 11441.7 11457.9 8948.4 9207.0 9406.9 9539.1 9541.5 8449.7 8713.0 8812.3 9212.4 9289.7 00:07:18 INFO - PROCESS | 13992 | -------- Summary: end -------- 00:07:18 INFO - PROCESS | 13992 | 00:07:19 INFO - TEST-INFO | 13992: exit 0 00:07:19 INFO - TEST-OK | dromaeo_css | took 1122187ms 00:07:19 INFO - TEST-START | kraken 00:07:19 INFO - operating with platform_type : linux_ 00:07:19 INFO - Initialising browser for kraken test... 00:07:19 INFO - TEST-INFO | started process 14297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPLm0g/profile http://localhost:57916/getInfo.html) 00:07:24 INFO - PROCESS | 14297 | __metrics Screen width/height:1600/1200 00:07:24 INFO - PROCESS | 14297 | colorDepth:24 00:07:24 INFO - PROCESS | 14297 | Browser inner width/height: 1024/697 00:07:24 INFO - PROCESS | 14297 | __metrics 00:07:24 INFO - PROCESS | 14297 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:07:24 INFO - PROCESS | 14297 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:07:25 INFO - PROCESS | 14297 | console.error: PushService: 00:07:25 INFO - PROCESS | 14297 | stateChangeProcessEnqueue: Error transitioning state 00:07:25 INFO - PROCESS | 14297 | UnknownError 00:07:26 INFO - TEST-INFO | 14297: exit 0 00:07:26 INFO - Browser initialized. 00:07:26 INFO - Running cycle 1/1 for kraken test... 00:07:26 INFO - TEST-INFO | started process 14378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEPLm0g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:07:38 INFO - PROCESS | 14378 | RSS: Main: 175542272 00:07:38 INFO - PROCESS | 14378 | 00:07:41 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57916/tests/kraken/driver.html?testName=audio-beat-detection) 00:07:42 INFO - PROCESS | 14378 | RSS: Main: 233824256 00:07:42 INFO - PROCESS | 14378 | 00:07:44 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57916/tests/kraken/driver.html?testName=audio-dft) 00:07:45 INFO - PROCESS | 14378 | RSS: Main: 219271168 00:07:45 INFO - PROCESS | 14378 | 00:07:48 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57916/tests/kraken/driver.html?testName=audio-fft) 00:07:49 INFO - PROCESS | 14378 | RSS: Main: 301182976 00:07:49 INFO - PROCESS | 14378 | 00:07:51 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57916/tests/kraken/driver.html?testName=audio-oscillator) 00:07:52 INFO - PROCESS | 14378 | RSS: Main: 210440192 00:07:52 INFO - PROCESS | 14378 | 00:07:54 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:07:55 INFO - PROCESS | 14378 | RSS: Main: 214601728 00:07:55 INFO - PROCESS | 14378 | 00:07:58 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57916/tests/kraken/driver.html?testName=imaging-darkroom) 00:07:58 INFO - PROCESS | 14378 | RSS: Main: 250855424 00:07:58 INFO - PROCESS | 14378 | 00:08:02 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57916/tests/kraken/driver.html?testName=imaging-desaturate) 00:08:02 INFO - PROCESS | 14378 | RSS: Main: 245456896 00:08:02 INFO - PROCESS | 14378 | 00:08:05 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57916/tests/kraken/driver.html?testName=json-parse-financial) 00:08:06 INFO - PROCESS | 14378 | RSS: Main: 247803904 00:08:06 INFO - PROCESS | 14378 | 00:08:08 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:08:08 INFO - PROCESS | 14378 | RSS: Main: 211357696 00:08:08 INFO - PROCESS | 14378 | 00:08:10 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:08:11 INFO - PROCESS | 14378 | RSS: Main: 219811840 00:08:11 INFO - PROCESS | 14378 | 00:08:13 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:08:14 INFO - PROCESS | 14378 | RSS: Main: 227602432 00:08:14 INFO - PROCESS | 14378 | 00:08:17 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:08:17 INFO - PROCESS | 14378 | RSS: Main: 237244416 00:08:17 INFO - PROCESS | 14378 | 00:08:20 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:08:21 INFO - PROCESS | 14378 | RSS: Main: 233648128 00:08:21 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | Cycle 1(1): loaded http://localhost:57916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57916/tests/kraken/driver.html?testName=ai-astar) 00:08:23 INFO - PROCESS | 14378 | RSS: Main: 286412800 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | __start_tp_report 00:08:23 INFO - PROCESS | 14378 | _x_x_mozilla_page_load 00:08:23 INFO - PROCESS | 14378 | _x_x_mozilla_page_load_details 00:08:23 INFO - PROCESS | 14378 | |i|pagename|runs| 00:08:23 INFO - PROCESS | 14378 | |0;ai-astar;113;115;114;116;114;114;113;115;113;114 00:08:23 INFO - PROCESS | 14378 | |1;audio-beat-detection;159;127;125;174;127;137;127;126;162;127 00:08:23 INFO - PROCESS | 14378 | |2;audio-dft;162;160;162;160;161;160;162;160;160;162 00:08:23 INFO - PROCESS | 14378 | |3;audio-fft;76;76;76;110;77;76;75;76;113;76 00:08:23 INFO - PROCESS | 14378 | |4;audio-oscillator;85;84;116;83;85;83;112;82;83;117 00:08:23 INFO - PROCESS | 14378 | |5;imaging-gaussian-blur;117;117;117;117;116;118;118;118;117;117 00:08:23 INFO - PROCESS | 14378 | |6;imaging-darkroom;146;147;147;147;146;147;147;146;147;145 00:08:23 INFO - PROCESS | 14378 | |7;imaging-desaturate;95;95;96;96;97;96;96;96;96;95 00:08:23 INFO - PROCESS | 14378 | |8;json-parse-financial;66;64;65;66;66;65;66;66;66;65 00:08:23 INFO - PROCESS | 14378 | |9;json-stringify-tinderbox;66;66;65;65;66;65;66;67;70;66 00:08:23 INFO - PROCESS | 14378 | |10;stanford-crypto-aes;83;83;83;88;84;82;83;89;83;83 00:08:23 INFO - PROCESS | 14378 | |11;stanford-crypto-ccm;154;141;139;148;142;138;140;148;187;139 00:08:23 INFO - PROCESS | 14378 | |12;stanford-crypto-pbkdf2;173;174;172;170;172;172;170;171;172;171 00:08:23 INFO - PROCESS | 14378 | |13;stanford-crypto-sha256-iterative;71;69;70;70;70;70;70;74;70;68 00:08:23 INFO - PROCESS | 14378 | __end_tp_report 00:08:23 INFO - PROCESS | 14378 | __start_cc_report 00:08:23 INFO - PROCESS | 14378 | _x_x_mozilla_cycle_collect,1931 00:08:23 INFO - PROCESS | 14378 | __end_cc_report 00:08:23 INFO - PROCESS | 14378 | __startTimestamp1475478503432__endTimestamp 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | ------- Summary: start ------- 00:08:23 INFO - PROCESS | 14378 | Number of tests: 14 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:0.97 00:08:23 INFO - PROCESS | 14378 | Values: 113.0 115.0 114.0 116.0 114.0 114.0 113.0 115.0 113.0 114.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:132.00 stddev:18.56 (14.1%) stddev-sans-first:18.23 00:08:23 INFO - PROCESS | 14378 | Values: 159.0 127.0 125.0 174.0 127.0 137.0 127.0 126.0 162.0 127.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:0.99 (0.6%) stddev-sans-first:0.97 00:08:23 INFO - PROCESS | 14378 | Values: 162.0 160.0 162.0 160.0 161.0 160.0 162.0 160.0 160.0 162.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:14.99 (19.7%) stddev-sans-first:15.68 00:08:23 INFO - PROCESS | 14378 | Values: 76.0 76.0 76.0 110.0 77.0 76.0 75.0 76.0 113.0 76.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:83.00 stddev:15.26 (18.4%) stddev-sans-first:15.91 00:08:23 INFO - PROCESS | 14378 | Values: 85.0 84.0 116.0 83.0 85.0 83.0 112.0 82.0 83.0 117.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 00:08:23 INFO - PROCESS | 14378 | Values: 117.0 117.0 117.0 117.0 116.0 118.0 118.0 118.0 117.0 117.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 00:08:23 INFO - PROCESS | 14378 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 146.0 147.0 145.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 00:08:23 INFO - PROCESS | 14378 | Values: 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 95.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:66.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 00:08:23 INFO - PROCESS | 14378 | Values: 66.0 64.0 65.0 66.0 66.0 65.0 66.0 66.0 66.0 65.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 00:08:23 INFO - PROCESS | 14378 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 66.0 67.0 70.0 66.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.00 stddev:2.38 (2.9%) stddev-sans-first:2.49 00:08:23 INFO - PROCESS | 14378 | Values: 83.0 83.0 83.0 88.0 84.0 82.0 83.0 89.0 83.0 83.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:145.00 stddev:14.78 (10.2%) stddev-sans-first:15.50 00:08:23 INFO - PROCESS | 14378 | Values: 154.0 141.0 139.0 148.0 142.0 138.0 140.0 148.0 187.0 139.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:1.25 (0.7%) stddev-sans-first:1.24 00:08:23 INFO - PROCESS | 14378 | Values: 173.0 174.0 172.0 170.0 172.0 172.0 170.0 171.0 172.0 171.0 00:08:23 INFO - PROCESS | 14378 | 00:08:23 INFO - PROCESS | 14378 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.55 (2.2%) stddev-sans-first:1.62 00:08:23 INFO - PROCESS | 14378 | Values: 71.0 69.0 70.0 70.0 70.0 70.0 70.0 74.0 70.0 68.0 00:08:23 INFO - PROCESS | 14378 | -------- Summary: end -------- 00:08:23 INFO - PROCESS | 14378 | 00:08:24 INFO - TEST-INFO | 14378: exit 0 00:08:24 INFO - TEST-OK | kraken | took 65075ms 00:08:24 INFO - SUITE-END | took 1187s 00:08:25 INFO - Completed test suite (00:19:47) 00:08:25 INFO - javascript benchmark 00:08:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.4867026594684, 2605.322616119808, 2635.3543381871436, 2642.9339266518336, 2657.787377009838, 4553.521880202581, 4628.190066738316, 4696.822912785353, 4797.784099715517, 4843.636727245457, 4666.743329116905, 4697.248440249561, 4726.598239149676, 4765.094632019914, 4821.035792841437, 4243.702940794145, 4294.849680261192, 4341.6526677865695, 4354.673399495051, 4370.2570563004365, 4129.793510324487, 4423.402840616508, 4432.3573081903105, 4444.97765513932, 4507.549245075499, 4236.788160591989, 4394.12117576486, 4401.075774087445, 4416.757078360689, 4517.390152329443, 4272.764997925113, 4317.740935543846, 4334.978325108385, 4361.629261512775, 4383.101464199832, 4353.0423306872435, 4357.9782101089295, 4367.650587952956, 4410.316400957857, 4426.048399594103, 4743.667943243974, 4752.809887604491, 4763.190257656172, 4782.497837727024, 4785.114753770564, 4881.829135980259, 4917.877053073666, 4930.457649658535, 5013.974930125362, 5101.132807422747, 4938.604911607063, 4953.083679519301, 4974.328465657126, 5005.724685142316, 5046.596272298208, 4649.511801260886, 4651.930221046687, 4653.139169253631, 4694.0, 4712.081144176853, 5088.720120393414, 5098.821541246039, 5100.438951715309, 5100.923486147711, 5166.767495462713, 4867.415910090812, 4870.099031679079, 4879.121758083508, 4905.068037072945, 4961.4294356148785, 4941.901161976741, 5023.321851550067, 5075.111855425286, 5085.1355269604255, 5090.77091530882, 4934.5805606523845, 4964.453910069889, 4970.701757894465, 4973.104841128559, 5031.899362012739, 4820.4456487504385, 4963.975180124148, 4964.404271487445, 4968.552830245295, 5014.84955451337, 4117.300058989979, 4210.663146948298, 4223.429836971969, 4265.53079161292, 4297.462817147856, 3700.6854417374825, 3715.331240376758, 3722.348588996969, 3758.8308526115843, 3766.642168993941, 4355.15074560464, 4372.125574885035, 4383.167198232326, 4414.823407063682, 4418.491873434532, 4892.8532144035735, 4932.1122198004705, 4950.3069570260195, 4980.551750342414, 5016.949830501721, 4342.848000319974, 4377.190219809346, 4380.16776812411, 4391.3193455014525, 4394.846180383671, 4486.798094085774, 4507.18870603288, 4517.5256598057385, 4525.660575456854, 4575.313702944519, 4616.376789133424, 4713.0, 4715.528447155257, 4717.575418212446, 4758.595519380891, 4946.208606622923, 5013.072581572421, 5060.620453465931, 5063.215201643751, 5141.203113517411, 4758.0, 4759.190937540696, 4760.047990401864, 4806.7836947336755, 4809.182438985311, 4927.581155601671, 4954.157793175097, 4970.65205435616, 4983.377077865267, 5038.395392552917, 4893.779779909842, 4948.307236986897, 4964.0, 4972.955679307386, 5042.974785126051, 4868.926966095582, 4903.190973489477, 4921.040397122527, 4948.05986862495, 4966.553010229097, 4878.967506591826, 4887.780049897692, 4892.0705066037335, 4898.632602554751, 4953.083679519301, 4745.810167593258, 4784.306275590089, 4793.832215872428, 4848.854534363974, 4885.1450996076255, 4948.257761335828, 4980.800767969386, 4994.0011997599895, 5024.246363045572, 5083.542481176712, 4716.174669432904, 4767.141914455293, 4920.630952678635, 4926.236433352836, 4926.630502712239], "value": 4618.430950418513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.8323011481498, 575.5683237571823, 576.0638961687258, 578.8523926398773, 586.6919867069788, 27094.458110837797, 37556.624433755656, 38512.22975540491, 38660.80669596655, 42382.36426453606, 38907.805460972726, 39181.60818391815, 39246.21507569847, 39250.41124383137, 39253.411198832044, 7631.084269887608, 7782.143964163937, 7783.455158138932, 7785.0, 7786.454948153631, 7605.0, 7690.769276921674, 7694.038245219348, 7694.076710794712, 7695.345895598881, 7686.0, 7760.922390776076, 7765.378769698411, 7767.728129515468, 7767.805804854867, 7654.770356889302, 7695.268949449794, 7696.499727517694, 7701.152873183945, 7702.191269916634, 7528.661210245552, 7587.279208475186, 7591.0, 7592.734254301128, 7594.050743657043, 37253.44119838205, 37417.43873841895, 37560.43659345112, 37580.248395031944, 37599.436008459896, 2873.324768679359, 2880.135959212249, 3124.3438877835683, 3338.9499157512655, 3341.63242043375, 27659.58510622342, 28334.149975500768, 28378.716212837815, 28542.571861422097, 29474.410511789858, 3372.4772660237704, 3381.070205693429, 3386.2380964283084, 3407.2163402417336, 3434.5019972103905, 246984.0, 247958.0, 247980.0, 248536.0, 248787.0, 31179.596918138286, 31671.683283167335, 48927.0, 49221.75389123031, 49296.75351623291, 33316.83341583276, 33471.16322091918, 33718.662813372044, 33728.32543349119, 33788.324233515195, 12860.678483037811, 12985.026123040621, 12990.220586764635, 12997.09020368584, 12999.480020799063, 9333.346665733468, 9334.439933604006, 9334.906650933404, 9340.486273255035, 9386.389884657612, 7703.1911649277135, 7838.098618658813, 7888.566128862853, 7951.840963180704, 7963.283304502623, 3069.6623371429123, 3128.3430479599083, 3137.2784259619957, 3144.135362775255, 3150.6691797361404, 863.6200071968314, 872.2760109109424, 884.3014018925106, 894.8478758611052, 954.398728800851, 26691.0, 27205.86397068002, 27214.863925680642, 27468.17595472139, 27893.302667433476, 780.5238804329355, 874.5190145419994, 930.9162175404247, 936.7939053408239, 981.5582987655441, 11885.702857428461, 14100.576982690536, 14977.625559361104, 15927.0, 16120.919395403182, 371565.0, 373753.0, 374198.0, 374378.0, 374844.0, 48284.275735863994, 48407.273890891665, 48514.5148548517, 48571.5142848567, 48690.0, 1080.1574771678104, 1115.966521004371, 1138.703936976392, 1173.7769823733804, 1178.4107946026986, 26716.332091697863, 27795.722042779315, 28545.28636784014, 28819.27951801138, 28911.56632650554, 39514.0, 40236.19527609373, 40258.597414025484, 40308.59691403166, 40348.59651403566, 301975.0, 305935.0, 306155.0, 306545.4672726622, 306722.0, 24760.628590571516, 25572.616410754224, 25603.359916001504, 26686.86656566705, 26859.731402685724, 41381.0, 43732.56267437285, 44736.77631611821, 45346.319805202285, 49544.0, 34931.12672183216, 35157.41791619332, 35159.47260791039, 38125.046873828374, 38891.80554097325, 37261.88214353574, 38058.238835223696, 38214.6178538211, 38718.22563548657, 39498.33544942792, 36019.3174887263, 36797.0, 36811.44782828313, 36832.44751328786, 37129.0, 32680.541612350866, 34629.006771449625, 34741.82629086838, 35053.824730876186, 35260.0, 25701.485970280115, 25760.484790303715, 26016.73983260143, 26023.394728706695, 26273.868630656725], "value": 16163.810327810645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.2907610322734, 359.9100224943764, 366.59308167933597, 370.0, 382.91767270036934, 12308.199967002138, 13153.342332883365, 14363.856361436383, 16344.83655163448, 16992.065436400993, 16541.83458165421, 16587.41944031959, 16981.15094245289, 17091.230894609773, 17109.40117095902, 4702.459217190016, 5076.492350764913, 5104.5405913467785, 5111.718855462948, 5111.923321150186, 3675.6691897729197, 3869.787161706105, 5039.370078740158, 5077.923831142536, 5118.718470484122, 5618.550515958714, 5895.0, 5914.2015827863115, 6008.218931538894, 6017.277926648786, 5686.033374326333, 5827.970860145714, 5845.561582881301, 5996.640201587897, 6004.579679422464, 5162.0, 5181.481851814826, 5184.948150518484, 5186.611004174664, 5186.818461353872, 19636.70544941827, 20255.696164557543, 20368.490787730276, 20394.796052039437, 20543.2809851656, 1913.913873875679, 1985.0868600443814, 1998.1108406759, 2139.7860213978634, 2298.0577963035075, 12552.0, 13216.405261763244, 13363.131396459296, 13638.249896255702, 13805.654858628513, 1594.4055944055945, 1656.7266401043935, 1659.585103724069, 1673.0, 1678.5467923660544, 62692.0, 64193.358066419205, 64968.675156624384, 65925.67037164784, 67211.327886721, 9342.392744471588, 9381.812363752686, 9617.663381781604, 9826.9017309826, 10000.949995249977, 13386.933065334611, 13400.597982060553, 13418.060735748404, 13429.462821487226, 13434.664133396744, 6819.5908245505425, 6852.6916288767125, 6931.306869313028, 6989.196242432084, 7019.684114214872, 6442.8389290268115, 6501.1548498694865, 6653.600783952978, 6685.456707944797, 6691.1636045494315, 5813.680247586339, 5842.0, 6010.66941318223, 6045.1234570987845, 6119.173911521888, 1712.700277451466, 1737.5916659584987, 1768.9027103509172, 1776.7068433708553, 1777.2446710148395, 821.5358322547742, 844.4806444036873, 898.955052247385, 936.194872409727, 943.5848226780195, 16555.17224138788, 16707.49877503677, 17099.48701538931, 17418.65162696739, 17646.91176544109, 848.6859861851154, 872.284726524244, 884.0584777212248, 904.7014485219862, 937.5734041011324, 9286.303527235485, 9852.753681158028, 9865.314150500739, 9914.702558923243, 10057.094861462358, 170684.0, 173110.0, 173462.0, 368229.0, 371912.0, 67132.32867671359, 77820.0, 79151.60424197842, 79866.6006669963, 80255.0, 895.0646574329711, 915.4004127296631, 921.635953798246, 930.2418528898926, 931.6087243357941, 15701.685966280838, 15851.969621974535, 16065.196740162712, 16868.746968795233, 17024.999125205813, 27581.586276206275, 34313.485297721054, 36343.45484817677, 36383.81808090943, 36550.8172459136, 47256.87779910395, 48910.75544622254, 51662.74168629133, 51925.7403712979, 52463.47536524586, 7656.961715191388, 7657.425693072931, 7805.8829117562145, 7871.252231038042, 7935.166807485131, 9122.452652840851, 11530.1928864982, 11804.0, 11993.940030299793, 12186.268823870241, 9795.559199835881, 10144.695659130239, 10350.068493835592, 10431.58273669075, 10733.355998640107, 9653.324267301221, 10198.184145268213, 10295.794084118426, 10312.742181445525, 10332.845007324746, 10506.0, 10590.417527036087, 10626.0, 10717.9464102679, 10832.404217768099, 7563.508371955805, 7594.8860767087435, 7712.498687585289, 7832.505944268034, 7950.840983180419, 8789.824203516022, 10021.398716076767, 10038.548265328223, 10160.187185025328, 10485.26603137773], "value": 8166.799150757461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1242.7141757395805, 1330.3215360166312, 1370.3285390158826, 1372.6568357910523, 1601.1994002998501, 6512.479001679866, 7455.627218639073, 7687.154413014564, 7693.846123077542, 7946.562939038351, 7783.92216077839, 7847.0, 7848.960755196216, 7852.882206766903, 7862.803429914241, 2094.706741056253, 2114.5559432519112, 2114.6722258050027, 2117.3859580721573, 2120.183729264229, 2048.989755051223, 2082.979170208301, 2095.0153427888868, 2109.6835474678846, 2110.2930518276394, 2071.078370125295, 2073.284716772711, 2077.7610574783944, 2080.6670932650777, 2085.280578200526, 2059.969100463494, 2062.9690554641693, 2068.7620923593827, 2075.294399904032, 2079.5840831833543, 2011.9195232190696, 2020.6968954656918, 2061.98969005154, 2065.535254567725, 2066.95866082679, 7545.320921117126, 7660.578668173248, 7733.994580704529, 7761.883571746428, 7783.766487005399, 4291.442112525352, 4444.28891377378, 4447.0, 4447.933281000755, 4449.488308844492, 2578.626099215622, 2654.1772050664354, 2686.1404350607813, 2695.3261684578856, 2705.998780451226, 824.814416756225, 826.0706704956923, 837.3426859914998, 840.9243168114838, 841.1252297610478, 10376.584936602527, 10475.423851688154, 10500.632477863315, 10514.158867290598, 10515.0, 3646.781193128421, 3851.326017946848, 3906.453096566483, 3938.0942383252013, 3959.366501359826, 8123.3095186908595, 8124.172061286282, 8130.430869839172, 8169.428140030141, 8182.427230093836, 4387.276099443556, 4389.4513185851765, 4390.846320378835, 4391.385206071152, 4394.033312671208, 3585.2112535242204, 3710.870119545803, 3983.2232714620372, 4089.7750623715388, 4092.1406504633765, 3183.2837611537684, 3282.901512954615, 3315.1214928044087, 3340.716039136652, 3373.8144402057633, 1044.6343779677052, 1046.2885238038207, 1048.0933992096782, 1052.9684109476727, 1064.7178497698117, 795.3915254830059, 832.9750107496785, 836.5566249887569, 837.8240569480478, 851.7827953871723, 5035.874103147451, 5124.897502050013, 5144.279800827887, 5196.0, 5204.193350030751, 371.5300145316123, 384.644204111196, 387.3743903595729, 390.2838291734642, 390.50210980998884, 3500.054985153994, 3502.1069627244888, 3520.1727594015388, 3528.6647768462467, 3614.6385361464168, 9045.095490450902, 9415.717528474157, 9420.057994200524, 9461.763455913657, 9486.335956483117, 9303.302252331103, 9344.859827102599, 9349.672761453316, 9352.438853668802, 9412.388194767318, 6816.420604248694, 6928.44572434204, 7036.401905838061, 7042.6126563039525, 7048.436125109979, 5208.635395522429, 5210.791568337376, 5270.130428479258, 5395.784168633368, 5487.478689524489, 8712.346574006848, 8723.432976856484, 8725.563721814011, 8774.868376974478, 8775.254103401283, 8559.0, 8843.336749743667, 8949.105089491259, 8957.865632015395, 8975.237104846161, 5528.695921724344, 6088.695565221633, 6102.694865256631, 6125.601835880653, 6140.539459540463, 6636.568623039487, 6988.930110698828, 7194.784156475314, 7242.239564845615, 7445.218252083453, 6403.3276505966205, 6410.262819775786, 6612.933870661232, 6620.768273110418, 6732.764353247809, 6310.968445157745, 6375.458086062551, 6487.805365839033, 6488.837779055561, 6599.0761293418, 5868.0, 5949.25634295713, 5979.282486101695, 6002.939970600412, 6016.8796624068145, 4562.247229207276, 4674.088552732184, 4719.38647975761, 4768.928466072943, 4769.260764581495, 4503.234450143549, 4577.977110114428, 4660.324252983366, 4701.177293973473, 4839.540243676845], "value": 3881.307446910111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.5816461542302, 300.71882789591734, 301.81136789506553, 305.75845082384916, 309.24081380211584, 4810.783514741836, 4909.091818013666, 4926.955313544879, 4929.014197160564, 4984.4018717753925, 4812.711237325763, 4854.320395144682, 4864.805407783684, 4869.561739443449, 4873.439554451239, 3578.5347904772343, 3690.7785532868115, 3691.907702307437, 3765.284595926779, 3821.808909554525, 3810.5236845394325, 3814.771113733185, 3833.8658146964863, 3843.9807800960957, 3851.9229615407676, 3778.263238668461, 3783.545974483066, 3791.592338864827, 3794.981025094871, 3820.815547180369, 3561.145325121978, 3679.374506333903, 3699.944500832476, 3733.701303895709, 3812.0850995760816, 3339.933201335984, 3345.6821601947777, 3346.397648423283, 3346.4311067118406, 3350.011746534778, 4695.1783437898575, 4695.5304469552775, 4697.741624210667, 4706.505816889246, 4726.149293127236, 4203.684723645708, 4319.50325712544, 4330.198913201068, 4332.978335108336, 4350.4115051544595, 5029.346184995927, 5030.622703297267, 5033.295338652591, 5035.84892453227, 5040.370932928286, 3667.6699097081123, 3669.87155449558, 3679.2641471705765, 3701.592824789271, 3704.666320124753, 5176.0683077046115, 5284.497972692588, 5293.470652934714, 5296.92054619181, 5349.0, 3719.6094410087094, 3726.9068273293383, 3727.7949712765517, 3733.272011957642, 3753.4423214365734, 3770.359038963383, 3782.63585259213, 3796.6013568575454, 3816.2749077675153, 3829.5021647186245, 4320.524742278347, 4333.653307735373, 4336.631386332134, 4353.760543170093, 4371.322445021026, 4840.491748366371, 4983.25251212321, 5013.3983921928875, 5057.165567681365, 5128.384593848762, 1304.621659718671, 1311.2591385866954, 1315.4540865540694, 1316.2694704439127, 1322.358656051814, 819.8975128108987, 821.9630116644765, 856.2764464027887, 867.1891781184487, 874.4753148111082, 4329.264025115738, 4421.9336709949375, 4519.960409105924, 4522.728636281834, 4524.57475895092, 5217.373915130132, 5222.164453687392, 5232.3721153461065, 5234.895302094013, 5239.030779305841, 4520.50274469808, 4531.320301954667, 4535.478419981679, 4546.74992875395, 4566.178087944136, 2652.5092857821364, 2797.8740956656998, 2802.089320970693, 2813.3529288263403, 2833.5891295762412, 4938.728369939688, 4948.975255123773, 4957.107720610325, 4971.527704868032, 4973.50264973507, 5191.558717509054, 5355.30381050461, 5384.6769193848495, 5406.135018397038, 5432.212329212242, 4885.291632713237, 4912.361393018885, 4918.704877707349, 4965.30485732005, 4979.9004019918675, 5278.656887302313, 5314.229436731575, 5328.626996110235, 5341.8782055768725, 5343.519083282523, 5046.268291097844, 5138.203578445347, 5145.279660847409, 5214.0, 5229.895402092013, 4945.455999839943, 4945.975270123627, 4951.133551628379, 4982.402111746469, 4997.9500204997485, 3376.7805092668896, 3377.3583019226267, 3398.3033478136426, 3432.262063656326, 3448.965510344965, 4578.855286178456, 4632.2819962905805, 4746.691465054761, 4760.809567617256, 4769.260764581495, 4506.78316854454, 4538.909221815479, 4573.908521829611, 4623.791929363254, 4627.467841198305, 4574.382458368211, 4591.3801636779945, 4595.149897269016, 4611.700239484423, 4613.3771940787565, 4468.123388177039, 4497.437820272466, 4507.887302817456, 4508.661850361171, 4520.751358675305, 4733.502982186958, 4861.805527778849, 4996.775145118406, 5015.423226329019, 5118.846434606968, 5019.799208031638, 5035.723035233097, 5041.395032596112, 5044.974775126101, 5051.393832740095], "value": 3785.8453466519427, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.75543516288, 577.1256546332305, 580.669018659364, 635.313861030087, 645.6416688737748, 12024.879751202485, 12432.378381080933, 12941.805872911913, 12990.0, 12999.350032498372, 13029.609111726664, 13625.523106691267, 13680.247586382746, 13711.177329360245, 13713.108647937877, 738.2801768275915, 753.9971837456197, 755.7921571567836, 756.6632848382473, 756.8032311598969, 621.9906701399483, 639.6162302618415, 745.0947099274381, 765.1850778920432, 771.1363273134069, 798.5049269452918, 799.6601444386142, 799.6841247707152, 800.3557136505111, 800.3997002248313, 793.80551764818, 794.9562774047425, 795.2683531151325, 795.2961628958385, 795.4829360915394, 482.44277859072827, 489.56428778387266, 568.8208214412447, 584.080073883635, 588.4233451217788, 11971.46128424223, 11984.101192410604, 11998.0, 11998.940005300004, 12016.279023258632, 11008.39453830039, 11524.308541487537, 11626.825597616042, 11813.586524471688, 12126.029917606571, 10915.890841091566, 11182.27315224516, 11221.831672524919, 11228.0, 11281.717957051058, 4057.6348128668265, 4068.593140685937, 4089.3865920111925, 4090.9181816363507, 4277.850275240352, 61940.0, 63019.0, 63925.360746392405, 65329.34670653327, 65431.67284163596, 9493.715188544355, 9523.90476095244, 9711.077447642463, 9784.853227201455, 9848.21214302854, 17587.56031099207, 17596.0, 17605.647887042443, 17608.11959402025, 17626.559336016446, 6168.629882206992, 6181.227346581677, 6199.132121502903, 6333.904991425133, 6413.16628838248, 3371.072954937412, 3455.2571197192724, 3458.3602033623356, 3476.4090104682264, 3526.559180102487, 2597.714251432341, 2664.7475686427347, 2670.946581068368, 2673.4385778986243, 2676.598510223482, 462.54208333749347, 469.8825293676581, 472.6100966702484, 476.6734786671141, 483.1737728484261, 464.82801363495724, 479.54203735432577, 487.19612639144987, 513.2070950381594, 552.7844140785097, 7098.0, 7467.0, 7523.510971786816, 7761.689532418753, 7865.567393793282, 465.4693649239869, 472.69274971268266, 476.9403824521935, 489.2905287333381, 513.3403576404377, 3596.8561257549927, 3681.7606855554304, 3792.905177370533, 3799.1831756172005, 3907.6873850091924, 55230.0, 56458.717706412026, 72641.0, 75525.24474755183, 76623.61688191634, 23969.880150599136, 24057.639135412985, 24285.150019749224, 28924.710752892202, 61670.0749488758, 61341.4792668662, 63523.364766353596, 63958.0, 68043.31956680567, 69443.0, 7790.376769858284, 8268.793280168044, 8325.167483251626, 8336.458130221516, 8451.112633173674, 40319.3952090713, 42361.78819105885, 42665.36001960035, 42978.57021429871, 43000.78499607607, 34652.82673586616, 39277.60722392739, 57173.42826571681, 59869.70065149647, 60465.0, 10918.781624367628, 10956.397398143179, 11096.88903110991, 11252.718682033015, 11737.765244695229, 11257.549698012315, 11901.345426001306, 12294.20087694297, 12651.240925544496, 13047.913339005634, 11117.722056948642, 11559.422028898689, 12230.205036672587, 12255.0, 12262.0, 10416.583336666752, 11153.0, 11375.715607109889, 11407.600733974272, 11426.600068997544, 10222.437765922945, 10780.191485638765, 11185.440727963733, 11441.713957150805, 11457.885421146015, 8948.418352807306, 9207.0, 9406.858897116412, 9539.09378609031, 9541.522923853918, 8449.704260350858, 8713.0, 8812.339074569305, 9212.355135140744, 9289.72130836076], "value": 6000.92127762401, "unit": "score"}], "name": "dromaeo_css", "value": 6143.506225664645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 116.0, 114.0, 114.0, 113.0, 115.0, 113.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 125.0, 174.0, 127.0, 137.0, 127.0, 126.0, 162.0, 127.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 160.0, 161.0, 160.0, 162.0, 160.0, 160.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 110.0, 77.0, 76.0, 75.0, 76.0, 113.0, 76.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 116.0, 83.0, 85.0, 83.0, 112.0, 82.0, 83.0, 117.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 118.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 145.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 67.0, 70.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 88.0, 84.0, 82.0, 83.0, 89.0, 83.0, 83.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 141.0, 139.0, 148.0, 142.0, 138.0, 140.0, 148.0, 187.0, 139.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 172.0, 170.0, 172.0, 172.0, 170.0, 171.0, 172.0, 171.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 74.0, 70.0, 68.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1555.0, "alertThreshold": 2.0}]} 00:08:25 INFO - Return code: 0 00:08:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:08:25 INFO - # TBPL SUCCESS # 00:08:25 INFO - Running post-action listener: _resource_record_post_action 00:08:25 INFO - [mozharness: 2016-10-03 07:08:25.260736Z] Finished run-tests step (success) 00:08:25 INFO - Running post-run listener: _resource_record_post_run 00:08:25 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402362368; Read time: 8; Write time: 207996 00:08:25 INFO - TinderboxPrint: CPU usage
13.0% 00:08:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 00:08:25 INFO - TinderboxPrint: I/O write bytes / time
402,362,368 / 207,996 00:08:25 INFO - TinderboxPrint: CPU idle
8,352.8 (86.9%) 00:08:25 INFO - TinderboxPrint: CPU user
1,205.6 (12.5%) 00:08:25 INFO - TinderboxPrint: Swap in / out
0 / 0 00:08:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99995648; Read time: 0; Write time: 66168 00:08:25 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291028992; Read time: 0; Write time: 139564 00:08:25 INFO - Running post-run listener: _upload_blobber_files 00:08:25 INFO - Blob upload gear active. 00:08:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:08:25 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 00:08:25 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'] 00:08:25 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 00:08:26 INFO - (blobuploader) - INFO - Open directory for files ... 00:08:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:08:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:08:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:08:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:08:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:08:27 INFO - (blobuploader) - INFO - Done attempting. 00:08:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:08:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:08:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:08:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:08:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:08:28 INFO - (blobuploader) - INFO - Done attempting. 00:08:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:08:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:08:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:08:32 INFO - (blobuploader) - INFO - Done attempting. 00:08:32 INFO - (blobuploader) - INFO - Iteration through files over. 00:08:32 INFO - Return code: 0 00:08:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:08:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:08:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65eabf6ce2248f79e956dd261aa5a5bada5447d3cd0d1870eee2ccc205b403cffe54ac5be501561956bcd3d7e18d73060458f9a91c86534ba5479ac2e8732432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/546dd702ed330c1b71b8138dcaff11c320bd586e5490f068fe8b690303030e10cb1706454bc1d5b6f23933d4bab26304526b89bdf8f3715d8a8d9cc21d7c243b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1e1431494921eca14fd1f9aed34220e5b6c5276a84b6c99fa9518934a9a2f031391b3685a6f6d43d5515ea751c27f6a1d6d2649e557825aeede0dfa4d00d808"} 00:08:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:08:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:08:32 INFO - Contents: 00:08:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65eabf6ce2248f79e956dd261aa5a5bada5447d3cd0d1870eee2ccc205b403cffe54ac5be501561956bcd3d7e18d73060458f9a91c86534ba5479ac2e8732432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/546dd702ed330c1b71b8138dcaff11c320bd586e5490f068fe8b690303030e10cb1706454bc1d5b6f23933d4bab26304526b89bdf8f3715d8a8d9cc21d7c243b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1e1431494921eca14fd1f9aed34220e5b6c5276a84b6c99fa9518934a9a2f031391b3685a6f6d43d5515ea751c27f6a1d6d2649e557825aeede0dfa4d00d808"} 00:08:32 INFO - Running post-run listener: copy_logs_to_upload_dir 00:08:32 INFO - Copying logs to upload dir... 00:08:32 INFO - mkdir: /builds/slave/test/build/upload/logs 00:08:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.103829 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-03 00:08:32.012042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 00:08:32.015596) ========= 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=41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65eabf6ce2248f79e956dd261aa5a5bada5447d3cd0d1870eee2ccc205b403cffe54ac5be501561956bcd3d7e18d73060458f9a91c86534ba5479ac2e8732432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/546dd702ed330c1b71b8138dcaff11c320bd586e5490f068fe8b690303030e10cb1706454bc1d5b6f23933d4bab26304526b89bdf8f3715d8a8d9cc21d7c243b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1e1431494921eca14fd1f9aed34220e5b6c5276a84b6c99fa9518934a9a2f031391b3685a6f6d43d5515ea751c27f6a1d6d2649e557825aeede0dfa4d00d808"} build_url:https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/NfmzJECESaWqX-px_rHtnQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/65eabf6ce2248f79e956dd261aa5a5bada5447d3cd0d1870eee2ccc205b403cffe54ac5be501561956bcd3d7e18d73060458f9a91c86534ba5479ac2e8732432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/546dd702ed330c1b71b8138dcaff11c320bd586e5490f068fe8b690303030e10cb1706454bc1d5b6f23933d4bab26304526b89bdf8f3715d8a8d9cc21d7c243b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a1e1431494921eca14fd1f9aed34220e5b6c5276a84b6c99fa9518934a9a2f031391b3685a6f6d43d5515ea751c27f6a1d6d2649e557825aeede0dfa4d00d808"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 00:08:32.040590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 00:08:32.040928) ========= 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=41bf3e9aed84707956354da8000001c5-1475476979.788379-672698020 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 00:08:32.123267) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 00:08:32.123587) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 00:08:32.123891) ========= ========= Total master_lag: 0.17 =========