builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1484340816.49 results: success (0) buildid: 20170113111023 builduid: 5fd3d95f81fa476996c8fe7202b8d31c revision: de66a249a38b540ea34e9eb36a8d6a72c9fde4ef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.487438) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.487939) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.488242) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.503247) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.503547) ========= 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=652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-13 12:53:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-01-13 12:53:36 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.091530 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.610747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.611271) ========= 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=652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022017 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:36.662127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 12:53:36.662538) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev de66a249a38b540ea34e9eb36a8d6a72c9fde4ef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev de66a249a38b540ea34e9eb36a8d6a72c9fde4ef --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=652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-13 12:53:37,020 truncating revision to first 12 chars 2017-01-13 12:53:37,020 Setting DEBUG logging. 2017-01-13 12:53:37,020 attempt 1/10 2017-01-13 12:53:37,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/de66a249a38b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 12:53:37,972 unpacking tar archive at: mozilla-aurora-de66a249a38b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323801 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 12:53:38.000536) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:38.000864) ========= script_repo_revision: de66a249a38b540ea34e9eb36a8d6a72c9fde4ef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:38.001316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:38.001606) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 12:53:38.011959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-13 12:53:38.012363) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:53:38 INFO - MultiFileLogger online at 20170113 12:53:38 in /builds/slave/test 12:53:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:53:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:53:38 INFO - {'append_to_log': False, 12:53:38 INFO - 'base_work_dir': '/builds/slave/test', 12:53:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:53:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:53:38 INFO - 'branch': 'Mozilla-Aurora', 12:53:38 INFO - 'buildbot_json_path': 'buildprops.json', 12:53:38 INFO - 'config_files': ('talos/linux_config.py',), 12:53:38 INFO - 'default_actions': ('clobber', 12:53:38 INFO - 'read-buildbot-config', 12:53:38 INFO - 'download-and-extract', 12:53:38 INFO - 'populate-webroot', 12:53:38 INFO - 'create-virtualenv', 12:53:38 INFO - 'install', 12:53:38 INFO - 'run-tests'), 12:53:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:53:38 INFO - 'download_minidump_stackwalk': True, 12:53:38 INFO - 'download_symbols': 'ondemand', 12:53:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:53:38 INFO - 'tooltool.py': '/tools/tooltool.py', 12:53:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:53:38 INFO - '/tools/misc-python/virtualenv.py')}, 12:53:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:53:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:53:38 INFO - 'installer_path': 'installer.exe', 12:53:38 INFO - 'log_level': 'info', 12:53:38 INFO - 'log_name': 'talos', 12:53:38 INFO - 'log_to_console': True, 12:53:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:53:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:53:38 INFO - 'opt_config_files': (), 12:53:38 INFO - 'pip_index': False, 12:53:38 INFO - 'sps_profile': False, 12:53:38 INFO - 'sps_profile_interval': 0, 12:53:38 INFO - 'suite': 'dromaeojs', 12:53:38 INFO - 'system_bits': '32', 12:53:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:53:38 INFO - 'title': 'talos-linux64-ix-046', 12:53:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:53:38 INFO - 'use_talos_json': True, 12:53:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:53:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:53:38 INFO - 'work_dir': 'build'} 12:53:38 INFO - [mozharness: 2017-01-13 20:53:38.460610Z] Running clobber step. 12:53:38 INFO - Running pre-action listener: _resource_record_pre_action 12:53:38 INFO - Running main action method: clobber 12:53:38 INFO - rmtree: /builds/slave/test/build 12:53:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:53:38 INFO - Running post-action listener: _resource_record_post_action 12:53:38 INFO - [mozharness: 2017-01-13 20:53:38.924836Z] Finished clobber step (success) 12:53:38 INFO - [mozharness: 2017-01-13 20:53:38.924935Z] Running read-buildbot-config step. 12:53:38 INFO - Running pre-action listener: _resource_record_pre_action 12:53:38 INFO - Running main action method: read_buildbot_config 12:53:38 INFO - Using buildbot properties: 12:53:38 INFO - { 12:53:38 INFO - "project": "", 12:53:38 INFO - "product": "firefox", 12:53:38 INFO - "script_repo_revision": "production", 12:53:38 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 12:53:38 INFO - "repository": "", 12:53:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 12:53:38 INFO - "buildid": "20170113111023", 12:53:38 INFO - "pgo_build": "True", 12:53:38 INFO - "basedir": "/builds/slave/test", 12:53:38 INFO - "buildnumber": 739, 12:53:38 INFO - "slavename": "talos-linux64-ix-046", 12:53:38 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:53:38 INFO - "platform": "ubuntu64_hw", 12:53:38 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 12:53:38 INFO - "branch": "mozilla-aurora", 12:53:38 INFO - "repo_path": "releases/mozilla-aurora", 12:53:38 INFO - "revision": "de66a249a38b540ea34e9eb36a8d6a72c9fde4ef", 12:53:38 INFO - "stage_platform": "linux64-pgo", 12:53:38 INFO - "builduid": "5fd3d95f81fa476996c8fe7202b8d31c", 12:53:38 INFO - "slavebuilddir": "test" 12:53:38 INFO - } 12:53:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 12:53:38 INFO - Running post-action listener: _resource_record_post_action 12:53:38 INFO - [mozharness: 2017-01-13 20:53:38.927327Z] Finished read-buildbot-config step (success) 12:53:38 INFO - [mozharness: 2017-01-13 20:53:38.927416Z] Running download-and-extract step. 12:53:38 INFO - Running pre-action listener: _resource_record_pre_action 12:53:38 INFO - Running main action method: download_and_extract 12:53:38 INFO - mkdir: /builds/slave/test/build/tests 12:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:53:38 INFO - trying https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 12:53:38 INFO - Downloading https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 12:53:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:53:39 INFO - Downloaded 1361 bytes. 12:53:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 12:53:39 INFO - Using the following test package requirements: 12:53:39 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 12:53:39 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 12:53:39 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 12:53:39 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'jsshell-linux-x86_64.zip'], 12:53:39 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 12:53:39 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 12:53:39 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 12:53:39 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 12:53:39 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 12:53:39 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 12:53:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 12:53:39 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:53:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 12:53:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:53:39 INFO - Fetch https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:53:40 INFO - Http code: 200 12:53:40 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 12:53:40 INFO - x-amz-cf-id: U0uq1Med2lw4xbJQ0dCpic85SOjrSo3KHSI3LEWn3zEqXpQK9BlENg== 12:53:40 INFO - x-amz-version-id: mA1DuQYUFi4me_kkJm1aUnnJntc1tu3q 12:53:40 INFO - Expected file size: 21949108 12:53:40 INFO - Obtained file size: 21949108 12:53:44 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:53:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 12:53:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:53:44 INFO - Fetch https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 12:53:44 INFO - Http code: 200 12:53:44 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 12:53:44 INFO - x-amz-cf-id: 46sR99z18mOWX4fmRbofL-9IX-5eggn_yEyqpvhL_Ie3YGsE2_z_oA== 12:53:44 INFO - x-amz-version-id: mA1DuQYUFi4me_kkJm1aUnnJntc1tu3q 12:53:45 INFO - Expected file size: 21949108 12:53:45 INFO - Obtained file size: 21949108 12:53:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 12:53:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:53:49 INFO - Fetch https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 12:53:50 INFO - Http code: 200 12:53:50 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 12:53:50 INFO - x-amz-cf-id: srEwTCLbpfPc_vCLxTx4vQ0EOU0Xe6nKhju4FvGJZcwQmo46HmTVlQ== 12:53:50 INFO - x-amz-version-id: 5lkQetaBS3z9CoXb8RmkY_lQGhPqw09D 12:53:50 INFO - Expected file size: 14409038 12:53:50 INFO - Obtained file size: 14409038 12:53: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')]} 12:53:50 INFO - trying https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 12:53:50 INFO - Downloading https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 12:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:53:51 INFO - Downloaded 64147851 bytes. 12:53:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 12:53:51 INFO - mkdir: /builds/slave/test/properties 12:53:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:53:51 INFO - Writing to file /builds/slave/test/properties/build_url 12:53:51 INFO - Contents: 12:53:51 INFO - build_url:https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 12:53:52 INFO - Running post-action listener: _resource_record_post_action 12:53:52 INFO - Running post-action listener: set_extra_try_arguments 12:53:52 INFO - [mozharness: 2017-01-13 20:53:52.413083Z] Finished download-and-extract step (success) 12:53:52 INFO - [mozharness: 2017-01-13 20:53:52.413314Z] Running populate-webroot step. 12:53:52 INFO - Running pre-action listener: _resource_record_pre_action 12:53:52 INFO - Running main action method: populate_webroot 12:53:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:53:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:53:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:53:52 INFO - '--tppagecycles', 12:53:52 INFO - '7'], 12:53:52 INFO - 'tests': ['tsvgm']}}, 12:53:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:53:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:53:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:53:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:53:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['damp', 'tps']}, 12:53:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'tests': ['damp', 'tps']}, 12:53:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['dromaeo_dom']}, 12:53:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:53:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['basic_compositor_video']}, 12:53:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:53:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['a11yr', 12:53:52 INFO - 'ts_paint', 12:53:52 INFO - 'tpaint', 12:53:52 INFO - 'sessionrestore', 12:53:52 INFO - 'sessionrestore_no_auto_restore', 12:53:52 INFO - 'tabpaint']}, 12:53:52 INFO - 'other-e10s': {'tests': ['a11yr', 12:53:52 INFO - 'ts_paint', 12:53:52 INFO - 'tpaint', 12:53:52 INFO - 'sessionrestore', 12:53:52 INFO - 'sessionrestore_no_auto_restore', 12:53:52 INFO - 'tabpaint']}, 12:53:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:53:52 INFO - 'ts_paint', 12:53:52 INFO - 'tpaint', 12:53:52 INFO - 'sessionrestore', 12:53:52 INFO - 'sessionrestore_no_auto_restore', 12:53:52 INFO - 'tabpaint']}, 12:53:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:53:52 INFO - 'ts_paint', 12:53:52 INFO - 'tpaint', 12:53:52 INFO - 'sessionrestore', 12:53:52 INFO - 'sessionrestore_no_auto_restore', 12:53:52 INFO - 'tabpaint']}, 12:53:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['a11yr', 12:53:52 INFO - 'ts_paint', 12:53:52 INFO - 'tpaint', 12:53:52 INFO - 'sessionrestore', 12:53:52 INFO - 'sessionrestore_no_auto_restore', 12:53:52 INFO - 'tabpaint']}, 12:53:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['a11yr', 12:53:52 INFO - 'ts_paint', 12:53:52 INFO - 'tpaint', 12:53:52 INFO - 'sessionrestore', 12:53:52 INFO - 'sessionrestore_no_auto_restore', 12:53:52 INFO - 'tabpaint']}, 12:53:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['tsvgx', 12:53:52 INFO - 'tsvgr_opacity', 12:53:52 INFO - 'tart', 12:53:52 INFO - 'tscrollx', 12:53:52 INFO - 'cart']}, 12:53:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:53:52 INFO - 'tsvgr_opacity', 12:53:52 INFO - 'tart', 12:53:52 INFO - 'tscrollx', 12:53:52 INFO - 'cart']}, 12:53:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'talos_options': ['--disable-e10s'], 12:53:52 INFO - 'tests': ['tp5o']}, 12:53:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'tests': ['tp5o']}, 12:53:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'talos_options': ['--disable-e10s', 12:53:52 INFO - '--xperf_path', 12:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:52 INFO - 'tests': ['tp5n']}, 12:53:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:52 INFO - 'talos_options': ['--xperf_path', 12:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:52 INFO - 'tests': ['tp5n']}}, 12:53:52 INFO - 'talos.zip': {'path': '', 12:53:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:53:52 INFO - Running post-action listener: _resource_record_post_action 12:53:52 INFO - [mozharness: 2017-01-13 20:53:52.441436Z] Finished populate-webroot step (success) 12:53:52 INFO - [mozharness: 2017-01-13 20:53:52.441527Z] Running create-virtualenv step. 12:53:52 INFO - Running pre-action listener: _resource_record_pre_action 12:53:52 INFO - Running main action method: create_virtualenv 12:53:52 INFO - Creating virtualenv /builds/slave/test/build/venv 12:53:52 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 12:53:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:53:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:53:52 INFO - Using real prefix '/usr' 12:53:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:53:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:55 INFO - Installing pip.................done. 12:53:55 INFO - Return code: 0 12:53:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:53:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:53:55 INFO - Reading from file tmpfile_stdout 12:53:55 INFO - Output received: 12:53:55 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) 12:53:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:53: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', 'pip>=1.5'] in /builds/slave/test/build 12:53: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 pip>=1.5 12:53:55 INFO - Using env: {'DISPLAY': ':0', 12:53:55 INFO - 'HOME': '/home/cltbld', 12:53:55 INFO - 'LANG': 'en_US.UTF-8', 12:53:55 INFO - 'LANGUAGE': 'en_US:en', 12:53:55 INFO - 'LOGNAME': 'cltbld', 12:53:55 INFO - 'MAIL': '/var/mail/cltbld', 12:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:55 INFO - 'MOZ_NO_REMOTE': '1', 12:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:55 INFO - 'NO_EM_RESTART': '1', 12:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:55 INFO - 'PWD': '/builds/slave/test', 12:53:55 INFO - 'SHELL': '/bin/bash', 12:53:55 INFO - 'SHLVL': '1', 12:53:55 INFO - 'TERM': 'linux', 12:53:55 INFO - 'TMOUT': '86400', 12:53:55 INFO - 'USER': 'cltbld', 12:53:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:55 INFO - '_': '/tools/buildbot/bin/python'} 12:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:55 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 12:53:55 INFO - Cleaning up... 12:53:55 INFO - Return code: 0 12:53:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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', '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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:53: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', 'psutil>=3.1.1'] in /builds/slave/test/build 12:53: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 psutil>=3.1.1 12:53:55 INFO - Using env: {'DISPLAY': ':0', 12:53:55 INFO - 'HOME': '/home/cltbld', 12:53:55 INFO - 'LANG': 'en_US.UTF-8', 12:53:55 INFO - 'LANGUAGE': 'en_US:en', 12:53:55 INFO - 'LOGNAME': 'cltbld', 12:53:55 INFO - 'MAIL': '/var/mail/cltbld', 12:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:55 INFO - 'MOZ_NO_REMOTE': '1', 12:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:55 INFO - 'NO_EM_RESTART': '1', 12:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:55 INFO - 'PWD': '/builds/slave/test', 12:53:55 INFO - 'SHELL': '/bin/bash', 12:53:55 INFO - 'SHLVL': '1', 12:53:55 INFO - 'TERM': 'linux', 12:53:55 INFO - 'TMOUT': '86400', 12:53:55 INFO - 'USER': 'cltbld', 12:53:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:55 INFO - '_': '/tools/buildbot/bin/python'} 12:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:55 INFO - Downloading/unpacking psutil>=3.1.1 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:57 INFO - Installing collected packages: psutil 12:53:57 INFO - Running setup.py install for psutil 12:53:57 INFO - building 'psutil._psutil_linux' extension 12:53:57 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 12:53:58 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 12:53:58 INFO - building 'psutil._psutil_posix' extension 12:53:58 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 12:53:58 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 12:53:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:58 INFO - Successfully installed psutil 12:53:58 INFO - Cleaning up... 12:53:58 INFO - Return code: 0 12:53:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:53:58 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')]} 12:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:58 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')]} 12:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:58 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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:53:58 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 12:53:58 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 12:53:58 INFO - Using env: {'DISPLAY': ':0', 12:53:58 INFO - 'HOME': '/home/cltbld', 12:53:58 INFO - 'LANG': 'en_US.UTF-8', 12:53:58 INFO - 'LANGUAGE': 'en_US:en', 12:53:58 INFO - 'LOGNAME': 'cltbld', 12:53:58 INFO - 'MAIL': '/var/mail/cltbld', 12:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:58 INFO - 'MOZ_NO_REMOTE': '1', 12:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:58 INFO - 'NO_EM_RESTART': '1', 12:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:58 INFO - 'PWD': '/builds/slave/test', 12:53:58 INFO - 'SHELL': '/bin/bash', 12:53:58 INFO - 'SHLVL': '1', 12:53:58 INFO - 'TERM': 'linux', 12:53:58 INFO - 'TMOUT': '86400', 12:53:58 INFO - 'USER': 'cltbld', 12:53:58 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:58 INFO - '_': '/tools/buildbot/bin/python'} 12:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:53: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 12:54:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:00 INFO - Installing collected packages: mozsystemmonitor 12:54:00 INFO - Running setup.py install for mozsystemmonitor 12:54:00 INFO - Successfully installed mozsystemmonitor 12:54:00 INFO - Cleaning up... 12:54:00 INFO - Return code: 0 12:54:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:00 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')]} 12:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:00 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')]} 12:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:00 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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:54:00 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 12:54:00 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 12:54:00 INFO - Using env: {'DISPLAY': ':0', 12:54:00 INFO - 'HOME': '/home/cltbld', 12:54:00 INFO - 'LANG': 'en_US.UTF-8', 12:54:00 INFO - 'LANGUAGE': 'en_US:en', 12:54:00 INFO - 'LOGNAME': 'cltbld', 12:54:00 INFO - 'MAIL': '/var/mail/cltbld', 12:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:00 INFO - 'MOZ_NO_REMOTE': '1', 12:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:00 INFO - 'NO_EM_RESTART': '1', 12:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:00 INFO - 'PWD': '/builds/slave/test', 12:54:00 INFO - 'SHELL': '/bin/bash', 12:54:00 INFO - 'SHLVL': '1', 12:54:00 INFO - 'TERM': 'linux', 12:54:00 INFO - 'TMOUT': '86400', 12:54:00 INFO - 'USER': 'cltbld', 12:54:00 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:00 INFO - '_': '/tools/buildbot/bin/python'} 12:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:00 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:00 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 12:54:00 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 12:54:00 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 12:54:00 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 12:54:00 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 12:54:00 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 12:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:03 INFO - warning: no files found matching '*.txt' 12:54:03 INFO - no previously-included directories found matching 'build' 12:54:03 INFO - no previously-included directories found matching 'dist' 12:54:03 INFO - no previously-included directories found matching '.git*' 12:54:03 INFO - Installing collected packages: jsonschema, functools32 12:54:03 INFO - Running setup.py install for functools32 12:54:03 INFO - warning: no files found matching '*.txt' 12:54:03 INFO - no previously-included directories found matching 'build' 12:54:03 INFO - no previously-included directories found matching 'dist' 12:54:03 INFO - no previously-included directories found matching '.git*' 12:54:03 INFO - Successfully installed jsonschema functools32 12:54:03 INFO - Cleaning up... 12:54:03 INFO - Return code: 0 12:54:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:54:03 INFO - Using env: {'DISPLAY': ':0', 12:54:03 INFO - 'HOME': '/home/cltbld', 12:54:03 INFO - 'LANG': 'en_US.UTF-8', 12:54:03 INFO - 'LANGUAGE': 'en_US:en', 12:54:03 INFO - 'LOGNAME': 'cltbld', 12:54:03 INFO - 'MAIL': '/var/mail/cltbld', 12:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:03 INFO - 'MOZ_NO_REMOTE': '1', 12:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:03 INFO - 'NO_EM_RESTART': '1', 12:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:03 INFO - 'PWD': '/builds/slave/test', 12:54:03 INFO - 'SHELL': '/bin/bash', 12:54:03 INFO - 'SHLVL': '1', 12:54:03 INFO - 'TERM': 'linux', 12:54:03 INFO - 'TMOUT': '86400', 12:54:03 INFO - 'USER': 'cltbld', 12:54:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:03 INFO - '_': '/tools/buildbot/bin/python'} 12:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:54:03 INFO - Cleaning up... 12:54:03 INFO - Return code: 0 12:54:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:54:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:54:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:54:03 INFO - Using env: {'DISPLAY': ':0', 12:54:03 INFO - 'HOME': '/home/cltbld', 12:54:03 INFO - 'LANG': 'en_US.UTF-8', 12:54:03 INFO - 'LANGUAGE': 'en_US:en', 12:54:03 INFO - 'LOGNAME': 'cltbld', 12:54:03 INFO - 'MAIL': '/var/mail/cltbld', 12:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:03 INFO - 'MOZ_NO_REMOTE': '1', 12:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:03 INFO - 'NO_EM_RESTART': '1', 12:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:03 INFO - 'PWD': '/builds/slave/test', 12:54:03 INFO - 'SHELL': '/bin/bash', 12:54:03 INFO - 'SHLVL': '1', 12:54:03 INFO - 'TERM': 'linux', 12:54:03 INFO - 'TMOUT': '86400', 12:54:03 INFO - 'USER': 'cltbld', 12:54:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:03 INFO - '_': '/tools/buildbot/bin/python'} 12:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:03 INFO - Downloading/unpacking blobuploader==1.2.4 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54: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 12:54:05 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:06 INFO - Downloading docopt-0.6.1.tar.gz 12:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:06 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:06 INFO - Running setup.py install for blobuploader 12:54:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:06 INFO - Running setup.py install for requests 12:54:07 INFO - Running setup.py install for docopt 12:54:07 INFO - Successfully installed blobuploader requests docopt 12:54:07 INFO - Cleaning up... 12:54:07 INFO - Return code: 0 12:54:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:07 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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:54:07 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 12:54:07 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 12:54:07 INFO - Using env: {'DISPLAY': ':0', 12:54:07 INFO - 'HOME': '/home/cltbld', 12:54:07 INFO - 'LANG': 'en_US.UTF-8', 12:54:07 INFO - 'LANGUAGE': 'en_US:en', 12:54:07 INFO - 'LOGNAME': 'cltbld', 12:54:07 INFO - 'MAIL': '/var/mail/cltbld', 12:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:07 INFO - 'MOZ_NO_REMOTE': '1', 12:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:07 INFO - 'NO_EM_RESTART': '1', 12:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:07 INFO - 'PWD': '/builds/slave/test', 12:54:07 INFO - 'SHELL': '/bin/bash', 12:54:07 INFO - 'SHLVL': '1', 12:54:07 INFO - 'TERM': 'linux', 12:54:07 INFO - 'TMOUT': '86400', 12:54:07 INFO - 'USER': 'cltbld', 12:54:07 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:07 INFO - '_': '/tools/buildbot/bin/python'} 12:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:07 INFO - Running setup.py (path:/tmp/pip-9k2pMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:07 INFO - Running setup.py (path:/tmp/pip-Ja1EgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:07 INFO - Running setup.py (path:/tmp/pip-liGFMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:07 INFO - Running setup.py (path:/tmp/pip-mfsut8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:07 INFO - Running setup.py (path:/tmp/pip-ITCaIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:07 INFO - Running setup.py (path:/tmp/pip-9HPKqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:08 INFO - Running setup.py (path:/tmp/pip-mZWMZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:08 INFO - Running setup.py (path:/tmp/pip-ntHAgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:08 INFO - Running setup.py (path:/tmp/pip-SBve3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:08 INFO - Running setup.py (path:/tmp/pip-q526OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:08 INFO - Running setup.py (path:/tmp/pip-A1tVjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:08 INFO - Running setup.py (path:/tmp/pip-w6BCXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:08 INFO - Running setup.py (path:/tmp/pip-fLZu84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:08 INFO - Running setup.py (path:/tmp/pip-hhoRj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:08 INFO - Running setup.py (path:/tmp/pip-mzWAAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:08 INFO - Running setup.py (path:/tmp/pip-BdHV8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:08 INFO - Running setup.py (path:/tmp/pip-Fum9wh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:08 INFO - Running setup.py install for manifestparser 12:54:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:08 INFO - Running setup.py install for mozcrash 12:54:09 INFO - Running setup.py install for mozdebug 12:54:09 INFO - Running setup.py install for mozdevice 12:54:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Running setup.py install for mozfile 12:54:09 INFO - Running setup.py install for mozhttpd 12:54:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Running setup.py install for mozinfo 12:54:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Running setup.py install for mozInstall 12:54:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Running setup.py install for mozleak 12:54:09 INFO - Running setup.py install for mozlog 12:54:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Running setup.py install for moznetwork 12:54:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:09 INFO - Running setup.py install for mozprocess 12:54:10 INFO - Running setup.py install for mozprofile 12:54:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:10 INFO - Running setup.py install for mozrunner 12:54:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:10 INFO - Running setup.py install for mozscreenshot 12:54:10 INFO - Running setup.py install for moztest 12:54:10 INFO - Running setup.py install for mozversion 12:54:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:10 INFO - Cleaning up... 12:54:10 INFO - Return code: 0 12:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:10 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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:54:10 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 12:54:10 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 12:54:10 INFO - Using env: {'DISPLAY': ':0', 12:54:10 INFO - 'HOME': '/home/cltbld', 12:54:10 INFO - 'LANG': 'en_US.UTF-8', 12:54:10 INFO - 'LANGUAGE': 'en_US:en', 12:54:10 INFO - 'LOGNAME': 'cltbld', 12:54:10 INFO - 'MAIL': '/var/mail/cltbld', 12:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:10 INFO - 'MOZ_NO_REMOTE': '1', 12:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:10 INFO - 'NO_EM_RESTART': '1', 12:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:10 INFO - 'PWD': '/builds/slave/test', 12:54:10 INFO - 'SHELL': '/bin/bash', 12:54:10 INFO - 'SHLVL': '1', 12:54:10 INFO - 'TERM': 'linux', 12:54:10 INFO - 'TMOUT': '86400', 12:54:10 INFO - 'USER': 'cltbld', 12:54:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:10 INFO - '_': '/tools/buildbot/bin/python'} 12:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:10 INFO - Running setup.py (path:/tmp/pip-UpjGCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:10 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)) 12:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:10 INFO - Running setup.py (path:/tmp/pip-QmT_MT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 12:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:10 INFO - Running setup.py (path:/tmp/pip-NMMn7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:11 INFO - Running setup.py (path:/tmp/pip-aWX6CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:11 INFO - Running setup.py (path:/tmp/pip-yKGkfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:11 INFO - Running setup.py (path:/tmp/pip-ovjDxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:11 INFO - Running setup.py (path:/tmp/pip-4d7O2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:11 INFO - Running setup.py (path:/tmp/pip-_goMy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:11 INFO - Running setup.py (path:/tmp/pip-XkLqJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:11 INFO - Running setup.py (path:/tmp/pip-8rFj4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:11 INFO - Running setup.py (path:/tmp/pip-FQqSHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:11 INFO - Running setup.py (path:/tmp/pip-1lBDWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:11 INFO - Running setup.py (path:/tmp/pip-R5RXWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:11 INFO - Running setup.py (path:/tmp/pip-BIoa9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:11 INFO - Running setup.py (path:/tmp/pip-ptZLbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:11 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)) 12:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:11 INFO - Running setup.py (path:/tmp/pip-DMDlKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 12:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:12 INFO - Running setup.py (path:/tmp/pip-GG0FOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:12 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)) 12:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:12 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)) 12:54:12 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)) 12:54:12 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)) 12:54:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:14 INFO - Downloading blessings-1.6.tar.gz 12:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:14 INFO - Installing collected packages: blessings 12:54:14 INFO - Running setup.py install for blessings 12:54:14 INFO - Successfully installed blessings 12:54:14 INFO - Cleaning up... 12:54:14 INFO - Return code: 0 12:54:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:14 INFO - Reading from file tmpfile_stdout 12:54:14 INFO - Current package versions: 12:54:14 INFO - argparse == 1.2.1 12:54:14 INFO - blessings == 1.6 12:54:14 INFO - blobuploader == 1.2.4 12:54:14 INFO - docopt == 0.6.1 12:54:14 INFO - functools32 == 3.2.3-2 12:54:14 INFO - jsonschema == 2.5.1 12:54:14 INFO - manifestparser == 1.1 12:54:14 INFO - mozInstall == 1.12 12:54:14 INFO - mozcrash == 1.0 12:54:14 INFO - mozdebug == 0.1 12:54:14 INFO - mozdevice == 0.48 12:54:14 INFO - mozfile == 1.2 12:54:14 INFO - mozhttpd == 0.7 12:54:14 INFO - mozinfo == 0.9 12:54:14 INFO - mozleak == 0.1 12:54:14 INFO - mozlog == 3.4 12:54:14 INFO - moznetwork == 0.27 12:54:14 INFO - mozprocess == 0.23 12:54:14 INFO - mozprofile == 0.28 12:54:14 INFO - mozrunner == 6.13 12:54:14 INFO - mozscreenshot == 0.1 12:54:14 INFO - mozsystemmonitor == 0.3 12:54:14 INFO - moztest == 0.8 12:54:14 INFO - mozversion == 1.4 12:54:14 INFO - psutil == 3.1.1 12:54:14 INFO - requests == 1.2.3 12:54:14 INFO - wsgiref == 0.1.2 12:54:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:14 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')]} 12:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:14 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')]} 12:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:14 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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:54:14 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 12:54:14 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 12:54:14 INFO - Using env: {'DISPLAY': ':0', 12:54:14 INFO - 'HOME': '/home/cltbld', 12:54:14 INFO - 'LANG': 'en_US.UTF-8', 12:54:14 INFO - 'LANGUAGE': 'en_US:en', 12:54:14 INFO - 'LOGNAME': 'cltbld', 12:54:14 INFO - 'MAIL': '/var/mail/cltbld', 12:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:14 INFO - 'MOZ_NO_REMOTE': '1', 12:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:14 INFO - 'NO_EM_RESTART': '1', 12:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:14 INFO - 'PWD': '/builds/slave/test', 12:54:14 INFO - 'SHELL': '/bin/bash', 12:54:14 INFO - 'SHLVL': '1', 12:54:14 INFO - 'TERM': 'linux', 12:54:14 INFO - 'TMOUT': '86400', 12:54:14 INFO - 'USER': 'cltbld', 12:54:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:14 INFO - '_': '/tools/buildbot/bin/python'} 12:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 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)) 12:54:14 INFO - Cleaning up... 12:54:14 INFO - Return code: 0 12:54:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:14 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')]} 12:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:14 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')]} 12:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:14 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 0x7f968c5c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2951ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', '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 12:54:14 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 12:54:14 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 12:54:14 INFO - Using env: {'DISPLAY': ':0', 12:54:14 INFO - 'HOME': '/home/cltbld', 12:54:14 INFO - 'LANG': 'en_US.UTF-8', 12:54:14 INFO - 'LANGUAGE': 'en_US:en', 12:54:14 INFO - 'LOGNAME': 'cltbld', 12:54:14 INFO - 'MAIL': '/var/mail/cltbld', 12:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:14 INFO - 'MOZ_NO_REMOTE': '1', 12:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:14 INFO - 'NO_EM_RESTART': '1', 12:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:14 INFO - 'PWD': '/builds/slave/test', 12:54:14 INFO - 'SHELL': '/bin/bash', 12:54:14 INFO - 'SHLVL': '1', 12:54:14 INFO - 'TERM': 'linux', 12:54:14 INFO - 'TMOUT': '86400', 12:54:14 INFO - 'USER': 'cltbld', 12:54:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:14 INFO - '_': '/tools/buildbot/bin/python'} 12:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:14 INFO - Cleaning up... 12:54:15 INFO - Return code: 0 12:54:15 INFO - Running post-action listener: _resource_record_post_action 12:54:15 INFO - Running post-action listener: _start_resource_monitoring 12:54:15 INFO - Starting resource monitoring. 12:54:15 INFO - [mozharness: 2017-01-13 20:54:15.039043Z] Finished create-virtualenv step (success) 12:54:15 INFO - [mozharness: 2017-01-13 20:54:15.039497Z] Running install step. 12:54:15 INFO - Running pre-action listener: _resource_record_pre_action 12:54:15 INFO - Running main action method: install 12:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:15 INFO - Reading from file tmpfile_stdout 12:54:15 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:15 INFO - Reading from file tmpfile_stdout 12:54:15 INFO - Output received: 12:54:15 INFO - Usage: mozinstall [options] installer 12:54:15 INFO - Options: 12:54:15 INFO - -h, --help show this help message and exit 12:54:15 INFO - -d DEST, --destination=DEST 12:54:15 INFO - Directory to install application into. [default: 12:54:15 INFO - "/builds/slave/test"] 12:54:15 INFO - --app=APP Application being installed. [default: firefox] 12:54:15 INFO - mkdir: /builds/slave/test/build/application 12:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:54:31 INFO - Reading from file tmpfile_stdout 12:54:31 INFO - Output received: 12:54:31 INFO - /builds/slave/test/build/application/firefox/firefox 12:54:31 INFO - Running post-action listener: _resource_record_post_action 12:54:31 INFO - [mozharness: 2017-01-13 20:54:31.295937Z] Finished install step (success) 12:54:31 INFO - [mozharness: 2017-01-13 20:54:31.296179Z] Running run-tests step. 12:54:31 INFO - Running pre-action listener: _resource_record_pre_action 12:54:31 INFO - Running main action method: run_tests 12:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:31 INFO - Python 2.7.3 12:54:31 INFO - Return code: 0 12:54:31 INFO - grabbing minidump binary from tooltool 12:54: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')]} 12:54:31 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 0x294ef60>, '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 0x294fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29501d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:31 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 12:54:31 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 12:54:31 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 12:54:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:31 INFO - Return code: 0 12:54:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:54:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:54:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:54:31 INFO - Using env: {'DISPLAY': ':0', 12:54:31 INFO - 'HOME': '/home/cltbld', 12:54:31 INFO - 'LANG': 'en_US.UTF-8', 12:54:31 INFO - 'LANGUAGE': 'en_US:en', 12:54:31 INFO - 'LOGNAME': 'cltbld', 12:54:31 INFO - 'MAIL': '/var/mail/cltbld', 12:54:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:31 INFO - 'MOZ_NO_REMOTE': '1', 12:54:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:31 INFO - 'NO_EM_RESTART': '1', 12:54:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:31 INFO - 'PWD': '/builds/slave/test', 12:54:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:31 INFO - 'SHELL': '/bin/bash', 12:54:31 INFO - 'SHLVL': '1', 12:54:31 INFO - 'TERM': 'linux', 12:54:31 INFO - 'TMOUT': '86400', 12:54:31 INFO - 'USER': 'cltbld', 12:54:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883', 12:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:31 INFO - '_': '/tools/buildbot/bin/python'} 12:54:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:54:31 INFO - mozversion application_buildid: 20170113111023 12:54:31 INFO - mozversion application_changeset: de66a249a38b540ea34e9eb36a8d6a72c9fde4ef 12:54:31 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:54:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:31 INFO - mozversion application_name: Firefox 12:54:31 INFO - mozversion application_remotingname: firefox-dev 12:54:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:54:31 INFO - mozversion application_vendor: Mozilla 12:54:31 INFO - mozversion application_version: 52.0a2 12:54:31 INFO - mozversion platform_buildid: 20170113111023 12:54:31 INFO - mozversion platform_changeset: de66a249a38b540ea34e9eb36a8d6a72c9fde4ef 12:54:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:54:31 INFO - mozversion platform_version: 52.0a2 12:54:31 INFO - using testdate: 1484340871 12:54:31 INFO - actual date: 1484340871 12:54:31 INFO - starting webserver on 'localhost:41298' 12:54:31 INFO - SUITE-START | Running 2 tests 12:54:31 INFO - TEST-START | dromaeo_css 12:54:31 INFO - operating with platform_type : linux_ 12:54:31 INFO - Initialising browser for dromaeo_css test... 12:54:31 INFO - TEST-INFO | started process 843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW8xWk/profile http://localhost:41298/getInfo.html) 12:54:35 INFO - PROCESS | 843 | __metrics Screen width/height:1600/1200 12:54:35 INFO - PROCESS | 843 | colorDepth:24 12:54:35 INFO - PROCESS | 843 | Browser inner width/height: 1024/697 12:54:35 INFO - PROCESS | 843 | __metrics 12:54:36 INFO - PROCESS | 843 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:54:36 INFO - PROCESS | 843 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:54:36 INFO - PROCESS | 843 | console.error: PushService: 12:54:36 INFO - PROCESS | 843 | stateChangeProcessEnqueue: Error transitioning state 12:54:36 INFO - PROCESS | 843 | UnknownError 12:54:37 INFO - TEST-INFO | 843: exit 0 12:54:37 INFO - Browser initialized. 12:54:37 INFO - Running cycle 1/1 for dromaeo_css test... 12:54:37 INFO - TEST-INFO | started process 939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIW8xWk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:49 INFO - PROCESS | 939 | RSS: Main: 143880192 12:54:49 INFO - PROCESS | 939 | 12:57:50 INFO - PROCESS | 939 | Cycle 1(1): loaded http://localhost:41298/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41298/tests/dromaeo/cssquery-ext.html) 12:57:51 INFO - PROCESS | 939 | RSS: Main: 233463808 12:57:51 INFO - PROCESS | 939 | 13:00:54 INFO - PROCESS | 939 | Cycle 1(1): loaded http://localhost:41298/tests/dromaeo/cssquery-ext.html (next: http://localhost:41298/tests/dromaeo/cssquery-jquery.html) 13:00:54 INFO - PROCESS | 939 | RSS: Main: 230625280 13:00:54 INFO - PROCESS | 939 | 13:03:56 INFO - PROCESS | 939 | Cycle 1(1): loaded http://localhost:41298/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41298/tests/dromaeo/cssquery-mootools.html) 13:03:57 INFO - PROCESS | 939 | RSS: Main: 222183424 13:03:57 INFO - PROCESS | 939 | 13:06:59 INFO - PROCESS | 939 | Cycle 1(1): loaded http://localhost:41298/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41298/tests/dromaeo/cssquery-prototype.html) 13:06:59 INFO - PROCESS | 939 | RSS: Main: 220532736 13:06:59 INFO - PROCESS | 939 | 13:10:02 INFO - PROCESS | 939 | Cycle 1(1): loaded http://localhost:41298/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41298/tests/dromaeo/cssquery-yui.html) 13:10:03 INFO - PROCESS | 939 | RSS: Main: 173355008 13:10:03 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | Cycle 1(1): loaded http://localhost:41298/tests/dromaeo/cssquery-yui.html (next: http://localhost:41298/tests/dromaeo/cssquery-dojo.html) 13:13:05 INFO - PROCESS | 939 | RSS: Main: 266092544 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | __start_tp_report 13:13:05 INFO - PROCESS | 939 | _x_x_mozilla_page_load 13:13:05 INFO - PROCESS | 939 | _x_x_mozilla_page_load_details 13:13:05 INFO - PROCESS | 939 | |i|pagename|runs| 13:13:05 INFO - PROCESS | 939 | |0;dojo.html;3201.9359612807743;3217.4691175955954;3224.32289219264;3234.223786291288;3242.2056596133934;5536;5575.832725018246;5593;5629.690367029812;5644.435556444359;5626.887462250753;5679.517241034517;5682.573806964484;5693.8576535586635;5712.057510510771;5104.591632669387;5132.692038477703;5160.716160611165;5179.983753370179;5207.739613019353;4987.1521841286885;5220.530152286294;5221.738913054332;5226.738663066851;5226.895462090775;4995.025969935864;5021.221710634839;5055.140626093555;5066.265391518227;5078.238264260353;5126.7436628168625;5170.560502357285;5172.741362931838;5239.79040838366;5240.135377662719;5060.190369540893;5137.6403651744395;5179.456157103487;5205.661631993946;5230.450802665741;5325.680459172462;5373.167159090347;5444.482774136451;5500.58745594082;5512.751926163332;5972.432618901197;5978.940210597882;5990.191324171225;6079.6960151992225;6080.9391906081255;6127.509799216052;6133.509319254449;6139.539534534928;6140.293866205398;6151.354107818659;5402.37872644647;5451.073317536028;5566.888662226733;5622.91565626516;5624.803131890446;6179.752809887644;6195;6204.100405441186;6209.813705588749;6216.7824126155365;5945.910811337833;5949.940500594938;5951.434613711777;5954.047352423591;5956.434138756811;5772.9711351442975;5829.59192856496;5837.066069428871;5971.671558064349;6041.365656606081;6053.45518903292;6057.727402266909;6081.148639190517;6088.330283668793;6088.360722124113;6034.306054803754;6056.545759068;6091.756329746849;6095.725692343855;6101.420365065312;4528.728276303366;4574.862754117382;4614.630829533629;4730.195866702668;4731.976340118277;4141.4616099907425;4175.227582897113;4181.247375472383;4203.47456567929;4225.281702110648;5694.601377903507;5696.8860622787315;5698.0598201296325;5700.6009579329875;5758.136279558016;5774.191613174159;5830.096335068071;6017.247844019497;6028.306744724325;6031.306399763996;5475.698836564027;5571.13647384656;5620.915686264628;5687.60186786921;5711.457411545896;5150.845474635767;5178.275041494194;5187.403448603383;5189.455107213764;5192.8961420771375;5910.556708246812;6120.755169793248;6158.568900177034;6181.134641150243;6181.938180618136;5802.564807639359;5879.382664820303;5952.494038006645;5957.434043765836;6003.459688628044;6125.724342404514;6126.632402055891;6126.846828829315;6127.448529632355;6127.540434467343;5865.912011319919;5879.647221166743;5881.176635271151;5882.411758824083;5886.646801191942;5845.210896528914;5850.473457388855;5960.970195148997;6011.819645410645;6032.306284777307;5873.442023007808;5920.496757775637;5926.822195334147;5931.021381472009;5934.495567876606;5880.088586269135;5891.293044834647;5892.204552385545;5900.055991041413;5901.232839730807;5577;5711.086226203787;5716.942830571641;5807.186993820784;5829.183914251923;5849.239598852122;5916.852078698067;5918.881622367442;5930.495907847881;5939.940600594112;5536.446355364593;5789.768409263751;5797.101449275369;5801;5805.448482394166 13:13:05 INFO - PROCESS | 939 | |1;ext.html;583.4894467341077;606.7500948047024;628.7673560782512;643.7618081309917;646.221303329488;35036.299274014505;35561.46657800132;37881.62118378812;45895;47046;46490.30264546026;47073.11707531694;47156.764216178955;47177.528224717746;47260.29109563359;8771.254443372321;8923.866142007875;8925.107489251088;8925.776855578597;8927.06265842087;8379.706710265142;8562.828743425127;10477.84283235752;10707.143428525738;10721.195910306718;10627.149828013778;10674.893251067506;10686.893131068706;10694.358338499715;10695.625653102143;10595;10618.097461715763;10659.147268218523;10680.839787403194;10683.732906677318;10554.788904221949;10614.734631634194;10626.415547144903;10629.309094908805;10630.362178269328;43670.781646091564;43832.78083609593;43879;43879.48964082866;44038.77980610108;3656.634336566349;3717.442383642448;3771.302309072803;3775.9433608495897;3825.0437390652337;33117.503237451456;33266.16834579155;33378;33437;33850.322993540234;4449.57729015743;4547.477040140393;4572.862814115582;4577.816887324503;4627;359022;359580;359928;360693;361102;63895.68052159803;64145.679271603345;64206.35793642097;64234;64266.6786666073;39719;39766.806995790175;39789;43414.7829260858;43452.3482147768;18414.079296035146;18534.351297704787;18552.05203453645;18590.53523661919;18591.070446477894;11775.587854425054;12010.099242556844;14020.649483762783;14119.082259653089;14126.434942602385;16629.16854157287;16951.745723814154;20448.284310049075;21248.825777720333;21267.574648506943;7160.677769500385;7198.92801071993;7434.665440055211;7515.173330933593;7540.509866858637;961.2838435365697;966.4587830814626;1010.4493051287067;1026.9537870795832;1146.0545050333342;33824.66175338264;34036;34086.829565852015;34348.14129646779;34504;1088.1294964028746;1120.3781901044836;1130.2766229613055;1162.2619636530694;1199.56215981168;16801.269967258755;17822.51755315473;17923.73114403285;17955.703772077333;19203.807961920204;567086;570337;572848;573355;574018;63806.68096659487;64307;64405.355946440875;64522.03216951749;64561;1277.8530468995998;1315.9144655597547;1375.938082786277;1389.8957578181678;1402.3338914015965;30061.398772024873;34345.656543435245;34658.48012279868;34899.47650785291;35094.473582895764;54102.72948635231;54722;54855.451445485036;54971.450285496634;55072;343693;346047;346249;346891;347220;29865.104046878627;29888;31255.218619533785;32291.19272018218;32365.838170809937;48544.514554854;49507.75246123746;49670.75164624154;50172;50294.245586315505;41810.37284440675;43115.13769724651;43184.78407607942;43464;44213.77893110514;42141.367879482445;42444;42674.14651706886;44572;44658;42001.159976800904;42798.14403711846;43658.56341436545;43746;43838.56161438345;35900.28199436049;38249.80875095718;38550.22899541938;38865.61134388733;39316.60683393129;29137.271568210963;29226;29416.26459338534;29512.704872950995;29579.852100739357 13:13:05 INFO - PROCESS | 939 | |2;jquery.html;380.0953730122308;395.59451562148814;416.68123885227794;422.4276105876537;423.94064830923674;13959;15915.602109947256;19256.22975080995;19829.40511784645;20131;19006.809931900676;19289.421317360502;19612;19806.40580782575;20055.799442005577;4829.444613869415;5735.340435849868;5898.262717160355;5937.346891841916;5937.88124237515;5823.242978412801;5917.970410147943;5919.260092488439;5924.0521516557355;5924.081767326072;5824.679642619654;5887.558433117512;5889.911651325212;6076.422739839731;6111.633302001872;6062.363451837582;6077.483413909823;6100.176476175749;6116.327204007578;6116.785912493064;5761.769529218868;5964.373740757244;5980.491658209057;5982.312034116088;5982.551308651825;14663.926680366636;14667.48663796762;14700.852991470056;14798.630034249123;14917.104973701504;2261.8190544756544;2368.289513146049;2372.857628542293;2586.9910734813247;2974.5240761478058;10973.957474039953;11090.334579925231;11169.218154729173;13018.349082545836;14837.629059273497;1957.168203513501;1981.3560592807396;2004.4086994336706;2091.487585541552;2105.1789801977243;80314.59842700748;85643;86095.56952215261;86421;88453;11469.71325716847;11656.30062196271;11678.70803229926;11680.415979201176;11803.763924721628;16727.665446690997;16735.49793506197;16743.330266789435;16744.330226790793;16767.245473953702;8157.632906519221;8236.711715089943;8237.588120593946;8331.458455200393;8385.538795366314;7737.342325902248;7748.535087894745;7897.565633890076;7923.603819808986;7929.246721561558;4856.660033797671;4868.683535570177;4952.108620448354;4956.653034287565;5106.948930510647;2028.665270230425;2031.248438077891;2032.8780273183656;2069.2550681754556;2080.199123337526;805.255138996426;983.4836710726782;1031.7884833609091;1130.3218069158604;1131.0725205331714;19374;19586.608267834563;19592.118354674072;19600.70598941017;20158.59682806365;991.4844280973854;1008.8032833597379;1018.8828284747201;1030;1070.5022164693455;10244.180465562737;10783.352998820095;10840.728981775519;10881.945590271998;11018.39398833072;480320;483254;486579;490797;493110;55167;56851.43148568461;76933.6153319241;98920.50539747255;101301;964.5466630683568;984.7144328144901;986.2571541001915;990.5740531571349;1003.9046290602381;17251.82748172502;18074.638507230044;18129.546761330545;18382.356617518322;18642.44072677822;39071.41392879052;43042.56957430386;43745.343819843365;43912;43983.560164397946;54700.90598187935;54842;58292;59102.40897590969;59642.70178649079;7892.210778922062;8350.58247087631;8401.747947561584;8450.915490845013;8748.562571871254;12856.228626282453;13626.863731362559;13753.106048106842;13851.23818189969;13995.440182392591;11597.6520704379;11818.881811181778;11946.223495472766;12209.267443953391;12247.142700010914;11187.608433704781;11427;11566.65300041;11867.762644746885;11985.64043078709;11702.180847340604;11941.64175074749;11972.401379931143;11974.820377694168;12214.328211948428;8933.15135062168;8940.776480588038;8962.641494340154;9285.72142835716;9378.390404623678;9349.53252337394;12073.818892716441;12106.273623582612;12444.128910976146;12515.624531264077 13:13:05 INFO - PROCESS | 939 | |3;mootools.html;1365.1467832604621;1496.0425327790213;1530.8086489188852;1640.1963038111328;1787.26722043962;7795.92204077959;8705.347098967572;9094.636214551418;9095.90904090959;9098.681546145886;8930.687425940094;9010.72967810965;9011.909880901188;9013.278937684985;9014.098590140982;2446.131623273739;2473.5794914864427;2479.3429741118616;2479.764422379871;2479.938001549958;2386.713594368678;2441.584930561809;2443.987780061097;2447.4615584571366;2449.5835707929605;2361.988190059047;2396.9280921572295;2406.1698713943747;2443.584590619599;2447.938801529967;2369.277370402027;2380.5952987991996;2388.199953015742;2398.124684490166;2402.8318017738766;2343.390718413225;2348.896018871128;2371.0989823866994;2371.5256948610345;2373.2524254859663;8693.347998900044;8906.86639700405;8994.595243214006;8999.100089991014;9080.22818060459;5296.3379577552805;5513.448655134494;5526.336839579236;5531.170324451325;5531.502164805147;3415.077928959167;3424.8116353600544;3517.22621023377;3547.7693949893173;3554.697850682695;1196.1328037173066;1212.8180772884139;1234.0497816681195;1249.8750124987428;1280.359820089955;12555.372231388485;12661.493540258287;12702.110852240347;12708.936455317757;12727;4298.978505107454;4651.651126165551;4690.390249267642;4740.051989602024;4745.264484004984;10087.04173103554;10087.04173103554;10090.394576325298;10091;10091.798164036825;5412.56699464042;5413.621046526705;5415.458454154632;5417;5417.83746487606;4255.489341279066;4387.407699960529;4574.268117101248;5082.059818933435;5085.898282034413;4103.420183229418;4122.715353220668;4190.266703326905;4204.894877628022;4224.809883555247;1218.567408569945;1228.177121328712;1231.9076069294838;1238.325112813519;1245.9813102803466;965.232640051161;996.1433167475965;1002.6390499420203;1003.2876657573205;1016.9491525423699;5715.4570315820765;5860.8534786629825;6028;6095.2685677718955;6182.103594978703;929.7815013471828;942.40157499988;952.8999455057258;968.6900191938512;1003.7289931718395;3994.6005399459823;4131.97934010328;4190.182914331737;4233.174530966432;4235.576442355801;10603.734906627242;10951.890481095246;10995;11177.776444471065;11244.831327530093;11243.606473773541;11405.486753096131;11415.258008229439;11431.828522572168;11442.885571144348;8396.160383961555;8694.521801300989;8702.608382622797;8708.69519566812;8714.694985675598;6036.69816509164;6066.484348830222;6110.7250173741395;6237.563370564017;6274.403931626488;10099.343542669703;10206.642767503101;10297.9485102574;10450.529726162189;10461.320014199357;9251.86122208154;9540.666076687283;10545.841812372668;10655.733606659896;10705.678829635124;7598.582077985543;7718.729844455417;7808.258215469521;8006.799830004296;8022.435625053058;8832.160944710242;8872.201501864864;8883.466991980502;8892.510911899908;8902.065283145177;7513.549187048795;7553.660085296065;7642.923570764444;7659.617019148909;7853.528788272493;7796.88304675419;7883.921160788548;7905.130435652189;7916.485428447132;7926.643301051351;7029.929700703132;7157.320054594805;7158.212596614472;7166.247544007804;7167.569945803269;5193.76628051731;5293.5765138789575;5329.147336426153;5370.812021579226;5528.700755322577;5313.070212712837;5319.574434045189;5337.092694241911;5367.946320536745;5381.165919282517 13:13:05 INFO - PROCESS | 939 | |4;prototype.html;329.2657374055855;330.20585491891995;331.65342217382835;346.1674672412847;353.6127939905802;5203.2975548300965;5330.546903513196;5356.892862142759;5367.248585198071;5368.973155134228;5192.7403629818455;5256.26412302278;5296.285001524793;5309.097453432916;5328.733563321838;4234.21666991606;4238.427812245346;4251.723637963522;4252.255855225323;4263.678259739475;4157.127003329305;4228.175505776375;4248.447701798762;4273.145370925812;4277.52425413232;4220.36694495825;4225.535191128974;4228.1966426378885;4228.894277643069;4253.702240843142;4219.303814870543;4224.852130175429;4227.408162857187;4239.8092085856215;4239.876432745325;3692.2061756722164;3817.9809100954594;3824.7131465139946;3835;3836.4437156612134;5189.273501709764;5214.296070030573;5222.16445368743;5225.921611175835;5227.843164705065;4845.75771211438;4892.290617860426;4896.363472748555;4916.877078073041;4924.409070911478;5324.653897496689;5552.3892371839065;5586.106223004341;5593.552515798727;5606.747696353674;4174.70777045607;4181.142865712552;4181.519125300599;4209.705320627558;4209.7474151551005;5742.827715168552;5774.364819869811;5811.501054546543;5816.272965879265;5839.64962102271;4196.307609244441;4257.40396344512;4305.332673435622;4309.095090031066;4327.891802704958;4285.635720963753;4292.806823692878;4296.484421869396;4311.413152108709;4312.331588603772;4804.447488538793;4814.9518504815205;4824.782884770194;4830.227163653799;4832.371791667061;5360.410354860962;5553.194786755897;5577.163425486209;5584.329880414295;5612.97193514038;1391.7981892625714;1408.2325132802648;1431;1452.3028946105928;1454.7852543126396;981.8379967305315;1015.3603229965074;1016.974575635615;1017.6997785653102;1022.437659287389;5048.545630893163;5086.313347698014;5086.567641750418;5094.592432605383;5106.489351064938;5502.724863756796;5509.972450137724;5526.309211348582;5538.944610553924;5568.415316391802;5082.364704411949;5185.714785686748;5212;5223.268742376071;5419.34967803866;2945.2931296488687;2966.5463922678164;2974.048304542569;2978.27032377069;2993.206800197949;5740;5760.567957403212;5781.9763082920645;5798.710064496842;5834.299884013945;5566.805161819317;5725.255716756795;5744.856378590485;5750.654960702372;5760.308762948473;5697.287839020122;5737.250138707651;5747.505648531328;5752.6836024019085;5761.683107429131;5377.919331210113;5581.386047534849;5623.662580245198;5687.658740475585;5712.400197979152;5465.316835395575;5500.23992322453;5527.668339899458;5544.889102218014;5584.274044374205;5684.669285592887;5692.4876761090045;5698.572607054404;5712.200291959212;5751.97124014394;3945.723799334019;4009.478767760289;4023.8390464381096;4045.422285308791;4085.7752823594988;5527.972360138174;5569.888602227852;5575.1915972184615;5577.525910297508;5667.40492248308;5428.972855135699;5607.5513958882375;5648.5481161507805;5660.29246344207;5661.575381846295;5587.832365029056;5629.54963602919;5631.887362252814;5635.773869321513;5649.858753531194;5447.74701818576;5472.616916815944;5493.862653433696;5559.470440949439;5569.220309156803;5565.972170139124;5576.665400076008;5580.832575022756;5585.832425027255;5587.74855131512;5241.715779634014;5466.638017619215;5530.364008139116;5545.584081194007;5559.388467268516 13:13:05 INFO - PROCESS | 939 | |5;yui.html;781.5779479081297;787.0437418536477;801.6432687454082;819.2135549872119;871.5511511571542;14804.333804978774;15759.448419305327;15775.13236771977;15827.920860395681;15879.92060039701;13833.584992450218;14518.637034074154;14661.926690366534;14669.633259168526;14683.265836708175;715.3633266392915;729.4930023633577;828.9709860154895;842.0316635868754;857.8841856349406;853.4495250563383;853.7780177153923;854.1970547685156;859.3039637893295;861.5003298087125;874.4884242718017;875.2997601918472;875.3216257400502;876.0888675777184;876.4565969099135;757.5946868425393;780.4809801482007;869.9565021748919;883.4301875290402;891.6968230801558;651.6253154436218;651.6318280171688;651.8500744828716;651.8663673946829;652.7160685101949;14787.556373308711;15091.849081509154;15096.924515377463;15134.848651513454;15140;13653.931730341385;13682.726345473135;13852.16886986784;14142.434302627882;14213.786793198007;11738.413079345999;11779.764404711857;11854.762904741858;12061.396930153545;12144.939275303655;4581.404417425713;4605.861824145248;4644;4673.509281525425;4770.236762118045;65460.345396545905;65677;67891.56867450592;67938.32061679369;68165.31834681639;11402.315861048364;11479;11568.13239007061;11792;11953.163278570417;20344;20344.287949921683;20348.89825550863;20386.898065509577;20469.59060818775;8459.746207613782;8471;8607.139286071342;8760.036395996436;8853.424527405827;4762.476127625959;4852.781624826821;4911.778969946361;4999.02519008797;5107.923381149286;3583.874564390234;3676.1361080146144;3679.8528058877346;3706.777593344408;3711.7958512282084;645.029231007331;662.8574856405896;662.9801105966828;671.2448495442627;683.2654895986834;753.179034852014;761.9733309334147;784.1413652050995;790.1861083084432;804.4007214625142;9633.710988670351;9711.562979665932;9792.363496372713;9836.803263934682;9857.014298570086;638.2946843737695;716.0726858717973;746.3805041815281;763.7670510494353;784.1296161260996;4643.558861908114;4808.158572249912;4871.707697538159;4954.3063971044085;4991.151504244287;90737.09262907287;91447;91705;91961.54019229994;92333;80114;80796.19203808004;82482.17517824865;82606;83081.58459207666;58547;60249.69875150596;63003.36996629975;65100.67449662816;65122;9845.212383009199;9935.950320248352;10140.695779126638;10194;10312.381257124596;44308.77845610751;46153.76923115363;46193;46683.29975050309;47664.2850357238;54889;60862;62652;63871;66186;12746.044046696721;12868.678283042998;12879.420426081037;13004.349782511026;13033.087683862039;14281.14313141215;14285.28573571338;14496.637584060483;14528.564143075724;15278;12923.28921909304;12957.287349195885;13411.932940335237;13428.731425371634;13451.663708407368;13703.657408564866;13806.585802425943;13848.653783655489;13973.790393143907;14411.207383594003;13564.457421703022;13964.511242106477;13996.300184990914;14216.502422415166;14427.92786036063;10008.249381296286;11060.612878549213;11097.00126988575;11407.144464165387;11752.23610465317;11062.280951738112;11062.336259824437;11344.716382090513;11353.659390218307;11689.181757276909 13:13:05 INFO - PROCESS | 939 | __end_tp_report 13:13:05 INFO - PROCESS | 939 | __start_cc_report 13:13:05 INFO - PROCESS | 939 | _x_x_mozilla_cycle_collect,882 13:13:05 INFO - PROCESS | 939 | __end_cc_report 13:13:05 INFO - PROCESS | 939 | __startTimestamp1484341985800__endTimestamp 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | ------- Summary: start ------- 13:13:05 INFO - PROCESS | 939 | Number of tests: 6 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | [#0] dojo.html Cycles:165 Average:5575.06 Median:5797.10 stddev:622.23 (10.7%) stddev-sans-first:595.63 13:13:05 INFO - PROCESS | 939 | Values: 3201.9 3217.5 3224.3 3234.2 3242.2 5536.0 5575.8 5593.0 5629.7 5644.4 5626.9 5679.5 5682.6 5693.9 5712.1 5104.6 5132.7 5160.7 5180.0 5207.7 4987.2 5220.5 5221.7 5226.7 5226.9 4995.0 5021.2 5055.1 5066.3 5078.2 5126.7 5170.6 5172.7 5239.8 5240.1 5060.2 5137.6 5179.5 5205.7 5230.5 5325.7 5373.2 5444.5 5500.6 5512.8 5972.4 5978.9 5990.2 6079.7 6080.9 6127.5 6133.5 6139.5 6140.3 6151.4 5402.4 5451.1 5566.9 5622.9 5624.8 6179.8 6195.0 6204.1 6209.8 6216.8 5945.9 5949.9 5951.4 5954.0 5956.4 5773.0 5829.6 5837.1 5971.7 6041.4 6053.5 6057.7 6081.1 6088.3 6088.4 6034.3 6056.5 6091.8 6095.7 6101.4 4528.7 4574.9 4614.6 4730.2 4732.0 4141.5 4175.2 4181.2 4203.5 4225.3 5694.6 5696.9 5698.1 5700.6 5758.1 5774.2 5830.1 6017.2 6028.3 6031.3 5475.7 5571.1 5620.9 5687.6 5711.5 5150.8 5178.3 5187.4 5189.5 5192.9 5910.6 6120.8 6158.6 6181.1 6181.9 5802.6 5879.4 5952.5 5957.4 6003.5 6125.7 6126.6 6126.8 6127.4 6127.5 5865.9 5879.6 5881.2 5882.4 5886.6 5845.2 5850.5 5961.0 6011.8 6032.3 5873.4 5920.5 5926.8 5931.0 5934.5 5880.1 5891.3 5892.2 5900.1 5901.2 5577.0 5711.1 5716.9 5807.2 5829.2 5849.2 5916.9 5918.9 5930.5 5939.9 5536.4 5789.8 5797.1 5801.0 5805.4 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | [#1] ext.html Cycles:180 Average:59777.97 Median:3744.37 stddev:116122.99 (3101.3%) stddev-sans-first:116363.70 13:13:05 INFO - PROCESS | 939 | Values: 583.5 606.8 628.8 643.8 646.2 35036.3 35561.5 37881.6 45895.0 47046.0 46490.3 47073.1 47156.8 47177.5 47260.3 8771.3 8923.9 8925.1 8925.8 8927.1 8379.7 8562.8 10477.8 10707.1 10721.2 10627.1 10674.9 10686.9 10694.4 10695.6 10595.0 10618.1 10659.1 10680.8 10683.7 10554.8 10614.7 10626.4 10629.3 10630.4 43670.8 43832.8 43879.0 43879.5 44038.8 3656.6 3717.4 3771.3 3775.9 3825.0 33117.5 33266.2 33378.0 33437.0 33850.3 4449.6 4547.5 4572.9 4577.8 4627.0 359022.0 359580.0 359928.0 360693.0 361102.0 63895.7 64145.7 64206.4 64234.0 64266.7 39719.0 39766.8 39789.0 43414.8 43452.3 18414.1 18534.4 18552.1 18590.5 18591.1 11775.6 12010.1 14020.6 14119.1 14126.4 16629.2 16951.7 20448.3 21248.8 21267.6 7160.7 7198.9 7434.7 7515.2 7540.5 961.3 966.5 1010.4 1027.0 1146.1 33824.7 34036.0 34086.8 34348.1 34504.0 1088.1 1120.4 1130.3 1162.3 1199.6 16801.3 17822.5 17923.7 17955.7 19203.8 567086.0 570337.0 572848.0 573355.0 574018.0 63806.7 64307.0 64405.4 64522.0 64561.0 1277.9 1315.9 1375.9 1389.9 1402.3 30061.4 34345.7 34658.5 34899.5 35094.5 54102.7 54722.0 54855.5 54971.5 55072.0 343693.0 346047.0 346249.0 346891.0 347220.0 29865.1 29888.0 31255.2 32291.2 32365.8 48544.5 49507.8 49670.8 50172.0 50294.2 41810.4 43115.1 43184.8 43464.0 44213.8 42141.4 42444.0 42674.1 44572.0 44658.0 42001.2 42798.1 43658.6 43746.0 43838.6 35900.3 38249.8 38550.2 38865.6 39316.6 29137.3 29226.0 29416.3 29512.7 29579.9 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | [#2] jquery.html Cycles:180 Average:28619.80 Median:2479.92 stddev:80145.55 (3231.8%) stddev-sans-first:80342.33 13:13:05 INFO - PROCESS | 939 | Values: 380.1 395.6 416.7 422.4 423.9 13959.0 15915.6 19256.2 19829.4 20131.0 19006.8 19289.4 19612.0 19806.4 20055.8 4829.4 5735.3 5898.3 5937.3 5937.9 5823.2 5918.0 5919.3 5924.1 5924.1 5824.7 5887.6 5889.9 6076.4 6111.6 6062.4 6077.5 6100.2 6116.3 6116.8 5761.8 5964.4 5980.5 5982.3 5982.6 14663.9 14667.5 14700.9 14798.6 14917.1 2261.8 2368.3 2372.9 2587.0 2974.5 10974.0 11090.3 11169.2 13018.3 14837.6 1957.2 1981.4 2004.4 2091.5 2105.2 80314.6 85643.0 86095.6 86421.0 88453.0 11469.7 11656.3 11678.7 11680.4 11803.8 16727.7 16735.5 16743.3 16744.3 16767.2 8157.6 8236.7 8237.6 8331.5 8385.5 7737.3 7748.5 7897.6 7923.6 7929.2 4856.7 4868.7 4952.1 4956.7 5106.9 2028.7 2031.2 2032.9 2069.3 2080.2 805.3 983.5 1031.8 1130.3 1131.1 19374.0 19586.6 19592.1 19600.7 20158.6 991.5 1008.8 1018.9 1030.0 1070.5 10244.2 10783.4 10840.7 10881.9 11018.4 480320.0 483254.0 486579.0 490797.0 493110.0 55167.0 56851.4 76933.6 98920.5 101301.0 964.5 984.7 986.3 990.6 1003.9 17251.8 18074.6 18129.5 18382.4 18642.4 39071.4 43042.6 43745.3 43912.0 43983.6 54700.9 54842.0 58292.0 59102.4 59642.7 7892.2 8350.6 8401.7 8450.9 8748.6 12856.2 13626.9 13753.1 13851.2 13995.4 11597.7 11818.9 11946.2 12209.3 12247.1 11187.6 11427.0 11566.7 11867.8 11985.6 11702.2 11941.6 11972.4 11974.8 12214.3 8933.2 8940.8 8962.6 9285.7 9378.4 9349.5 12073.8 12106.3 12444.1 12515.6 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | [#3] mootools.html Cycles:180 Average:5921.39 Median:4612.96 stddev:3347.20 (72.6%) stddev-sans-first:3339.07 13:13:05 INFO - PROCESS | 939 | Values: 1365.1 1496.0 1530.8 1640.2 1787.3 7795.9 8705.3 9094.6 9095.9 9098.7 8930.7 9010.7 9011.9 9013.3 9014.1 2446.1 2473.6 2479.3 2479.8 2479.9 2386.7 2441.6 2444.0 2447.5 2449.6 2362.0 2396.9 2406.2 2443.6 2447.9 2369.3 2380.6 2388.2 2398.1 2402.8 2343.4 2348.9 2371.1 2371.5 2373.3 8693.3 8906.9 8994.6 8999.1 9080.2 5296.3 5513.4 5526.3 5531.2 5531.5 3415.1 3424.8 3517.2 3547.8 3554.7 1196.1 1212.8 1234.0 1249.9 1280.4 12555.4 12661.5 12702.1 12708.9 12727.0 4299.0 4651.7 4690.4 4740.1 4745.3 10087.0 10087.0 10090.4 10091.0 10091.8 5412.6 5413.6 5415.5 5417.0 5417.8 4255.5 4387.4 4574.3 5082.1 5085.9 4103.4 4122.7 4190.3 4204.9 4224.8 1218.6 1228.2 1231.9 1238.3 1246.0 965.2 996.1 1002.6 1003.3 1016.9 5715.5 5860.9 6028.0 6095.3 6182.1 929.8 942.4 952.9 968.7 1003.7 3994.6 4132.0 4190.2 4233.2 4235.6 10603.7 10951.9 10995.0 11177.8 11244.8 11243.6 11405.5 11415.3 11431.8 11442.9 8396.2 8694.5 8702.6 8708.7 8714.7 6036.7 6066.5 6110.7 6237.6 6274.4 10099.3 10206.6 10297.9 10450.5 10461.3 9251.9 9540.7 10545.8 10655.7 10705.7 7598.6 7718.7 7808.3 8006.8 8022.4 8832.2 8872.2 8883.5 8892.5 8902.1 7513.5 7553.7 7642.9 7659.6 7853.5 7796.9 7883.9 7905.1 7916.5 7926.6 7029.9 7157.3 7158.2 7166.2 7167.6 5193.8 5293.6 5329.1 5370.8 5528.7 5313.1 5319.6 5337.1 5367.9 5381.2 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | [#4] prototype.html Cycles:180 Average:4693.28 Median:5248.99 stddev:1338.60 (25.5%) stddev-sans-first:1301.66 13:13:05 INFO - PROCESS | 939 | Values: 329.3 330.2 331.7 346.2 353.6 5203.3 5330.5 5356.9 5367.2 5369.0 5192.7 5256.3 5296.3 5309.1 5328.7 4234.2 4238.4 4251.7 4252.3 4263.7 4157.1 4228.2 4248.4 4273.1 4277.5 4220.4 4225.5 4228.2 4228.9 4253.7 4219.3 4224.9 4227.4 4239.8 4239.9 3692.2 3818.0 3824.7 3835.0 3836.4 5189.3 5214.3 5222.2 5225.9 5227.8 4845.8 4892.3 4896.4 4916.9 4924.4 5324.7 5552.4 5586.1 5593.6 5606.7 4174.7 4181.1 4181.5 4209.7 4209.7 5742.8 5774.4 5811.5 5816.3 5839.6 4196.3 4257.4 4305.3 4309.1 4327.9 4285.6 4292.8 4296.5 4311.4 4312.3 4804.4 4815.0 4824.8 4830.2 4832.4 5360.4 5553.2 5577.2 5584.3 5613.0 1391.8 1408.2 1431.0 1452.3 1454.8 981.8 1015.4 1017.0 1017.7 1022.4 5048.5 5086.3 5086.6 5094.6 5106.5 5502.7 5510.0 5526.3 5538.9 5568.4 5082.4 5185.7 5212.0 5223.3 5419.3 2945.3 2966.5 2974.0 2978.3 2993.2 5740.0 5760.6 5782.0 5798.7 5834.3 5566.8 5725.3 5744.9 5750.7 5760.3 5697.3 5737.3 5747.5 5752.7 5761.7 5377.9 5581.4 5623.7 5687.7 5712.4 5465.3 5500.2 5527.7 5544.9 5584.3 5684.7 5692.5 5698.6 5712.2 5752.0 3945.7 4009.5 4023.8 4045.4 4085.8 5528.0 5569.9 5575.2 5577.5 5667.4 5429.0 5607.6 5648.5 5660.3 5661.6 5587.8 5629.5 5631.9 5635.8 5649.9 5447.7 5472.6 5493.9 5559.5 5569.2 5566.0 5576.7 5580.8 5585.8 5587.7 5241.7 5466.6 5530.4 5545.6 5559.4 13:13:05 INFO - PROCESS | 939 | 13:13:05 INFO - PROCESS | 939 | [#5] yui.html Cycles:180 Average:18289.10 Median:4830.47 stddev:23944.45 (495.7%) stddev-sans-first:23975.53 13:13:05 INFO - PROCESS | 939 | Values: 781.6 787.0 801.6 819.2 871.6 14804.3 15759.4 15775.1 15827.9 15879.9 13833.6 14518.6 14661.9 14669.6 14683.3 715.4 729.5 829.0 842.0 857.9 853.4 853.8 854.2 859.3 861.5 874.5 875.3 875.3 876.1 876.5 757.6 780.5 870.0 883.4 891.7 651.6 651.6 651.9 651.9 652.7 14787.6 15091.8 15096.9 15134.8 15140.0 13653.9 13682.7 13852.2 14142.4 14213.8 11738.4 11779.8 11854.8 12061.4 12144.9 4581.4 4605.9 4644.0 4673.5 4770.2 65460.3 65677.0 67891.6 67938.3 68165.3 11402.3 11479.0 11568.1 11792.0 11953.2 20344.0 20344.3 20348.9 20386.9 20469.6 8459.7 8471.0 8607.1 8760.0 8853.4 4762.5 4852.8 4911.8 4999.0 5107.9 3583.9 3676.1 3679.9 3706.8 3711.8 645.0 662.9 663.0 671.2 683.3 753.2 762.0 784.1 790.2 804.4 9633.7 9711.6 9792.4 9836.8 9857.0 638.3 716.1 746.4 763.8 784.1 4643.6 4808.2 4871.7 4954.3 4991.2 90737.1 91447.0 91705.0 91961.5 92333.0 80114.0 80796.2 82482.2 82606.0 83081.6 58547.0 60249.7 63003.4 65100.7 65122.0 9845.2 9936.0 10140.7 10194.0 10312.4 44308.8 46153.8 46193.0 46683.3 47664.3 54889.0 60862.0 62652.0 63871.0 66186.0 12746.0 12868.7 12879.4 13004.3 13033.1 14281.1 14285.3 14496.6 14528.6 15278.0 12923.3 12957.3 13411.9 13428.7 13451.7 13703.7 13806.6 13848.7 13973.8 14411.2 13564.5 13964.5 13996.3 14216.5 14427.9 10008.2 11060.6 11097.0 11407.1 11752.2 11062.3 11062.3 11344.7 11353.7 11689.2 13:13:05 INFO - PROCESS | 939 | -------- Summary: end -------- 13:13:05 INFO - PROCESS | 939 | 13:13:06 INFO - TEST-INFO | 939: exit 0 13:13:06 INFO - TEST-OK | dromaeo_css | took 1114903ms 13:13:06 INFO - TEST-START | kraken 13:13:06 INFO - operating with platform_type : linux_ 13:13:06 INFO - Initialising browser for kraken test... 13:13:06 INFO - TEST-INFO | started process 1287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2tw7yt/profile http://localhost:41298/getInfo.html) 13:13:10 INFO - PROCESS | 1287 | __metrics Screen width/height:1600/1200 13:13:10 INFO - PROCESS | 1287 | colorDepth:24 13:13:10 INFO - PROCESS | 1287 | Browser inner width/height: 1024/697 13:13:10 INFO - PROCESS | 1287 | __metrics 13:13:11 INFO - PROCESS | 1287 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:13:11 INFO - PROCESS | 1287 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:11 INFO - PROCESS | 1287 | console.error: PushService: 13:13:11 INFO - PROCESS | 1287 | stateChangeProcessEnqueue: Error transitioning state 13:13:11 INFO - PROCESS | 1287 | UnknownError 13:13:12 INFO - TEST-INFO | 1287: exit 0 13:13:12 INFO - Browser initialized. 13:13:12 INFO - Running cycle 1/1 for kraken test... 13:13:12 INFO - TEST-INFO | started process 1381 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2tw7yt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:24 INFO - PROCESS | 1381 | RSS: Main: 143876096 13:13:24 INFO - PROCESS | 1381 | 13:13:26 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41298/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:27 INFO - PROCESS | 1381 | RSS: Main: 184877056 13:13:27 INFO - PROCESS | 1381 | 13:13:29 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41298/tests/kraken/driver.html?testName=audio-dft) 13:13:30 INFO - PROCESS | 1381 | RSS: Main: 175263744 13:13:30 INFO - PROCESS | 1381 | 13:13:33 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41298/tests/kraken/driver.html?testName=audio-fft) 13:13:33 INFO - PROCESS | 1381 | RSS: Main: 265965568 13:13:33 INFO - PROCESS | 1381 | 13:13:35 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41298/tests/kraken/driver.html?testName=audio-oscillator) 13:13:36 INFO - PROCESS | 1381 | RSS: Main: 173887488 13:13:36 INFO - PROCESS | 1381 | 13:13:38 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41298/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:39 INFO - PROCESS | 1381 | RSS: Main: 175947776 13:13:39 INFO - PROCESS | 1381 | 13:13:42 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41298/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:42 INFO - PROCESS | 1381 | RSS: Main: 213835776 13:13:42 INFO - PROCESS | 1381 | 13:13:46 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41298/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:46 INFO - PROCESS | 1381 | RSS: Main: 212459520 13:13:46 INFO - PROCESS | 1381 | 13:13:49 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41298/tests/kraken/driver.html?testName=json-parse-financial) 13:13:49 INFO - PROCESS | 1381 | RSS: Main: 211222528 13:13:49 INFO - PROCESS | 1381 | 13:13:51 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41298/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:13:51 INFO - PROCESS | 1381 | RSS: Main: 173817856 13:13:51 INFO - PROCESS | 1381 | 13:13:53 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:13:54 INFO - PROCESS | 1381 | RSS: Main: 181317632 13:13:54 INFO - PROCESS | 1381 | 13:13:56 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:13:56 INFO - PROCESS | 1381 | RSS: Main: 189648896 13:13:56 INFO - PROCESS | 1381 | 13:13:59 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:00 INFO - PROCESS | 1381 | RSS: Main: 199471104 13:14:00 INFO - PROCESS | 1381 | 13:14:02 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:03 INFO - PROCESS | 1381 | RSS: Main: 195305472 13:14:03 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | Cycle 1(1): loaded http://localhost:41298/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41298/tests/kraken/driver.html?testName=ai-astar) 13:14:05 INFO - PROCESS | 1381 | RSS: Main: 246784000 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | __start_tp_report 13:14:05 INFO - PROCESS | 1381 | _x_x_mozilla_page_load 13:14:05 INFO - PROCESS | 1381 | _x_x_mozilla_page_load_details 13:14:05 INFO - PROCESS | 1381 | |i|pagename|runs| 13:14:05 INFO - PROCESS | 1381 | |0;ai-astar;102;112;109;111;111;111;113;112;109;113 13:14:05 INFO - PROCESS | 1381 | |1;audio-beat-detection;145;117;117;151;119;118;119;117;142;117 13:14:05 INFO - PROCESS | 1381 | |2;audio-dft;161;161;162;161;162;161;161;161;160;162 13:14:05 INFO - PROCESS | 1381 | |3;audio-fft;74;75;75;106;77;76;75;75;96;75 13:14:05 INFO - PROCESS | 1381 | |4;audio-oscillator;82;81;109;82;83;83;103;82;82;116 13:14:05 INFO - PROCESS | 1381 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 13:14:05 INFO - PROCESS | 1381 | |6;imaging-darkroom;146;147;147;146;146;146;146;146;147;146 13:14:05 INFO - PROCESS | 1381 | |7;imaging-desaturate;86;85;84;84;85;85;85;84;84;84 13:14:05 INFO - PROCESS | 1381 | |8;json-parse-financial;49;50;50;50;50;50;50;49;50;51 13:14:05 INFO - PROCESS | 1381 | |9;json-stringify-tinderbox;60;59;59;61;61;60;61;60;61;62 13:14:05 INFO - PROCESS | 1381 | |10;stanford-crypto-aes;76;75;74;75;80;74;84;75;75;75 13:14:05 INFO - PROCESS | 1381 | |11;stanford-crypto-ccm;127;127;132;132;120;120;119;119;171;125 13:14:05 INFO - PROCESS | 1381 | |12;stanford-crypto-pbkdf2;155;155;155;160;158;156;152;159;155;157 13:14:05 INFO - PROCESS | 1381 | |13;stanford-crypto-sha256-iterative;63;62;63;66;66;62;67;62;61;60 13:14:05 INFO - PROCESS | 1381 | __end_tp_report 13:14:05 INFO - PROCESS | 1381 | __start_cc_report 13:14:05 INFO - PROCESS | 1381 | _x_x_mozilla_cycle_collect,1585 13:14:05 INFO - PROCESS | 1381 | __end_cc_report 13:14:05 INFO - PROCESS | 1381 | __startTimestamp1484342045282__endTimestamp 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | ------- Summary: start ------- 13:14:05 INFO - PROCESS | 1381 | Number of tests: 14 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.23 (2.9%) stddev-sans-first:1.48 13:14:05 INFO - PROCESS | 1381 | Values: 102.0 112.0 109.0 111.0 111.0 111.0 113.0 112.0 109.0 113.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:119.00 stddev:13.85 (11.6%) stddev-sans-first:12.92 13:14:05 INFO - PROCESS | 1381 | Values: 145.0 117.0 117.0 151.0 119.0 118.0 119.0 117.0 142.0 117.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:14:05 INFO - PROCESS | 1381 | Values: 161.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 160.0 162.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:11.14 (14.9%) stddev-sans-first:11.57 13:14:05 INFO - PROCESS | 1381 | Values: 74.0 75.0 75.0 106.0 77.0 76.0 75.0 75.0 96.0 75.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:82.00 stddev:13.50 (16.5%) stddev-sans-first:13.98 13:14:05 INFO - PROCESS | 1381 | Values: 82.0 81.0 109.0 82.0 83.0 83.0 103.0 82.0 82.0 116.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:14:05 INFO - PROCESS | 1381 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 13:14:05 INFO - PROCESS | 1381 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 13:14:05 INFO - PROCESS | 1381 | Values: 86.0 85.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 84.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 13:14:05 INFO - PROCESS | 1381 | Values: 49.0 50.0 50.0 50.0 50.0 50.0 50.0 49.0 50.0 51.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 13:14:05 INFO - PROCESS | 1381 | Values: 60.0 59.0 59.0 61.0 61.0 60.0 61.0 60.0 61.0 62.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#10] stanford-crypto-aes Cycles:10 Average:76.30 Median:75.00 stddev:3.20 (4.3%) stddev-sans-first:3.39 13:14:05 INFO - PROCESS | 1381 | Values: 76.0 75.0 74.0 75.0 80.0 74.0 84.0 75.0 75.0 75.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:127.00 stddev:15.52 (12.2%) stddev-sans-first:16.44 13:14:05 INFO - PROCESS | 1381 | Values: 127.0 127.0 132.0 132.0 120.0 120.0 119.0 119.0 171.0 125.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:156.50 stddev:2.35 (1.5%) stddev-sans-first:2.45 13:14:05 INFO - PROCESS | 1381 | Values: 155.0 155.0 155.0 160.0 158.0 156.0 152.0 159.0 155.0 157.0 13:14:05 INFO - PROCESS | 1381 | 13:14:05 INFO - PROCESS | 1381 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:2.35 (3.7%) stddev-sans-first:2.49 13:14:05 INFO - PROCESS | 1381 | Values: 63.0 62.0 63.0 66.0 66.0 62.0 67.0 62.0 61.0 60.0 13:14:05 INFO - PROCESS | 1381 | -------- Summary: end -------- 13:14:05 INFO - PROCESS | 1381 | 13:14:06 INFO - TEST-INFO | 1381: exit 0 13:14:06 INFO - TEST-OK | kraken | took 60023ms 13:14:06 INFO - SUITE-END | took 1174s 13:14:06 INFO - Completed test suite (00:19:35) 13:14:06 INFO - javascript benchmark 13:14:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3201.9359612807743, 3217.4691175955954, 3224.32289219264, 3234.223786291288, 3242.2056596133934, 5536.0, 5575.832725018246, 5593.0, 5629.690367029812, 5644.435556444359, 5626.887462250753, 5679.517241034517, 5682.573806964484, 5693.8576535586635, 5712.057510510771, 5104.591632669387, 5132.692038477703, 5160.716160611165, 5179.983753370179, 5207.739613019353, 4987.1521841286885, 5220.530152286294, 5221.738913054332, 5226.738663066851, 5226.895462090775, 4995.025969935864, 5021.221710634839, 5055.140626093555, 5066.265391518227, 5078.238264260353, 5126.7436628168625, 5170.560502357285, 5172.741362931838, 5239.79040838366, 5240.135377662719, 5060.190369540893, 5137.6403651744395, 5179.456157103487, 5205.661631993946, 5230.450802665741, 5325.680459172462, 5373.167159090347, 5444.482774136451, 5500.58745594082, 5512.751926163332, 5972.432618901197, 5978.940210597882, 5990.191324171225, 6079.6960151992225, 6080.9391906081255, 6127.509799216052, 6133.509319254449, 6139.539534534928, 6140.293866205398, 6151.354107818659, 5402.37872644647, 5451.073317536028, 5566.888662226733, 5622.91565626516, 5624.803131890446, 6179.752809887644, 6195.0, 6204.100405441186, 6209.813705588749, 6216.7824126155365, 5945.910811337833, 5949.940500594938, 5951.434613711777, 5954.047352423591, 5956.434138756811, 5772.9711351442975, 5829.59192856496, 5837.066069428871, 5971.671558064349, 6041.365656606081, 6053.45518903292, 6057.727402266909, 6081.148639190517, 6088.330283668793, 6088.360722124113, 6034.306054803754, 6056.545759068, 6091.756329746849, 6095.725692343855, 6101.420365065312, 4528.728276303366, 4574.862754117382, 4614.630829533629, 4730.195866702668, 4731.976340118277, 4141.4616099907425, 4175.227582897113, 4181.247375472383, 4203.47456567929, 4225.281702110648, 5694.601377903507, 5696.8860622787315, 5698.0598201296325, 5700.6009579329875, 5758.136279558016, 5774.191613174159, 5830.096335068071, 6017.247844019497, 6028.306744724325, 6031.306399763996, 5475.698836564027, 5571.13647384656, 5620.915686264628, 5687.60186786921, 5711.457411545896, 5150.845474635767, 5178.275041494194, 5187.403448603383, 5189.455107213764, 5192.8961420771375, 5910.556708246812, 6120.755169793248, 6158.568900177034, 6181.134641150243, 6181.938180618136, 5802.564807639359, 5879.382664820303, 5952.494038006645, 5957.434043765836, 6003.459688628044, 6125.724342404514, 6126.632402055891, 6126.846828829315, 6127.448529632355, 6127.540434467343, 5865.912011319919, 5879.647221166743, 5881.176635271151, 5882.411758824083, 5886.646801191942, 5845.210896528914, 5850.473457388855, 5960.970195148997, 6011.819645410645, 6032.306284777307, 5873.442023007808, 5920.496757775637, 5926.822195334147, 5931.021381472009, 5934.495567876606, 5880.088586269135, 5891.293044834647, 5892.204552385545, 5900.055991041413, 5901.232839730807, 5577.0, 5711.086226203787, 5716.942830571641, 5807.186993820784, 5829.183914251923, 5849.239598852122, 5916.852078698067, 5918.881622367442, 5930.495907847881, 5939.940600594112, 5536.446355364593, 5789.768409263751, 5797.101449275369, 5801.0, 5805.448482394166], "value": 5533.661788657651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4894467341077, 606.7500948047024, 628.7673560782512, 643.7618081309917, 646.221303329488, 35036.299274014505, 35561.46657800132, 37881.62118378812, 45895.0, 47046.0, 46490.30264546026, 47073.11707531694, 47156.764216178955, 47177.528224717746, 47260.29109563359, 8771.254443372321, 8923.866142007875, 8925.107489251088, 8925.776855578597, 8927.06265842087, 8379.706710265142, 8562.828743425127, 10477.84283235752, 10707.143428525738, 10721.195910306718, 10627.149828013778, 10674.893251067506, 10686.893131068706, 10694.358338499715, 10695.625653102143, 10595.0, 10618.097461715763, 10659.147268218523, 10680.839787403194, 10683.732906677318, 10554.788904221949, 10614.734631634194, 10626.415547144903, 10629.309094908805, 10630.362178269328, 43670.781646091564, 43832.78083609593, 43879.0, 43879.48964082866, 44038.77980610108, 3656.634336566349, 3717.442383642448, 3771.302309072803, 3775.9433608495897, 3825.0437390652337, 33117.503237451456, 33266.16834579155, 33378.0, 33437.0, 33850.322993540234, 4449.57729015743, 4547.477040140393, 4572.862814115582, 4577.816887324503, 4627.0, 359022.0, 359580.0, 359928.0, 360693.0, 361102.0, 63895.68052159803, 64145.679271603345, 64206.35793642097, 64234.0, 64266.6786666073, 39719.0, 39766.806995790175, 39789.0, 43414.7829260858, 43452.3482147768, 18414.079296035146, 18534.351297704787, 18552.05203453645, 18590.53523661919, 18591.070446477894, 11775.587854425054, 12010.099242556844, 14020.649483762783, 14119.082259653089, 14126.434942602385, 16629.16854157287, 16951.745723814154, 20448.284310049075, 21248.825777720333, 21267.574648506943, 7160.677769500385, 7198.92801071993, 7434.665440055211, 7515.173330933593, 7540.509866858637, 961.2838435365697, 966.4587830814626, 1010.4493051287067, 1026.9537870795832, 1146.0545050333342, 33824.66175338264, 34036.0, 34086.829565852015, 34348.14129646779, 34504.0, 1088.1294964028746, 1120.3781901044836, 1130.2766229613055, 1162.2619636530694, 1199.56215981168, 16801.269967258755, 17822.51755315473, 17923.73114403285, 17955.703772077333, 19203.807961920204, 567086.0, 570337.0, 572848.0, 573355.0, 574018.0, 63806.68096659487, 64307.0, 64405.355946440875, 64522.03216951749, 64561.0, 1277.8530468995998, 1315.9144655597547, 1375.938082786277, 1389.8957578181678, 1402.3338914015965, 30061.398772024873, 34345.656543435245, 34658.48012279868, 34899.47650785291, 35094.473582895764, 54102.72948635231, 54722.0, 54855.451445485036, 54971.450285496634, 55072.0, 343693.0, 346047.0, 346249.0, 346891.0, 347220.0, 29865.104046878627, 29888.0, 31255.218619533785, 32291.19272018218, 32365.838170809937, 48544.514554854, 49507.75246123746, 49670.75164624154, 50172.0, 50294.245586315505, 41810.37284440675, 43115.13769724651, 43184.78407607942, 43464.0, 44213.77893110514, 42141.367879482445, 42444.0, 42674.14651706886, 44572.0, 44658.0, 42001.159976800904, 42798.14403711846, 43658.56341436545, 43746.0, 43838.56161438345, 35900.28199436049, 38249.80875095718, 38550.22899541938, 38865.61134388733, 39316.60683393129, 29137.271568210963, 29226.0, 29416.26459338534, 29512.704872950995, 29579.852100739357], "value": 20886.97794891666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.0953730122308, 395.59451562148814, 416.68123885227794, 422.4276105876537, 423.94064830923674, 13959.0, 15915.602109947256, 19256.22975080995, 19829.40511784645, 20131.0, 19006.809931900676, 19289.421317360502, 19612.0, 19806.40580782575, 20055.799442005577, 4829.444613869415, 5735.340435849868, 5898.262717160355, 5937.346891841916, 5937.88124237515, 5823.242978412801, 5917.970410147943, 5919.260092488439, 5924.0521516557355, 5924.081767326072, 5824.679642619654, 5887.558433117512, 5889.911651325212, 6076.422739839731, 6111.633302001872, 6062.363451837582, 6077.483413909823, 6100.176476175749, 6116.327204007578, 6116.785912493064, 5761.769529218868, 5964.373740757244, 5980.491658209057, 5982.312034116088, 5982.551308651825, 14663.926680366636, 14667.48663796762, 14700.852991470056, 14798.630034249123, 14917.104973701504, 2261.8190544756544, 2368.289513146049, 2372.857628542293, 2586.9910734813247, 2974.5240761478058, 10973.957474039953, 11090.334579925231, 11169.218154729173, 13018.349082545836, 14837.629059273497, 1957.168203513501, 1981.3560592807396, 2004.4086994336706, 2091.487585541552, 2105.1789801977243, 80314.59842700748, 85643.0, 86095.56952215261, 86421.0, 88453.0, 11469.71325716847, 11656.30062196271, 11678.70803229926, 11680.415979201176, 11803.763924721628, 16727.665446690997, 16735.49793506197, 16743.330266789435, 16744.330226790793, 16767.245473953702, 8157.632906519221, 8236.711715089943, 8237.588120593946, 8331.458455200393, 8385.538795366314, 7737.342325902248, 7748.535087894745, 7897.565633890076, 7923.603819808986, 7929.246721561558, 4856.660033797671, 4868.683535570177, 4952.108620448354, 4956.653034287565, 5106.948930510647, 2028.665270230425, 2031.248438077891, 2032.8780273183656, 2069.2550681754556, 2080.199123337526, 805.255138996426, 983.4836710726782, 1031.7884833609091, 1130.3218069158604, 1131.0725205331714, 19374.0, 19586.608267834563, 19592.118354674072, 19600.70598941017, 20158.59682806365, 991.4844280973854, 1008.8032833597379, 1018.8828284747201, 1030.0, 1070.5022164693455, 10244.180465562737, 10783.352998820095, 10840.728981775519, 10881.945590271998, 11018.39398833072, 480320.0, 483254.0, 486579.0, 490797.0, 493110.0, 55167.0, 56851.43148568461, 76933.6153319241, 98920.50539747255, 101301.0, 964.5466630683568, 984.7144328144901, 986.2571541001915, 990.5740531571349, 1003.9046290602381, 17251.82748172502, 18074.638507230044, 18129.546761330545, 18382.356617518322, 18642.44072677822, 39071.41392879052, 43042.56957430386, 43745.343819843365, 43912.0, 43983.560164397946, 54700.90598187935, 54842.0, 58292.0, 59102.40897590969, 59642.70178649079, 7892.210778922062, 8350.58247087631, 8401.747947561584, 8450.915490845013, 8748.562571871254, 12856.228626282453, 13626.863731362559, 13753.106048106842, 13851.23818189969, 13995.440182392591, 11597.6520704379, 11818.881811181778, 11946.223495472766, 12209.267443953391, 12247.142700010914, 11187.608433704781, 11427.0, 11566.65300041, 11867.762644746885, 11985.64043078709, 11702.180847340604, 11941.64175074749, 11972.401379931143, 11974.820377694168, 12214.328211948428, 8933.15135062168, 8940.776480588038, 8962.641494340154, 9285.72142835716, 9378.390404623678, 9349.53252337394, 12073.818892716441, 12106.273623582612, 12444.128910976146, 12515.624531264077], "value": 9309.667077008377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1365.1467832604621, 1496.0425327790213, 1530.8086489188852, 1640.1963038111328, 1787.26722043962, 7795.92204077959, 8705.347098967572, 9094.636214551418, 9095.90904090959, 9098.681546145886, 8930.687425940094, 9010.72967810965, 9011.909880901188, 9013.278937684985, 9014.098590140982, 2446.131623273739, 2473.5794914864427, 2479.3429741118616, 2479.764422379871, 2479.938001549958, 2386.713594368678, 2441.584930561809, 2443.987780061097, 2447.4615584571366, 2449.5835707929605, 2361.988190059047, 2396.9280921572295, 2406.1698713943747, 2443.584590619599, 2447.938801529967, 2369.277370402027, 2380.5952987991996, 2388.199953015742, 2398.124684490166, 2402.8318017738766, 2343.390718413225, 2348.896018871128, 2371.0989823866994, 2371.5256948610345, 2373.2524254859663, 8693.347998900044, 8906.86639700405, 8994.595243214006, 8999.100089991014, 9080.22818060459, 5296.3379577552805, 5513.448655134494, 5526.336839579236, 5531.170324451325, 5531.502164805147, 3415.077928959167, 3424.8116353600544, 3517.22621023377, 3547.7693949893173, 3554.697850682695, 1196.1328037173066, 1212.8180772884139, 1234.0497816681195, 1249.8750124987428, 1280.359820089955, 12555.372231388485, 12661.493540258287, 12702.110852240347, 12708.936455317757, 12727.0, 4298.978505107454, 4651.651126165551, 4690.390249267642, 4740.051989602024, 4745.264484004984, 10087.04173103554, 10087.04173103554, 10090.394576325298, 10091.0, 10091.798164036825, 5412.56699464042, 5413.621046526705, 5415.458454154632, 5417.0, 5417.83746487606, 4255.489341279066, 4387.407699960529, 4574.268117101248, 5082.059818933435, 5085.898282034413, 4103.420183229418, 4122.715353220668, 4190.266703326905, 4204.894877628022, 4224.809883555247, 1218.567408569945, 1228.177121328712, 1231.9076069294838, 1238.325112813519, 1245.9813102803466, 965.232640051161, 996.1433167475965, 1002.6390499420203, 1003.2876657573205, 1016.9491525423699, 5715.4570315820765, 5860.8534786629825, 6028.0, 6095.2685677718955, 6182.103594978703, 929.7815013471828, 942.40157499988, 952.8999455057258, 968.6900191938512, 1003.7289931718395, 3994.6005399459823, 4131.97934010328, 4190.182914331737, 4233.174530966432, 4235.576442355801, 10603.734906627242, 10951.890481095246, 10995.0, 11177.776444471065, 11244.831327530093, 11243.606473773541, 11405.486753096131, 11415.258008229439, 11431.828522572168, 11442.885571144348, 8396.160383961555, 8694.521801300989, 8702.608382622797, 8708.69519566812, 8714.694985675598, 6036.69816509164, 6066.484348830222, 6110.7250173741395, 6237.563370564017, 6274.403931626488, 10099.343542669703, 10206.642767503101, 10297.9485102574, 10450.529726162189, 10461.320014199357, 9251.86122208154, 9540.666076687283, 10545.841812372668, 10655.733606659896, 10705.678829635124, 7598.582077985543, 7718.729844455417, 7808.258215469521, 8006.799830004296, 8022.435625053058, 8832.160944710242, 8872.201501864864, 8883.466991980502, 8892.510911899908, 8902.065283145177, 7513.549187048795, 7553.660085296065, 7642.923570764444, 7659.617019148909, 7853.528788272493, 7796.88304675419, 7883.921160788548, 7905.130435652189, 7916.485428447132, 7926.643301051351, 7029.929700703132, 7157.320054594805, 7158.212596614472, 7166.247544007804, 7167.569945803269, 5193.76628051731, 5293.5765138789575, 5329.147336426153, 5370.812021579226, 5528.700755322577, 5313.070212712837, 5319.574434045189, 5337.092694241911, 5367.946320536745, 5381.165919282517], "value": 4751.058604163025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.2657374055855, 330.20585491891995, 331.65342217382835, 346.1674672412847, 353.6127939905802, 5203.2975548300965, 5330.546903513196, 5356.892862142759, 5367.248585198071, 5368.973155134228, 5192.7403629818455, 5256.26412302278, 5296.285001524793, 5309.097453432916, 5328.733563321838, 4234.21666991606, 4238.427812245346, 4251.723637963522, 4252.255855225323, 4263.678259739475, 4157.127003329305, 4228.175505776375, 4248.447701798762, 4273.145370925812, 4277.52425413232, 4220.36694495825, 4225.535191128974, 4228.1966426378885, 4228.894277643069, 4253.702240843142, 4219.303814870543, 4224.852130175429, 4227.408162857187, 4239.8092085856215, 4239.876432745325, 3692.2061756722164, 3817.9809100954594, 3824.7131465139946, 3835.0, 3836.4437156612134, 5189.273501709764, 5214.296070030573, 5222.16445368743, 5225.921611175835, 5227.843164705065, 4845.75771211438, 4892.290617860426, 4896.363472748555, 4916.877078073041, 4924.409070911478, 5324.653897496689, 5552.3892371839065, 5586.106223004341, 5593.552515798727, 5606.747696353674, 4174.70777045607, 4181.142865712552, 4181.519125300599, 4209.705320627558, 4209.7474151551005, 5742.827715168552, 5774.364819869811, 5811.501054546543, 5816.272965879265, 5839.64962102271, 4196.307609244441, 4257.40396344512, 4305.332673435622, 4309.095090031066, 4327.891802704958, 4285.635720963753, 4292.806823692878, 4296.484421869396, 4311.413152108709, 4312.331588603772, 4804.447488538793, 4814.9518504815205, 4824.782884770194, 4830.227163653799, 4832.371791667061, 5360.410354860962, 5553.194786755897, 5577.163425486209, 5584.329880414295, 5612.97193514038, 1391.7981892625714, 1408.2325132802648, 1431.0, 1452.3028946105928, 1454.7852543126396, 981.8379967305315, 1015.3603229965074, 1016.974575635615, 1017.6997785653102, 1022.437659287389, 5048.545630893163, 5086.313347698014, 5086.567641750418, 5094.592432605383, 5106.489351064938, 5502.724863756796, 5509.972450137724, 5526.309211348582, 5538.944610553924, 5568.415316391802, 5082.364704411949, 5185.714785686748, 5212.0, 5223.268742376071, 5419.34967803866, 2945.2931296488687, 2966.5463922678164, 2974.048304542569, 2978.27032377069, 2993.206800197949, 5740.0, 5760.567957403212, 5781.9763082920645, 5798.710064496842, 5834.299884013945, 5566.805161819317, 5725.255716756795, 5744.856378590485, 5750.654960702372, 5760.308762948473, 5697.287839020122, 5737.250138707651, 5747.505648531328, 5752.6836024019085, 5761.683107429131, 5377.919331210113, 5581.386047534849, 5623.662580245198, 5687.658740475585, 5712.400197979152, 5465.316835395575, 5500.23992322453, 5527.668339899458, 5544.889102218014, 5584.274044374205, 5684.669285592887, 5692.4876761090045, 5698.572607054404, 5712.200291959212, 5751.97124014394, 3945.723799334019, 4009.478767760289, 4023.8390464381096, 4045.422285308791, 4085.7752823594988, 5527.972360138174, 5569.888602227852, 5575.1915972184615, 5577.525910297508, 5667.40492248308, 5428.972855135699, 5607.5513958882375, 5648.5481161507805, 5660.29246344207, 5661.575381846295, 5587.832365029056, 5629.54963602919, 5631.887362252814, 5635.773869321513, 5649.858753531194, 5447.74701818576, 5472.616916815944, 5493.862653433696, 5559.470440949439, 5569.220309156803, 5565.972170139124, 5576.665400076008, 5580.832575022756, 5585.832425027255, 5587.74855131512, 5241.715779634014, 5466.638017619215, 5530.364008139116, 5545.584081194007, 5559.388467268516], "value": 4269.35154377886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.5779479081297, 787.0437418536477, 801.6432687454082, 819.2135549872119, 871.5511511571542, 14804.333804978774, 15759.448419305327, 15775.13236771977, 15827.920860395681, 15879.92060039701, 13833.584992450218, 14518.637034074154, 14661.926690366534, 14669.633259168526, 14683.265836708175, 715.3633266392915, 729.4930023633577, 828.9709860154895, 842.0316635868754, 857.8841856349406, 853.4495250563383, 853.7780177153923, 854.1970547685156, 859.3039637893295, 861.5003298087125, 874.4884242718017, 875.2997601918472, 875.3216257400502, 876.0888675777184, 876.4565969099135, 757.5946868425393, 780.4809801482007, 869.9565021748919, 883.4301875290402, 891.6968230801558, 651.6253154436218, 651.6318280171688, 651.8500744828716, 651.8663673946829, 652.7160685101949, 14787.556373308711, 15091.849081509154, 15096.924515377463, 15134.848651513454, 15140.0, 13653.931730341385, 13682.726345473135, 13852.16886986784, 14142.434302627882, 14213.786793198007, 11738.413079345999, 11779.764404711857, 11854.762904741858, 12061.396930153545, 12144.939275303655, 4581.404417425713, 4605.861824145248, 4644.0, 4673.509281525425, 4770.236762118045, 65460.345396545905, 65677.0, 67891.56867450592, 67938.32061679369, 68165.31834681639, 11402.315861048364, 11479.0, 11568.13239007061, 11792.0, 11953.163278570417, 20344.0, 20344.287949921683, 20348.89825550863, 20386.898065509577, 20469.59060818775, 8459.746207613782, 8471.0, 8607.139286071342, 8760.036395996436, 8853.424527405827, 4762.476127625959, 4852.781624826821, 4911.778969946361, 4999.02519008797, 5107.923381149286, 3583.874564390234, 3676.1361080146144, 3679.8528058877346, 3706.777593344408, 3711.7958512282084, 645.029231007331, 662.8574856405896, 662.9801105966828, 671.2448495442627, 683.2654895986834, 753.179034852014, 761.9733309334147, 784.1413652050995, 790.1861083084432, 804.4007214625142, 9633.710988670351, 9711.562979665932, 9792.363496372713, 9836.803263934682, 9857.014298570086, 638.2946843737695, 716.0726858717973, 746.3805041815281, 763.7670510494353, 784.1296161260996, 4643.558861908114, 4808.158572249912, 4871.707697538159, 4954.3063971044085, 4991.151504244287, 90737.09262907287, 91447.0, 91705.0, 91961.54019229994, 92333.0, 80114.0, 80796.19203808004, 82482.17517824865, 82606.0, 83081.58459207666, 58547.0, 60249.69875150596, 63003.36996629975, 65100.67449662816, 65122.0, 9845.212383009199, 9935.950320248352, 10140.695779126638, 10194.0, 10312.381257124596, 44308.77845610751, 46153.76923115363, 46193.0, 46683.29975050309, 47664.2850357238, 54889.0, 60862.0, 62652.0, 63871.0, 66186.0, 12746.044046696721, 12868.678283042998, 12879.420426081037, 13004.349782511026, 13033.087683862039, 14281.14313141215, 14285.28573571338, 14496.637584060483, 14528.564143075724, 15278.0, 12923.28921909304, 12957.287349195885, 13411.932940335237, 13428.731425371634, 13451.663708407368, 13703.657408564866, 13806.585802425943, 13848.653783655489, 13973.790393143907, 14411.207383594003, 13564.457421703022, 13964.511242106477, 13996.300184990914, 14216.502422415166, 14427.92786036063, 10008.249381296286, 11060.612878549213, 11097.00126988575, 11407.144464165387, 11752.23610465317, 11062.280951738112, 11062.336259824437, 11344.716382090513, 11353.659390218307, 11689.181757276909], "value": 7454.048424179379, "unit": "score"}], "name": "dromaeo_css", "value": 7388.709427649037, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 109.0, 111.0, 111.0, 111.0, 113.0, 112.0, 109.0, 113.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 117.0, 151.0, 119.0, 118.0, 119.0, 117.0, 142.0, 117.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 106.0, 77.0, 76.0, 75.0, 75.0, 96.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 82.0, 83.0, 83.0, 103.0, 82.0, 82.0, 116.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 50.0, 51.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 62.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 75.0, 80.0, 74.0, 84.0, 75.0, 75.0, 75.0], "value": 76.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 132.0, 132.0, 120.0, 120.0, 119.0, 119.0, 171.0, 125.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 155.0, 160.0, 158.0, 156.0, 152.0, 159.0, 155.0, 157.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 66.0, 66.0, 62.0, 67.0, 62.0, 61.0, 60.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1451.6000000000001, "alertThreshold": 2.0}]} 13:14:07 INFO - Return code: 0 13:14:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:07 INFO - # TBPL SUCCESS # 13:14:07 INFO - Running post-action listener: _resource_record_post_action 13:14:07 INFO - [mozharness: 2017-01-13 21:14:07.093609Z] Finished run-tests step (success) 13:14:07 INFO - Running post-run listener: _resource_record_post_run 13:14:07 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 369033216; Read time: 36; Write time: 238732 13:14:07 INFO - TinderboxPrint: CPU usage
13.0% 13:14:07 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 13:14:07 INFO - TinderboxPrint: I/O write bytes / time
369,033,216 / 238,732 13:14:07 INFO - TinderboxPrint: CPU idle
8,277.2 (87.0%) 13:14:07 INFO - TinderboxPrint: CPU user
1,192.4 (12.5%) 13:14:07 INFO - TinderboxPrint: Swap in / out
0 / 0 13:14:07 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119205888; Read time: 0; Write time: 84816 13:14:07 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248676352; Read time: 20; Write time: 153880 13:14:07 INFO - Running post-run listener: _upload_blobber_files 13:14:07 INFO - Blob upload gear active. 13:14:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:07 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 13:14:07 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:14:07 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:08 INFO - (blobuploader) - INFO - Done attempting. 13:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:09 INFO - (blobuploader) - INFO - Done attempting. 13:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:13 INFO - (blobuploader) - INFO - Done attempting. 13:14:13 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:13 INFO - Return code: 0 13:14:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a150c1966dc292235361188f73fec9efdfa008201ade71e2f623e2e7ad95cf42085d8ae0714aaf6bd35369c534264bc7439169f20994f20d5503b8ae3b2983f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d60184b6f04a799d0edd1bff32771e6d8bc8c50f1ad08188fcdfd90af991079a2dca5c5a11d1df27214d0e2ee0969322d04c0a594577fcc47f298d17b8162658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b528d7a5a1ed9896723fb806ead1f430a258af2bbcb133b3df12a783ade8bd382e4dc85b501c3b0f1eb1fa2f099b97b1f6b9fdeed3559a56a09efdcde6191077"} 13:14:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:13 INFO - Contents: 13:14:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a150c1966dc292235361188f73fec9efdfa008201ade71e2f623e2e7ad95cf42085d8ae0714aaf6bd35369c534264bc7439169f20994f20d5503b8ae3b2983f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d60184b6f04a799d0edd1bff32771e6d8bc8c50f1ad08188fcdfd90af991079a2dca5c5a11d1df27214d0e2ee0969322d04c0a594577fcc47f298d17b8162658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b528d7a5a1ed9896723fb806ead1f430a258af2bbcb133b3df12a783ade8bd382e4dc85b501c3b0f1eb1fa2f099b97b1f6b9fdeed3559a56a09efdcde6191077"} 13:14:13 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:13 INFO - Copying logs to upload dir... 13:14:13 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.202347 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-13 13:14:13.233847) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 13:14:13.238807) ========= 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=652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a150c1966dc292235361188f73fec9efdfa008201ade71e2f623e2e7ad95cf42085d8ae0714aaf6bd35369c534264bc7439169f20994f20d5503b8ae3b2983f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d60184b6f04a799d0edd1bff32771e6d8bc8c50f1ad08188fcdfd90af991079a2dca5c5a11d1df27214d0e2ee0969322d04c0a594577fcc47f298d17b8162658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b528d7a5a1ed9896723fb806ead1f430a258af2bbcb133b3df12a783ade8bd382e4dc85b501c3b0f1eb1fa2f099b97b1f6b9fdeed3559a56a09efdcde6191077"} build_url:https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/QXlqv-8wRtuilwMxhVTubg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a150c1966dc292235361188f73fec9efdfa008201ade71e2f623e2e7ad95cf42085d8ae0714aaf6bd35369c534264bc7439169f20994f20d5503b8ae3b2983f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d60184b6f04a799d0edd1bff32771e6d8bc8c50f1ad08188fcdfd90af991079a2dca5c5a11d1df27214d0e2ee0969322d04c0a594577fcc47f298d17b8162658", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b528d7a5a1ed9896723fb806ead1f430a258af2bbcb133b3df12a783ade8bd382e4dc85b501c3b0f1eb1fa2f099b97b1f6b9fdeed3559a56a09efdcde6191077"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 13:14:13.353637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 13:14:13.354058) ========= 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=652eb03db935cfc1c15ebda0000001ad-1484338023.324762-415780883 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004516 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 13:14:13.397913) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 13:14:13.398249) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 13:14:13.398546) ========= ========= Total master_lag: 0.22 =========