builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1477974508.7 results: success (0) buildid: 20161031193403 builduid: 609919d2cac74787a66e824960e5faee revision: 2c773b97167252cedcba0be0c7af9d4cab192ef5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.702584) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.703056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.703345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.717946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.718216) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 21:28:29-- 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% 223M=0s 2016-10-31 21:28:29 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072891 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.805039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.805360) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017892 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:28.855333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 21:28:28.855729) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2c773b97167252cedcba0be0c7af9d4cab192ef5 --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 2c773b97167252cedcba0be0c7af9d4cab192ef5 --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=8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 21:28:29,230 truncating revision to first 12 chars 2016-10-31 21:28:29,230 Setting DEBUG logging. 2016-10-31 21:28:29,230 attempt 1/10 2016-10-31 21:28:29,230 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2c773b971672?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 21:28:30,118 unpacking tar archive at: mozilla-central-2c773b971672/testing/mozharness/ program finished with exit code 0 elapsedTime=1.214287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-31 21:28:30.084985) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:30.085461) ========= script_repo_revision: 2c773b97167252cedcba0be0c7af9d4cab192ef5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:30.086019) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:30.086418) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 21:28:30.096966) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-31 21:28:30.097298) ========= /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=8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:28:30 INFO - MultiFileLogger online at 20161031 21:28:30 in /builds/slave/test 21:28:30 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 21:28:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:28:30 INFO - {'append_to_log': False, 21:28:30 INFO - 'base_work_dir': '/builds/slave/test', 21:28:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:28:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:28:30 INFO - 'branch': 'Firefox-Non-PGO', 21:28:30 INFO - 'buildbot_json_path': 'buildprops.json', 21:28:30 INFO - 'config_files': ('talos/linux_config.py',), 21:28:30 INFO - 'default_actions': ('clobber', 21:28:30 INFO - 'read-buildbot-config', 21:28:30 INFO - 'download-and-extract', 21:28:30 INFO - 'populate-webroot', 21:28:30 INFO - 'create-virtualenv', 21:28:30 INFO - 'install', 21:28:30 INFO - 'run-tests'), 21:28:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:28:30 INFO - 'download_minidump_stackwalk': True, 21:28:30 INFO - 'download_symbols': 'ondemand', 21:28:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:28:30 INFO - 'tooltool.py': '/tools/tooltool.py', 21:28:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:28:30 INFO - '/tools/misc-python/virtualenv.py')}, 21:28:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:28:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:28:30 INFO - 'installer_path': 'installer.exe', 21:28:30 INFO - 'log_level': 'info', 21:28:30 INFO - 'log_name': 'talos', 21:28:30 INFO - 'log_to_console': True, 21:28:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:28:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:28:30 INFO - 'opt_config_files': (), 21:28:30 INFO - 'pip_index': False, 21:28:30 INFO - 'sps_profile': False, 21:28:30 INFO - 'sps_profile_interval': 0, 21:28:30 INFO - 'suite': 'dromaeojs-e10s', 21:28:30 INFO - 'system_bits': '32', 21:28:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:28:30 INFO - 'title': 'talos-linux64-ix-001', 21:28:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:28:30 INFO - 'use_talos_json': True, 21:28:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:28:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:28:30 INFO - 'work_dir': 'build'} 21:28:30 INFO - [mozharness: 2016-11-01 04:28:30.576263Z] Running clobber step. 21:28:30 INFO - Running pre-action listener: _resource_record_pre_action 21:28:30 INFO - Running main action method: clobber 21:28:30 INFO - rmtree: /builds/slave/test/build 21:28:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:28:31 INFO - Running post-action listener: _resource_record_post_action 21:28:31 INFO - [mozharness: 2016-11-01 04:28:31.031486Z] Finished clobber step (success) 21:28:31 INFO - [mozharness: 2016-11-01 04:28:31.031587Z] Running read-buildbot-config step. 21:28:31 INFO - Running pre-action listener: _resource_record_pre_action 21:28:31 INFO - Running main action method: read_buildbot_config 21:28:31 INFO - Using buildbot properties: 21:28:31 INFO - { 21:28:31 INFO - "project": "", 21:28:31 INFO - "product": "firefox", 21:28:31 INFO - "script_repo_revision": "production", 21:28:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:28:31 INFO - "repository": "", 21:28:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 21:28:31 INFO - "buildid": "20161031193403", 21:28:31 INFO - "pgo_build": "False", 21:28:31 INFO - "basedir": "/builds/slave/test", 21:28:31 INFO - "buildnumber": 528, 21:28:31 INFO - "slavename": "talos-linux64-ix-001", 21:28:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:28:31 INFO - "platform": "ubuntu64_hw", 21:28:31 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:28:31 INFO - "branch": "mozilla-central", 21:28:31 INFO - "repo_path": "mozilla-central", 21:28:31 INFO - "revision": "2c773b97167252cedcba0be0c7af9d4cab192ef5", 21:28:31 INFO - "stage_platform": "linux64", 21:28:31 INFO - "builduid": "609919d2cac74787a66e824960e5faee", 21:28:31 INFO - "slavebuilddir": "test" 21:28:31 INFO - } 21:28:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:28:31 INFO - Running post-action listener: _resource_record_post_action 21:28:31 INFO - [mozharness: 2016-11-01 04:28:31.034021Z] Finished read-buildbot-config step (success) 21:28:31 INFO - [mozharness: 2016-11-01 04:28:31.034110Z] Running download-and-extract step. 21:28:31 INFO - Running pre-action listener: _resource_record_pre_action 21:28:31 INFO - Running main action method: download_and_extract 21:28:31 INFO - mkdir: /builds/slave/test/build/tests 21:28:31 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')]} 21:28:31 INFO - trying https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:28:31 INFO - Downloading https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/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 21:28:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/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 21:28:31 INFO - Downloaded 1361 bytes. 21:28:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:28:31 INFO - Using the following test package requirements: 21:28:31 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:28:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:28:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'jsshell-linux-x86_64.zip'], 21:28:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:28:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:28:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:28:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:28:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:28:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:28:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:28:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:28:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:28:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:28:31 INFO - Fetch https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:28:32 INFO - Http code: 200 21:28:32 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 21:28:32 INFO - x-amz-cf-id: CIAtWIbDr8mF9Lf-QY4I1513mDCEKcqbo5pY0CC5OiTkCd4c6XDN0w== 21:28:32 INFO - x-amz-version-id: PtcKiQK7RTyLhQloYdB7.ULa_abIdySl 21:28:32 INFO - Expected file size: 20452283 21:28:32 INFO - Obtained file size: 20452283 21:28:36 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 21:28:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:28:36 INFO - Fetch https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:28:37 INFO - Http code: 200 21:28:37 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 21:28:37 INFO - x-amz-cf-id: -skBFLbiGLEEdyOdNWoDRPtk2NxsDvWWMP0oLh3jh0Q4cLqJz5Ek4Q== 21:28:37 INFO - x-amz-version-id: PtcKiQK7RTyLhQloYdB7.ULa_abIdySl 21:28:37 INFO - Expected file size: 20452283 21:28:37 INFO - Obtained file size: 20452283 21:28:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:28:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:28:41 INFO - Fetch https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:28:42 INFO - Http code: 200 21:28:42 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 21:28:42 INFO - x-amz-cf-id: jNEZJqi5Y1agr2A76Ew-WQp7nM06yqgRqhzZEshlX_xU5jtggxxtFA== 21:28:42 INFO - x-amz-version-id: w18mq0O4GKJcGqCPormT000JKbyG_K1. 21:28:42 INFO - Expected file size: 14409038 21:28:42 INFO - Obtained file size: 14409038 21:28: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')]} 21:28:42 INFO - trying https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:28:42 INFO - Downloading https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/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 21:28:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/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 21:28:43 INFO - Downloaded 55805330 bytes. 21:28:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:28:43 INFO - mkdir: /builds/slave/test/properties 21:28:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:28:43 INFO - Writing to file /builds/slave/test/properties/build_url 21:28:43 INFO - Contents: 21:28:43 INFO - build_url:https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:28:44 INFO - Running post-action listener: _resource_record_post_action 21:28:44 INFO - Running post-action listener: set_extra_try_arguments 21:28:44 INFO - [mozharness: 2016-11-01 04:28:44.583501Z] Finished download-and-extract step (success) 21:28:44 INFO - [mozharness: 2016-11-01 04:28:44.583728Z] Running populate-webroot step. 21:28:44 INFO - Running pre-action listener: _resource_record_pre_action 21:28:44 INFO - Running main action method: populate_webroot 21:28:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:28:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:28:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:28:44 INFO - '--tppagecycles', 21:28:44 INFO - '7'], 21:28:44 INFO - 'tests': ['tsvgm']}}, 21:28:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:28:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:28:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:28:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:28:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['damp', 'tps']}, 21:28:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'tests': ['damp', 'tps']}, 21:28:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['dromaeo_dom']}, 21:28:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:28:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['basic_compositor_video']}, 21:28:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:28:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['a11yr', 21:28:44 INFO - 'ts_paint', 21:28:44 INFO - 'tpaint', 21:28:44 INFO - 'sessionrestore', 21:28:44 INFO - 'sessionrestore_no_auto_restore', 21:28:44 INFO - 'tabpaint']}, 21:28:44 INFO - 'other-e10s': {'tests': ['a11yr', 21:28:44 INFO - 'ts_paint', 21:28:44 INFO - 'tpaint', 21:28:44 INFO - 'sessionrestore', 21:28:44 INFO - 'sessionrestore_no_auto_restore', 21:28:44 INFO - 'tabpaint']}, 21:28:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:28:44 INFO - 'ts_paint', 21:28:44 INFO - 'tpaint', 21:28:44 INFO - 'sessionrestore', 21:28:44 INFO - 'sessionrestore_no_auto_restore', 21:28:44 INFO - 'tabpaint']}, 21:28:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:28:44 INFO - 'ts_paint', 21:28:44 INFO - 'tpaint', 21:28:44 INFO - 'sessionrestore', 21:28:44 INFO - 'sessionrestore_no_auto_restore', 21:28:44 INFO - 'tabpaint']}, 21:28:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['a11yr', 21:28:44 INFO - 'ts_paint', 21:28:44 INFO - 'tpaint', 21:28:44 INFO - 'sessionrestore', 21:28:44 INFO - 'sessionrestore_no_auto_restore', 21:28:44 INFO - 'tabpaint']}, 21:28:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['a11yr', 21:28:44 INFO - 'ts_paint', 21:28:44 INFO - 'tpaint', 21:28:44 INFO - 'sessionrestore', 21:28:44 INFO - 'sessionrestore_no_auto_restore', 21:28:44 INFO - 'tabpaint']}, 21:28:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['tsvgx', 21:28:44 INFO - 'tsvgr_opacity', 21:28:44 INFO - 'tart', 21:28:44 INFO - 'tscrollx', 21:28:44 INFO - 'cart']}, 21:28:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:28:44 INFO - 'tsvgr_opacity', 21:28:44 INFO - 'tart', 21:28:44 INFO - 'tscrollx', 21:28:44 INFO - 'cart']}, 21:28:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'talos_options': ['--disable-e10s'], 21:28:44 INFO - 'tests': ['tp5o']}, 21:28:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'tests': ['tp5o']}, 21:28:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'talos_options': ['--disable-e10s', 21:28:44 INFO - '--xperf_path', 21:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:44 INFO - 'tests': ['tp5n']}, 21:28:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:44 INFO - 'talos_options': ['--xperf_path', 21:28:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:44 INFO - 'tests': ['tp5n']}}, 21:28:44 INFO - 'talos.zip': {'path': '', 21:28:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:28:44 INFO - Running post-action listener: _resource_record_post_action 21:28:44 INFO - [mozharness: 2016-11-01 04:28:44.600406Z] Finished populate-webroot step (success) 21:28:44 INFO - [mozharness: 2016-11-01 04:28:44.600493Z] Running create-virtualenv step. 21:28:44 INFO - Running pre-action listener: _resource_record_pre_action 21:28:44 INFO - Running main action method: create_virtualenv 21:28:44 INFO - Creating virtualenv /builds/slave/test/build/venv 21:28:44 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 21:28:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:28:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:28:44 INFO - Using real prefix '/usr' 21:28:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:28:45 INFO - Installing distribute.............................................................................................................................................................................................done. 21:28:47 INFO - Installing pip.................done. 21:28:47 INFO - Return code: 0 21:28:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:28:47 INFO - Reading from file tmpfile_stdout 21:28:47 INFO - Output received: 21:28:47 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) 21:28:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:47 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:28:47 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 21:28:47 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 21:28:47 INFO - Using env: {'DISPLAY': ':0', 21:28:47 INFO - 'HOME': '/home/cltbld', 21:28:47 INFO - 'LANG': 'en_US.UTF-8', 21:28:47 INFO - 'LANGUAGE': 'en_US:en', 21:28:47 INFO - 'LOGNAME': 'cltbld', 21:28:47 INFO - 'MAIL': '/var/mail/cltbld', 21:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:47 INFO - 'MOZ_NO_REMOTE': '1', 21:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:47 INFO - 'NO_EM_RESTART': '1', 21:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:47 INFO - 'PWD': '/builds/slave/test', 21:28:47 INFO - 'SHELL': '/bin/bash', 21:28:47 INFO - 'SHLVL': '1', 21:28:47 INFO - 'TERM': 'linux', 21:28:47 INFO - 'TMOUT': '86400', 21:28:47 INFO - 'USER': 'cltbld', 21:28:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:47 INFO - '_': '/tools/buildbot/bin/python'} 21:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:47 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 21:28:47 INFO - Cleaning up... 21:28:47 INFO - Return code: 0 21:28:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:47 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:28:47 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 21:28:47 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 21:28:47 INFO - Using env: {'DISPLAY': ':0', 21:28:47 INFO - 'HOME': '/home/cltbld', 21:28:47 INFO - 'LANG': 'en_US.UTF-8', 21:28:47 INFO - 'LANGUAGE': 'en_US:en', 21:28:47 INFO - 'LOGNAME': 'cltbld', 21:28:47 INFO - 'MAIL': '/var/mail/cltbld', 21:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:47 INFO - 'MOZ_NO_REMOTE': '1', 21:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:47 INFO - 'NO_EM_RESTART': '1', 21:28:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:47 INFO - 'PWD': '/builds/slave/test', 21:28:47 INFO - 'SHELL': '/bin/bash', 21:28:47 INFO - 'SHLVL': '1', 21:28:47 INFO - 'TERM': 'linux', 21:28:47 INFO - 'TMOUT': '86400', 21:28:47 INFO - 'USER': 'cltbld', 21:28:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:47 INFO - '_': '/tools/buildbot/bin/python'} 21:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:47 INFO - Downloading/unpacking psutil>=3.1.1 21:28:47 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 21:28:47 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 21:28:47 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 21:28:47 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 21:28:47 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 21:28:47 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 21:28:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:28:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:49 INFO - Installing collected packages: psutil 21:28:49 INFO - Running setup.py install for psutil 21:28:49 INFO - building 'psutil._psutil_linux' extension 21:28:49 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 21:28:50 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 21:28:50 INFO - building 'psutil._psutil_posix' extension 21:28:50 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 21:28:50 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 21:28:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:50 INFO - Successfully installed psutil 21:28:50 INFO - Cleaning up... 21:28:50 INFO - Return code: 0 21:28:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:50 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:28:50 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 21:28:50 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 21:28:50 INFO - Using env: {'DISPLAY': ':0', 21:28:50 INFO - 'HOME': '/home/cltbld', 21:28:50 INFO - 'LANG': 'en_US.UTF-8', 21:28:50 INFO - 'LANGUAGE': 'en_US:en', 21:28:50 INFO - 'LOGNAME': 'cltbld', 21:28:50 INFO - 'MAIL': '/var/mail/cltbld', 21:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:50 INFO - 'MOZ_NO_REMOTE': '1', 21:28:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:50 INFO - 'NO_EM_RESTART': '1', 21:28:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:50 INFO - 'PWD': '/builds/slave/test', 21:28:50 INFO - 'SHELL': '/bin/bash', 21:28:50 INFO - 'SHLVL': '1', 21:28:50 INFO - 'TERM': 'linux', 21:28:50 INFO - 'TMOUT': '86400', 21:28:50 INFO - 'USER': 'cltbld', 21:28:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:50 INFO - '_': '/tools/buildbot/bin/python'} 21:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:28:50 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 21:28:50 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 21:28:50 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 21:28:50 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 21:28:50 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 21:28:50 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 21:28:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:28:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:28:52 INFO - Installing collected packages: mozsystemmonitor 21:28:52 INFO - Running setup.py install for mozsystemmonitor 21:28:52 INFO - Successfully installed mozsystemmonitor 21:28:52 INFO - Cleaning up... 21:28:52 INFO - Return code: 0 21:28:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:28:52 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')]} 21:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:52 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')]} 21:28:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:52 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:28:52 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 21:28:52 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 21:28:52 INFO - Using env: {'DISPLAY': ':0', 21:28:52 INFO - 'HOME': '/home/cltbld', 21:28:52 INFO - 'LANG': 'en_US.UTF-8', 21:28:52 INFO - 'LANGUAGE': 'en_US:en', 21:28:52 INFO - 'LOGNAME': 'cltbld', 21:28:52 INFO - 'MAIL': '/var/mail/cltbld', 21:28:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:52 INFO - 'MOZ_NO_REMOTE': '1', 21:28:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:52 INFO - 'NO_EM_RESTART': '1', 21:28:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:52 INFO - 'PWD': '/builds/slave/test', 21:28:52 INFO - 'SHELL': '/bin/bash', 21:28:52 INFO - 'SHLVL': '1', 21:28:52 INFO - 'TERM': 'linux', 21:28:52 INFO - 'TMOUT': '86400', 21:28:52 INFO - 'USER': 'cltbld', 21:28:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:28:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:52 INFO - '_': '/tools/buildbot/bin/python'} 21:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:52 INFO - Downloading/unpacking jsonschema==2.5.1 21:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:28:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:55 INFO - Downloading functools32-3.2.3-2.tar.gz 21:28:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:28:55 INFO - warning: no files found matching '*.txt' 21:28:55 INFO - no previously-included directories found matching 'build' 21:28:55 INFO - no previously-included directories found matching 'dist' 21:28:55 INFO - no previously-included directories found matching '.git*' 21:28:55 INFO - Installing collected packages: jsonschema, functools32 21:28:55 INFO - Running setup.py install for functools32 21:28:55 INFO - warning: no files found matching '*.txt' 21:28:55 INFO - no previously-included directories found matching 'build' 21:28:55 INFO - no previously-included directories found matching 'dist' 21:28:55 INFO - no previously-included directories found matching '.git*' 21:28:55 INFO - Successfully installed jsonschema functools32 21:28:55 INFO - Cleaning up... 21:28:55 INFO - Return code: 0 21:28:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:55 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:28:55 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 21:28:55 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 21:28:55 INFO - Using env: {'DISPLAY': ':0', 21:28:55 INFO - 'HOME': '/home/cltbld', 21:28:55 INFO - 'LANG': 'en_US.UTF-8', 21:28:55 INFO - 'LANGUAGE': 'en_US:en', 21:28:55 INFO - 'LOGNAME': 'cltbld', 21:28:55 INFO - 'MAIL': '/var/mail/cltbld', 21:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:55 INFO - 'MOZ_NO_REMOTE': '1', 21:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:55 INFO - 'NO_EM_RESTART': '1', 21:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:55 INFO - 'PWD': '/builds/slave/test', 21:28:55 INFO - 'SHELL': '/bin/bash', 21:28:55 INFO - 'SHLVL': '1', 21:28:55 INFO - 'TERM': 'linux', 21:28:55 INFO - 'TMOUT': '86400', 21:28:55 INFO - 'USER': 'cltbld', 21:28:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:55 INFO - '_': '/tools/buildbot/bin/python'} 21:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:28:55 INFO - Cleaning up... 21:28:55 INFO - Return code: 0 21:28:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:55 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:28:55 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 21:28:55 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 21:28:55 INFO - Using env: {'DISPLAY': ':0', 21:28:55 INFO - 'HOME': '/home/cltbld', 21:28:55 INFO - 'LANG': 'en_US.UTF-8', 21:28:55 INFO - 'LANGUAGE': 'en_US:en', 21:28:55 INFO - 'LOGNAME': 'cltbld', 21:28:55 INFO - 'MAIL': '/var/mail/cltbld', 21:28:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:55 INFO - 'MOZ_NO_REMOTE': '1', 21:28:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:55 INFO - 'NO_EM_RESTART': '1', 21:28:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:55 INFO - 'PWD': '/builds/slave/test', 21:28:55 INFO - 'SHELL': '/bin/bash', 21:28:55 INFO - 'SHLVL': '1', 21:28:55 INFO - 'TERM': 'linux', 21:28:55 INFO - 'TMOUT': '86400', 21:28:55 INFO - 'USER': 'cltbld', 21:28:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:28:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:55 INFO - '_': '/tools/buildbot/bin/python'} 21:28:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:55 INFO - Downloading/unpacking blobuploader==1.2.4 21:28:55 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 21:28:55 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 21:28:55 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 21:28:55 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 21:28:55 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 21:28:55 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 21:28:57 INFO - Downloading blobuploader-1.2.4.tar.gz 21:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:28:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:28:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:28:58 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 21:28:58 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 21:28:58 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 21:28:58 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 21:28:58 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 21:28:58 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 21:28:58 INFO - Downloading docopt-0.6.1.tar.gz 21:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:28:58 INFO - Installing collected packages: blobuploader, requests, docopt 21:28:58 INFO - Running setup.py install for blobuploader 21:28:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:28:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:28:58 INFO - Running setup.py install for requests 21:28:58 INFO - Running setup.py install for docopt 21:28:59 INFO - Successfully installed blobuploader requests docopt 21:28:59 INFO - Cleaning up... 21:28:59 INFO - Return code: 0 21:28:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:59 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:28:59 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 21:28:59 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 21:28:59 INFO - Using env: {'DISPLAY': ':0', 21:28:59 INFO - 'HOME': '/home/cltbld', 21:28:59 INFO - 'LANG': 'en_US.UTF-8', 21:28:59 INFO - 'LANGUAGE': 'en_US:en', 21:28:59 INFO - 'LOGNAME': 'cltbld', 21:28:59 INFO - 'MAIL': '/var/mail/cltbld', 21:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:59 INFO - 'MOZ_NO_REMOTE': '1', 21:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:59 INFO - 'NO_EM_RESTART': '1', 21:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:59 INFO - 'PWD': '/builds/slave/test', 21:28:59 INFO - 'SHELL': '/bin/bash', 21:28:59 INFO - 'SHLVL': '1', 21:28:59 INFO - 'TERM': 'linux', 21:28:59 INFO - 'TMOUT': '86400', 21:28:59 INFO - 'USER': 'cltbld', 21:28:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:59 INFO - '_': '/tools/buildbot/bin/python'} 21:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:59 INFO - Running setup.py (path:/tmp/pip-YIF_tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:59 INFO - Running setup.py (path:/tmp/pip-g98dnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:59 INFO - Running setup.py (path:/tmp/pip-SaSlTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:59 INFO - Running setup.py (path:/tmp/pip-ys3pDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:59 INFO - Running setup.py (path:/tmp/pip-0URL8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:59 INFO - Running setup.py (path:/tmp/pip-YlilYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:59 INFO - Running setup.py (path:/tmp/pip-8mJVxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:59 INFO - Running setup.py (path:/tmp/pip-AwBfDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:59 INFO - Running setup.py (path:/tmp/pip-cpGyWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:00 INFO - Running setup.py (path:/tmp/pip-bYlZRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:00 INFO - Running setup.py (path:/tmp/pip-KiQS3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:00 INFO - Running setup.py (path:/tmp/pip-OhVmhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:00 INFO - Running setup.py (path:/tmp/pip-1fPKHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:00 INFO - Running setup.py (path:/tmp/pip-pVqJWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:00 INFO - Running setup.py (path:/tmp/pip-BP1t5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:00 INFO - Running setup.py (path:/tmp/pip-ZJqxHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:00 INFO - Running setup.py (path:/tmp/pip-mZ5Tct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:29:00 INFO - Running setup.py install for manifestparser 21:29:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:29:00 INFO - Running setup.py install for mozcrash 21:29:00 INFO - Running setup.py install for mozdebug 21:29:00 INFO - Running setup.py install for mozdevice 21:29:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Running setup.py install for mozfile 21:29:01 INFO - Running setup.py install for mozhttpd 21:29:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Running setup.py install for mozinfo 21:29:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Running setup.py install for mozInstall 21:29:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Running setup.py install for mozleak 21:29:01 INFO - Running setup.py install for mozlog 21:29:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Running setup.py install for moznetwork 21:29:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Running setup.py install for mozprocess 21:29:01 INFO - Running setup.py install for mozprofile 21:29:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:29:01 INFO - Running setup.py install for mozrunner 21:29:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:29:02 INFO - Running setup.py install for mozscreenshot 21:29:02 INFO - Running setup.py install for moztest 21:29:02 INFO - Running setup.py install for mozversion 21:29:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:29:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:29:02 INFO - Cleaning up... 21:29:02 INFO - Return code: 0 21:29:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:02 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')]} 21:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:02 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')]} 21:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:02 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:29:02 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 21:29:02 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 21:29:02 INFO - Using env: {'DISPLAY': ':0', 21:29:02 INFO - 'HOME': '/home/cltbld', 21:29:02 INFO - 'LANG': 'en_US.UTF-8', 21:29:02 INFO - 'LANGUAGE': 'en_US:en', 21:29:02 INFO - 'LOGNAME': 'cltbld', 21:29:02 INFO - 'MAIL': '/var/mail/cltbld', 21:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:02 INFO - 'MOZ_NO_REMOTE': '1', 21:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:02 INFO - 'NO_EM_RESTART': '1', 21:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:02 INFO - 'PWD': '/builds/slave/test', 21:29:02 INFO - 'SHELL': '/bin/bash', 21:29:02 INFO - 'SHLVL': '1', 21:29:02 INFO - 'TERM': 'linux', 21:29:02 INFO - 'TMOUT': '86400', 21:29:02 INFO - 'USER': 'cltbld', 21:29:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:02 INFO - '_': '/tools/buildbot/bin/python'} 21:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:29:02 INFO - Running setup.py (path:/tmp/pip-ImyBfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:29:02 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)) 21:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:29:02 INFO - Running setup.py (path:/tmp/pip-Du55YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:29:02 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)) 21:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:29:02 INFO - Running setup.py (path:/tmp/pip-f7kJVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:29:02 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)) 21:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:29:02 INFO - Running setup.py (path:/tmp/pip-bN9vLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:29:02 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)) 21:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:29:02 INFO - Running setup.py (path:/tmp/pip-dRnmOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:29:03 INFO - Running setup.py (path:/tmp/pip-jBtbui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:29:03 INFO - Running setup.py (path:/tmp/pip-BRGigq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:29:03 INFO - Running setup.py (path:/tmp/pip-kOvAmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:29:03 INFO - Running setup.py (path:/tmp/pip-0PWhrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:29:03 INFO - Running setup.py (path:/tmp/pip-65wnOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:29:03 INFO - Running setup.py (path:/tmp/pip-0GwF06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:29:03 INFO - Running setup.py (path:/tmp/pip-r5MDSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:29:03 INFO - Running setup.py (path:/tmp/pip-XFtzfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:29:03 INFO - Running setup.py (path:/tmp/pip-En6z8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:03 INFO - Running setup.py (path:/tmp/pip-PzCewQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:29:03 INFO - Running setup.py (path:/tmp/pip-LwaaKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:29:03 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)) 21:29:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:29:03 INFO - Running setup.py (path:/tmp/pip-gyqJ1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:29:03 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)) 21:29:03 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)) 21:29:03 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)) 21:29:03 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)) 21:29:03 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)) 21:29:03 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)) 21:29:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:29:05 INFO - Downloading blessings-1.6.tar.gz 21:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:29:05 INFO - Installing collected packages: blessings 21:29:05 INFO - Running setup.py install for blessings 21:29:06 INFO - Successfully installed blessings 21:29:06 INFO - Cleaning up... 21:29:06 INFO - Return code: 0 21:29:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:06 INFO - Reading from file tmpfile_stdout 21:29:06 INFO - Current package versions: 21:29:06 INFO - argparse == 1.2.1 21:29:06 INFO - blessings == 1.6 21:29:06 INFO - blobuploader == 1.2.4 21:29:06 INFO - docopt == 0.6.1 21:29:06 INFO - functools32 == 3.2.3-2 21:29:06 INFO - jsonschema == 2.5.1 21:29:06 INFO - manifestparser == 1.1 21:29:06 INFO - mozInstall == 1.12 21:29:06 INFO - mozcrash == 0.17 21:29:06 INFO - mozdebug == 0.1 21:29:06 INFO - mozdevice == 0.48 21:29:06 INFO - mozfile == 1.2 21:29:06 INFO - mozhttpd == 0.7 21:29:06 INFO - mozinfo == 0.9 21:29:06 INFO - mozleak == 0.1 21:29:06 INFO - mozlog == 3.4 21:29:06 INFO - moznetwork == 0.27 21:29:06 INFO - mozprocess == 0.23 21:29:06 INFO - mozprofile == 0.28 21:29:06 INFO - mozrunner == 6.12 21:29:06 INFO - mozscreenshot == 0.1 21:29:06 INFO - mozsystemmonitor == 0.3 21:29:06 INFO - moztest == 0.7 21:29:06 INFO - mozversion == 1.4 21:29:06 INFO - psutil == 3.1.1 21:29:06 INFO - requests == 1.2.3 21:29:06 INFO - wsgiref == 0.1.2 21:29:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:06 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 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:29:06 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 21:29:06 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 21:29:06 INFO - Using env: {'DISPLAY': ':0', 21:29:06 INFO - 'HOME': '/home/cltbld', 21:29:06 INFO - 'LANG': 'en_US.UTF-8', 21:29:06 INFO - 'LANGUAGE': 'en_US:en', 21:29:06 INFO - 'LOGNAME': 'cltbld', 21:29:06 INFO - 'MAIL': '/var/mail/cltbld', 21:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:06 INFO - 'MOZ_NO_REMOTE': '1', 21:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:06 INFO - 'NO_EM_RESTART': '1', 21:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:06 INFO - 'PWD': '/builds/slave/test', 21:29:06 INFO - 'SHELL': '/bin/bash', 21:29:06 INFO - 'SHLVL': '1', 21:29:06 INFO - 'TERM': 'linux', 21:29:06 INFO - 'TMOUT': '86400', 21:29:06 INFO - 'USER': 'cltbld', 21:29:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:06 INFO - '_': '/tools/buildbot/bin/python'} 21:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 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)) 21:29:06 INFO - Cleaning up... 21:29:06 INFO - Return code: 0 21:29:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:29:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3d036cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x141bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', '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 21:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:29:06 INFO - Using env: {'DISPLAY': ':0', 21:29:06 INFO - 'HOME': '/home/cltbld', 21:29:06 INFO - 'LANG': 'en_US.UTF-8', 21:29:06 INFO - 'LANGUAGE': 'en_US:en', 21:29:06 INFO - 'LOGNAME': 'cltbld', 21:29:06 INFO - 'MAIL': '/var/mail/cltbld', 21:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:06 INFO - 'MOZ_NO_REMOTE': '1', 21:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:06 INFO - 'NO_EM_RESTART': '1', 21:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:06 INFO - 'PWD': '/builds/slave/test', 21:29:06 INFO - 'SHELL': '/bin/bash', 21:29:06 INFO - 'SHLVL': '1', 21:29:06 INFO - 'TERM': 'linux', 21:29:06 INFO - 'TMOUT': '86400', 21:29:06 INFO - 'USER': 'cltbld', 21:29:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:06 INFO - '_': '/tools/buildbot/bin/python'} 21:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:29:06 INFO - Cleaning up... 21:29:06 INFO - Return code: 0 21:29:06 INFO - Running post-action listener: _resource_record_post_action 21:29:06 INFO - Running post-action listener: _start_resource_monitoring 21:29:06 INFO - Starting resource monitoring. 21:29:06 INFO - [mozharness: 2016-11-01 04:29:06.819452Z] Finished create-virtualenv step (success) 21:29:06 INFO - [mozharness: 2016-11-01 04:29:06.819958Z] Running install step. 21:29:06 INFO - Running pre-action listener: _resource_record_pre_action 21:29:06 INFO - Running main action method: install 21:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:29:07 INFO - Reading from file tmpfile_stdout 21:29:07 INFO - Detecting whether we're running mozinstall >=1.0... 21:29:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:29:07 INFO - Reading from file tmpfile_stdout 21:29:07 INFO - Output received: 21:29:07 INFO - Usage: mozinstall [options] installer 21:29:07 INFO - Options: 21:29:07 INFO - -h, --help show this help message and exit 21:29:07 INFO - -d DEST, --destination=DEST 21:29:07 INFO - Directory to install application into. [default: 21:29:07 INFO - "/builds/slave/test"] 21:29:07 INFO - --app=APP Application being installed. [default: firefox] 21:29:07 INFO - mkdir: /builds/slave/test/build/application 21:29:07 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'] 21:29:07 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 21:29:23 INFO - Reading from file tmpfile_stdout 21:29:23 INFO - Output received: 21:29:23 INFO - /builds/slave/test/build/application/firefox/firefox 21:29:23 INFO - Running post-action listener: _resource_record_post_action 21:29:23 INFO - [mozharness: 2016-11-01 04:29:23.206345Z] Finished install step (success) 21:29:23 INFO - [mozharness: 2016-11-01 04:29:23.206680Z] Running run-tests step. 21:29:23 INFO - Running pre-action listener: _resource_record_pre_action 21:29:23 INFO - Running main action method: run_tests 21:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:29:23 INFO - Python 2.7.3 21:29:23 INFO - Return code: 0 21:29:23 INFO - grabbing minidump binary from tooltool 21:29: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')]} 21:29:23 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 0x1418f60>, '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 0x1419d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x141a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:29:23 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 21:29:23 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 21:29:23 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 21:29:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:29:23 INFO - Return code: 0 21:29:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:29:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:29:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:29:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:29:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:29:23 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/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 21:29:23 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/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 21:29:23 INFO - Using env: {'DISPLAY': ':0', 21:29:23 INFO - 'HOME': '/home/cltbld', 21:29:23 INFO - 'LANG': 'en_US.UTF-8', 21:29:23 INFO - 'LANGUAGE': 'en_US:en', 21:29:23 INFO - 'LOGNAME': 'cltbld', 21:29:23 INFO - 'MAIL': '/var/mail/cltbld', 21:29:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:29:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:29:23 INFO - 'MOZ_NO_REMOTE': '1', 21:29:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:29:23 INFO - 'NO_EM_RESTART': '1', 21:29:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:29:23 INFO - 'PWD': '/builds/slave/test', 21:29:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:29:23 INFO - 'SHELL': '/bin/bash', 21:29:23 INFO - 'SHLVL': '1', 21:29:23 INFO - 'TERM': 'linux', 21:29:23 INFO - 'TMOUT': '86400', 21:29:23 INFO - 'USER': 'cltbld', 21:29:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924', 21:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:29:23 INFO - '_': '/tools/buildbot/bin/python'} 21:29:23 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/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 21:29:23 INFO - mozversion application_buildid: 20161031193403 21:29:23 INFO - mozversion application_changeset: 2c773b97167252cedcba0be0c7af9d4cab192ef5 21:29:23 INFO - mozversion application_display_name: Nightly 21:29:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:29:23 INFO - mozversion application_name: Firefox 21:29:23 INFO - mozversion application_remotingname: firefox 21:29:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:29:23 INFO - mozversion application_vendor: Mozilla 21:29:23 INFO - mozversion application_version: 52.0a1 21:29:23 INFO - mozversion platform_buildid: 20161031193403 21:29:23 INFO - mozversion platform_changeset: 2c773b97167252cedcba0be0c7af9d4cab192ef5 21:29:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:29:23 INFO - mozversion platform_version: 52.0a1 21:29:23 INFO - using testdate: 1477974563 21:29:23 INFO - actual date: 1477974563 21:29:23 INFO - starting webserver on 'localhost:43477' 21:29:23 INFO - SUITE-START | Running 2 tests 21:29:23 INFO - TEST-START | dromaeo_css 21:29:23 INFO - operating with platform_type : linux_ 21:29:23 INFO - Initialising browser for dromaeo_css test... 21:29:23 INFO - TEST-INFO | started process 30600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEMTKYA/profile http://localhost:43477/getInfo.html) 21:29:28 INFO - PROCESS | 30600 | __metrics Screen width/height:1600/1200 21:29:28 INFO - PROCESS | 30600 | colorDepth:24 21:29:28 INFO - PROCESS | 30600 | Browser inner width/height: 1024/697 21:29:28 INFO - PROCESS | 30600 | __metrics 21:29:28 ERROR - PROCESS | 30600 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 21:29:29 INFO - TEST-INFO | 30600: exit 0 21:29:29 INFO - Browser initialized. 21:29:29 INFO - Running cycle 1/1 for dromaeo_css test... 21:29:29 INFO - TEST-INFO | started process 30721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEMTKYA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:29:42 INFO - PROCESS | 30721 | RSS: Main: 186359808 21:29:42 INFO - PROCESS | 30721 | 21:30:31 INFO - PROCESS | 30721 | 1477974631738 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] 21:32:46 INFO - PROCESS | 30721 | Cycle 1(1): loaded http://localhost:43477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43477/tests/dromaeo/cssquery-ext.html) 21:32:47 INFO - PROCESS | 30721 | RSS: Main: 196415488 21:32:47 INFO - PROCESS | 30721 | 21:35:50 INFO - PROCESS | 30721 | Cycle 1(1): loaded http://localhost:43477/tests/dromaeo/cssquery-ext.html (next: http://localhost:43477/tests/dromaeo/cssquery-jquery.html) 21:35:50 INFO - PROCESS | 30721 | RSS: Main: 196784128 21:35:50 INFO - PROCESS | 30721 | 21:38:52 INFO - PROCESS | 30721 | Cycle 1(1): loaded http://localhost:43477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43477/tests/dromaeo/cssquery-mootools.html) 21:38:53 INFO - PROCESS | 30721 | RSS: Main: 198537216 21:38:53 INFO - PROCESS | 30721 | 21:41:55 INFO - PROCESS | 30721 | Cycle 1(1): loaded http://localhost:43477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43477/tests/dromaeo/cssquery-prototype.html) 21:41:56 INFO - PROCESS | 30721 | RSS: Main: 195084288 21:41:56 INFO - PROCESS | 30721 | 21:44:59 INFO - PROCESS | 30721 | Cycle 1(1): loaded http://localhost:43477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43477/tests/dromaeo/cssquery-yui.html) 21:45:00 INFO - PROCESS | 30721 | RSS: Main: 197939200 21:45:00 INFO - PROCESS | 30721 | 21:48:02 INFO - PROCESS | 30721 | Cycle 1(1): loaded http://localhost:43477/tests/dromaeo/cssquery-yui.html (next: http://localhost:43477/tests/dromaeo/cssquery-dojo.html) 21:48:03 INFO - PROCESS | 30721 | RSS: Main: 198623232 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | __start_tp_report 21:48:03 INFO - PROCESS | 30721 | _x_x_mozilla_page_load 21:48:03 INFO - PROCESS | 30721 | _x_x_mozilla_page_load_details 21:48:03 INFO - PROCESS | 30721 | |i|pagename|runs| 21:48:03 INFO - PROCESS | 30721 | |0;dojo.html;2599.545079611068;2609.452015076834;2618.8952441902325;2638.7097419283878;2643.418447941452;4655.231886738684;4680.572425410244;4701.059788042388;4725.102230576188;4768.427788665361;4658.440987081555;4748.97625511872;4781.163296423129;4803.087413391453;4817.590504807095;4331.7834108294455;4423.845165419211;4488.259437192859;4488.842890498833;4538.410006699124;4407.140607581523;4409.80155892984;4438.223310920592;4476.753778542179;4510.458744950594;4309.913801723948;4357.346398040319;4363.847265345697;4406.53731358206;4452.265376212921;4383.956160438387;4411.117776444724;4412.095520418338;4413.5365786592265;4416.094700586372;4349.760763158025;4384.693071484998;4385.868423947255;4389.736615803062;4390.604845563915;4695.248760198386;4725.5510726480925;4725.76371181443;4732.219183834663;4752.382190315271;5088.363954505687;5090.440051594322;5095.8980820383385;5112.923306150411;5129.358830146231;5111.872203194913;5124.92312615311;5140.588752899759;5145.897082058338;5164.6384753067305;4601.838935637236;4625.259958406638;4665.626749860071;4745.335653008581;4757.714537127784;5187.403448603383;5191.662541934762;5193.402758682724;5195.3246078009615;5196.636235463557;4966.404031516241;4966.602671786249;5011.047900898818;5019.723915184627;5083.74581270935;4860.149473842063;5079.720615366116;5102.8214012510125;5107.080725469377;5114.079465696211;4925.704457732548;4990.351254336913;5022.221555658879;5058.392992840809;5071.366079240095;4856.587190088882;4917.237828136645;5021.974890125526;5029.1450453423;5036.924446133311;4278.080212754273;4297.634701050446;4309.353596960418;4314.654827613784;4374;3724.8137593120778;3727.2731817295908;3746.5316835395574;3771.4719939208535;3779.149691319431;4302.053548219386;4338.219120558329;4356.215881141362;4360.520342762294;4441.311596702451;4958.9008219835405;4990.6506544541535;5008.449070602231;5053.343065401475;5104.846854594368;4266.722663026893;4280.914381712349;4281.186574550888;4301.763403012802;4333.046729719456;4511.706739062016;4536.296873984537;4548.4541854977615;4550.522195169526;4603.102395033004;4681.7190968542;4724.598409135262;4739.644526660583;4753.358296629911;4780.043991201704;5071.2139618359215;5090.847274581768;5097.362829646294;5111.87220319495;5135.7432128394175;4795.256735206049;4807.158747219292;4807.254875494304;4807.4471435785335;4811.158047341772;4916.139675556835;4976.477469865757;4982.252662100714;5024.773885175103;5083.5678967288195;5129.384473863161;5130.820421285237;5136.049830781318;5180.456052114474;5205.791768329224;4858.028394321221;4961.627877909244;4975.975120124376;4997.350344455198;5018.949810501848;4908.484609115992;4941.33292005589;4947.1589829729755;4992.226204938241;5047.722375269395;4907.2393778964315;4916.852494425173;4917.532834380728;4922.310876477368;4979.626528010342;4986.401631804061;4999.325091112653;5020.42265139499;5029.27075574047;5103.642745007814;4754.286856971482;4816.771723210559;4821.156297647968;4845.345878306524;4876.195427754523 21:48:03 INFO - PROCESS | 30721 | |1;ext.html;548.6790227716785;549.9615026948113;552.3206456059047;564.7402194990304;570.940051294614;38670.41994370083;40905;41048.79475602622;44088.338674919825;44126.55873441265;41889.79055104728;42297;42381;42447.151056978844;42452.15095698084;7795.727149549767;7884.960575197116;7928.8810667840025;7951.40364472664;7956.721514746985;7875.724349647735;7923.484973476734;7935.880961785578;7949.602519874012;7953.164917683646;7989.680412783511;8024.759257222293;8032.638531266078;8033.598320084002;8036.27673509384;7918.485298455611;7957.7612671619945;7973;7975.561344126071;7987.400944929153;7782;7819.569923654197;7831.804204894866;7839.412044096659;7846.686132554691;38413.423798643045;38800.417993730116;38817;38827.41758873619;38853.41719874204;3146.2134466383404;3386.187315044396;3616.5117709109195;3626.2747450510005;3721.1255354991554;28682.856585717145;28776;29373.26566835825;29430.852845735633;29530;3317.402867483852;3355.832208389571;3393.8472768725464;3408.301298233856;3464.566929133858;239021;239213;239806;240913;242269.99999999822;53755;54163;54167.72916135394;54271.58790387496;54321.72839135858;56712.43287567154;56820.71589642108;56920.715396423584;57029.42970570241;57218.42781572131;15018.324175412132;15328.156951367782;15349.693006140038;15368.385264589291;15371.92314038445;11482.655520334403;11486.310821350746;11497.310161390344;11501.309921404743;11509.942450287863;16038.919805400898;17102.57243568896;17170.828291717175;17171.31314747421;17267.74098388525;6177.413145751147;6465.191851018622;6556.8360790980605;6576.421658801949;6584.572002819801;793.305857374797;796.4186144114828;915.4278575890069;950.5816843989152;1020.0921180149672;26397;27496.450070998468;28501.144965651063;28517.71482285192;28553.428931421255;957.1433566957674;973.7030205787162;974.5614473486959;1017.2878984710732;1031.6234574380446;14331.211783351808;14835.406583736529;14869.702605947821;14913.387633360075;14968.401263949538;351336;353507;353954;354755;354928.2253588767;48893.51106488961;50025.49974500281;50146.24780628293;50161.49838501641;50182.49817501851;1154.936478493674;1189.8215267709913;1211.0614273937592;1213.9817902731465;1219.4207751318054;26065.869670651526;26915.461690765682;27177.1846844595;27540;27642.308942276602;41722;42010.1597968045;42061;42241;42312.6728029949;324197;325802;325879;325900;326469;24206.75793242045;25112.62331064999;25205.74794252034;25351.61972570376;26940.865295673397;40647.71579694739;40884;41049.589504105774;42088.158236835705;42775.57224427716;35789.1052723684;36183.27633447369;36212.050023491654;36214.4567831488;36734.44898326581;36061.63938360583;36318.45522317114;36503.817480912425;36506;37144.628553714116;30902.53646195264;31629;35278.647213528566;35593;36408.08979775527;27656;32338.83830580832;33498.162545936546;33665.15837104092;33684.83157584196;25292.367690807878;25839.354016149748;25893.74106258989;26153.215403537924;26272 21:48:03 INFO - PROCESS | 30721 | |2;jquery.html;363.43485879457467;370.86463440844096;378.10389377176097;388.0337958483377;396.90275882408815;15694.450694225705;16940.66118677626;17523.73714394285;17546;17574.384896528623;16489.257983390748;16620.916895415536;16834.24245908934;16952.880889888766;16969;4970.726610036456;5281;5281.419043905167;5283.233931079991;5286.682799032071;5149.819756308511;5182.54888631182;5424.430434804348;5464.289642346489;5531.889362212753;5508.641938274;5519.39286678465;5519.889602207953;5521.3926468088475;5526.668399895999;5330.840074797743;5503.064479038573;5509.393966663663;5520.723963801794;5560.972195139039;5297.523222909918;5376.059189641797;5391.218273350381;5406.972965135149;5415.810446634388;20261.8986905066;20501.692474612893;20583.279585214594;20673.276435324842;20831.791682083287;1799.4151900632346;1902.1820617134626;2146.5921474919714;2322.7561106083785;2413.03478608558;8951.865722014176;8980.19178273952;9059.773505662346;9491.19324857381;9499.38254013487;1655.2551351891698;1695.635438380754;1731.437282883068;1749.2827940544444;1787.7229029500447;66985;67965;68449;68794.31205687879;69916.6504167481;9948.35335703177;10085.747856303504;10110.24173187014;10244.899795541896;10264.64073757415;13615.31923403826;13665.795013074812;13693.178409295475;13709.794353084711;13716.931415342859;7429.182789893108;7486.812829679193;7552.546847189186;7626.42801789868;7699.923000769921;7089.14930208368;7161.67772450241;7237.131544214622;7349.926500734924;7456.32893039629;4304.397384366192;4306.978465107717;4315.115401342718;4327.6105150536605;4416.3596278539435;1504.8194216693848;1575.4170956746077;1605.9518214453585;1776.9515985568576;1888.3296429767508;836.2431999040878;845.5349557743217;861.6467248428114;871.8692196170625;892.3173772064376;16146.596335091717;16557.503274901774;16627.750583741254;16688.916555417145;17011;854.2098558833054;861.345377513082;877.8507653698758;904.6471875968377;906.7914379692708;9488.810223795623;9493.240540756722;9552.14030737237;9554.713358599252;9714.319997600242;385945;395579;400954;407514;407681.15507294174;73957;75932.62033689907;76287.61856190684;77446.22553774503;78546.21453785503;895.3642913531336;900.504722402676;934.2946075712929;935.4901578639658;940.2149205413419;14918;14948.936359987893;14958.925205373904;15086.698266034398;15520.1463919481;33864.83067584646;35668.46497302491;35711.46432803458;36199.81900090483;36955;49357;49805.25292120549;49825;49848.52575062321;50484.49515504798;4371.147626212858;4622.86131416058;5609.49514543693;6390.505420918434;6399.520035997412;9893.35693179941;10786.73033174177;10885.401302928414;11105.333679979227;11497.82753258685;9532.95233523828;9566;9616.182624476718;9970.900290996997;10152.03555662211;8983.685571004984;9497.192738617296;9646.710598682052;9653.71151245137;9724.95137524308;9632.807343853225;9805.901940980784;9907.64647467726;9954;10022.849657255292;6063.757449701962;6614.239362473377;6790.72837086511;6809.285025072494;6819.2498825128205;9450.243980481408;9610.567524461276;9701.70894873155;10133.949330253301;10191.133753630727 21:48:03 INFO - PROCESS | 30721 | |3;mootools.html;1300.1938797945274;1360.8366995960487;1389.8957578181632;1550.8371620979797;1570.7957965464489;6060.363661815512;6236.501079913607;6691.531592788507;7173.641317934102;7176.354128128474;6659.267480577145;6927.168739751237;6928.307169283069;7112.3954463870505;7137.500374973754;2114.3656902929097;2150.4516348331153;2152.3973287479453;2154.6121698094335;2155.073318473056;2093.267356425254;2130.1585873579925;2133.4666333416644;2164.091081745663;2174.6194415977143;2047.7337946067064;2058.1355830551206;2082.5938941906334;2087.8225350845196;2106.536561956367;2058.8249998750125;2065.33740339027;2076.9896150519303;2079.386580958606;2084.6143463459234;2026.847986401011;2103.14822496889;2105.210546045233;2117.6400011998;2121.2575598540543;6962.408195303406;7006.894896576556;7013;7013.859722805515;7027.82430439238;4146.1914926589325;4264.701470897038;4307.590778876001;4312.28847240205;4323.4163387942535;2797.692253852075;2897.768178545711;2912.039027121045;2951.4687356275863;2962.3927094945484;904.2675432899373;912.4588022357768;917.6833992272656;928.2295694573488;945.3713280668347;9032.05163457834;9101.36290459668;9142;9183.770405739842;9184.265258779214;3615.439606860941;3621.492990981265;3753.680937120321;3761.962380376216;3774.169682669808;7034.2262351141335;7055;7072.858542829217;7096.290370962863;7154.570725756471;4143.19207754491;4144.378343248537;4146.419501269825;4153.169366126726;4183.644390226865;3528.788272703646;3641.16253261746;3736.4208547675153;3826.1964987352967;3881.340172170738;3087.243625311768;3138.168385377877;3218.2598002459567;3232.078857525594;3249.1227368610816;1003.0671475527683;1005.4721271332609;1010.9747256318503;1023.2070145637191;1034.2863424237253;848.9320854331638;849.8810166576684;865.9393842431095;867.2541614211773;889.0265159650173;4904.877378065506;4923.630727695438;4966.925496117561;4972.229304457815;5068.239764035424;795.9681612735542;867.1285358214953;869.5826003518221;870.8388948044632;888.9866652000096;3352.7988320700347;3355.0773537277446;3374.2407958209697;3482.5472688550326;3551.6803487686234;8008.839823203503;8472.152784721602;8478.660853565912;8481.024682161631;8494.53280069602;8264.628091735887;8369.665213391518;8438.324934005264;8441.620127094295;8463.788405289793;6445.774397896051;6450.5484616077365;6545.705443255065;6594.505412094112;6610.900836487456;4879.146149423766;4896.461389247252;4899.975500122477;4915.655904086822;5119.948800512097;7571.659275332733;7677.884831727641;7686.500377475446;7727.072751269883;7734.342580880688;7653.425993050432;7769.339606133542;7849;7873.488223265469;7982.84034319322;5287.68273903567;5749.425057494217;5863.2670916135485;5891.646501209942;5919.6744179070565;5988.431099045583;6014.097885317237;6120.60216085953;6152.661603611844;6233.844153896189;5680;5701.572382071444;5717.628354156966;5744.798932037359;5754.53963682896;5578.525825304894;5594;5609.4390560943575;5624.493795558419;5654.575906806924;5469.234307196916;5487.64330318528;5515.889682206413;5532.806351777829;5552.333719953632;3944.211157768515;3975.900602484961;3995.9600403995587;4060.9796951015055;4095.2833254180996;4091.243120022805;4117.341225403921;4144.233316836395;4208.621224089847;4262.829486820492 21:48:03 INFO - PROCESS | 30721 | |4;prototype.html;288.46201833580375;292.5261077055171;297.63688300273657;299.9310158663508;301.24688279301745;4879.780409881555;4952.554270115689;5009.924851127232;5017.473165317635;5063.291139240509;4923.286123512089;4966.602671786258;4987.600991920646;4989.975050124754;5056.671316364443;3640.9271814563695;3675;3776.6412190841825;3866.613338666139;3876.6511014008734;3762.3415902217002;3842.9615703843024;3843.252074766541;3845.2309538092354;3864.072622570577;3811.7712937223855;3813.6186381361917;3814.6948244140403;3815.7598780396343;3828.7365169494;3824.9426258606145;3839.1361943562756;3843.9807800960957;3844.3656796628525;3864.8840534784003;3154.463741164008;3302.768806183568;3303.9504407433906;3308.4871844864083;3333.3499967506345;4836.395450568679;4837.637177211688;4838.564529192389;4839.370881785346;4875.414950205998;4304.117655880568;4333.978330108361;4342.261815491374;4363.2800587903275;4404.361367601712;4859.732714700725;5097.3118628984985;5139.794408223666;5216.7913283468615;5218.739063046833;3581;3585.6195364784485;3586.497890295361;3601.729870259741;3602.783832970004;5417.322834645669;5420.457954204588;5429.421025013126;5485.286912701324;5496.422875598045;3597.460380942827;3637.3452778499595;3688.114852435396;3690.391085470921;3714.201446688975;3685.760425572329;3691.1325838427947;3711.573169085536;3735.7198210134347;3746.9437958430644;4257.936130958038;4266.189424009428;4295.140971805651;4324.113556720865;4326.134773045404;5151.124308867502;5154.974225128851;5182.404023537341;5192;5211.713355765393;1229.432473596172;1276.7255040166408;1279.5457612547598;1284.5677070066995;1287.523616261989;787.8733411221893;790.9446338756347;812.7683610171191;812.8496228197803;816.9673213071529;3997.7801220932547;4023.617756313204;4313.719608225455;4372.322290044985;4438.578335058164;5285.630005899627;5296.523312901857;5309.7345132743985;5345.893082138336;5360.624756267024;4512.390827238347;4518.118966801442;4554.726716397026;4557.316402539579;4564.680472366969;2769.6814866290633;2836.1491552534158;2845.374017716099;2864.854058376666;2875.7555607773156;5020.648554601143;5030.522100400456;5039.546440820343;5040.672356296829;5047.318611987334;5425.403205647375;5441.6190866639745;5454.10007348783;5489.313835770528;5512.57011843334;4783.617310615143;4984.526469985346;5007.923296491272;5027.315849190489;5039.79840806371;5351.224072509543;5364.597655175956;5386.461353864739;5402.594805389533;5419.187121931742;5013.523715247045;5223.947760522498;5250.737463126905;5252.501012403815;5253.579713622978;5060.418051924076;5071.290019397361;5085.64400491962;5115.2071428928575;5121.206213036985;3721.423179407196;3749;3752.399616061526;3753.155540003477;3757.755745876509;5183.663061900965;5473.397926228191;5473.715770537805;5476.151196564539;5496.7526461308535;5234.39804422481;5250.789968401374;5260.9736951315;5264.6314757966575;5277.525022747971;5252.894942101213;5260.316158899319;5289.307421625043;5312.9468705314;5337.973310133424;4840.515948405131;5123.692578445305;5189.844304670715;5193.584513239008;5217.191335343028;5113.258577506315;5262.42113367537;5264.78940842362;5265.341832270966;5295.920561191662;5152.913070206572;5167.457416971314;5178.326817513699;5196.506331898464;5234.921476177784 21:48:03 INFO - PROCESS | 30721 | |5;yui.html;658.2298710508704;751.8721817291062;764.8240904591944;766.455816370377;782.7064850680995;11473.311601303927;11995.820062699066;12297.754044919096;12315.507379704823;12414.441350139243;12735.108542402013;12799.680007999781;12810.487580496792;12864.421101050451;12943.288119153443;775.7129861951086;791.9247671471215;808.6563210635486;810.6190090657382;813.3411936331561;799.1808396393685;807.6527093349857;812.155358427235;813.446856137829;816.6733306677318;862.3015357560365;864.3301441382947;865.7489328094845;865.9177378149097;867.4621734524603;852.6078004118144;856.199453510963;857.2156476823699;861.5132450165636;862.9309655227598;623.554158776477;624.1137584629837;624.8750249950028;626.8996960486301;628.0359647940435;12585.181963172365;13125.40935657888;13211.14127581704;13248.873845723125;13303.600891973256;13050.412731427108;13072;13196.274204918725;13230.66923326915;13329.466821327136;10123.493825308778;10184.694459166238;10295.536700848479;10346.12057975073;10427.895721042843;3310.702036816698;3352.3127758809387;3366.074329559366;3436.862525498977;3490.8254587270535;53792;54171;54432;54691.45308546903;55532.16701749477;10058.949705251427;10146.033836743369;10255.58977640886;10372.585096596202;10421.270511064153;19368.225270989;19438;19442.708359374337;19553.315633952745;19694.21223151058;6734.831629209309;6737.427318677869;6743.5953842769595;6829.863402732017;6880.380765731008;3469.120629877196;3574.1550419876817;3623.8006909620226;3625.2568223514118;3676.117731744362;2742.506348857225;2799.2861820236117;2817.5914492398488;2837.744602985741;2840.4035152617766;473.9881502962385;475.38437723148604;476.604418332783;485.56056768623745;485.58239913674214;589.9144624029492;605.1873198847245;611.257322353334;643.6106155775689;663.4360793325635;8270;8281.751547453587;8413.495190288602;8487.10885357041;8496.320294376435;589.8112603966775;595.8946154882717;634.7873462390058;645.1548471502347;657.8519833037528;4011.338129208706;4041.8989525261513;4097.44684467599;4162.9791851041155;4218.135282267128;69477.65261173662;71992;72538.27461725421;76140.23859761443;76340;50170;50478.24282635764;50787;57942.71028644914;58162;34222.82888585541;40887.38668919969;45575.54424455713;53136;53493.46506534885;8548.74353769388;9098.31762617793;9115.544222788967;9137.451752894847;9226.123518265755;30568.08295751131;31756.6824331763;37576.81211593925;38899.6110038896;39337.606623933396;45255.77372113118;49518;49697.75151124366;50779.49220507748;51423.0863450693;10334.276600637882;11016.669499915015;11042.558297668325;11141.498632561392;11198.272112312674;10762;10956.506957186786;11365.261258018203;11740;12087.818682719942;11338.716532086764;11608.709782255512;11671.183017188716;11694.239874408137;11896.345700986529;11028.503717332578;11126.221164518729;11168.441577921234;12005.579804706793;12014.459349329127;10957.342559446459;11602.419879005847;11699.590514331958;11848.28910265387;11873.228240164708;9669.323147379617;9866.408015519091;9981.500924953869;10158.949205254223;10633.787324253317;10315.48422578883;10375;10461.529231184768;10524.421156836448;10599.841002385125 21:48:03 INFO - PROCESS | 30721 | __end_tp_report 21:48:03 INFO - PROCESS | 30721 | __start_cc_report 21:48:03 INFO - PROCESS | 30721 | _x_x_mozilla_cycle_collect,358 21:48:03 INFO - PROCESS | 30721 | __end_cc_report 21:48:03 INFO - PROCESS | 30721 | __startTimestamp1477975683168__endTimestamp 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | ------- Summary: start ------- 21:48:03 INFO - PROCESS | 30721 | Number of tests: 6 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | [#0] dojo.html Cycles:165 Average:4692.15 Median:4807.25 stddev:494.86 (10.3%) stddev-sans-first:468.36 21:48:03 INFO - PROCESS | 30721 | Values: 2599.5 2609.5 2618.9 2638.7 2643.4 4655.2 4680.6 4701.1 4725.1 4768.4 4658.4 4749.0 4781.2 4803.1 4817.6 4331.8 4423.8 4488.3 4488.8 4538.4 4407.1 4409.8 4438.2 4476.8 4510.5 4309.9 4357.3 4363.8 4406.5 4452.3 4384.0 4411.1 4412.1 4413.5 4416.1 4349.8 4384.7 4385.9 4389.7 4390.6 4695.2 4725.6 4725.8 4732.2 4752.4 5088.4 5090.4 5095.9 5112.9 5129.4 5111.9 5124.9 5140.6 5145.9 5164.6 4601.8 4625.3 4665.6 4745.3 4757.7 5187.4 5191.7 5193.4 5195.3 5196.6 4966.4 4966.6 5011.0 5019.7 5083.7 4860.1 5079.7 5102.8 5107.1 5114.1 4925.7 4990.4 5022.2 5058.4 5071.4 4856.6 4917.2 5022.0 5029.1 5036.9 4278.1 4297.6 4309.4 4314.7 4374.0 3724.8 3727.3 3746.5 3771.5 3779.1 4302.1 4338.2 4356.2 4360.5 4441.3 4958.9 4990.7 5008.4 5053.3 5104.8 4266.7 4280.9 4281.2 4301.8 4333.0 4511.7 4536.3 4548.5 4550.5 4603.1 4681.7 4724.6 4739.6 4753.4 4780.0 5071.2 5090.8 5097.4 5111.9 5135.7 4795.3 4807.2 4807.3 4807.4 4811.2 4916.1 4976.5 4982.3 5024.8 5083.6 5129.4 5130.8 5136.0 5180.5 5205.8 4858.0 4961.6 4976.0 4997.4 5018.9 4908.5 4941.3 4947.2 4992.2 5047.7 4907.2 4916.9 4917.5 4922.3 4979.6 4986.4 4999.3 5020.4 5029.3 5103.6 4754.3 4816.8 4821.2 4845.3 4876.2 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | [#1] ext.html Cycles:180 Average:46564.06 Median:19972.36 stddev:81498.20 (408.1%) stddev-sans-first:81653.59 21:48:03 INFO - PROCESS | 30721 | Values: 548.7 550.0 552.3 564.7 570.9 38670.4 40905.0 41048.8 44088.3 44126.6 41889.8 42297.0 42381.0 42447.2 42452.2 7795.7 7885.0 7928.9 7951.4 7956.7 7875.7 7923.5 7935.9 7949.6 7953.2 7989.7 8024.8 8032.6 8033.6 8036.3 7918.5 7957.8 7973.0 7975.6 7987.4 7782.0 7819.6 7831.8 7839.4 7846.7 38413.4 38800.4 38817.0 38827.4 38853.4 3146.2 3386.2 3616.5 3626.3 3721.1 28682.9 28776.0 29373.3 29430.9 29530.0 3317.4 3355.8 3393.8 3408.3 3464.6 239021.0 239213.0 239806.0 240913.0 242270.0 53755.0 54163.0 54167.7 54271.6 54321.7 56712.4 56820.7 56920.7 57029.4 57218.4 15018.3 15328.2 15349.7 15368.4 15371.9 11482.7 11486.3 11497.3 11501.3 11509.9 16038.9 17102.6 17170.8 17171.3 17267.7 6177.4 6465.2 6556.8 6576.4 6584.6 793.3 796.4 915.4 950.6 1020.1 26397.0 27496.5 28501.1 28517.7 28553.4 957.1 973.7 974.6 1017.3 1031.6 14331.2 14835.4 14869.7 14913.4 14968.4 351336.0 353507.0 353954.0 354755.0 354928.2 48893.5 50025.5 50146.2 50161.5 50182.5 1154.9 1189.8 1211.1 1214.0 1219.4 26065.9 26915.5 27177.2 27540.0 27642.3 41722.0 42010.2 42061.0 42241.0 42312.7 324197.0 325802.0 325879.0 325900.0 326469.0 24206.8 25112.6 25205.7 25351.6 26940.9 40647.7 40884.0 41049.6 42088.2 42775.6 35789.1 36183.3 36212.1 36214.5 36734.4 36061.6 36318.5 36503.8 36506.0 37144.6 30902.5 31629.0 35278.6 35593.0 36408.1 27656.0 32338.8 33498.2 33665.2 33684.8 25292.4 25839.4 25893.7 26153.2 26272.0 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | [#2] jquery.html Cycles:180 Average:24309.36 Median:5292.10 stddev:65912.62 (1245.5%) stddev-sans-first:66073.00 21:48:03 INFO - PROCESS | 30721 | Values: 363.4 370.9 378.1 388.0 396.9 15694.5 16940.7 17523.7 17546.0 17574.4 16489.3 16620.9 16834.2 16952.9 16969.0 4970.7 5281.0 5281.4 5283.2 5286.7 5149.8 5182.5 5424.4 5464.3 5531.9 5508.6 5519.4 5519.9 5521.4 5526.7 5330.8 5503.1 5509.4 5520.7 5561.0 5297.5 5376.1 5391.2 5407.0 5415.8 20261.9 20501.7 20583.3 20673.3 20831.8 1799.4 1902.2 2146.6 2322.8 2413.0 8951.9 8980.2 9059.8 9491.2 9499.4 1655.3 1695.6 1731.4 1749.3 1787.7 66985.0 67965.0 68449.0 68794.3 69916.7 9948.4 10085.7 10110.2 10244.9 10264.6 13615.3 13665.8 13693.2 13709.8 13716.9 7429.2 7486.8 7552.5 7626.4 7699.9 7089.1 7161.7 7237.1 7349.9 7456.3 4304.4 4307.0 4315.1 4327.6 4416.4 1504.8 1575.4 1606.0 1777.0 1888.3 836.2 845.5 861.6 871.9 892.3 16146.6 16557.5 16627.8 16688.9 17011.0 854.2 861.3 877.9 904.6 906.8 9488.8 9493.2 9552.1 9554.7 9714.3 385945.0 395579.0 400954.0 407514.0 407681.2 73957.0 75932.6 76287.6 77446.2 78546.2 895.4 900.5 934.3 935.5 940.2 14918.0 14948.9 14958.9 15086.7 15520.1 33864.8 35668.5 35711.5 36199.8 36955.0 49357.0 49805.3 49825.0 49848.5 50484.5 4371.1 4622.9 5609.5 6390.5 6399.5 9893.4 10786.7 10885.4 11105.3 11497.8 9533.0 9566.0 9616.2 9970.9 10152.0 8983.7 9497.2 9646.7 9653.7 9725.0 9632.8 9805.9 9907.6 9954.0 10022.8 6063.8 6614.2 6790.7 6809.3 6819.2 9450.2 9610.6 9701.7 10133.9 10191.1 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | [#3] mootools.html Cycles:180 Average:4539.42 Median:5378.46 stddev:2398.80 (44.6%) stddev-sans-first:2393.18 21:48:03 INFO - PROCESS | 30721 | Values: 1300.2 1360.8 1389.9 1550.8 1570.8 6060.4 6236.5 6691.5 7173.6 7176.4 6659.3 6927.2 6928.3 7112.4 7137.5 2114.4 2150.5 2152.4 2154.6 2155.1 2093.3 2130.2 2133.5 2164.1 2174.6 2047.7 2058.1 2082.6 2087.8 2106.5 2058.8 2065.3 2077.0 2079.4 2084.6 2026.8 2103.1 2105.2 2117.6 2121.3 6962.4 7006.9 7013.0 7013.9 7027.8 4146.2 4264.7 4307.6 4312.3 4323.4 2797.7 2897.8 2912.0 2951.5 2962.4 904.3 912.5 917.7 928.2 945.4 9032.1 9101.4 9142.0 9183.8 9184.3 3615.4 3621.5 3753.7 3762.0 3774.2 7034.2 7055.0 7072.9 7096.3 7154.6 4143.2 4144.4 4146.4 4153.2 4183.6 3528.8 3641.2 3736.4 3826.2 3881.3 3087.2 3138.2 3218.3 3232.1 3249.1 1003.1 1005.5 1011.0 1023.2 1034.3 848.9 849.9 865.9 867.3 889.0 4904.9 4923.6 4966.9 4972.2 5068.2 796.0 867.1 869.6 870.8 889.0 3352.8 3355.1 3374.2 3482.5 3551.7 8008.8 8472.2 8478.7 8481.0 8494.5 8264.6 8369.7 8438.3 8441.6 8463.8 6445.8 6450.5 6545.7 6594.5 6610.9 4879.1 4896.5 4900.0 4915.7 5119.9 7571.7 7677.9 7686.5 7727.1 7734.3 7653.4 7769.3 7849.0 7873.5 7982.8 5287.7 5749.4 5863.3 5891.6 5919.7 5988.4 6014.1 6120.6 6152.7 6233.8 5680.0 5701.6 5717.6 5744.8 5754.5 5578.5 5594.0 5609.4 5624.5 5654.6 5469.2 5487.6 5515.9 5532.8 5552.3 3944.2 3975.9 3996.0 4061.0 4095.3 4091.2 4117.3 4144.2 4208.6 4262.8 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | [#4] prototype.html Cycles:180 Average:4288.98 Median:4959.58 stddev:1281.14 (25.8%) stddev-sans-first:1249.05 21:48:03 INFO - PROCESS | 30721 | Values: 288.5 292.5 297.6 299.9 301.2 4879.8 4952.6 5009.9 5017.5 5063.3 4923.3 4966.6 4987.6 4990.0 5056.7 3640.9 3675.0 3776.6 3866.6 3876.7 3762.3 3843.0 3843.3 3845.2 3864.1 3811.8 3813.6 3814.7 3815.8 3828.7 3824.9 3839.1 3844.0 3844.4 3864.9 3154.5 3302.8 3304.0 3308.5 3333.3 4836.4 4837.6 4838.6 4839.4 4875.4 4304.1 4334.0 4342.3 4363.3 4404.4 4859.7 5097.3 5139.8 5216.8 5218.7 3581.0 3585.6 3586.5 3601.7 3602.8 5417.3 5420.5 5429.4 5485.3 5496.4 3597.5 3637.3 3688.1 3690.4 3714.2 3685.8 3691.1 3711.6 3735.7 3746.9 4257.9 4266.2 4295.1 4324.1 4326.1 5151.1 5155.0 5182.4 5192.0 5211.7 1229.4 1276.7 1279.5 1284.6 1287.5 787.9 790.9 812.8 812.8 817.0 3997.8 4023.6 4313.7 4372.3 4438.6 5285.6 5296.5 5309.7 5345.9 5360.6 4512.4 4518.1 4554.7 4557.3 4564.7 2769.7 2836.1 2845.4 2864.9 2875.8 5020.6 5030.5 5039.5 5040.7 5047.3 5425.4 5441.6 5454.1 5489.3 5512.6 4783.6 4984.5 5007.9 5027.3 5039.8 5351.2 5364.6 5386.5 5402.6 5419.2 5013.5 5223.9 5250.7 5252.5 5253.6 5060.4 5071.3 5085.6 5115.2 5121.2 3721.4 3749.0 3752.4 3753.2 3757.8 5183.7 5473.4 5473.7 5476.2 5496.8 5234.4 5250.8 5261.0 5264.6 5277.5 5252.9 5260.3 5289.3 5312.9 5338.0 4840.5 5123.7 5189.8 5193.6 5217.2 5113.3 5262.4 5264.8 5265.3 5295.9 5152.9 5167.5 5178.3 5196.5 5234.9 21:48:03 INFO - PROCESS | 30721 | 21:48:03 INFO - PROCESS | 30721 | [#5] yui.html Cycles:180 Average:14585.10 Median:22492.42 stddev:18136.24 (80.6%) stddev-sans-first:18156.96 21:48:03 INFO - PROCESS | 30721 | Values: 658.2 751.9 764.8 766.5 782.7 11473.3 11995.8 12297.8 12315.5 12414.4 12735.1 12799.7 12810.5 12864.4 12943.3 775.7 791.9 808.7 810.6 813.3 799.2 807.7 812.2 813.4 816.7 862.3 864.3 865.7 865.9 867.5 852.6 856.2 857.2 861.5 862.9 623.6 624.1 624.9 626.9 628.0 12585.2 13125.4 13211.1 13248.9 13303.6 13050.4 13072.0 13196.3 13230.7 13329.5 10123.5 10184.7 10295.5 10346.1 10427.9 3310.7 3352.3 3366.1 3436.9 3490.8 53792.0 54171.0 54432.0 54691.5 55532.2 10058.9 10146.0 10255.6 10372.6 10421.3 19368.2 19438.0 19442.7 19553.3 19694.2 6734.8 6737.4 6743.6 6829.9 6880.4 3469.1 3574.2 3623.8 3625.3 3676.1 2742.5 2799.3 2817.6 2837.7 2840.4 474.0 475.4 476.6 485.6 485.6 589.9 605.2 611.3 643.6 663.4 8270.0 8281.8 8413.5 8487.1 8496.3 589.8 595.9 634.8 645.2 657.9 4011.3 4041.9 4097.4 4163.0 4218.1 69477.7 71992.0 72538.3 76140.2 76340.0 50170.0 50478.2 50787.0 57942.7 58162.0 34222.8 40887.4 45575.5 53136.0 53493.5 8548.7 9098.3 9115.5 9137.5 9226.1 30568.1 31756.7 37576.8 38899.6 39337.6 45255.8 49518.0 49697.8 50779.5 51423.1 10334.3 11016.7 11042.6 11141.5 11198.3 10762.0 10956.5 11365.3 11740.0 12087.8 11338.7 11608.7 11671.2 11694.2 11896.3 11028.5 11126.2 11168.4 12005.6 12014.5 10957.3 11602.4 11699.6 11848.3 11873.2 9669.3 9866.4 9981.5 10158.9 10633.8 10315.5 10375.0 10461.5 10524.4 10599.8 21:48:03 INFO - PROCESS | 30721 | -------- Summary: end -------- 21:48:03 INFO - PROCESS | 30721 | 21:48:04 INFO - TEST-INFO | 30721: exit 0 21:48:04 INFO - TEST-OK | dromaeo_css | took 1120747ms 21:48:04 INFO - TEST-START | kraken 21:48:04 INFO - operating with platform_type : linux_ 21:48:04 INFO - Initialising browser for kraken test... 21:48:04 INFO - TEST-INFO | started process 31082 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMaeMxI/profile http://localhost:43477/getInfo.html) 21:48:09 INFO - PROCESS | 31082 | __metrics Screen width/height:1600/1200 21:48:09 INFO - PROCESS | 31082 | colorDepth:24 21:48:09 INFO - PROCESS | 31082 | Browser inner width/height: 1024/697 21:48:09 INFO - PROCESS | 31082 | __metrics 21:48:09 ERROR - PROCESS | 31082 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 21:48:10 INFO - TEST-INFO | 31082: exit 0 21:48:10 INFO - Browser initialized. 21:48:10 INFO - Running cycle 1/1 for kraken test... 21:48:10 INFO - TEST-INFO | started process 31203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMaeMxI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:22 INFO - PROCESS | 31203 | RSS: Main: 187113472 21:48:22 INFO - PROCESS | 31203 | 21:48:25 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43477/tests/kraken/driver.html?testName=audio-beat-detection) 21:48:26 INFO - PROCESS | 31203 | RSS: Main: 199380992 21:48:26 INFO - PROCESS | 31203 | 21:48:29 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43477/tests/kraken/driver.html?testName=audio-dft) 21:48:30 INFO - PROCESS | 31203 | RSS: Main: 197484544 21:48:30 INFO - PROCESS | 31203 | 21:48:33 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43477/tests/kraken/driver.html?testName=audio-fft) 21:48:33 INFO - PROCESS | 31203 | RSS: Main: 194134016 21:48:33 INFO - PROCESS | 31203 | 21:48:36 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43477/tests/kraken/driver.html?testName=audio-oscillator) 21:48:36 INFO - PROCESS | 31203 | RSS: Main: 194506752 21:48:36 INFO - PROCESS | 31203 | 21:48:38 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:48:39 INFO - PROCESS | 31203 | RSS: Main: 195276800 21:48:39 INFO - PROCESS | 31203 | 21:48:42 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43477/tests/kraken/driver.html?testName=imaging-darkroom) 21:48:43 INFO - PROCESS | 31203 | RSS: Main: 195416064 21:48:43 INFO - PROCESS | 31203 | 21:48:46 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43477/tests/kraken/driver.html?testName=imaging-desaturate) 21:48:47 INFO - PROCESS | 31203 | RSS: Main: 193191936 21:48:47 INFO - PROCESS | 31203 | 21:48:50 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43477/tests/kraken/driver.html?testName=json-parse-financial) 21:48:50 INFO - PROCESS | 31203 | RSS: Main: 194719744 21:48:50 INFO - PROCESS | 31203 | 21:48:52 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:48:53 INFO - PROCESS | 31203 | RSS: Main: 194940928 21:48:53 INFO - PROCESS | 31203 | 21:48:55 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:48:55 INFO - PROCESS | 31203 | RSS: Main: 195264512 21:48:55 INFO - PROCESS | 31203 | 21:48:58 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:48:58 INFO - PROCESS | 31203 | RSS: Main: 194908160 21:48:58 INFO - PROCESS | 31203 | 21:49:01 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:49:02 INFO - PROCESS | 31203 | RSS: Main: 195555328 21:49:02 INFO - PROCESS | 31203 | 21:49:05 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:49:05 INFO - PROCESS | 31203 | RSS: Main: 195465216 21:49:05 INFO - PROCESS | 31203 | 21:49:07 INFO - PROCESS | 31203 | Cycle 1(1): loaded http://localhost:43477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43477/tests/kraken/driver.html?testName=ai-astar) 21:49:08 INFO - PROCESS | 31203 | RSS: Main: 197537792 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | __start_tp_report 21:49:08 INFO - PROCESS | 31203 | _x_x_mozilla_page_load 21:49:08 INFO - PROCESS | 31203 | _x_x_mozilla_page_load_details 21:49:08 INFO - PROCESS | 31203 | |i|pagename|runs| 21:49:08 INFO - PROCESS | 31203 | |0;ai-astar;111;118;117;117;119;117;118;118;117;116 21:49:08 INFO - PROCESS | 31203 | |1;audio-beat-detection;161;138;136;181;138;134;139;131;172;133 21:49:08 INFO - PROCESS | 31203 | |2;audio-dft;171;167;163;165;163;164;168;163;163;164 21:49:08 INFO - PROCESS | 31203 | |3;audio-fft;76;76;77;113;76;82;77;76;104;76 21:49:08 INFO - PROCESS | 31203 | |4;audio-oscillator;84;84;114;85;86;83;109;85;83;118 21:49:08 INFO - PROCESS | 31203 | |5;imaging-gaussian-blur;118;119;117;118;120;119;119;117;119;117 21:49:08 INFO - PROCESS | 31203 | |6;imaging-darkroom;148;148;149;148;148;151;147;149;148;148 21:49:08 INFO - PROCESS | 31203 | |7;imaging-desaturate;87;87;86;86;86;86;85;85;86;85 21:49:08 INFO - PROCESS | 31203 | |8;json-parse-financial;64;64;64;63;65;65;66;64;65;70 21:49:08 INFO - PROCESS | 31203 | |9;json-stringify-tinderbox;67;67;67;68;67;67;66;67;67;66 21:49:08 INFO - PROCESS | 31203 | |10;stanford-crypto-aes;84;84;85;86;88;90;90;84;86;84 21:49:08 INFO - PROCESS | 31203 | |11;stanford-crypto-ccm;146;152;144;148;144;143;154;141;187;150 21:49:08 INFO - PROCESS | 31203 | |12;stanford-crypto-pbkdf2;176;175;171;177;181;176;177;175;175;180 21:49:08 INFO - PROCESS | 31203 | |13;stanford-crypto-sha256-iterative;72;74;70;68;69;70;73;69;72;72 21:49:08 INFO - PROCESS | 31203 | __end_tp_report 21:49:08 INFO - PROCESS | 31203 | __start_cc_report 21:49:08 INFO - PROCESS | 31203 | _x_x_mozilla_cycle_collect,877 21:49:08 INFO - PROCESS | 31203 | __end_cc_report 21:49:08 INFO - PROCESS | 31203 | __startTimestamp1477975748055__endTimestamp 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | ------- Summary: start ------- 21:49:08 INFO - PROCESS | 31203 | Number of tests: 14 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#0] ai-astar Cycles:10 Average:116.80 Median:117.50 stddev:2.20 (1.9%) stddev-sans-first:0.88 21:49:08 INFO - PROCESS | 31203 | Values: 111.0 118.0 117.0 117.0 119.0 117.0 118.0 118.0 117.0 116.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:138.50 stddev:18.07 (13.0%) stddev-sans-first:18.37 21:49:08 INFO - PROCESS | 31203 | Values: 161.0 138.0 136.0 181.0 138.0 134.0 139.0 131.0 172.0 133.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:2.73 (1.7%) stddev-sans-first:1.88 21:49:08 INFO - PROCESS | 31203 | Values: 171.0 167.0 163.0 165.0 163.0 164.0 168.0 163.0 163.0 164.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:13.57 (17.9%) stddev-sans-first:14.14 21:49:08 INFO - PROCESS | 31203 | Values: 76.0 76.0 77.0 113.0 76.0 82.0 77.0 76.0 104.0 76.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:84.00 stddev:14.38 (17.1%) stddev-sans-first:14.87 21:49:08 INFO - PROCESS | 31203 | Values: 84.0 84.0 114.0 85.0 86.0 83.0 109.0 85.0 83.0 118.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:119.00 stddev:1.06 (0.9%) stddev-sans-first:1.12 21:49:08 INFO - PROCESS | 31203 | Values: 118.0 119.0 117.0 118.0 120.0 119.0 119.0 117.0 119.0 117.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 21:49:08 INFO - PROCESS | 31203 | Values: 148.0 148.0 149.0 148.0 148.0 151.0 147.0 149.0 148.0 148.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:0.74 (0.9%) stddev-sans-first:0.67 21:49:08 INFO - PROCESS | 31203 | Values: 87.0 87.0 86.0 86.0 86.0 86.0 85.0 85.0 86.0 85.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:1.94 (3.0%) stddev-sans-first:2.03 21:49:08 INFO - PROCESS | 31203 | Values: 64.0 64.0 64.0 63.0 65.0 65.0 66.0 64.0 65.0 70.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 21:49:08 INFO - PROCESS | 31203 | Values: 67.0 67.0 67.0 68.0 67.0 67.0 66.0 67.0 67.0 66.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:2.42 (2.8%) stddev-sans-first:2.45 21:49:08 INFO - PROCESS | 31203 | Values: 84.0 84.0 85.0 86.0 88.0 90.0 90.0 84.0 86.0 84.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:149.00 stddev:13.35 (9.0%) stddev-sans-first:14.04 21:49:08 INFO - PROCESS | 31203 | Values: 146.0 152.0 144.0 148.0 144.0 143.0 154.0 141.0 187.0 150.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.50 stddev:2.79 (1.6%) stddev-sans-first:2.96 21:49:08 INFO - PROCESS | 31203 | Values: 176.0 175.0 171.0 177.0 181.0 176.0 177.0 175.0 175.0 180.0 21:49:08 INFO - PROCESS | 31203 | 21:49:08 INFO - PROCESS | 31203 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:72.00 stddev:1.97 (2.7%) stddev-sans-first:2.05 21:49:08 INFO - PROCESS | 31203 | Values: 72.0 74.0 70.0 68.0 69.0 70.0 73.0 69.0 72.0 72.0 21:49:08 INFO - PROCESS | 31203 | -------- Summary: end -------- 21:49:08 INFO - PROCESS | 31203 | 21:49:09 INFO - TEST-INFO | 31203: exit 0 21:49:09 INFO - TEST-OK | kraken | took 65134ms 21:49:09 INFO - SUITE-END | took 1185s 21:49:09 INFO - Completed test suite (00:19:46) 21:49:09 INFO - javascript benchmark 21:49:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6263.843974581033, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.545079611068, 2609.452015076834, 2618.8952441902325, 2638.7097419283878, 2643.418447941452, 4655.231886738684, 4680.572425410244, 4701.059788042388, 4725.102230576188, 4768.427788665361, 4658.440987081555, 4748.97625511872, 4781.163296423129, 4803.087413391453, 4817.590504807095, 4331.7834108294455, 4423.845165419211, 4488.259437192859, 4488.842890498833, 4538.410006699124, 4407.140607581523, 4409.80155892984, 4438.223310920592, 4476.753778542179, 4510.458744950594, 4309.913801723948, 4357.346398040319, 4363.847265345697, 4406.53731358206, 4452.265376212921, 4383.956160438387, 4411.117776444724, 4412.095520418338, 4413.5365786592265, 4416.094700586372, 4349.760763158025, 4384.693071484998, 4385.868423947255, 4389.736615803062, 4390.604845563915, 4695.248760198386, 4725.5510726480925, 4725.76371181443, 4732.219183834663, 4752.382190315271, 5088.363954505687, 5090.440051594322, 5095.8980820383385, 5112.923306150411, 5129.358830146231, 5111.872203194913, 5124.92312615311, 5140.588752899759, 5145.897082058338, 5164.6384753067305, 4601.838935637236, 4625.259958406638, 4665.626749860071, 4745.335653008581, 4757.714537127784, 5187.403448603383, 5191.662541934762, 5193.402758682724, 5195.3246078009615, 5196.636235463557, 4966.404031516241, 4966.602671786249, 5011.047900898818, 5019.723915184627, 5083.74581270935, 4860.149473842063, 5079.720615366116, 5102.8214012510125, 5107.080725469377, 5114.079465696211, 4925.704457732548, 4990.351254336913, 5022.221555658879, 5058.392992840809, 5071.366079240095, 4856.587190088882, 4917.237828136645, 5021.974890125526, 5029.1450453423, 5036.924446133311, 4278.080212754273, 4297.634701050446, 4309.353596960418, 4314.654827613784, 4374.0, 3724.8137593120778, 3727.2731817295908, 3746.5316835395574, 3771.4719939208535, 3779.149691319431, 4302.053548219386, 4338.219120558329, 4356.215881141362, 4360.520342762294, 4441.311596702451, 4958.9008219835405, 4990.6506544541535, 5008.449070602231, 5053.343065401475, 5104.846854594368, 4266.722663026893, 4280.914381712349, 4281.186574550888, 4301.763403012802, 4333.046729719456, 4511.706739062016, 4536.296873984537, 4548.4541854977615, 4550.522195169526, 4603.102395033004, 4681.7190968542, 4724.598409135262, 4739.644526660583, 4753.358296629911, 4780.043991201704, 5071.2139618359215, 5090.847274581768, 5097.362829646294, 5111.87220319495, 5135.7432128394175, 4795.256735206049, 4807.158747219292, 4807.254875494304, 4807.4471435785335, 4811.158047341772, 4916.139675556835, 4976.477469865757, 4982.252662100714, 5024.773885175103, 5083.5678967288195, 5129.384473863161, 5130.820421285237, 5136.049830781318, 5180.456052114474, 5205.791768329224, 4858.028394321221, 4961.627877909244, 4975.975120124376, 4997.350344455198, 5018.949810501848, 4908.484609115992, 4941.33292005589, 4947.1589829729755, 4992.226204938241, 5047.722375269395, 4907.2393778964315, 4916.852494425173, 4917.532834380728, 4922.310876477368, 4979.626528010342, 4986.401631804061, 4999.325091112653, 5020.42265139499, 5029.27075574047, 5103.642745007814, 4754.286856971482, 4816.771723210559, 4821.156297647968, 4845.345878306524, 4876.195427754523], "value": 4660.092868060199, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6790227716785, 549.9615026948113, 552.3206456059047, 564.7402194990304, 570.940051294614, 38670.41994370083, 40905.0, 41048.79475602622, 44088.338674919825, 44126.55873441265, 41889.79055104728, 42297.0, 42381.0, 42447.151056978844, 42452.15095698084, 7795.727149549767, 7884.960575197116, 7928.8810667840025, 7951.40364472664, 7956.721514746985, 7875.724349647735, 7923.484973476734, 7935.880961785578, 7949.602519874012, 7953.164917683646, 7989.680412783511, 8024.759257222293, 8032.638531266078, 8033.598320084002, 8036.27673509384, 7918.485298455611, 7957.7612671619945, 7973.0, 7975.561344126071, 7987.400944929153, 7782.0, 7819.569923654197, 7831.804204894866, 7839.412044096659, 7846.686132554691, 38413.423798643045, 38800.417993730116, 38817.0, 38827.41758873619, 38853.41719874204, 3146.2134466383404, 3386.187315044396, 3616.5117709109195, 3626.2747450510005, 3721.1255354991554, 28682.856585717145, 28776.0, 29373.26566835825, 29430.852845735633, 29530.0, 3317.402867483852, 3355.832208389571, 3393.8472768725464, 3408.301298233856, 3464.566929133858, 239021.0, 239213.0, 239806.0, 240913.0, 242269.99999999822, 53755.0, 54163.0, 54167.72916135394, 54271.58790387496, 54321.72839135858, 56712.43287567154, 56820.71589642108, 56920.715396423584, 57029.42970570241, 57218.42781572131, 15018.324175412132, 15328.156951367782, 15349.693006140038, 15368.385264589291, 15371.92314038445, 11482.655520334403, 11486.310821350746, 11497.310161390344, 11501.309921404743, 11509.942450287863, 16038.919805400898, 17102.57243568896, 17170.828291717175, 17171.31314747421, 17267.74098388525, 6177.413145751147, 6465.191851018622, 6556.8360790980605, 6576.421658801949, 6584.572002819801, 793.305857374797, 796.4186144114828, 915.4278575890069, 950.5816843989152, 1020.0921180149672, 26397.0, 27496.450070998468, 28501.144965651063, 28517.71482285192, 28553.428931421255, 957.1433566957674, 973.7030205787162, 974.5614473486959, 1017.2878984710732, 1031.6234574380446, 14331.211783351808, 14835.406583736529, 14869.702605947821, 14913.387633360075, 14968.401263949538, 351336.0, 353507.0, 353954.0, 354755.0, 354928.2253588767, 48893.51106488961, 50025.49974500281, 50146.24780628293, 50161.49838501641, 50182.49817501851, 1154.936478493674, 1189.8215267709913, 1211.0614273937592, 1213.9817902731465, 1219.4207751318054, 26065.869670651526, 26915.461690765682, 27177.1846844595, 27540.0, 27642.308942276602, 41722.0, 42010.1597968045, 42061.0, 42241.0, 42312.6728029949, 324197.0, 325802.0, 325879.0, 325900.0, 326469.0, 24206.75793242045, 25112.62331064999, 25205.74794252034, 25351.61972570376, 26940.865295673397, 40647.71579694739, 40884.0, 41049.589504105774, 42088.158236835705, 42775.57224427716, 35789.1052723684, 36183.27633447369, 36212.050023491654, 36214.4567831488, 36734.44898326581, 36061.63938360583, 36318.45522317114, 36503.817480912425, 36506.0, 37144.628553714116, 30902.53646195264, 31629.0, 35278.647213528566, 35593.0, 36408.08979775527, 27656.0, 32338.83830580832, 33498.162545936546, 33665.15837104092, 33684.83157584196, 25292.367690807878, 25839.354016149748, 25893.74106258989, 26153.215403537924, 26272.0], "value": 17584.946694334743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.43485879457467, 370.86463440844096, 378.10389377176097, 388.0337958483377, 396.90275882408815, 15694.450694225705, 16940.66118677626, 17523.73714394285, 17546.0, 17574.384896528623, 16489.257983390748, 16620.916895415536, 16834.24245908934, 16952.880889888766, 16969.0, 4970.726610036456, 5281.0, 5281.419043905167, 5283.233931079991, 5286.682799032071, 5149.819756308511, 5182.54888631182, 5424.430434804348, 5464.289642346489, 5531.889362212753, 5508.641938274, 5519.39286678465, 5519.889602207953, 5521.3926468088475, 5526.668399895999, 5330.840074797743, 5503.064479038573, 5509.393966663663, 5520.723963801794, 5560.972195139039, 5297.523222909918, 5376.059189641797, 5391.218273350381, 5406.972965135149, 5415.810446634388, 20261.8986905066, 20501.692474612893, 20583.279585214594, 20673.276435324842, 20831.791682083287, 1799.4151900632346, 1902.1820617134626, 2146.5921474919714, 2322.7561106083785, 2413.03478608558, 8951.865722014176, 8980.19178273952, 9059.773505662346, 9491.19324857381, 9499.38254013487, 1655.2551351891698, 1695.635438380754, 1731.437282883068, 1749.2827940544444, 1787.7229029500447, 66985.0, 67965.0, 68449.0, 68794.31205687879, 69916.6504167481, 9948.35335703177, 10085.747856303504, 10110.24173187014, 10244.899795541896, 10264.64073757415, 13615.31923403826, 13665.795013074812, 13693.178409295475, 13709.794353084711, 13716.931415342859, 7429.182789893108, 7486.812829679193, 7552.546847189186, 7626.42801789868, 7699.923000769921, 7089.14930208368, 7161.67772450241, 7237.131544214622, 7349.926500734924, 7456.32893039629, 4304.397384366192, 4306.978465107717, 4315.115401342718, 4327.6105150536605, 4416.3596278539435, 1504.8194216693848, 1575.4170956746077, 1605.9518214453585, 1776.9515985568576, 1888.3296429767508, 836.2431999040878, 845.5349557743217, 861.6467248428114, 871.8692196170625, 892.3173772064376, 16146.596335091717, 16557.503274901774, 16627.750583741254, 16688.916555417145, 17011.0, 854.2098558833054, 861.345377513082, 877.8507653698758, 904.6471875968377, 906.7914379692708, 9488.810223795623, 9493.240540756722, 9552.14030737237, 9554.713358599252, 9714.319997600242, 385945.0, 395579.0, 400954.0, 407514.0, 407681.15507294174, 73957.0, 75932.62033689907, 76287.61856190684, 77446.22553774503, 78546.21453785503, 895.3642913531336, 900.504722402676, 934.2946075712929, 935.4901578639658, 940.2149205413419, 14918.0, 14948.936359987893, 14958.925205373904, 15086.698266034398, 15520.1463919481, 33864.83067584646, 35668.46497302491, 35711.46432803458, 36199.81900090483, 36955.0, 49357.0, 49805.25292120549, 49825.0, 49848.52575062321, 50484.49515504798, 4371.147626212858, 4622.86131416058, 5609.49514543693, 6390.505420918434, 6399.520035997412, 9893.35693179941, 10786.73033174177, 10885.401302928414, 11105.333679979227, 11497.82753258685, 9532.95233523828, 9566.0, 9616.182624476718, 9970.900290996997, 10152.03555662211, 8983.685571004984, 9497.192738617296, 9646.710598682052, 9653.71151245137, 9724.95137524308, 9632.807343853225, 9805.901940980784, 9907.64647467726, 9954.0, 10022.849657255292, 6063.757449701962, 6614.239362473377, 6790.72837086511, 6809.285025072494, 6819.2498825128205, 9450.243980481408, 9610.567524461276, 9701.70894873155, 10133.949330253301, 10191.133753630727], "value": 8054.82739806935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.1938797945274, 1360.8366995960487, 1389.8957578181632, 1550.8371620979797, 1570.7957965464489, 6060.363661815512, 6236.501079913607, 6691.531592788507, 7173.641317934102, 7176.354128128474, 6659.267480577145, 6927.168739751237, 6928.307169283069, 7112.3954463870505, 7137.500374973754, 2114.3656902929097, 2150.4516348331153, 2152.3973287479453, 2154.6121698094335, 2155.073318473056, 2093.267356425254, 2130.1585873579925, 2133.4666333416644, 2164.091081745663, 2174.6194415977143, 2047.7337946067064, 2058.1355830551206, 2082.5938941906334, 2087.8225350845196, 2106.536561956367, 2058.8249998750125, 2065.33740339027, 2076.9896150519303, 2079.386580958606, 2084.6143463459234, 2026.847986401011, 2103.14822496889, 2105.210546045233, 2117.6400011998, 2121.2575598540543, 6962.408195303406, 7006.894896576556, 7013.0, 7013.859722805515, 7027.82430439238, 4146.1914926589325, 4264.701470897038, 4307.590778876001, 4312.28847240205, 4323.4163387942535, 2797.692253852075, 2897.768178545711, 2912.039027121045, 2951.4687356275863, 2962.3927094945484, 904.2675432899373, 912.4588022357768, 917.6833992272656, 928.2295694573488, 945.3713280668347, 9032.05163457834, 9101.36290459668, 9142.0, 9183.770405739842, 9184.265258779214, 3615.439606860941, 3621.492990981265, 3753.680937120321, 3761.962380376216, 3774.169682669808, 7034.2262351141335, 7055.0, 7072.858542829217, 7096.290370962863, 7154.570725756471, 4143.19207754491, 4144.378343248537, 4146.419501269825, 4153.169366126726, 4183.644390226865, 3528.788272703646, 3641.16253261746, 3736.4208547675153, 3826.1964987352967, 3881.340172170738, 3087.243625311768, 3138.168385377877, 3218.2598002459567, 3232.078857525594, 3249.1227368610816, 1003.0671475527683, 1005.4721271332609, 1010.9747256318503, 1023.2070145637191, 1034.2863424237253, 848.9320854331638, 849.8810166576684, 865.9393842431095, 867.2541614211773, 889.0265159650173, 4904.877378065506, 4923.630727695438, 4966.925496117561, 4972.229304457815, 5068.239764035424, 795.9681612735542, 867.1285358214953, 869.5826003518221, 870.8388948044632, 888.9866652000096, 3352.7988320700347, 3355.0773537277446, 3374.2407958209697, 3482.5472688550326, 3551.6803487686234, 8008.839823203503, 8472.152784721602, 8478.660853565912, 8481.024682161631, 8494.53280069602, 8264.628091735887, 8369.665213391518, 8438.324934005264, 8441.620127094295, 8463.788405289793, 6445.774397896051, 6450.5484616077365, 6545.705443255065, 6594.505412094112, 6610.900836487456, 4879.146149423766, 4896.461389247252, 4899.975500122477, 4915.655904086822, 5119.948800512097, 7571.659275332733, 7677.884831727641, 7686.500377475446, 7727.072751269883, 7734.342580880688, 7653.425993050432, 7769.339606133542, 7849.0, 7873.488223265469, 7982.84034319322, 5287.68273903567, 5749.425057494217, 5863.2670916135485, 5891.646501209942, 5919.6744179070565, 5988.431099045583, 6014.097885317237, 6120.60216085953, 6152.661603611844, 6233.844153896189, 5680.0, 5701.572382071444, 5717.628354156966, 5744.798932037359, 5754.53963682896, 5578.525825304894, 5594.0, 5609.4390560943575, 5624.493795558419, 5654.575906806924, 5469.234307196916, 5487.64330318528, 5515.889682206413, 5532.806351777829, 5552.333719953632, 3944.211157768515, 3975.900602484961, 3995.9600403995587, 4060.9796951015055, 4095.2833254180996, 4091.243120022805, 4117.341225403921, 4144.233316836395, 4208.621224089847, 4262.829486820492], "value": 3752.3122428019174, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.46201833580375, 292.5261077055171, 297.63688300273657, 299.9310158663508, 301.24688279301745, 4879.780409881555, 4952.554270115689, 5009.924851127232, 5017.473165317635, 5063.291139240509, 4923.286123512089, 4966.602671786258, 4987.600991920646, 4989.975050124754, 5056.671316364443, 3640.9271814563695, 3675.0, 3776.6412190841825, 3866.613338666139, 3876.6511014008734, 3762.3415902217002, 3842.9615703843024, 3843.252074766541, 3845.2309538092354, 3864.072622570577, 3811.7712937223855, 3813.6186381361917, 3814.6948244140403, 3815.7598780396343, 3828.7365169494, 3824.9426258606145, 3839.1361943562756, 3843.9807800960957, 3844.3656796628525, 3864.8840534784003, 3154.463741164008, 3302.768806183568, 3303.9504407433906, 3308.4871844864083, 3333.3499967506345, 4836.395450568679, 4837.637177211688, 4838.564529192389, 4839.370881785346, 4875.414950205998, 4304.117655880568, 4333.978330108361, 4342.261815491374, 4363.2800587903275, 4404.361367601712, 4859.732714700725, 5097.3118628984985, 5139.794408223666, 5216.7913283468615, 5218.739063046833, 3581.0, 3585.6195364784485, 3586.497890295361, 3601.729870259741, 3602.783832970004, 5417.322834645669, 5420.457954204588, 5429.421025013126, 5485.286912701324, 5496.422875598045, 3597.460380942827, 3637.3452778499595, 3688.114852435396, 3690.391085470921, 3714.201446688975, 3685.760425572329, 3691.1325838427947, 3711.573169085536, 3735.7198210134347, 3746.9437958430644, 4257.936130958038, 4266.189424009428, 4295.140971805651, 4324.113556720865, 4326.134773045404, 5151.124308867502, 5154.974225128851, 5182.404023537341, 5192.0, 5211.713355765393, 1229.432473596172, 1276.7255040166408, 1279.5457612547598, 1284.5677070066995, 1287.523616261989, 787.8733411221893, 790.9446338756347, 812.7683610171191, 812.8496228197803, 816.9673213071529, 3997.7801220932547, 4023.617756313204, 4313.719608225455, 4372.322290044985, 4438.578335058164, 5285.630005899627, 5296.523312901857, 5309.7345132743985, 5345.893082138336, 5360.624756267024, 4512.390827238347, 4518.118966801442, 4554.726716397026, 4557.316402539579, 4564.680472366969, 2769.6814866290633, 2836.1491552534158, 2845.374017716099, 2864.854058376666, 2875.7555607773156, 5020.648554601143, 5030.522100400456, 5039.546440820343, 5040.672356296829, 5047.318611987334, 5425.403205647375, 5441.6190866639745, 5454.10007348783, 5489.313835770528, 5512.57011843334, 4783.617310615143, 4984.526469985346, 5007.923296491272, 5027.315849190489, 5039.79840806371, 5351.224072509543, 5364.597655175956, 5386.461353864739, 5402.594805389533, 5419.187121931742, 5013.523715247045, 5223.947760522498, 5250.737463126905, 5252.501012403815, 5253.579713622978, 5060.418051924076, 5071.290019397361, 5085.64400491962, 5115.2071428928575, 5121.206213036985, 3721.423179407196, 3749.0, 3752.399616061526, 3753.155540003477, 3757.755745876509, 5183.663061900965, 5473.397926228191, 5473.715770537805, 5476.151196564539, 5496.7526461308535, 5234.39804422481, 5250.789968401374, 5260.9736951315, 5264.6314757966575, 5277.525022747971, 5252.894942101213, 5260.316158899319, 5289.307421625043, 5312.9468705314, 5337.973310133424, 4840.515948405131, 5123.692578445305, 5189.844304670715, 5193.584513239008, 5217.191335343028, 5113.258577506315, 5262.42113367537, 5264.78940842362, 5265.341832270966, 5295.920561191662, 5152.913070206572, 5167.457416971314, 5178.326817513699, 5196.506331898464, 5234.921476177784], "value": 3873.365260833166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.2298710508704, 751.8721817291062, 764.8240904591944, 766.455816370377, 782.7064850680995, 11473.311601303927, 11995.820062699066, 12297.754044919096, 12315.507379704823, 12414.441350139243, 12735.108542402013, 12799.680007999781, 12810.487580496792, 12864.421101050451, 12943.288119153443, 775.7129861951086, 791.9247671471215, 808.6563210635486, 810.6190090657382, 813.3411936331561, 799.1808396393685, 807.6527093349857, 812.155358427235, 813.446856137829, 816.6733306677318, 862.3015357560365, 864.3301441382947, 865.7489328094845, 865.9177378149097, 867.4621734524603, 852.6078004118144, 856.199453510963, 857.2156476823699, 861.5132450165636, 862.9309655227598, 623.554158776477, 624.1137584629837, 624.8750249950028, 626.8996960486301, 628.0359647940435, 12585.181963172365, 13125.40935657888, 13211.14127581704, 13248.873845723125, 13303.600891973256, 13050.412731427108, 13072.0, 13196.274204918725, 13230.66923326915, 13329.466821327136, 10123.493825308778, 10184.694459166238, 10295.536700848479, 10346.12057975073, 10427.895721042843, 3310.702036816698, 3352.3127758809387, 3366.074329559366, 3436.862525498977, 3490.8254587270535, 53792.0, 54171.0, 54432.0, 54691.45308546903, 55532.16701749477, 10058.949705251427, 10146.033836743369, 10255.58977640886, 10372.585096596202, 10421.270511064153, 19368.225270989, 19438.0, 19442.708359374337, 19553.315633952745, 19694.21223151058, 6734.831629209309, 6737.427318677869, 6743.5953842769595, 6829.863402732017, 6880.380765731008, 3469.120629877196, 3574.1550419876817, 3623.8006909620226, 3625.2568223514118, 3676.117731744362, 2742.506348857225, 2799.2861820236117, 2817.5914492398488, 2837.744602985741, 2840.4035152617766, 473.9881502962385, 475.38437723148604, 476.604418332783, 485.56056768623745, 485.58239913674214, 589.9144624029492, 605.1873198847245, 611.257322353334, 643.6106155775689, 663.4360793325635, 8270.0, 8281.751547453587, 8413.495190288602, 8487.10885357041, 8496.320294376435, 589.8112603966775, 595.8946154882717, 634.7873462390058, 645.1548471502347, 657.8519833037528, 4011.338129208706, 4041.8989525261513, 4097.44684467599, 4162.9791851041155, 4218.135282267128, 69477.65261173662, 71992.0, 72538.27461725421, 76140.23859761443, 76340.0, 50170.0, 50478.24282635764, 50787.0, 57942.71028644914, 58162.0, 34222.82888585541, 40887.38668919969, 45575.54424455713, 53136.0, 53493.46506534885, 8548.74353769388, 9098.31762617793, 9115.544222788967, 9137.451752894847, 9226.123518265755, 30568.08295751131, 31756.6824331763, 37576.81211593925, 38899.6110038896, 39337.606623933396, 45255.77372113118, 49518.0, 49697.75151124366, 50779.49220507748, 51423.0863450693, 10334.276600637882, 11016.669499915015, 11042.558297668325, 11141.498632561392, 11198.272112312674, 10762.0, 10956.506957186786, 11365.261258018203, 11740.0, 12087.818682719942, 11338.716532086764, 11608.709782255512, 11671.183017188716, 11694.239874408137, 11896.345700986529, 11028.503717332578, 11126.221164518729, 11168.441577921234, 12005.579804706793, 12014.459349329127, 10957.342559446459, 11602.419879005847, 11699.590514331958, 11848.28910265387, 11873.228240164708, 9669.323147379617, 9866.408015519091, 9981.500924953869, 10158.949205254223, 10633.787324253317, 10315.48422578883, 10375.0, 10461.529231184768, 10524.421156836448, 10599.841002385125], "value": 6295.2597739252615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 118.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 138.0, 136.0, 181.0, 138.0, 134.0, 139.0, 131.0, 172.0, 133.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 163.0, 165.0, 163.0, 164.0, 168.0, 163.0, 163.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 113.0, 76.0, 82.0, 77.0, 76.0, 104.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 85.0, 86.0, 83.0, 109.0, 85.0, 83.0, 118.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 118.0, 120.0, 119.0, 119.0, 117.0, 119.0, 117.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 148.0, 151.0, 147.0, 149.0, 148.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 86.0, 86.0, 85.0, 85.0, 86.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 65.0, 66.0, 64.0, 65.0, 70.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 86.0, 88.0, 90.0, 90.0, 84.0, 86.0, 84.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 152.0, 144.0, 148.0, 144.0, 143.0, 154.0, 141.0, 187.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 171.0, 177.0, 181.0, 176.0, 177.0, 175.0, 175.0, 180.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 70.0, 68.0, 69.0, 70.0, 73.0, 69.0, 72.0, 72.0], "value": 70.9, "unit": "score"}]}]} 21:49:09 INFO - Return code: 0 21:49:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:49:09 ERROR - # TBPL SUCCESS # 21:49:09 INFO - Running post-action listener: _resource_record_post_action 21:49:09 INFO - [mozharness: 2016-11-01 04:49:09.855067Z] Finished run-tests step (success) 21:49:09 INFO - Running post-run listener: _resource_record_post_run 21:49:09 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 399343616; Read time: 0; Write time: 286940 21:49:09 INFO - TinderboxPrint: CPU usage
13.4% 21:49:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:49:09 INFO - TinderboxPrint: I/O write bytes / time
399,343,616 / 286,940 21:49:09 INFO - TinderboxPrint: CPU idle
8,298.9 (86.6%) 21:49:09 INFO - TinderboxPrint: CPU user
1,224.1 (12.8%) 21:49:09 INFO - TinderboxPrint: Swap in / out
0 / 0 21:49:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106352640; Read time: 0; Write time: 76160 21:49:09 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292081664; Read time: 0; Write time: 210760 21:49:10 INFO - Running post-run listener: _upload_blobber_files 21:49:10 INFO - Blob upload gear active. 21:49:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:49:10 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 21:49:10 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'] 21:49:10 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 21:49:10 INFO - (blobuploader) - INFO - Open directory for files ... 21:49:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:49:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:49:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:14 INFO - (blobuploader) - INFO - Done attempting. 21:49:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:49:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:49:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:15 INFO - (blobuploader) - INFO - Done attempting. 21:49:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:49:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:49:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:49:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:49:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:49:16 INFO - (blobuploader) - INFO - Done attempting. 21:49:16 INFO - (blobuploader) - INFO - Iteration through files over. 21:49:16 INFO - Return code: 0 21:49:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:49:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:49:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fbc9e23d2662c4a14151003cbc6e7dbdc5ad9a4fa199ab25c71f29999bec9f692508eb0c205065d6f5d45c870f0052ab0c027a06dfa17f12485f63b0127766d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d41a5d9e11fe045f57866869d4020dcbc9a8bc10ee0b025d2a0ef24ff4cd4a138330a8a8a5e93b6820a27fda0ec7259e389e0a1b1c9eb0af44f14e5f6ab20d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f8407a08302b6362d69d71bfaf19042e966f40e2d32676beac1219780b75b9e5f51f398c1549ee075597b34ffbb57bca93ebb2a90b8ad03aac4d5a5a260cdf"} 21:49:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:49:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:49:16 INFO - Contents: 21:49:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fbc9e23d2662c4a14151003cbc6e7dbdc5ad9a4fa199ab25c71f29999bec9f692508eb0c205065d6f5d45c870f0052ab0c027a06dfa17f12485f63b0127766d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d41a5d9e11fe045f57866869d4020dcbc9a8bc10ee0b025d2a0ef24ff4cd4a138330a8a8a5e93b6820a27fda0ec7259e389e0a1b1c9eb0af44f14e5f6ab20d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f8407a08302b6362d69d71bfaf19042e966f40e2d32676beac1219780b75b9e5f51f398c1549ee075597b34ffbb57bca93ebb2a90b8ad03aac4d5a5a260cdf"} 21:49:16 INFO - Running post-run listener: copy_logs_to_upload_dir 21:49:16 INFO - Copying logs to upload dir... 21:49:16 INFO - mkdir: /builds/slave/test/build/upload/logs 21:49:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.695298 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-31 21:49:15.809006) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:49:15.812748) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924 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/fbc9e23d2662c4a14151003cbc6e7dbdc5ad9a4fa199ab25c71f29999bec9f692508eb0c205065d6f5d45c870f0052ab0c027a06dfa17f12485f63b0127766d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d41a5d9e11fe045f57866869d4020dcbc9a8bc10ee0b025d2a0ef24ff4cd4a138330a8a8a5e93b6820a27fda0ec7259e389e0a1b1c9eb0af44f14e5f6ab20d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f8407a08302b6362d69d71bfaf19042e966f40e2d32676beac1219780b75b9e5f51f398c1549ee075597b34ffbb57bca93ebb2a90b8ad03aac4d5a5a260cdf"} build_url:https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/TMNsbPpNRwKevSGdguLkBQ/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/fbc9e23d2662c4a14151003cbc6e7dbdc5ad9a4fa199ab25c71f29999bec9f692508eb0c205065d6f5d45c870f0052ab0c027a06dfa17f12485f63b0127766d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7d41a5d9e11fe045f57866869d4020dcbc9a8bc10ee0b025d2a0ef24ff4cd4a138330a8a8a5e93b6820a27fda0ec7259e389e0a1b1c9eb0af44f14e5f6ab20d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/98f8407a08302b6362d69d71bfaf19042e966f40e2d32676beac1219780b75b9e5f51f398c1549ee075597b34ffbb57bca93ebb2a90b8ad03aac4d5a5a260cdf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 21:49:15.837762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:49:15.838059) ========= 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=8887e36bb8e381bfd44124ac000001a8-1477974508.350775-1496880924 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 21:49:15.923160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:49:15.923565) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 21:49:15.923862) ========= ========= Total master_lag: 0.17 =========