builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1478888290.91 results: success (0) buildid: 20161111073206 builduid: 8cfd8102b27e4a09913f483c2cbb77ee revision: bf3c647eec8100c19efd5ba415686bfd0854c113 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:10.913471) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:10.913875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:10.914182) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:10.928768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:10.929040) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-11 10:18:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2016-11-11 10:18:11 (15.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:11.023129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:11.023450) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021413 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:11.080750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 10:18:11.081152) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bf3c647eec8100c19efd5ba415686bfd0854c113 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev bf3c647eec8100c19efd5ba415686bfd0854c113 --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=e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-11 10:18:11,318 truncating revision to first 12 chars 2016-11-11 10:18:11,318 Setting DEBUG logging. 2016-11-11 10:18:11,318 attempt 1/10 2016-11-11 10:18:11,318 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bf3c647eec81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-11 10:18:12,371 unpacking tar archive at: mozilla-central-bf3c647eec81/testing/mozharness/ program finished with exit code 0 elapsedTime=1.402243 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-11 10:18:12.499256) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:12.499605) ========= script_repo_revision: bf3c647eec8100c19efd5ba415686bfd0854c113 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:12.499995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:12.500271) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-11 10:18:12.509975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-11 10:18:12.510289) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:18:12 INFO - MultiFileLogger online at 20161111 10:18:12 in /builds/slave/test 10:18:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:18:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:12 INFO - {'append_to_log': False, 10:18:12 INFO - 'base_work_dir': '/builds/slave/test', 10:18:12 INFO - 'blob_upload_branch': 'Firefox', 10:18:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:12 INFO - 'branch': 'Firefox', 10:18:12 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:12 INFO - 'config_files': ('talos/linux_config.py',), 10:18:12 INFO - 'default_actions': ('clobber', 10:18:12 INFO - 'read-buildbot-config', 10:18:12 INFO - 'download-and-extract', 10:18:12 INFO - 'populate-webroot', 10:18:12 INFO - 'create-virtualenv', 10:18:12 INFO - 'install', 10:18:12 INFO - 'run-tests'), 10:18:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:12 INFO - 'download_minidump_stackwalk': True, 10:18:12 INFO - 'download_symbols': 'ondemand', 10:18:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:12 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:12 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:12 INFO - 'installer_path': 'installer.exe', 10:18:12 INFO - 'log_level': 'info', 10:18:12 INFO - 'log_name': 'talos', 10:18:12 INFO - 'log_to_console': True, 10:18:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:18:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:18:12 INFO - 'opt_config_files': (), 10:18:12 INFO - 'pip_index': False, 10:18:12 INFO - 'sps_profile': False, 10:18:12 INFO - 'sps_profile_interval': 0, 10:18:12 INFO - 'suite': 'dromaeojs', 10:18:12 INFO - 'system_bits': '32', 10:18:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:12 INFO - 'title': 'talos-linux64-ix-067', 10:18:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:12 INFO - 'use_talos_json': True, 10:18:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:12 INFO - 'work_dir': 'build'} 10:18:12 INFO - [mozharness: 2016-11-11 18:18:12.837312Z] Running clobber step. 10:18:12 INFO - Running pre-action listener: _resource_record_pre_action 10:18:12 INFO - Running main action method: clobber 10:18:12 INFO - rmtree: /builds/slave/test/build 10:18:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:18:13 INFO - Running post-action listener: _resource_record_post_action 10:18:13 INFO - [mozharness: 2016-11-11 18:18:13.293342Z] Finished clobber step (success) 10:18:13 INFO - [mozharness: 2016-11-11 18:18:13.293442Z] Running read-buildbot-config step. 10:18:13 INFO - Running pre-action listener: _resource_record_pre_action 10:18:13 INFO - Running main action method: read_buildbot_config 10:18:13 INFO - Using buildbot properties: 10:18:13 INFO - { 10:18:13 INFO - "project": "", 10:18:13 INFO - "product": "firefox", 10:18:13 INFO - "script_repo_revision": "production", 10:18:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:18:13 INFO - "repository": "", 10:18:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:18:13 INFO - "buildid": "20161111073206", 10:18:13 INFO - "pgo_build": "True", 10:18:13 INFO - "basedir": "/builds/slave/test", 10:18:13 INFO - "buildnumber": 79, 10:18:13 INFO - "slavename": "talos-linux64-ix-067", 10:18:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:18:13 INFO - "platform": "ubuntu64_hw", 10:18:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:18:13 INFO - "branch": "mozilla-central", 10:18:13 INFO - "repo_path": "mozilla-central", 10:18:13 INFO - "revision": "bf3c647eec8100c19efd5ba415686bfd0854c113", 10:18:13 INFO - "stage_platform": "linux64-pgo", 10:18:13 INFO - "builduid": "8cfd8102b27e4a09913f483c2cbb77ee", 10:18:13 INFO - "slavebuilddir": "test" 10:18:13 INFO - } 10:18:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:18:13 INFO - Running post-action listener: _resource_record_post_action 10:18:13 INFO - [mozharness: 2016-11-11 18:18:13.295856Z] Finished read-buildbot-config step (success) 10:18:13 INFO - [mozharness: 2016-11-11 18:18:13.295944Z] Running download-and-extract step. 10:18:13 INFO - Running pre-action listener: _resource_record_pre_action 10:18:13 INFO - Running main action method: download_and_extract 10:18:13 INFO - mkdir: /builds/slave/test/build/tests 10:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:13 INFO - trying https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:18:13 INFO - Downloading https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:18:13 INFO - Downloaded 1361 bytes. 10:18:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:18:13 INFO - Using the following test package requirements: 10:18:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:18:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:18:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'jsshell-linux-x86_64.zip'], 10:18:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:18:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:18:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:18:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:18:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:18:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:18:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:18:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:18:13 INFO - Fetch https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:18:14 INFO - Http code: 200 10:18:14 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 10:18:14 INFO - x-amz-cf-id: imHuHpWqEnf70-vM2pRMhkr_Bp3NKkGk-X64RHSxzvylQPZeXuV0Yg== 10:18:14 INFO - x-amz-version-id: _VeDnQp.uRiFAQVKlnRLyX2dIO1sI88i 10:18:14 INFO - Expected file size: 21969191 10:18:14 INFO - Obtained file size: 21969191 10:18:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:18:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:18:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:18:18 INFO - Fetch https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:18:19 INFO - Http code: 200 10:18:19 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:18:19 INFO - x-amz-cf-id: zY9b7yjelFdCYnL_5rY3uRkqAF5ybMb-ZG1RpqAO4kUN5fbIlHE1mQ== 10:18:19 INFO - x-amz-version-id: _VeDnQp.uRiFAQVKlnRLyX2dIO1sI88i 10:18:19 INFO - Expected file size: 21969191 10:18:19 INFO - Obtained file size: 21969191 10:18:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:18:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:18:24 INFO - Fetch https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:18:24 INFO - Http code: 200 10:18:24 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 10:18:24 INFO - x-amz-cf-id: veXJ-N9MCDWPt7G8QKWfZmEtVF0nLSUIP033xtjkEHjSCveVsu5Spg== 10:18:24 INFO - x-amz-version-id: I_v6ZoqdM4.w_PkZ59Y0lpFd9QF6JEYk 10:18:24 INFO - Expected file size: 14409038 10:18:24 INFO - Obtained file size: 14409038 10:18:25 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')]} 10:18:25 INFO - trying https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:18:25 INFO - Downloading https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:18:26 INFO - Downloaded 59321181 bytes. 10:18:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:18:26 INFO - mkdir: /builds/slave/test/properties 10:18:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:18:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:18:26 INFO - Contents: 10:18:26 INFO - build_url:https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:18:27 INFO - Running post-action listener: _resource_record_post_action 10:18:27 INFO - Running post-action listener: set_extra_try_arguments 10:18:27 INFO - [mozharness: 2016-11-11 18:18:27.089682Z] Finished download-and-extract step (success) 10:18:27 INFO - [mozharness: 2016-11-11 18:18:27.089907Z] Running populate-webroot step. 10:18:27 INFO - Running pre-action listener: _resource_record_pre_action 10:18:27 INFO - Running main action method: populate_webroot 10:18:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:18:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:18:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:18:27 INFO - '--tppagecycles', 10:18:27 INFO - '7'], 10:18:27 INFO - 'tests': ['tsvgm']}}, 10:18:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:18:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:18:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:18:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:18:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:18:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['damp', 'tps']}, 10:18:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'tests': ['damp', 'tps']}, 10:18:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['dromaeo_dom']}, 10:18:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:18:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['basic_compositor_video']}, 10:18:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:18:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['a11yr', 10:18:27 INFO - 'ts_paint', 10:18:27 INFO - 'tpaint', 10:18:27 INFO - 'sessionrestore', 10:18:27 INFO - 'sessionrestore_no_auto_restore', 10:18:27 INFO - 'tabpaint']}, 10:18:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:18:27 INFO - 'ts_paint', 10:18:27 INFO - 'tpaint', 10:18:27 INFO - 'sessionrestore', 10:18:27 INFO - 'sessionrestore_no_auto_restore', 10:18:27 INFO - 'tabpaint']}, 10:18:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:18:27 INFO - 'ts_paint', 10:18:27 INFO - 'tpaint', 10:18:27 INFO - 'sessionrestore', 10:18:27 INFO - 'sessionrestore_no_auto_restore', 10:18:27 INFO - 'tabpaint']}, 10:18:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:18:27 INFO - 'ts_paint', 10:18:27 INFO - 'tpaint', 10:18:27 INFO - 'sessionrestore', 10:18:27 INFO - 'sessionrestore_no_auto_restore', 10:18:27 INFO - 'tabpaint']}, 10:18:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['a11yr', 10:18:27 INFO - 'ts_paint', 10:18:27 INFO - 'tpaint', 10:18:27 INFO - 'sessionrestore', 10:18:27 INFO - 'sessionrestore_no_auto_restore', 10:18:27 INFO - 'tabpaint']}, 10:18:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['a11yr', 10:18:27 INFO - 'ts_paint', 10:18:27 INFO - 'tpaint', 10:18:27 INFO - 'sessionrestore', 10:18:27 INFO - 'sessionrestore_no_auto_restore', 10:18:27 INFO - 'tabpaint']}, 10:18:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['tsvgx', 10:18:27 INFO - 'tsvgr_opacity', 10:18:27 INFO - 'tart', 10:18:27 INFO - 'tscrollx', 10:18:27 INFO - 'cart']}, 10:18:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:18:27 INFO - 'tsvgr_opacity', 10:18:27 INFO - 'tart', 10:18:27 INFO - 'tscrollx', 10:18:27 INFO - 'cart']}, 10:18:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'talos_options': ['--disable-e10s'], 10:18:27 INFO - 'tests': ['tp5o']}, 10:18:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'tests': ['tp5o']}, 10:18:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'talos_options': ['--disable-e10s', 10:18:27 INFO - '--xperf_path', 10:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:27 INFO - 'tests': ['tp5n']}, 10:18:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:18:27 INFO - 'talos_options': ['--xperf_path', 10:18:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:18:27 INFO - 'tests': ['tp5n']}}, 10:18:27 INFO - 'talos.zip': {'path': '', 10:18:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:18:27 INFO - Running post-action listener: _resource_record_post_action 10:18:27 INFO - [mozharness: 2016-11-11 18:18:27.109988Z] Finished populate-webroot step (success) 10:18:27 INFO - [mozharness: 2016-11-11 18:18:27.110075Z] Running create-virtualenv step. 10:18:27 INFO - Running pre-action listener: _resource_record_pre_action 10:18:27 INFO - Running main action method: create_virtualenv 10:18:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:18:27 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 10:18:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:18:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:18:27 INFO - Using real prefix '/usr' 10:18:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:18:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:18:29 INFO - Installing pip.................done. 10:18:29 INFO - Return code: 0 10:18:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:18:29 INFO - Reading from file tmpfile_stdout 10:18:29 INFO - Output received: 10:18:29 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) 10:18:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:18:29 INFO - Using env: {'DISPLAY': ':0', 10:18:29 INFO - 'HOME': '/home/cltbld', 10:18:29 INFO - 'LANG': 'en_US.UTF-8', 10:18:29 INFO - 'LANGUAGE': 'en_US:en', 10:18:29 INFO - 'LOGNAME': 'cltbld', 10:18:29 INFO - 'MAIL': '/var/mail/cltbld', 10:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:29 INFO - 'MOZ_NO_REMOTE': '1', 10:18:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:29 INFO - 'NO_EM_RESTART': '1', 10:18:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:29 INFO - 'PWD': '/builds/slave/test', 10:18:29 INFO - 'SHELL': '/bin/bash', 10:18:29 INFO - 'SHLVL': '1', 10:18:29 INFO - 'TERM': 'linux', 10:18:29 INFO - 'TMOUT': '86400', 10:18:29 INFO - 'USER': 'cltbld', 10:18:29 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:29 INFO - '_': '/tools/buildbot/bin/python'} 10:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:30 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 10:18:30 INFO - Cleaning up... 10:18:30 INFO - Return code: 0 10:18:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:18:30 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')]} 10:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:30 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')]} 10:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:30 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:30 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 10:18:30 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 10:18:30 INFO - Using env: {'DISPLAY': ':0', 10:18:30 INFO - 'HOME': '/home/cltbld', 10:18:30 INFO - 'LANG': 'en_US.UTF-8', 10:18:30 INFO - 'LANGUAGE': 'en_US:en', 10:18:30 INFO - 'LOGNAME': 'cltbld', 10:18:30 INFO - 'MAIL': '/var/mail/cltbld', 10:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:30 INFO - 'MOZ_NO_REMOTE': '1', 10:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:30 INFO - 'NO_EM_RESTART': '1', 10:18:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:30 INFO - 'PWD': '/builds/slave/test', 10:18:30 INFO - 'SHELL': '/bin/bash', 10:18:30 INFO - 'SHLVL': '1', 10:18:30 INFO - 'TERM': 'linux', 10:18:30 INFO - 'TMOUT': '86400', 10:18:30 INFO - 'USER': 'cltbld', 10:18:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:30 INFO - '_': '/tools/buildbot/bin/python'} 10:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:30 INFO - Downloading/unpacking psutil>=3.1.1 10:18:30 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 10:18:30 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 10:18:30 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 10:18:30 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 10:18:30 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 10:18:30 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 10:18:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:32 INFO - Installing collected packages: psutil 10:18:32 INFO - Running setup.py install for psutil 10:18:32 INFO - building 'psutil._psutil_linux' extension 10:18:32 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 10:18:32 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 10:18:32 INFO - building 'psutil._psutil_posix' extension 10:18:32 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 10:18:32 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 10:18:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:18:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:18:32 INFO - Successfully installed psutil 10:18:32 INFO - Cleaning up... 10:18:32 INFO - Return code: 0 10:18:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:18:32 INFO - Using env: {'DISPLAY': ':0', 10:18:32 INFO - 'HOME': '/home/cltbld', 10:18:32 INFO - 'LANG': 'en_US.UTF-8', 10:18:32 INFO - 'LANGUAGE': 'en_US:en', 10:18:32 INFO - 'LOGNAME': 'cltbld', 10:18:32 INFO - 'MAIL': '/var/mail/cltbld', 10:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:32 INFO - 'MOZ_NO_REMOTE': '1', 10:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:32 INFO - 'NO_EM_RESTART': '1', 10:18:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:32 INFO - 'PWD': '/builds/slave/test', 10:18:32 INFO - 'SHELL': '/bin/bash', 10:18:32 INFO - 'SHLVL': '1', 10:18:32 INFO - 'TERM': 'linux', 10:18:32 INFO - 'TMOUT': '86400', 10:18:32 INFO - 'USER': 'cltbld', 10:18:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:32 INFO - '_': '/tools/buildbot/bin/python'} 10:18:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:18:33 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 10:18:33 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 10:18:33 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 10:18:33 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 10:18:33 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 10:18:33 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 10:18:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:18:35 INFO - Installing collected packages: mozsystemmonitor 10:18:35 INFO - Running setup.py install for mozsystemmonitor 10:18:35 INFO - Successfully installed mozsystemmonitor 10:18:35 INFO - Cleaning up... 10:18:35 INFO - Return code: 0 10:18:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:35 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:35 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 10:18:35 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 10:18:35 INFO - Using env: {'DISPLAY': ':0', 10:18:35 INFO - 'HOME': '/home/cltbld', 10:18:35 INFO - 'LANG': 'en_US.UTF-8', 10:18:35 INFO - 'LANGUAGE': 'en_US:en', 10:18:35 INFO - 'LOGNAME': 'cltbld', 10:18:35 INFO - 'MAIL': '/var/mail/cltbld', 10:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:35 INFO - 'MOZ_NO_REMOTE': '1', 10:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:35 INFO - 'NO_EM_RESTART': '1', 10:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:35 INFO - 'PWD': '/builds/slave/test', 10:18:35 INFO - 'SHELL': '/bin/bash', 10:18:35 INFO - 'SHLVL': '1', 10:18:35 INFO - 'TERM': 'linux', 10:18:35 INFO - 'TMOUT': '86400', 10:18:35 INFO - 'USER': 'cltbld', 10:18:35 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:35 INFO - '_': '/tools/buildbot/bin/python'} 10:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:18:35 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 10:18:35 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 10:18:35 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 10:18:35 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 10:18:35 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 10:18:35 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 10:18:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:18:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 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 10:18:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:18:37 INFO - warning: no files found matching '*.txt' 10:18:37 INFO - no previously-included directories found matching 'build' 10:18:37 INFO - no previously-included directories found matching 'dist' 10:18:37 INFO - no previously-included directories found matching '.git*' 10:18:37 INFO - Installing collected packages: jsonschema, functools32 10:18:37 INFO - Running setup.py install for functools32 10:18:37 INFO - warning: no files found matching '*.txt' 10:18:37 INFO - no previously-included directories found matching 'build' 10:18:37 INFO - no previously-included directories found matching 'dist' 10:18:37 INFO - no previously-included directories found matching '.git*' 10:18:38 INFO - Successfully installed jsonschema functools32 10:18:38 INFO - Cleaning up... 10:18:38 INFO - Return code: 0 10:18:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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')]} 10:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:38 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:38 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 10:18:38 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 10:18:38 INFO - Using env: {'DISPLAY': ':0', 10:18:38 INFO - 'HOME': '/home/cltbld', 10:18:38 INFO - 'LANG': 'en_US.UTF-8', 10:18:38 INFO - 'LANGUAGE': 'en_US:en', 10:18:38 INFO - 'LOGNAME': 'cltbld', 10:18:38 INFO - 'MAIL': '/var/mail/cltbld', 10:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:38 INFO - 'MOZ_NO_REMOTE': '1', 10:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:38 INFO - 'NO_EM_RESTART': '1', 10:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:38 INFO - 'PWD': '/builds/slave/test', 10:18:38 INFO - 'SHELL': '/bin/bash', 10:18:38 INFO - 'SHLVL': '1', 10:18:38 INFO - 'TERM': 'linux', 10:18:38 INFO - 'TMOUT': '86400', 10:18:38 INFO - 'USER': 'cltbld', 10:18:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:38 INFO - '_': '/tools/buildbot/bin/python'} 10:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:18:38 INFO - Cleaning up... 10:18:38 INFO - Return code: 0 10:18:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:18: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')]} 10:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18: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')]} 10:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:38 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:38 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 10:18:38 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 10:18:38 INFO - Using env: {'DISPLAY': ':0', 10:18:38 INFO - 'HOME': '/home/cltbld', 10:18:38 INFO - 'LANG': 'en_US.UTF-8', 10:18:38 INFO - 'LANGUAGE': 'en_US:en', 10:18:38 INFO - 'LOGNAME': 'cltbld', 10:18:38 INFO - 'MAIL': '/var/mail/cltbld', 10:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:38 INFO - 'MOZ_NO_REMOTE': '1', 10:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:38 INFO - 'NO_EM_RESTART': '1', 10:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:38 INFO - 'PWD': '/builds/slave/test', 10:18:38 INFO - 'SHELL': '/bin/bash', 10:18:38 INFO - 'SHLVL': '1', 10:18:38 INFO - 'TERM': 'linux', 10:18:38 INFO - 'TMOUT': '86400', 10:18:38 INFO - 'USER': 'cltbld', 10:18:38 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:38 INFO - '_': '/tools/buildbot/bin/python'} 10:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:18:38 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 10:18:38 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 10:18:38 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 10:18:38 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 10:18:38 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 10:18:38 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 10:18:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:18:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:18:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:18:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:18:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:18:41 INFO - Downloading docopt-0.6.1.tar.gz 10:18:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:18:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:18:41 INFO - Running setup.py install for blobuploader 10:18:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:18:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:18:41 INFO - Running setup.py install for requests 10:18:41 INFO - Running setup.py install for docopt 10:18:41 INFO - Successfully installed blobuploader requests docopt 10:18:41 INFO - Cleaning up... 10:18:41 INFO - Return code: 0 10:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:41 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')]} 10:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:41 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')]} 10:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:41 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:41 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 10:18:41 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 10:18:41 INFO - Using env: {'DISPLAY': ':0', 10:18:41 INFO - 'HOME': '/home/cltbld', 10:18:41 INFO - 'LANG': 'en_US.UTF-8', 10:18:41 INFO - 'LANGUAGE': 'en_US:en', 10:18:41 INFO - 'LOGNAME': 'cltbld', 10:18:41 INFO - 'MAIL': '/var/mail/cltbld', 10:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:41 INFO - 'MOZ_NO_REMOTE': '1', 10:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:41 INFO - 'NO_EM_RESTART': '1', 10:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:41 INFO - 'PWD': '/builds/slave/test', 10:18:41 INFO - 'SHELL': '/bin/bash', 10:18:41 INFO - 'SHLVL': '1', 10:18:41 INFO - 'TERM': 'linux', 10:18:41 INFO - 'TMOUT': '86400', 10:18:41 INFO - 'USER': 'cltbld', 10:18:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:41 INFO - '_': '/tools/buildbot/bin/python'} 10:18:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:42 INFO - Running setup.py (path:/tmp/pip-EMBWCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:42 INFO - Running setup.py (path:/tmp/pip-w1fx4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:42 INFO - Running setup.py (path:/tmp/pip-rGQhDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:42 INFO - Running setup.py (path:/tmp/pip-OG78Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:42 INFO - Running setup.py (path:/tmp/pip-0oWfw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:42 INFO - Running setup.py (path:/tmp/pip-dUhztH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:42 INFO - Running setup.py (path:/tmp/pip-6QZ2Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:42 INFO - Running setup.py (path:/tmp/pip-U4M1GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:42 INFO - Running setup.py (path:/tmp/pip-4R4nDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:42 INFO - Running setup.py (path:/tmp/pip-Xr2jcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:42 INFO - Running setup.py (path:/tmp/pip-bNOWSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:42 INFO - Running setup.py (path:/tmp/pip-hgx2uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:42 INFO - Running setup.py (path:/tmp/pip-UGzD4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:42 INFO - Running setup.py (path:/tmp/pip-DV6iQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:43 INFO - Running setup.py (path:/tmp/pip-F9uzKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:43 INFO - Running setup.py (path:/tmp/pip-0UX2KV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:43 INFO - Running setup.py (path:/tmp/pip-KHLjvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:18:43 INFO - Running setup.py install for manifestparser 10:18:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:18:43 INFO - Running setup.py install for mozcrash 10:18:43 INFO - Running setup.py install for mozdebug 10:18:43 INFO - Running setup.py install for mozdevice 10:18:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:18:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:18:43 INFO - Running setup.py install for mozfile 10:18:43 INFO - Running setup.py install for mozhttpd 10:18:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:18:43 INFO - Running setup.py install for mozinfo 10:18:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:18:43 INFO - Running setup.py install for mozInstall 10:18:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Running setup.py install for mozleak 10:18:44 INFO - Running setup.py install for mozlog 10:18:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Running setup.py install for moznetwork 10:18:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Running setup.py install for mozprocess 10:18:44 INFO - Running setup.py install for mozprofile 10:18:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Running setup.py install for mozrunner 10:18:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:18:44 INFO - Running setup.py install for mozscreenshot 10:18:44 INFO - Running setup.py install for moztest 10:18:44 INFO - Running setup.py install for mozversion 10:18:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:18:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:18:45 INFO - Cleaning up... 10:18:45 INFO - Return code: 0 10:18:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:45 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')]} 10:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:45 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')]} 10:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:45 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:45 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 10:18:45 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 10:18:45 INFO - Using env: {'DISPLAY': ':0', 10:18:45 INFO - 'HOME': '/home/cltbld', 10:18:45 INFO - 'LANG': 'en_US.UTF-8', 10:18:45 INFO - 'LANGUAGE': 'en_US:en', 10:18:45 INFO - 'LOGNAME': 'cltbld', 10:18:45 INFO - 'MAIL': '/var/mail/cltbld', 10:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:45 INFO - 'MOZ_NO_REMOTE': '1', 10:18:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:45 INFO - 'NO_EM_RESTART': '1', 10:18:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:45 INFO - 'PWD': '/builds/slave/test', 10:18:45 INFO - 'SHELL': '/bin/bash', 10:18:45 INFO - 'SHLVL': '1', 10:18:45 INFO - 'TERM': 'linux', 10:18:45 INFO - 'TMOUT': '86400', 10:18:45 INFO - 'USER': 'cltbld', 10:18:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:45 INFO - '_': '/tools/buildbot/bin/python'} 10:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:18:45 INFO - Running setup.py (path:/tmp/pip-3UoWJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:18:45 INFO - Running setup.py (path:/tmp/pip-D27y07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:18:45 INFO - Running setup.py (path:/tmp/pip-p04P8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:18:45 INFO - Running setup.py (path:/tmp/pip-NR7t8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:18:45 INFO - Running setup.py (path:/tmp/pip-Hg6Jx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:18:45 INFO - Running setup.py (path:/tmp/pip-U1T9Nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:18:45 INFO - Running setup.py (path:/tmp/pip-e7NLpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:18:45 INFO - Running setup.py (path:/tmp/pip-prd51P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:18:45 INFO - Running setup.py (path:/tmp/pip-3sMZJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:18:45 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)) 10:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:18:45 INFO - Running setup.py (path:/tmp/pip-Lcz7r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:18:46 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)) 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:18:46 INFO - Running setup.py (path:/tmp/pip-6mS0qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:18:46 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)) 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:18:46 INFO - Running setup.py (path:/tmp/pip-HPFj75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:18:46 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)) 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:18:46 INFO - Running setup.py (path:/tmp/pip-99ntGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:18:46 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)) 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:18:46 INFO - Running setup.py (path:/tmp/pip-T5PkdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:18:46 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)) 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:46 INFO - Running setup.py (path:/tmp/pip-rwSyxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:18:46 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)) 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:18:46 INFO - Running setup.py (path:/tmp/pip-VmTYGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:18:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:18:46 INFO - Running setup.py (path:/tmp/pip-ECSYv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:18:46 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)) 10:18:46 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)) 10:18:46 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)) 10:18:46 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)) 10:18:46 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)) 10:18:46 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)) 10:18:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:18:46 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 10:18:46 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 10:18:46 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 10:18:46 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 10:18:46 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 10:18:46 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 10:18:48 INFO - Downloading blessings-1.6.tar.gz 10:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:18:48 INFO - Installing collected packages: blessings 10:18:48 INFO - Running setup.py install for blessings 10:18:48 INFO - Successfully installed blessings 10:18:48 INFO - Cleaning up... 10:18:48 INFO - Return code: 0 10:18:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:48 INFO - Reading from file tmpfile_stdout 10:18:48 INFO - Current package versions: 10:18:48 INFO - argparse == 1.2.1 10:18:48 INFO - blessings == 1.6 10:18:48 INFO - blobuploader == 1.2.4 10:18:48 INFO - docopt == 0.6.1 10:18:48 INFO - functools32 == 3.2.3-2 10:18:48 INFO - jsonschema == 2.5.1 10:18:48 INFO - manifestparser == 1.1 10:18:48 INFO - mozInstall == 1.12 10:18:48 INFO - mozcrash == 1.0 10:18:48 INFO - mozdebug == 0.1 10:18:48 INFO - mozdevice == 0.48 10:18:48 INFO - mozfile == 1.2 10:18:48 INFO - mozhttpd == 0.7 10:18:48 INFO - mozinfo == 0.9 10:18:48 INFO - mozleak == 0.1 10:18:48 INFO - mozlog == 3.4 10:18:48 INFO - moznetwork == 0.27 10:18:48 INFO - mozprocess == 0.23 10:18:48 INFO - mozprofile == 0.28 10:18:48 INFO - mozrunner == 6.13 10:18:48 INFO - mozscreenshot == 0.1 10:18:48 INFO - mozsystemmonitor == 0.3 10:18:48 INFO - moztest == 0.7 10:18:48 INFO - mozversion == 1.4 10:18:48 INFO - psutil == 3.1.1 10:18:48 INFO - requests == 1.2.3 10:18:48 INFO - wsgiref == 0.1.2 10:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:18:48 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')]} 10:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:48 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')]} 10:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:48 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:48 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 10:18:48 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 10:18:48 INFO - Using env: {'DISPLAY': ':0', 10:18:48 INFO - 'HOME': '/home/cltbld', 10:18:48 INFO - 'LANG': 'en_US.UTF-8', 10:18:48 INFO - 'LANGUAGE': 'en_US:en', 10:18:48 INFO - 'LOGNAME': 'cltbld', 10:18:48 INFO - 'MAIL': '/var/mail/cltbld', 10:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:48 INFO - 'MOZ_NO_REMOTE': '1', 10:18:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:48 INFO - 'NO_EM_RESTART': '1', 10:18:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:48 INFO - 'PWD': '/builds/slave/test', 10:18:48 INFO - 'SHELL': '/bin/bash', 10:18:48 INFO - 'SHLVL': '1', 10:18:48 INFO - 'TERM': 'linux', 10:18:48 INFO - 'TMOUT': '86400', 10:18:48 INFO - 'USER': 'cltbld', 10:18:48 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:48 INFO - '_': '/tools/buildbot/bin/python'} 10:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 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)) 10:18:49 INFO - Cleaning up... 10:18:49 INFO - Return code: 0 10:18:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:18:49 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')]} 10:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:49 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')]} 10:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:18:49 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 0x7f7aa2ddef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272c790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', '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 10:18:49 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 10:18:49 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 10:18:49 INFO - Using env: {'DISPLAY': ':0', 10:18:49 INFO - 'HOME': '/home/cltbld', 10:18:49 INFO - 'LANG': 'en_US.UTF-8', 10:18:49 INFO - 'LANGUAGE': 'en_US:en', 10:18:49 INFO - 'LOGNAME': 'cltbld', 10:18:49 INFO - 'MAIL': '/var/mail/cltbld', 10:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:49 INFO - 'MOZ_NO_REMOTE': '1', 10:18:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:18:49 INFO - 'NO_EM_RESTART': '1', 10:18:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:49 INFO - 'PWD': '/builds/slave/test', 10:18:49 INFO - 'SHELL': '/bin/bash', 10:18:49 INFO - 'SHLVL': '1', 10:18:49 INFO - 'TERM': 'linux', 10:18:49 INFO - 'TMOUT': '86400', 10:18:49 INFO - 'USER': 'cltbld', 10:18:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:49 INFO - '_': '/tools/buildbot/bin/python'} 10:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:18:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:18:49 INFO - Cleaning up... 10:18:49 INFO - Return code: 0 10:18:49 INFO - Running post-action listener: _resource_record_post_action 10:18:49 INFO - Running post-action listener: _start_resource_monitoring 10:18:49 INFO - Starting resource monitoring. 10:18:49 INFO - [mozharness: 2016-11-11 18:18:49.460346Z] Finished create-virtualenv step (success) 10:18:49 INFO - [mozharness: 2016-11-11 18:18:49.460986Z] Running install step. 10:18:49 INFO - Running pre-action listener: _resource_record_pre_action 10:18:49 INFO - Running main action method: install 10:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:18:49 INFO - Reading from file tmpfile_stdout 10:18:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:18:49 INFO - Reading from file tmpfile_stdout 10:18:49 INFO - Output received: 10:18:49 INFO - Usage: mozinstall [options] installer 10:18:49 INFO - Options: 10:18:49 INFO - -h, --help show this help message and exit 10:18:49 INFO - -d DEST, --destination=DEST 10:18:49 INFO - Directory to install application into. [default: 10:18:49 INFO - "/builds/slave/test"] 10:18:49 INFO - --app=APP Application being installed. [default: firefox] 10:18:49 INFO - mkdir: /builds/slave/test/build/application 10:18:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:18:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:19:06 INFO - Reading from file tmpfile_stdout 10:19:06 INFO - Output received: 10:19:06 INFO - /builds/slave/test/build/application/firefox/firefox 10:19:06 INFO - Running post-action listener: _resource_record_post_action 10:19:06 INFO - [mozharness: 2016-11-11 18:19:06.614851Z] Finished install step (success) 10:19:06 INFO - [mozharness: 2016-11-11 18:19:06.615093Z] Running run-tests step. 10:19:06 INFO - Running pre-action listener: _resource_record_pre_action 10:19:06 INFO - Running main action method: run_tests 10:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:06 INFO - Python 2.7.3 10:19:06 INFO - Return code: 0 10:19:06 INFO - grabbing minidump binary from tooltool 10:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:19:06 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 0x2729930>, '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 0x272a830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x272acc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:06 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 10:19:06 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 10:19:06 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 10:19:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:06 INFO - Return code: 0 10:19:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:19:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:19:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 10:19:06 INFO - Using env: {'DISPLAY': ':0', 10:19:06 INFO - 'HOME': '/home/cltbld', 10:19:06 INFO - 'LANG': 'en_US.UTF-8', 10:19:06 INFO - 'LANGUAGE': 'en_US:en', 10:19:06 INFO - 'LOGNAME': 'cltbld', 10:19:06 INFO - 'MAIL': '/var/mail/cltbld', 10:19:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:06 INFO - 'MOZ_NO_REMOTE': '1', 10:19:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:06 INFO - 'NO_EM_RESTART': '1', 10:19:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:06 INFO - 'PWD': '/builds/slave/test', 10:19:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:06 INFO - 'SHELL': '/bin/bash', 10:19:06 INFO - 'SHLVL': '1', 10:19:06 INFO - 'TERM': 'linux', 10:19:06 INFO - 'TMOUT': '86400', 10:19:06 INFO - 'USER': 'cltbld', 10:19:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852', 10:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:06 INFO - '_': '/tools/buildbot/bin/python'} 10:19:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 10:19:06 INFO - mozversion application_buildid: 20161111073206 10:19:06 INFO - mozversion application_changeset: bf3c647eec8100c19efd5ba415686bfd0854c113 10:19:06 INFO - mozversion application_display_name: Nightly 10:19:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:06 INFO - mozversion application_name: Firefox 10:19:06 INFO - mozversion application_remotingname: firefox 10:19:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:19:06 INFO - mozversion application_vendor: Mozilla 10:19:06 INFO - mozversion application_version: 52.0a1 10:19:06 INFO - mozversion platform_buildid: 20161111073206 10:19:06 INFO - mozversion platform_changeset: bf3c647eec8100c19efd5ba415686bfd0854c113 10:19:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:19:06 INFO - mozversion platform_version: 52.0a1 10:19:06 INFO - using testdate: 1478888346 10:19:06 INFO - actual date: 1478888346 10:19:06 INFO - starting webserver on 'localhost:60247' 10:19:06 INFO - SUITE-START | Running 2 tests 10:19:06 INFO - TEST-START | dromaeo_css 10:19:06 INFO - operating with platform_type : linux_ 10:19:06 INFO - Initialising browser for dromaeo_css test... 10:19:06 INFO - TEST-INFO | started process 16802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywcI1m/profile http://localhost:60247/getInfo.html) 10:19:10 INFO - PROCESS | 16802 | __metrics Screen width/height:1600/1200 10:19:10 INFO - PROCESS | 16802 | colorDepth:24 10:19:10 INFO - PROCESS | 16802 | Browser inner width/height: 1024/697 10:19:10 INFO - PROCESS | 16802 | __metrics 10:19:11 INFO - PROCESS | 16802 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:19:11 INFO - PROCESS | 16802 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:11 INFO - PROCESS | 16802 | console.error: PushService: 10:19:11 INFO - PROCESS | 16802 | stateChangeProcessEnqueue: Error transitioning state 10:19:11 INFO - PROCESS | 16802 | UnknownError 10:19:12 INFO - TEST-INFO | 16802: exit 0 10:19:12 INFO - Browser initialized. 10:19:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:12 INFO - TEST-INFO | started process 16887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpywcI1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:24 INFO - PROCESS | 16887 | RSS: Main: 173023232 10:19:24 INFO - PROCESS | 16887 | 10:20:15 INFO - PROCESS | 16887 | 1478888415335 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:22:26 INFO - PROCESS | 16887 | Cycle 1(1): loaded http://localhost:60247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60247/tests/dromaeo/cssquery-ext.html) 10:22:28 INFO - PROCESS | 16887 | RSS: Main: 422735872 10:22:28 INFO - PROCESS | 16887 | 10:25:31 INFO - PROCESS | 16887 | Cycle 1(1): loaded http://localhost:60247/tests/dromaeo/cssquery-ext.html (next: http://localhost:60247/tests/dromaeo/cssquery-jquery.html) 10:25:32 INFO - PROCESS | 16887 | RSS: Main: 285548544 10:25:32 INFO - PROCESS | 16887 | 10:28:34 INFO - PROCESS | 16887 | Cycle 1(1): loaded http://localhost:60247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60247/tests/dromaeo/cssquery-mootools.html) 10:28:34 INFO - PROCESS | 16887 | RSS: Main: 219365376 10:28:34 INFO - PROCESS | 16887 | 10:31:36 INFO - PROCESS | 16887 | Cycle 1(1): loaded http://localhost:60247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60247/tests/dromaeo/cssquery-prototype.html) 10:31:37 INFO - PROCESS | 16887 | RSS: Main: 220450816 10:31:37 INFO - PROCESS | 16887 | 10:34:40 INFO - PROCESS | 16887 | Cycle 1(1): loaded http://localhost:60247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60247/tests/dromaeo/cssquery-yui.html) 10:34:41 INFO - PROCESS | 16887 | RSS: Main: 220626944 10:34:41 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | Cycle 1(1): loaded http://localhost:60247/tests/dromaeo/cssquery-yui.html (next: http://localhost:60247/tests/dromaeo/cssquery-dojo.html) 10:37:44 INFO - PROCESS | 16887 | RSS: Main: 314359808 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | __start_tp_report 10:37:44 INFO - PROCESS | 16887 | _x_x_mozilla_page_load 10:37:44 INFO - PROCESS | 16887 | _x_x_mozilla_page_load_details 10:37:44 INFO - PROCESS | 16887 | |i|pagename|runs| 10:37:44 INFO - PROCESS | 16887 | |0;dojo.html;3094.767892408069;3125.328054468289;3130.843457827109;3151.1964449065513;3183.8726450941963;5329.573634109272;5359.517643412092;5388.865278368043;5452.890942181159;5456.345238571372;5361.249425080492;5383.838484845451;5385.892282154365;5392.811251606195;5395.21769343446;4888.364512613364;4934.28452874333;4956.653034287601;5009.849704508871;5062.164742817449;4950.405951285833;4965.801367945278;4978.701277923318;5023.372078490189;5024.874378140557;4947.060058588857;4985.127602669519;4987.975060124694;4991.5258050485145;5001.7499125043605;4948.183549714328;4958.553730164303;4959.652824302264;5004.949950500485;5011.523905228997;4817.084753896748;4848.636352273558;4850.95149048512;4888;4935.284383764334;5321.627486075976;5325.068113080234;5334.733263336818;5363.54409875161;5400.756965936543;5735.684537350444;5751.281089863767;5773.047447171211;5773.884522309572;5775.047117225653;5694.9430505695245;5805.796797112081;5809.825705228807;5813.767449302023;5819.563532735019;5345.7594408251725;5385.542228910508;5417.458254174551;5419.376771671229;5485.259489968883;5912.704364781744;5921.496672782776;5924.052151655715;5930.932432162253;5933.080372542263;5701.743421546041;5708.857278567986;5723.656580605177;5723.771049157987;5734.627249228787;5626.2967129108865;5702.0591602385975;5757.510611597977;5769.278840144982;5802.071668533014;5767.596268261265;5794.942050579441;5812.128180772918;5845.649261044351;5861.765529378862;5805.332386775575;5816.680082595498;5826.533877289807;5830.125481177857;5832.62087964281;4361.411209486679;4408.911821763547;4411.1618792429335;4413.1394378095965;4461.5092339842595;3936.980315098406;3980.7014473914574;3999.140184860269;4001.0597509585805;4012.8996775080855;5494.587905906993;5500.724963751876;5501.449855014466;5501.642393244506;5501.642393244506;5677.545796336283;5720.513756330675;5788.218590490314;5832.88334233313;5841;5467.589930755209;5486.286782718221;5510.173473978855;5555.194496797942;5611.354694210137;5092.898142037138;5093.694378337312;5099.643024988215;5103.642745007888;5136.049830781318;5828.883422331445;6062.120992455981;6067.24159480065;6073.48375388097;6076.817695469143;5691.573132015198;5727.140928860537;5780.381493181916;5783.94216057834;5784.681842498703;5958.553108516965;5961.314448838439;5969.492593129633;5971.0744834550715;5972;5614.915776263278;5648.943510565006;5656.886862262814;5660.377358490645;5663;5754.741036653277;5762.654240745569;5764.769409223584;5765.3946335634155;5766.250387449605;5617.241672374341;5628.718564071698;5633.324001119892;5635.887282254414;5639.379668236409;5631.099024156116;5637.210790489253;5639.3232812062815;5639.915401268902;5640.774369025357;5600.85997850057;5607.130894711163;5618.943810561842;5688.77244910199;5696.715164241688;5769.94230057694;5774.364819869895;5775.306963164279;5779.68211748341;5783.248177737036;5439;5466.2620546227345;5565.499105080562;5575.804846830341;5637.718114094197 10:37:44 INFO - PROCESS | 16887 | |1;ext.html;589.9056151015837;596.3053043204667;631.7630888416844;641.9775307864226;644.2044075566678;31516.212094697614;40748.38877416837;42141;42272.577274227246;45067.54932450675;42817;43522.56477435225;43554;43555.12889742203;43652;7787.143414224431;8555.957220213906;8704.303655707528;8710.956445217766;8723.781905452352;7946.6821327146845;10079.244056695778;10305.278630495868;10308.793824123513;10542.10392116671;10422.843657345107;10440.112590429822;10446.843297350546;10479;10488.947555262213;10362.27464077515;10401.271910966236;10404.219683523766;10431.061204491556;10432.165426765878;10265.897341026568;10313.535890884928;10320.329178603442;10326.328788628714;10327.431991240479;41154.38268425976;41340;41574.792126039174;41611;41649.583504164875;3096;3112.719855213019;3115.6572776994512;3326.501024846268;3482.7736197147356;30050;30286.84856575725;30605.234869128228;31099.222519437197;32228.35543289121;4075.4090656854887;4176.227397931392;4186.644135248507;4220.177065472234;4222.071144348239;329469;330755;330862;331228;331633;33528.664713352555;54075.188872166946;54388.728056360254;54441.45558544443;54534.181987270225;33645.663543364746;36150.45774313388;36216.45675314873;36235;36299.4555081674;15373.615659608375;15604;15611.453599123975;15613.3754649815;15619.531414057596;9885;10128.240381971382;12760.553380631633;12962.22226666403;13180.340982950815;8318.168183181633;8348.290395316344;8414.242718155396;8420.2842758365;8438.957805211057;3144.6383665878716;3203.4233837908932;3216.710496055366;3216.9839150804564;3286.8520916558814;929.7303781903307;1004.4826914139225;1018.1142406106586;1074.4735079810837;1114.400139300024;29656.555151672743;31107.68892311048;31359.529607055912;31673.20816979594;33569.664303357145;1089.9182561307935;1102.2835157147917;1128.3850301585655;1141.2866958151155;1152.0898490192822;15342.232888355538;15925;15990.680186396206;16309.755353669705;16475.917620411823;486624;486982;490435;490570;491276;54173;54601.72699136479;54687.45312546824;54718;54830;1204.7048473123966;1237.3689418396682;1258.9307588082743;1328.913620614657;1370.9245991470366;27570.724292756815;30801.229969250053;31370.21574460657;31786.841065794524;31805.363892721554;53397.7330113347;53506.73246633742;53624.22448744988;53678.194827078405;54014.45985540094;413013;417566;417672;417854;417971;27121.72878271192;27152.185434436997;27470;28601.713982859907;41419.58580414157;44796.32805507855;45212;45338.773306133255;45386.77306613446;45432.54567454283;37475.25049499049;38159.23681526409;38705.41941870818;39546;40113.59886401215;37965.430518542795;38227.235455291295;38905;39878.800605997945;40135.1972960545;38984.415233770946;40228.597714022486;40282.597174029055;40373.1925361497;40480.1903961925;30566.388672225985;34665.65334346624;35044.64955350414;35375.46936796002;35479.11302217465;26950.59574106429;27271;27384.58923116115;27468.587971180048;27529.587056193774 10:37:44 INFO - PROCESS | 16887 | |2;jquery.html;374.39908946141423;380.2907577368209;400.09179163299314;401.3297792686214;414.2274657763272;13302.534411295594;15109.168995705231;18520;18922.432327030176;19253.22987080515;17767.378141765043;17881;18795.624087518274;19322;19363;5437.211604317372;5677.659340439566;5680.943190568083;5693.800716974907;5693.971530142344;3812.9809350953205;3932.390479475686;5341;5545.694986775726;5600.131979543177;5809.244798176232;5817.592768506206;5902.675352855591;5918.2306300181135;5926.1110833374905;5773.3937936516695;5915.852103697399;6094.085887116968;6130.2030736004035;6132;5485.533729632986;5508.421615730331;5515.751791169407;5519.337679478488;5520.558355331604;12765.680857978532;12849.87150128496;12867.22796632205;12873.356332183446;13726.245056521888;2145.1741079684434;2151.698762173297;2156.266869264442;2237.876916769577;2271.602469567819;9440.527973601293;9589.041095890425;9718.222542196607;12519.56181533642;13119;1840.834324910751;1842.9078546072776;1850.6391253705533;1882.265916292647;1896.3078476356168;77264;79940.20059799385;81496;82103;82377.40772772486;10869.347839129678;10883.619073332395;11023.44882755859;11062.170337224741;11066;15418.768718469231;15713.68572628541;15737.213139342986;15744.763828542582;15752.68494630101;7577.962110189524;7611.695532178762;7843.882341764764;7885.29032387088;8232.753017409488;7671.884921726179;7731.304182623591;7780.183080776437;8021.997250343707;8076.757697269091;4203.558626344251;4266.381374700651;4576.542345765463;4812.831550895702;4837.733924634179;1767.5139336682514;1855.1095474172203;1905.9428217153506;1991.73111629931;1992.531755037565;811.8011087283653;893.9016708162097;945;956.8038552096804;1004.8693669822876;18120;18234.270629174684;18822.529436763918;18952.62094758097;19133;923.2337160157053;957.5902966837751;964.8890377606525;979.9951000244953;1001.104011909337;9974.301798874008;10707.357558546511;10710.410927399067;10710.625128120479;10712.303700259457;426377;427901;429034;449878;460663;84930.6850506673;88474;95385;99445.50277248568;100522;994.7811481474064;1021.1218352217087;1038.7143535527791;1062.8086944349936;1071.7642118733866;12252.181998140655;16445;16861;17848.643027139125;18100.09499525045;39413.80293098516;39955.40735778564;40080;40278.798606006785;40696.79651601842;51296.48703513067;54457.45542544524;54485.45514544804;54497.45502545082;55409.72295138498;8032.959835200787;8070.47541909774;8259.628316725642;8390.28682561989;8462.703805366782;11344.886551134383;12802.67993300175;13065.477380904656;13073.869261307265;13308.866911330762;11691.707707307385;11701.239419437708;11791.115666324888;12172.634820955385;12245.571405000783;10996.670099897015;11082.833757493805;11251.043661288883;11535.36555489456;11735.119866010255;9399.483028433502;9833.4099954003;10151.238657100599;11513.769724605294;11797.11521635898;8524.167304029663;8562.48625082497;8635.913640863511;8820.2061814437;8844.292456603585;9307;10471.21465890046;10577.048065674126;10826.13390928708;10966.396848173426 10:37:44 INFO - PROCESS | 16887 | |3;mootools.html;1408.5563047639992;1433.6702558411564;1517.5068102866571;1671.4400675773616;1707.0867086108933;6839.316068393158;7004.859902801941;7586.506877052988;7994.800129996753;8019.518828870265;7532.096148462192;7706.7687969361;7755.069391672993;7932.524048557077;7950.36397088233;2260.480089579398;2288.8855557222073;2294.621387471065;2295.1507942061376;2295.36877358726;1949.62957038163;2240.451089483071;2297.8391512594126;2297.9659153381044;2300.25241796416;1976.041619814396;2214.5128071824174;2300.2869110575693;2300.999065406545;2326.581215381239;2231.2079211879714;2256.458449972003;2260.4009937366527;2261.344210179046;2268.1267711931027;2241.5180736141647;2242.2040175737543;2275.1013349726763;2278.601244782173;2280.6350983842503;7881.290683838425;7958.721444749463;7965.482243654202;8013.11855695873;8029.116797152308;4832.565069143759;4968.130577148984;4973.850784476472;4976.4277108132665;4981.476944920803;3151.086185006345;3180.25264062945;3252.1219270796987;3258.4297747894025;3329.350776598564;1039.0907955538903;1086.869575650919;1089.9073578745815;1097.040089921319;1104.309806371018;11092.55629774808;11121.888781112086;11137.276077055047;11145;11154.609588664358;4329.610335069859;4551.954480455153;4611.976940115345;4642.396488456547;4653.302004699254;9358.344915855825;9360.438373697463;9362.812743745088;9374;9376.390534615228;5093.465186155475;5112.437631860566;5114.488551144856;5115.590752739772;5115.74421278942;4531.932021019687;4546.29532422475;4645.442546894395;4699.671023028355;4712.69367491112;3691.53855768029;3740.121071548184;3813.9809300953316;3851.056491159684;3882.4370466282794;1151.7293436042523;1183.6863231243726;1262.4571434283162;1272.2557303977278;1283.3134273163998;868.9739307820776;903.8056817784077;924.3160061554402;933.4585940154694;942.8585712143233;5429.131338985743;5454.481824226692;5499.1476321170285;5500.1749737539685;5555.861103472364;867.696306292805;890.7550423633423;893.0845882969878;923.6905636611676;967.5500892085214;3713.461548075568;3848.1534062506203;3883.8446462141765;3884.3590807517007;3907.785071821077;9291.163795258459;9701.417914925127;9727.124558789743;9751.317407781387;9780.902190977999;9689.854652180224;9714.951425242829;9736;9771.462569558742;9793.118619324296;7295.124585049828;7396.519226250384;7406.037215162102;7411.925880741232;7427.442941779388;5315.734213289397;5513.724313784375;5608.10270356741;5627.943720562742;5649.096144616841;8771.649134034567;8920.24177944882;8944.463332200088;8962.596683149404;9116.589753461243;8473.788155296166;8691.174338437839;8825.249853762245;9022.233110185707;9129.954350228472;7336.889946650697;7368.37368823656;7428.442866785121;7444;7525.209852965579;7353.37496312798;7410.036695229585;7413.184549699421;7416.406687465098;7419.369353605004;6718.899216511659;6865.691043902936;6918.169819621678;6920.5847649141215;6973.3375329343635;6657.966710166418;6714.227863795726;6749.763758268437;6758.324167583202;6824;6233.781817636361;6249.96875015622;6310.84222894413;6451.967740161269;6455.903161452676;4833.2025215840395;4850.684705494132;4896.92654610174;4917.58200552957;4982.5764809990105;4864.236033761568;5006.424261210008;5034.345535080416;5042.520960508746;5065.39215294167 10:37:44 INFO - PROCESS | 16887 | |4;prototype.html;321.1777848707308;331.32079237563;333.95825521809775;342.3768740891578;344.66739596289574;5232.84301470956;5248.8425347239545;5263.86840328992;5282.2076688496745;5300.681959082448;5191.636585439021;5206.5834733221345;5210.635255532115;5215.348081489814;5216.60875434343;3919.529656441224;4020.2361551305157;4026.396040593905;4110.766769968997;4149.875503734893;4129.731567448106;4138.855140070098;4151.647109995654;4162.313218318974;4166.604172603597;4106.240345536071;4113;4114.382842573608;4121.793910304487;4138.482689663792;3886.24218277436;3912.4326972588956;4022.1754540319166;4051.534073581546;4078.1028173802015;3572.4462708280257;3589.982050089759;3592.6946209572216;3592.7844329340323;3592.9281414371826;5113.488651134894;5120.15517439622;5132.384113906318;5133.512316329943;5171.586273098181;4511.548845115495;4652.255639097762;4672.299155126758;4684.953150468486;4686.367340409035;5475.72621368934;5477.20580515823;5481.780728770845;5489.890202195934;5504.944950550484;3867.7679339239453;3971.245463361952;3977.7016723745833;3980.24375368679;3994.2610617035652;5744.368119506851;5746.569007324426;5759.251297331362;5759.934412133769;5766.336871259775;3923.705722070856;3937.330653788863;3993.221321842213;3996.160806230666;3997.9400308995387;3956.8219430125714;3985.561588225293;3990.3615421532418;4022.230218703761;4025.6376926076796;4439.689221754446;4600;4600.769961501978;4620.5379462053525;4623.4451865775645;5480.725963701799;5481.616286859961;5501.504864562208;5516.565692919869;5583.916241256385;1351.567498400522;1353.9574527613681;1357.4909408971635;1358.5652591170929;1360.183889666212;887.1483375959151;903.4985583001366;918.7201689966888;919.9540022998823;931.4085555672197;4980.601551875841;5235;5296.523312901857;5308.628396012242;5331.786728530893;5589.496945274864;5615.606907516516;5620.908500324805;5674.858128546737;5704.201411802351;5112.539871411591;5311.814086506954;5343.278657381282;5363.544098751572;5368.677879327252;2891.407261511385;2907.680155182928;2908.389238259947;2924.8976285829895;2928.516794728846;5583.441655834384;5609.831705048855;5625;5626.521745651584;5663.716814159276;5534.916976245359;5570.498655120978;5726.484616384545;5798.797042103506;5799.420057994167;5856.4143585641095;5857.824265272048;5872.853178670567;5879.676617785977;5930.822075337746;5537.861553461195;5622.550195984393;5764.241906218476;5766.682832444088;5770;5514.944850551604;5575.832725018256;5576.191452239484;5615.157726341082;5616.578756593353;5805.809808989232;5874.823755287348;5881.206037184926;5931.228940237742;5938.435848594377;3922.5096862892137;3931.506027709452;3945.7768091891608;3964.6630036447227;4014.397840323975;5601.439856014366;5630.943690563042;5631.831045068655;5667.858303542444;5687.60186786921;5533.312339736258;5548.834744703496;5566.522897310658;5572.916406253828;5574;5249.685018898878;5464.55189374808;5501.174823776306;5512.3385193777;5537.473939975695;5438.619296649196;5445.646033007842;5459.332270908475;5463.945360546344;5474;5261.789528418821;5387.649802762808;5397.811076612456;5496.80761173357;5543.861403464945;5412.431694672003;5431.9185212221055;5459.972700136474;5460.563154947516;5486.259354987185 10:37:44 INFO - PROCESS | 16887 | |5;yui.html;687.7145984416468;754.6981207516994;771.2364758888701;775.6005657086598;786.4298383671835;12668.113232073747;13104.772188727928;13109.803352949713;13620.863791362084;13731.931340343284;12743.808842867342;12805.423755930982;12821;12821.679458013554;12822.67943301418;651.3388910256094;765.6592816196809;783.4868161354322;784.5841703896915;784.6273020315361;669.4276393683404;679.3987321220706;679.5209377388929;679.8640271945605;772.4091070331173;811.4968719393984;812.8618134917049;822.1942496353577;822.2476434062826;822.7490615362312;817.5748610722391;817.8200795824908;820.6758330459495;821.5194111444812;822.1326500541926;502.0260694253137;510.59152677857935;599.7361161089107;603.8912995660779;603.9909401358983;11583.884161158365;11924.880751192464;12000.879991200063;12216.938915305456;12301.261924284481;12447.875521244852;12605.684857878534;12938;12966.935165324114;12968.935155324258;9560.235181185488;9587.616495340179;9814.362066465657;10099.242556808269;10196.643117490927;3411.96588034119;3431.330890476358;3493.4454514804784;3635.745497815154;3647.3070116677745;63574;65845.67077164583;65984.3401565983;66112.6694366525;66165.66917165431;9628.32601717873;9752.414855108575;9793.314467987315;9829.361091529028;9841.753956151011;17629.911850440923;17670;17683.73474397885;17692.29230830778;17693.469195924143;7499.363063688675;7516.24837516244;7717.112532058773;7854.8429031419055;7892.329152022027;4023.3361495353524;4102.261592913244;4200.138971510833;4218.261804184255;4222.873313800591;3282.753793465452;3352.3573449010296;3386.3227354529195;3389.5254664347012;3396.100033491127;551.5918220516788;553.9944600553943;560.0954458549413;561.9859503512445;568.3208565763872;522.7020598258956;574.4313130001269;580.38189328366;670.5306285600002;686.0943554508002;8584.613692383859;9469.66856160031;9638;9740.220782337396;9880.209583233323;545.6180673528546;552.541390645763;571.5970240980099;629.2700467457727;669.3306693306694;4038.656714179269;4445.466544014739;4537.659675524349;4558.33904083906;4579.260465418276;81555;82165.72928383952;85181.57409212914;86970;88696.11303886879;48145.277820832714;52980;68456;69588.5205739711;73584;56209;64021.679891600244;64147.67926160339;64917.20993480718;66856.9971450419;8947.776305592412;9503.714888553355;9540.95229523848;9739.805203896025;9798.57920601523;41913.79043104765;42086.57913420827;42305.78847105745;43507.56492435035;44125.33811992887;38445.23109537738;38833.223335533694;40391;40477.1904561913;41157;10990.835137473105;11588.67522431446;11696.532138714696;11770.3526306054;11860;13511.459541618618;13602.319884005958;13664;13928.164310141425;14377.56867293983;12873;12972.935135324264;13292.136011159244;13662.658433539242;13852.584422467342;11953.402329883296;12412.503499859904;12962.481500739865;13096;13474.461021559027;11882.16824822254;12332.075094368138;12727.490900363882;12786.61640150797;12860.742785144057;10391.012853778879;10684.305520141166;10840.783184336427;10880.782384352111;10970.890291097307;9673.516324183904;10383.325083869524;10660.253782235479;10697.14422846155;10861.239713219999 10:37:44 INFO - PROCESS | 16887 | __end_tp_report 10:37:44 INFO - PROCESS | 16887 | __start_cc_report 10:37:44 INFO - PROCESS | 16887 | _x_x_mozilla_cycle_collect,2678 10:37:44 INFO - PROCESS | 16887 | __end_cc_report 10:37:44 INFO - PROCESS | 16887 | __startTimestamp1478889464494__endTimestamp 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | ------- Summary: start ------- 10:37:44 INFO - PROCESS | 16887 | Number of tests: 6 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | [#0] dojo.html Cycles:165 Average:5385.05 Median:5617.24 stddev:601.26 (10.7%) stddev-sans-first:575.64 10:37:44 INFO - PROCESS | 16887 | Values: 3094.8 3125.3 3130.8 3151.2 3183.9 5329.6 5359.5 5388.9 5452.9 5456.3 5361.2 5383.8 5385.9 5392.8 5395.2 4888.4 4934.3 4956.7 5009.8 5062.2 4950.4 4965.8 4978.7 5023.4 5024.9 4947.1 4985.1 4988.0 4991.5 5001.7 4948.2 4958.6 4959.7 5004.9 5011.5 4817.1 4848.6 4851.0 4888.0 4935.3 5321.6 5325.1 5334.7 5363.5 5400.8 5735.7 5751.3 5773.0 5773.9 5775.0 5694.9 5805.8 5809.8 5813.8 5819.6 5345.8 5385.5 5417.5 5419.4 5485.3 5912.7 5921.5 5924.1 5930.9 5933.1 5701.7 5708.9 5723.7 5723.8 5734.6 5626.3 5702.1 5757.5 5769.3 5802.1 5767.6 5794.9 5812.1 5845.6 5861.8 5805.3 5816.7 5826.5 5830.1 5832.6 4361.4 4408.9 4411.2 4413.1 4461.5 3937.0 3980.7 3999.1 4001.1 4012.9 5494.6 5500.7 5501.4 5501.6 5501.6 5677.5 5720.5 5788.2 5832.9 5841.0 5467.6 5486.3 5510.2 5555.2 5611.4 5092.9 5093.7 5099.6 5103.6 5136.0 5828.9 6062.1 6067.2 6073.5 6076.8 5691.6 5727.1 5780.4 5783.9 5784.7 5958.6 5961.3 5969.5 5971.1 5972.0 5614.9 5648.9 5656.9 5660.4 5663.0 5754.7 5762.7 5764.8 5765.4 5766.3 5617.2 5628.7 5633.3 5635.9 5639.4 5631.1 5637.2 5639.3 5639.9 5640.8 5600.9 5607.1 5618.9 5688.8 5696.7 5769.9 5774.4 5775.3 5779.7 5783.2 5439.0 5466.3 5565.5 5575.8 5637.7 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | [#1] ext.html Cycles:180 Average:56114.01 Median:19263.71 stddev:110581.39 (574.0%) stddev-sans-first:110813.02 10:37:44 INFO - PROCESS | 16887 | Values: 589.9 596.3 631.8 642.0 644.2 31516.2 40748.4 42141.0 42272.6 45067.5 42817.0 43522.6 43554.0 43555.1 43652.0 7787.1 8556.0 8704.3 8711.0 8723.8 7946.7 10079.2 10305.3 10308.8 10542.1 10422.8 10440.1 10446.8 10479.0 10488.9 10362.3 10401.3 10404.2 10431.1 10432.2 10265.9 10313.5 10320.3 10326.3 10327.4 41154.4 41340.0 41574.8 41611.0 41649.6 3096.0 3112.7 3115.7 3326.5 3482.8 30050.0 30286.8 30605.2 31099.2 32228.4 4075.4 4176.2 4186.6 4220.2 4222.1 329469.0 330755.0 330862.0 331228.0 331633.0 33528.7 54075.2 54388.7 54441.5 54534.2 33645.7 36150.5 36216.5 36235.0 36299.5 15373.6 15604.0 15611.5 15613.4 15619.5 9885.0 10128.2 12760.6 12962.2 13180.3 8318.2 8348.3 8414.2 8420.3 8439.0 3144.6 3203.4 3216.7 3217.0 3286.9 929.7 1004.5 1018.1 1074.5 1114.4 29656.6 31107.7 31359.5 31673.2 33569.7 1089.9 1102.3 1128.4 1141.3 1152.1 15342.2 15925.0 15990.7 16309.8 16475.9 486624.0 486982.0 490435.0 490570.0 491276.0 54173.0 54601.7 54687.5 54718.0 54830.0 1204.7 1237.4 1258.9 1328.9 1370.9 27570.7 30801.2 31370.2 31786.8 31805.4 53397.7 53506.7 53624.2 53678.2 54014.5 413013.0 417566.0 417672.0 417854.0 417971.0 27121.7 27152.2 27470.0 28601.7 41419.6 44796.3 45212.0 45338.8 45386.8 45432.5 37475.3 38159.2 38705.4 39546.0 40113.6 37965.4 38227.2 38905.0 39878.8 40135.2 38984.4 40228.6 40282.6 40373.2 40480.2 30566.4 34665.7 35044.6 35375.5 35479.1 26950.6 27271.0 27384.6 27468.6 27529.6 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | [#2] jquery.html Cycles:180 Average:26950.39 Median:20177.75 stddev:72768.18 (360.6%) stddev-sans-first:72944.96 10:37:44 INFO - PROCESS | 16887 | Values: 374.4 380.3 400.1 401.3 414.2 13302.5 15109.2 18520.0 18922.4 19253.2 17767.4 17881.0 18795.6 19322.0 19363.0 5437.2 5677.7 5680.9 5693.8 5694.0 3813.0 3932.4 5341.0 5545.7 5600.1 5809.2 5817.6 5902.7 5918.2 5926.1 5773.4 5915.9 6094.1 6130.2 6132.0 5485.5 5508.4 5515.8 5519.3 5520.6 12765.7 12849.9 12867.2 12873.4 13726.2 2145.2 2151.7 2156.3 2237.9 2271.6 9440.5 9589.0 9718.2 12519.6 13119.0 1840.8 1842.9 1850.6 1882.3 1896.3 77264.0 79940.2 81496.0 82103.0 82377.4 10869.3 10883.6 11023.4 11062.2 11066.0 15418.8 15713.7 15737.2 15744.8 15752.7 7578.0 7611.7 7843.9 7885.3 8232.8 7671.9 7731.3 7780.2 8022.0 8076.8 4203.6 4266.4 4576.5 4812.8 4837.7 1767.5 1855.1 1905.9 1991.7 1992.5 811.8 893.9 945.0 956.8 1004.9 18120.0 18234.3 18822.5 18952.6 19133.0 923.2 957.6 964.9 980.0 1001.1 9974.3 10707.4 10710.4 10710.6 10712.3 426377.0 427901.0 429034.0 449878.0 460663.0 84930.7 88474.0 95385.0 99445.5 100522.0 994.8 1021.1 1038.7 1062.8 1071.8 12252.2 16445.0 16861.0 17848.6 18100.1 39413.8 39955.4 40080.0 40278.8 40696.8 51296.5 54457.5 54485.5 54497.5 55409.7 8033.0 8070.5 8259.6 8390.3 8462.7 11344.9 12802.7 13065.5 13073.9 13308.9 11691.7 11701.2 11791.1 12172.6 12245.6 10996.7 11082.8 11251.0 11535.4 11735.1 9399.5 9833.4 10151.2 11513.8 11797.1 8524.2 8562.5 8635.9 8820.2 8844.3 9307.0 10471.2 10577.0 10826.1 10966.4 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | [#3] mootools.html Cycles:180 Average:5306.82 Median:5372.43 stddev:2875.45 (53.5%) stddev-sans-first:2868.59 10:37:44 INFO - PROCESS | 16887 | Values: 1408.6 1433.7 1517.5 1671.4 1707.1 6839.3 7004.9 7586.5 7994.8 8019.5 7532.1 7706.8 7755.1 7932.5 7950.4 2260.5 2288.9 2294.6 2295.2 2295.4 1949.6 2240.5 2297.8 2298.0 2300.3 1976.0 2214.5 2300.3 2301.0 2326.6 2231.2 2256.5 2260.4 2261.3 2268.1 2241.5 2242.2 2275.1 2278.6 2280.6 7881.3 7958.7 7965.5 8013.1 8029.1 4832.6 4968.1 4973.9 4976.4 4981.5 3151.1 3180.3 3252.1 3258.4 3329.4 1039.1 1086.9 1089.9 1097.0 1104.3 11092.6 11121.9 11137.3 11145.0 11154.6 4329.6 4552.0 4612.0 4642.4 4653.3 9358.3 9360.4 9362.8 9374.0 9376.4 5093.5 5112.4 5114.5 5115.6 5115.7 4531.9 4546.3 4645.4 4699.7 4712.7 3691.5 3740.1 3814.0 3851.1 3882.4 1151.7 1183.7 1262.5 1272.3 1283.3 869.0 903.8 924.3 933.5 942.9 5429.1 5454.5 5499.1 5500.2 5555.9 867.7 890.8 893.1 923.7 967.6 3713.5 3848.2 3883.8 3884.4 3907.8 9291.2 9701.4 9727.1 9751.3 9780.9 9689.9 9715.0 9736.0 9771.5 9793.1 7295.1 7396.5 7406.0 7411.9 7427.4 5315.7 5513.7 5608.1 5627.9 5649.1 8771.6 8920.2 8944.5 8962.6 9116.6 8473.8 8691.2 8825.2 9022.2 9130.0 7336.9 7368.4 7428.4 7444.0 7525.2 7353.4 7410.0 7413.2 7416.4 7419.4 6718.9 6865.7 6918.2 6920.6 6973.3 6658.0 6714.2 6749.8 6758.3 6824.0 6233.8 6250.0 6310.8 6452.0 6455.9 4833.2 4850.7 4896.9 4917.6 4982.6 4864.2 5006.4 5034.3 5042.5 5065.4 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | [#4] prototype.html Cycles:180 Average:4621.26 Median:5304.66 stddev:1373.48 (25.9%) stddev-sans-first:1338.87 10:37:44 INFO - PROCESS | 16887 | Values: 321.2 331.3 334.0 342.4 344.7 5232.8 5248.8 5263.9 5282.2 5300.7 5191.6 5206.6 5210.6 5215.3 5216.6 3919.5 4020.2 4026.4 4110.8 4149.9 4129.7 4138.9 4151.6 4162.3 4166.6 4106.2 4113.0 4114.4 4121.8 4138.5 3886.2 3912.4 4022.2 4051.5 4078.1 3572.4 3590.0 3592.7 3592.8 3592.9 5113.5 5120.2 5132.4 5133.5 5171.6 4511.5 4652.3 4672.3 4685.0 4686.4 5475.7 5477.2 5481.8 5489.9 5504.9 3867.8 3971.2 3977.7 3980.2 3994.3 5744.4 5746.6 5759.3 5759.9 5766.3 3923.7 3937.3 3993.2 3996.2 3997.9 3956.8 3985.6 3990.4 4022.2 4025.6 4439.7 4600.0 4600.8 4620.5 4623.4 5480.7 5481.6 5501.5 5516.6 5583.9 1351.6 1354.0 1357.5 1358.6 1360.2 887.1 903.5 918.7 920.0 931.4 4980.6 5235.0 5296.5 5308.6 5331.8 5589.5 5615.6 5620.9 5674.9 5704.2 5112.5 5311.8 5343.3 5363.5 5368.7 2891.4 2907.7 2908.4 2924.9 2928.5 5583.4 5609.8 5625.0 5626.5 5663.7 5534.9 5570.5 5726.5 5798.8 5799.4 5856.4 5857.8 5872.9 5879.7 5930.8 5537.9 5622.6 5764.2 5766.7 5770.0 5514.9 5575.8 5576.2 5615.2 5616.6 5805.8 5874.8 5881.2 5931.2 5938.4 3922.5 3931.5 3945.8 3964.7 4014.4 5601.4 5630.9 5631.8 5667.9 5687.6 5533.3 5548.8 5566.5 5572.9 5574.0 5249.7 5464.6 5501.2 5512.3 5537.5 5438.6 5445.6 5459.3 5463.9 5474.0 5261.8 5387.6 5397.8 5496.8 5543.9 5412.4 5431.9 5460.0 5460.6 5486.3 10:37:44 INFO - PROCESS | 16887 | 10:37:44 INFO - PROCESS | 16887 | [#5] yui.html Cycles:180 Average:16126.47 Median:26362.27 stddev:21208.92 (80.5%) stddev-sans-first:21236.73 10:37:44 INFO - PROCESS | 16887 | Values: 687.7 754.7 771.2 775.6 786.4 12668.1 13104.8 13109.8 13620.9 13731.9 12743.8 12805.4 12821.0 12821.7 12822.7 651.3 765.7 783.5 784.6 784.6 669.4 679.4 679.5 679.9 772.4 811.5 812.9 822.2 822.2 822.7 817.6 817.8 820.7 821.5 822.1 502.0 510.6 599.7 603.9 604.0 11583.9 11924.9 12000.9 12216.9 12301.3 12447.9 12605.7 12938.0 12966.9 12968.9 9560.2 9587.6 9814.4 10099.2 10196.6 3412.0 3431.3 3493.4 3635.7 3647.3 63574.0 65845.7 65984.3 66112.7 66165.7 9628.3 9752.4 9793.3 9829.4 9841.8 17629.9 17670.0 17683.7 17692.3 17693.5 7499.4 7516.2 7717.1 7854.8 7892.3 4023.3 4102.3 4200.1 4218.3 4222.9 3282.8 3352.4 3386.3 3389.5 3396.1 551.6 554.0 560.1 562.0 568.3 522.7 574.4 580.4 670.5 686.1 8584.6 9469.7 9638.0 9740.2 9880.2 545.6 552.5 571.6 629.3 669.3 4038.7 4445.5 4537.7 4558.3 4579.3 81555.0 82165.7 85181.6 86970.0 88696.1 48145.3 52980.0 68456.0 69588.5 73584.0 56209.0 64021.7 64147.7 64917.2 66857.0 8947.8 9503.7 9541.0 9739.8 9798.6 41913.8 42086.6 42305.8 43507.6 44125.3 38445.2 38833.2 40391.0 40477.2 41157.0 10990.8 11588.7 11696.5 11770.4 11860.0 13511.5 13602.3 13664.0 13928.2 14377.6 12873.0 12972.9 13292.1 13662.7 13852.6 11953.4 12412.5 12962.5 13096.0 13474.5 11882.2 12332.1 12727.5 12786.6 12860.7 10391.0 10684.3 10840.8 10880.8 10970.9 9673.5 10383.3 10660.3 10697.1 10861.2 10:37:44 INFO - PROCESS | 16887 | -------- Summary: end -------- 10:37:44 INFO - PROCESS | 16887 | 10:37:45 INFO - TEST-INFO | 16887: exit 0 10:37:45 INFO - TEST-OK | dromaeo_css | took 1118436ms 10:37:45 INFO - TEST-START | kraken 10:37:45 INFO - operating with platform_type : linux_ 10:37:45 INFO - Initialising browser for kraken test... 10:37:45 INFO - TEST-INFO | started process 17186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_62_aD/profile http://localhost:60247/getInfo.html) 10:37:48 INFO - PROCESS | 17186 | __metrics Screen width/height:1600/1200 10:37:48 INFO - PROCESS | 17186 | colorDepth:24 10:37:48 INFO - PROCESS | 17186 | Browser inner width/height: 1024/697 10:37:48 INFO - PROCESS | 17186 | __metrics 10:37:49 INFO - PROCESS | 17186 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:37:49 INFO - PROCESS | 17186 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:37:50 INFO - TEST-INFO | 17186: exit 0 10:37:50 INFO - Browser initialized. 10:37:50 INFO - Running cycle 1/1 for kraken test... 10:37:50 INFO - TEST-INFO | started process 17270 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_62_aD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:02 INFO - PROCESS | 17270 | RSS: Main: 172531712 10:38:02 INFO - PROCESS | 17270 | 10:38:05 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60247/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:06 INFO - PROCESS | 17270 | RSS: Main: 229539840 10:38:06 INFO - PROCESS | 17270 | 10:38:08 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60247/tests/kraken/driver.html?testName=audio-dft) 10:38:09 INFO - PROCESS | 17270 | RSS: Main: 216018944 10:38:09 INFO - PROCESS | 17270 | 10:38:12 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60247/tests/kraken/driver.html?testName=audio-fft) 10:38:13 INFO - PROCESS | 17270 | RSS: Main: 297005056 10:38:13 INFO - PROCESS | 17270 | 10:38:15 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60247/tests/kraken/driver.html?testName=audio-oscillator) 10:38:15 INFO - PROCESS | 17270 | RSS: Main: 207106048 10:38:15 INFO - PROCESS | 17270 | 10:38:18 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:18 INFO - PROCESS | 17270 | RSS: Main: 213127168 10:38:18 INFO - PROCESS | 17270 | 10:38:21 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60247/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:22 INFO - PROCESS | 17270 | RSS: Main: 247967744 10:38:22 INFO - PROCESS | 17270 | 10:38:25 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60247/tests/kraken/driver.html?testName=imaging-desaturate) 10:38:26 INFO - PROCESS | 17270 | RSS: Main: 246947840 10:38:26 INFO - PROCESS | 17270 | 10:38:28 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60247/tests/kraken/driver.html?testName=json-parse-financial) 10:38:29 INFO - PROCESS | 17270 | RSS: Main: 245682176 10:38:29 INFO - PROCESS | 17270 | 10:38:30 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:38:31 INFO - PROCESS | 17270 | RSS: Main: 208846848 10:38:31 INFO - PROCESS | 17270 | 10:38:33 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:38:33 INFO - PROCESS | 17270 | RSS: Main: 215588864 10:38:33 INFO - PROCESS | 17270 | 10:38:35 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:38:36 INFO - PROCESS | 17270 | RSS: Main: 224591872 10:38:36 INFO - PROCESS | 17270 | 10:38:39 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:38:39 INFO - PROCESS | 17270 | RSS: Main: 227721216 10:38:39 INFO - PROCESS | 17270 | 10:38:42 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:38:43 INFO - PROCESS | 17270 | RSS: Main: 230031360 10:38:43 INFO - PROCESS | 17270 | 10:38:44 INFO - PROCESS | 17270 | Cycle 1(1): loaded http://localhost:60247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60247/tests/kraken/driver.html?testName=ai-astar) 10:38:45 INFO - PROCESS | 17270 | RSS: Main: 279511040 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | __start_tp_report 10:38:45 INFO - PROCESS | 17270 | _x_x_mozilla_page_load 10:38:45 INFO - PROCESS | 17270 | _x_x_mozilla_page_load_details 10:38:45 INFO - PROCESS | 17270 | |i|pagename|runs| 10:38:45 INFO - PROCESS | 17270 | |0;ai-astar;106;114;113;111;112;113;112;112;114;112 10:38:45 INFO - PROCESS | 17270 | |1;audio-beat-detection;160;122;125;164;124;124;123;127;152;121 10:38:45 INFO - PROCESS | 17270 | |2;audio-dft;161;160;159;160;161;162;161;159;162;165 10:38:45 INFO - PROCESS | 17270 | |3;audio-fft;75;75;75;107;77;77;77;76;105;76 10:38:45 INFO - PROCESS | 17270 | |4;audio-oscillator;83;83;134;82;82;82;114;81;83;114 10:38:45 INFO - PROCESS | 17270 | |5;imaging-gaussian-blur;118;118;117;117;117;118;117;117;117;118 10:38:45 INFO - PROCESS | 17270 | |6;imaging-darkroom;146;146;145;146;148;149;148;145;145;148 10:38:45 INFO - PROCESS | 17270 | |7;imaging-desaturate;85;85;85;85;84;85;85;85;85;85 10:38:45 INFO - PROCESS | 17270 | |8;json-parse-financial;52;52;53;53;53;53;64;53;53;58 10:38:45 INFO - PROCESS | 17270 | |9;json-stringify-tinderbox;62;62;62;63;62;61;62;62;62;62 10:38:45 INFO - PROCESS | 17270 | |10;stanford-crypto-aes;80;79;80;80;81;92;78;82;80;79 10:38:45 INFO - PROCESS | 17270 | |11;stanford-crypto-ccm;135;134;141;130;132;130;139;139;174;154 10:38:45 INFO - PROCESS | 17270 | |12;stanford-crypto-pbkdf2;166;162;170;167;167;169;165;160;165;162 10:38:45 INFO - PROCESS | 17270 | |13;stanford-crypto-sha256-iterative;67;64;64;70;64;64;73;67;66;63 10:38:45 INFO - PROCESS | 17270 | __end_tp_report 10:38:45 INFO - PROCESS | 17270 | __start_cc_report 10:38:45 INFO - PROCESS | 17270 | _x_x_mozilla_cycle_collect,1684 10:38:45 INFO - PROCESS | 17270 | __end_cc_report 10:38:45 INFO - PROCESS | 17270 | __startTimestamp1478889525218__endTimestamp 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | ------- Summary: start ------- 10:38:45 INFO - PROCESS | 17270 | Number of tests: 14 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:2.28 (2.0%) stddev-sans-first:1.01 10:38:45 INFO - PROCESS | 17270 | Values: 106.0 114.0 113.0 111.0 112.0 113.0 112.0 112.0 114.0 112.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:126.00 stddev:17.20 (13.7%) stddev-sans-first:15.51 10:38:45 INFO - PROCESS | 17270 | Values: 160.0 122.0 125.0 164.0 124.0 124.0 123.0 127.0 152.0 121.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.76 (1.1%) stddev-sans-first:1.87 10:38:45 INFO - PROCESS | 17270 | Values: 161.0 160.0 159.0 160.0 161.0 162.0 161.0 159.0 162.0 165.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.68 (16.7%) stddev-sans-first:13.20 10:38:45 INFO - PROCESS | 17270 | Values: 75.0 75.0 75.0 107.0 77.0 77.0 77.0 76.0 105.0 76.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:82.00 stddev:19.33 (23.6%) stddev-sans-first:20.11 10:38:45 INFO - PROCESS | 17270 | Values: 83.0 83.0 134.0 82.0 82.0 82.0 114.0 81.0 83.0 114.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:38:45 INFO - PROCESS | 17270 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.51 (1.0%) stddev-sans-first:1.58 10:38:45 INFO - PROCESS | 17270 | Values: 146.0 146.0 145.0 146.0 148.0 149.0 148.0 145.0 145.0 148.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 10:38:45 INFO - PROCESS | 17270 | Values: 85.0 85.0 85.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.00 stddev:3.78 (7.1%) stddev-sans-first:3.91 10:38:45 INFO - PROCESS | 17270 | Values: 52.0 52.0 53.0 53.0 53.0 53.0 64.0 53.0 53.0 58.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 10:38:45 INFO - PROCESS | 17270 | Values: 62.0 62.0 62.0 63.0 62.0 61.0 62.0 62.0 62.0 62.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.00 stddev:3.98 (5.0%) stddev-sans-first:4.21 10:38:45 INFO - PROCESS | 17270 | Values: 80.0 79.0 80.0 80.0 81.0 92.0 78.0 82.0 80.0 79.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.00 stddev:13.64 (9.8%) stddev-sans-first:14.30 10:38:45 INFO - PROCESS | 17270 | Values: 135.0 134.0 141.0 130.0 132.0 130.0 139.0 139.0 174.0 154.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:3.20 (1.9%) stddev-sans-first:3.38 10:38:45 INFO - PROCESS | 17270 | Values: 166.0 162.0 170.0 167.0 167.0 169.0 165.0 160.0 165.0 162.0 10:38:45 INFO - PROCESS | 17270 | 10:38:45 INFO - PROCESS | 17270 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:3.19 (4.8%) stddev-sans-first:3.37 10:38:45 INFO - PROCESS | 17270 | Values: 67.0 64.0 64.0 70.0 64.0 64.0 73.0 67.0 66.0 63.0 10:38:45 INFO - PROCESS | 17270 | -------- Summary: end -------- 10:38:45 INFO - PROCESS | 17270 | 10:38:46 INFO - TEST-INFO | 17270: exit 0 10:38:46 INFO - TEST-OK | kraken | took 61024ms 10:38:46 INFO - SUITE-END | took 1179s 10:38:46 INFO - Completed test suite (00:19:39) 10:38:46 INFO - javascript benchmark 10:38:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.767892408069, 3125.328054468289, 3130.843457827109, 3151.1964449065513, 3183.8726450941963, 5329.573634109272, 5359.517643412092, 5388.865278368043, 5452.890942181159, 5456.345238571372, 5361.249425080492, 5383.838484845451, 5385.892282154365, 5392.811251606195, 5395.21769343446, 4888.364512613364, 4934.28452874333, 4956.653034287601, 5009.849704508871, 5062.164742817449, 4950.405951285833, 4965.801367945278, 4978.701277923318, 5023.372078490189, 5024.874378140557, 4947.060058588857, 4985.127602669519, 4987.975060124694, 4991.5258050485145, 5001.7499125043605, 4948.183549714328, 4958.553730164303, 4959.652824302264, 5004.949950500485, 5011.523905228997, 4817.084753896748, 4848.636352273558, 4850.95149048512, 4888.0, 4935.284383764334, 5321.627486075976, 5325.068113080234, 5334.733263336818, 5363.54409875161, 5400.756965936543, 5735.684537350444, 5751.281089863767, 5773.047447171211, 5773.884522309572, 5775.047117225653, 5694.9430505695245, 5805.796797112081, 5809.825705228807, 5813.767449302023, 5819.563532735019, 5345.7594408251725, 5385.542228910508, 5417.458254174551, 5419.376771671229, 5485.259489968883, 5912.704364781744, 5921.496672782776, 5924.052151655715, 5930.932432162253, 5933.080372542263, 5701.743421546041, 5708.857278567986, 5723.656580605177, 5723.771049157987, 5734.627249228787, 5626.2967129108865, 5702.0591602385975, 5757.510611597977, 5769.278840144982, 5802.071668533014, 5767.596268261265, 5794.942050579441, 5812.128180772918, 5845.649261044351, 5861.765529378862, 5805.332386775575, 5816.680082595498, 5826.533877289807, 5830.125481177857, 5832.62087964281, 4361.411209486679, 4408.911821763547, 4411.1618792429335, 4413.1394378095965, 4461.5092339842595, 3936.980315098406, 3980.7014473914574, 3999.140184860269, 4001.0597509585805, 4012.8996775080855, 5494.587905906993, 5500.724963751876, 5501.449855014466, 5501.642393244506, 5501.642393244506, 5677.545796336283, 5720.513756330675, 5788.218590490314, 5832.88334233313, 5841.0, 5467.589930755209, 5486.286782718221, 5510.173473978855, 5555.194496797942, 5611.354694210137, 5092.898142037138, 5093.694378337312, 5099.643024988215, 5103.642745007888, 5136.049830781318, 5828.883422331445, 6062.120992455981, 6067.24159480065, 6073.48375388097, 6076.817695469143, 5691.573132015198, 5727.140928860537, 5780.381493181916, 5783.94216057834, 5784.681842498703, 5958.553108516965, 5961.314448838439, 5969.492593129633, 5971.0744834550715, 5972.0, 5614.915776263278, 5648.943510565006, 5656.886862262814, 5660.377358490645, 5663.0, 5754.741036653277, 5762.654240745569, 5764.769409223584, 5765.3946335634155, 5766.250387449605, 5617.241672374341, 5628.718564071698, 5633.324001119892, 5635.887282254414, 5639.379668236409, 5631.099024156116, 5637.210790489253, 5639.3232812062815, 5639.915401268902, 5640.774369025357, 5600.85997850057, 5607.130894711163, 5618.943810561842, 5688.77244910199, 5696.715164241688, 5769.94230057694, 5774.364819869895, 5775.306963164279, 5779.68211748341, 5783.248177737036, 5439.0, 5466.2620546227345, 5565.499105080562, 5575.804846830341, 5637.718114094197], "value": 5344.841913533378, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.9056151015837, 596.3053043204667, 631.7630888416844, 641.9775307864226, 644.2044075566678, 31516.212094697614, 40748.38877416837, 42141.0, 42272.577274227246, 45067.54932450675, 42817.0, 43522.56477435225, 43554.0, 43555.12889742203, 43652.0, 7787.143414224431, 8555.957220213906, 8704.303655707528, 8710.956445217766, 8723.781905452352, 7946.6821327146845, 10079.244056695778, 10305.278630495868, 10308.793824123513, 10542.10392116671, 10422.843657345107, 10440.112590429822, 10446.843297350546, 10479.0, 10488.947555262213, 10362.27464077515, 10401.271910966236, 10404.219683523766, 10431.061204491556, 10432.165426765878, 10265.897341026568, 10313.535890884928, 10320.329178603442, 10326.328788628714, 10327.431991240479, 41154.38268425976, 41340.0, 41574.792126039174, 41611.0, 41649.583504164875, 3096.0, 3112.719855213019, 3115.6572776994512, 3326.501024846268, 3482.7736197147356, 30050.0, 30286.84856575725, 30605.234869128228, 31099.222519437197, 32228.35543289121, 4075.4090656854887, 4176.227397931392, 4186.644135248507, 4220.177065472234, 4222.071144348239, 329469.0, 330755.0, 330862.0, 331228.0, 331633.0, 33528.664713352555, 54075.188872166946, 54388.728056360254, 54441.45558544443, 54534.181987270225, 33645.663543364746, 36150.45774313388, 36216.45675314873, 36235.0, 36299.4555081674, 15373.615659608375, 15604.0, 15611.453599123975, 15613.3754649815, 15619.531414057596, 9885.0, 10128.240381971382, 12760.553380631633, 12962.22226666403, 13180.340982950815, 8318.168183181633, 8348.290395316344, 8414.242718155396, 8420.2842758365, 8438.957805211057, 3144.6383665878716, 3203.4233837908932, 3216.710496055366, 3216.9839150804564, 3286.8520916558814, 929.7303781903307, 1004.4826914139225, 1018.1142406106586, 1074.4735079810837, 1114.400139300024, 29656.555151672743, 31107.68892311048, 31359.529607055912, 31673.20816979594, 33569.664303357145, 1089.9182561307935, 1102.2835157147917, 1128.3850301585655, 1141.2866958151155, 1152.0898490192822, 15342.232888355538, 15925.0, 15990.680186396206, 16309.755353669705, 16475.917620411823, 486624.0, 486982.0, 490435.0, 490570.0, 491276.0, 54173.0, 54601.72699136479, 54687.45312546824, 54718.0, 54830.0, 1204.7048473123966, 1237.3689418396682, 1258.9307588082743, 1328.913620614657, 1370.9245991470366, 27570.724292756815, 30801.229969250053, 31370.21574460657, 31786.841065794524, 31805.363892721554, 53397.7330113347, 53506.73246633742, 53624.22448744988, 53678.194827078405, 54014.45985540094, 413013.0, 417566.0, 417672.0, 417854.0, 417971.0, 27121.72878271192, 27152.185434436997, 27470.0, 28601.713982859907, 41419.58580414157, 44796.32805507855, 45212.0, 45338.773306133255, 45386.77306613446, 45432.54567454283, 37475.25049499049, 38159.23681526409, 38705.41941870818, 39546.0, 40113.59886401215, 37965.430518542795, 38227.235455291295, 38905.0, 39878.800605997945, 40135.1972960545, 38984.415233770946, 40228.597714022486, 40282.597174029055, 40373.1925361497, 40480.1903961925, 30566.388672225985, 34665.65334346624, 35044.64955350414, 35375.46936796002, 35479.11302217465, 26950.59574106429, 27271.0, 27384.58923116115, 27468.587971180048, 27529.587056193774], "value": 18645.03604741743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.39908946141423, 380.2907577368209, 400.09179163299314, 401.3297792686214, 414.2274657763272, 13302.534411295594, 15109.168995705231, 18520.0, 18922.432327030176, 19253.22987080515, 17767.378141765043, 17881.0, 18795.624087518274, 19322.0, 19363.0, 5437.211604317372, 5677.659340439566, 5680.943190568083, 5693.800716974907, 5693.971530142344, 3812.9809350953205, 3932.390479475686, 5341.0, 5545.694986775726, 5600.131979543177, 5809.244798176232, 5817.592768506206, 5902.675352855591, 5918.2306300181135, 5926.1110833374905, 5773.3937936516695, 5915.852103697399, 6094.085887116968, 6130.2030736004035, 6132.0, 5485.533729632986, 5508.421615730331, 5515.751791169407, 5519.337679478488, 5520.558355331604, 12765.680857978532, 12849.87150128496, 12867.22796632205, 12873.356332183446, 13726.245056521888, 2145.1741079684434, 2151.698762173297, 2156.266869264442, 2237.876916769577, 2271.602469567819, 9440.527973601293, 9589.041095890425, 9718.222542196607, 12519.56181533642, 13119.0, 1840.834324910751, 1842.9078546072776, 1850.6391253705533, 1882.265916292647, 1896.3078476356168, 77264.0, 79940.20059799385, 81496.0, 82103.0, 82377.40772772486, 10869.347839129678, 10883.619073332395, 11023.44882755859, 11062.170337224741, 11066.0, 15418.768718469231, 15713.68572628541, 15737.213139342986, 15744.763828542582, 15752.68494630101, 7577.962110189524, 7611.695532178762, 7843.882341764764, 7885.29032387088, 8232.753017409488, 7671.884921726179, 7731.304182623591, 7780.183080776437, 8021.997250343707, 8076.757697269091, 4203.558626344251, 4266.381374700651, 4576.542345765463, 4812.831550895702, 4837.733924634179, 1767.5139336682514, 1855.1095474172203, 1905.9428217153506, 1991.73111629931, 1992.531755037565, 811.8011087283653, 893.9016708162097, 945.0, 956.8038552096804, 1004.8693669822876, 18120.0, 18234.270629174684, 18822.529436763918, 18952.62094758097, 19133.0, 923.2337160157053, 957.5902966837751, 964.8890377606525, 979.9951000244953, 1001.104011909337, 9974.301798874008, 10707.357558546511, 10710.410927399067, 10710.625128120479, 10712.303700259457, 426377.0, 427901.0, 429034.0, 449878.0, 460663.0, 84930.6850506673, 88474.0, 95385.0, 99445.50277248568, 100522.0, 994.7811481474064, 1021.1218352217087, 1038.7143535527791, 1062.8086944349936, 1071.7642118733866, 12252.181998140655, 16445.0, 16861.0, 17848.643027139125, 18100.09499525045, 39413.80293098516, 39955.40735778564, 40080.0, 40278.798606006785, 40696.79651601842, 51296.48703513067, 54457.45542544524, 54485.45514544804, 54497.45502545082, 55409.72295138498, 8032.959835200787, 8070.47541909774, 8259.628316725642, 8390.28682561989, 8462.703805366782, 11344.886551134383, 12802.67993300175, 13065.477380904656, 13073.869261307265, 13308.866911330762, 11691.707707307385, 11701.239419437708, 11791.115666324888, 12172.634820955385, 12245.571405000783, 10996.670099897015, 11082.833757493805, 11251.043661288883, 11535.36555489456, 11735.119866010255, 9399.483028433502, 9833.4099954003, 10151.238657100599, 11513.769724605294, 11797.11521635898, 8524.167304029663, 8562.48625082497, 8635.913640863511, 8820.2061814437, 8844.292456603585, 9307.0, 10471.21465890046, 10577.048065674126, 10826.13390928708, 10966.396848173426], "value": 8803.087937051532, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.5563047639992, 1433.6702558411564, 1517.5068102866571, 1671.4400675773616, 1707.0867086108933, 6839.316068393158, 7004.859902801941, 7586.506877052988, 7994.800129996753, 8019.518828870265, 7532.096148462192, 7706.7687969361, 7755.069391672993, 7932.524048557077, 7950.36397088233, 2260.480089579398, 2288.8855557222073, 2294.621387471065, 2295.1507942061376, 2295.36877358726, 1949.62957038163, 2240.451089483071, 2297.8391512594126, 2297.9659153381044, 2300.25241796416, 1976.041619814396, 2214.5128071824174, 2300.2869110575693, 2300.999065406545, 2326.581215381239, 2231.2079211879714, 2256.458449972003, 2260.4009937366527, 2261.344210179046, 2268.1267711931027, 2241.5180736141647, 2242.2040175737543, 2275.1013349726763, 2278.601244782173, 2280.6350983842503, 7881.290683838425, 7958.721444749463, 7965.482243654202, 8013.11855695873, 8029.116797152308, 4832.565069143759, 4968.130577148984, 4973.850784476472, 4976.4277108132665, 4981.476944920803, 3151.086185006345, 3180.25264062945, 3252.1219270796987, 3258.4297747894025, 3329.350776598564, 1039.0907955538903, 1086.869575650919, 1089.9073578745815, 1097.040089921319, 1104.309806371018, 11092.55629774808, 11121.888781112086, 11137.276077055047, 11145.0, 11154.609588664358, 4329.610335069859, 4551.954480455153, 4611.976940115345, 4642.396488456547, 4653.302004699254, 9358.344915855825, 9360.438373697463, 9362.812743745088, 9374.0, 9376.390534615228, 5093.465186155475, 5112.437631860566, 5114.488551144856, 5115.590752739772, 5115.74421278942, 4531.932021019687, 4546.29532422475, 4645.442546894395, 4699.671023028355, 4712.69367491112, 3691.53855768029, 3740.121071548184, 3813.9809300953316, 3851.056491159684, 3882.4370466282794, 1151.7293436042523, 1183.6863231243726, 1262.4571434283162, 1272.2557303977278, 1283.3134273163998, 868.9739307820776, 903.8056817784077, 924.3160061554402, 933.4585940154694, 942.8585712143233, 5429.131338985743, 5454.481824226692, 5499.1476321170285, 5500.1749737539685, 5555.861103472364, 867.696306292805, 890.7550423633423, 893.0845882969878, 923.6905636611676, 967.5500892085214, 3713.461548075568, 3848.1534062506203, 3883.8446462141765, 3884.3590807517007, 3907.785071821077, 9291.163795258459, 9701.417914925127, 9727.124558789743, 9751.317407781387, 9780.902190977999, 9689.854652180224, 9714.951425242829, 9736.0, 9771.462569558742, 9793.118619324296, 7295.124585049828, 7396.519226250384, 7406.037215162102, 7411.925880741232, 7427.442941779388, 5315.734213289397, 5513.724313784375, 5608.10270356741, 5627.943720562742, 5649.096144616841, 8771.649134034567, 8920.24177944882, 8944.463332200088, 8962.596683149404, 9116.589753461243, 8473.788155296166, 8691.174338437839, 8825.249853762245, 9022.233110185707, 9129.954350228472, 7336.889946650697, 7368.37368823656, 7428.442866785121, 7444.0, 7525.209852965579, 7353.37496312798, 7410.036695229585, 7413.184549699421, 7416.406687465098, 7419.369353605004, 6718.899216511659, 6865.691043902936, 6918.169819621678, 6920.5847649141215, 6973.3375329343635, 6657.966710166418, 6714.227863795726, 6749.763758268437, 6758.324167583202, 6824.0, 6233.781817636361, 6249.96875015622, 6310.84222894413, 6451.967740161269, 6455.903161452676, 4833.2025215840395, 4850.684705494132, 4896.92654610174, 4917.58200552957, 4982.5764809990105, 4864.236033761568, 5006.424261210008, 5034.345535080416, 5042.520960508746, 5065.39215294167], "value": 4326.461399108035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.1777848707308, 331.32079237563, 333.95825521809775, 342.3768740891578, 344.66739596289574, 5232.84301470956, 5248.8425347239545, 5263.86840328992, 5282.2076688496745, 5300.681959082448, 5191.636585439021, 5206.5834733221345, 5210.635255532115, 5215.348081489814, 5216.60875434343, 3919.529656441224, 4020.2361551305157, 4026.396040593905, 4110.766769968997, 4149.875503734893, 4129.731567448106, 4138.855140070098, 4151.647109995654, 4162.313218318974, 4166.604172603597, 4106.240345536071, 4113.0, 4114.382842573608, 4121.793910304487, 4138.482689663792, 3886.24218277436, 3912.4326972588956, 4022.1754540319166, 4051.534073581546, 4078.1028173802015, 3572.4462708280257, 3589.982050089759, 3592.6946209572216, 3592.7844329340323, 3592.9281414371826, 5113.488651134894, 5120.15517439622, 5132.384113906318, 5133.512316329943, 5171.586273098181, 4511.548845115495, 4652.255639097762, 4672.299155126758, 4684.953150468486, 4686.367340409035, 5475.72621368934, 5477.20580515823, 5481.780728770845, 5489.890202195934, 5504.944950550484, 3867.7679339239453, 3971.245463361952, 3977.7016723745833, 3980.24375368679, 3994.2610617035652, 5744.368119506851, 5746.569007324426, 5759.251297331362, 5759.934412133769, 5766.336871259775, 3923.705722070856, 3937.330653788863, 3993.221321842213, 3996.160806230666, 3997.9400308995387, 3956.8219430125714, 3985.561588225293, 3990.3615421532418, 4022.230218703761, 4025.6376926076796, 4439.689221754446, 4600.0, 4600.769961501978, 4620.5379462053525, 4623.4451865775645, 5480.725963701799, 5481.616286859961, 5501.504864562208, 5516.565692919869, 5583.916241256385, 1351.567498400522, 1353.9574527613681, 1357.4909408971635, 1358.5652591170929, 1360.183889666212, 887.1483375959151, 903.4985583001366, 918.7201689966888, 919.9540022998823, 931.4085555672197, 4980.601551875841, 5235.0, 5296.523312901857, 5308.628396012242, 5331.786728530893, 5589.496945274864, 5615.606907516516, 5620.908500324805, 5674.858128546737, 5704.201411802351, 5112.539871411591, 5311.814086506954, 5343.278657381282, 5363.544098751572, 5368.677879327252, 2891.407261511385, 2907.680155182928, 2908.389238259947, 2924.8976285829895, 2928.516794728846, 5583.441655834384, 5609.831705048855, 5625.0, 5626.521745651584, 5663.716814159276, 5534.916976245359, 5570.498655120978, 5726.484616384545, 5798.797042103506, 5799.420057994167, 5856.4143585641095, 5857.824265272048, 5872.853178670567, 5879.676617785977, 5930.822075337746, 5537.861553461195, 5622.550195984393, 5764.241906218476, 5766.682832444088, 5770.0, 5514.944850551604, 5575.832725018256, 5576.191452239484, 5615.157726341082, 5616.578756593353, 5805.809808989232, 5874.823755287348, 5881.206037184926, 5931.228940237742, 5938.435848594377, 3922.5096862892137, 3931.506027709452, 3945.7768091891608, 3964.6630036447227, 4014.397840323975, 5601.439856014366, 5630.943690563042, 5631.831045068655, 5667.858303542444, 5687.60186786921, 5533.312339736258, 5548.834744703496, 5566.522897310658, 5572.916406253828, 5574.0, 5249.685018898878, 5464.55189374808, 5501.174823776306, 5512.3385193777, 5537.473939975695, 5438.619296649196, 5445.646033007842, 5459.332270908475, 5463.945360546344, 5474.0, 5261.789528418821, 5387.649802762808, 5397.811076612456, 5496.80761173357, 5543.861403464945, 5412.431694672003, 5431.9185212221055, 5459.972700136474, 5460.563154947516, 5486.259354987185], "value": 4182.0996771981245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.7145984416468, 754.6981207516994, 771.2364758888701, 775.6005657086598, 786.4298383671835, 12668.113232073747, 13104.772188727928, 13109.803352949713, 13620.863791362084, 13731.931340343284, 12743.808842867342, 12805.423755930982, 12821.0, 12821.679458013554, 12822.67943301418, 651.3388910256094, 765.6592816196809, 783.4868161354322, 784.5841703896915, 784.6273020315361, 669.4276393683404, 679.3987321220706, 679.5209377388929, 679.8640271945605, 772.4091070331173, 811.4968719393984, 812.8618134917049, 822.1942496353577, 822.2476434062826, 822.7490615362312, 817.5748610722391, 817.8200795824908, 820.6758330459495, 821.5194111444812, 822.1326500541926, 502.0260694253137, 510.59152677857935, 599.7361161089107, 603.8912995660779, 603.9909401358983, 11583.884161158365, 11924.880751192464, 12000.879991200063, 12216.938915305456, 12301.261924284481, 12447.875521244852, 12605.684857878534, 12938.0, 12966.935165324114, 12968.935155324258, 9560.235181185488, 9587.616495340179, 9814.362066465657, 10099.242556808269, 10196.643117490927, 3411.96588034119, 3431.330890476358, 3493.4454514804784, 3635.745497815154, 3647.3070116677745, 63574.0, 65845.67077164583, 65984.3401565983, 66112.6694366525, 66165.66917165431, 9628.32601717873, 9752.414855108575, 9793.314467987315, 9829.361091529028, 9841.753956151011, 17629.911850440923, 17670.0, 17683.73474397885, 17692.29230830778, 17693.469195924143, 7499.363063688675, 7516.24837516244, 7717.112532058773, 7854.8429031419055, 7892.329152022027, 4023.3361495353524, 4102.261592913244, 4200.138971510833, 4218.261804184255, 4222.873313800591, 3282.753793465452, 3352.3573449010296, 3386.3227354529195, 3389.5254664347012, 3396.100033491127, 551.5918220516788, 553.9944600553943, 560.0954458549413, 561.9859503512445, 568.3208565763872, 522.7020598258956, 574.4313130001269, 580.38189328366, 670.5306285600002, 686.0943554508002, 8584.613692383859, 9469.66856160031, 9638.0, 9740.220782337396, 9880.209583233323, 545.6180673528546, 552.541390645763, 571.5970240980099, 629.2700467457727, 669.3306693306694, 4038.656714179269, 4445.466544014739, 4537.659675524349, 4558.33904083906, 4579.260465418276, 81555.0, 82165.72928383952, 85181.57409212914, 86970.0, 88696.11303886879, 48145.277820832714, 52980.0, 68456.0, 69588.5205739711, 73584.0, 56209.0, 64021.679891600244, 64147.67926160339, 64917.20993480718, 66856.9971450419, 8947.776305592412, 9503.714888553355, 9540.95229523848, 9739.805203896025, 9798.57920601523, 41913.79043104765, 42086.57913420827, 42305.78847105745, 43507.56492435035, 44125.33811992887, 38445.23109537738, 38833.223335533694, 40391.0, 40477.1904561913, 41157.0, 10990.835137473105, 11588.67522431446, 11696.532138714696, 11770.3526306054, 11860.0, 13511.459541618618, 13602.319884005958, 13664.0, 13928.164310141425, 14377.56867293983, 12873.0, 12972.935135324264, 13292.136011159244, 13662.658433539242, 13852.584422467342, 11953.402329883296, 12412.503499859904, 12962.481500739865, 13096.0, 13474.461021559027, 11882.16824822254, 12332.075094368138, 12727.490900363882, 12786.61640150797, 12860.742785144057, 10391.012853778879, 10684.305520141166, 10840.783184336427, 10880.782384352111, 10970.890291097307, 9673.516324183904, 10383.325083869524, 10660.253782235479, 10697.14422846155, 10861.239713219999], "value": 6585.129075885644, "unit": "score"}], "name": "dromaeo_css", "value": 6863.487356648338, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 111.0, 112.0, 113.0, 112.0, 112.0, 114.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 125.0, 164.0, 124.0, 124.0, 123.0, 127.0, 152.0, 121.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 160.0, 161.0, 162.0, 161.0, 159.0, 162.0, 165.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 107.0, 77.0, 77.0, 77.0, 76.0, 105.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 134.0, 82.0, 82.0, 82.0, 114.0, 81.0, 83.0, 114.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 148.0, 149.0, 148.0, 145.0, 145.0, 148.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 64.0, 53.0, 53.0, 58.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 80.0, 81.0, 92.0, 78.0, 82.0, 80.0, 79.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 141.0, 130.0, 132.0, 130.0, 139.0, 139.0, 174.0, 154.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 170.0, 167.0, 167.0, 169.0, 165.0, 160.0, 165.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 70.0, 64.0, 64.0, 73.0, 67.0, 66.0, 63.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1501.5999999999997, "alertThreshold": 2.0}]} 10:38:46 INFO - Return code: 0 10:38:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:38:46 INFO - # TBPL SUCCESS # 10:38:46 INFO - Running post-action listener: _resource_record_post_action 10:38:46 INFO - [mozharness: 2016-11-11 18:38:46.522505Z] Finished run-tests step (success) 10:38:46 INFO - Running post-run listener: _resource_record_post_run 10:38:46 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 403525632; Read time: 20; Write time: 221116 10:38:46 INFO - TinderboxPrint: CPU usage
13.1% 10:38:46 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 10:38:46 INFO - TinderboxPrint: I/O write bytes / time
403,525,632 / 221,116 10:38:46 INFO - TinderboxPrint: CPU idle
8,294.9 (86.9%) 10:38:46 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 10:38:46 INFO - TinderboxPrint: Swap in / out
0 / 0 10:38:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114892800; Read time: 0; Write time: 63376 10:38:46 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288219136; Read time: 12; Write time: 157672 10:38:47 INFO - Running post-run listener: _upload_blobber_files 10:38:47 INFO - Blob upload gear active. 10:38:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:47 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 10:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:38:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:38:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:38:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:51 INFO - (blobuploader) - INFO - Done attempting. 10:38:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:38:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:52 INFO - (blobuploader) - INFO - Done attempting. 10:38:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:38:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:38:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:52 INFO - (blobuploader) - INFO - Done attempting. 10:38:52 INFO - (blobuploader) - INFO - Iteration through files over. 10:38:52 INFO - Return code: 0 10:38:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:38:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:38:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bd81a4f550086b3db2e585497249a7d6f1877f9a00ed9ff9b841ebe9b4bfda7ee0a8d596e31a3cd6374b0349eb21766cd64e76cb7a9d4476f8b2a02b8e8aef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e19322c4ca5b5633bc748ef058bb9c975246e88812d8740319defcda1dcf6741cf975206b841fff9dc526afe01c51e403978405f53b7c01bb726352a2fb90c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98d0cc30480c211f9a86e6a13f5422c121656a0a8c8e7d7ca6c1a9b138aae269135be1d669ec394a70bf239da7a4ed9853b450c8b96bace4601ac5591523d61"} 10:38:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:38:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:38:52 INFO - Contents: 10:38:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bd81a4f550086b3db2e585497249a7d6f1877f9a00ed9ff9b841ebe9b4bfda7ee0a8d596e31a3cd6374b0349eb21766cd64e76cb7a9d4476f8b2a02b8e8aef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e19322c4ca5b5633bc748ef058bb9c975246e88812d8740319defcda1dcf6741cf975206b841fff9dc526afe01c51e403978405f53b7c01bb726352a2fb90c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98d0cc30480c211f9a86e6a13f5422c121656a0a8c8e7d7ca6c1a9b138aae269135be1d669ec394a70bf239da7a4ed9853b450c8b96bace4601ac5591523d61"} 10:38:52 INFO - Running post-run listener: copy_logs_to_upload_dir 10:38:52 INFO - Copying logs to upload dir... 10:38:52 INFO - mkdir: /builds/slave/test/build/upload/logs 10:38:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.274623 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-11-11 10:38:52.830292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 10:38:52.834123) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bd81a4f550086b3db2e585497249a7d6f1877f9a00ed9ff9b841ebe9b4bfda7ee0a8d596e31a3cd6374b0349eb21766cd64e76cb7a9d4476f8b2a02b8e8aef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e19322c4ca5b5633bc748ef058bb9c975246e88812d8740319defcda1dcf6741cf975206b841fff9dc526afe01c51e403978405f53b7c01bb726352a2fb90c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98d0cc30480c211f9a86e6a13f5422c121656a0a8c8e7d7ca6c1a9b138aae269135be1d669ec394a70bf239da7a4ed9853b450c8b96bace4601ac5591523d61"} build_url:https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/MF5pEfR8QJaOFPY4C5OHgw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bd81a4f550086b3db2e585497249a7d6f1877f9a00ed9ff9b841ebe9b4bfda7ee0a8d596e31a3cd6374b0349eb21766cd64e76cb7a9d4476f8b2a02b8e8aef9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e19322c4ca5b5633bc748ef058bb9c975246e88812d8740319defcda1dcf6741cf975206b841fff9dc526afe01c51e403978405f53b7c01bb726352a2fb90c00", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e98d0cc30480c211f9a86e6a13f5422c121656a0a8c8e7d7ca6c1a9b138aae269135be1d669ec394a70bf239da7a4ed9853b450c8b96bace4601ac5591523d61"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-11 10:38:52.860042) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 10:38:52.860397) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1478888022.400047-995708852 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-11 10:38:52.944555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 10:38:52.944902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-11 10:38:52.945236) ========= ========= Total master_lag: 0.20 =========