builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1476748924.87 results: success (0) buildid: 20161017153519 builduid: 806b249512b9415f81a5f632c3c661b8 revision: 56b3f2c6f53e72698fea6c25130efceef2a26548 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:04.870150) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:04.870603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:04.870891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:04.886091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:04.886467) ========= 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=ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 17:02:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.3M=0.001s 2016-10-17 17:02:05 (17.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:05.029265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:05.029577) ========= 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=ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014166 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:05.079485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 17:02:05.079848) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 56b3f2c6f53e72698fea6c25130efceef2a26548 --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 56b3f2c6f53e72698fea6c25130efceef2a26548 --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=ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 17:02:05,334 truncating revision to first 12 chars 2016-10-17 17:02:05,334 Setting DEBUG logging. 2016-10-17 17:02:05,334 attempt 1/10 2016-10-17 17:02:05,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/56b3f2c6f53e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 17:02:06,390 unpacking tar archive at: mozilla-central-56b3f2c6f53e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380097 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 17:02:06.473368) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:06.473734) ========= script_repo_revision: 56b3f2c6f53e72698fea6c25130efceef2a26548 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:06.474140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:06.474445) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:02:06.485589) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-17 17:02:06.486052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:02:06 INFO - MultiFileLogger online at 20161017 17:02:06 in /builds/slave/test 17:02:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:02:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:02:06 INFO - {'append_to_log': False, 17:02:06 INFO - 'base_work_dir': '/builds/slave/test', 17:02:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:02:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:02:06 INFO - 'branch': 'Firefox-Non-PGO', 17:02:06 INFO - 'buildbot_json_path': 'buildprops.json', 17:02:06 INFO - 'config_files': ('talos/linux_config.py',), 17:02:06 INFO - 'default_actions': ('clobber', 17:02:06 INFO - 'read-buildbot-config', 17:02:06 INFO - 'download-and-extract', 17:02:06 INFO - 'populate-webroot', 17:02:06 INFO - 'create-virtualenv', 17:02:06 INFO - 'install', 17:02:06 INFO - 'run-tests'), 17:02:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:02:06 INFO - 'download_minidump_stackwalk': True, 17:02:06 INFO - 'download_symbols': 'ondemand', 17:02:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:02:06 INFO - 'tooltool.py': '/tools/tooltool.py', 17:02:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:02:06 INFO - '/tools/misc-python/virtualenv.py')}, 17:02:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:02:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:02:06 INFO - 'installer_path': 'installer.exe', 17:02:06 INFO - 'log_level': 'info', 17:02:06 INFO - 'log_name': 'talos', 17:02:06 INFO - 'log_to_console': True, 17:02:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:02:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:02:06 INFO - 'opt_config_files': (), 17:02:06 INFO - 'pip_index': False, 17:02:06 INFO - 'sps_profile': False, 17:02:06 INFO - 'sps_profile_interval': 0, 17:02:06 INFO - 'suite': 'dromaeojs-e10s', 17:02:06 INFO - 'system_bits': '32', 17:02:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:02:06 INFO - 'title': 'talos-linux64-ix-035', 17:02:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:02:06 INFO - 'use_talos_json': True, 17:02:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:02:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:02:06 INFO - 'work_dir': 'build'} 17:02:06 INFO - [mozharness: 2016-10-18 00:02:06.839867Z] Running clobber step. 17:02:06 INFO - Running pre-action listener: _resource_record_pre_action 17:02:06 INFO - Running main action method: clobber 17:02:06 INFO - rmtree: /builds/slave/test/build 17:02:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:02:07 INFO - Running post-action listener: _resource_record_post_action 17:02:07 INFO - [mozharness: 2016-10-18 00:02:07.293928Z] Finished clobber step (success) 17:02:07 INFO - [mozharness: 2016-10-18 00:02:07.294028Z] Running read-buildbot-config step. 17:02:07 INFO - Running pre-action listener: _resource_record_pre_action 17:02:07 INFO - Running main action method: read_buildbot_config 17:02:07 INFO - Using buildbot properties: 17:02:07 INFO - { 17:02:07 INFO - "project": "", 17:02:07 INFO - "product": "firefox", 17:02:07 INFO - "script_repo_revision": "production", 17:02:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:02:07 INFO - "repository": "", 17:02:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:02:07 INFO - "buildid": "20161017153519", 17:02:07 INFO - "pgo_build": "False", 17:02:07 INFO - "basedir": "/builds/slave/test", 17:02:07 INFO - "buildnumber": 519, 17:02:07 INFO - "slavename": "talos-linux64-ix-035", 17:02:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:02:07 INFO - "platform": "ubuntu64_hw", 17:02:07 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:02:07 INFO - "branch": "mozilla-central", 17:02:07 INFO - "repo_path": "mozilla-central", 17:02:07 INFO - "revision": "56b3f2c6f53e72698fea6c25130efceef2a26548", 17:02:07 INFO - "stage_platform": "linux64", 17:02:07 INFO - "builduid": "806b249512b9415f81a5f632c3c661b8", 17:02:07 INFO - "slavebuilddir": "test" 17:02:07 INFO - } 17:02:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:02:07 INFO - Running post-action listener: _resource_record_post_action 17:02:07 INFO - [mozharness: 2016-10-18 00:02:07.296432Z] Finished read-buildbot-config step (success) 17:02:07 INFO - [mozharness: 2016-10-18 00:02:07.296531Z] Running download-and-extract step. 17:02:07 INFO - Running pre-action listener: _resource_record_pre_action 17:02:07 INFO - Running main action method: download_and_extract 17:02:07 INFO - mkdir: /builds/slave/test/build/tests 17:02:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:07 INFO - trying https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:02:07 INFO - Downloading https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/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 17:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/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 17:02:07 INFO - Downloaded 1361 bytes. 17:02:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:02:07 INFO - Using the following test package requirements: 17:02:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:02:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:02:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'jsshell-linux-x86_64.zip'], 17:02:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:02:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:02:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:02:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:02:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:02:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:02:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:02:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:02:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:02:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:02:07 INFO - Fetch https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:02:08 INFO - Http code: 200 17:02:08 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 17:02:08 INFO - x-amz-cf-id: mCNlSfiu_IAMKtfoR9RW4QYgEg0ELdK9tHuX0QTh_lz7wEnktbvg7w== 17:02:08 INFO - x-amz-version-id: AFk.obNWSUP1QlWCxJH_IH2Ve7f.b7EB 17:02:08 INFO - Expected file size: 20519939 17:02:08 INFO - Obtained file size: 20519939 17:02:12 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 17:02:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:02:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:02:12 INFO - Fetch https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:02:13 INFO - Http code: 200 17:02:13 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 17:02:13 INFO - x-amz-cf-id: w368Ghb0I1XOpxv2wv9OWPZ67Mz9aW7SyM4MyhhmL07IAF5laF_Cpw== 17:02:13 INFO - x-amz-version-id: AFk.obNWSUP1QlWCxJH_IH2Ve7f.b7EB 17:02:13 INFO - Expected file size: 20519939 17:02:13 INFO - Obtained file size: 20519939 17:02:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:02:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:02:18 INFO - Fetch https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:02:18 INFO - Http code: 200 17:02:18 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 17:02:18 INFO - x-amz-cf-id: 5h5iV6sYdDdoKaVQCnDS-isfZQL3IH1TQ5QoBo7jti6y854Cm0Nw9w== 17:02:18 INFO - x-amz-version-id: Yq1KoPX6xXlrILbns9IxnXbIRrWK5_Ku 17:02:18 INFO - Expected file size: 14409028 17:02:18 INFO - Obtained file size: 14409028 17:02:19 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')]} 17:02:19 INFO - trying https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:02:19 INFO - Downloading https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/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 17:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/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 17:02:20 INFO - Downloaded 55565541 bytes. 17:02:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:02:20 INFO - mkdir: /builds/slave/test/properties 17:02:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:02:20 INFO - Writing to file /builds/slave/test/properties/build_url 17:02:20 INFO - Contents: 17:02:20 INFO - build_url:https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:02:21 INFO - Running post-action listener: _resource_record_post_action 17:02:21 INFO - Running post-action listener: set_extra_try_arguments 17:02:21 INFO - [mozharness: 2016-10-18 00:02:21.126435Z] Finished download-and-extract step (success) 17:02:21 INFO - [mozharness: 2016-10-18 00:02:21.126660Z] Running populate-webroot step. 17:02:21 INFO - Running pre-action listener: _resource_record_pre_action 17:02:21 INFO - Running main action method: populate_webroot 17:02:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:02:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:02:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:02:21 INFO - '--tppagecycles', 17:02:21 INFO - '7'], 17:02:21 INFO - 'tests': ['tsvgm']}}, 17:02:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:02:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:02:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:02:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:02:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:02:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['damp', 'tps']}, 17:02:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'tests': ['damp', 'tps']}, 17:02:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['dromaeo_dom']}, 17:02:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:02:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['basic_compositor_video']}, 17:02:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:02:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['a11yr', 17:02:21 INFO - 'ts_paint', 17:02:21 INFO - 'tpaint', 17:02:21 INFO - 'sessionrestore', 17:02:21 INFO - 'sessionrestore_no_auto_restore', 17:02:21 INFO - 'tabpaint']}, 17:02:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:02:21 INFO - 'ts_paint', 17:02:21 INFO - 'tpaint', 17:02:21 INFO - 'sessionrestore', 17:02:21 INFO - 'sessionrestore_no_auto_restore', 17:02:21 INFO - 'tabpaint']}, 17:02:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:02:21 INFO - 'ts_paint', 17:02:21 INFO - 'tpaint', 17:02:21 INFO - 'sessionrestore', 17:02:21 INFO - 'sessionrestore_no_auto_restore', 17:02:21 INFO - 'tabpaint']}, 17:02:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:02:21 INFO - 'ts_paint', 17:02:21 INFO - 'tpaint', 17:02:21 INFO - 'sessionrestore', 17:02:21 INFO - 'sessionrestore_no_auto_restore', 17:02:21 INFO - 'tabpaint']}, 17:02:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['a11yr', 17:02:21 INFO - 'ts_paint', 17:02:21 INFO - 'tpaint', 17:02:21 INFO - 'sessionrestore', 17:02:21 INFO - 'sessionrestore_no_auto_restore', 17:02:21 INFO - 'tabpaint']}, 17:02:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['a11yr', 17:02:21 INFO - 'ts_paint', 17:02:21 INFO - 'tpaint', 17:02:21 INFO - 'sessionrestore', 17:02:21 INFO - 'sessionrestore_no_auto_restore', 17:02:21 INFO - 'tabpaint']}, 17:02:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['tsvgx', 17:02:21 INFO - 'tsvgr_opacity', 17:02:21 INFO - 'tart', 17:02:21 INFO - 'tscrollx', 17:02:21 INFO - 'cart']}, 17:02:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:02:21 INFO - 'tsvgr_opacity', 17:02:21 INFO - 'tart', 17:02:21 INFO - 'tscrollx', 17:02:21 INFO - 'cart']}, 17:02:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'talos_options': ['--disable-e10s'], 17:02:21 INFO - 'tests': ['tp5o']}, 17:02:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'tests': ['tp5o']}, 17:02:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'talos_options': ['--disable-e10s', 17:02:21 INFO - '--xperf_path', 17:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:21 INFO - 'tests': ['tp5n']}, 17:02:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:02:21 INFO - 'talos_options': ['--xperf_path', 17:02:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:02:21 INFO - 'tests': ['tp5n']}}, 17:02:21 INFO - 'talos.zip': {'path': '', 17:02:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:02:21 INFO - Running post-action listener: _resource_record_post_action 17:02:21 INFO - [mozharness: 2016-10-18 00:02:21.148682Z] Finished populate-webroot step (success) 17:02:21 INFO - [mozharness: 2016-10-18 00:02:21.148769Z] Running create-virtualenv step. 17:02:21 INFO - Running pre-action listener: _resource_record_pre_action 17:02:21 INFO - Running main action method: create_virtualenv 17:02:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:02:21 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 17:02:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:02:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:02:21 INFO - Using real prefix '/usr' 17:02:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:02:21 INFO - Installing distribute.............................................................................................................................................................................................done. 17:02:23 INFO - Installing pip.................done. 17:02:23 INFO - Return code: 0 17:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:02:23 INFO - Reading from file tmpfile_stdout 17:02:23 INFO - Output received: 17:02:23 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) 17:02:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:02:23 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')]} 17:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:23 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')]} 17:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:23 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:23 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 17:02:23 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 17:02:23 INFO - Using env: {'DISPLAY': ':0', 17:02:23 INFO - 'HOME': '/home/cltbld', 17:02:23 INFO - 'LANG': 'en_US.UTF-8', 17:02:23 INFO - 'LANGUAGE': 'en_US:en', 17:02:23 INFO - 'LOGNAME': 'cltbld', 17:02:23 INFO - 'MAIL': '/var/mail/cltbld', 17:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:23 INFO - 'MOZ_NO_REMOTE': '1', 17:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:23 INFO - 'NO_EM_RESTART': '1', 17:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:23 INFO - 'PWD': '/builds/slave/test', 17:02:23 INFO - 'SHELL': '/bin/bash', 17:02:23 INFO - 'SHLVL': '1', 17:02:23 INFO - 'TERM': 'linux', 17:02:23 INFO - 'TMOUT': '86400', 17:02:23 INFO - 'USER': 'cltbld', 17:02:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:23 INFO - '_': '/tools/buildbot/bin/python'} 17:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:24 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 17:02:24 INFO - Cleaning up... 17:02:24 INFO - Return code: 0 17:02:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:02:24 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')]} 17:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:24 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')]} 17:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:24 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:24 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 17:02:24 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 17:02:24 INFO - Using env: {'DISPLAY': ':0', 17:02:24 INFO - 'HOME': '/home/cltbld', 17:02:24 INFO - 'LANG': 'en_US.UTF-8', 17:02:24 INFO - 'LANGUAGE': 'en_US:en', 17:02:24 INFO - 'LOGNAME': 'cltbld', 17:02:24 INFO - 'MAIL': '/var/mail/cltbld', 17:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:24 INFO - 'MOZ_NO_REMOTE': '1', 17:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:24 INFO - 'NO_EM_RESTART': '1', 17:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:24 INFO - 'PWD': '/builds/slave/test', 17:02:24 INFO - 'SHELL': '/bin/bash', 17:02:24 INFO - 'SHLVL': '1', 17:02:24 INFO - 'TERM': 'linux', 17:02:24 INFO - 'TMOUT': '86400', 17:02:24 INFO - 'USER': 'cltbld', 17:02:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:24 INFO - '_': '/tools/buildbot/bin/python'} 17:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:24 INFO - Downloading/unpacking psutil>=3.1.1 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:24 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 17:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:02:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:26 INFO - Installing collected packages: psutil 17:02:26 INFO - Running setup.py install for psutil 17:02:26 INFO - building 'psutil._psutil_linux' extension 17:02:26 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 17:02:26 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 17:02:26 INFO - building 'psutil._psutil_posix' extension 17:02:26 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 17:02:26 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 17:02:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:02:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:02:26 INFO - Successfully installed psutil 17:02:26 INFO - Cleaning up... 17:02:26 INFO - Return code: 0 17:02:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:02:26 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')]} 17:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:26 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')]} 17:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:26 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:26 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 17:02:26 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 17:02:26 INFO - Using env: {'DISPLAY': ':0', 17:02:26 INFO - 'HOME': '/home/cltbld', 17:02:26 INFO - 'LANG': 'en_US.UTF-8', 17:02:26 INFO - 'LANGUAGE': 'en_US:en', 17:02:26 INFO - 'LOGNAME': 'cltbld', 17:02:26 INFO - 'MAIL': '/var/mail/cltbld', 17:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:26 INFO - 'MOZ_NO_REMOTE': '1', 17:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:26 INFO - 'NO_EM_RESTART': '1', 17:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:26 INFO - 'PWD': '/builds/slave/test', 17:02:26 INFO - 'SHELL': '/bin/bash', 17:02:26 INFO - 'SHLVL': '1', 17:02:26 INFO - 'TERM': 'linux', 17:02:26 INFO - 'TMOUT': '86400', 17:02:26 INFO - 'USER': 'cltbld', 17:02:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:26 INFO - '_': '/tools/buildbot/bin/python'} 17:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:02:27 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 17:02:27 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 17:02:27 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 17:02:27 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 17:02:27 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 17:02:27 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 17:02:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:02:29 INFO - Installing collected packages: mozsystemmonitor 17:02:29 INFO - Running setup.py install for mozsystemmonitor 17:02:29 INFO - Successfully installed mozsystemmonitor 17:02:29 INFO - Cleaning up... 17:02:29 INFO - Return code: 0 17:02:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:02:29 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')]} 17:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:29 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')]} 17:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:29 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:29 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 17:02:29 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 17:02:29 INFO - Using env: {'DISPLAY': ':0', 17:02:29 INFO - 'HOME': '/home/cltbld', 17:02:29 INFO - 'LANG': 'en_US.UTF-8', 17:02:29 INFO - 'LANGUAGE': 'en_US:en', 17:02:29 INFO - 'LOGNAME': 'cltbld', 17:02:29 INFO - 'MAIL': '/var/mail/cltbld', 17:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:29 INFO - 'MOZ_NO_REMOTE': '1', 17:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:29 INFO - 'NO_EM_RESTART': '1', 17:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:29 INFO - 'PWD': '/builds/slave/test', 17:02:29 INFO - 'SHELL': '/bin/bash', 17:02:29 INFO - 'SHLVL': '1', 17:02:29 INFO - 'TERM': 'linux', 17:02:29 INFO - 'TMOUT': '86400', 17:02:29 INFO - 'USER': 'cltbld', 17:02:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:29 INFO - '_': '/tools/buildbot/bin/python'} 17:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:29 INFO - Downloading/unpacking jsonschema==2.5.1 17:02:29 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 17:02:29 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 17:02:29 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 17:02:29 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 17:02:29 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 17:02:29 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 17:02:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:02:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:02:31 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 17:02:31 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 17:02:31 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 17:02:31 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 17:02:31 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 17:02:31 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 17:02:31 INFO - Downloading functools32-3.2.3-2.tar.gz 17:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:02:31 INFO - warning: no files found matching '*.txt' 17:02:31 INFO - no previously-included directories found matching 'build' 17:02:31 INFO - no previously-included directories found matching 'dist' 17:02:31 INFO - no previously-included directories found matching '.git*' 17:02:31 INFO - Installing collected packages: jsonschema, functools32 17:02:31 INFO - Running setup.py install for functools32 17:02:32 INFO - warning: no files found matching '*.txt' 17:02:32 INFO - no previously-included directories found matching 'build' 17:02:32 INFO - no previously-included directories found matching 'dist' 17:02:32 INFO - no previously-included directories found matching '.git*' 17:02:32 INFO - Successfully installed jsonschema functools32 17:02:32 INFO - Cleaning up... 17:02:32 INFO - Return code: 0 17:02:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:32 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:32 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 17:02:32 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 17:02:32 INFO - Using env: {'DISPLAY': ':0', 17:02:32 INFO - 'HOME': '/home/cltbld', 17:02:32 INFO - 'LANG': 'en_US.UTF-8', 17:02:32 INFO - 'LANGUAGE': 'en_US:en', 17:02:32 INFO - 'LOGNAME': 'cltbld', 17:02:32 INFO - 'MAIL': '/var/mail/cltbld', 17:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:32 INFO - 'MOZ_NO_REMOTE': '1', 17:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:32 INFO - 'NO_EM_RESTART': '1', 17:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:32 INFO - 'PWD': '/builds/slave/test', 17:02:32 INFO - 'SHELL': '/bin/bash', 17:02:32 INFO - 'SHLVL': '1', 17:02:32 INFO - 'TERM': 'linux', 17:02:32 INFO - 'TMOUT': '86400', 17:02:32 INFO - 'USER': 'cltbld', 17:02:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:32 INFO - '_': '/tools/buildbot/bin/python'} 17:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:02:32 INFO - Cleaning up... 17:02:32 INFO - Return code: 0 17:02:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:32 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:32 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 17:02:32 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 17:02:32 INFO - Using env: {'DISPLAY': ':0', 17:02:32 INFO - 'HOME': '/home/cltbld', 17:02:32 INFO - 'LANG': 'en_US.UTF-8', 17:02:32 INFO - 'LANGUAGE': 'en_US:en', 17:02:32 INFO - 'LOGNAME': 'cltbld', 17:02:32 INFO - 'MAIL': '/var/mail/cltbld', 17:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:32 INFO - 'MOZ_NO_REMOTE': '1', 17:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:32 INFO - 'NO_EM_RESTART': '1', 17:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:32 INFO - 'PWD': '/builds/slave/test', 17:02:32 INFO - 'SHELL': '/bin/bash', 17:02:32 INFO - 'SHLVL': '1', 17:02:32 INFO - 'TERM': 'linux', 17:02:32 INFO - 'TMOUT': '86400', 17:02:32 INFO - 'USER': 'cltbld', 17:02:32 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:32 INFO - '_': '/tools/buildbot/bin/python'} 17:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:32 INFO - Downloading/unpacking blobuploader==1.2.4 17:02:32 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 17:02:32 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 17:02:32 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 17:02:32 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 17:02:32 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 17:02:32 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 17:02:34 INFO - Downloading blobuploader-1.2.4.tar.gz 17:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:02:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:02:34 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 17:02:34 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 17:02:34 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 17:02:34 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 17:02:34 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 17:02:34 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 17:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:02:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:02:34 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 17:02:34 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 17:02:34 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 17:02:34 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 17:02:34 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 17:02:34 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 17:02:35 INFO - Downloading docopt-0.6.1.tar.gz 17:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:02:35 INFO - Installing collected packages: blobuploader, requests, docopt 17:02:35 INFO - Running setup.py install for blobuploader 17:02:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:02:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:02:35 INFO - Running setup.py install for requests 17:02:35 INFO - Running setup.py install for docopt 17:02:35 INFO - Successfully installed blobuploader requests docopt 17:02:35 INFO - Cleaning up... 17:02:35 INFO - Return code: 0 17:02:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:35 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')]} 17:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:35 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')]} 17:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:35 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:35 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 17:02:35 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 17:02:35 INFO - Using env: {'DISPLAY': ':0', 17:02:35 INFO - 'HOME': '/home/cltbld', 17:02:35 INFO - 'LANG': 'en_US.UTF-8', 17:02:35 INFO - 'LANGUAGE': 'en_US:en', 17:02:35 INFO - 'LOGNAME': 'cltbld', 17:02:35 INFO - 'MAIL': '/var/mail/cltbld', 17:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:35 INFO - 'MOZ_NO_REMOTE': '1', 17:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:35 INFO - 'NO_EM_RESTART': '1', 17:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:35 INFO - 'PWD': '/builds/slave/test', 17:02:35 INFO - 'SHELL': '/bin/bash', 17:02:35 INFO - 'SHLVL': '1', 17:02:35 INFO - 'TERM': 'linux', 17:02:35 INFO - 'TMOUT': '86400', 17:02:35 INFO - 'USER': 'cltbld', 17:02:35 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:35 INFO - '_': '/tools/buildbot/bin/python'} 17:02:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:36 INFO - Running setup.py (path:/tmp/pip-7pZvWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:36 INFO - Running setup.py (path:/tmp/pip-J2zbnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:36 INFO - Running setup.py (path:/tmp/pip-ZbDrKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:36 INFO - Running setup.py (path:/tmp/pip-oFaPjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:36 INFO - Running setup.py (path:/tmp/pip-Y7x1JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:36 INFO - Running setup.py (path:/tmp/pip-BfuCCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:36 INFO - Running setup.py (path:/tmp/pip-LW3B1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:36 INFO - Running setup.py (path:/tmp/pip-O5TVKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:36 INFO - Running setup.py (path:/tmp/pip-U6JfS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:36 INFO - Running setup.py (path:/tmp/pip-tBQKqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:36 INFO - Running setup.py (path:/tmp/pip-ES8oAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:36 INFO - Running setup.py (path:/tmp/pip-nFFrI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:37 INFO - Running setup.py (path:/tmp/pip-QZz2ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:37 INFO - Running setup.py (path:/tmp/pip-O49jdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:37 INFO - Running setup.py (path:/tmp/pip-a1O3qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:37 INFO - Running setup.py (path:/tmp/pip-G7ZTAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:37 INFO - Running setup.py (path:/tmp/pip-tLdI99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:02:37 INFO - Running setup.py install for manifestparser 17:02:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:02:37 INFO - Running setup.py install for mozcrash 17:02:37 INFO - Running setup.py install for mozdebug 17:02:37 INFO - Running setup.py install for mozdevice 17:02:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:02:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:02:37 INFO - Running setup.py install for mozfile 17:02:37 INFO - Running setup.py install for mozhttpd 17:02:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:02:37 INFO - Running setup.py install for mozinfo 17:02:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Running setup.py install for mozInstall 17:02:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Running setup.py install for mozleak 17:02:38 INFO - Running setup.py install for mozlog 17:02:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Running setup.py install for moznetwork 17:02:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Running setup.py install for mozprocess 17:02:38 INFO - Running setup.py install for mozprofile 17:02:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Running setup.py install for mozrunner 17:02:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:02:38 INFO - Running setup.py install for mozscreenshot 17:02:38 INFO - Running setup.py install for moztest 17:02:39 INFO - Running setup.py install for mozversion 17:02:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:02:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:02:39 INFO - Cleaning up... 17:02:39 INFO - Return code: 0 17:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02:39 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')]} 17:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:39 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')]} 17:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:39 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:39 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 17:02:39 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 17:02:39 INFO - Using env: {'DISPLAY': ':0', 17:02:39 INFO - 'HOME': '/home/cltbld', 17:02:39 INFO - 'LANG': 'en_US.UTF-8', 17:02:39 INFO - 'LANGUAGE': 'en_US:en', 17:02:39 INFO - 'LOGNAME': 'cltbld', 17:02:39 INFO - 'MAIL': '/var/mail/cltbld', 17:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:39 INFO - 'MOZ_NO_REMOTE': '1', 17:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:39 INFO - 'NO_EM_RESTART': '1', 17:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:39 INFO - 'PWD': '/builds/slave/test', 17:02:39 INFO - 'SHELL': '/bin/bash', 17:02:39 INFO - 'SHLVL': '1', 17:02:39 INFO - 'TERM': 'linux', 17:02:39 INFO - 'TMOUT': '86400', 17:02:39 INFO - 'USER': 'cltbld', 17:02:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:39 INFO - '_': '/tools/buildbot/bin/python'} 17:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:02:39 INFO - Running setup.py (path:/tmp/pip-cKzSBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:02:39 INFO - Running setup.py (path:/tmp/pip-dJdNtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:02:39 INFO - Running setup.py (path:/tmp/pip-qBZm9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:02:39 INFO - Running setup.py (path:/tmp/pip-MgTLs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:02:39 INFO - Running setup.py (path:/tmp/pip-yuP27T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:02:39 INFO - Running setup.py (path:/tmp/pip-CinOB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:02:39 INFO - Running setup.py (path:/tmp/pip-HJpfVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:02:39 INFO - Running setup.py (path:/tmp/pip-tQgdTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:02:39 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)) 17:02:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:02:39 INFO - Running setup.py (path:/tmp/pip-X93hPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:02:40 INFO - Running setup.py (path:/tmp/pip-xtPvHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:02:40 INFO - Running setup.py (path:/tmp/pip-pjvBZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:02:40 INFO - Running setup.py (path:/tmp/pip-4whvzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:02:40 INFO - Running setup.py (path:/tmp/pip-GCOoTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:02:40 INFO - Running setup.py (path:/tmp/pip-YNhljs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:40 INFO - Running setup.py (path:/tmp/pip-dCek5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:02:40 INFO - Running setup.py (path:/tmp/pip-wscK6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:02:40 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)) 17:02:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:02:40 INFO - Running setup.py (path:/tmp/pip-Uw1GDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 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)) 17:02:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:02:40 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 17:02:40 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 17:02:40 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 17:02:40 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 17:02:40 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 17:02:40 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 17:02:42 INFO - Downloading blessings-1.6.tar.gz 17:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:02:42 INFO - Installing collected packages: blessings 17:02:42 INFO - Running setup.py install for blessings 17:02:42 INFO - Successfully installed blessings 17:02:42 INFO - Cleaning up... 17:02:42 INFO - Return code: 0 17:02:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:02:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:42 INFO - Reading from file tmpfile_stdout 17:02:42 INFO - Current package versions: 17:02:42 INFO - argparse == 1.2.1 17:02:42 INFO - blessings == 1.6 17:02:42 INFO - blobuploader == 1.2.4 17:02:42 INFO - docopt == 0.6.1 17:02:42 INFO - functools32 == 3.2.3-2 17:02:42 INFO - jsonschema == 2.5.1 17:02:42 INFO - manifestparser == 1.1 17:02:42 INFO - mozInstall == 1.12 17:02:42 INFO - mozcrash == 0.17 17:02:42 INFO - mozdebug == 0.1 17:02:42 INFO - mozdevice == 0.48 17:02:42 INFO - mozfile == 1.2 17:02:42 INFO - mozhttpd == 0.7 17:02:42 INFO - mozinfo == 0.9 17:02:42 INFO - mozleak == 0.1 17:02:42 INFO - mozlog == 3.4 17:02:42 INFO - moznetwork == 0.27 17:02:42 INFO - mozprocess == 0.23 17:02:42 INFO - mozprofile == 0.28 17:02:42 INFO - mozrunner == 6.12 17:02:42 INFO - mozscreenshot == 0.1 17:02:42 INFO - mozsystemmonitor == 0.3 17:02:42 INFO - moztest == 0.7 17:02:42 INFO - mozversion == 1.4 17:02:42 INFO - psutil == 3.1.1 17:02:42 INFO - requests == 1.2.3 17:02:42 INFO - wsgiref == 0.1.2 17:02:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:02: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')]} 17:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:43 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:43 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 17:02:43 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 17:02:43 INFO - Using env: {'DISPLAY': ':0', 17:02:43 INFO - 'HOME': '/home/cltbld', 17:02:43 INFO - 'LANG': 'en_US.UTF-8', 17:02:43 INFO - 'LANGUAGE': 'en_US:en', 17:02:43 INFO - 'LOGNAME': 'cltbld', 17:02:43 INFO - 'MAIL': '/var/mail/cltbld', 17:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:43 INFO - 'MOZ_NO_REMOTE': '1', 17:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:43 INFO - 'NO_EM_RESTART': '1', 17:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:43 INFO - 'PWD': '/builds/slave/test', 17:02:43 INFO - 'SHELL': '/bin/bash', 17:02:43 INFO - 'SHLVL': '1', 17:02:43 INFO - 'TERM': 'linux', 17:02:43 INFO - 'TMOUT': '86400', 17:02:43 INFO - 'USER': 'cltbld', 17:02:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:43 INFO - '_': '/tools/buildbot/bin/python'} 17:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 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)) 17:02:43 INFO - Cleaning up... 17:02:43 INFO - Return code: 0 17:02:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:02:43 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 0x7f802ce8bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe89ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', '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 17:02:43 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 17:02:43 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 17:02:43 INFO - Using env: {'DISPLAY': ':0', 17:02:43 INFO - 'HOME': '/home/cltbld', 17:02:43 INFO - 'LANG': 'en_US.UTF-8', 17:02:43 INFO - 'LANGUAGE': 'en_US:en', 17:02:43 INFO - 'LOGNAME': 'cltbld', 17:02:43 INFO - 'MAIL': '/var/mail/cltbld', 17:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:43 INFO - 'MOZ_NO_REMOTE': '1', 17:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:43 INFO - 'NO_EM_RESTART': '1', 17:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:43 INFO - 'PWD': '/builds/slave/test', 17:02:43 INFO - 'SHELL': '/bin/bash', 17:02:43 INFO - 'SHLVL': '1', 17:02:43 INFO - 'TERM': 'linux', 17:02:43 INFO - 'TMOUT': '86400', 17:02:43 INFO - 'USER': 'cltbld', 17:02:43 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:43 INFO - '_': '/tools/buildbot/bin/python'} 17:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:02:43 INFO - Cleaning up... 17:02:43 INFO - Return code: 0 17:02:43 INFO - Running post-action listener: _resource_record_post_action 17:02:43 INFO - Running post-action listener: _start_resource_monitoring 17:02:43 INFO - Starting resource monitoring. 17:02:43 INFO - [mozharness: 2016-10-18 00:02:43.498813Z] Finished create-virtualenv step (success) 17:02:43 INFO - [mozharness: 2016-10-18 00:02:43.499315Z] Running install step. 17:02:43 INFO - Running pre-action listener: _resource_record_pre_action 17:02:43 INFO - Running main action method: install 17:02:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:02:43 INFO - Reading from file tmpfile_stdout 17:02:43 INFO - Detecting whether we're running mozinstall >=1.0... 17:02:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:02:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:02:43 INFO - Reading from file tmpfile_stdout 17:02:43 INFO - Output received: 17:02:43 INFO - Usage: mozinstall [options] installer 17:02:43 INFO - Options: 17:02:43 INFO - -h, --help show this help message and exit 17:02:43 INFO - -d DEST, --destination=DEST 17:02:43 INFO - Directory to install application into. [default: 17:02:43 INFO - "/builds/slave/test"] 17:02:43 INFO - --app=APP Application being installed. [default: firefox] 17:02:43 INFO - mkdir: /builds/slave/test/build/application 17:02:43 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'] 17:02:43 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 17:02:59 INFO - Reading from file tmpfile_stdout 17:02:59 INFO - Output received: 17:02:59 INFO - /builds/slave/test/build/application/firefox/firefox 17:02:59 INFO - Running post-action listener: _resource_record_post_action 17:02:59 INFO - [mozharness: 2016-10-18 00:02:59.869063Z] Finished install step (success) 17:02:59 INFO - [mozharness: 2016-10-18 00:02:59.869307Z] Running run-tests step. 17:02:59 INFO - Running pre-action listener: _resource_record_pre_action 17:02:59 INFO - Running main action method: run_tests 17:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:02:59 INFO - Python 2.7.3 17:02:59 INFO - Return code: 0 17:02:59 INFO - grabbing minidump binary from tooltool 17:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:02:59 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 0xe86f60>, '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 0xe87d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe881d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:02:59 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 17:02:59 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 17:02:59 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 17:02:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:02:59 INFO - Return code: 0 17:02:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:02:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:02:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:02:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:02:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:02:59 INFO - Using env: {'DISPLAY': ':0', 17:02:59 INFO - 'HOME': '/home/cltbld', 17:02:59 INFO - 'LANG': 'en_US.UTF-8', 17:02:59 INFO - 'LANGUAGE': 'en_US:en', 17:02:59 INFO - 'LOGNAME': 'cltbld', 17:02:59 INFO - 'MAIL': '/var/mail/cltbld', 17:02:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:02:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:02:59 INFO - 'MOZ_NO_REMOTE': '1', 17:02:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:02:59 INFO - 'NO_EM_RESTART': '1', 17:02:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:02:59 INFO - 'PWD': '/builds/slave/test', 17:02:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:02:59 INFO - 'SHELL': '/bin/bash', 17:02:59 INFO - 'SHLVL': '1', 17:02:59 INFO - 'TERM': 'linux', 17:02:59 INFO - 'TMOUT': '86400', 17:02:59 INFO - 'USER': 'cltbld', 17:02:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401', 17:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:02:59 INFO - '_': '/tools/buildbot/bin/python'} 17:02:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:03:00 INFO - mozversion application_buildid: 20161017153519 17:03:00 INFO - mozversion application_changeset: 56b3f2c6f53e72698fea6c25130efceef2a26548 17:03:00 INFO - mozversion application_display_name: Nightly 17:03:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:03:00 INFO - mozversion application_name: Firefox 17:03:00 INFO - mozversion application_remotingname: firefox 17:03:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:03:00 INFO - mozversion application_vendor: Mozilla 17:03:00 INFO - mozversion application_version: 52.0a1 17:03:00 INFO - mozversion platform_buildid: 20161017153519 17:03:00 INFO - mozversion platform_changeset: 56b3f2c6f53e72698fea6c25130efceef2a26548 17:03:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:03:00 INFO - mozversion platform_version: 52.0a1 17:03:00 INFO - using testdate: 1476748980 17:03:00 INFO - actual date: 1476748980 17:03:00 INFO - starting webserver on 'localhost:40116' 17:03:00 INFO - SUITE-START | Running 2 tests 17:03:00 INFO - TEST-START | dromaeo_css 17:03:00 INFO - operating with platform_type : linux_ 17:03:00 INFO - Initialising browser for dromaeo_css test... 17:03:00 INFO - TEST-INFO | started process 19547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6GMofL/profile http://localhost:40116/getInfo.html) 17:03:04 INFO - PROCESS | 19547 | __metrics Screen width/height:1600/1200 17:03:04 INFO - PROCESS | 19547 | colorDepth:24 17:03:04 INFO - PROCESS | 19547 | Browser inner width/height: 1024/697 17:03:04 INFO - PROCESS | 19547 | __metrics 17:03:05 ERROR - PROCESS | 19547 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 17:03:06 INFO - TEST-INFO | 19547: exit 0 17:03:06 INFO - Browser initialized. 17:03:06 INFO - Running cycle 1/1 for dromaeo_css test... 17:03:06 INFO - TEST-INFO | started process 19670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6GMofL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:18 INFO - PROCESS | 19670 | RSS: Main: 184483840 17:03:18 INFO - PROCESS | 19670 | 17:04:07 INFO - PROCESS | 19670 | 1476749047985 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] 17:06:22 INFO - PROCESS | 19670 | Cycle 1(1): loaded http://localhost:40116/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40116/tests/dromaeo/cssquery-ext.html) 17:06:23 INFO - PROCESS | 19670 | RSS: Main: 194572288 17:06:23 INFO - PROCESS | 19670 | 17:09:25 INFO - PROCESS | 19670 | Cycle 1(1): loaded http://localhost:40116/tests/dromaeo/cssquery-ext.html (next: http://localhost:40116/tests/dromaeo/cssquery-jquery.html) 17:09:26 INFO - PROCESS | 19670 | RSS: Main: 195342336 17:09:26 INFO - PROCESS | 19670 | 17:12:28 INFO - PROCESS | 19670 | Cycle 1(1): loaded http://localhost:40116/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40116/tests/dromaeo/cssquery-mootools.html) 17:12:29 INFO - PROCESS | 19670 | RSS: Main: 197476352 17:12:29 INFO - PROCESS | 19670 | 17:15:31 INFO - PROCESS | 19670 | Cycle 1(1): loaded http://localhost:40116/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40116/tests/dromaeo/cssquery-prototype.html) 17:15:31 INFO - PROCESS | 19670 | RSS: Main: 194228224 17:15:31 INFO - PROCESS | 19670 | 17:18:34 INFO - PROCESS | 19670 | Cycle 1(1): loaded http://localhost:40116/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40116/tests/dromaeo/cssquery-yui.html) 17:18:35 INFO - PROCESS | 19670 | RSS: Main: 197054464 17:18:35 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | Cycle 1(1): loaded http://localhost:40116/tests/dromaeo/cssquery-yui.html (next: http://localhost:40116/tests/dromaeo/cssquery-dojo.html) 17:21:38 INFO - PROCESS | 19670 | RSS: Main: 197095424 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | __start_tp_report 17:21:38 INFO - PROCESS | 19670 | _x_x_mozilla_page_load 17:21:38 INFO - PROCESS | 19670 | _x_x_mozilla_page_load_details 17:21:38 INFO - PROCESS | 19670 | |i|pagename|runs| 17:21:38 INFO - PROCESS | 19670 | |0;dojo.html;2626.5797472404397;2651.4166883285675;2665.307020174755;2674.9732502674974;2696.878640461179;4695.953040469594;4831.565159135677;4837.153498137825;4861.611071114311;4866.294387313837;4746.216874215759;4799.880002999927;4824.782884770185;4862;4862.051899879516;4335.523092459843;4378.671599630033;4430.579094985971;4437.378766972626;4488.97755511222;4390.517043125254;4451.844185453509;4463.821447142111;4553.362529245908;4587.036722288307;4325.740455572675;4370.060437006027;4416.24923762961;4478.373027776114;4520.706154100006;4397.406350142722;4411.1618792429335;4420.31485119807;4496.100779844044;4502.302143167782;4411.316245981878;4412.669049821244;4420.646348292129;4442.977785111054;4461.330800379937;4691.366665500148;4695.624350051988;4823.059503396839;4836.056968891067;4858.5384388483035;5100.968077844837;5175.223716442526;5177.275181474596;5183.2743415921805;5238.79044838206;5212.087884620214;5227.555657769094;5233.058049551079;5233.398159211663;5290.285811415448;4723.7874295656775;4864.80540778372;4872.902541949141;4873.390826146731;4874.488178741217;5226.059309324358;5269.604779641542;5281.049411105961;5287.41838397776;5289.7355132244;5000.599952003831;5045.117104506697;5054.19132938728;5056.165732654071;5057.064443078042;4954.727489988013;5049.192129259374;5059.595232381401;5074.568661663726;5154.716490593053;5045.066662667418;5064.290999260106;5089.134847076006;5121.539061484485;5211.270422140903;5116.718580478035;5122.359705036871;5126;5127.820526281562;5137.101007323703;4372.628326592276;4388.385626012361;4398.3842262083335;4434.623057040188;4448.977755111204;3779.9433008504893;3821.6942644588366;3842.2315536892734;3843.404272337792;3843.577206507282;4468.530804265505;4475.440569928759;4486.304622783474;4528;4529.954700452953;5188.896222075613;5212.374515058217;5225.712585807817;5229.895402092013;5286.894262114736;4324.8486302979245;4371.934420983688;4395.494518130392;4406.977965110218;4438.911221775611;4685.344051832746;4688.9531104689195;4692.81228750853;4728.905421891543;4738.407699037621;4852.369192005017;4856.68431551948;4861.95138048615;4871.0501452217895;4895;4879.975600121977;4921.237208232729;5100.438951715382;5182.844514664566;5255.159174532057;4779.545943135397;4816.253480710496;4833.275008748716;4859.829905953275;4876.658633895735;5038.294638750504;5056.185376845877;5070.087384270867;5077.543021128116;5150.665206761549;4951.9257211142585;4999.600031997505;5131.5559767564255;5136.563392111712;5148.2020286855595;4955.108080545392;4970.229614409773;4972.353594032753;4980.501949805135;5032.823851165192;4961.479044700254;4995.675281106716;5023.924641130459;5035.899282014412;5090.847274581768;4753.5008824072975;4818.759062046814;4879.292502587176;4905.190643543775;4923.950760492349;5046.9906018795655;5058.924116138334;5072.467390924047;5111.080005599028;5129.666571672829;4927.063857866994;4937.679050861682;4947.060058588857;4955.554000140005;5004.099262132851 17:21:38 INFO - PROCESS | 19670 | |1;ext.html;547.4634857839318;548.7695168029429;556.4463358957837;557.356253527176;558.717847487019;37036.629633703655;38938.22123557531;39076.804615976915;43171;43185.78407107968;38484.42273365902;39157.41263881037;39160.21679566414;39277.60722392775;39326.606733932655;7596.658150383232;7714.8457030859345;7726.227377262285;7753.883691744629;7754.495957762756;7565.886511702329;7599;7638.083429988382;7681.539107653531;7686.654100565488;7664.1952594977565;7737.651805668758;7738.651760670755;7738.883916741253;7747;7629.732959346452;7630.236976302381;7655.234476552356;7686.846263074707;7707.997960265157;7494.6627401767055;7564.9243507565325;7565.508241964255;7597.316241538233;7599.316061554487;37198.62801371979;37412.812935935144;37431;37654.81172594147;37729;2990.925226869324;3128.3274096069226;3318.386098571772;3365.932681346384;3624.836882340301;25949.61075583868;27913.302167445774;28048.298792530146;28112.859435702896;28401.715982840113;3263.612964490106;3437.157896315394;3456.3605732939486;3555.875544355961;3559.60844307126;245661;246861;248115;248343.75828120924;248428;52919;53247.20129198065;53281.2007819883;53323.733381332844;53331;55539;55830;56010;56034.71982640061;56054.71972640192;12997.350132493337;13261.602151935458;13276;13283.203007819562;13349.399277032557;9682.56428460721;9701.272404569685;9725.221982241404;9760.853587196198;9779.755506112404;16935.576610584587;17859.553511162067;17902.672652555346;17919.641607167785;18095;6632.83417914556;6894.24163342032;6968.616726080114;7103.147622285359;7150.713971441188;765.6171914042978;827.2472050434076;871.0897112517434;878.9208971192623;1002.4887307473241;26276.21171364862;27618.171454856387;28075;28277.43445131127;28357.858210709226;948.2224575847877;953.1707414549248;971.3297824501071;1001.7145113642723;1010.7877345757473;13971.441142354395;14759.040662356912;14784.186869722053;15046.247687615576;15116.773248401283;320396;321516;323607;323665;325129;48109.75945120252;48462;48646.270305945436;48878;48893;1175.2419689300352;1180.1267062373781;1200.1418985425462;1207.9033677305795;1220.7070303127364;25420.74579254184;26251.868740656173;27230;27511.17466476009;27724.306892327048;41789.79105104455;42428.36357454579;42515.3622695666;42518.14963700647;42540.787296063325;288229;288885;289810;290390;290808;24665.38336541529;24866.751332486445;24898.377540561632;24929;24953.875230624457;39580.40629390504;39749.602503975744;39883.40174897321;41240.793796030826;41413;34454;34616.30767384689;34860.82569587136;35711.46432803458;35965;35474.11314717153;35502;35632.64367356293;35730.46404303885;35745.28509429849;35137.47293790647;35324.82337588296;35820.64179358173;36224.63775362318;36279.09302267464;31150.688493115686;32622.841369964066;32755.836220818743;33011.66988330086;33162.33675326432;24701.38246543779;24923.50152996966;25178.874105630086;25509.61735573931;25565 17:21:38 INFO - PROCESS | 19670 | |2;jquery.html;334.5784311767173;340.58788865472775;341.53380635432626;347.66450375387745;361.734125417818;14138.575842724735;15456.304466299016;16355.34578616857;16515.504534863943;16697;16732.41436549721;16909.7463538047;17133.31466741332;17169.484915452525;17487.300507979664;4878.682885612441;5133.717645529495;5420.268263784398;5459.372172200208;5548.140038294071;5494.423085576017;5510.972445137789;5514.751836167362;5515.862103447426;5543.750531226085;5374.7043912584795;5534.667919924797;5561.110222364423;5570;5583.078791999315;5526.751296191661;5538.307711536058;5572.972135139339;5587.217789509472;5590.2732644756325;5227.8431647050265;5268.736563171864;5276.736163191825;5277.788888444457;5278.47215278473;12137.878621213764;12240.81638775419;12368.381580921008;12397.380130993415;12433.316167610777;1766.6908291049015;1860.7301941218582;1930.758655168104;2100.7584127825344;2161.654135338354;8593.398462107654;8891.466512009236;9477.241820654332;9486.620535178654;9593;1656.3209084275509;1678.5048410718746;1705.984938961316;1732.4704094252768;1801.3335066025654;67646.3235367645;68461;68947;69483.30516694869;70965.64517177433;9515.191208747334;9603.135717785433;9623.594101474631;9847.359921605073;9878.407295562289;13594.93202533981;13638.79541806854;13645.863541364657;13649.795253071212;13676.521321753691;6315.652639104802;6462.289148193695;6640.900386494206;6652.004398680377;6676.432503237182;5910.52715782745;6033.577649564576;6084.452399284086;6195.349488303754;6214.720337584819;4015.15681706839;4168.270552653274;4188.4136220929095;4205.726627769185;4220.978895105505;1712.2637265975502;1713.6915355236176;1750.308628091922;1778.1998100854667;1871.3637363296546;776.7708525984848;831.301706566487;871.2681347667989;890.4212262029732;952.8380175370204;16415;16729;16970.321187152622;17460.563485912953;17855.196516156804;823.9176082391713;839.2069494327801;865.536937738307;866.1641515937025;921.8478950973148;9015.639374424949;9028.322875784343;9657.46883921377;9664.081912218327;9725.805483890283;352934;354644;356930;374544;376749;75218;75965;76676;76744;77667;881.1761003461784;885.3536918049731;905.6965916417942;916.5554705967601;922.806210695748;14637.048591841496;14696.853031469976;14878.925605371904;15196.848031519543;15506;33363.165920852174;33889.66110338963;38519.80740096394;38786;39980.604073143804;49554;49838;50600.49399505958;50639.746801265755;51190.232146518574;10313.381197128196;10388.480575971322;10564.630237941636;10837.78324433491;11507.482163302504;7710.845783084419;7718.266764657573;7768.53388796674;11110.333379997226;11819.695159443825;7272.672729727281;7281.2718728126765;7301.780946571611;7314.890276645748;7455.962720186364;7318.1949985502615;7365.558066516026;7483.92516074854;7641.47170565878;7705.1909549496495;6890.207626122859;7296;7307.561546307238;7480.251974802476;7485.850282994418;10594.364338139736;11246.550137994716;11253.831192531954;11342.659720208407;11386.829197562209;9760.463174525185;10037.849432258668;10087.394756314645;10279.794404112026;10314.535845886803 17:21:38 INFO - PROCESS | 19670 | |3;mootools.html;1399.4052527675735;1420.8152940117784;1496.8278647955487;1627.5361521966227;1660.2031025107947;6386.137871387361;6598.736050557984;6868.553544019642;7428.257174282569;7431.739889103883;6986.895196572043;7224.7471338503165;7235.131784185892;7317.4511911606705;7376.594287314196;2085.0721428964116;2116.6507526258147;2122.957540849182;2123.6814477828293;2138.101997161196;2025.1178173619771;2064.3910046536234;2093.706881036656;2105.5894100650303;2111.102781317934;2000.379882236504;2013.1242909334487;2030.2183659291206;2032.5223572460459;2038.327351973845;2018.2633338831295;2021.8989050547561;2024.7975202479781;2030.2893987104544;2035.6335859545277;2028.3205126282712;2091.6757902525133;2113.4293740689927;2129.6379615465407;2132.093860109447;7273.6726847292;7388.556686598768;7401.555906645618;7405.407567394595;7421.109466863957;4404.427424434835;4522.186006518826;4532.5240849710635;4532.841350552748;4545.431821022372;2780.207640822376;2807.845568493732;2814.127620437671;2864.742173204401;2954.0547024952025;890.6749036601659;908.1780988205685;915.7847905742145;942.4251206763869;945.2343601682659;9705.126538611488;9732.367396119229;9770.36492627977;9771.951140244324;9803.950980245054;3791.4881490998914;4011.799410029545;4137.275976704064;4140.296149654566;4146.5024197096545;8465.111163327885;8514.31885449175;8515.74452766418;8519.148085191431;8535.359848011423;4516.954830451654;4555.476120246214;4568.771561421916;4569.223232050559;4570.588647021784;3518.1732292911147;3625.148090198801;4009.398590211433;4163.7293575917465;4177.227212965611;3492.214251793377;3508.754387192872;3574.285142971416;3624.9700167906058;3644.9817750911075;1181.1023622047135;1195.3664557784214;1198.4307453959475;1199.91600587958;1200.2078628105583;628.5914155798768;741.7922981565063;776.421565933372;776.8308695413367;781.9022622172229;4570.794314255866;4693.718376897329;4779.976100119477;4874.268859671078;4929.088118698052;805.6052534258172;836.3016880904391;836.4646626159263;843.3084870406208;850.9914900850912;3166.5408515765084;3222.0978126124724;3292.1769557610596;3314.419976504102;3367.983160084184;8538.487690738575;8999.32505062123;9004.729858104267;9007.05425930281;9009.684661036963;8878.511681857432;8947.955260223658;8984.595693193822;8987.101289870961;8989.41568798026;6733.3939945405145;6845.418139458202;6852.486063545154;6858.862822743617;6861.421872969245;4521.253993091234;4526.117407105583;4564.954350456453;4591.288350305708;4689.249720044776;8112.553809540532;8116.837663246584;8159.939207902935;8168;8175.059868115243;8011.799705007422;8372.28835548985;8418.242358187792;8451.704190353308;8474.449160804528;5684.772609095755;5847.7368518417625;6284.371562843862;6436.485081193399;6509.1863517060365;6520.771772987922;6792.456603471612;6808.693608787716;6824.624645644537;6830.556013859084;6235.469985051322;6360.586561873649;6452.483801295791;6491.221053473613;6491.448226900767;6335.334789847184;6372.617642941438;6389.137466441971;6389.48884089281;6402.807915762534;5495.203195536705;5559.082116669742;5593.720313984366;5597.944020559742;5602;3767.5290588676417;3870.3226935285647;3872.96127038726;3905.726599138033;3955.090329224352;3894.1822217334675;3908.6286802753693;3931.5085614298214;3936.6653834424396;3937.4290727844873 17:21:38 INFO - PROCESS | 19670 | |4;prototype.html;279.633679879358;287.75972063327123;287.7683464810828;291.49571241751755;296.3968324459725;4970.3538539989795;5032.220005899091;5040.823571175009;5041.8235361762345;5051.595872330214;4968.652194346389;4970.776315065822;4983.476734942833;4986.401631804189;4990.276409920569;3653.7442379033478;3797.373433383488;3823.604384399688;3871.477350557681;3909.361181202691;3906.667933225665;3907.120897797987;3909.9609003910023;3925.9803700981456;3928.3910993795866;3879.5538513071074;3884.59211782763;3884.941725874114;3885.5224574006247;3901.5708272090046;3794.677452416548;3824.694024478063;3885.5531613864346;3888.4361767543833;3898.3762597984187;3421.367047096295;3438.209211881281;3438.7249020078584;3448.2586243957417;3452.723782097426;4763.76181190939;4799.424069111694;4810.6873053251775;4819.44576373718;4825.710457372569;4413.646908247332;4432.113577284556;4443.333499974998;4444.377787109807;4470.776461176928;4922.26166075088;5201.505856943584;5212.009718153577;5213.428801271141;5221.425643179247;3615.981920090409;3659.670629643318;3662.212624285765;3663.21240933198;3673.7061035117126;5428.6742795432;5430.5927055471;5499.917501237484;5501.697406642633;5508.834734957958;3631.5642122945414;3716.4053751399647;3721.423179407196;3725.9254814904093;3730.8321125549414;3774.226283611853;3786.012343519619;3788.753731007476;3797.240551889633;3802.6767724743154;4312;4319.524852266248;4328.199283132568;4359.912801743947;4367.366731823868;5028.296038554532;5117.8720531987;5213.348331458567;5217.295665085241;5222.7127507987425;1269.6889262130837;1276.2278821313157;1280.2126692084487;1288.935553222335;1293.8512071111943;804.9736585853084;814.7148498025762;831.9334453243725;841.2470838599419;846.9745907622781;4402.889927751832;4483.730976141442;4583.977080114578;4612.423447069116;4628.213203755369;5421.972890135603;5441.972790136024;5443.727813609304;5444.183372494078;5447.603054655939;4607.262837945913;4610.446746390455;4620.861374158713;4621.19129152397;4625.791839367236;2722.4963381774437;2888.638920134983;2898.5362342025173;2904.3320036391747;2906.2007947814095;5073.416557095908;5077.416097148801;5078.603384069411;5084.9745751271;5097.9745101275;5339.466053394707;5494.972525137348;5553.305836770403;5560.527355174774;5572;5029.396472423259;5043.420006699276;5059.418166910705;5068.239764035424;5074.23886417033;5402.513773760224;5415.187721841755;5417.945820541744;5431.945680543302;5441.7551210196425;5043;5298.549623282064;5313.335833020872;5318.335208098988;5347.331583552056;5067.493250674903;5076.416212135652;5078.492150784892;5090.981803639213;5094.643374963865;3747.700183985329;3755.4742336072427;3760.5675347334313;3770.9245815082995;3784.6215378461934;5101.591872650253;5364.517193452608;5414.593905457185;5421.5933804964;5443.319585051869;5249.658772179796;5279.340082489689;5282.31329927107;5287.444818294178;5302.337207849019;5267.341582302212;5280.735963201748;5282.788688452419;5288.153895376721;5293.894122117459;5027.64806463544;5143.61422893277;5186.792528298825;5207.192885102815;5213.713245771519;5022.949770502249;5216.478352164905;5227.575937760773;5262.868428289324;5293.814716484904;5155.633757054308;5158.8968220636125;5161.251618515369;5162.793488260578;5211.941283193041 17:21:38 INFO - PROCESS | 19670 | |5;yui.html;647.6308504152632;731.6195578299285;732.560463721767;740.4853626729422;766.9760869239565;12942;13422.664433389158;13781.242031688253;13859.099158554687;14113.153210807333;13617.319134043282;13866.584002479916;13925.721485570282;13940.233287169202;13945.093568918013;633.1389310537666;774.3340726974798;790.3913986230599;793.6428607126816;796.0964305513255;653.5882394091716;784.5175217241413;803.2770506544099;812.2770734046703;814.8288859339516;844.4426678392232;845.2181731898;845.2350622686448;845.3364109174299;846.7883029242689;830.9626066827008;836.7531578184451;838.3167718309559;838.6477679374647;840.1514470384894;617.450469082517;618.6071844378807;618.9350118237566;618.9628622282632;623.9220097487814;13108.541201058013;13131.212127272394;13152.671183220496;13177.275249861254;13291.53479628218;13100.868991310155;13267.781447222314;13473.461061557526;13495.86504134956;13685.384157712828;10589.84115238272;10598.735031624194;10620.256582039183;10634.149268058614;10760.139188864872;3376.9155771105675;3397.252604427022;3416.572928383952;3423.7945723256685;3516.771409858351;61789;61925.380746192415;61985;62792.37207627911;62990.37009629891;10314.469171253026;10451.529681164366;10463.790724185474;10527.894721052844;10722.78554428907;20354.592908141753;20365.49086272855;20437.795622043886;20561;21083.472913177295;6760.560563563353;6807.285235050248;6833.214180369321;6877.037214789933;6915.585064896122;3589.192431702846;3635.4365073413132;3702.66675999156;3713.702903767692;3824.330742120118;2650.509655713699;2749.2439579115503;2774.861256937145;2780.0825727509873;2795.4968105741164;467.09616891315414;478.60754181571474;487.56850187584246;491.0057134303065;491.20915326324587;523.4948274914725;585.6690969602162;587.9764809407576;621.7844114755642;625.3871206217841;7769.53382797034;7911.406644501571;7932.405069619802;8085.636146373427;8134.471259368122;498.97505124744345;546.6883876190533;594.6045879490091;595.675356930474;609.8930441249119;3903.1998440320235;3970.583088775637;4092.7544347339253;4104.856330028494;4154.896127596834;51716.74141629268;52004.47995519996;52018.21972670413;52130.73934630379;87409.5629521861;75029.62485187648;76714.61642691863;77156;77415;78387.60806196046;64419;69589.65205174043;69764.30235697578;70120.64939675269;71039;7561.470697051153;8147.918520814953;8182.549959752271;8253.943037566223;8359.95820020896;41017.1796564073;41536.37695434631;41649;42779.786101069294;42915;53202;62161.378386217366;62447.375526244155;63250.68374658097;64963;11383.658490245305;11384.715382115513;11446.198766086294;11478.82781758291;11616;12721.93639031799;12917.677058073623;12961.740765184455;13169.275689837152;13799.51701690436;10833.891661083288;11437.656870293904;11807.822882656596;11914.642560723192;12541.874581254071;10788.460576971276;11150.832737509107;11205.159613028893;11379.580668194478;11982.940085299517;10215.080642742189;10793.136549076213;10801.783964320826;11030.669079927615;11642.5342986283;9300.581473833558;9400.482973436527;9493.477858717837;9540.618375264912;9675.612975481183;9109.590068447069;9413.670521531714;9421.81156376855;9477.535780958307;9486 17:21:38 INFO - PROCESS | 19670 | __end_tp_report 17:21:38 INFO - PROCESS | 19670 | __start_cc_report 17:21:38 INFO - PROCESS | 19670 | _x_x_mozilla_cycle_collect,320 17:21:38 INFO - PROCESS | 19670 | __end_cc_report 17:21:38 INFO - PROCESS | 19670 | __startTimestamp1476750098647__endTimestamp 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | ------- Summary: start ------- 17:21:38 INFO - PROCESS | 19670 | Number of tests: 6 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | [#0] dojo.html Cycles:165 Average:4758.10 Median:4872.90 stddev:497.07 (10.2%) stddev-sans-first:469.62 17:21:38 INFO - PROCESS | 19670 | Values: 2626.6 2651.4 2665.3 2675.0 2696.9 4696.0 4831.6 4837.2 4861.6 4866.3 4746.2 4799.9 4824.8 4862.0 4862.1 4335.5 4378.7 4430.6 4437.4 4489.0 4390.5 4451.8 4463.8 4553.4 4587.0 4325.7 4370.1 4416.2 4478.4 4520.7 4397.4 4411.2 4420.3 4496.1 4502.3 4411.3 4412.7 4420.6 4443.0 4461.3 4691.4 4695.6 4823.1 4836.1 4858.5 5101.0 5175.2 5177.3 5183.3 5238.8 5212.1 5227.6 5233.1 5233.4 5290.3 4723.8 4864.8 4872.9 4873.4 4874.5 5226.1 5269.6 5281.0 5287.4 5289.7 5000.6 5045.1 5054.2 5056.2 5057.1 4954.7 5049.2 5059.6 5074.6 5154.7 5045.1 5064.3 5089.1 5121.5 5211.3 5116.7 5122.4 5126.0 5127.8 5137.1 4372.6 4388.4 4398.4 4434.6 4449.0 3779.9 3821.7 3842.2 3843.4 3843.6 4468.5 4475.4 4486.3 4528.0 4530.0 5188.9 5212.4 5225.7 5229.9 5286.9 4324.8 4371.9 4395.5 4407.0 4438.9 4685.3 4689.0 4692.8 4728.9 4738.4 4852.4 4856.7 4862.0 4871.1 4895.0 4880.0 4921.2 5100.4 5182.8 5255.2 4779.5 4816.3 4833.3 4859.8 4876.7 5038.3 5056.2 5070.1 5077.5 5150.7 4951.9 4999.6 5131.6 5136.6 5148.2 4955.1 4970.2 4972.4 4980.5 5032.8 4961.5 4995.7 5023.9 5035.9 5090.8 4753.5 4818.8 4879.3 4905.2 4924.0 5047.0 5058.9 5072.5 5111.1 5129.7 4927.1 4937.7 4947.1 4955.6 5004.1 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | [#1] ext.html Cycles:180 Average:44433.13 Median:19924.74 stddev:75510.18 (379.0%) stddev-sans-first:75650.11 17:21:38 INFO - PROCESS | 19670 | Values: 547.5 548.8 556.4 557.4 558.7 37036.6 38938.2 39076.8 43171.0 43185.8 38484.4 39157.4 39160.2 39277.6 39326.6 7596.7 7714.8 7726.2 7753.9 7754.5 7565.9 7599.0 7638.1 7681.5 7686.7 7664.2 7737.7 7738.7 7738.9 7747.0 7629.7 7630.2 7655.2 7686.8 7708.0 7494.7 7564.9 7565.5 7597.3 7599.3 37198.6 37412.8 37431.0 37654.8 37729.0 2990.9 3128.3 3318.4 3365.9 3624.8 25949.6 27913.3 28048.3 28112.9 28401.7 3263.6 3437.2 3456.4 3555.9 3559.6 245661.0 246861.0 248115.0 248343.8 248428.0 52919.0 53247.2 53281.2 53323.7 53331.0 55539.0 55830.0 56010.0 56034.7 56054.7 12997.4 13261.6 13276.0 13283.2 13349.4 9682.6 9701.3 9725.2 9760.9 9779.8 16935.6 17859.6 17902.7 17919.6 18095.0 6632.8 6894.2 6968.6 7103.1 7150.7 765.6 827.2 871.1 878.9 1002.5 26276.2 27618.2 28075.0 28277.4 28357.9 948.2 953.2 971.3 1001.7 1010.8 13971.4 14759.0 14784.2 15046.2 15116.8 320396.0 321516.0 323607.0 323665.0 325129.0 48109.8 48462.0 48646.3 48878.0 48893.0 1175.2 1180.1 1200.1 1207.9 1220.7 25420.7 26251.9 27230.0 27511.2 27724.3 41789.8 42428.4 42515.4 42518.1 42540.8 288229.0 288885.0 289810.0 290390.0 290808.0 24665.4 24866.8 24898.4 24929.0 24953.9 39580.4 39749.6 39883.4 41240.8 41413.0 34454.0 34616.3 34860.8 35711.5 35965.0 35474.1 35502.0 35632.6 35730.5 35745.3 35137.5 35324.8 35820.6 36224.6 36279.1 31150.7 32622.8 32755.8 33011.7 33162.3 24701.4 24923.5 25178.9 25509.6 25565.0 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | [#2] jquery.html Cycles:180 Average:23082.09 Median:5277.26 stddev:60226.89 (1141.3%) stddev-sans-first:60371.62 17:21:38 INFO - PROCESS | 19670 | Values: 334.6 340.6 341.5 347.7 361.7 14138.6 15456.3 16355.3 16515.5 16697.0 16732.4 16909.7 17133.3 17169.5 17487.3 4878.7 5133.7 5420.3 5459.4 5548.1 5494.4 5511.0 5514.8 5515.9 5543.8 5374.7 5534.7 5561.1 5570.0 5583.1 5526.8 5538.3 5573.0 5587.2 5590.3 5227.8 5268.7 5276.7 5277.8 5278.5 12137.9 12240.8 12368.4 12397.4 12433.3 1766.7 1860.7 1930.8 2100.8 2161.7 8593.4 8891.5 9477.2 9486.6 9593.0 1656.3 1678.5 1706.0 1732.5 1801.3 67646.3 68461.0 68947.0 69483.3 70965.6 9515.2 9603.1 9623.6 9847.4 9878.4 13594.9 13638.8 13645.9 13649.8 13676.5 6315.7 6462.3 6640.9 6652.0 6676.4 5910.5 6033.6 6084.5 6195.3 6214.7 4015.2 4168.3 4188.4 4205.7 4221.0 1712.3 1713.7 1750.3 1778.2 1871.4 776.8 831.3 871.3 890.4 952.8 16415.0 16729.0 16970.3 17460.6 17855.2 823.9 839.2 865.5 866.2 921.8 9015.6 9028.3 9657.5 9664.1 9725.8 352934.0 354644.0 356930.0 374544.0 376749.0 75218.0 75965.0 76676.0 76744.0 77667.0 881.2 885.4 905.7 916.6 922.8 14637.0 14696.9 14878.9 15196.8 15506.0 33363.2 33889.7 38519.8 38786.0 39980.6 49554.0 49838.0 50600.5 50639.7 51190.2 10313.4 10388.5 10564.6 10837.8 11507.5 7710.8 7718.3 7768.5 11110.3 11819.7 7272.7 7281.3 7301.8 7314.9 7456.0 7318.2 7365.6 7483.9 7641.5 7705.2 6890.2 7296.0 7307.6 7480.3 7485.9 10594.4 11246.6 11253.8 11342.7 11386.8 9760.5 10037.8 10087.4 10279.8 10314.5 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | [#3] mootools.html Cycles:180 Average:4768.46 Median:5527.14 stddev:2634.98 (47.7%) stddev-sans-first:2630.21 17:21:38 INFO - PROCESS | 19670 | Values: 1399.4 1420.8 1496.8 1627.5 1660.2 6386.1 6598.7 6868.6 7428.3 7431.7 6986.9 7224.7 7235.1 7317.5 7376.6 2085.1 2116.7 2123.0 2123.7 2138.1 2025.1 2064.4 2093.7 2105.6 2111.1 2000.4 2013.1 2030.2 2032.5 2038.3 2018.3 2021.9 2024.8 2030.3 2035.6 2028.3 2091.7 2113.4 2129.6 2132.1 7273.7 7388.6 7401.6 7405.4 7421.1 4404.4 4522.2 4532.5 4532.8 4545.4 2780.2 2807.8 2814.1 2864.7 2954.1 890.7 908.2 915.8 942.4 945.2 9705.1 9732.4 9770.4 9772.0 9804.0 3791.5 4011.8 4137.3 4140.3 4146.5 8465.1 8514.3 8515.7 8519.1 8535.4 4517.0 4555.5 4568.8 4569.2 4570.6 3518.2 3625.1 4009.4 4163.7 4177.2 3492.2 3508.8 3574.3 3625.0 3645.0 1181.1 1195.4 1198.4 1199.9 1200.2 628.6 741.8 776.4 776.8 781.9 4570.8 4693.7 4780.0 4874.3 4929.1 805.6 836.3 836.5 843.3 851.0 3166.5 3222.1 3292.2 3314.4 3368.0 8538.5 8999.3 9004.7 9007.1 9009.7 8878.5 8948.0 8984.6 8987.1 8989.4 6733.4 6845.4 6852.5 6858.9 6861.4 4521.3 4526.1 4565.0 4591.3 4689.2 8112.6 8116.8 8159.9 8168.0 8175.1 8011.8 8372.3 8418.2 8451.7 8474.4 5684.8 5847.7 6284.4 6436.5 6509.2 6520.8 6792.5 6808.7 6824.6 6830.6 6235.5 6360.6 6452.5 6491.2 6491.4 6335.3 6372.6 6389.1 6389.5 6402.8 5495.2 5559.1 5593.7 5597.9 5602.0 3767.5 3870.3 3873.0 3905.7 3955.1 3894.2 3908.6 3931.5 3936.7 3937.4 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | [#4] prototype.html Cycles:180 Average:4331.02 Median:4988.34 stddev:1278.63 (25.6%) stddev-sans-first:1245.54 17:21:38 INFO - PROCESS | 19670 | Values: 279.6 287.8 287.8 291.5 296.4 4970.4 5032.2 5040.8 5041.8 5051.6 4968.7 4970.8 4983.5 4986.4 4990.3 3653.7 3797.4 3823.6 3871.5 3909.4 3906.7 3907.1 3910.0 3926.0 3928.4 3879.6 3884.6 3884.9 3885.5 3901.6 3794.7 3824.7 3885.6 3888.4 3898.4 3421.4 3438.2 3438.7 3448.3 3452.7 4763.8 4799.4 4810.7 4819.4 4825.7 4413.6 4432.1 4443.3 4444.4 4470.8 4922.3 5201.5 5212.0 5213.4 5221.4 3616.0 3659.7 3662.2 3663.2 3673.7 5428.7 5430.6 5499.9 5501.7 5508.8 3631.6 3716.4 3721.4 3725.9 3730.8 3774.2 3786.0 3788.8 3797.2 3802.7 4312.0 4319.5 4328.2 4359.9 4367.4 5028.3 5117.9 5213.3 5217.3 5222.7 1269.7 1276.2 1280.2 1288.9 1293.9 805.0 814.7 831.9 841.2 847.0 4402.9 4483.7 4584.0 4612.4 4628.2 5422.0 5442.0 5443.7 5444.2 5447.6 4607.3 4610.4 4620.9 4621.2 4625.8 2722.5 2888.6 2898.5 2904.3 2906.2 5073.4 5077.4 5078.6 5085.0 5098.0 5339.5 5495.0 5553.3 5560.5 5572.0 5029.4 5043.4 5059.4 5068.2 5074.2 5402.5 5415.2 5417.9 5431.9 5441.8 5043.0 5298.5 5313.3 5318.3 5347.3 5067.5 5076.4 5078.5 5091.0 5094.6 3747.7 3755.5 3760.6 3770.9 3784.6 5101.6 5364.5 5414.6 5421.6 5443.3 5249.7 5279.3 5282.3 5287.4 5302.3 5267.3 5280.7 5282.8 5288.2 5293.9 5027.6 5143.6 5186.8 5207.2 5213.7 5022.9 5216.5 5227.6 5262.9 5293.8 5155.6 5158.9 5161.3 5162.8 5211.9 17:21:38 INFO - PROCESS | 19670 | 17:21:38 INFO - PROCESS | 19670 | [#5] yui.html Cycles:180 Average:16294.03 Median:26107.86 stddev:21595.59 (82.7%) stddev-sans-first:21624.22 17:21:38 INFO - PROCESS | 19670 | Values: 647.6 731.6 732.6 740.5 767.0 12942.0 13422.7 13781.2 13859.1 14113.2 13617.3 13866.6 13925.7 13940.2 13945.1 633.1 774.3 790.4 793.6 796.1 653.6 784.5 803.3 812.3 814.8 844.4 845.2 845.2 845.3 846.8 831.0 836.8 838.3 838.6 840.2 617.5 618.6 618.9 619.0 623.9 13108.5 13131.2 13152.7 13177.3 13291.5 13100.9 13267.8 13473.5 13495.9 13685.4 10589.8 10598.7 10620.3 10634.1 10760.1 3376.9 3397.3 3416.6 3423.8 3516.8 61789.0 61925.4 61985.0 62792.4 62990.4 10314.5 10451.5 10463.8 10527.9 10722.8 20354.6 20365.5 20437.8 20561.0 21083.5 6760.6 6807.3 6833.2 6877.0 6915.6 3589.2 3635.4 3702.7 3713.7 3824.3 2650.5 2749.2 2774.9 2780.1 2795.5 467.1 478.6 487.6 491.0 491.2 523.5 585.7 588.0 621.8 625.4 7769.5 7911.4 7932.4 8085.6 8134.5 499.0 546.7 594.6 595.7 609.9 3903.2 3970.6 4092.8 4104.9 4154.9 51716.7 52004.5 52018.2 52130.7 87409.6 75029.6 76714.6 77156.0 77415.0 78387.6 64419.0 69589.7 69764.3 70120.6 71039.0 7561.5 8147.9 8182.5 8253.9 8360.0 41017.2 41536.4 41649.0 42779.8 42915.0 53202.0 62161.4 62447.4 63250.7 64963.0 11383.7 11384.7 11446.2 11478.8 11616.0 12721.9 12917.7 12961.7 13169.3 13799.5 10833.9 11437.7 11807.8 11914.6 12541.9 10788.5 11150.8 11205.2 11379.6 11982.9 10215.1 10793.1 10801.8 11030.7 11642.5 9300.6 9400.5 9493.5 9540.6 9675.6 9109.6 9413.7 9421.8 9477.5 9486.0 17:21:38 INFO - PROCESS | 19670 | -------- Summary: end -------- 17:21:38 INFO - PROCESS | 19670 | 17:21:39 INFO - TEST-INFO | 19670: exit 0 17:21:39 INFO - TEST-OK | dromaeo_css | took 1119659ms 17:21:39 INFO - TEST-START | kraken 17:21:39 INFO - operating with platform_type : linux_ 17:21:39 INFO - Initialising browser for kraken test... 17:21:39 INFO - TEST-INFO | started process 20030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpry9clR/profile http://localhost:40116/getInfo.html) 17:21:44 INFO - PROCESS | 20030 | __metrics Screen width/height:1600/1200 17:21:44 INFO - PROCESS | 20030 | colorDepth:24 17:21:44 INFO - PROCESS | 20030 | Browser inner width/height: 1024/697 17:21:44 INFO - PROCESS | 20030 | __metrics 17:21:44 ERROR - PROCESS | 20030 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 17:21:45 INFO - TEST-INFO | 20030: exit 0 17:21:45 INFO - Browser initialized. 17:21:45 INFO - Running cycle 1/1 for kraken test... 17:21:45 INFO - TEST-INFO | started process 20151 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpry9clR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:21:58 INFO - PROCESS | 20151 | RSS: Main: 183775232 17:21:58 INFO - PROCESS | 20151 | 17:22:01 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40116/tests/kraken/driver.html?testName=audio-beat-detection) 17:22:02 INFO - PROCESS | 20151 | RSS: Main: 197091328 17:22:02 INFO - PROCESS | 20151 | 17:22:05 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40116/tests/kraken/driver.html?testName=audio-dft) 17:22:05 INFO - PROCESS | 20151 | RSS: Main: 195444736 17:22:05 INFO - PROCESS | 20151 | 17:22:08 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40116/tests/kraken/driver.html?testName=audio-fft) 17:22:09 INFO - PROCESS | 20151 | RSS: Main: 192008192 17:22:09 INFO - PROCESS | 20151 | 17:22:11 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40116/tests/kraken/driver.html?testName=audio-oscillator) 17:22:12 INFO - PROCESS | 20151 | RSS: Main: 192663552 17:22:12 INFO - PROCESS | 20151 | 17:22:14 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40116/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:22:14 INFO - PROCESS | 20151 | RSS: Main: 192569344 17:22:14 INFO - PROCESS | 20151 | 17:22:18 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40116/tests/kraken/driver.html?testName=imaging-darkroom) 17:22:18 INFO - PROCESS | 20151 | RSS: Main: 192937984 17:22:18 INFO - PROCESS | 20151 | 17:22:22 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40116/tests/kraken/driver.html?testName=imaging-desaturate) 17:22:22 INFO - PROCESS | 20151 | RSS: Main: 190918656 17:22:22 INFO - PROCESS | 20151 | 17:22:25 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40116/tests/kraken/driver.html?testName=json-parse-financial) 17:22:26 INFO - PROCESS | 20151 | RSS: Main: 192348160 17:22:26 INFO - PROCESS | 20151 | 17:22:28 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40116/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:22:28 INFO - PROCESS | 20151 | RSS: Main: 192892928 17:22:28 INFO - PROCESS | 20151 | 17:22:30 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:22:31 INFO - PROCESS | 20151 | RSS: Main: 192954368 17:22:31 INFO - PROCESS | 20151 | 17:22:33 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:22:34 INFO - PROCESS | 20151 | RSS: Main: 192970752 17:22:34 INFO - PROCESS | 20151 | 17:22:37 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:22:37 INFO - PROCESS | 20151 | RSS: Main: 193220608 17:22:37 INFO - PROCESS | 20151 | 17:22:40 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:22:41 INFO - PROCESS | 20151 | RSS: Main: 193175552 17:22:41 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | Cycle 1(1): loaded http://localhost:40116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40116/tests/kraken/driver.html?testName=ai-astar) 17:22:43 INFO - PROCESS | 20151 | RSS: Main: 196304896 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | __start_tp_report 17:22:43 INFO - PROCESS | 20151 | _x_x_mozilla_page_load 17:22:43 INFO - PROCESS | 20151 | _x_x_mozilla_page_load_details 17:22:43 INFO - PROCESS | 20151 | |i|pagename|runs| 17:22:43 INFO - PROCESS | 20151 | |0;ai-astar;108;115;115;115;117;118;118;115;116;117 17:22:43 INFO - PROCESS | 20151 | |1;audio-beat-detection;159;135;129;178;136;136;131;130;164;134 17:22:43 INFO - PROCESS | 20151 | |2;audio-dft;165;167;163;169;163;164;163;162;161;166 17:22:43 INFO - PROCESS | 20151 | |3;audio-fft;76;76;75;106;78;78;78;82;101;77 17:22:43 INFO - PROCESS | 20151 | |4;audio-oscillator;87;84;124;84;84;85;103;85;88;114 17:22:43 INFO - PROCESS | 20151 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;117;118;118 17:22:43 INFO - PROCESS | 20151 | |6;imaging-darkroom;148;148;147;149;149;148;149;149;148;147 17:22:43 INFO - PROCESS | 20151 | |7;imaging-desaturate;84;86;85;84;85;86;86;86;85;85 17:22:43 INFO - PROCESS | 20151 | |8;json-parse-financial;72;66;68;66;69;67;68;66;66;69 17:22:43 INFO - PROCESS | 20151 | |9;json-stringify-tinderbox;68;68;68;70;69;68;69;68;68;68 17:22:43 INFO - PROCESS | 20151 | |10;stanford-crypto-aes;85;83;94;83;83;85;84;91;83;89 17:22:43 INFO - PROCESS | 20151 | |11;stanford-crypto-ccm;154;151;141;147;139;146;147;146;178;145 17:22:43 INFO - PROCESS | 20151 | |12;stanford-crypto-pbkdf2;180;179;175;177;174;173;186;184;176;177 17:22:43 INFO - PROCESS | 20151 | |13;stanford-crypto-sha256-iterative;71;78;70;70;72;71;72;70;80;71 17:22:43 INFO - PROCESS | 20151 | __end_tp_report 17:22:43 INFO - PROCESS | 20151 | __start_cc_report 17:22:43 INFO - PROCESS | 20151 | _x_x_mozilla_cycle_collect,888 17:22:43 INFO - PROCESS | 20151 | __end_cc_report 17:22:43 INFO - PROCESS | 20151 | __startTimestamp1476750163651__endTimestamp 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | ------- Summary: start ------- 17:22:43 INFO - PROCESS | 20151 | Number of tests: 14 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.50 stddev:2.88 (2.5%) stddev-sans-first:1.30 17:22:43 INFO - PROCESS | 20151 | Values: 108.0 115.0 115.0 115.0 117.0 118.0 118.0 115.0 116.0 117.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:136.00 stddev:17.24 (12.7%) stddev-sans-first:17.31 17:22:43 INFO - PROCESS | 20151 | Values: 159.0 135.0 129.0 178.0 136.0 136.0 131.0 130.0 164.0 134.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.45 (1.5%) stddev-sans-first:2.59 17:22:43 INFO - PROCESS | 20151 | Values: 165.0 167.0 163.0 169.0 163.0 164.0 163.0 162.0 161.0 166.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.50 stddev:11.19 (14.4%) stddev-sans-first:11.60 17:22:43 INFO - PROCESS | 20151 | Values: 76.0 76.0 75.0 106.0 78.0 78.0 78.0 82.0 101.0 77.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:84.50 stddev:14.63 (17.3%) stddev-sans-first:15.31 17:22:43 INFO - PROCESS | 20151 | Values: 87.0 84.0 124.0 84.0 84.0 85.0 103.0 85.0 88.0 114.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:22:43 INFO - PROCESS | 20151 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 118.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 17:22:43 INFO - PROCESS | 20151 | Values: 148.0 148.0 147.0 149.0 149.0 148.0 149.0 149.0 148.0 147.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:0.79 (0.9%) stddev-sans-first:0.71 17:22:43 INFO - PROCESS | 20151 | Values: 84.0 86.0 85.0 84.0 85.0 86.0 86.0 86.0 85.0 85.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#8] json-parse-financial Cycles:10 Average:67.70 Median:68.00 stddev:1.95 (2.9%) stddev-sans-first:1.30 17:22:43 INFO - PROCESS | 20151 | Values: 72.0 66.0 68.0 66.0 69.0 67.0 68.0 66.0 66.0 69.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 17:22:43 INFO - PROCESS | 20151 | Values: 68.0 68.0 68.0 70.0 69.0 68.0 69.0 68.0 68.0 68.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:3.94 (4.6%) stddev-sans-first:4.17 17:22:43 INFO - PROCESS | 20151 | Values: 85.0 83.0 94.0 83.0 83.0 85.0 84.0 91.0 83.0 89.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:147.00 stddev:10.93 (7.4%) stddev-sans-first:11.46 17:22:43 INFO - PROCESS | 20151 | Values: 154.0 151.0 141.0 147.0 139.0 146.0 147.0 146.0 178.0 145.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:178.00 stddev:4.23 (2.4%) stddev-sans-first:4.43 17:22:43 INFO - PROCESS | 20151 | Values: 180.0 179.0 175.0 177.0 174.0 173.0 186.0 184.0 176.0 177.0 17:22:43 INFO - PROCESS | 20151 | 17:22:43 INFO - PROCESS | 20151 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:71.50 stddev:3.54 (4.9%) stddev-sans-first:3.71 17:22:43 INFO - PROCESS | 20151 | Values: 71.0 78.0 70.0 70.0 72.0 71.0 72.0 70.0 80.0 71.0 17:22:43 INFO - PROCESS | 20151 | -------- Summary: end -------- 17:22:43 INFO - PROCESS | 20151 | 17:22:44 INFO - TEST-INFO | 20151: exit 0 17:22:44 INFO - TEST-OK | kraken | took 65073ms 17:22:44 INFO - SUITE-END | took 1184s 17:22:45 INFO - Completed test suite (00:19:45) 17:22:45 INFO - javascript benchmark 17:22:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6294.092943586893, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2626.5797472404397, 2651.4166883285675, 2665.307020174755, 2674.9732502674974, 2696.878640461179, 4695.953040469594, 4831.565159135677, 4837.153498137825, 4861.611071114311, 4866.294387313837, 4746.216874215759, 4799.880002999927, 4824.782884770185, 4862.0, 4862.051899879516, 4335.523092459843, 4378.671599630033, 4430.579094985971, 4437.378766972626, 4488.97755511222, 4390.517043125254, 4451.844185453509, 4463.821447142111, 4553.362529245908, 4587.036722288307, 4325.740455572675, 4370.060437006027, 4416.24923762961, 4478.373027776114, 4520.706154100006, 4397.406350142722, 4411.1618792429335, 4420.31485119807, 4496.100779844044, 4502.302143167782, 4411.316245981878, 4412.669049821244, 4420.646348292129, 4442.977785111054, 4461.330800379937, 4691.366665500148, 4695.624350051988, 4823.059503396839, 4836.056968891067, 4858.5384388483035, 5100.968077844837, 5175.223716442526, 5177.275181474596, 5183.2743415921805, 5238.79044838206, 5212.087884620214, 5227.555657769094, 5233.058049551079, 5233.398159211663, 5290.285811415448, 4723.7874295656775, 4864.80540778372, 4872.902541949141, 4873.390826146731, 4874.488178741217, 5226.059309324358, 5269.604779641542, 5281.049411105961, 5287.41838397776, 5289.7355132244, 5000.599952003831, 5045.117104506697, 5054.19132938728, 5056.165732654071, 5057.064443078042, 4954.727489988013, 5049.192129259374, 5059.595232381401, 5074.568661663726, 5154.716490593053, 5045.066662667418, 5064.290999260106, 5089.134847076006, 5121.539061484485, 5211.270422140903, 5116.718580478035, 5122.359705036871, 5126.0, 5127.820526281562, 5137.101007323703, 4372.628326592276, 4388.385626012361, 4398.3842262083335, 4434.623057040188, 4448.977755111204, 3779.9433008504893, 3821.6942644588366, 3842.2315536892734, 3843.404272337792, 3843.577206507282, 4468.530804265505, 4475.440569928759, 4486.304622783474, 4528.0, 4529.954700452953, 5188.896222075613, 5212.374515058217, 5225.712585807817, 5229.895402092013, 5286.894262114736, 4324.8486302979245, 4371.934420983688, 4395.494518130392, 4406.977965110218, 4438.911221775611, 4685.344051832746, 4688.9531104689195, 4692.81228750853, 4728.905421891543, 4738.407699037621, 4852.369192005017, 4856.68431551948, 4861.95138048615, 4871.0501452217895, 4895.0, 4879.975600121977, 4921.237208232729, 5100.438951715382, 5182.844514664566, 5255.159174532057, 4779.545943135397, 4816.253480710496, 4833.275008748716, 4859.829905953275, 4876.658633895735, 5038.294638750504, 5056.185376845877, 5070.087384270867, 5077.543021128116, 5150.665206761549, 4951.9257211142585, 4999.600031997505, 5131.5559767564255, 5136.563392111712, 5148.2020286855595, 4955.108080545392, 4970.229614409773, 4972.353594032753, 4980.501949805135, 5032.823851165192, 4961.479044700254, 4995.675281106716, 5023.924641130459, 5035.899282014412, 5090.847274581768, 4753.5008824072975, 4818.759062046814, 4879.292502587176, 4905.190643543775, 4923.950760492349, 5046.9906018795655, 5058.924116138334, 5072.467390924047, 5111.080005599028, 5129.666571672829, 4927.063857866994, 4937.679050861682, 4947.060058588857, 4955.554000140005, 5004.099262132851], "value": 4726.216291176649, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.4634857839318, 548.7695168029429, 556.4463358957837, 557.356253527176, 558.717847487019, 37036.629633703655, 38938.22123557531, 39076.804615976915, 43171.0, 43185.78407107968, 38484.42273365902, 39157.41263881037, 39160.21679566414, 39277.60722392775, 39326.606733932655, 7596.658150383232, 7714.8457030859345, 7726.227377262285, 7753.883691744629, 7754.495957762756, 7565.886511702329, 7599.0, 7638.083429988382, 7681.539107653531, 7686.654100565488, 7664.1952594977565, 7737.651805668758, 7738.651760670755, 7738.883916741253, 7747.0, 7629.732959346452, 7630.236976302381, 7655.234476552356, 7686.846263074707, 7707.997960265157, 7494.6627401767055, 7564.9243507565325, 7565.508241964255, 7597.316241538233, 7599.316061554487, 37198.62801371979, 37412.812935935144, 37431.0, 37654.81172594147, 37729.0, 2990.925226869324, 3128.3274096069226, 3318.386098571772, 3365.932681346384, 3624.836882340301, 25949.61075583868, 27913.302167445774, 28048.298792530146, 28112.859435702896, 28401.715982840113, 3263.612964490106, 3437.157896315394, 3456.3605732939486, 3555.875544355961, 3559.60844307126, 245661.0, 246861.0, 248115.0, 248343.75828120924, 248428.0, 52919.0, 53247.20129198065, 53281.2007819883, 53323.733381332844, 53331.0, 55539.0, 55830.0, 56010.0, 56034.71982640061, 56054.71972640192, 12997.350132493337, 13261.602151935458, 13276.0, 13283.203007819562, 13349.399277032557, 9682.56428460721, 9701.272404569685, 9725.221982241404, 9760.853587196198, 9779.755506112404, 16935.576610584587, 17859.553511162067, 17902.672652555346, 17919.641607167785, 18095.0, 6632.83417914556, 6894.24163342032, 6968.616726080114, 7103.147622285359, 7150.713971441188, 765.6171914042978, 827.2472050434076, 871.0897112517434, 878.9208971192623, 1002.4887307473241, 26276.21171364862, 27618.171454856387, 28075.0, 28277.43445131127, 28357.858210709226, 948.2224575847877, 953.1707414549248, 971.3297824501071, 1001.7145113642723, 1010.7877345757473, 13971.441142354395, 14759.040662356912, 14784.186869722053, 15046.247687615576, 15116.773248401283, 320396.0, 321516.0, 323607.0, 323665.0, 325129.0, 48109.75945120252, 48462.0, 48646.270305945436, 48878.0, 48893.0, 1175.2419689300352, 1180.1267062373781, 1200.1418985425462, 1207.9033677305795, 1220.7070303127364, 25420.74579254184, 26251.868740656173, 27230.0, 27511.17466476009, 27724.306892327048, 41789.79105104455, 42428.36357454579, 42515.3622695666, 42518.14963700647, 42540.787296063325, 288229.0, 288885.0, 289810.0, 290390.0, 290808.0, 24665.38336541529, 24866.751332486445, 24898.377540561632, 24929.0, 24953.875230624457, 39580.40629390504, 39749.602503975744, 39883.40174897321, 41240.793796030826, 41413.0, 34454.0, 34616.30767384689, 34860.82569587136, 35711.46432803458, 35965.0, 35474.11314717153, 35502.0, 35632.64367356293, 35730.46404303885, 35745.28509429849, 35137.47293790647, 35324.82337588296, 35820.64179358173, 36224.63775362318, 36279.09302267464, 31150.688493115686, 32622.841369964066, 32755.836220818743, 33011.66988330086, 33162.33675326432, 24701.38246543779, 24923.50152996966, 25178.874105630086, 25509.61735573931, 25565.0], "value": 17112.209720899657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.5784311767173, 340.58788865472775, 341.53380635432626, 347.66450375387745, 361.734125417818, 14138.575842724735, 15456.304466299016, 16355.34578616857, 16515.504534863943, 16697.0, 16732.41436549721, 16909.7463538047, 17133.31466741332, 17169.484915452525, 17487.300507979664, 4878.682885612441, 5133.717645529495, 5420.268263784398, 5459.372172200208, 5548.140038294071, 5494.423085576017, 5510.972445137789, 5514.751836167362, 5515.862103447426, 5543.750531226085, 5374.7043912584795, 5534.667919924797, 5561.110222364423, 5570.0, 5583.078791999315, 5526.751296191661, 5538.307711536058, 5572.972135139339, 5587.217789509472, 5590.2732644756325, 5227.8431647050265, 5268.736563171864, 5276.736163191825, 5277.788888444457, 5278.47215278473, 12137.878621213764, 12240.81638775419, 12368.381580921008, 12397.380130993415, 12433.316167610777, 1766.6908291049015, 1860.7301941218582, 1930.758655168104, 2100.7584127825344, 2161.654135338354, 8593.398462107654, 8891.466512009236, 9477.241820654332, 9486.620535178654, 9593.0, 1656.3209084275509, 1678.5048410718746, 1705.984938961316, 1732.4704094252768, 1801.3335066025654, 67646.3235367645, 68461.0, 68947.0, 69483.30516694869, 70965.64517177433, 9515.191208747334, 9603.135717785433, 9623.594101474631, 9847.359921605073, 9878.407295562289, 13594.93202533981, 13638.79541806854, 13645.863541364657, 13649.795253071212, 13676.521321753691, 6315.652639104802, 6462.289148193695, 6640.900386494206, 6652.004398680377, 6676.432503237182, 5910.52715782745, 6033.577649564576, 6084.452399284086, 6195.349488303754, 6214.720337584819, 4015.15681706839, 4168.270552653274, 4188.4136220929095, 4205.726627769185, 4220.978895105505, 1712.2637265975502, 1713.6915355236176, 1750.308628091922, 1778.1998100854667, 1871.3637363296546, 776.7708525984848, 831.301706566487, 871.2681347667989, 890.4212262029732, 952.8380175370204, 16415.0, 16729.0, 16970.321187152622, 17460.563485912953, 17855.196516156804, 823.9176082391713, 839.2069494327801, 865.536937738307, 866.1641515937025, 921.8478950973148, 9015.639374424949, 9028.322875784343, 9657.46883921377, 9664.081912218327, 9725.805483890283, 352934.0, 354644.0, 356930.0, 374544.0, 376749.0, 75218.0, 75965.0, 76676.0, 76744.0, 77667.0, 881.1761003461784, 885.3536918049731, 905.6965916417942, 916.5554705967601, 922.806210695748, 14637.048591841496, 14696.853031469976, 14878.925605371904, 15196.848031519543, 15506.0, 33363.165920852174, 33889.66110338963, 38519.80740096394, 38786.0, 39980.604073143804, 49554.0, 49838.0, 50600.49399505958, 50639.746801265755, 51190.232146518574, 10313.381197128196, 10388.480575971322, 10564.630237941636, 10837.78324433491, 11507.482163302504, 7710.845783084419, 7718.266764657573, 7768.53388796674, 11110.333379997226, 11819.695159443825, 7272.672729727281, 7281.2718728126765, 7301.780946571611, 7314.890276645748, 7455.962720186364, 7318.1949985502615, 7365.558066516026, 7483.92516074854, 7641.47170565878, 7705.1909549496495, 6890.207626122859, 7296.0, 7307.561546307238, 7480.251974802476, 7485.850282994418, 10594.364338139736, 11246.550137994716, 11253.831192531954, 11342.659720208407, 11386.829197562209, 9760.463174525185, 10037.849432258668, 10087.394756314645, 10279.794404112026, 10314.535845886803], "value": 7857.353339108372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.4052527675735, 1420.8152940117784, 1496.8278647955487, 1627.5361521966227, 1660.2031025107947, 6386.137871387361, 6598.736050557984, 6868.553544019642, 7428.257174282569, 7431.739889103883, 6986.895196572043, 7224.7471338503165, 7235.131784185892, 7317.4511911606705, 7376.594287314196, 2085.0721428964116, 2116.6507526258147, 2122.957540849182, 2123.6814477828293, 2138.101997161196, 2025.1178173619771, 2064.3910046536234, 2093.706881036656, 2105.5894100650303, 2111.102781317934, 2000.379882236504, 2013.1242909334487, 2030.2183659291206, 2032.5223572460459, 2038.327351973845, 2018.2633338831295, 2021.8989050547561, 2024.7975202479781, 2030.2893987104544, 2035.6335859545277, 2028.3205126282712, 2091.6757902525133, 2113.4293740689927, 2129.6379615465407, 2132.093860109447, 7273.6726847292, 7388.556686598768, 7401.555906645618, 7405.407567394595, 7421.109466863957, 4404.427424434835, 4522.186006518826, 4532.5240849710635, 4532.841350552748, 4545.431821022372, 2780.207640822376, 2807.845568493732, 2814.127620437671, 2864.742173204401, 2954.0547024952025, 890.6749036601659, 908.1780988205685, 915.7847905742145, 942.4251206763869, 945.2343601682659, 9705.126538611488, 9732.367396119229, 9770.36492627977, 9771.951140244324, 9803.950980245054, 3791.4881490998914, 4011.799410029545, 4137.275976704064, 4140.296149654566, 4146.5024197096545, 8465.111163327885, 8514.31885449175, 8515.74452766418, 8519.148085191431, 8535.359848011423, 4516.954830451654, 4555.476120246214, 4568.771561421916, 4569.223232050559, 4570.588647021784, 3518.1732292911147, 3625.148090198801, 4009.398590211433, 4163.7293575917465, 4177.227212965611, 3492.214251793377, 3508.754387192872, 3574.285142971416, 3624.9700167906058, 3644.9817750911075, 1181.1023622047135, 1195.3664557784214, 1198.4307453959475, 1199.91600587958, 1200.2078628105583, 628.5914155798768, 741.7922981565063, 776.421565933372, 776.8308695413367, 781.9022622172229, 4570.794314255866, 4693.718376897329, 4779.976100119477, 4874.268859671078, 4929.088118698052, 805.6052534258172, 836.3016880904391, 836.4646626159263, 843.3084870406208, 850.9914900850912, 3166.5408515765084, 3222.0978126124724, 3292.1769557610596, 3314.419976504102, 3367.983160084184, 8538.487690738575, 8999.32505062123, 9004.729858104267, 9007.05425930281, 9009.684661036963, 8878.511681857432, 8947.955260223658, 8984.595693193822, 8987.101289870961, 8989.41568798026, 6733.3939945405145, 6845.418139458202, 6852.486063545154, 6858.862822743617, 6861.421872969245, 4521.253993091234, 4526.117407105583, 4564.954350456453, 4591.288350305708, 4689.249720044776, 8112.553809540532, 8116.837663246584, 8159.939207902935, 8168.0, 8175.059868115243, 8011.799705007422, 8372.28835548985, 8418.242358187792, 8451.704190353308, 8474.449160804528, 5684.772609095755, 5847.7368518417625, 6284.371562843862, 6436.485081193399, 6509.1863517060365, 6520.771772987922, 6792.456603471612, 6808.693608787716, 6824.624645644537, 6830.556013859084, 6235.469985051322, 6360.586561873649, 6452.483801295791, 6491.221053473613, 6491.448226900767, 6335.334789847184, 6372.617642941438, 6389.137466441971, 6389.48884089281, 6402.807915762534, 5495.203195536705, 5559.082116669742, 5593.720313984366, 5597.944020559742, 5602.0, 3767.5290588676417, 3870.3226935285647, 3872.96127038726, 3905.726599138033, 3955.090329224352, 3894.1822217334675, 3908.6286802753693, 3931.5085614298214, 3936.6653834424396, 3937.4290727844873], "value": 3875.5435641919635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.633679879358, 287.75972063327123, 287.7683464810828, 291.49571241751755, 296.3968324459725, 4970.3538539989795, 5032.220005899091, 5040.823571175009, 5041.8235361762345, 5051.595872330214, 4968.652194346389, 4970.776315065822, 4983.476734942833, 4986.401631804189, 4990.276409920569, 3653.7442379033478, 3797.373433383488, 3823.604384399688, 3871.477350557681, 3909.361181202691, 3906.667933225665, 3907.120897797987, 3909.9609003910023, 3925.9803700981456, 3928.3910993795866, 3879.5538513071074, 3884.59211782763, 3884.941725874114, 3885.5224574006247, 3901.5708272090046, 3794.677452416548, 3824.694024478063, 3885.5531613864346, 3888.4361767543833, 3898.3762597984187, 3421.367047096295, 3438.209211881281, 3438.7249020078584, 3448.2586243957417, 3452.723782097426, 4763.76181190939, 4799.424069111694, 4810.6873053251775, 4819.44576373718, 4825.710457372569, 4413.646908247332, 4432.113577284556, 4443.333499974998, 4444.377787109807, 4470.776461176928, 4922.26166075088, 5201.505856943584, 5212.009718153577, 5213.428801271141, 5221.425643179247, 3615.981920090409, 3659.670629643318, 3662.212624285765, 3663.21240933198, 3673.7061035117126, 5428.6742795432, 5430.5927055471, 5499.917501237484, 5501.697406642633, 5508.834734957958, 3631.5642122945414, 3716.4053751399647, 3721.423179407196, 3725.9254814904093, 3730.8321125549414, 3774.226283611853, 3786.012343519619, 3788.753731007476, 3797.240551889633, 3802.6767724743154, 4312.0, 4319.524852266248, 4328.199283132568, 4359.912801743947, 4367.366731823868, 5028.296038554532, 5117.8720531987, 5213.348331458567, 5217.295665085241, 5222.7127507987425, 1269.6889262130837, 1276.2278821313157, 1280.2126692084487, 1288.935553222335, 1293.8512071111943, 804.9736585853084, 814.7148498025762, 831.9334453243725, 841.2470838599419, 846.9745907622781, 4402.889927751832, 4483.730976141442, 4583.977080114578, 4612.423447069116, 4628.213203755369, 5421.972890135603, 5441.972790136024, 5443.727813609304, 5444.183372494078, 5447.603054655939, 4607.262837945913, 4610.446746390455, 4620.861374158713, 4621.19129152397, 4625.791839367236, 2722.4963381774437, 2888.638920134983, 2898.5362342025173, 2904.3320036391747, 2906.2007947814095, 5073.416557095908, 5077.416097148801, 5078.603384069411, 5084.9745751271, 5097.9745101275, 5339.466053394707, 5494.972525137348, 5553.305836770403, 5560.527355174774, 5572.0, 5029.396472423259, 5043.420006699276, 5059.418166910705, 5068.239764035424, 5074.23886417033, 5402.513773760224, 5415.187721841755, 5417.945820541744, 5431.945680543302, 5441.7551210196425, 5043.0, 5298.549623282064, 5313.335833020872, 5318.335208098988, 5347.331583552056, 5067.493250674903, 5076.416212135652, 5078.492150784892, 5090.981803639213, 5094.643374963865, 3747.700183985329, 3755.4742336072427, 3760.5675347334313, 3770.9245815082995, 3784.6215378461934, 5101.591872650253, 5364.517193452608, 5414.593905457185, 5421.5933804964, 5443.319585051869, 5249.658772179796, 5279.340082489689, 5282.31329927107, 5287.444818294178, 5302.337207849019, 5267.341582302212, 5280.735963201748, 5282.788688452419, 5288.153895376721, 5293.894122117459, 5027.64806463544, 5143.61422893277, 5186.792528298825, 5207.192885102815, 5213.713245771519, 5022.949770502249, 5216.478352164905, 5227.575937760773, 5262.868428289324, 5293.814716484904, 5155.633757054308, 5158.8968220636125, 5161.251618515369, 5162.793488260578, 5211.941283193041], "value": 3912.9447004476006, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.6308504152632, 731.6195578299285, 732.560463721767, 740.4853626729422, 766.9760869239565, 12942.0, 13422.664433389158, 13781.242031688253, 13859.099158554687, 14113.153210807333, 13617.319134043282, 13866.584002479916, 13925.721485570282, 13940.233287169202, 13945.093568918013, 633.1389310537666, 774.3340726974798, 790.3913986230599, 793.6428607126816, 796.0964305513255, 653.5882394091716, 784.5175217241413, 803.2770506544099, 812.2770734046703, 814.8288859339516, 844.4426678392232, 845.2181731898, 845.2350622686448, 845.3364109174299, 846.7883029242689, 830.9626066827008, 836.7531578184451, 838.3167718309559, 838.6477679374647, 840.1514470384894, 617.450469082517, 618.6071844378807, 618.9350118237566, 618.9628622282632, 623.9220097487814, 13108.541201058013, 13131.212127272394, 13152.671183220496, 13177.275249861254, 13291.53479628218, 13100.868991310155, 13267.781447222314, 13473.461061557526, 13495.86504134956, 13685.384157712828, 10589.84115238272, 10598.735031624194, 10620.256582039183, 10634.149268058614, 10760.139188864872, 3376.9155771105675, 3397.252604427022, 3416.572928383952, 3423.7945723256685, 3516.771409858351, 61789.0, 61925.380746192415, 61985.0, 62792.37207627911, 62990.37009629891, 10314.469171253026, 10451.529681164366, 10463.790724185474, 10527.894721052844, 10722.78554428907, 20354.592908141753, 20365.49086272855, 20437.795622043886, 20561.0, 21083.472913177295, 6760.560563563353, 6807.285235050248, 6833.214180369321, 6877.037214789933, 6915.585064896122, 3589.192431702846, 3635.4365073413132, 3702.66675999156, 3713.702903767692, 3824.330742120118, 2650.509655713699, 2749.2439579115503, 2774.861256937145, 2780.0825727509873, 2795.4968105741164, 467.09616891315414, 478.60754181571474, 487.56850187584246, 491.0057134303065, 491.20915326324587, 523.4948274914725, 585.6690969602162, 587.9764809407576, 621.7844114755642, 625.3871206217841, 7769.53382797034, 7911.406644501571, 7932.405069619802, 8085.636146373427, 8134.471259368122, 498.97505124744345, 546.6883876190533, 594.6045879490091, 595.675356930474, 609.8930441249119, 3903.1998440320235, 3970.583088775637, 4092.7544347339253, 4104.856330028494, 4154.896127596834, 51716.74141629268, 52004.47995519996, 52018.21972670413, 52130.73934630379, 87409.5629521861, 75029.62485187648, 76714.61642691863, 77156.0, 77415.0, 78387.60806196046, 64419.0, 69589.65205174043, 69764.30235697578, 70120.64939675269, 71039.0, 7561.470697051153, 8147.918520814953, 8182.549959752271, 8253.943037566223, 8359.95820020896, 41017.1796564073, 41536.37695434631, 41649.0, 42779.786101069294, 42915.0, 53202.0, 62161.378386217366, 62447.375526244155, 63250.68374658097, 64963.0, 11383.658490245305, 11384.715382115513, 11446.198766086294, 11478.82781758291, 11616.0, 12721.93639031799, 12917.677058073623, 12961.740765184455, 13169.275689837152, 13799.51701690436, 10833.891661083288, 11437.656870293904, 11807.822882656596, 11914.642560723192, 12541.874581254071, 10788.460576971276, 11150.832737509107, 11205.159613028893, 11379.580668194478, 11982.940085299517, 10215.080642742189, 10793.136549076213, 10801.783964320826, 11030.669079927615, 11642.5342986283, 9300.581473833558, 9400.482973436527, 9493.477858717837, 9540.618375264912, 9675.612975481183, 9109.590068447069, 9413.670521531714, 9421.81156376855, 9477.535780958307, 9486.0], "value": 6450.8613652534295, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 115.0, 115.0, 117.0, 118.0, 118.0, 115.0, 116.0, 117.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 129.0, 178.0, 136.0, 136.0, 131.0, 130.0, 164.0, 134.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 163.0, 169.0, 163.0, 164.0, 163.0, 162.0, 161.0, 166.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 106.0, 78.0, 78.0, 78.0, 82.0, 101.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 124.0, 84.0, 84.0, 85.0, 103.0, 85.0, 88.0, 114.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 149.0, 149.0, 148.0, 149.0, 149.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 84.0, 85.0, 86.0, 86.0, 86.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 68.0, 66.0, 69.0, 67.0, 68.0, 66.0, 66.0, 69.0], "value": 67.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 70.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0], "value": 68.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 94.0, 83.0, 83.0, 85.0, 84.0, 91.0, 83.0, 89.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 151.0, 141.0, 147.0, 139.0, 146.0, 147.0, 146.0, 178.0, 145.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 175.0, 177.0, 174.0, 173.0, 186.0, 184.0, 176.0, 177.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 78.0, 70.0, 70.0, 72.0, 71.0, 72.0, 70.0, 80.0, 71.0], "value": 72.5, "unit": "score"}]}]} 17:22:45 INFO - Return code: 0 17:22:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:22:45 ERROR - # TBPL SUCCESS # 17:22:45 INFO - Running post-action listener: _resource_record_post_action 17:22:45 INFO - [mozharness: 2016-10-18 00:22:45.459631Z] Finished run-tests step (success) 17:22:45 INFO - Running post-run listener: _resource_record_post_run 17:22:45 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 36864; Write bytes: 394207232; Read time: 72; Write time: 286944 17:22:45 INFO - TinderboxPrint: CPU usage
13.4% 17:22:45 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 72 17:22:45 INFO - TinderboxPrint: I/O write bytes / time
394,207,232 / 286,944 17:22:45 INFO - TinderboxPrint: CPU idle
8,295.1 (86.6%) 17:22:45 INFO - TinderboxPrint: CPU user
1,221.0 (12.7%) 17:22:45 INFO - TinderboxPrint: Swap in / out
0 / 0 17:22:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 103153664; Read time: 0; Write time: 92764 17:22:45 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 32768; Write bytes: 291053568; Read time: 60; Write time: 194180 17:22:46 INFO - Running post-run listener: _upload_blobber_files 17:22:46 INFO - Blob upload gear active. 17:22:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:22:46 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 17:22:46 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'] 17:22:46 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 17:22:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:22:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:49 INFO - (blobuploader) - INFO - Done attempting. 17:22:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:22:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:53 INFO - (blobuploader) - INFO - Done attempting. 17:22:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:22:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:22:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:22:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:22:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:22:54 INFO - (blobuploader) - INFO - Done attempting. 17:22:54 INFO - (blobuploader) - INFO - Iteration through files over. 17:22:54 INFO - Return code: 0 17:22:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:22:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:22:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5a2858d93252246b92b668d4ac3006796e7be4e0f1a8d7a522b1265884091eb7edb44f4091df628084f0e0826bb81d1cf5eecc48713f92e095c6d25c4b82f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95fe68ac9ae5d742e073c0aef4272051324b08093c71ed976e5d0266180d9af847819720fd3d8805346777c2b90de96d6dfb0e1a94d5b971bafe428d0a5583bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0918fa92ca12f8e36abf6d06d1351d8428895c80d6ef9965062055bbc2326323f4d4d2e0e97292c30c057215cf0920edd13267a888d733dd74f9012c5a52d1"} 17:22:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:22:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:22:54 INFO - Contents: 17:22:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5a2858d93252246b92b668d4ac3006796e7be4e0f1a8d7a522b1265884091eb7edb44f4091df628084f0e0826bb81d1cf5eecc48713f92e095c6d25c4b82f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95fe68ac9ae5d742e073c0aef4272051324b08093c71ed976e5d0266180d9af847819720fd3d8805346777c2b90de96d6dfb0e1a94d5b971bafe428d0a5583bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0918fa92ca12f8e36abf6d06d1351d8428895c80d6ef9965062055bbc2326323f4d4d2e0e97292c30c057215cf0920edd13267a888d733dd74f9012c5a52d1"} 17:22:54 INFO - Running post-run listener: copy_logs_to_upload_dir 17:22:54 INFO - Copying logs to upload dir... 17:22:54 INFO - mkdir: /builds/slave/test/build/upload/logs 17:22:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.612014 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-17 17:22:54.109317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:22:54.113283) ========= 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=ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5a2858d93252246b92b668d4ac3006796e7be4e0f1a8d7a522b1265884091eb7edb44f4091df628084f0e0826bb81d1cf5eecc48713f92e095c6d25c4b82f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95fe68ac9ae5d742e073c0aef4272051324b08093c71ed976e5d0266180d9af847819720fd3d8805346777c2b90de96d6dfb0e1a94d5b971bafe428d0a5583bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0918fa92ca12f8e36abf6d06d1351d8428895c80d6ef9965062055bbc2326323f4d4d2e0e97292c30c057215cf0920edd13267a888d733dd74f9012c5a52d1"} build_url:https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/C1UF0Ey9SaWBsSP0CEHJmQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f5a2858d93252246b92b668d4ac3006796e7be4e0f1a8d7a522b1265884091eb7edb44f4091df628084f0e0826bb81d1cf5eecc48713f92e095c6d25c4b82f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95fe68ac9ae5d742e073c0aef4272051324b08093c71ed976e5d0266180d9af847819720fd3d8805346777c2b90de96d6dfb0e1a94d5b971bafe428d0a5583bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c0918fa92ca12f8e36abf6d06d1351d8428895c80d6ef9965062055bbc2326323f4d4d2e0e97292c30c057215cf0920edd13267a888d733dd74f9012c5a52d1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:22:54.139437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:22:54.139831) ========= 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=ed14279e38b05397cf4aa391000001a4-1476748924.338671-1223582401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:22:54.224696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 17:22:54.225023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 17:22:54.225334) ========= ========= Total master_lag: 0.17 =========